2017-04-18T23:32:07.448Z,1492558327.448 [Supervisor](DEBUG): Initializing supervisor. 2017-04-18T23:32:07.451Z,1492558327.451 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2017-04-18T23:32:07.451Z,1492558327.451 [SyncHandler](INFO): Protected caller Thread ID is 769 2017-04-18T23:32:07.452Z,1492558327.452 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-04-18T23:32:07.453Z,1492558327.453 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2017-04-18T23:32:07.453Z,1492558327.453 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 770 2017-04-18T23:32:07.456Z,1492558327.456 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-04-18T23:32:07.469Z,1492558327.469 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-04-18T23:32:07.470Z,1492558327.470 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2017-04-18T23:32:07.470Z,1492558327.470 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 771 2017-04-18T23:32:07.471Z,1492558327.471 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-04-18T23:32:07.472Z,1492558327.472 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2017-04-18T23:32:07.473Z,1492558327.473 [logger ThreadHandler](INFO): Protected caller Thread ID is 772 2017-04-18T23:32:07.475Z,1492558327.475 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-04-18T23:32:07.475Z,1492558327.475 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-04-18T23:32:07.479Z,1492558327.479 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-04-18T23:32:07.566Z,1492558327.566 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-04-18T23:32:07.897Z,1492558327.897 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-04-18T23:32:07.899Z,1492558327.899 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-04-18T23:32:08.035Z,1492558328.035 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-04-18T23:32:08.036Z,1492558328.036 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-04-18T23:32:08.238Z,1492558328.239 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-04-18T23:32:08.239Z,1492558328.239 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-04-18T23:32:08.341Z,1492558328.341 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-04-18T23:32:08.343Z,1492558328.343 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-04-18T23:32:08.541Z,1492558328.541 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-04-18T23:32:08.543Z,1492558328.543 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-04-18T23:32:09.023Z,1492558329.023 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-04-18T23:32:09.024Z,1492558329.024 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-04-18T23:32:09.315Z,1492558329.316 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-04-18T23:32:09.316Z,1492558329.316 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-04-18T23:32:09.403Z,1492558329.403 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-04-18T23:32:09.404Z,1492558329.404 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-04-18T23:32:09.548Z,1492558329.548 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-04-18T23:32:09.549Z,1492558329.549 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-04-18T23:32:09.751Z,1492558329.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-04-18T23:32:09.751Z,1492558329.751 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-04-18T23:32:10.335Z,1492558330.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-04-18T23:32:10.335Z,1492558330.335 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-04-18T23:32:15.098Z,1492558335.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-04-18T23:32:15.099Z,1492558335.099 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-04-18T23:32:15.421Z,1492558335.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-04-18T23:32:15.421Z,1492558335.421 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-04-18T23:32:16.553Z,1492558336.553 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-04-18T23:32:16.555Z,1492558336.555 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/ 2017-04-18T23:32:16.559Z,1492558336.559 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg 2017-04-18T23:32:16.649Z,1492558336.649 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg 2017-04-18T23:32:16.825Z,1492558336.825 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg 2017-04-18T23:32:17.069Z,1492558337.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-04-18T23:32:17.070Z,1492558337.070 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg 2017-04-18T23:32:17.170Z,1492558337.170 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg 2017-04-18T23:32:17.283Z,1492558337.283 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg 2017-04-18T23:32:17.390Z,1492558337.390 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg 2017-04-18T23:32:17.537Z,1492558337.537 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg 2017-04-18T23:32:17.704Z,1492558337.704 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg 2017-04-18T23:32:17.816Z,1492558337.816 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg 2017-04-18T23:32:17.906Z,1492558337.906 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg 2017-04-18T23:32:18.006Z,1492558338.006 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2017-04-18T23:32:18.011Z,1492558338.011 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-04-18T23:32:18.055Z,1492558338.055 [DepthRateCalculator] Loaded 2017-04-18T23:32:18.055Z,1492558338.055 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-04-18T23:32:18.062Z,1492558338.062 [PitchRateCalculator] Loaded 2017-04-18T23:32:18.062Z,1492558338.062 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-04-18T23:32:18.074Z,1492558338.074 [SpeedCalculator] Loaded 2017-04-18T23:32:18.075Z,1492558338.075 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-04-18T23:32:18.098Z,1492558338.098 [TempGradientCalculator] Loaded 2017-04-18T23:32:18.098Z,1492558338.098 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-04-18T23:32:18.115Z,1492558338.115 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-04-18T23:32:18.116Z,1492558338.116 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-04-18T23:32:18.122Z,1492558338.122 [YawRateCalculator] Loaded 2017-04-18T23:32:18.122Z,1492558338.122 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-04-18T23:32:18.122Z,1492558338.122 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-04-18T23:32:18.123Z,1492558338.123 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-04-18T23:32:18.253Z,1492558338.253 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-04-18T23:32:18.253Z,1492558338.253 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-04-18T23:32:18.310Z,1492558338.310 [DeadReckonUsingSpeedCalculator] Loaded 2017-04-18T23:32:18.311Z,1492558338.311 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-04-18T23:32:18.369Z,1492558338.369 [DeadReckonWithRespectToSeafloor] Loaded 2017-04-18T23:32:18.370Z,1492558338.370 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2017-04-18T23:32:18.387Z,1492558338.387 [NavChart] Loaded 2017-04-18T23:32:18.387Z,1492558338.388 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-04-18T23:32:18.392Z,1492558338.392 [UniversalFixResidualReporter] Loaded 2017-04-18T23:32:18.392Z,1492558338.392 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-04-18T23:32:18.393Z,1492558338.392 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-04-18T23:32:18.393Z,1492558338.393 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-04-18T23:32:18.599Z,1492558338.599 [Aanderaa_O2] Loaded 2017-04-18T23:32:18.600Z,1492558338.600 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-04-18T23:32:18.615Z,1492558338.615 [PAR_Licor] Loaded 2017-04-18T23:32:18.616Z,1492558338.616 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-04-18T23:32:18.669Z,1492558338.669 [WetLabsBB2FL] Loaded 2017-04-18T23:32:18.669Z,1492558338.669 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-04-18T23:32:18.670Z,1492558338.670 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4066F4E0 2017-04-18T23:32:18.671Z,1492558338.671 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 852 2017-04-18T23:32:18.671Z,1492558338.671 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-04-18T23:32:18.672Z,1492558338.672 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2017-04-18T23:32:18.714Z,1492558338.714 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2017-04-18T23:32:18.715Z,1492558338.714 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-04-18T23:32:18.724Z,1492558338.724 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-04-18T23:32:18.725Z,1492558338.725 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-04-18T23:32:19.033Z,1492558339.033 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-04-18T23:32:19.033Z,1492558339.033 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-04-18T23:32:19.206Z,1492558339.206 [SBIT](DEBUG): Construct Startup Built In Test. 2017-04-18T23:32:19.239Z,1492558339.239 [SBIT] Loaded 2017-04-18T23:32:19.240Z,1492558339.240 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-04-18T23:32:19.240Z,1492558339.240 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-04-18T23:32:19.270Z,1492558339.270 [IBIT] Loaded 2017-04-18T23:32:19.270Z,1492558339.270 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-04-18T23:32:19.273Z,1492558339.273 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-04-18T23:32:19.436Z,1492558339.436 [CBIT] Loaded 2017-04-18T23:32:19.437Z,1492558339.437 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-04-18T23:32:19.437Z,1492558339.437 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-04-18T23:32:19.438Z,1492558339.438 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-04-18T23:32:20.073Z,1492558340.073 [DataOverHttps] Loaded 2017-04-18T23:32:20.073Z,1492558340.073 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-04-18T23:32:20.088Z,1492558340.088 [Depth_Keller] Loaded 2017-04-18T23:32:20.088Z,1492558340.088 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-04-18T23:32:20.188Z,1492558340.188 [NAL9602] Loaded 2017-04-18T23:32:20.188Z,1492558340.188 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-04-18T23:32:20.199Z,1492558340.199 [Onboard] Loaded 2017-04-18T23:32:20.199Z,1492558340.199 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-04-18T23:32:20.206Z,1492558340.206 [Radio_Surface] Loaded 2017-04-18T23:32:20.207Z,1492558340.207 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-04-18T23:32:20.208Z,1492558340.208 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409604E0 2017-04-18T23:32:20.208Z,1492558340.208 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 853 2017-04-18T23:32:20.353Z,1492558340.353 [DAT] Loaded 2017-04-18T23:32:20.353Z,1492558340.353 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2017-04-18T23:32:20.360Z,1492558340.360 [SCPI] Loaded 2017-04-18T23:32:20.360Z,1492558340.360 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2017-04-18T23:32:20.557Z,1492558340.557 [PNI_TCM] Loaded 2017-04-18T23:32:20.557Z,1492558340.557 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-04-18T23:32:20.921Z,1492558340.921 [Rowe_600LCM] Loaded 2017-04-18T23:32:20.922Z,1492558340.921 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2017-04-18T23:32:20.923Z,1492558340.922 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409904E0 2017-04-18T23:32:20.923Z,1492558340.923 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 854 2017-04-18T23:32:22.986Z,1492558342.986 [BPC1] Loaded 2017-04-18T23:32:22.986Z,1492558342.986 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2017-04-18T23:32:22.987Z,1492558342.987 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2017-04-18T23:32:22.987Z,1492558342.987 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2017-04-18T23:32:23.125Z,1492558343.125 [BuoyancyServo] Loaded 2017-04-18T23:32:23.126Z,1492558343.126 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2017-04-18T23:32:23.142Z,1492558343.142 [ElevatorServo] Loaded 2017-04-18T23:32:23.142Z,1492558343.142 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2017-04-18T23:32:23.158Z,1492558343.158 [MassServo] Loaded 2017-04-18T23:32:23.159Z,1492558343.159 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2017-04-18T23:32:23.175Z,1492558343.175 [RudderServo] Loaded 2017-04-18T23:32:23.175Z,1492558343.175 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2017-04-18T23:32:23.191Z,1492558343.191 [ThrusterServo] Loaded 2017-04-18T23:32:23.191Z,1492558343.191 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2017-04-18T23:32:23.192Z,1492558343.192 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2017-04-18T23:32:23.192Z,1492558343.193 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-04-18T23:32:23.268Z,1492558343.268 [VerticalControl](DEBUG): Construct VerticalControl. 2017-04-18T23:32:23.364Z,1492558343.364 [VerticalControl] Loaded 2017-04-18T23:32:23.364Z,1492558343.364 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-04-18T23:32:23.365Z,1492558343.365 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-04-18T23:32:23.429Z,1492558343.429 [HorizontalControl] Loaded 2017-04-18T23:32:23.429Z,1492558343.429 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-04-18T23:32:23.430Z,1492558343.430 [SpeedControl](DEBUG): Construct SpeedControl. 2017-04-18T23:32:23.431Z,1492558343.431 [SpeedControl] Loaded 2017-04-18T23:32:23.432Z,1492558343.432 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-04-18T23:32:23.433Z,1492558343.432 [LoopControl](DEBUG): Construct LoopControl. 2017-04-18T23:32:23.433Z,1492558343.433 [LoopControl] Loaded 2017-04-18T23:32:23.433Z,1492558343.433 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-04-18T23:32:23.434Z,1492558343.434 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-04-18T23:32:23.435Z,1492558343.435 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-04-18T23:32:23.563Z,1492558343.563 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-04-18T23:32:23.564Z,1492558343.564 [StratificationFrontDetector](DEBUG): (re)initializing 2017-04-18T23:32:23.564Z,1492558343.564 [StratificationFrontDetector] Loaded 2017-04-18T23:32:23.564Z,1492558343.564 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-04-18T23:32:23.590Z,1492558343.591 [DepAvgTempFrontDetector] Loaded 2017-04-18T23:32:23.591Z,1492558343.591 [ComponentRegistry](DEBUG): SyncComponent "DepAvgTempFrontDetector" handled in the control thread. 2017-04-18T23:32:23.591Z,1492558343.591 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-04-18T23:32:23.592Z,1492558343.592 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2017-04-18T23:32:23.735Z,1492558343.735 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2017-04-18T23:32:23.739Z,1492558343.739 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2017-04-18T23:32:23.740Z,1492558343.740 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2017-04-18T23:32:23.747Z,1492558343.747 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2017-04-18T23:32:23.748Z,1492558343.748 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A9C4E0 2017-04-18T23:32:23.749Z,1492558343.749 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 855 2017-04-18T23:32:23.753Z,1492558343.753 [Supervisor](INFO): Main Thread ID is 765 2017-04-18T23:32:23.753Z,1492558343.753 [Supervisor](DEBUG): Running supervisor. 2017-04-18T23:32:23.754Z,1492558343.754 [CommandLine ThreadHandler](INFO): Handler Thread ID is 856 2017-04-18T23:32:23.757Z,1492558343.757 [controlThread ThreadHandler](INFO): Handler Thread ID is 857 2017-04-18T23:32:23.757Z,1492558343.757 [controlThread](DEBUG): Initializing ControlThread 2017-04-18T23:32:23.758Z,1492558343.758 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2017-04-18T23:32:23.759Z,1492558343.759 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2017-04-18T23:32:23.759Z,1492558343.759 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2017-04-18T23:32:23.759Z,1492558343.759 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2017-04-18T23:32:23.760Z,1492558343.760 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2017-04-18T23:32:23.761Z,1492558343.761 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2017-04-18T23:32:23.761Z,1492558343.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-04-18T23:32:23.762Z,1492558343.762 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-04-18T23:32:23.762Z,1492558343.763 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-04-18T23:32:23.763Z,1492558343.763 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-04-18T23:32:23.763Z,1492558343.763 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-04-18T23:32:23.764Z,1492558343.764 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-04-18T23:32:23.764Z,1492558343.764 [DeadReckonWithRespectToSeafloor](DEBUG): Initializing DeadReckonWithRespectToSeafloor component. 2017-04-18T23:32:23.765Z,1492558343.765 [DeadReckonWithRespectToSeafloor](INFO): Will consider orientation measurement stale after 120s. 2017-04-18T23:32:23.765Z,1492558343.765 [DeadReckonWithRespectToSeafloor](INFO): Will consider velocity measurement stale after 20s. 2017-04-18T23:32:23.765Z,1492558343.765 [NavChart](DEBUG): Initialize NavChart Navigation. 2017-04-18T23:32:23.766Z,1492558343.766 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2017-04-18T23:32:23.767Z,1492558343.767 [SBIT](INFO): Initialize SBIT Component. 2017-04-18T23:32:23.768Z,1492558343.768 [SBIT](IMPORTANT): git: 2017-04-12-3-g3a402a6 2017-04-18T23:32:23.768Z,1492558343.768 [SBIT](INFO): git hash: 3a402a68fbc2d1f037574985f21b5bcd039a347c 2017-04-18T23:32:23.770Z,1492558343.770 [SBIT](INFO): Kernel Reporting Different Release From Configuration. Kernel Expected: 2.6.27.8 Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty 2017-04-18T23:32:23.770Z,1492558343.770 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #646 PREEMPT Thu Feb 11 17:01:12 PST 2016 2017-04-18T23:32:23.771Z,1492558343.771 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2017-04-18T23:32:23.772Z,1492558343.772 [IBIT](INFO): Initialize IBIT Component. 2017-04-18T23:32:23.772Z,1492558343.773 [CBIT](DEBUG): Initialize CBIT Component. 2017-04-18T23:32:23.773Z,1492558343.773 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2017-04-18T23:32:23.773Z,1492558343.773 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2017-04-18T23:32:23.774Z,1492558343.774 [logger ThreadHandler](INFO): Handler Thread ID is 858 2017-04-18T23:32:23.792Z,1492558343.792 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 859 2017-04-18T23:32:23.793Z,1492558343.793 [WetLabsBB2FL](INFO): Powering down 2017-04-18T23:32:23.812Z,1492558343.812 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 860 2017-04-18T23:32:23.823Z,1492558343.823 [Radio_Surface](INFO): Powering up 2017-04-18T23:32:23.832Z,1492558343.832 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 861 2017-04-18T23:32:23.832Z,1492558343.832 [Rowe_600LCM](INFO): Initializing 2017-04-18T23:32:23.833Z,1492558343.833 [Rowe_600LCM](INFO): Checking LCM 2017-04-18T23:32:23.833Z,1492558343.833 [Rowe_600LCM](INFO): LCM OK 2017-04-18T23:32:23.833Z,1492558343.833 [Rowe_600LCM](INFO): Powering up 2017-04-18T23:32:23.840Z,1492558343.840 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 862 2017-04-18T23:32:23.850Z,1492558343.850 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2017-04-18T23:32:23.850Z,1492558343.850 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2017-04-18T23:32:23.850Z,1492558343.850 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2017-04-18T23:32:23.850Z,1492558343.850 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2017-04-18T23:32:23.851Z,1492558343.851 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2017-04-18T23:32:23.851Z,1492558343.851 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2017-04-18T23:32:23.851Z,1492558343.851 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2017-04-18T23:32:23.851Z,1492558343.851 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2017-04-18T23:32:23.852Z,1492558343.852 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2017-04-18T23:32:23.852Z,1492558343.852 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2017-04-18T23:32:23.852Z,1492558343.852 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2017-04-18T23:32:23.852Z,1492558343.852 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2017-04-18T23:32:23.852Z,1492558343.852 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2017-04-18T23:32:23.853Z,1492558343.853 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2017-04-18T23:32:23.853Z,1492558343.853 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2017-04-18T23:32:23.853Z,1492558343.853 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2017-04-18T23:32:23.862Z,1492558343.862 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2017-04-18T23:32:23.864Z,1492558343.864 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2017-04-18T23:32:23.865Z,1492558343.865 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2017-04-18T23:32:23.866Z,1492558343.866 [LoopControl](DEBUG): Initialize LoopControlComponent. 2017-04-18T23:32:23.867Z,1492558343.867 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2017-04-18T23:32:23.893Z,1492558343.894 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2017-04-18T23:32:23.957Z,1492558343.957 [MissionManager](DEBUG): 2017-04-18T23:32:23.957Z,1492558343.957 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2017-04-18T23:32:24.014Z,1492558344.014 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2017-04-18T23:32:24.015Z,1492558344.015 [Default:A.Wait](DEBUG): Construct Wait. 2017-04-18T23:32:24.033Z,1492558344.033 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2017-04-18T23:32:24.059Z,1492558344.059 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2017-04-18T23:32:24.062Z,1492558344.062 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2017-04-18T23:32:24.083Z,1492558344.083 [Default:E.Execute](DEBUG): Construct Execute. 2017-04-18T23:32:24.100Z,1492558344.100 [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 2017-04-18T23:32:24.113Z,1492558344.113 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,PAR_Licor,DataOverHttps,Depth_Keller,NAL9602,Onboard,DAT,SCPI,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DepAvgTempFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2017-04-18T23:32:24.197Z,1492558344.197 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2017-04-18T23:32:24.359Z,1492558344.359 [DAT](INFO): Powering up 2017-04-18T23:32:24.359Z,1492558344.359 [DAT](DEBUG): Initializing DAT. 2017-04-18T23:32:24.616Z,1492558344.616 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:24.616Z,1492558344.616 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:24.745Z,1492558344.745 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:24.767Z,1492558344.767 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:24.793Z,1492558344.793 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:24.909Z,1492558344.908 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-04-18T23:32:24.915Z,1492558344.915 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-04-18T23:32:24.938Z,1492558344.938 [ElevatorServo](DEBUG): Initializing EZServoServo. 2017-04-18T23:32:24.943Z,1492558344.944 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2017-04-18T23:32:24.967Z,1492558344.967 [MassServo](DEBUG): Initializing EZServoServo. 2017-04-18T23:32:24.975Z,1492558344.976 [MassServo](DEBUG): Initializing MassServo. 2017-04-18T23:32:24.981Z,1492558344.981 [RudderServo](DEBUG): Initializing EZServoServo. 2017-04-18T23:32:24.988Z,1492558344.987 [RudderServo](DEBUG): Initializing RudderServo. 2017-04-18T23:32:25.009Z,1492558345.009 [ThrusterServo](DEBUG): Initializing EZServoServo. 2017-04-18T23:32:25.015Z,1492558345.016 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2017-04-18T23:32:25.068Z,1492558345.068 [CommandLine](FAULT): Scheduling is paused 2017-04-18T23:32:25.068Z,1492558345.068 [CBIT](INFO): Critical error at 20170418T233223 2017-04-18T23:32:25.069Z,1492558345.069 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2017-04-18T23:32:25.365Z,1492558345.365 [NAL9602](INFO): Powering up NAL9602 2017-04-18T23:32:25.468Z,1492558345.468 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:25.468Z,1492558345.468 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:25.469Z,1492558345.469 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:25.470Z,1492558345.470 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:25.470Z,1492558345.470 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:25.823Z,1492558345.823 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2017-04-18T23:32:25.823Z,1492558345.823 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2017-04-18T23:32:25.823Z,1492558345.823 [BuoyancyServo] Communications Fault, FailCount= 1 2017-04-18T23:32:25.823Z,1492558345.823 [BuoyancyServo](ERROR): Communications Fault 2017-04-18T23:32:26.039Z,1492558346.039 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2017-04-18T23:32:26.045Z,1492558346.045 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo 4831F 454 Mode AADI Smart Sensor Terminal Protocol RS232 Protocol Version 3 Config Version 11 2017-04-18T23:32:26.045Z,1492558346.045 [Aanderaa_O2] Data Fault, FailCount= 1 2017-04-18T23:32:26.045Z,1492558346.045 [Aanderaa_O2](ERROR): Data Fault 2017-04-18T23:32:26.112Z,1492558346.112 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.112Z,1492558346.112 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:26.113Z,1492558346.113 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:26.114Z,1492558346.114 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.115Z,1492558346.115 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.136Z,1492558346.136 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2017-04-18T23:32:26.137Z,1492558346.137 [BuoyancyServo](INFO): Powering down 2017-04-18T23:32:26.224Z,1492558346.224 [CBIT](ERROR): Data Fault in component: Aanderaa_O2 2017-04-18T23:32:26.567Z,1492558346.567 [Aanderaa_O2](INFO): Powering down 2017-04-18T23:32:26.712Z,1492558346.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.712Z,1492558346.712 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:26.713Z,1492558346.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:26.714Z,1492558346.714 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.715Z,1492558346.714 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.916Z,1492558346.916 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.916Z,1492558346.916 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:26.917Z,1492558346.917 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:26.918Z,1492558346.918 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:26.918Z,1492558346.918 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:27.347Z,1492558347.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:27.347Z,1492558347.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:27.349Z,1492558347.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:27.349Z,1492558347.349 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:27.350Z,1492558347.350 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:27.475Z,1492558347.475 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2017-04-18T23:32:27.475Z,1492558347.475 [Aanderaa_O2] No Fault, FailCount= 1 2017-04-18T23:32:27.724Z,1492558347.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:27.724Z,1492558347.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:27.725Z,1492558347.725 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:27.726Z,1492558347.726 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:27.727Z,1492558347.727 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:28.148Z,1492558348.148 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-04-18T23:32:28.185Z,1492558348.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:28.185Z,1492558348.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:28.186Z,1492558348.187 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:28.187Z,1492558348.187 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:28.188Z,1492558348.188 [DeadReckonWithRespectToSeafloor](DEBUG): Starting up and don't have orientation data yet. 2017-04-18T23:32:28.320Z,1492558348.320 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2017-04-18T23:32:28.320Z,1492558348.320 [BuoyancyServo] No Fault, FailCount= 1 2017-04-18T23:32:28.354Z,1492558348.354 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null & 2017-04-18T23:32:28.575Z,1492558348.575 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:28.593Z,1492558348.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:28.621Z,1492558348.621 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-04-18T23:32:28.622Z,1492558348.622 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-04-18T23:32:28.927Z,1492558348.927 [DeadReckonUsingMultipleVelocitySources](DEBUG): All data for platform velocity is invalid. 2017-04-18T23:32:28.928Z,1492558348.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:29.224Z,1492558349.224 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-04-18T23:32:29.225Z,1492558349.225 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-04-18T23:32:29.226Z,1492558349.226 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-04-18T23:32:29.366Z,1492558349.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:29.730Z,1492558349.730 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:30.226Z,1492558350.226 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:30.586Z,1492558350.586 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:30.930Z,1492558350.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:31.377Z,1492558351.377 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:31.738Z,1492558351.738 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:32.148Z,1492558352.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:32.524Z,1492558352.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:33.109Z,1492558353.109 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:33.445Z,1492558353.445 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:33.782Z,1492558353.782 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:34.129Z,1492558354.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:34.486Z,1492558354.486 [DAT](DEBUG): 2017-04-18T23:32:34.536Z,1492558354.536 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:35.067Z,1492558355.067 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:35.353Z,1492558355.353 [DAT](DEBUG): Teledyne Benthos DAT-900 Series 2017-04-18T23:32:35.355Z,1492558355.355 [DAT](DEBUG): MF Frequency Band 2017-04-18T23:32:35.358Z,1492558355.358 [DAT](DEBUG): Directional Acoustic Transponder version 8.10.9 2017-04-18T23:32:35.555Z,1492558355.555 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:35.774Z,1492558355.774 [DAT](DEBUG): Apr 18 2017 23:31:56 2017-04-18T23:32:35.816Z,1492558355.816 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:36.155Z,1492558356.155 [DAT](DEBUG): WARNING: battery low 2017-04-18T23:32:36.157Z,1492558356.157 [DAT](DEBUG): Features enabled [Bearing] 2017-04-18T23:32:36.195Z,1492558356.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:36.501Z,1492558356.501 [NAL9602](INFO): NAL9602 initialized 2017-04-18T23:32:36.569Z,1492558356.569 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:37.056Z,1492558357.056 [DAT](INFO): entering command mode 2017-04-18T23:32:37.189Z,1492558357.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:37.449Z,1492558357.450 [DAT](DEBUG): checking for command mode acknowledgment 2017-04-18T23:32:37.602Z,1492558357.602 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:37.820Z,1492558357.820 [Aanderaa_O2](FAULT): Timed out starting 2017-04-18T23:32:37.820Z,1492558357.820 [Aanderaa_O2] Communications Fault, FailCount= 2 2017-04-18T23:32:37.820Z,1492558357.820 [Aanderaa_O2](ERROR): Communications Fault 2017-04-18T23:32:37.864Z,1492558357.864 [DAT](DEBUG): checking for command mode acknowledgment 2017-04-18T23:32:37.865Z,1492558357.865 [DAT](DEBUG): read user prompt 1: user:1> 2017-04-18T23:32:37.865Z,1492558357.865 [DAT](INFO): command mode acknowledged 2017-04-18T23:32:37.891Z,1492558357.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:37.919Z,1492558357.919 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2017-04-18T23:32:38.215Z,1492558358.215 [Aanderaa_O2](INFO): Powering down 2017-04-18T23:32:38.264Z,1492558358.264 [DAT](INFO): setting local address to 0 2017-04-18T23:32:38.305Z,1492558358.305 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:38.645Z,1492558358.645 [DAT](DEBUG): checking for local address setting acknowledgment 2017-04-18T23:32:38.647Z,1492558358.647 [DAT](INFO): set local address to 0 2017-04-18T23:32:38.829Z,1492558358.829 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:39.129Z,1492558359.129 [DAT](DEBUG): read user prompt 2: user:2> 2017-04-18T23:32:39.284Z,1492558359.284 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:39.396Z,1492558359.396 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2017-04-18T23:32:39.396Z,1492558359.396 [Aanderaa_O2] No Fault, FailCount= 2 2017-04-18T23:32:39.655Z,1492558359.655 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:39.945Z,1492558359.945 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:40.298Z,1492558360.298 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:40.845Z,1492558360.845 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:41.046Z,1492558361.046 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo 4831F 454 Mode AADI Smart Sensor Terminal Protocol RS232 Protocol Version 3 Config Version 11 2017-04-18T23:32:41.048Z,1492558361.048 [Aanderaa_O2] Data Fault, FailCount= 3 2017-04-18T23:32:41.048Z,1492558361.048 [Aanderaa_O2](ERROR): Data Fault 2017-04-18T23:32:41.347Z,1492558361.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:41.459Z,1492558361.459 [CBIT](ERROR): Data Fault in component: Aanderaa_O2 2017-04-18T23:32:41.461Z,1492558361.461 [CBIT](FAULT): Data Fault in component: Aanderaa_O2 2017-04-18T23:32:41.495Z,1492558361.494 [Aanderaa_O2](INFO): Powering down 2017-04-18T23:32:41.718Z,1492558361.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:41.928Z,1492558361.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:42.366Z,1492558362.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:42.743Z,1492558362.743 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:43.375Z,1492558363.375 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:43.736Z,1492558363.736 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:44.008Z,1492558364.008 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:44.052Z,1492558364.052 [SBIT](IMPORTANT): Beginning Startup BIT 2017-04-18T23:32:44.065Z,1492558364.065 [CBIT](IMPORTANT): Beginning ground fault scan 2017-04-18T23:32:44.375Z,1492558364.375 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:44.814Z,1492558364.814 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:45.470Z,1492558365.470 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:45.935Z,1492558365.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:46.545Z,1492558366.545 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:46.968Z,1492558366.968 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:47.518Z,1492558367.518 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:47.924Z,1492558367.924 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:48.237Z,1492558368.237 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:48.582Z,1492558368.582 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:48.970Z,1492558368.970 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:49.533Z,1492558369.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:49.989Z,1492558369.989 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:50.341Z,1492558370.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:50.722Z,1492558370.722 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:51.195Z,1492558371.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:51.650Z,1492558371.650 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:52.048Z,1492558372.048 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:52.350Z,1492558372.350 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:52.716Z,1492558372.716 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:53.217Z,1492558373.217 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:53.664Z,1492558373.664 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:54.135Z,1492558374.135 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:54.235Z,1492558374.235 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 4.681929 CHAN A1 (24V): -0.243990 CHAN A2 (12V): 4.699929 CHAN A3 (5V): -0.067988 CHAN B0 (3.3V): -0.005369 CHAN B1 (3.15aV): 4.768929 CHAN B2 (3.15bV): 0.004826 CHAN B3 (GND): -0.003240 OPEN: 0.009788 Full Scale Calc: 4.765 mA, -1.589 mA 2017-04-18T23:32:54.368Z,1492558374.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:54.767Z,1492558374.767 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:55.311Z,1492558375.311 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:55.765Z,1492558375.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:56.223Z,1492558376.223 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:56.447Z,1492558376.447 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:56.827Z,1492558376.827 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:57.388Z,1492558377.388 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:57.807Z,1492558377.806 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:58.219Z,1492558378.219 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:58.457Z,1492558378.457 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:58.827Z,1492558378.827 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:32:59.371Z,1492558379.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:00.247Z,1492558380.247 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:00.486Z,1492558380.486 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:00.878Z,1492558380.878 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:01.436Z,1492558381.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:01.853Z,1492558381.853 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:02.227Z,1492558382.227 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:02.510Z,1492558382.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:02.914Z,1492558382.914 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:03.418Z,1492558383.418 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:03.868Z,1492558383.868 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:04.200Z,1492558384.200 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:04.537Z,1492558384.537 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-04-18T23:33:04.933Z,1492558384.933 [DeadReckonUsingMultipleVelocitySources](DEBUG): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depth