2017-06-01T16:48:49.734Z,1496335729.734 [Supervisor](DEBUG): Initializing supervisor. 2017-06-01T16:48:49.739Z,1496335729.739 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2017-06-01T16:48:49.739Z,1496335729.740 [SyncHandler](INFO): Protected caller Thread ID is 765 2017-06-01T16:48:49.740Z,1496335729.740 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-06-01T16:48:49.743Z,1496335729.743 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2017-06-01T16:48:49.743Z,1496335729.743 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 766 2017-06-01T16:48:49.746Z,1496335729.746 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-06-01T16:48:49.758Z,1496335729.758 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-06-01T16:48:49.763Z,1496335729.763 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2017-06-01T16:48:49.763Z,1496335729.763 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 767 2017-06-01T16:48:49.764Z,1496335729.764 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-06-01T16:48:49.767Z,1496335729.767 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2017-06-01T16:48:49.767Z,1496335729.767 [logger ThreadHandler](INFO): Protected caller Thread ID is 768 2017-06-01T16:48:49.769Z,1496335729.769 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-06-01T16:48:49.770Z,1496335729.770 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-06-01T16:48:49.773Z,1496335729.773 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-06-01T16:48:49.983Z,1496335729.983 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-06-01T16:48:49.984Z,1496335729.984 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-06-01T16:48:50.131Z,1496335730.131 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-06-01T16:48:50.132Z,1496335730.132 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-06-01T16:48:50.499Z,1496335730.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-06-01T16:48:50.500Z,1496335730.500 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-06-01T16:48:50.655Z,1496335730.655 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-06-01T16:48:50.657Z,1496335730.657 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-06-01T16:48:50.755Z,1496335730.755 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-06-01T16:48:50.982Z,1496335730.982 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-06-01T16:48:50.983Z,1496335730.983 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-06-01T16:48:51.078Z,1496335731.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-06-01T16:48:51.079Z,1496335731.079 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-06-01T16:48:51.400Z,1496335731.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-06-01T16:48:51.400Z,1496335731.400 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-06-01T16:48:51.798Z,1496335731.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-06-01T16:48:51.799Z,1496335731.799 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-06-01T16:48:52.131Z,1496335732.131 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-06-01T16:48:52.144Z,1496335732.144 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-06-01T16:48:52.700Z,1496335732.700 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-06-01T16:48:52.701Z,1496335732.701 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-06-01T16:49:02.345Z,1496335742.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-06-01T16:49:02.346Z,1496335742.346 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-06-01T16:49:03.760Z,1496335743.760 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-06-01T16:49:03.760Z,1496335743.760 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-06-01T16:49:04.214Z,1496335744.214 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-06-01T16:49:04.215Z,1496335744.215 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-06-01T16:49:04.327Z,1496335744.327 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-06-01T16:49:04.329Z,1496335744.329 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2017-06-01T16:49:04.333Z,1496335744.333 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2017-06-01T16:49:04.572Z,1496335744.572 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-06-01T16:49:04.572Z,1496335744.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2017-06-01T16:49:04.679Z,1496335744.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2017-06-01T16:49:04.776Z,1496335744.776 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2017-06-01T16:49:04.884Z,1496335744.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2017-06-01T16:49:04.976Z,1496335744.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2017-06-01T16:49:05.110Z,1496335745.110 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2017-06-01T16:49:05.272Z,1496335745.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2017-06-01T16:49:05.373Z,1496335745.373 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2017-06-01T16:49:05.471Z,1496335745.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2017-06-01T16:49:05.560Z,1496335745.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2017-06-01T16:49:05.749Z,1496335745.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2017-06-01T16:49:05.831Z,1496335745.831 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2017-06-01T16:49:05.835Z,1496335745.835 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-06-01T16:49:06.000Z,1496335746.000 [SBIT](DEBUG): Construct Startup Built In Test. 2017-06-01T16:49:06.032Z,1496335746.032 [SBIT] Loaded 2017-06-01T16:49:06.032Z,1496335746.032 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-06-01T16:49:06.032Z,1496335746.033 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-06-01T16:49:06.061Z,1496335746.061 [IBIT] Loaded 2017-06-01T16:49:06.061Z,1496335746.061 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-06-01T16:49:06.064Z,1496335746.064 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-06-01T16:49:06.216Z,1496335746.216 [CBIT] Loaded 2017-06-01T16:49:06.216Z,1496335746.216 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-06-01T16:49:06.216Z,1496335746.217 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-06-01T16:49:06.217Z,1496335746.217 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-06-01T16:49:06.288Z,1496335746.288 [VerticalControl](DEBUG): Construct VerticalControl. 2017-06-01T16:49:06.389Z,1496335746.389 [VerticalControl] Loaded 2017-06-01T16:49:06.390Z,1496335746.390 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-06-01T16:49:06.391Z,1496335746.391 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-06-01T16:49:06.454Z,1496335746.454 [HorizontalControl] Loaded 2017-06-01T16:49:06.454Z,1496335746.454 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-06-01T16:49:06.455Z,1496335746.455 [SpeedControl](DEBUG): Construct SpeedControl. 2017-06-01T16:49:06.460Z,1496335746.460 [SpeedControl] Loaded 2017-06-01T16:49:06.461Z,1496335746.461 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-06-01T16:49:06.461Z,1496335746.461 [LoopControl](DEBUG): Construct LoopControl. 2017-06-01T16:49:06.462Z,1496335746.462 [LoopControl] Loaded 2017-06-01T16:49:06.462Z,1496335746.462 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-06-01T16:49:06.463Z,1496335746.463 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-06-01T16:49:06.463Z,1496335746.463 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-06-01T16:49:06.504Z,1496335746.504 [DepthRateCalculator] Loaded 2017-06-01T16:49:06.505Z,1496335746.505 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-06-01T16:49:06.510Z,1496335746.510 [PitchRateCalculator] Loaded 2017-06-01T16:49:06.511Z,1496335746.510 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-06-01T16:49:06.522Z,1496335746.522 [SpeedCalculator] Loaded 2017-06-01T16:49:06.522Z,1496335746.522 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-06-01T16:49:06.544Z,1496335746.544 [TempGradientCalculator] Loaded 2017-06-01T16:49:06.544Z,1496335746.544 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-06-01T16:49:06.561Z,1496335746.560 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-06-01T16:49:06.561Z,1496335746.561 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-06-01T16:49:06.566Z,1496335746.566 [YawRateCalculator] Loaded 2017-06-01T16:49:06.566Z,1496335746.566 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-06-01T16:49:06.567Z,1496335746.567 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-06-01T16:49:06.567Z,1496335746.567 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-06-01T16:49:06.690Z,1496335746.690 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-06-01T16:49:06.690Z,1496335746.690 [StratificationFrontDetector](DEBUG): (re)initializing 2017-06-01T16:49:06.690Z,1496335746.690 [StratificationFrontDetector] Loaded 2017-06-01T16:49:06.691Z,1496335746.691 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-06-01T16:49:06.714Z,1496335746.714 [DepAvgTempFrontDetector] Loaded 2017-06-01T16:49:06.715Z,1496335746.715 [ComponentRegistry](DEBUG): SyncComponent "DepAvgTempFrontDetector" handled in the control thread. 2017-06-01T16:49:06.715Z,1496335746.715 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-06-01T16:49:06.716Z,1496335746.716 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-06-01T16:49:07.002Z,1496335747.003 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-06-01T16:49:07.003Z,1496335747.003 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-06-01T16:49:07.125Z,1496335747.125 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-06-01T16:49:07.125Z,1496335747.125 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-06-01T16:49:07.180Z,1496335747.180 [DeadReckonUsingSpeedCalculator] Loaded 2017-06-01T16:49:07.181Z,1496335747.181 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-06-01T16:49:07.198Z,1496335747.198 [NavChart] Loaded 2017-06-01T16:49:07.198Z,1496335747.198 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-06-01T16:49:07.202Z,1496335747.202 [UniversalFixResidualReporter] Loaded 2017-06-01T16:49:07.203Z,1496335747.203 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-06-01T16:49:07.203Z,1496335747.203 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-06-01T16:49:07.204Z,1496335747.204 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-06-01T16:49:07.213Z,1496335747.213 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-06-01T16:49:07.214Z,1496335747.214 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-06-01T16:49:07.407Z,1496335747.407 [Aanderaa_O2] Loaded 2017-06-01T16:49:07.407Z,1496335747.407 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-06-01T16:49:07.488Z,1496335747.488 [CTD_NeilBrown] Loaded 2017-06-01T16:49:07.488Z,1496335747.488 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2017-06-01T16:49:07.490Z,1496335747.490 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 407734E0 2017-06-01T16:49:07.490Z,1496335747.490 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 850 2017-06-01T16:49:07.823Z,1496335747.823 [CTD_Seabird] Loaded 2017-06-01T16:49:07.823Z,1496335747.823 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2017-06-01T16:49:07.824Z,1496335747.824 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 407A34E0 2017-06-01T16:49:07.825Z,1496335747.825 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 851 2017-06-01T16:49:07.840Z,1496335747.840 [PAR_Licor] Loaded 2017-06-01T16:49:07.840Z,1496335747.840 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-06-01T16:49:07.891Z,1496335747.891 [WetLabsBB2FL] Loaded 2017-06-01T16:49:07.891Z,1496335747.891 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-06-01T16:49:07.892Z,1496335747.892 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407D34E0 2017-06-01T16:49:07.893Z,1496335747.893 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 852 2017-06-01T16:49:07.893Z,1496335747.893 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-06-01T16:49:07.894Z,1496335747.894 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-06-01T16:49:16.958Z,1496335756.958 [DataOverHttps] Loaded 2017-06-01T16:49:16.959Z,1496335756.959 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-06-01T16:49:16.973Z,1496335756.973 [Depth_Keller] Loaded 2017-06-01T16:49:16.973Z,1496335756.973 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-06-01T16:49:16.978Z,1496335756.978 [DropWeight] Loaded 2017-06-01T16:49:16.978Z,1496335756.978 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2017-06-01T16:49:17.072Z,1496335757.072 [NAL9602] Loaded 2017-06-01T16:49:17.072Z,1496335757.072 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-06-01T16:49:17.082Z,1496335757.082 [Onboard] Loaded 2017-06-01T16:49:17.082Z,1496335757.082 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-06-01T16:49:17.089Z,1496335757.089 [Radio_Surface] Loaded 2017-06-01T16:49:17.089Z,1496335757.089 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-06-01T16:49:17.090Z,1496335757.091 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A1E4E0 2017-06-01T16:49:17.091Z,1496335757.091 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 853 2017-06-01T16:49:17.285Z,1496335757.285 [PNI_TCM] Loaded 2017-06-01T16:49:17.285Z,1496335757.285 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-06-01T16:49:17.348Z,1496335757.348 [Rowe_600LCM] Loaded 2017-06-01T16:49:17.349Z,1496335757.349 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2017-06-01T16:49:17.350Z,1496335757.350 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A4E4E0 2017-06-01T16:49:17.350Z,1496335757.350 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 854 2017-06-01T16:49:19.458Z,1496335759.458 [BPC1] Loaded 2017-06-01T16:49:19.458Z,1496335759.458 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2017-06-01T16:49:19.459Z,1496335759.459 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2017-06-01T16:49:19.459Z,1496335759.459 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2017-06-01T16:49:19.582Z,1496335759.582 [BuoyancyServo] Loaded 2017-06-01T16:49:19.583Z,1496335759.583 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2017-06-01T16:49:19.595Z,1496335759.595 [ElevatorServo] Loaded 2017-06-01T16:49:19.595Z,1496335759.595 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2017-06-01T16:49:19.607Z,1496335759.607 [MassServo] Loaded 2017-06-01T16:49:19.608Z,1496335759.608 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2017-06-01T16:49:19.619Z,1496335759.619 [RudderServo] Loaded 2017-06-01T16:49:19.620Z,1496335759.620 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2017-06-01T16:49:19.631Z,1496335759.631 [ThrusterServo] Loaded 2017-06-01T16:49:19.632Z,1496335759.632 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2017-06-01T16:49:19.632Z,1496335759.632 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2017-06-01T16:49:19.633Z,1496335759.633 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2017-06-01T16:49:19.767Z,1496335759.767 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2017-06-01T16:49:19.767Z,1496335759.767 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2017-06-01T16:49:19.808Z,1496335759.808 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2017-06-01T16:49:19.812Z,1496335759.812 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2017-06-01T16:49:19.813Z,1496335759.813 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2017-06-01T16:49:19.820Z,1496335759.820 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2017-06-01T16:49:19.821Z,1496335759.821 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AFC4E0 2017-06-01T16:49:19.821Z,1496335759.821 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 855 2017-06-01T16:49:19.826Z,1496335759.826 [Supervisor](INFO): Main Thread ID is 764 2017-06-01T16:49:19.826Z,1496335759.826 [Supervisor](DEBUG): Running supervisor. 2017-06-01T16:49:19.827Z,1496335759.827 [CommandLine ThreadHandler](INFO): Handler Thread ID is 856 2017-06-01T16:49:19.830Z,1496335759.830 [controlThread ThreadHandler](INFO): Handler Thread ID is 857 2017-06-01T16:49:19.830Z,1496335759.830 [controlThread](DEBUG): Initializing ControlThread 2017-06-01T16:49:19.831Z,1496335759.831 [SBIT](INFO): Initialize SBIT Component. 2017-06-01T16:49:19.832Z,1496335759.832 [SBIT](IMPORTANT): git: 2017-04-25-1-g5be4203 2017-06-01T16:49:19.832Z,1496335759.832 [SBIT](INFO): git hash: 5be4203e99563ce232d7cf111035ff7c729bf400 2017-06-01T16:49:19.834Z,1496335759.834 [SBIT](INFO): Kernel Reporting Different Release From Configuration. Kernel Expected: 2.6.27.8 Kernel Reported: 2.6.27.8-00011-g2bc81df-dirty 2017-06-01T16:49:19.834Z,1496335759.834 [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-06-01T16:49:19.835Z,1496335759.835 [SBIT](INFO): Beginning SBIT in 32.000000 seconds. 2017-06-01T16:49:19.836Z,1496335759.836 [IBIT](INFO): Initialize IBIT Component. 2017-06-01T16:49:19.837Z,1496335759.837 [CBIT](DEBUG): Initialize CBIT Component. 2017-06-01T16:49:19.837Z,1496335759.837 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2017-06-01T16:49:19.838Z,1496335759.838 [logger ThreadHandler](INFO): Handler Thread ID is 858 2017-06-01T16:49:19.863Z,1496335759.863 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 859 2017-06-01T16:49:19.864Z,1496335759.864 [CTD_NeilBrown](INFO): Powering down 2017-06-01T16:49:19.892Z,1496335759.892 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 860 2017-06-01T16:49:19.892Z,1496335759.892 [CTD_Seabird](INFO): Initializing 2017-06-01T16:49:19.928Z,1496335759.928 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2017-06-01T16:49:19.930Z,1496335759.930 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2017-06-01T16:49:19.931Z,1496335759.931 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2017-06-01T16:49:19.932Z,1496335759.932 [LoopControl](DEBUG): Initialize LoopControlComponent. 2017-06-01T16:49:19.932Z,1496335759.932 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2017-06-01T16:49:19.932Z,1496335759.932 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2017-06-01T16:49:19.933Z,1496335759.933 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2017-06-01T16:49:19.933Z,1496335759.933 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2017-06-01T16:49:19.934Z,1496335759.934 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2017-06-01T16:49:19.935Z,1496335759.935 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2017-06-01T16:49:19.936Z,1496335759.935 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T16:49:19.937Z,1496335759.937 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:49:19.937Z,1496335759.937 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:49:19.937Z,1496335759.937 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T16:49:19.938Z,1496335759.938 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:49:19.938Z,1496335759.938 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:49:19.939Z,1496335759.939 [NavChart](DEBUG): Initialize NavChart Navigation. 2017-06-01T16:49:19.939Z,1496335759.939 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2017-06-01T16:49:19.952Z,1496335759.952 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2017-06-01T16:49:19.964Z,1496335759.964 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 862 2017-06-01T16:49:19.966Z,1496335759.967 [WetLabsBB2FL](INFO): Powering down 2017-06-01T16:49:19.980Z,1496335759.980 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 863 2017-06-01T16:49:19.989Z,1496335759.989 [Radio_Surface](INFO): Powering up 2017-06-01T16:49:20.012Z,1496335760.012 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 864 2017-06-01T16:49:20.013Z,1496335760.013 [Rowe_600LCM](INFO): Initializing 2017-06-01T16:49:20.019Z,1496335760.019 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T16:49:20.020Z,1496335760.020 [Rowe_600LCM](INFO): LCM OK 2017-06-01T16:49:20.020Z,1496335760.020 [Rowe_600LCM](INFO): Powering up 2017-06-01T16:49:20.025Z,1496335760.025 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2017-06-01T16:49:20.028Z,1496335760.028 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 865 2017-06-01T16:49:20.036Z,1496335760.036 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2017-06-01T16:49:20.037Z,1496335760.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2017-06-01T16:49:20.037Z,1496335760.037 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2017-06-01T16:49:20.037Z,1496335760.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2017-06-01T16:49:20.037Z,1496335760.037 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2017-06-01T16:49:20.038Z,1496335760.037 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2017-06-01T16:49:20.038Z,1496335760.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2017-06-01T16:49:20.038Z,1496335760.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2017-06-01T16:49:20.038Z,1496335760.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2017-06-01T16:49:20.038Z,1496335760.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2017-06-01T16:49:20.038Z,1496335760.039 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2017-06-01T16:49:20.039Z,1496335760.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2017-06-01T16:49:20.039Z,1496335760.039 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2017-06-01T16:49:20.039Z,1496335760.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2017-06-01T16:49:20.040Z,1496335760.040 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2017-06-01T16:49:20.040Z,1496335760.040 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2017-06-01T16:49:20.094Z,1496335760.094 [MissionManager](DEBUG): 2017-06-01T16:49:20.095Z,1496335760.095 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2017-06-01T16:49:20.182Z,1496335760.182 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2017-06-01T16:49:20.207Z,1496335760.207 [Default:A.Wait](DEBUG): Construct Wait. 2017-06-01T16:49:20.209Z,1496335760.209 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2017-06-01T16:49:20.244Z,1496335760.244 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2017-06-01T16:49:20.246Z,1496335760.246 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2017-06-01T16:49:20.256Z,1496335760.256 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2017-06-01T16:49:20.256Z,1496335760.256 [CTD_Seabird](INFO): Powering down 2017-06-01T16:49:20.292Z,1496335760.292 [Default:E.Execute](DEBUG): Construct Execute. 2017-06-01T16:49:20.320Z,1496335760.320 [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-06-01T16:49:20.326Z,1496335760.326 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,PAR_Licor,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DepAvgTempFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2017-06-01T16:49:20.399Z,1496335760.399 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2017-06-01T16:49:20.416Z,1496335760.416 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar 2017-06-01T16:49:20.622Z,1496335760.622 [DepthRateCalculator](ERROR): Depth measurement is not active 2017-06-01T16:49:20.735Z,1496335760.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:20.961Z,1496335760.961 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:21.121Z,1496335761.121 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-06-01T16:49:21.127Z,1496335761.127 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-06-01T16:49:21.138Z,1496335761.138 [ElevatorServo](DEBUG): Initializing EZServoServo. 2017-06-01T16:49:21.143Z,1496335761.143 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2017-06-01T16:49:21.165Z,1496335761.165 [MassServo](DEBUG): Initializing EZServoServo. 2017-06-01T16:49:21.171Z,1496335761.171 [MassServo](DEBUG): Initializing MassServo. 2017-06-01T16:49:21.185Z,1496335761.185 [RudderServo](DEBUG): Initializing EZServoServo. 2017-06-01T16:49:21.191Z,1496335761.191 [RudderServo](DEBUG): Initializing RudderServo. 2017-06-01T16:49:21.209Z,1496335761.209 [ThrusterServo](DEBUG): Initializing EZServoServo. 2017-06-01T16:49:21.215Z,1496335761.215 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2017-06-01T16:49:21.489Z,1496335761.489 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2017-06-01T16:49:21.489Z,1496335761.489 [DropWeight] Hardware Fault, FailCount= 1 2017-06-01T16:49:21.489Z,1496335761.489 [DropWeight](ERROR): Hardware Fault 2017-06-01T16:49:21.567Z,1496335761.566 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:21.568Z,1496335761.568 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:21.592Z,1496335761.592 [CommandLine](FAULT): Scheduling is paused 2017-06-01T16:49:21.593Z,1496335761.593 [CBIT](INFO): Critical error at 20170601T164921 2017-06-01T16:49:21.593Z,1496335761.593 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2017-06-01T16:49:21.596Z,1496335761.596 [CBIT](ERROR): Hardware Fault in component: DropWeight 2017-06-01T16:49:21.596Z,1496335761.596 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2017-06-01T16:49:24.329Z,1496335764.329 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T16:49:24.490Z,1496335764.490 [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-06-01T16:49:25.296Z,1496335765.296 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T16:49:25.297Z,1496335765.297 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T16:49:25.298Z,1496335765.298 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T16:49:31.521Z,1496335771.521 [NAL9602](INFO): Powering up NAL9602 2017-06-01T16:49:31.640Z,1496335771.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:31.642Z,1496335771.642 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:31.957Z,1496335771.957 [CBIT](INFO): Critical error at 20170601T164921 2017-06-01T16:49:32.020Z,1496335772.020 [BPC1](ERROR): Failed to parse bank B battery data 2017-06-01T16:49:32.020Z,1496335772.020 [BPC1] Data Fault, FailCount= 1 2017-06-01T16:49:32.020Z,1496335772.020 [BPC1](ERROR): Data Fault 2017-06-01T16:49:32.124Z,1496335772.124 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:32.125Z,1496335772.125 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:32.150Z,1496335772.150 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T16:49:32.431Z,1496335772.431 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:32.432Z,1496335772.432 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:32.767Z,1496335772.767 [Aanderaa_O2](INFO): Powering down 2017-06-01T16:49:32.800Z,1496335772.800 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003600 2017-06-01T16:49:32.860Z,1496335772.860 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:32.861Z,1496335772.861 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:33.223Z,1496335773.223 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:33.224Z,1496335773.224 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:33.372Z,1496335773.372 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T16:49:33.372Z,1496335773.372 [BPC1] No Fault, FailCount= 1 2017-06-01T16:49:33.703Z,1496335773.703 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:33.704Z,1496335773.704 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-06-01T16:49:42.376Z,1496335782.376 [NAL9602](INFO): NAL9602 initialized 2017-06-01T16:49:52.478Z,1496335792.478 [SBIT](IMPORTANT): Beginning Startup BIT 2017-06-01T16:49:52.499Z,1496335792.499 [CBIT](IMPORTANT): Beginning ground fault scan 2017-06-01T16:50:03.077Z,1496335803.077 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): -0.008073 CHAN A1 (24V): 0.122400 CHAN A2 (12V): -0.002283 CHAN A3 (5V): 0.000492 CHAN B0 (3.3V): 0.000531 CHAN B1 (3.15aV): -0.000245 CHAN B2 (3.15bV): 0.000239 CHAN B3 (GND): 0.000005 OPEN: -0.000467 Full Scale Calc: 4.765 mA, -1.589 mA 2017-06-01T16:50:46.608Z,1496335846.608 [SBIT](IMPORTANT): SBIT PASSED 2017-06-01T16:50:47.020Z,1496335847.020 [MissionManager](IMPORTANT): Started mission Startup 2017-06-01T16:50:47.020Z,1496335847.020 [Startup] Running Loop=1 2017-06-01T16:50:47.020Z,1496335847.020 [Startup](DEBUG): Aggregate::initialize Startup 2017-06-01T16:50:47.021Z,1496335847.020 [Startup:A.GoToSurface] Running Loop=1 2017-06-01T16:50:47.021Z,1496335847.021 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2017-06-01T16:50:47.021Z,1496335847.021 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2017-06-01T16:50:47.022Z,1496335847.022 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2017-06-01T16:50:47.022Z,1496335847.022 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2017-06-01T16:50:47.023Z,1496335847.023 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds. 2017-06-01T16:50:47.047Z,1496335847.047 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2017-06-01T16:50:47.065Z,1496335847.065 [Startup:StartupSatComms] Running Loop=1 2017-06-01T16:50:47.065Z,1496335847.065 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2017-06-01T16:50:47.065Z,1496335847.065 [Startup:StartupSatComms:A] Running Loop=1 2017-06-01T16:50:47.418Z,1496335847.418 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2017-06-01T16:51:20.251Z,1496335880.251 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T16:51:20.251Z,1496335880.251 [Rowe_600LCM] Communications Fault, FailCount= 1 2017-06-01T16:51:20.251Z,1496335880.251 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T16:51:20.614Z,1496335880.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T16:51:20.655Z,1496335880.655 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T16:51:20.673Z,1496335880.673 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T16:51:20.786Z,1496335880.786 [Rowe_600LCM](INFO): Powering down 2017-06-01T16:51:21.022Z,1496335881.022 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T16:51:24.287Z,1496335884.287 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.1 s old, using for 20.0 s. 2017-06-01T16:51:24.336Z,1496335884.336 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T16:51:24.336Z,1496335884.336 [Rowe_600LCM] No Fault, FailCount= 1 2017-06-01T16:51:24.423Z,1496335884.423 [Rowe_600LCM](INFO): Initializing 2017-06-01T16:51:24.424Z,1496335884.424 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T16:51:24.424Z,1496335884.424 [Rowe_600LCM](INFO): LCM OK 2017-06-01T16:51:24.424Z,1496335884.424 [Rowe_600LCM](INFO): Powering up 2017-06-01T16:51:24.477Z,1496335884.477 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.3 s old, using for 20.0 s. 2017-06-01T16:51:24.830Z,1496335884.830 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.6 s old, using for 20.0 s. 2017-06-01T16:51:25.226Z,1496335885.226 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.0 s old, using for 20.0 s. 2017-06-01T16:51:25.621Z,1496335885.621 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.4 s old, using for 20.0 s. 2017-06-01T16:51:26.076Z,1496335886.076 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.9 s old, using for 20.0 s. 2017-06-01T16:51:26.395Z,1496335886.395 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.2 s old, using for 20.0 s. 2017-06-01T16:51:26.826Z,1496335886.826 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.6 s old, using for 20.0 s. 2017-06-01T16:51:27.195Z,1496335887.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.0 s old, using for 20.0 s. 2017-06-01T16:51:27.632Z,1496335887.632 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.4 s old, using for 20.0 s. 2017-06-01T16:51:28.008Z,1496335888.008 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.8 s old, using for 20.0 s. 2017-06-01T16:51:28.431Z,1496335888.431 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.2 s old, using for 20.0 s. 2017-06-01T16:51:28.564Z,1496335888.564 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T16:51:28.626Z,1496335888.626 [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-06-01T16:51:28.627Z,1496335888.628 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T16:51:28.628Z,1496335888.628 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T16:51:28.629Z,1496335888.629 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T16:51:28.822Z,1496335888.822 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.6 s old, using for 20.0 s. 2017-06-01T16:51:47.211Z,1496335907.211 [Startup:StartupSatComms:A](INFO): Timed out from 2017-06-01T16:50:47.1Z 2017-06-01T16:51:47.211Z,1496335907.211 [Startup:StartupSatComms:A] Stopped 2017-06-01T16:51:47.211Z,1496335907.211 [Startup:StartupSatComms:B] Running Loop=1 2017-06-01T16:51:47.616Z,1496335907.616 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2017-06-01T16:51:55.046Z,1496335915.046 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20170531T233445/Courier0404.lzma 2017-06-01T16:51:55.610Z,1496335915.610 [DataOverHttps](INFO): Moved sent file to Logs/20170531T233445/Courier0404.lzma.bak 2017-06-01T16:51:55.610Z,1496335915.610 [DataOverHttps](INFO): SBD MOMSN=5041075 2017-06-01T16:52:05.339Z,1496335925.339 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20170531T233445/Courier0408.lzma 2017-06-01T16:52:06.094Z,1496335926.094 [DataOverHttps](INFO): Moved sent file to Logs/20170531T233445/Courier0408.lzma.bak 2017-06-01T16:52:06.094Z,1496335926.094 [DataOverHttps](INFO): SBD MOMSN=5041077 2017-06-01T16:52:15.664Z,1496335935.664 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20170601T164849/Courier0000.lzma 2017-06-01T16:52:16.430Z,1496335936.430 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Courier0000.lzma.bak 2017-06-01T16:52:16.430Z,1496335936.430 [DataOverHttps](INFO): SBD MOMSN=5041079 2017-06-01T16:52:20.694Z,1496335940.694 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T16:52:20.695Z,1496335940.694 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2017-06-01T16:52:20.695Z,1496335940.694 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T16:52:20.696Z,1496335940.696 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T16:52:20.697Z,1496335940.697 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2017-06-01T16:52:20.697Z,1496335940.697 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T16:52:20.770Z,1496335940.770 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T16:52:20.770Z,1496335940.770 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T16:52:20.909Z,1496335940.909 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T16:52:20.909Z,1496335940.909 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2017-06-01T16:52:20.910Z,1496335940.909 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T16:52:20.910Z,1496335940.910 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2017-06-01T16:52:21.284Z,1496335941.284 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T16:52:21.284Z,1496335941.284 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:52:21.285Z,1496335941.285 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:52:21.285Z,1496335941.285 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T16:52:21.286Z,1496335941.286 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:52:21.286Z,1496335941.286 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:52:25.929Z,1496335945.929 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20170531T233445/Express0405.lzma 2017-06-01T16:52:26.718Z,1496335946.718 [DataOverHttps](INFO): Moved sent file to Logs/20170531T233445/Express0405.lzma.bak 2017-06-01T16:52:26.719Z,1496335946.718 [DataOverHttps](INFO): SBD MOMSN=5041084 2017-06-01T16:52:36.316Z,1496335956.316 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20170531T233445/Express0409.lzma 2017-06-01T16:52:37.086Z,1496335957.086 [DataOverHttps](INFO): Moved sent file to Logs/20170531T233445/Express0409.lzma.bak 2017-06-01T16:52:37.086Z,1496335957.086 [DataOverHttps](INFO): SBD MOMSN=5041088 2017-06-01T16:52:46.600Z,1496335966.600 [DataOverHttps](INFO): Sending 632 bytes from file Logs/20170601T164849/Express0001.lzma 2017-06-01T16:52:47.329Z,1496335967.329 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Express0001.lzma.bak 2017-06-01T16:52:47.329Z,1496335967.329 [DataOverHttps](INFO): SBD MOMSN=5041090 2017-06-01T16:52:47.416Z,1496335967.416 [Startup:StartupSatComms:B](INFO): Timed out from 2017-06-01T16:51:47.2Z 2017-06-01T16:52:47.416Z,1496335967.416 [Startup:StartupSatComms:B] Stopped 2017-06-01T16:52:47.416Z,1496335967.416 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2017-06-01T16:52:47.416Z,1496335967.416 [Startup:StartupSatComms] Stopped 2017-06-01T16:52:47.417Z,1496335967.417 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2017-06-01T16:52:47.417Z,1496335967.417 [Startup](INFO): Completed Startup 2017-06-01T16:52:47.417Z,1496335967.418 [MissionManager](INFO): Startup is completed. 2017-06-01T16:52:47.418Z,1496335967.418 [MissionManager](INFO): Uninitializing Mission Startup 2017-06-01T16:52:47.418Z,1496335967.418 [Startup] Stopped 2017-06-01T16:52:47.418Z,1496335967.418 [Startup](DEBUG): Aggregate::uninitialize Startup 2017-06-01T16:52:47.418Z,1496335967.418 [Startup:A.GoToSurface] Stopped 2017-06-01T16:52:47.418Z,1496335967.418 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2017-06-01T16:52:47.791Z,1496335967.791 [MissionManager](IMPORTANT): Started mission Default 2017-06-01T16:52:47.791Z,1496335967.791 [Default] Running Loop=1 2017-06-01T16:52:47.791Z,1496335967.791 [Default](DEBUG): Aggregate::initialize Default 2017-06-01T16:52:47.791Z,1496335967.791 [Default:B.GoToSurface] Running Loop=1 2017-06-01T16:52:47.791Z,1496335967.791 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2017-06-01T16:52:47.792Z,1496335967.792 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2017-06-01T16:52:47.792Z,1496335967.792 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2017-06-01T16:52:47.792Z,1496335967.792 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2017-06-01T16:52:47.793Z,1496335967.793 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds. 2017-06-01T16:52:47.793Z,1496335967.793 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2017-06-01T16:52:47.793Z,1496335967.793 [Default:A.Wait] Running Loop=1 2017-06-01T16:52:47.793Z,1496335967.793 [Default:A.Wait](DEBUG): Initialize Wait Component. 2017-06-01T16:53:01.025Z,1496335981.025 [Default:A.Wait](INFO): Done Waiting. 2017-06-01T16:53:01.026Z,1496335981.026 [Default:A.Wait] Stopped 2017-06-01T16:53:01.026Z,1496335981.026 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2017-06-01T16:53:01.432Z,1496335981.432 [Default:CheckIn] Running Loop=1 2017-06-01T16:53:01.432Z,1496335981.432 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2017-06-01T16:53:01.432Z,1496335981.432 [Default:CheckIn:Read_GPS] Running Loop=1 2017-06-01T16:53:01.844Z,1496335981.844 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2017-06-01T16:53:08.612Z,1496335988.612 [BPC1](ERROR): Failed to receive battery data 2017-06-01T16:53:08.612Z,1496335988.612 [BPC1] Communications Fault, FailCount= 1 2017-06-01T16:53:08.612Z,1496335988.612 [BPC1](ERROR): Communications Fault 2017-06-01T16:53:08.634Z,1496335988.634 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T16:53:09.848Z,1496335989.848 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T16:53:09.848Z,1496335989.848 [BPC1] No Fault, FailCount= 1 2017-06-01T16:53:24.799Z,1496336004.799 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T16:53:24.799Z,1496336004.799 [Rowe_600LCM] Communications Fault, FailCount= 2 2017-06-01T16:53:24.799Z,1496336004.799 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T16:53:25.018Z,1496336005.018 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T16:53:25.032Z,1496336005.032 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T16:53:25.203Z,1496336005.203 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T16:53:25.312Z,1496336005.312 [Rowe_600LCM](INFO): Powering down 2017-06-01T16:53:25.425Z,1496336005.425 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T16:53:25.823Z,1496336005.823 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T16:53:26.219Z,1496336006.219 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T16:53:26.625Z,1496336006.625 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T16:53:26.647Z,1496336006.648 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T16:53:26.647Z,1496336006.648 [Rowe_600LCM] No Fault, FailCount= 2 2017-06-01T16:53:26.927Z,1496336006.927 [Rowe_600LCM](INFO): Initializing 2017-06-01T16:53:26.928Z,1496336006.928 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T16:53:26.928Z,1496336006.928 [Rowe_600LCM](INFO): LCM OK 2017-06-01T16:53:26.928Z,1496336006.928 [Rowe_600LCM](INFO): Powering up 2017-06-01T16:53:27.023Z,1496336007.023 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T16:53:27.426Z,1496336007.426 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T16:53:27.829Z,1496336007.829 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T16:53:28.231Z,1496336008.231 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T16:53:28.637Z,1496336008.636 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T16:53:29.030Z,1496336009.030 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T16:53:29.424Z,1496336009.424 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T16:53:29.833Z,1496336009.833 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T16:53:30.234Z,1496336010.234 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T16:53:30.634Z,1496336010.634 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T16:53:31.128Z,1496336011.128 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.5 s old, using for 20.0 s. 2017-06-01T16:53:31.142Z,1496336011.142 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T16:53:31.246Z,1496336011.246 [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-06-01T16:53:31.247Z,1496336011.247 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T16:53:31.248Z,1496336011.248 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T16:53:31.249Z,1496336011.249 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T16:53:31.456Z,1496336011.456 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T16:54:46.220Z,1496336086.220 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2017-06-01T16:55:21.458Z,1496336121.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T16:55:21.458Z,1496336121.458 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2017-06-01T16:55:21.458Z,1496336121.458 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T16:55:21.483Z,1496336121.483 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T16:55:21.483Z,1496336121.483 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2017-06-01T16:55:21.483Z,1496336121.483 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T16:55:21.521Z,1496336121.521 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T16:55:21.522Z,1496336121.522 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T16:55:21.842Z,1496336121.842 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T16:55:21.842Z,1496336121.842 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2017-06-01T16:55:21.843Z,1496336121.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T16:55:21.843Z,1496336121.843 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2017-06-01T16:55:22.246Z,1496336122.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T16:55:22.246Z,1496336122.246 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:55:22.246Z,1496336122.246 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:55:22.247Z,1496336122.247 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T16:55:22.247Z,1496336122.247 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:55:22.248Z,1496336122.248 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:55:37.803Z,1496336137.803 [BPC1](ERROR): Failed to receive battery data 2017-06-01T16:55:37.803Z,1496336137.803 [BPC1] Communications Fault, FailCount= 1 2017-06-01T16:55:37.804Z,1496336137.804 [BPC1](ERROR): Communications Fault 2017-06-01T16:55:37.849Z,1496336137.849 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T16:55:39.076Z,1496336139.076 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T16:55:39.076Z,1496336139.076 [BPC1] No Fault, FailCount= 1 2017-06-01T16:56:57.183Z,1496336217.183 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T16:56:57.183Z,1496336217.183 [Rowe_600LCM] Communications Fault, FailCount= 3 2017-06-01T16:56:57.183Z,1496336217.183 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T16:56:57.317Z,1496336217.317 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T16:56:57.338Z,1496336217.339 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T16:56:57.588Z,1496336217.588 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T16:56:57.746Z,1496336217.746 [Rowe_600LCM](INFO): Powering down 2017-06-01T16:56:57.756Z,1496336217.756 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T16:56:58.129Z,1496336218.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T16:56:58.528Z,1496336218.528 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T16:56:58.910Z,1496336218.910 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T16:56:59.319Z,1496336219.319 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T16:56:59.333Z,1496336219.333 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T16:56:59.333Z,1496336219.333 [Rowe_600LCM] No Fault, FailCount= 3 2017-06-01T16:56:59.363Z,1496336219.363 [Rowe_600LCM](INFO): Initializing 2017-06-01T16:56:59.364Z,1496336219.364 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T16:56:59.364Z,1496336219.364 [Rowe_600LCM](INFO): LCM OK 2017-06-01T16:56:59.364Z,1496336219.364 [Rowe_600LCM](INFO): Powering up 2017-06-01T16:56:59.719Z,1496336219.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T16:57:00.118Z,1496336220.118 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T16:57:00.525Z,1496336220.525 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T16:57:00.922Z,1496336220.922 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T16:57:01.321Z,1496336221.321 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T16:57:01.716Z,1496336221.716 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T16:57:02.124Z,1496336222.124 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T16:57:02.517Z,1496336222.517 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T16:57:02.921Z,1496336222.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T16:57:03.316Z,1496336223.316 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T16:57:03.487Z,1496336223.487 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T16:57:03.562Z,1496336223.562 [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-06-01T16:57:03.563Z,1496336223.563 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T16:57:03.564Z,1496336223.564 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T16:57:03.565Z,1496336223.565 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T16:57:03.771Z,1496336223.771 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T16:57:09.712Z,1496336229.712 [BPC1](ERROR): Failed to receive battery data 2017-06-01T16:57:09.712Z,1496336229.712 [BPC1] Communications Fault, FailCount= 1 2017-06-01T16:57:09.712Z,1496336229.712 [BPC1](ERROR): Communications Fault 2017-06-01T16:57:09.754Z,1496336229.754 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T16:57:10.919Z,1496336230.919 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T16:57:10.919Z,1496336230.919 [BPC1] No Fault, FailCount= 1 2017-06-01T16:57:34.520Z,1496336254.520 [PNI_TCM](ERROR): CRC does not match. Expected:0x8618 got:0x5138 2017-06-01T16:57:35.290Z,1496336255.290 [PNI_TCM](ERROR): CRC does not match. Expected:0x49920 got:0x16823 2017-06-01T16:57:38.106Z,1496336258.106 [PNI_TCM](ERROR): CRC does not match. Expected:0x51614 got:0x5149 2017-06-01T16:57:45.729Z,1496336265.728 [PNI_TCM](ERROR): CRC does not match. Expected:0x48771 got:0x1287 2017-06-01T16:57:47.296Z,1496336267.296 [PNI_TCM](ERROR): CRC does not match. Expected:0x34960 got:0x47040 2017-06-01T16:58:01.840Z,1496336281.839 [Default:CheckIn:Read_GPS](INFO): Timed out from 2017-06-01T16:53:01.4Z 2017-06-01T16:58:01.840Z,1496336281.840 [Default:CheckIn:Read_GPS] Stopped 2017-06-01T16:58:01.840Z,1496336281.840 [Default:CheckIn:Read_Iridium] Running Loop=1 2017-06-01T16:58:02.177Z,1496336282.177 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2017-06-01T16:58:06.544Z,1496336286.544 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20170601T164849/Courier0004.lzma 2017-06-01T16:58:07.317Z,1496336287.317 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Courier0004.lzma.bak 2017-06-01T16:58:07.317Z,1496336287.317 [DataOverHttps](INFO): SBD MOMSN=5041101 2017-06-01T16:58:16.767Z,1496336296.767 [DataOverHttps](INFO): Sending 245 bytes from file Logs/20170601T164849/Express0005.lzma 2017-06-01T16:58:17.517Z,1496336297.517 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Express0005.lzma.bak 2017-06-01T16:58:17.517Z,1496336297.517 [DataOverHttps](INFO): SBD MOMSN=5041103 2017-06-01T16:58:17.994Z,1496336297.994 [Default:CheckIn:Read_Iridium] Stopped 2017-06-01T16:58:17.995Z,1496336297.995 [Default:CheckIn:C.Wait] Running Loop=1 2017-06-01T16:58:17.995Z,1496336297.995 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2017-06-01T16:58:22.295Z,1496336302.295 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T16:58:22.296Z,1496336302.296 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2017-06-01T16:58:22.296Z,1496336302.296 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T16:58:22.297Z,1496336302.297 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T16:58:22.298Z,1496336302.297 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2017-06-01T16:58:22.298Z,1496336302.298 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T16:58:22.330Z,1496336302.330 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T16:58:22.330Z,1496336302.330 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T16:58:22.741Z,1496336302.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T16:58:22.741Z,1496336302.741 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2017-06-01T16:58:22.742Z,1496336302.741 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T16:58:22.742Z,1496336302.742 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2017-06-01T16:58:23.102Z,1496336303.102 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T16:58:23.102Z,1496336303.102 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:58:23.103Z,1496336303.103 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:58:23.103Z,1496336303.103 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T16:58:23.104Z,1496336303.104 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T16:58:23.104Z,1496336303.104 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T16:58:59.691Z,1496336339.691 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T16:58:59.691Z,1496336339.691 [Rowe_600LCM] Communications Fault, FailCount= 4 2017-06-01T16:58:59.691Z,1496336339.691 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T16:58:59.931Z,1496336339.931 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T16:58:59.944Z,1496336339.944 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T16:59:00.095Z,1496336340.095 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T16:59:00.185Z,1496336340.185 [Rowe_600LCM](INFO): Powering down 2017-06-01T16:59:00.333Z,1496336340.333 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T16:59:00.715Z,1496336340.715 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T16:59:01.120Z,1496336341.120 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T16:59:01.498Z,1496336341.498 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T16:59:01.529Z,1496336341.529 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T16:59:01.529Z,1496336341.529 [Rowe_600LCM] No Fault, FailCount= 4 2017-06-01T16:59:01.799Z,1496336341.799 [Rowe_600LCM](INFO): Initializing 2017-06-01T16:59:01.800Z,1496336341.800 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T16:59:01.800Z,1496336341.800 [Rowe_600LCM](INFO): LCM OK 2017-06-01T16:59:01.800Z,1496336341.800 [Rowe_600LCM](INFO): Powering up 2017-06-01T16:59:01.899Z,1496336341.899 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T16:59:02.301Z,1496336342.302 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T16:59:02.711Z,1496336342.711 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T16:59:03.108Z,1496336343.108 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T16:59:03.498Z,1496336343.498 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T16:59:03.891Z,1496336343.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T16:59:04.297Z,1496336344.297 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T16:59:04.701Z,1496336344.701 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T16:59:05.105Z,1496336345.105 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T16:59:05.509Z,1496336345.509 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T16:59:05.960Z,1496336345.960 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T16:59:06.057Z,1496336346.057 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T16:59:06.122Z,1496336346.122 [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-06-01T16:59:06.123Z,1496336346.123 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T16:59:06.124Z,1496336346.124 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T16:59:06.124Z,1496336346.125 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T16:59:06.325Z,1496336346.325 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T16:59:43.337Z,1496336383.337 [NAL9602](FAULT): GPS failed to acquire within timeout. 2017-06-01T16:59:43.337Z,1496336383.337 [NAL9602] Data Fault, FailCount= 1 2017-06-01T16:59:43.337Z,1496336383.337 [NAL9602](ERROR): Data Fault 2017-06-01T16:59:43.424Z,1496336383.424 [CBIT](ERROR): Data Fault in component: NAL9602 2017-06-01T16:59:43.740Z,1496336383.740 [NAL9602](INFO): Powering down 2017-06-01T16:59:44.595Z,1496336384.595 [CBIT](INFO): Clearing failed state for component NAL9602 2017-06-01T16:59:44.595Z,1496336384.595 [NAL9602] No Fault, FailCount= 1 2017-06-01T16:59:48.942Z,1496336388.941 [NAL9602](INFO): Powering up NAL9602 2017-06-01T17:00:00.156Z,1496336400.156 [NAL9602](INFO): NAL9602 initialized 2017-06-01T17:01:02.115Z,1496336462.115 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T17:01:02.115Z,1496336462.115 [Rowe_600LCM] Communications Fault, FailCount= 5 2017-06-01T17:01:02.115Z,1496336462.115 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T17:01:02.169Z,1496336462.169 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T17:01:02.198Z,1496336462.198 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T17:01:02.199Z,1496336462.198 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM 2017-06-01T17:01:02.521Z,1496336462.521 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:01:02.604Z,1496336462.604 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T17:01:02.729Z,1496336462.729 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:01:02.987Z,1496336462.987 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:01:03.356Z,1496336463.355 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:01:03.763Z,1496336463.763 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:01:04.168Z,1496336464.168 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:01:04.562Z,1496336464.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:01:04.957Z,1496336464.957 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:01:05.366Z,1496336465.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:01:05.766Z,1496336465.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:01:06.173Z,1496336466.173 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:01:06.626Z,1496336466.625 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.9 s old, using for 20.0 s. 2017-06-01T17:01:06.952Z,1496336466.952 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:01:07.384Z,1496336467.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:01:07.767Z,1496336467.767 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:01:08.192Z,1496336468.192 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:01:08.593Z,1496336468.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:01:08.954Z,1496336468.954 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:01:09.362Z,1496336469.362 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:01:09.765Z,1496336469.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:01:10.187Z,1496336470.187 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:01:10.568Z,1496336470.568 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:01:10.961Z,1496336470.961 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:01:11.353Z,1496336471.353 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:01:11.761Z,1496336471.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s. 2017-06-01T17:01:12.160Z,1496336472.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s. 2017-06-01T17:01:12.571Z,1496336472.571 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s. 2017-06-01T17:01:12.997Z,1496336472.997 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:01:13.368Z,1496336473.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s. 2017-06-01T17:01:13.746Z,1496336473.746 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:01:14.162Z,1496336474.162 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s. 2017-06-01T17:01:14.556Z,1496336474.556 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s. 2017-06-01T17:01:14.937Z,1496336474.937 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:01:15.346Z,1496336475.346 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s. 2017-06-01T17:01:15.774Z,1496336475.774 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:01:16.180Z,1496336476.180 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s. 2017-06-01T17:01:16.570Z,1496336476.570 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s. 2017-06-01T17:01:16.975Z,1496336476.975 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:01:17.375Z,1496336477.375 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s. 2017-06-01T17:01:17.750Z,1496336477.750 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s. 2017-06-01T17:01:18.149Z,1496336478.149 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s. 2017-06-01T17:01:18.554Z,1496336478.554 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s. 2017-06-01T17:01:18.961Z,1496336478.961 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:01:19.384Z,1496336479.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s. 2017-06-01T17:01:23.251Z,1496336483.251 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:01:23.251Z,1496336483.251 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2017-06-01T17:01:23.251Z,1496336483.251 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:01:23.253Z,1496336483.253 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:01:23.253Z,1496336483.253 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2017-06-01T17:01:23.253Z,1496336483.253 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:01:23.265Z,1496336483.265 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:01:23.266Z,1496336483.266 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:01:23.626Z,1496336483.626 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:01:23.626Z,1496336483.626 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2017-06-01T17:01:23.626Z,1496336483.626 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:01:23.626Z,1496336483.626 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2017-06-01T17:01:24.052Z,1496336484.052 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:01:24.052Z,1496336484.052 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:01:24.052Z,1496336484.052 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:01:24.053Z,1496336484.053 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:01:24.053Z,1496336484.053 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:01:24.054Z,1496336484.053 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:01:24.425Z,1496336484.425 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:01:24.780Z,1496336484.780 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.5 s old, using for 20.0 s. 2017-06-01T17:01:25.214Z,1496336485.214 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:01:25.613Z,1496336485.613 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:01:26.012Z,1496336486.012 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:01:26.405Z,1496336486.405 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:01:26.781Z,1496336486.781 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.5 s old, using for 20.0 s. 2017-06-01T17:01:27.189Z,1496336487.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.9 s old, using for 20.0 s. 2017-06-01T17:01:27.585Z,1496336487.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.3 s old, using for 20.0 s. 2017-06-01T17:01:27.985Z,1496336487.986 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.7 s old, using for 20.0 s. 2017-06-01T17:01:28.389Z,1496336488.389 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.1 s old, using for 20.0 s. 2017-06-01T17:01:28.792Z,1496336488.792 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.5 s old, using for 20.0 s. 2017-06-01T17:01:29.193Z,1496336489.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.9 s old, using for 20.0 s. 2017-06-01T17:01:29.597Z,1496336489.597 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.3 s old, using for 20.0 s. 2017-06-01T17:01:29.974Z,1496336489.974 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.7 s old, using for 20.0 s. 2017-06-01T17:01:30.409Z,1496336490.409 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:01:30.807Z,1496336490.806 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:01:31.200Z,1496336491.200 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:01:31.601Z,1496336491.602 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:01:31.982Z,1496336491.982 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.7 s old, using for 20.0 s. 2017-06-01T17:01:32.411Z,1496336492.411 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:01:32.821Z,1496336492.821 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:01:33.189Z,1496336493.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.9 s old, using for 20.0 s. 2017-06-01T17:01:33.590Z,1496336493.590 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.3 s old, using for 20.0 s. 2017-06-01T17:01:33.987Z,1496336493.987 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.7 s old, using for 20.0 s. 2017-06-01T17:01:34.401Z,1496336494.401 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:01:34.797Z,1496336494.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.5 s old, using for 20.0 s. 2017-06-01T17:01:35.205Z,1496336495.204 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:01:35.579Z,1496336495.579 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.3 s old, using for 20.0 s. 2017-06-01T17:01:35.986Z,1496336495.986 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.7 s old, using for 20.0 s. 2017-06-01T17:01:36.460Z,1496336496.460 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:01:36.811Z,1496336496.811 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.5 s old, using for 20.0 s. 2017-06-01T17:01:37.241Z,1496336497.240 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:01:37.587Z,1496336497.587 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.3 s old, using for 20.0 s. 2017-06-01T17:01:38.019Z,1496336498.019 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s. 2017-06-01T17:01:38.426Z,1496336498.426 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:01:38.795Z,1496336498.795 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.5 s old, using for 20.0 s. 2017-06-01T17:01:39.193Z,1496336499.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.9 s old, using for 20.0 s. 2017-06-01T17:01:39.595Z,1496336499.595 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.3 s old, using for 20.0 s. 2017-06-01T17:01:39.993Z,1496336499.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.7 s old, using for 20.0 s. 2017-06-01T17:01:40.400Z,1496336500.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:01:40.796Z,1496336500.796 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.5 s old, using for 20.0 s. 2017-06-01T17:01:41.192Z,1496336501.192 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.9 s old, using for 20.0 s. 2017-06-01T17:01:41.585Z,1496336501.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.3 s old, using for 20.0 s. 2017-06-01T17:01:41.983Z,1496336501.983 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.7 s old, using for 20.0 s. 2017-06-01T17:01:42.397Z,1496336502.397 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.1 s old, using for 20.0 s. 2017-06-01T17:01:42.797Z,1496336502.797 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.5 s old, using for 20.0 s. 2017-06-01T17:01:43.193Z,1496336503.193 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.9 s old, using for 20.0 s. 2017-06-01T17:02:53.379Z,1496336573.379 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:02:53.380Z,1496336573.379 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:02:53.380Z,1496336573.380 [BPC1](ERROR): Communications Fault 2017-06-01T17:02:53.402Z,1496336573.402 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:02:54.594Z,1496336574.594 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:02:54.594Z,1496336574.594 [BPC1] No Fault, FailCount= 1 2017-06-01T17:03:18.576Z,1496336598.576 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2017-06-01T17:03:18.576Z,1496336598.576 [Default:CheckIn:C.Wait] Stopped 2017-06-01T17:03:18.576Z,1496336598.576 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2017-06-01T17:03:18.576Z,1496336598.576 [Default:CheckIn:D] Running Loop=1 2017-06-01T17:03:18.984Z,1496336598.984 [Default:CheckIn:D] Stopped 2017-06-01T17:03:18.984Z,1496336598.984 [Default:CheckIn:E] Running Loop=1 2017-06-01T17:03:19.381Z,1496336599.381 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.519847 min 2017-06-01T17:03:19.383Z,1496336599.383 [Default:CheckIn:E] Stopped 2017-06-01T17:03:19.383Z,1496336599.383 [Default:CheckIn](INFO): Completed Default:CheckIn 2017-06-01T17:03:19.383Z,1496336599.383 [Default:CheckIn] Stopped 2017-06-01T17:03:19.384Z,1496336599.384 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2017-06-01T17:03:19.384Z,1496336599.384 [Default:CheckIn](INFO): Running loop #2 2017-06-01T17:03:19.384Z,1496336599.384 [Default:CheckIn] Running Loop=2 2017-06-01T17:03:19.384Z,1496336599.384 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2017-06-01T17:03:19.384Z,1496336599.384 [Default:CheckIn:Read_GPS] Running Loop=1 2017-06-01T17:03:27.569Z,1496336607.569 [PNI_TCM](ERROR): CRC does not match. Expected:0x32666 got:0x7103 2017-06-01T17:03:30.766Z,1496336610.766 [PNI_TCM](ERROR): CRC does not match. Expected:0x12237 got:0x62407 2017-06-01T17:03:37.178Z,1496336617.178 [PNI_TCM](ERROR): CRC does not match. Expected:0x49641 got:0x49927 2017-06-01T17:04:09.568Z,1496336649.568 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:04:09.568Z,1496336649.568 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:04:09.568Z,1496336649.569 [BPC1](ERROR): Communications Fault 2017-06-01T17:04:09.612Z,1496336649.612 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:04:10.814Z,1496336650.814 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:04:10.814Z,1496336650.814 [BPC1] No Fault, FailCount= 1 2017-06-01T17:04:23.356Z,1496336663.356 [CBIT](INFO): Clearing failed state for component DropWeight 2017-06-01T17:04:23.356Z,1496336663.356 [DropWeight] No Fault, FailCount= 1 2017-06-01T17:04:24.246Z,1496336664.246 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:04:24.247Z,1496336664.247 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2017-06-01T17:04:24.247Z,1496336664.247 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:04:24.249Z,1496336664.249 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:04:24.250Z,1496336664.250 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2017-06-01T17:04:24.250Z,1496336664.250 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:04:24.264Z,1496336664.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:04:24.264Z,1496336664.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:04:24.668Z,1496336664.668 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:04:24.668Z,1496336664.668 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2017-06-01T17:04:24.669Z,1496336664.669 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:04:24.669Z,1496336664.669 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2017-06-01T17:04:25.045Z,1496336665.046 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:04:25.046Z,1496336665.046 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:04:25.046Z,1496336665.046 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:04:25.047Z,1496336665.047 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:04:25.047Z,1496336665.047 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:04:25.048Z,1496336665.048 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:04:25.424Z,1496336665.424 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:04:25.822Z,1496336665.822 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:04:26.222Z,1496336666.222 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:04:26.633Z,1496336666.633 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:04:27.032Z,1496336667.032 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:04:27.421Z,1496336667.421 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:04:27.825Z,1496336667.825 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:04:28.225Z,1496336668.225 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:04:28.626Z,1496336668.626 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:04:29.014Z,1496336669.014 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:04:29.435Z,1496336669.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:04:29.841Z,1496336669.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:04:30.238Z,1496336670.238 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:04:30.634Z,1496336670.634 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:04:31.038Z,1496336671.038 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:04:31.430Z,1496336671.430 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:04:31.815Z,1496336671.815 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:04:32.218Z,1496336672.218 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:04:32.617Z,1496336672.617 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:04:33.020Z,1496336673.020 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:04:33.421Z,1496336673.421 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:04:33.821Z,1496336673.821 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:04:34.217Z,1496336674.217 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s. 2017-06-01T17:04:34.625Z,1496336674.625 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s. 2017-06-01T17:04:35.028Z,1496336675.028 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s. 2017-06-01T17:04:35.432Z,1496336675.432 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:04:35.854Z,1496336675.854 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s. 2017-06-01T17:04:36.229Z,1496336676.230 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:04:36.629Z,1496336676.629 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s. 2017-06-01T17:04:37.072Z,1496336677.072 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s. 2017-06-01T17:04:37.428Z,1496336677.428 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:04:37.820Z,1496336677.820 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s. 2017-06-01T17:04:38.265Z,1496336678.265 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:04:38.635Z,1496336678.635 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s. 2017-06-01T17:04:39.066Z,1496336679.066 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s. 2017-06-01T17:04:39.424Z,1496336679.424 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:04:39.841Z,1496336679.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s. 2017-06-01T17:04:40.222Z,1496336680.222 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s. 2017-06-01T17:04:40.627Z,1496336680.626 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s. 2017-06-01T17:04:41.024Z,1496336681.024 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s. 2017-06-01T17:04:41.439Z,1496336681.439 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:04:41.835Z,1496336681.835 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s. 2017-06-01T17:04:42.233Z,1496336682.233 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s. 2017-06-01T17:04:42.617Z,1496336682.617 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s. 2017-06-01T17:04:43.016Z,1496336683.016 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s. 2017-06-01T17:04:43.433Z,1496336683.433 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s. 2017-06-01T17:04:43.829Z,1496336683.829 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s. 2017-06-01T17:04:44.234Z,1496336684.234 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s. 2017-06-01T17:05:00.228Z,1496336700.228 [PNI_TCM](ERROR): CRC does not match. Expected:0x18034 got:0x43036 2017-06-01T17:05:01.006Z,1496336701.006 [PNI_TCM](ERROR): CRC does not match. Expected:0x33381 got:0x30602 2017-06-01T17:05:03.824Z,1496336703.824 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.387800 seconds old. 2017-06-01T17:05:03.825Z,1496336703.825 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.388200 seconds old. 2017-06-01T17:05:04.244Z,1496336704.244 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.807800 seconds old. 2017-06-01T17:05:04.245Z,1496336704.245 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.808100 seconds old. 2017-06-01T17:05:04.628Z,1496336704.628 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.191800 seconds old. 2017-06-01T17:05:04.629Z,1496336704.629 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.192100 seconds old. 2017-06-01T17:05:08.219Z,1496336708.219 [PNI_TCM](ERROR): CRC does not match. Expected:0x47088 got:0x7233 2017-06-01T17:05:35.585Z,1496336735.585 [BPC1](ERROR): Failed to parse bank B battery data 2017-06-01T17:05:35.585Z,1496336735.585 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:05:35.585Z,1496336735.585 [BPC1](ERROR): Data Fault 2017-06-01T17:05:35.615Z,1496336735.615 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:05:36.816Z,1496336736.816 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:05:36.816Z,1496336736.816 [BPC1] No Fault, FailCount= 1 2017-06-01T17:05:49.612Z,1496336749.612 [BPC1](ERROR): Failed to parse bank B battery data 2017-06-01T17:05:49.612Z,1496336749.612 [BPC1] Data Fault, FailCount= 2 2017-06-01T17:05:49.612Z,1496336749.612 [BPC1](ERROR): Data Fault 2017-06-01T17:05:49.653Z,1496336749.653 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:05:50.818Z,1496336750.818 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:05:50.818Z,1496336750.818 [BPC1] No Fault, FailCount= 2 2017-06-01T17:06:17.166Z,1496336777.166 [BPC1](ERROR): Failed to parse bank A battery data 2017-06-01T17:06:17.166Z,1496336777.166 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:06:17.166Z,1496336777.166 [BPC1](ERROR): Data Fault 2017-06-01T17:06:17.229Z,1496336777.229 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:06:18.427Z,1496336778.427 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:06:18.427Z,1496336778.427 [BPC1] No Fault, FailCount= 1 2017-06-01T17:06:49.327Z,1496336809.327 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:06:49.327Z,1496336809.327 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:06:49.327Z,1496336809.327 [BPC1](ERROR): Communications Fault 2017-06-01T17:06:49.390Z,1496336809.390 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:06:50.566Z,1496336810.566 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:06:50.566Z,1496336810.566 [BPC1] No Fault, FailCount= 1 2017-06-01T17:07:25.132Z,1496336845.132 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:07:25.132Z,1496336845.132 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2017-06-01T17:07:25.132Z,1496336845.132 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:07:25.134Z,1496336845.134 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:07:25.134Z,1496336845.134 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2017-06-01T17:07:25.134Z,1496336845.135 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:07:25.147Z,1496336845.147 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:07:25.147Z,1496336845.147 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:07:25.543Z,1496336845.543 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:07:25.543Z,1496336845.543 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2017-06-01T17:07:25.544Z,1496336845.543 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:07:25.544Z,1496336845.544 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2017-06-01T17:07:25.932Z,1496336845.932 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:07:25.933Z,1496336845.933 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:07:25.933Z,1496336845.933 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:07:25.933Z,1496336845.933 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:07:25.934Z,1496336845.934 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:07:25.934Z,1496336845.934 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:07:26.307Z,1496336846.307 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:07:26.713Z,1496336846.713 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:07:27.101Z,1496336847.102 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:07:27.500Z,1496336847.500 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:07:27.897Z,1496336847.897 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:07:28.300Z,1496336848.300 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:07:28.707Z,1496336848.707 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:07:29.117Z,1496336849.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:07:29.516Z,1496336849.516 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:07:29.919Z,1496336849.919 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:07:30.312Z,1496336850.312 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:07:30.688Z,1496336850.688 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:07:31.090Z,1496336851.090 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:07:31.492Z,1496336851.492 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:07:31.925Z,1496336851.925 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:07:32.329Z,1496336852.329 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:07:32.723Z,1496336852.723 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:07:33.100Z,1496336853.100 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:07:33.501Z,1496336853.501 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:07:33.900Z,1496336853.901 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:07:34.299Z,1496336854.299 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:07:34.705Z,1496336854.705 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:07:35.130Z,1496336855.130 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s. 2017-06-01T17:07:35.504Z,1496336855.504 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s. 2017-06-01T17:07:35.908Z,1496336855.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s. 2017-06-01T17:07:36.315Z,1496336856.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:07:36.741Z,1496336856.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s. 2017-06-01T17:07:37.102Z,1496336857.102 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:07:37.510Z,1496336857.510 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s. 2017-06-01T17:07:37.938Z,1496336857.938 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s. 2017-06-01T17:07:38.319Z,1496336858.319 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:07:38.749Z,1496336858.749 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s. 2017-06-01T17:07:39.103Z,1496336859.103 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:07:39.559Z,1496336859.559 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s. 2017-06-01T17:07:39.926Z,1496336859.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s. 2017-06-01T17:07:40.310Z,1496336860.310 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:07:40.708Z,1496336860.708 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s. 2017-06-01T17:07:41.114Z,1496336861.114 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s. 2017-06-01T17:07:41.513Z,1496336861.513 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s. 2017-06-01T17:07:41.914Z,1496336861.914 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s. 2017-06-01T17:07:42.307Z,1496336862.307 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:07:42.709Z,1496336862.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s. 2017-06-01T17:07:43.109Z,1496336863.109 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s. 2017-06-01T17:07:43.508Z,1496336863.508 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s. 2017-06-01T17:07:43.922Z,1496336863.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s. 2017-06-01T17:07:44.322Z,1496336864.322 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s. 2017-06-01T17:07:44.729Z,1496336864.729 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s. 2017-06-01T17:07:45.087Z,1496336865.087 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s. 2017-06-01T17:08:19.567Z,1496336899.567 [Default:CheckIn:Read_GPS](INFO): Timed out from 2017-06-01T17:03:19.4Z 2017-06-01T17:08:19.567Z,1496336899.567 [Default:CheckIn:Read_GPS] Stopped 2017-06-01T17:08:19.567Z,1496336899.568 [Default:CheckIn:Read_Iridium] Running Loop=1 2017-06-01T17:08:24.072Z,1496336904.072 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20170601T164849/Courier0008.lzma 2017-06-01T17:08:24.873Z,1496336904.873 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Courier0008.lzma.bak 2017-06-01T17:08:24.873Z,1496336904.873 [DataOverHttps](INFO): SBD MOMSN=5041109 2017-06-01T17:08:34.060Z,1496336914.060 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20170601T164849/Express0009.lzma 2017-06-01T17:08:34.802Z,1496336914.802 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Express0009.lzma.bak 2017-06-01T17:08:34.802Z,1496336914.802 [DataOverHttps](INFO): SBD MOMSN=5041111 2017-06-01T17:08:35.288Z,1496336915.288 [Default:CheckIn:Read_Iridium] Stopped 2017-06-01T17:08:35.289Z,1496336915.289 [Default:CheckIn:C.Wait] Running Loop=1 2017-06-01T17:08:35.289Z,1496336915.289 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2017-06-01T17:08:40.000Z,1496336921.000 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:41.394Z,1496336921.394 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:41.803Z,1496336921.803 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:42.215Z,1496336922.215 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:42.615Z,1496336922.615 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:43.003Z,1496336923.003 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:43.407Z,1496336923.407 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:43.806Z,1496336923.806 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:44.197Z,1496336924.197 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:44.607Z,1496336924.607 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:45.012Z,1496336925.012 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:45.411Z,1496336925.411 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:45.813Z,1496336925.813 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:46.189Z,1496336926.189 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:46.589Z,1496336926.589 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:46.990Z,1496336926.990 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:47.407Z,1496336927.408 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:47.813Z,1496336927.813 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:48.218Z,1496336928.218 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:48.608Z,1496336928.608 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:08:48.993Z,1496336928.993 [PNI_TCM](DEBUG): LCB error: Software Overcurrent. 2017-06-01T17:09:16.603Z,1496336956.603 [PNI_TCM](ERROR): CRC does not match. Expected:0x62232 got:0x18769 2017-06-01T17:09:22.605Z,1496336962.605 [PNI_TCM](ERROR): CRC does not match. Expected:0x58691 got:0x22299 2017-06-01T17:09:25.409Z,1496336965.409 [PNI_TCM](ERROR): CRC does not match. Expected:0x48450 got:0x3056 2017-06-01T17:09:27.020Z,1496336967.020 [PNI_TCM](ERROR): CRC does not match. Expected:0x61927 got:0x1797 2017-06-01T17:10:02.837Z,1496337002.837 [NAL9602](FAULT): GPS failed to acquire within timeout. 2017-06-01T17:10:02.837Z,1496337002.837 [NAL9602] Data Fault, FailCount= 2 2017-06-01T17:10:02.837Z,1496337002.837 [NAL9602](ERROR): Data Fault 2017-06-01T17:10:02.915Z,1496337002.915 [CBIT](ERROR): Data Fault in component: NAL9602 2017-06-01T17:10:03.240Z,1496337003.240 [NAL9602](INFO): Powering down 2017-06-01T17:10:04.110Z,1496337004.110 [CBIT](INFO): Clearing failed state for component NAL9602 2017-06-01T17:10:04.110Z,1496337004.110 [NAL9602] No Fault, FailCount= 2 2017-06-01T17:10:08.433Z,1496337008.433 [NAL9602](INFO): Powering up NAL9602 2017-06-01T17:10:19.629Z,1496337019.629 [NAL9602](INFO): NAL9602 initialized 2017-06-01T17:10:26.104Z,1496337026.104 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:10:26.104Z,1496337026.104 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2017-06-01T17:10:26.104Z,1496337026.104 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:10:26.111Z,1496337026.111 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:10:26.111Z,1496337026.111 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2017-06-01T17:10:26.111Z,1496337026.111 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:10:26.129Z,1496337026.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:10:26.129Z,1496337026.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:10:26.495Z,1496337026.495 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:10:26.495Z,1496337026.495 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2017-06-01T17:10:26.496Z,1496337026.496 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:10:26.496Z,1496337026.496 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2017-06-01T17:10:26.889Z,1496337026.889 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:10:26.890Z,1496337026.890 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:10:26.891Z,1496337026.891 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:10:26.903Z,1496337026.903 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:10:26.903Z,1496337026.903 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:10:26.904Z,1496337026.904 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:10:27.280Z,1496337027.280 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:10:27.682Z,1496337027.682 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:10:28.073Z,1496337028.073 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:10:28.466Z,1496337028.466 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:10:28.873Z,1496337028.872 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:10:29.289Z,1496337029.289 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:10:29.691Z,1496337029.691 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:10:30.094Z,1496337030.094 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:10:30.489Z,1496337030.489 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:10:30.863Z,1496337030.862 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:10:31.285Z,1496337031.286 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:10:31.669Z,1496337031.669 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:10:32.087Z,1496337032.087 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:10:32.471Z,1496337032.471 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:10:32.900Z,1496337032.900 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:10:33.280Z,1496337033.280 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:10:33.668Z,1496337033.668 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:10:34.079Z,1496337034.079 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:10:34.478Z,1496337034.478 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:10:34.883Z,1496337034.883 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:10:35.296Z,1496337035.296 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:10:35.683Z,1496337035.683 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:10:36.161Z,1496337036.161 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.1 s old, using for 20.0 s. 2017-06-01T17:10:39.336Z,1496337039.336 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:10:39.481Z,1496337039.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.4 s old, using for 20.0 s. 2017-06-01T17:10:39.832Z,1496337039.832 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.7 s old, using for 20.0 s. 2017-06-01T17:10:40.257Z,1496337040.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.2 s old, using for 20.0 s. 2017-06-01T17:10:40.629Z,1496337040.629 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.5 s old, using for 20.0 s. 2017-06-01T17:10:41.034Z,1496337041.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.9 s old, using for 20.0 s. 2017-06-01T17:10:41.435Z,1496337041.435 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.3 s old, using for 20.0 s. 2017-06-01T17:10:41.805Z,1496337041.805 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s. 2017-06-01T17:10:42.207Z,1496337042.207 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.1 s old, using for 20.0 s. 2017-06-01T17:10:42.611Z,1496337042.611 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.5 s old, using for 20.0 s. 2017-06-01T17:10:43.011Z,1496337043.011 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.9 s old, using for 20.0 s. 2017-06-01T17:10:43.405Z,1496337043.405 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.3 s old, using for 20.0 s. 2017-06-01T17:10:43.804Z,1496337043.804 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.7 s old, using for 20.0 s. 2017-06-01T17:10:44.219Z,1496337044.219 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.1 s old, using for 20.0 s. 2017-06-01T17:10:44.610Z,1496337044.611 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.5 s old, using for 20.0 s. 2017-06-01T17:10:45.018Z,1496337045.018 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.9 s old, using for 20.0 s. 2017-06-01T17:10:45.417Z,1496337045.417 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.3 s old, using for 20.0 s. 2017-06-01T17:10:45.827Z,1496337045.827 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.7 s old, using for 20.0 s. 2017-06-01T17:11:02.234Z,1496337062.234 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T17:11:02.234Z,1496337062.234 [Rowe_600LCM] No Fault, FailCount= 5 2017-06-01T17:11:02.569Z,1496337062.569 [Rowe_600LCM](INFO): Initializing 2017-06-01T17:11:02.569Z,1496337062.569 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T17:11:02.569Z,1496337062.569 [Rowe_600LCM](INFO): LCM OK 2017-06-01T17:11:02.569Z,1496337062.569 [Rowe_600LCM](INFO): Powering up 2017-06-01T17:11:06.771Z,1496337066.771 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T17:11:06.834Z,1496337066.834 [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-06-01T17:11:06.836Z,1496337066.836 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T17:11:06.837Z,1496337066.837 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T17:11:06.837Z,1496337066.838 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T17:12:41.046Z,1496337161.046 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:12:41.046Z,1496337161.046 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:12:41.046Z,1496337161.046 [BPC1](ERROR): Communications Fault 2017-06-01T17:12:41.094Z,1496337161.094 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:12:42.288Z,1496337162.288 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:12:42.288Z,1496337162.288 [BPC1] No Fault, FailCount= 1 2017-06-01T17:13:02.975Z,1496337182.975 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T17:13:02.975Z,1496337182.975 [Rowe_600LCM] Communications Fault, FailCount= 1 2017-06-01T17:13:02.975Z,1496337182.975 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T17:13:03.068Z,1496337183.068 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T17:13:03.081Z,1496337183.081 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T17:13:03.379Z,1496337183.379 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:13:03.530Z,1496337183.530 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.9 s old, using for 20.0 s. 2017-06-01T17:13:03.615Z,1496337183.615 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:13:03.889Z,1496337183.889 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:13:04.271Z,1496337184.271 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:13:04.679Z,1496337184.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:13:05.074Z,1496337185.074 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:13:05.100Z,1496337185.100 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T17:13:05.100Z,1496337185.100 [Rowe_600LCM] No Fault, FailCount= 1 2017-06-01T17:13:05.231Z,1496337185.231 [Rowe_600LCM](INFO): Initializing 2017-06-01T17:13:05.232Z,1496337185.232 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T17:13:05.232Z,1496337185.232 [Rowe_600LCM](INFO): LCM OK 2017-06-01T17:13:05.232Z,1496337185.232 [Rowe_600LCM](INFO): Powering up 2017-06-01T17:13:05.476Z,1496337185.476 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:13:05.877Z,1496337185.877 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:13:06.276Z,1496337186.276 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:13:06.678Z,1496337186.678 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:13:07.078Z,1496337187.078 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:13:07.505Z,1496337187.505 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:13:07.857Z,1496337187.856 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:13:08.253Z,1496337188.253 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:13:08.693Z,1496337188.693 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:13:09.063Z,1496337189.063 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:13:09.353Z,1496337189.353 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T17:13:09.486Z,1496337189.486 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:13:09.501Z,1496337189.501 [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-06-01T17:13:09.502Z,1496337189.502 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T17:13:09.503Z,1496337189.503 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T17:13:09.504Z,1496337189.504 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T17:13:11.056Z,1496337191.056 [PNI_TCM](ERROR): CRC does not match. Expected:0x51588 got:0x16826 2017-06-01T17:13:11.868Z,1496337191.868 [PNI_TCM](ERROR): CRC does not match. Expected:0x19612 got:0x47616 2017-06-01T17:13:26.643Z,1496337206.643 [PNI_TCM](ERROR): CRC does not match. Expected:0x47743 got:0x8382 2017-06-01T17:13:27.071Z,1496337207.071 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:13:27.072Z,1496337207.072 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2017-06-01T17:13:27.072Z,1496337207.072 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:13:27.073Z,1496337207.073 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:13:27.074Z,1496337207.074 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2017-06-01T17:13:27.074Z,1496337207.074 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:13:27.086Z,1496337207.086 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:13:27.086Z,1496337207.086 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:13:27.517Z,1496337207.517 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:13:27.517Z,1496337207.517 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2017-06-01T17:13:27.517Z,1496337207.517 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:13:27.517Z,1496337207.517 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2017-06-01T17:13:27.882Z,1496337207.882 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:13:27.882Z,1496337207.882 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:13:27.883Z,1496337207.883 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:13:27.883Z,1496337207.883 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:13:27.884Z,1496337207.884 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:13:27.884Z,1496337207.884 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:13:35.881Z,1496337215.881 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2017-06-01T17:13:35.881Z,1496337215.881 [Default:CheckIn:C.Wait] Stopped 2017-06-01T17:13:35.882Z,1496337215.882 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2017-06-01T17:13:35.882Z,1496337215.882 [Default:CheckIn:D] Running Loop=1 2017-06-01T17:13:36.347Z,1496337216.347 [Default:CheckIn:D] Stopped 2017-06-01T17:13:36.347Z,1496337216.347 [Default:CheckIn:E] Running Loop=1 2017-06-01T17:13:39.775Z,1496337219.775 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.809196 min 2017-06-01T17:13:39.775Z,1496337219.775 [Default:CheckIn:E] Stopped 2017-06-01T17:13:39.775Z,1496337219.775 [Default:CheckIn](INFO): Completed Default:CheckIn 2017-06-01T17:13:39.775Z,1496337219.775 [Default:CheckIn] Stopped 2017-06-01T17:13:39.775Z,1496337219.776 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2017-06-01T17:13:39.776Z,1496337219.776 [Default:CheckIn](INFO): Running loop #3 2017-06-01T17:13:39.776Z,1496337219.776 [Default:CheckIn] Running Loop=3 2017-06-01T17:13:39.776Z,1496337219.776 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2017-06-01T17:13:39.776Z,1496337219.776 [Default:CheckIn:Read_GPS] Running Loop=1 2017-06-01T17:15:05.987Z,1496337305.987 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T17:15:05.987Z,1496337305.987 [Rowe_600LCM] Communications Fault, FailCount= 2 2017-06-01T17:15:05.987Z,1496337305.987 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T17:15:06.267Z,1496337306.267 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.3 s old, using for 20.0 s. 2017-06-01T17:15:06.293Z,1496337306.293 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T17:15:06.392Z,1496337306.392 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:15:06.496Z,1496337306.496 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:15:06.705Z,1496337306.705 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T17:15:07.121Z,1496337307.121 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:15:07.462Z,1496337307.462 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.5 s old, using for 20.0 s. 2017-06-01T17:15:07.881Z,1496337307.881 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:15:07.895Z,1496337307.895 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T17:15:07.895Z,1496337307.895 [Rowe_600LCM] No Fault, FailCount= 2 2017-06-01T17:15:08.111Z,1496337308.111 [Rowe_600LCM](INFO): Initializing 2017-06-01T17:15:08.112Z,1496337308.112 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T17:15:08.112Z,1496337308.112 [Rowe_600LCM](INFO): LCM OK 2017-06-01T17:15:08.112Z,1496337308.112 [Rowe_600LCM](INFO): Powering up 2017-06-01T17:15:08.294Z,1496337308.293 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:15:08.686Z,1496337308.686 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:15:09.117Z,1496337309.117 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:15:09.490Z,1496337309.490 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:15:09.882Z,1496337309.882 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:15:10.281Z,1496337310.281 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:15:10.681Z,1496337310.681 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:15:11.085Z,1496337311.085 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:15:11.481Z,1496337311.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:15:11.885Z,1496337311.885 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:15:12.293Z,1496337312.293 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T17:15:12.336Z,1496337312.336 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:15:12.434Z,1496337312.434 [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-06-01T17:15:12.435Z,1496337312.435 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T17:15:12.436Z,1496337312.436 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T17:15:12.437Z,1496337312.437 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T17:15:12.720Z,1496337312.720 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:16:24.164Z,1496337384.164 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:16:24.164Z,1496337384.164 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:16:24.164Z,1496337384.164 [BPC1](ERROR): Communications Fault 2017-06-01T17:16:24.219Z,1496337384.219 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:16:25.399Z,1496337385.399 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:16:25.399Z,1496337385.399 [BPC1] No Fault, FailCount= 1 2017-06-01T17:16:28.162Z,1496337388.162 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:16:28.162Z,1496337388.162 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2017-06-01T17:16:28.162Z,1496337388.162 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:16:28.164Z,1496337388.164 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:16:28.164Z,1496337388.164 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2017-06-01T17:16:28.164Z,1496337388.164 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:16:28.193Z,1496337388.193 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:16:28.193Z,1496337388.194 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:16:28.604Z,1496337388.604 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:16:28.604Z,1496337388.604 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2017-06-01T17:16:28.604Z,1496337388.604 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:16:28.604Z,1496337388.604 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2017-06-01T17:16:29.004Z,1496337389.004 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:16:29.005Z,1496337389.005 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:16:29.005Z,1496337389.005 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:16:29.006Z,1496337389.006 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:16:29.006Z,1496337389.006 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:16:29.007Z,1496337389.007 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:16:44.056Z,1496337404.056 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:16:44.057Z,1496337404.057 [BPC1] Communications Fault, FailCount= 2 2017-06-01T17:16:44.057Z,1496337404.057 [BPC1](ERROR): Communications Fault 2017-06-01T17:16:44.095Z,1496337404.095 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:16:45.276Z,1496337405.276 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:16:45.276Z,1496337405.276 [BPC1] No Fault, FailCount= 2 2017-06-01T17:17:08.587Z,1496337428.587 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T17:17:08.587Z,1496337428.587 [Rowe_600LCM] Communications Fault, FailCount= 3 2017-06-01T17:17:08.587Z,1496337428.587 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T17:17:08.853Z,1496337428.853 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T17:17:08.900Z,1496337428.900 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T17:17:08.992Z,1496337428.992 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:17:09.097Z,1496337429.097 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:17:09.281Z,1496337429.281 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T17:17:09.654Z,1496337429.654 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:17:10.062Z,1496337430.062 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:17:10.488Z,1496337430.488 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:17:10.502Z,1496337430.502 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T17:17:10.502Z,1496337430.502 [Rowe_600LCM] No Fault, FailCount= 3 2017-06-01T17:17:10.711Z,1496337430.711 [Rowe_600LCM](INFO): Initializing 2017-06-01T17:17:10.711Z,1496337430.711 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T17:17:10.712Z,1496337430.712 [Rowe_600LCM](INFO): LCM OK 2017-06-01T17:17:10.712Z,1496337430.712 [Rowe_600LCM](INFO): Powering up 2017-06-01T17:17:10.856Z,1496337430.856 [BPC1](ERROR): Failed to parse bank A battery data 2017-06-01T17:17:10.856Z,1496337430.856 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:17:10.856Z,1496337430.856 [BPC1](ERROR): Data Fault 2017-06-01T17:17:10.879Z,1496337430.879 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:17:10.918Z,1496337430.918 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:17:11.264Z,1496337431.264 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:17:11.660Z,1496337431.660 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:17:12.055Z,1496337432.055 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:17:12.068Z,1496337432.068 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:17:12.068Z,1496337432.068 [BPC1] No Fault, FailCount= 1 2017-06-01T17:17:12.536Z,1496337432.536 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.1 s old, using for 20.0 s. 2017-06-01T17:17:12.900Z,1496337432.901 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:17:13.257Z,1496337433.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:17:13.671Z,1496337433.671 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:17:14.073Z,1496337434.073 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:17:14.473Z,1496337434.473 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:17:14.880Z,1496337434.880 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:17:14.950Z,1496337434.950 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T17:17:15.030Z,1496337435.030 [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-06-01T17:17:15.031Z,1496337435.031 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T17:17:15.032Z,1496337435.032 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T17:17:15.033Z,1496337435.033 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T17:17:15.315Z,1496337435.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:18:06.401Z,1496337486.401 [BPC1](ERROR): Failed to parse message. 2017-06-01T17:18:06.402Z,1496337486.402 [BPC1](ERROR): Failed to parse bank B battery data 2017-06-01T17:18:06.402Z,1496337486.402 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:18:06.402Z,1496337486.402 [BPC1](ERROR): Data Fault 2017-06-01T17:18:06.457Z,1496337486.457 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:18:07.654Z,1496337487.654 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:18:07.654Z,1496337487.654 [BPC1] No Fault, FailCount= 1 2017-06-01T17:18:40.601Z,1496337520.601 [Default:CheckIn:Read_GPS](INFO): Timed out from 2017-06-01T17:13:39.8Z 2017-06-01T17:18:40.601Z,1496337520.601 [Default:CheckIn:Read_GPS] Stopped 2017-06-01T17:18:40.601Z,1496337520.601 [Default:CheckIn:Read_Iridium] Running Loop=1 2017-06-01T17:18:45.928Z,1496337525.928 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20170601T164849/Courier0012.lzma 2017-06-01T17:18:46.709Z,1496337526.709 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Courier0012.lzma.bak 2017-06-01T17:18:46.709Z,1496337526.709 [DataOverHttps](INFO): SBD MOMSN=5041118 2017-06-01T17:18:56.212Z,1496337536.212 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20170601T164849/Express0013.lzma 2017-06-01T17:18:56.985Z,1496337536.985 [DataOverHttps](INFO): Moved sent file to Logs/20170601T164849/Express0013.lzma.bak 2017-06-01T17:18:56.985Z,1496337536.985 [DataOverHttps](INFO): SBD MOMSN=5041120 2017-06-01T17:18:57.478Z,1496337537.478 [Default:CheckIn:Read_Iridium] Stopped 2017-06-01T17:18:57.478Z,1496337537.478 [Default:CheckIn:C.Wait] Running Loop=1 2017-06-01T17:18:57.478Z,1496337537.478 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2017-06-01T17:19:29.363Z,1496337569.363 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:19:29.363Z,1496337569.363 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2017-06-01T17:19:29.363Z,1496337569.363 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:19:29.365Z,1496337569.365 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:19:29.365Z,1496337569.365 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2017-06-01T17:19:29.365Z,1496337569.365 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:19:29.378Z,1496337569.378 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:19:29.378Z,1496337569.378 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:19:29.777Z,1496337569.777 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:19:29.777Z,1496337569.777 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2017-06-01T17:19:29.777Z,1496337569.777 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:19:29.777Z,1496337569.777 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2017-06-01T17:19:30.218Z,1496337570.218 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:19:30.223Z,1496337570.223 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:19:30.224Z,1496337570.224 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:19:30.224Z,1496337570.224 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:19:30.225Z,1496337570.225 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:19:30.226Z,1496337570.226 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:20:12.987Z,1496337612.987 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T17:20:12.987Z,1496337612.987 [Rowe_600LCM] Communications Fault, FailCount= 4 2017-06-01T17:20:12.987Z,1496337612.987 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T17:20:13.301Z,1496337613.301 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T17:20:13.315Z,1496337613.315 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T17:20:13.391Z,1496337613.391 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:20:13.482Z,1496337613.482 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:20:13.700Z,1496337613.700 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T17:20:14.104Z,1496337614.104 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:20:14.507Z,1496337614.507 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:20:14.904Z,1496337614.904 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:20:14.918Z,1496337614.918 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-06-01T17:20:14.918Z,1496337614.918 [Rowe_600LCM] No Fault, FailCount= 4 2017-06-01T17:20:15.099Z,1496337615.099 [Rowe_600LCM](INFO): Initializing 2017-06-01T17:20:15.100Z,1496337615.100 [Rowe_600LCM](INFO): Checking LCM 2017-06-01T17:20:15.100Z,1496337615.100 [Rowe_600LCM](INFO): LCM OK 2017-06-01T17:20:15.100Z,1496337615.100 [Rowe_600LCM](INFO): Powering up 2017-06-01T17:20:15.304Z,1496337615.304 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:20:15.698Z,1496337615.698 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:20:16.103Z,1496337616.103 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:20:16.509Z,1496337616.509 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:20:16.905Z,1496337616.905 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:20:17.294Z,1496337617.294 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:20:17.685Z,1496337617.685 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:20:18.109Z,1496337618.109 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:20:18.503Z,1496337618.503 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:20:18.916Z,1496337618.916 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:20:19.248Z,1496337619.248 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2017-06-01T17:20:19.342Z,1496337619.342 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:20:19.411Z,1496337619.411 [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-06-01T17:20:19.412Z,1496337619.412 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2017-06-01T17:20:19.413Z,1496337619.413 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2017-06-01T17:20:19.414Z,1496337619.414 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2017-06-01T17:20:19.724Z,1496337619.724 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:20:20.445Z,1496337620.445 [NAL9602](FAULT): GPS failed to acquire within timeout. 2017-06-01T17:20:20.445Z,1496337620.445 [NAL9602] Data Fault, FailCount= 3 2017-06-01T17:20:20.445Z,1496337620.445 [NAL9602](ERROR): Data Fault 2017-06-01T17:20:20.528Z,1496337620.528 [CBIT](ERROR): Data Fault in component: NAL9602 2017-06-01T17:20:20.849Z,1496337620.849 [NAL9602](INFO): Powering down 2017-06-01T17:20:21.704Z,1496337621.704 [CBIT](INFO): Clearing failed state for component NAL9602 2017-06-01T17:20:21.704Z,1496337621.704 [NAL9602] No Fault, FailCount= 3 2017-06-01T17:20:26.049Z,1496337626.049 [NAL9602](INFO): Powering up NAL9602 2017-06-01T17:20:37.241Z,1496337637.240 [NAL9602](INFO): NAL9602 initialized 2017-06-01T17:22:15.131Z,1496337735.131 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2017-06-01T17:22:15.131Z,1496337735.131 [Rowe_600LCM] Communications Fault, FailCount= 5 2017-06-01T17:22:15.131Z,1496337735.131 [Rowe_600LCM](ERROR): Communications Fault 2017-06-01T17:22:15.415Z,1496337735.415 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s. 2017-06-01T17:22:15.445Z,1496337735.445 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2017-06-01T17:22:15.446Z,1496337735.446 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM 2017-06-01T17:22:15.535Z,1496337735.535 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:22:15.654Z,1496337735.654 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:22:15.855Z,1496337735.855 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s. 2017-06-01T17:22:16.229Z,1496337736.229 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:22:16.658Z,1496337736.658 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:22:17.011Z,1496337737.011 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:22:17.408Z,1496337737.408 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:22:17.853Z,1496337737.853 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:22:18.217Z,1496337738.217 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:22:18.650Z,1496337738.650 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:22:19.053Z,1496337739.053 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:22:19.433Z,1496337739.434 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:22:19.841Z,1496337739.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:22:20.213Z,1496337740.214 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:22:20.610Z,1496337740.610 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:22:21.018Z,1496337741.017 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:22:21.429Z,1496337741.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:22:21.817Z,1496337741.817 [PNI_TCM](ERROR): CRC does not match. Expected:0x48771 got:0x1287 2017-06-01T17:22:21.853Z,1496337741.853 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:22:22.233Z,1496337742.233 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:22:22.625Z,1496337742.625 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:22:23.014Z,1496337743.014 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:22:23.420Z,1496337743.420 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:22:23.812Z,1496337743.812 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:22:24.197Z,1496337744.197 [PNI_TCM](ERROR): CRC does not match. Expected:0x670 got:0x60188 2017-06-01T17:22:24.250Z,1496337744.250 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:22:24.650Z,1496337744.650 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:22:25.022Z,1496337745.022 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s. 2017-06-01T17:22:25.431Z,1496337745.431 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s. 2017-06-01T17:22:25.822Z,1496337745.822 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s. 2017-06-01T17:22:26.225Z,1496337746.225 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:22:26.621Z,1496337746.621 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s. 2017-06-01T17:22:27.013Z,1496337747.013 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:22:27.416Z,1496337747.416 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s. 2017-06-01T17:22:27.826Z,1496337747.826 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s. 2017-06-01T17:22:28.224Z,1496337748.224 [PNI_TCM](ERROR): CRC does not match. Expected:0x17738 got:0x25960 2017-06-01T17:22:28.250Z,1496337748.250 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:22:28.633Z,1496337748.633 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s. 2017-06-01T17:22:29.022Z,1496337749.022 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:22:29.433Z,1496337749.433 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s. 2017-06-01T17:22:29.799Z,1496337749.799 [PNI_TCM](ERROR): CRC does not match. Expected:0x44125 got:0x16669 2017-06-01T17:22:29.837Z,1496337749.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s. 2017-06-01T17:22:30.205Z,1496337750.205 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:22:30.629Z,1496337750.629 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s. 2017-06-01T17:22:30.630Z,1496337750.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:22:30.630Z,1496337750.630 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2017-06-01T17:22:30.630Z,1496337750.630 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:22:30.633Z,1496337750.633 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:22:30.633Z,1496337750.633 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2017-06-01T17:22:30.633Z,1496337750.633 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:22:30.646Z,1496337750.646 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:22:30.646Z,1496337750.646 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:22:31.040Z,1496337751.040 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:22:31.040Z,1496337751.040 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2017-06-01T17:22:31.040Z,1496337751.040 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:22:31.040Z,1496337751.040 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2017-06-01T17:22:31.445Z,1496337751.445 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:22:31.445Z,1496337751.445 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:22:31.446Z,1496337751.446 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:22:31.446Z,1496337751.446 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:22:31.447Z,1496337751.447 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:22:31.447Z,1496337751.447 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:22:31.808Z,1496337751.808 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s. 2017-06-01T17:22:32.210Z,1496337752.210 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:22:32.642Z,1496337752.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s. 2017-06-01T17:22:33.015Z,1496337753.015 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s. 2017-06-01T17:22:33.449Z,1496337753.449 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s. 2017-06-01T17:22:33.851Z,1496337753.852 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s. 2017-06-01T17:22:34.225Z,1496337754.225 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s. 2017-06-01T17:22:34.622Z,1496337754.622 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s. 2017-06-01T17:22:35.016Z,1496337755.016 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s. 2017-06-01T17:22:36.186Z,1496337756.186 [PNI_TCM](ERROR): CRC does not match. Expected:0x50426 got:0x44954 2017-06-01T17:22:39.390Z,1496337759.390 [PNI_TCM](ERROR): CRC does not match. Expected:0x2514 got:0x1857 2017-06-01T17:23:43.213Z,1496337823.213 [BPC1](ERROR): Failed to parse bank B battery data 2017-06-01T17:23:43.213Z,1496337823.214 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:23:43.213Z,1496337823.214 [BPC1](ERROR): Data Fault 2017-06-01T17:23:43.235Z,1496337823.235 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:23:44.437Z,1496337824.437 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:23:44.437Z,1496337824.437 [BPC1] No Fault, FailCount= 1 2017-06-01T17:23:58.031Z,1496337838.031 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2017-06-01T17:23:58.031Z,1496337838.031 [Default:CheckIn:C.Wait] Stopped 2017-06-01T17:23:58.031Z,1496337838.031 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2017-06-01T17:23:58.031Z,1496337838.031 [Default:CheckIn:D] Running Loop=1 2017-06-01T17:23:58.459Z,1496337838.459 [Default:CheckIn:D] Stopped 2017-06-01T17:23:58.459Z,1496337838.459 [Default:CheckIn:E] Running Loop=1 2017-06-01T17:23:58.810Z,1496337838.810 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.177795 min 2017-06-01T17:23:58.810Z,1496337838.810 [Default:CheckIn:E] Stopped 2017-06-01T17:23:58.810Z,1496337838.810 [Default:CheckIn](INFO): Completed Default:CheckIn 2017-06-01T17:23:58.810Z,1496337838.810 [Default:CheckIn] Stopped 2017-06-01T17:23:58.810Z,1496337838.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2017-06-01T17:23:58.811Z,1496337838.810 [Default:CheckIn](INFO): Running loop #4 2017-06-01T17:23:58.811Z,1496337838.811 [Default:CheckIn] Running Loop=4 2017-06-01T17:23:58.811Z,1496337838.811 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2017-06-01T17:23:58.811Z,1496337838.811 [Default:CheckIn:Read_GPS] Running Loop=1 2017-06-01T17:24:26.987Z,1496337866.987 [BPC1](ERROR): Failed to parse message. 2017-06-01T17:24:26.987Z,1496337866.987 [BPC1](ERROR): Failed to parse bank A battery data 2017-06-01T17:24:26.988Z,1496337866.987 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:24:26.988Z,1496337866.987 [BPC1](ERROR): Data Fault 2017-06-01T17:24:27.022Z,1496337867.022 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:24:28.200Z,1496337868.200 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:24:28.200Z,1496337868.200 [BPC1] No Fault, FailCount= 1 2017-06-01T17:24:58.970Z,1496337898.970 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:24:58.970Z,1496337898.970 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:24:58.970Z,1496337898.970 [BPC1](ERROR): Communications Fault 2017-06-01T17:24:59.022Z,1496337899.022 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:25:02.830Z,1496337902.830 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:25:02.830Z,1496337902.830 [BPC1] No Fault, FailCount= 1 2017-06-01T17:25:09.580Z,1496337909.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.404300 seconds old. 2017-06-01T17:25:09.582Z,1496337909.582 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.404800 seconds old. 2017-06-01T17:25:09.982Z,1496337909.982 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.806400 seconds old. 2017-06-01T17:25:09.984Z,1496337909.984 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.807000 seconds old. 2017-06-01T17:25:10.386Z,1496337910.385 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.209500 seconds old. 2017-06-01T17:25:10.387Z,1496337910.387 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.209900 seconds old. 2017-06-01T17:25:10.786Z,1496337910.786 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.609600 seconds old. 2017-06-01T17:25:10.787Z,1496337910.787 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.610500 seconds old. 2017-06-01T17:25:11.181Z,1496337911.181 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.004900 seconds old. 2017-06-01T17:25:11.182Z,1496337911.182 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.005300 seconds old. 2017-06-01T17:25:11.580Z,1496337911.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.404100 seconds old. 2017-06-01T17:25:11.581Z,1496337911.581 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.404500 seconds old. 2017-06-01T17:25:11.977Z,1496337911.977 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.801400 seconds old. 2017-06-01T17:25:11.979Z,1496337911.979 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.801800 seconds old. 2017-06-01T17:25:12.371Z,1496337912.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.195100 seconds old. 2017-06-01T17:25:12.373Z,1496337912.372 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.195600 seconds old. 2017-06-01T17:25:12.776Z,1496337912.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.599700 seconds old. 2017-06-01T17:25:12.777Z,1496337912.777 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.600100 seconds old. 2017-06-01T17:25:13.171Z,1496337913.171 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.994600 seconds old. 2017-06-01T17:25:13.172Z,1496337913.172 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.995200 seconds old. 2017-06-01T17:25:13.589Z,1496337913.589 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.412800 seconds old. 2017-06-01T17:25:13.590Z,1496337913.590 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.413200 seconds old. 2017-06-01T17:25:13.994Z,1496337913.994 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.818200 seconds old. 2017-06-01T17:25:13.996Z,1496337913.996 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.818600 seconds old. 2017-06-01T17:25:14.385Z,1496337914.385 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.209000 seconds old. 2017-06-01T17:25:14.386Z,1496337914.386 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.209400 seconds old. 2017-06-01T17:25:14.772Z,1496337914.772 [BPC1](ERROR): Failed to parse bank A battery data 2017-06-01T17:25:14.773Z,1496337914.773 [BPC1] Data Fault, FailCount= 2 2017-06-01T17:25:14.773Z,1496337914.773 [BPC1](ERROR): Data Fault 2017-06-01T17:25:14.780Z,1496337914.780 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.604200 seconds old. 2017-06-01T17:25:14.781Z,1496337914.782 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.604600 seconds old. 2017-06-01T17:25:14.795Z,1496337914.795 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:25:15.180Z,1496337915.180 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.004400 seconds old. 2017-06-01T17:25:15.182Z,1496337915.182 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.004800 seconds old. 2017-06-01T17:25:15.575Z,1496337915.575 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.398400 seconds old. 2017-06-01T17:25:15.576Z,1496337915.576 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.399100 seconds old. 2017-06-01T17:25:15.974Z,1496337915.974 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.797600 seconds old. 2017-06-01T17:25:15.979Z,1496337915.979 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.802300 seconds old. 2017-06-01T17:25:16.001Z,1496337916.001 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:25:16.001Z,1496337916.001 [BPC1] No Fault, FailCount= 2 2017-06-01T17:25:16.441Z,1496337916.441 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.264600 seconds old. 2017-06-01T17:25:16.442Z,1496337916.442 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.265100 seconds old. 2017-06-01T17:25:16.828Z,1496337916.828 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.652000 seconds old. 2017-06-01T17:25:16.829Z,1496337916.829 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.652400 seconds old. 2017-06-01T17:25:17.199Z,1496337917.199 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.022800 seconds old. 2017-06-01T17:25:17.200Z,1496337917.200 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.023500 seconds old. 2017-06-01T17:25:17.580Z,1496337917.579 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.403400 seconds old. 2017-06-01T17:25:17.581Z,1496337917.581 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.403900 seconds old. 2017-06-01T17:25:17.967Z,1496337917.967 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 8.790500 seconds old. 2017-06-01T17:25:17.968Z,1496337917.968 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 8.791400 seconds old. 2017-06-01T17:25:18.367Z,1496337918.367 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.191200 seconds old. 2017-06-01T17:25:18.369Z,1496337918.369 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.191600 seconds old. 2017-06-01T17:25:18.769Z,1496337918.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.592600 seconds old. 2017-06-01T17:25:18.770Z,1496337918.770 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.593000 seconds old. 2017-06-01T17:25:19.171Z,1496337919.171 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 9.995100 seconds old. 2017-06-01T17:25:19.172Z,1496337919.172 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 9.995600 seconds old. 2017-06-01T17:25:19.579Z,1496337919.579 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 10.403100 seconds old. 2017-06-01T17:25:19.581Z,1496337919.580 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 10.403600 seconds old. 2017-06-01T17:25:19.975Z,1496337919.976 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 10.799400 seconds old. 2017-06-01T17:25:19.977Z,1496337919.977 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 10.799900 seconds old. 2017-06-01T17:25:20.374Z,1496337920.374 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 11.197700 seconds old. 2017-06-01T17:25:20.375Z,1496337920.375 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 11.198400 seconds old. 2017-06-01T17:25:20.776Z,1496337920.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 11.600400 seconds old. 2017-06-01T17:25:20.778Z,1496337920.778 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 11.600900 seconds old. 2017-06-01T17:25:21.185Z,1496337921.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.009300 seconds old. 2017-06-01T17:25:21.187Z,1496337921.187 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.009800 seconds old. 2017-06-01T17:25:21.585Z,1496337921.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.409000 seconds old. 2017-06-01T17:25:21.586Z,1496337921.586 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.409500 seconds old. 2017-06-01T17:25:21.981Z,1496337921.981 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 12.804700 seconds old. 2017-06-01T17:25:21.982Z,1496337921.982 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 12.805200 seconds old. 2017-06-01T17:25:22.372Z,1496337922.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 13.196000 seconds old. 2017-06-01T17:25:22.373Z,1496337922.373 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 13.196500 seconds old. 2017-06-01T17:25:22.766Z,1496337922.766 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 13.590300 seconds old. 2017-06-01T17:25:22.772Z,1496337922.772 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 13.595000 seconds old. 2017-06-01T17:25:23.179Z,1496337923.179 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 14.003200 seconds old. 2017-06-01T17:25:23.181Z,1496337923.181 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 14.003700 seconds old. 2017-06-01T17:25:23.589Z,1496337923.589 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 14.413300 seconds old. 2017-06-01T17:25:23.591Z,1496337923.591 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 14.413800 seconds old. 2017-06-01T17:25:23.993Z,1496337923.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 14.817000 seconds old. 2017-06-01T17:25:23.994Z,1496337923.994 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 14.817500 seconds old. 2017-06-01T17:25:24.383Z,1496337924.383 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 15.206600 seconds old. 2017-06-01T17:25:24.384Z,1496337924.384 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 15.207300 seconds old. 2017-06-01T17:25:24.781Z,1496337924.781 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 15.604700 seconds old. 2017-06-01T17:25:24.782Z,1496337924.782 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 15.605200 seconds old. 2017-06-01T17:25:25.190Z,1496337925.190 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 16.014200 seconds old. 2017-06-01T17:25:25.192Z,1496337925.192 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 16.015500 seconds old. 2017-06-01T17:25:25.590Z,1496337925.590 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 16.413500 seconds old. 2017-06-01T17:25:25.592Z,1496337925.592 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 16.414700 seconds old. 2017-06-01T17:25:25.978Z,1496337925.978 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 16.801800 seconds old. 2017-06-01T17:25:25.983Z,1496337925.983 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 16.806300 seconds old. 2017-06-01T17:25:26.376Z,1496337926.376 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 17.200300 seconds old. 2017-06-01T17:25:26.378Z,1496337926.378 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 17.200900 seconds old. 2017-06-01T17:25:26.788Z,1496337926.788 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 17.612200 seconds old. 2017-06-01T17:25:26.790Z,1496337926.790 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 17.612700 seconds old. 2017-06-01T17:25:27.195Z,1496337927.195 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 18.019200 seconds old. 2017-06-01T17:25:27.197Z,1496337927.197 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 18.019700 seconds old. 2017-06-01T17:25:27.589Z,1496337927.589 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 18.413000 seconds old. 2017-06-01T17:25:27.590Z,1496337927.590 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 18.413500 seconds old. 2017-06-01T17:25:27.993Z,1496337927.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 18.817400 seconds old. 2017-06-01T17:25:27.995Z,1496337927.995 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 18.817900 seconds old. 2017-06-01T17:25:28.399Z,1496337928.399 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 19.223100 seconds old. 2017-06-01T17:25:28.401Z,1496337928.401 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 19.223800 seconds old. 2017-06-01T17:25:28.808Z,1496337928.808 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 19.631600 seconds old. 2017-06-01T17:25:28.809Z,1496337928.809 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 19.632100 seconds old. 2017-06-01T17:25:29.194Z,1496337929.194 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 20.017900 seconds old. 2017-06-01T17:25:29.200Z,1496337929.200 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 20.023200 seconds old. 2017-06-01T17:25:29.576Z,1496337929.576 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 20.399900 seconds old. 2017-06-01T17:25:29.577Z,1496337929.577 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 20.400400 seconds old. 2017-06-01T17:25:30.004Z,1496337930.004 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 20.828200 seconds old. 2017-06-01T17:25:30.006Z,1496337930.006 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 20.828700 seconds old. 2017-06-01T17:25:30.366Z,1496337930.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 21.190000 seconds old. 2017-06-01T17:25:30.372Z,1496337930.372 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 21.194600 seconds old. 2017-06-01T17:25:30.789Z,1496337930.789 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 21.612600 seconds old. 2017-06-01T17:25:30.790Z,1496337930.790 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 21.613100 seconds old. 2017-06-01T17:25:31.224Z,1496337931.224 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 22.048100 seconds old. 2017-06-01T17:25:31.226Z,1496337931.226 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 22.048600 seconds old. 2017-06-01T17:25:31.597Z,1496337931.597 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 22.420900 seconds old. 2017-06-01T17:25:31.598Z,1496337931.598 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:25:31.598Z,1496337931.598 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2017-06-01T17:25:31.598Z,1496337931.598 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:25:31.616Z,1496337931.616 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 22.438800 seconds old. 2017-06-01T17:25:31.617Z,1496337931.617 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:25:31.617Z,1496337931.617 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2017-06-01T17:25:31.617Z,1496337931.617 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:25:31.651Z,1496337931.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:25:31.651Z,1496337931.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:25:32.040Z,1496337932.040 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:25:32.040Z,1496337932.040 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2017-06-01T17:25:32.041Z,1496337932.040 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:25:32.041Z,1496337932.041 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2017-06-01T17:25:32.372Z,1496337932.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:25:32.372Z,1496337932.372 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:25:32.373Z,1496337932.372 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:25:32.373Z,1496337932.373 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:25:32.373Z,1496337932.373 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:25:32.374Z,1496337932.374 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:25:32.776Z,1496337932.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 23.600200 seconds old. 2017-06-01T17:25:32.777Z,1496337932.777 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:25:32.778Z,1496337932.778 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 23.601200 seconds old. 2017-06-01T17:25:33.186Z,1496337933.186 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 24.009700 seconds old. 2017-06-01T17:25:33.186Z,1496337933.186 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:25:33.188Z,1496337933.188 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 24.010800 seconds old. 2017-06-01T17:25:33.593Z,1496337933.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 24.416800 seconds old. 2017-06-01T17:25:33.594Z,1496337933.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:25:33.599Z,1496337933.599 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 24.417800 seconds old. 2017-06-01T17:25:33.986Z,1496337933.986 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 24.810200 seconds old. 2017-06-01T17:25:33.987Z,1496337933.987 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:25:33.988Z,1496337933.988 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 24.811400 seconds old. 2017-06-01T17:25:34.388Z,1496337934.388 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 25.211600 seconds old. 2017-06-01T17:25:34.388Z,1496337934.388 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:25:34.389Z,1496337934.389 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 25.212600 seconds old. 2017-06-01T17:25:34.760Z,1496337934.760 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 25.584200 seconds old. 2017-06-01T17:25:34.761Z,1496337934.761 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:25:34.762Z,1496337934.762 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 25.585200 seconds old. 2017-06-01T17:25:35.196Z,1496337935.196 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 26.020200 seconds old. 2017-06-01T17:25:35.197Z,1496337935.197 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:25:35.198Z,1496337935.198 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 26.021200 seconds old. 2017-06-01T17:25:35.573Z,1496337935.573 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 26.397300 seconds old. 2017-06-01T17:25:35.574Z,1496337935.574 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:25:35.592Z,1496337935.592 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 26.415000 seconds old. 2017-06-01T17:25:35.966Z,1496337935.966 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 26.789800 seconds old. 2017-06-01T17:25:35.966Z,1496337935.967 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:25:35.968Z,1496337935.968 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 26.791000 seconds old. 2017-06-01T17:25:36.370Z,1496337936.370 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 27.193900 seconds old. 2017-06-01T17:25:36.371Z,1496337936.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:25:36.372Z,1496337936.372 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 27.195100 seconds old. 2017-06-01T17:25:36.762Z,1496337936.762 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 27.585800 seconds old. 2017-06-01T17:25:36.762Z,1496337936.763 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:25:36.764Z,1496337936.764 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 27.586800 seconds old. 2017-06-01T17:25:37.172Z,1496337937.172 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 27.996200 seconds old. 2017-06-01T17:25:37.173Z,1496337937.173 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:25:37.174Z,1496337937.174 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 27.997200 seconds old. 2017-06-01T17:25:37.581Z,1496337937.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 28.404400 seconds old. 2017-06-01T17:25:37.581Z,1496337937.581 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:25:37.582Z,1496337937.582 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 28.405400 seconds old. 2017-06-01T17:25:37.976Z,1496337937.976 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 28.800000 seconds old. 2017-06-01T17:25:37.977Z,1496337937.977 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:25:37.978Z,1496337937.978 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 28.800900 seconds old. 2017-06-01T17:25:38.365Z,1496337938.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 29.188900 seconds old. 2017-06-01T17:25:38.366Z,1496337938.366 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:25:38.371Z,1496337938.371 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 29.189900 seconds old. 2017-06-01T17:25:38.777Z,1496337938.777 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 29.601300 seconds old. 2017-06-01T17:25:38.778Z,1496337938.778 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:25:38.780Z,1496337938.780 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 29.602600 seconds old. 2017-06-01T17:25:39.177Z,1496337939.177 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 30.000500 seconds old. 2017-06-01T17:25:39.177Z,1496337939.177 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:25:39.178Z,1496337939.178 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 30.001600 seconds old. 2017-06-01T17:25:39.585Z,1496337939.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 30.408500 seconds old. 2017-06-01T17:25:39.585Z,1496337939.585 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:25:39.586Z,1496337939.586 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 30.409500 seconds old. 2017-06-01T17:25:39.984Z,1496337939.984 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 30.808400 seconds old. 2017-06-01T17:25:39.985Z,1496337939.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:25:39.986Z,1496337939.986 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 30.809400 seconds old. 2017-06-01T17:25:40.368Z,1496337940.368 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 31.192000 seconds old. 2017-06-01T17:25:40.369Z,1496337940.369 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:25:40.370Z,1496337940.370 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 31.193000 seconds old. 2017-06-01T17:25:40.776Z,1496337940.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 31.600200 seconds old. 2017-06-01T17:25:40.777Z,1496337940.777 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:25:40.778Z,1496337940.778 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 31.601200 seconds old. 2017-06-01T17:25:41.185Z,1496337941.185 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 32.009100 seconds old. 2017-06-01T17:25:41.186Z,1496337941.186 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:25:41.187Z,1496337941.187 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 32.010300 seconds old. 2017-06-01T17:25:41.593Z,1496337941.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 32.417200 seconds old. 2017-06-01T17:25:41.594Z,1496337941.594 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s. 2017-06-01T17:25:41.595Z,1496337941.595 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 32.418300 seconds old. 2017-06-01T17:25:41.991Z,1496337941.991 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 32.814500 seconds old. 2017-06-01T17:25:41.992Z,1496337941.992 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s. 2017-06-01T17:25:41.993Z,1496337941.993 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 32.816300 seconds old. 2017-06-01T17:25:42.383Z,1496337942.383 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 33.206500 seconds old. 2017-06-01T17:25:42.383Z,1496337942.383 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s. 2017-06-01T17:25:42.385Z,1496337942.385 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 33.208000 seconds old. 2017-06-01T17:25:42.780Z,1496337942.780 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 33.604000 seconds old. 2017-06-01T17:25:42.781Z,1496337942.781 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:25:42.782Z,1496337942.782 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 33.605000 seconds old. 2017-06-01T17:25:43.244Z,1496337943.244 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 34.067600 seconds old. 2017-06-01T17:25:43.244Z,1496337943.244 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s. 2017-06-01T17:25:43.245Z,1496337943.246 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 34.068600 seconds old. 2017-06-01T17:25:43.596Z,1496337943.596 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 34.420300 seconds old. 2017-06-01T17:25:43.597Z,1496337943.597 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:25:43.598Z,1496337943.598 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 34.421300 seconds old. 2017-06-01T17:25:43.972Z,1496337943.972 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 34.796000 seconds old. 2017-06-01T17:25:43.973Z,1496337943.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s. 2017-06-01T17:25:43.974Z,1496337943.974 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 34.797000 seconds old. 2017-06-01T17:25:44.404Z,1496337944.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 35.227500 seconds old. 2017-06-01T17:25:44.404Z,1496337944.404 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s. 2017-06-01T17:25:44.405Z,1496337944.405 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 35.228500 seconds old. 2017-06-01T17:25:44.771Z,1496337944.771 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 35.590700 seconds old. 2017-06-01T17:25:44.772Z,1496337944.772 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:25:44.773Z,1496337944.773 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 35.595900 seconds old. 2017-06-01T17:25:45.207Z,1496337945.207 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 36.031400 seconds old. 2017-06-01T17:25:45.208Z,1496337945.208 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s. 2017-06-01T17:25:45.210Z,1496337945.210 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 36.032600 seconds old. 2017-06-01T17:25:45.608Z,1496337945.608 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 36.431500 seconds old. 2017-06-01T17:25:45.608Z,1496337945.608 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:25:45.609Z,1496337945.609 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 36.432500 seconds old. 2017-06-01T17:25:45.970Z,1496337945.970 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 36.794000 seconds old. 2017-06-01T17:25:45.971Z,1496337945.971 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s. 2017-06-01T17:25:45.972Z,1496337945.972 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 36.795400 seconds old. 2017-06-01T17:25:46.370Z,1496337946.369 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 37.193400 seconds old. 2017-06-01T17:25:46.370Z,1496337946.370 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s. 2017-06-01T17:25:46.371Z,1496337946.372 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 37.194500 seconds old. 2017-06-01T17:25:46.765Z,1496337946.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 37.588700 seconds old. 2017-06-01T17:25:46.765Z,1496337946.765 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:25:46.767Z,1496337946.767 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 37.589700 seconds old. 2017-06-01T17:25:47.174Z,1496337947.174 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 37.998200 seconds old. 2017-06-01T17:25:47.175Z,1496337947.175 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s. 2017-06-01T17:25:47.176Z,1496337947.176 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 37.999500 seconds old. 2017-06-01T17:25:47.580Z,1496337947.580 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 38.404100 seconds old. 2017-06-01T17:25:47.581Z,1496337947.581 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s. 2017-06-01T17:25:47.582Z,1496337947.582 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 38.405100 seconds old. 2017-06-01T17:25:47.977Z,1496337947.977 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 38.800900 seconds old. 2017-06-01T17:25:47.978Z,1496337947.978 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s. 2017-06-01T17:25:47.979Z,1496337947.979 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 38.801900 seconds old. 2017-06-01T17:25:48.373Z,1496337948.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 39.196400 seconds old. 2017-06-01T17:25:48.373Z,1496337948.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s. 2017-06-01T17:25:48.374Z,1496337948.374 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 39.197400 seconds old. 2017-06-01T17:25:48.772Z,1496337948.772 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 39.596300 seconds old. 2017-06-01T17:25:48.773Z,1496337948.773 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:25:48.774Z,1496337948.774 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 39.597400 seconds old. 2017-06-01T17:25:49.177Z,1496337949.177 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 40.001200 seconds old. 2017-06-01T17:25:49.178Z,1496337949.178 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s. 2017-06-01T17:25:49.179Z,1496337949.180 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 40.002500 seconds old. 2017-06-01T17:25:49.582Z,1496337949.582 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 40.405700 seconds old. 2017-06-01T17:25:49.582Z,1496337949.582 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s. 2017-06-01T17:25:49.584Z,1496337949.584 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 40.406900 seconds old. 2017-06-01T17:25:49.985Z,1496337949.985 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 40.808900 seconds old. 2017-06-01T17:25:49.986Z,1496337949.986 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s. 2017-06-01T17:25:49.987Z,1496337949.987 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 40.809900 seconds old. 2017-06-01T17:25:50.373Z,1496337950.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 41.197300 seconds old. 2017-06-01T17:25:50.374Z,1496337950.374 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s. 2017-06-01T17:25:50.376Z,1496337950.376 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 41.198700 seconds old. 2017-06-01T17:25:50.776Z,1496337950.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 41.599500 seconds old. 2017-06-01T17:25:50.776Z,1496337950.776 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s. 2017-06-01T17:25:50.777Z,1496337950.777 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 41.600500 seconds old. 2017-06-01T17:25:51.182Z,1496337951.182 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 42.005700 seconds old. 2017-06-01T17:25:51.182Z,1496337951.182 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s. 2017-06-01T17:25:51.184Z,1496337951.184 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 42.006700 seconds old. 2017-06-01T17:25:51.586Z,1496337951.586 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 42.410100 seconds old. 2017-06-01T17:25:51.592Z,1496337951.592 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s. 2017-06-01T17:25:51.593Z,1496337951.593 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 42.416000 seconds old. 2017-06-01T17:25:51.983Z,1496337951.983 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 42.807200 seconds old. 2017-06-01T17:25:51.985Z,1496337951.985 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 42.807700 seconds old. 2017-06-01T17:25:52.357Z,1496337952.357 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 43.180900 seconds old. 2017-06-01T17:25:52.358Z,1496337952.358 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 43.181400 seconds old. 2017-06-01T17:25:52.781Z,1496337952.782 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 43.605400 seconds old. 2017-06-01T17:25:52.787Z,1496337952.787 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 43.605900 seconds old. 2017-06-01T17:25:53.189Z,1496337953.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 44.013100 seconds old. 2017-06-01T17:25:53.191Z,1496337953.191 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 44.013600 seconds old. 2017-06-01T17:25:53.587Z,1496337953.587 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 44.410600 seconds old. 2017-06-01T17:25:53.588Z,1496337953.588 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 44.411200 seconds old. 2017-06-01T17:25:53.993Z,1496337953.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 44.816900 seconds old. 2017-06-01T17:25:53.994Z,1496337953.994 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 44.817400 seconds old. 2017-06-01T17:25:54.372Z,1496337954.372 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 45.196000 seconds old. 2017-06-01T17:25:54.374Z,1496337954.374 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 45.196500 seconds old. 2017-06-01T17:25:54.764Z,1496337954.764 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 45.587500 seconds old. 2017-06-01T17:25:54.765Z,1496337954.765 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 45.588000 seconds old. 2017-06-01T17:25:55.189Z,1496337955.189 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 46.012900 seconds old. 2017-06-01T17:25:55.190Z,1496337955.190 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 46.013400 seconds old. 2017-06-01T17:25:55.590Z,1496337955.590 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 46.413800 seconds old. 2017-06-01T17:25:55.600Z,1496337955.599 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 46.422500 seconds old. 2017-06-01T17:25:55.998Z,1496337955.998 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 46.821800 seconds old. 2017-06-01T17:25:56.008Z,1496337956.008 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 46.830900 seconds old. 2017-06-01T17:25:56.367Z,1496337956.367 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 47.190600 seconds old. 2017-06-01T17:25:56.368Z,1496337956.368 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 47.191300 seconds old. 2017-06-01T17:25:56.767Z,1496337956.767 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 47.590700 seconds old. 2017-06-01T17:25:56.768Z,1496337956.768 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 47.591400 seconds old. 2017-06-01T17:25:57.163Z,1496337957.163 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 47.986600 seconds old. 2017-06-01T17:25:57.164Z,1496337957.164 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 47.987200 seconds old. 2017-06-01T17:25:57.573Z,1496337957.573 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 48.397200 seconds old. 2017-06-01T17:25:57.579Z,1496337957.579 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 48.397700 seconds old. 2017-06-01T17:25:57.996Z,1496337957.996 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 48.820200 seconds old. 2017-06-01T17:25:57.998Z,1496337957.998 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 48.820700 seconds old. 2017-06-01T17:25:58.377Z,1496337958.377 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 49.200500 seconds old. 2017-06-01T17:25:58.378Z,1496337958.378 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 49.201000 seconds old. 2017-06-01T17:25:58.778Z,1496337958.778 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 49.601800 seconds old. 2017-06-01T17:25:58.780Z,1496337958.780 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 49.602600 seconds old. 2017-06-01T17:25:59.179Z,1496337959.179 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 50.003300 seconds old. 2017-06-01T17:25:59.181Z,1496337959.181 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 50.003900 seconds old. 2017-06-01T17:26:02.429Z,1496337962.429 [BPC1](ERROR): Failed to receive battery data 2017-06-01T17:26:02.429Z,1496337962.429 [BPC1] Communications Fault, FailCount= 1 2017-06-01T17:26:02.429Z,1496337962.429 [BPC1](ERROR): Communications Fault 2017-06-01T17:26:02.436Z,1496337962.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 53.260100 seconds old. 2017-06-01T17:26:02.438Z,1496337962.438 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 53.260600 seconds old. 2017-06-01T17:26:02.474Z,1496337962.474 [CBIT](ERROR): Communications Fault in component: BPC1 2017-06-01T17:26:02.592Z,1496337962.592 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 53.415500 seconds old. 2017-06-01T17:26:02.593Z,1496337962.593 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 53.416000 seconds old. 2017-06-01T17:26:03.376Z,1496337963.376 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:26:03.376Z,1496337963.376 [BPC1] No Fault, FailCount= 1 2017-06-01T17:28:32.541Z,1496338112.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:28:32.541Z,1496338112.541 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2017-06-01T17:28:32.541Z,1496338112.541 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2017-06-01T17:28:32.543Z,1496338112.543 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2017-06-01T17:28:32.543Z,1496338112.543 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2017-06-01T17:28:32.543Z,1496338112.543 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2017-06-01T17:28:32.573Z,1496338112.573 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2017-06-01T17:28:32.574Z,1496338112.574 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2017-06-01T17:28:32.980Z,1496338112.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2017-06-01T17:28:32.980Z,1496338112.980 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2017-06-01T17:28:32.980Z,1496338112.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2017-06-01T17:28:32.980Z,1496338112.980 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2017-06-01T17:28:33.349Z,1496338113.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-06-01T17:28:33.349Z,1496338113.349 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:28:33.349Z,1496338113.349 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:28:33.350Z,1496338113.350 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-06-01T17:28:33.350Z,1496338113.350 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-06-01T17:28:33.355Z,1496338113.355 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-06-01T17:28:33.769Z,1496338113.769 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s. 2017-06-01T17:28:34.136Z,1496338114.136 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s. 2017-06-01T17:28:34.536Z,1496338114.536 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s. 2017-06-01T17:28:34.949Z,1496338114.949 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s. 2017-06-01T17:28:35.345Z,1496338115.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s. 2017-06-01T17:28:35.743Z,1496338115.743 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s. 2017-06-01T17:28:36.143Z,1496338116.143 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s. 2017-06-01T17:28:36.514Z,1496338116.514 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s. 2017-06-01T17:28:36.944Z,1496338116.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s. 2017-06-01T17:28:37.349Z,1496338117.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s. 2017-06-01T17:28:37.715Z,1496338117.715 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s. 2017-06-01T17:28:38.148Z,1496338118.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s. 2017-06-01T17:28:38.546Z,1496338118.546 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s. 2017-06-01T17:28:38.941Z,1496338118.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s. 2017-06-01T17:28:39.326Z,1496338119.326 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s. 2017-06-01T17:28:39.725Z,1496338119.725 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s. 2017-06-01T17:28:40.123Z,1496338120.123 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s. 2017-06-01T17:28:40.526Z,1496338120.526 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s. 2017-06-01T17:28:40.932Z,1496338120.932 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s. 2017-06-01T17:28:41.331Z,1496338121.331 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s. 2017-06-01T17:28:41.735Z,1496338121.736 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s. 2017-06-01T17:28:42.133Z,1496338122.133 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s. 2017-06-01T17:28:42.534Z,1496338122.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s. 2017-06-01T17:28:42.929Z,1496338122.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s. 2017-06-01T17:28:43.334Z,1496338123.334 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s. 2017-06-01T17:28:43.725Z,1496338123.725 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s. 2017-06-01T17:28:44.144Z,1496338124.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s. 2017-06-01T17:28:44.553Z,1496338124.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s. 2017-06-01T17:28:44.947Z,1496338124.947 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s. 2017-06-01T17:28:45.313Z,1496338125.313 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s. 2017-06-01T17:28:45.710Z,1496338125.710 [BPC1](ERROR): Failed to parse bank A battery data 2017-06-01T17:28:45.710Z,1496338125.710 [BPC1] Data Fault, FailCount= 1 2017-06-01T17:28:45.710Z,1496338125.710 [BPC1](ERROR): Data Fault 2017-06-01T17:28:45.718Z,1496338125.718 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s. 2017-06-01T17:28:45.770Z,1496338125.770 [CBIT](ERROR): Data Fault in component: BPC1 2017-06-01T17:28:46.124Z,1496338126.124 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s. 2017-06-01T17:28:46.529Z,1496338126.529 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s. 2017-06-01T17:28:46.930Z,1496338126.930 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s. 2017-06-01T17:28:46.966Z,1496338126.966 [CBIT](INFO): Clearing failed state for component BPC1 2017-06-01T17:28:46.966Z,1496338126.966 [BPC1] No Fault, FailCount= 1 2017-06-01T17:28:47.391Z,1496338127.391 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.9 s old, using for 20.0 s. 2017-06-01T17:28:47.760Z,1496338127.760 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s. 2017-06-01T17:28:48.123Z,1496338128.122 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s. 2017-06-01T17:28:48.522Z,1496338128.522 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s. 2017-06-01T17:28:48.926Z,1496338128.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s. 2017-06-01T17:28:49.324Z,1496338129.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s. 2017-06-01T17:28:49.727Z,1496338129.727 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s. 2017-06-01T17:28:50.129Z,1496338130.129 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s. 2017-06-01T17:28:50.533Z,1496338130.533 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s. 2017-06-01T17:28:50.932Z,1496338130.932 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s. 2017-06-01T17:28:51.324Z,1496338131.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s. 2017-06-01T17:28:51.725Z,1496338131.725 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s. 2017-06-01T17:28:52.138Z,1496338132.138 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s. 2017-06-01T17:28:52.531Z,1496338132.531 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 20.0 s old, using for 20.0 s. 2017-06-01T17:28:58.960Z,1496338138.960 [Default:CheckIn:Read_GPS](INFO): Timed out from 2017-06-01T17:23:58.8Z 2017-06-01T17:28:58.960Z,1496338138.960 [Default:CheckIn:Read_GPS] Stopped 2017-06-01T17:28:58.960Z,1496338138.960 [Default:CheckIn:Read_Iridium] Running Loop=1 2017-06-01T17:29:29.676Z,1496338169.676 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2017-06-01T17:29:46.389Z,1496338186.389 [CommandLine](IMPORTANT): got command failComponent 2017-06-01T17:29:46.389Z,1496338186.389 [CommandLine](IMPORTANT): Failed components: 2017-06-01T17:29:46.389Z,1496338186.389 [CommandLine](IMPORTANT): Rowe_600LCM: Communications Fault 2017-06-01T17:29:52.604Z,1496338192.604 [CommandLine](IMPORTANT): got command restart application 2017-06-01T17:29:53.610Z,1496338193.610 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:53.611Z,1496338193.611 [CommandLine ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:53.615Z,1496338193.615 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2017-06-01T17:29:53.615Z,1496338193.615 [CommandLine ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:53.616Z,1496338193.616 [CommandLine](INFO): Join timeout helper Thread ID is 929 2017-06-01T17:29:53.616Z,1496338193.616 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2017-06-01T17:29:53.616Z,1496338193.616 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:53.617Z,1496338193.617 [NavChartDb](INFO): Join timeout helper Thread ID is 930 2017-06-01T17:29:53.991Z,1496338193.991 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:53.991Z,1496338193.991 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.003Z,1496338194.003 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler 2017-06-01T17:29:54.003Z,1496338194.003 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.003Z,1496338194.003 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 931 2017-06-01T17:29:54.379Z,1496338194.379 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:54.379Z,1496338194.379 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-06-01T17:29:54.508Z,1496338194.508 [Rowe_600LCM](INFO): Powering down 2017-06-01T17:29:54.509Z,1496338194.509 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.523Z,1496338194.523 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2017-06-01T17:29:54.523Z,1496338194.523 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.524Z,1496338194.524 [Radio_Surface](INFO): Join timeout helper Thread ID is 933 2017-06-01T17:29:54.703Z,1496338194.703 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:54.704Z,1496338194.704 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.723Z,1496338194.723 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2017-06-01T17:29:54.723Z,1496338194.723 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.724Z,1496338194.724 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 934 2017-06-01T17:29:54.887Z,1496338194.887 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:54.887Z,1496338194.887 [WetLabsBB2FL](INFO): Powering down 2017-06-01T17:29:54.888Z,1496338194.888 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.890Z,1496338194.890 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2017-06-01T17:29:54.890Z,1496338194.890 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:54.890Z,1496338194.890 [CTD_Seabird](INFO): Join timeout helper Thread ID is 935 2017-06-01T17:29:54.924Z,1496338194.924 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:55.102Z,1496338195.102 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2017-06-01T17:29:55.102Z,1496338195.102 [CTD_Seabird](INFO): Powering down 2017-06-01T17:29:55.104Z,1496338195.104 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.120Z,1496338195.120 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2017-06-01T17:29:55.120Z,1496338195.120 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.120Z,1496338195.120 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 937 2017-06-01T17:29:55.211Z,1496338195.211 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:55.211Z,1496338195.211 [CTD_NeilBrown](INFO): Powering down 2017-06-01T17:29:55.212Z,1496338195.212 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.220Z,1496338195.220 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2017-06-01T17:29:55.220Z,1496338195.220 [logger ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.220Z,1496338195.220 [logger](INFO): Join timeout helper Thread ID is 938 2017-06-01T17:29:55.243Z,1496338195.243 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:55.243Z,1496338195.243 [logger ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.260Z,1496338195.260 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2017-06-01T17:29:55.260Z,1496338195.260 [CommandLine ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.260Z,1496338195.260 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2017-06-01T17:29:55.260Z,1496338195.260 [controlThread ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.261Z,1496338195.260 [controlThread](INFO): Join timeout helper Thread ID is 939 2017-06-01T17:29:55.271Z,1496338195.271 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2017-06-01T17:29:55.271Z,1496338195.271 [controlThread](DEBUG): Uninitializing ControlThread 2017-06-01T17:29:55.272Z,1496338195.272 [Aanderaa_O2](INFO): Powering down 2017-06-01T17:29:55.274Z,1496338195.274 [NAL9602](INFO): Powering down 2017-06-01T17:29:55.275Z,1496338195.275 [PNI_TCM](INFO): Powering down 2017-06-01T17:29:55.364Z,1496338195.364 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2017-06-01T17:29:55.366Z,1496338195.366 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2017-06-01T17:29:55.366Z,1496338195.366 [MissionManager](INFO): Uninitializing Mission Default 2017-06-01T17:29:55.366Z,1496338195.366 [Default] Stopped 2017-06-01T17:29:55.367Z,1496338195.367 [Default](DEBUG): Aggregate::uninitialize Default 2017-06-01T17:29:55.367Z,1496338195.367 [Default:B.GoToSurface] Stopped 2017-06-01T17:29:55.367Z,1496338195.367 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2017-06-01T17:29:55.367Z,1496338195.367 [Default:CheckIn] Stopped 2017-06-01T17:29:55.367Z,1496338195.367 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2017-06-01T17:29:55.367Z,1496338195.367 [Default:CheckIn:Read_Iridium] Stopped 2017-06-01T17:29:55.370Z,1496338195.370 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2017-06-01T17:29:55.371Z,1496338195.371 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2017-06-01T17:29:55.371Z,1496338195.371 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2017-06-01T17:29:55.371Z,1496338195.371 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2017-06-01T17:29:55.372Z,1496338195.372 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2017-06-01T17:29:55.372Z,1496338195.372 [BuoyancyServo](INFO): Powering down 2017-06-01T17:29:55.387Z,1496338195.387 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2017-06-01T17:29:55.387Z,1496338195.387 [ElevatorServo](INFO): Powering down 2017-06-01T17:29:55.388Z,1496338195.388 [MassServo](DEBUG): Uninitialize Mass Servo. 2017-06-01T17:29:55.388Z,1496338195.388 [MassServo](INFO): Powering down 2017-06-01T17:29:55.389Z,1496338195.389 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2017-06-01T17:29:55.389Z,1496338195.389 [RudderServo](INFO): Powering down 2017-06-01T17:29:55.390Z,1496338195.390 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2017-06-01T17:29:55.390Z,1496338195.390 [ThrusterServo](INFO): Powering down 2017-06-01T17:29:55.391Z,1496338195.391 [SBIT](DEBUG): Uninitialize SBIT Component. 2017-06-01T17:29:55.392Z,1496338195.392 [IBIT](DEBUG): Uninitialize IBIT Component. 2017-06-01T17:29:55.392Z,1496338195.392 [CBIT](DEBUG): Uninitialize CBIT Component. 2017-06-01T17:29:55.393Z,1496338195.393 [controlThread ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.450Z,1496338195.450 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.454Z,1496338195.454 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.457Z,1496338195.457 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.524Z,1496338195.524 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.555Z,1496338195.556 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.599Z,1496338195.599 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2017-06-01T17:29:55.649Z,1496338195.649 [logger ThreadHandler](INFO): Thread cancelled.