2018-10-16T17:25:53.042Z,1539710753.042 [Supervisor](DEBUG): Initializing supervisor. 2018-10-16T17:25:53.045Z,1539710753.045 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-16T17:25:53.045Z,1539710753.045 [SyncHandler](INFO): Protected caller Thread ID is 799 2018-10-16T17:25:53.046Z,1539710753.046 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-16T17:25:53.047Z,1539710753.047 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-16T17:25:53.047Z,1539710753.047 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 800 2018-10-16T17:25:53.050Z,1539710753.050 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-16T17:25:53.061Z,1539710753.061 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-16T17:25:53.062Z,1539710753.062 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-16T17:25:53.062Z,1539710753.062 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 801 2018-10-16T17:25:53.063Z,1539710753.063 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-16T17:25:53.064Z,1539710753.064 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-16T17:25:53.065Z,1539710753.065 [logger ThreadHandler](INFO): Protected caller Thread ID is 802 2018-10-16T17:25:53.066Z,1539710753.066 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-16T17:25:53.067Z,1539710753.067 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-16T17:25:53.071Z,1539710753.071 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-16T17:25:53.169Z,1539710753.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-16T17:25:53.170Z,1539710753.170 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-16T17:25:53.271Z,1539710753.271 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-16T17:25:53.272Z,1539710753.272 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-16T17:25:53.472Z,1539710753.472 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-16T17:25:53.472Z,1539710753.472 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-16T17:25:53.808Z,1539710753.808 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-16T17:25:53.810Z,1539710753.810 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-16T17:25:54.154Z,1539710754.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-16T17:25:54.156Z,1539710754.156 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-16T17:25:54.616Z,1539710754.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-16T17:25:54.617Z,1539710754.617 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-16T17:25:55.077Z,1539710755.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-16T17:25:55.079Z,1539710755.079 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-16T17:25:55.575Z,1539710755.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-16T17:25:55.577Z,1539710755.577 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-16T17:25:55.659Z,1539710755.659 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-16T17:25:55.973Z,1539710755.973 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-16T17:25:55.975Z,1539710755.975 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-16T17:25:56.125Z,1539710756.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-16T17:25:56.125Z,1539710756.125 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-16T17:25:56.340Z,1539710756.340 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-16T17:25:56.342Z,1539710756.342 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-16T17:25:56.551Z,1539710756.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-16T17:25:56.553Z,1539710756.553 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-16T17:25:56.821Z,1539710756.821 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-16T17:25:56.821Z,1539710756.821 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-16T17:25:57.164Z,1539710757.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-16T17:25:57.166Z,1539710757.166 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-10-16T17:25:57.169Z,1539710757.169 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-10-16T17:25:57.399Z,1539710757.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-16T17:25:57.400Z,1539710757.400 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-10-16T17:25:57.506Z,1539710757.506 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-10-16T17:25:57.742Z,1539710757.742 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-10-16T17:25:57.839Z,1539710757.839 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-10-16T17:25:57.926Z,1539710757.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-10-16T17:25:58.087Z,1539710758.087 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-10-16T17:25:58.294Z,1539710758.294 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-10-16T17:25:58.393Z,1539710758.393 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-10-16T17:25:58.490Z,1539710758.490 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-10-16T17:25:58.589Z,1539710758.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-10-16T17:25:58.673Z,1539710758.673 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2018-10-16T17:25:58.675Z,1539710758.675 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-16T17:25:58.808Z,1539710758.808 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-16T17:25:58.809Z,1539710758.809 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-16T17:25:58.833Z,1539710758.833 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-16T17:25:58.835Z,1539710758.835 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-16T17:25:58.892Z,1539710758.892 [DepthRateCalculator] Loaded 2018-10-16T17:25:58.892Z,1539710758.892 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-16T17:25:58.898Z,1539710758.898 [PitchRateCalculator] Loaded 2018-10-16T17:25:58.898Z,1539710758.898 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-16T17:25:58.914Z,1539710758.914 [SpeedCalculator] Loaded 2018-10-16T17:25:58.914Z,1539710758.914 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-16T17:25:58.935Z,1539710758.935 [TempGradientCalculator] Loaded 2018-10-16T17:25:58.935Z,1539710758.935 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-16T17:25:58.941Z,1539710758.941 [YawRateCalculator] Loaded 2018-10-16T17:25:58.942Z,1539710758.942 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-16T17:25:58.981Z,1539710758.981 [ElevatorOffsetCalculator] Loaded 2018-10-16T17:25:58.982Z,1539710758.982 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-16T17:25:58.982Z,1539710758.982 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-16T17:25:58.983Z,1539710758.983 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-16T17:25:59.021Z,1539710759.021 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-16T17:25:59.022Z,1539710759.022 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-16T17:26:11.049Z,1539710771.049 [DataOverHttps] Loaded 2018-10-16T17:26:11.049Z,1539710771.049 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-16T17:26:11.077Z,1539710771.077 [Depth_Keller] Loaded 2018-10-16T17:26:11.078Z,1539710771.078 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-16T17:26:11.086Z,1539710771.086 [GobyModem] Loaded 2018-10-16T17:26:11.087Z,1539710771.087 [ComponentRegistry](DEBUG): SyncComponent "GobyModem" handled in the control thread. 2018-10-16T17:26:11.184Z,1539710771.184 [NAL9602] Loaded 2018-10-16T17:26:11.185Z,1539710771.185 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-16T17:26:11.202Z,1539710771.202 [Onboard] Loaded 2018-10-16T17:26:11.202Z,1539710771.202 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-16T17:26:11.212Z,1539710771.212 [Radio_Surface] Loaded 2018-10-16T17:26:11.212Z,1539710771.212 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-16T17:26:11.213Z,1539710771.213 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 419D44E0 2018-10-16T17:26:11.214Z,1539710771.214 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 883 2018-10-16T17:26:11.215Z,1539710771.215 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-16T17:26:11.216Z,1539710771.216 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-16T17:26:11.374Z,1539710771.374 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-16T17:26:11.397Z,1539710771.397 [SBIT] Loaded 2018-10-16T17:26:11.397Z,1539710771.397 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-16T17:26:11.398Z,1539710771.398 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-16T17:26:11.410Z,1539710771.410 [IBIT] Loaded 2018-10-16T17:26:11.411Z,1539710771.411 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-16T17:26:11.414Z,1539710771.414 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-16T17:26:11.561Z,1539710771.561 [CBIT] Loaded 2018-10-16T17:26:11.561Z,1539710771.561 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-16T17:26:11.561Z,1539710771.561 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-16T17:26:11.562Z,1539710771.562 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-16T17:26:11.757Z,1539710771.757 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-16T17:26:11.758Z,1539710771.758 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-16T17:26:12.047Z,1539710772.047 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-16T17:26:12.049Z,1539710772.049 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-16T17:26:12.138Z,1539710772.138 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-16T17:26:12.233Z,1539710772.233 [VerticalControl] Loaded 2018-10-16T17:26:12.233Z,1539710772.233 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-16T17:26:12.234Z,1539710772.234 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-16T17:26:12.295Z,1539710772.295 [HorizontalControl] Loaded 2018-10-16T17:26:12.295Z,1539710772.295 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-16T17:26:12.296Z,1539710772.296 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-16T17:26:12.301Z,1539710772.301 [SpeedControl] Loaded 2018-10-16T17:26:12.301Z,1539710772.301 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-16T17:26:12.302Z,1539710772.302 [LoopControl](DEBUG): Construct LoopControl. 2018-10-16T17:26:12.303Z,1539710772.303 [LoopControl] Loaded 2018-10-16T17:26:12.303Z,1539710772.303 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-16T17:26:12.303Z,1539710772.303 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-16T17:26:12.304Z,1539710772.304 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-16T17:26:12.409Z,1539710772.409 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-16T17:26:12.410Z,1539710772.410 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-16T17:26:12.533Z,1539710772.533 [BuoyancyServo] Loaded 2018-10-16T17:26:12.533Z,1539710772.533 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-16T17:26:12.545Z,1539710772.545 [ElevatorServo] Loaded 2018-10-16T17:26:12.545Z,1539710772.545 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-16T17:26:12.556Z,1539710772.556 [MassServo] Loaded 2018-10-16T17:26:12.556Z,1539710772.556 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-16T17:26:12.567Z,1539710772.567 [RudderServo] Loaded 2018-10-16T17:26:12.568Z,1539710772.568 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-16T17:26:12.578Z,1539710772.578 [ThrusterServo] Loaded 2018-10-16T17:26:12.578Z,1539710772.578 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-16T17:26:12.579Z,1539710772.579 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-16T17:26:12.580Z,1539710772.580 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-16T17:26:12.688Z,1539710772.688 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-16T17:26:12.689Z,1539710772.689 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-16T17:26:12.693Z,1539710772.693 [UniversalFixResidualReporter] Loaded 2018-10-16T17:26:12.693Z,1539710772.693 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-16T17:26:12.694Z,1539710772.694 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-16T17:26:12.697Z,1539710772.697 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-16T17:26:12.698Z,1539710772.698 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-16T17:26:12.705Z,1539710772.705 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-16T17:26:12.706Z,1539710772.706 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 41BC84E0 2018-10-16T17:26:12.706Z,1539710772.706 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 884 2018-10-16T17:26:12.711Z,1539710772.711 [Supervisor](INFO): Main Thread ID is 795 2018-10-16T17:26:12.711Z,1539710772.711 [Supervisor](DEBUG): Running supervisor. 2018-10-16T17:26:12.712Z,1539710772.712 [CommandLine ThreadHandler](INFO): Handler Thread ID is 885 2018-10-16T17:26:12.714Z,1539710772.714 [controlThread ThreadHandler](INFO): Handler Thread ID is 886 2018-10-16T17:26:12.714Z,1539710772.714 [controlThread](DEBUG): Initializing ControlThread 2018-10-16T17:26:12.715Z,1539710772.715 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-16T17:26:12.716Z,1539710772.716 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-10-16T17:26:12.716Z,1539710772.716 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-10-16T17:26:12.716Z,1539710772.716 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-10-16T17:26:12.717Z,1539710772.717 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-10-16T17:26:12.717Z,1539710772.717 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-10-16T17:26:12.742Z,1539710772.742 [logger ThreadHandler](INFO): Handler Thread ID is 887 2018-10-16T17:26:12.771Z,1539710772.771 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 888 2018-10-16T17:26:12.776Z,1539710772.776 [Radio_Surface](INFO): Powering up 2018-10-16T17:26:12.791Z,1539710772.791 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 889 2018-10-16T17:26:12.798Z,1539710772.798 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-16T17:26:12.798Z,1539710772.798 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-10-16T17:26:12.798Z,1539710772.798 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-16T17:26:12.798Z,1539710772.798 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-10-16T17:26:12.799Z,1539710772.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-16T17:26:12.799Z,1539710772.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-10-16T17:26:12.799Z,1539710772.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-16T17:26:12.799Z,1539710772.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-10-16T17:26:12.799Z,1539710772.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-16T17:26:12.800Z,1539710772.800 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-10-16T17:26:12.800Z,1539710772.800 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-16T17:26:12.800Z,1539710772.800 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-10-16T17:26:12.800Z,1539710772.800 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-16T17:26:12.800Z,1539710772.800 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-10-16T17:26:12.800Z,1539710772.800 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-16T17:26:12.801Z,1539710772.801 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-10-16T17:27:01.579Z,1539710821.579 [CommandLine](IMPORTANT): got command show stack 2018-10-16T17:27:01.579Z,1539710821.579 [CommandLine](IMPORTANT): Behavior Stack: 2018-10-16T17:27:01.579Z,1539710821.579 [MissionManager](IMPORTANT): No startup, active, or default mission! 2018-10-16T17:27:23.244Z,1539710843.244 [CommandLine](IMPORTANT): got command show variable goby 2018-10-16T17:27:23.265Z,1539710843.265 [CommandLine](IMPORTANT): GobyModem.loadAtStartup (bool) 2018-10-16T17:27:23.265Z,1539710843.265 [CommandLine](IMPORTANT): GobyModem.simulateHardware (bool) 2018-10-16T17:27:23.265Z,1539710843.265 [CommandLine](IMPORTANT): GobyModem.modemType (none) 2018-10-16T17:27:23.266Z,1539710843.266 [CommandLine](IMPORTANT): GobyModem.networkIds (none) 2018-10-16T17:27:23.266Z,1539710843.266 [CommandLine](IMPORTANT): GobyModem.maxDistance (kilometer) 2018-10-16T17:27:23.267Z,1539710843.267 [CommandLine](IMPORTANT): GobyModem.transBaud (bit_per_second) 2018-10-16T17:27:23.328Z,1539710843.328 [CommandLine](IMPORTANT): GobyModem.loadControl (none) 2018-10-16T17:27:23.328Z,1539710843.328 [CommandLine](IMPORTANT): GobyModem.uart (none) 2018-10-16T17:27:23.329Z,1539710843.329 [CommandLine](IMPORTANT): GobyModem.baud (bit_per_second) 2018-10-16T17:27:23.330Z,1539710843.330 [CommandLine](IMPORTANT): GobyModem.platform_conversation (bool) 2018-10-16T17:27:45.495Z,1539710865.495 [GobyModem](CRITICAL): exception at startup: Failed to startup. 2018-10-16T17:27:45.553Z,1539710865.553 [SBIT](INFO): Initialize SBIT Component. 2018-10-16T17:27:45.554Z,1539710865.554 [SBIT](IMPORTANT): git: 2018-10-09-15-g073c7cf 2018-10-16T17:27:45.554Z,1539710865.554 [SBIT](INFO): git hash: 073c7cfad008e3c02fc00b8e52c9ff77a81c70b1 2018-10-16T17:27:45.554Z,1539710865.554 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-10-16T17:27:45.555Z,1539710865.555 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-10-16T17:27:45.555Z,1539710865.555 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2018-10-16T17:27:45.556Z,1539710865.556 [IBIT](INFO): Initialize IBIT Component. 2018-10-16T17:27:45.557Z,1539710865.557 [CBIT](DEBUG): Initialize CBIT Component. 2018-10-16T17:27:45.557Z,1539710865.557 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2018-10-16T17:27:45.557Z,1539710865.557 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2018-10-16T17:27:45.662Z,1539710865.662 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-10-16T17:27:45.664Z,1539710865.664 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-10-16T17:27:45.665Z,1539710865.665 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-10-16T17:27:45.665Z,1539710865.665 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-10-16T17:27:45.667Z,1539710865.667 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-16T17:27:45.667Z,1539710865.667 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-16T17:27:45.668Z,1539710865.668 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-16T17:27:45.668Z,1539710865.668 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-10-16T17:27:45.669Z,1539710865.669 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-10-16T17:27:45.718Z,1539710865.718 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-16T17:27:45.730Z,1539710865.730 [MissionManager](DEBUG): 2018-10-16T17:27:45.731Z,1539710865.731 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-10-16T17:27:45.788Z,1539710865.788 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-10-16T17:27:45.789Z,1539710865.789 [Default:A.Wait](DEBUG): Construct Wait. 2018-10-16T17:27:45.795Z,1539710865.795 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-16T17:27:45.821Z,1539710865.821 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-10-16T17:27:45.828Z,1539710865.828 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-10-16T17:27:45.845Z,1539710865.845 [Default:E.Execute](DEBUG): Construct Execute. 2018-10-16T17:27:45.860Z,1539710865.860 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2018-10-16T17:27:45.865Z,1539710865.865 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,GobyModem,NAL9602,Onboard,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-10-16T17:27:45.881Z,1539710865.881 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-10-16T17:27:45.915Z,1539710865.915 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2018-10-16T17:27:45.932Z,1539710865.932 [NAL9602](INFO): Powering up NAL9602 2018-10-16T17:27:45.990Z,1539710865.990 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-10-16T17:27:46.040Z,1539710866.040 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:46.191Z,1539710866.191 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-16T17:27:46.198Z,1539710866.198 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-16T17:27:46.204Z,1539710866.204 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-16T17:27:46.210Z,1539710866.210 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-16T17:27:46.216Z,1539710866.216 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-16T17:27:46.222Z,1539710866.222 [MassServo](DEBUG): Initializing MassServo. 2018-10-16T17:27:46.228Z,1539710866.228 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-16T17:27:46.234Z,1539710866.234 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-16T17:27:46.240Z,1539710866.240 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-16T17:27:46.246Z,1539710866.246 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-16T17:27:46.262Z,1539710866.262 [CommandLine](FAULT): Scheduling is paused 2018-10-16T17:27:46.262Z,1539710866.262 [CBIT](INFO): Critical error at 20181016T172745 2018-10-16T17:27:46.262Z,1539710866.262 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-10-16T17:27:46.377Z,1539710866.377 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:46.738Z,1539710866.738 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:47.070Z,1539710867.070 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-16T17:27:47.070Z,1539710867.070 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-16T17:27:47.070Z,1539710867.070 [BuoyancyServo] Communications Fault, FailCount= 1 2018-10-16T17:27:47.070Z,1539710867.070 [BuoyancyServo](ERROR): Communications Fault 2018-10-16T17:27:47.278Z,1539710867.278 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-16T17:27:47.305Z,1539710867.305 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:47.311Z,1539710867.311 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-16T17:27:47.313Z,1539710867.313 [BuoyancyServo](INFO): Powering down 2018-10-16T17:27:47.717Z,1539710867.717 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:48.108Z,1539710868.108 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:48.513Z,1539710868.513 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:48.917Z,1539710868.917 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:49.315Z,1539710869.315 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:49.347Z,1539710869.347 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-16T17:27:49.347Z,1539710869.347 [BuoyancyServo] No Fault, FailCount= 1 2018-10-16T17:27:49.717Z,1539710869.717 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:49.723Z,1539710869.723 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-16T17:27:49.839Z,1539710869.839 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-16T17:27:50.117Z,1539710870.117 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:50.520Z,1539710870.520 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:50.922Z,1539710870.922 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:51.318Z,1539710871.318 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:51.717Z,1539710871.717 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:52.117Z,1539710872.117 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:52.518Z,1539710872.518 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:52.922Z,1539710872.922 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:53.319Z,1539710873.319 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:53.718Z,1539710873.718 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:54.115Z,1539710874.115 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:54.522Z,1539710874.522 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:54.922Z,1539710874.922 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:55.322Z,1539710875.322 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:55.718Z,1539710875.718 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:55.729Z,1539710875.729 [CBIT](CRITICAL): Environmental Failure. Press:14.801923 PSI. Humidity:24%. Temp:26 C. ABORTING MISSION 2018-10-16T17:27:56.115Z,1539710876.115 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:56.124Z,1539710876.124 [CBIT](INFO): Critical error at 20181016T172755 2018-10-16T17:27:56.497Z,1539710876.497 [GobyModem](INFO): Added slot 1 2018-10-16T17:27:56.497Z,1539710876.497 [GobyModem](INFO): Added slot 2 2018-10-16T17:27:56.509Z,1539710876.509 [GobyModem](INFO): Added slot 3 2018-10-16T17:27:57.966Z,1539710877.966 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:58.075Z,1539710878.075 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:58.393Z,1539710878.393 [NAL9602](INFO): NAL9602 initialized 2018-10-16T17:27:58.433Z,1539710878.433 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:58.838Z,1539710878.838 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:59.234Z,1539710879.234 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:27:59.633Z,1539710879.633 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:00.061Z,1539710880.061 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:00.439Z,1539710880.439 [GobyModem](INFO): {control} starting send from me 2018-10-16T17:28:00.473Z,1539710880.473 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:00.826Z,1539710880.826 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:01.223Z,1539710881.223 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:01.630Z,1539710881.630 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:02.026Z,1539710882.026 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:02.426Z,1539710882.426 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:02.827Z,1539710882.827 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:03.225Z,1539710883.225 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:03.625Z,1539710883.625 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:04.026Z,1539710884.026 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:04.419Z,1539710884.419 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:04.821Z,1539710884.821 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:05.226Z,1539710885.226 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:05.630Z,1539710885.630 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:06.022Z,1539710886.022 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:06.426Z,1539710886.426 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:06.833Z,1539710886.833 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:07.224Z,1539710887.224 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:07.626Z,1539710887.626 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:08.034Z,1539710888.034 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:08.423Z,1539710888.423 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:08.823Z,1539710888.823 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:09.229Z,1539710889.229 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:09.623Z,1539710889.623 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:09.928Z,1539710889.928 [CommandLine](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.799999 degree 2018-10-16T17:28:09.929Z,1539710889.929 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread. 2018-10-16T17:28:10.025Z,1539710890.025 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:10.033Z,1539710890.033 [SBIT](IMPORTANT): Beginning Startup BIT 2018-10-16T17:28:10.037Z,1539710890.037 [CBIT](IMPORTANT): Beginning ground fault scan 2018-10-16T17:28:10.043Z,1539710890.043 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,GobyModem,NAL9602,Onboard,Depth_Keller,Maintain_NAL9602.latitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-10-16T17:28:10.428Z,1539710890.428 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:10.823Z,1539710890.823 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:11.230Z,1539710891.230 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:11.626Z,1539710891.626 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:12.030Z,1539710892.030 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:12.564Z,1539710892.564 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:12.950Z,1539710892.950 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:13.365Z,1539710893.365 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:13.734Z,1539710893.734 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:14.138Z,1539710894.138 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:14.549Z,1539710894.549 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:14.946Z,1539710894.946 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:15.334Z,1539710895.334 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:15.729Z,1539710895.729 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:16.134Z,1539710896.134 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:16.542Z,1539710896.542 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:16.938Z,1539710896.938 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:17.350Z,1539710897.350 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:17.746Z,1539710897.746 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:18.151Z,1539710898.151 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:18.552Z,1539710898.552 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:18.939Z,1539710898.939 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:19.338Z,1539710899.338 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:19.544Z,1539710899.544 [CommandLine](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -121.900002 degree 2018-10-16T17:28:19.545Z,1539710899.545 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread. 2018-10-16T17:28:19.738Z,1539710899.738 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:19.797Z,1539710899.797 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,GobyModem,NAL9602,Onboard,Depth_Keller,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-10-16T17:28:20.137Z,1539710900.137 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:20.538Z,1539710900.538 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:20.936Z,1539710900.936 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:20.995Z,1539710900.995 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.014424 CHAN A1 (24V): -0.017761 CHAN A2 (12V): -0.005302 CHAN A3 (5V): -0.002798 CHAN B0 (3.3V): -0.001340 CHAN B1 (3.15aV): -0.000999 CHAN B2 (3.15bV): -0.001187 CHAN B3 (GND): 0.000253 OPEN: 0.003787 Full Scale Calc: 4.765 mA, -1.589 mA 2018-10-16T17:28:21.339Z,1539710901.339 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:21.742Z,1539710901.742 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:22.143Z,1539710902.143 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:22.551Z,1539710902.551 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:22.946Z,1539710902.946 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:23.351Z,1539710903.351 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:23.746Z,1539710903.746 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:24.140Z,1539710904.140 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:24.534Z,1539710904.534 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:24.935Z,1539710904.935 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:25.336Z,1539710905.336 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:25.911Z,1539710905.911 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:26.334Z,1539710906.334 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:26.727Z,1539710906.727 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:27.111Z,1539710907.111 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:27.530Z,1539710907.530 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:27.931Z,1539710907.931 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:28.335Z,1539710908.335 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:28.731Z,1539710908.731 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:29.130Z,1539710909.130 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:29.528Z,1539710909.528 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:29.930Z,1539710909.930 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:30.311Z,1539710910.311 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:30.711Z,1539710910.711 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:31.130Z,1539710911.130 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:31.506Z,1539710911.506 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:31.930Z,1539710911.930 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:32.310Z,1539710912.310 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:32.730Z,1539710912.730 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:32.951Z,1539710912.951 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1539710848.000000 second 2018-10-16T17:28:33.135Z,1539710913.135 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:33.531Z,1539710913.531 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:33.532Z,1539710913.532 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:33.931Z,1539710913.931 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:33.932Z,1539710913.932 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:34.331Z,1539710914.331 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:34.332Z,1539710914.332 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:34.711Z,1539710914.711 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:34.712Z,1539710914.712 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:35.111Z,1539710915.111 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:35.112Z,1539710915.112 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:35.526Z,1539710915.526 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:35.528Z,1539710915.528 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:35.910Z,1539710915.910 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:35.912Z,1539710915.912 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:36.287Z,1539710916.287 [GobyModem](INFO): {control} starting send from me 2018-10-16T17:28:36.332Z,1539710916.332 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:36.334Z,1539710916.334 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:36.401Z,1539710916.401 [CommandLine](IMPORTANT): got command get latitude 2018-10-16T17:28:36.401Z,1539710916.401 [CommandLine](IMPORTANT): latitude 36.799999 arcdeg 2018-10-16T17:28:36.711Z,1539710916.711 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:36.712Z,1539710916.712 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:37.111Z,1539710917.111 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:37.112Z,1539710917.112 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:37.511Z,1539710917.511 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:37.512Z,1539710917.512 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:37.911Z,1539710917.911 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:37.912Z,1539710917.912 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:38.330Z,1539710918.330 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:38.332Z,1539710918.332 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:38.731Z,1539710918.731 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:38.732Z,1539710918.732 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:39.131Z,1539710919.131 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:39.132Z,1539710919.132 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:39.531Z,1539710919.531 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:39.532Z,1539710919.532 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:39.906Z,1539710919.906 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:39.907Z,1539710919.907 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:40.143Z,1539710920.143 [CommandLine](IMPORTANT): got command get depth 2018-10-16T17:28:40.143Z,1539710920.143 [CommandLine](IMPORTANT): depth 0.075992 m 2018-10-16T17:28:40.309Z,1539710920.309 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:40.310Z,1539710920.310 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:40.710Z,1539710920.710 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:40.712Z,1539710920.712 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:41.103Z,1539710921.103 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:41.104Z,1539710921.104 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:41.511Z,1539710921.511 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:41.512Z,1539710921.512 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or orientation is invalid, and horizontal path length since last fix is nonzero. 2018-10-16T17:28:41.910Z,1539710921.910 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-16T17:28:41.912Z,1539710921.912 [DeadReckonUsingSpeedCalculator](DEBUG): Will not write estimated position: allowance for input measurements to start up has not expired, but velocity or or