2018-11-07T21:37:45.578Z,1541626665.578 [Supervisor](DEBUG): Initializing supervisor. 2018-11-07T21:37:45.580Z,1541626665.580 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-11-07T21:37:45.581Z,1541626665.581 [SyncHandler](INFO): Protected caller Thread ID is 799 2018-11-07T21:37:45.581Z,1541626665.581 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-11-07T21:37:45.582Z,1541626665.582 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-11-07T21:37:45.583Z,1541626665.583 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 800 2018-11-07T21:37:45.585Z,1541626665.585 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-11-07T21:37:45.597Z,1541626665.597 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-11-07T21:37:45.598Z,1541626665.598 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-11-07T21:37:45.599Z,1541626665.599 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 801 2018-11-07T21:37:45.599Z,1541626665.599 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-11-07T21:37:45.600Z,1541626665.600 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-11-07T21:37:45.601Z,1541626665.601 [logger ThreadHandler](INFO): Protected caller Thread ID is 802 2018-11-07T21:37:45.603Z,1541626665.603 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-11-07T21:37:45.603Z,1541626665.603 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-11-07T21:37:45.608Z,1541626665.608 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-11-07T21:37:45.963Z,1541626665.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-11-07T21:37:45.964Z,1541626665.964 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-11-07T21:37:46.456Z,1541626666.456 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-11-07T21:37:46.458Z,1541626666.458 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-11-07T21:37:46.842Z,1541626666.842 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-11-07T21:37:46.843Z,1541626666.843 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-11-07T21:37:47.055Z,1541626667.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-11-07T21:37:47.056Z,1541626667.056 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-11-07T21:37:47.550Z,1541626667.550 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-11-07T21:37:47.551Z,1541626667.551 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-11-07T21:37:48.071Z,1541626668.071 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-11-07T21:37:48.071Z,1541626668.071 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-11-07T21:37:48.182Z,1541626668.182 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-11-07T21:37:48.183Z,1541626668.183 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-11-07T21:37:48.404Z,1541626668.404 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-11-07T21:37:48.405Z,1541626668.405 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-11-07T21:37:48.558Z,1541626668.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-11-07T21:37:48.559Z,1541626668.559 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-11-07T21:37:48.642Z,1541626668.642 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-11-07T21:37:48.879Z,1541626668.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-11-07T21:37:48.879Z,1541626668.879 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-11-07T21:37:48.985Z,1541626668.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-11-07T21:37:48.986Z,1541626668.986 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-11-07T21:37:49.571Z,1541626669.571 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-11-07T21:37:49.572Z,1541626669.572 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-11-07T21:37:50.319Z,1541626670.319 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-11-07T21:37:50.320Z,1541626670.320 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-11-07T21:37:50.668Z,1541626670.668 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-11-07T21:37:50.670Z,1541626670.670 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/ 2018-11-07T21:37:50.673Z,1541626670.673 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg 2018-11-07T21:37:50.816Z,1541626670.816 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg 2018-11-07T21:37:51.049Z,1541626671.049 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-11-07T21:37:51.050Z,1541626671.050 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg 2018-11-07T21:37:51.240Z,1541626671.240 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg 2018-11-07T21:37:51.346Z,1541626671.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg 2018-11-07T21:37:51.452Z,1541626671.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg 2018-11-07T21:37:51.665Z,1541626671.665 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg 2018-11-07T21:37:51.753Z,1541626671.753 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg 2018-11-07T21:37:51.857Z,1541626671.857 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg 2018-11-07T21:37:51.955Z,1541626671.955 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg 2018-11-07T21:37:52.041Z,1541626672.041 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg 2018-11-07T21:37:52.156Z,1541626672.156 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-11-07T21:37:52.160Z,1541626672.160 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-11-07T21:37:52.316Z,1541626672.316 [SBIT](DEBUG): Construct Startup Built In Test. 2018-11-07T21:37:52.347Z,1541626672.347 [SBIT] Loaded 2018-11-07T21:37:52.348Z,1541626672.348 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-11-07T21:37:52.348Z,1541626672.348 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-11-07T21:37:52.376Z,1541626672.376 [IBIT] Loaded 2018-11-07T21:37:52.377Z,1541626672.377 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-11-07T21:37:52.380Z,1541626672.380 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-11-07T21:37:52.536Z,1541626672.536 [CBIT] Loaded 2018-11-07T21:37:52.536Z,1541626672.536 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-11-07T21:37:52.537Z,1541626672.537 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-11-07T21:37:52.537Z,1541626672.537 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-11-07T21:37:52.674Z,1541626672.674 [BuoyancyServo] Loaded 2018-11-07T21:37:52.674Z,1541626672.674 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-11-07T21:37:52.690Z,1541626672.690 [ElevatorServo] Loaded 2018-11-07T21:37:52.690Z,1541626672.690 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-11-07T21:37:52.704Z,1541626672.704 [MassServo] Loaded 2018-11-07T21:37:52.705Z,1541626672.705 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-11-07T21:37:52.720Z,1541626672.720 [RudderServo] Loaded 2018-11-07T21:37:52.721Z,1541626672.721 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-11-07T21:37:52.736Z,1541626672.736 [ThrusterServo] Loaded 2018-11-07T21:37:52.736Z,1541626672.736 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-11-07T21:37:52.736Z,1541626672.736 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-11-07T21:37:52.737Z,1541626672.737 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-11-07T21:37:52.854Z,1541626672.854 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-11-07T21:37:52.854Z,1541626672.854 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-11-07T21:37:52.909Z,1541626672.909 [DeadReckonUsingSpeedCalculator] Loaded 2018-11-07T21:37:52.909Z,1541626672.909 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-11-07T21:37:52.926Z,1541626672.926 [NavChart] Loaded 2018-11-07T21:37:52.926Z,1541626672.926 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-11-07T21:37:52.930Z,1541626672.930 [UniversalFixResidualReporter] Loaded 2018-11-07T21:37:52.930Z,1541626672.930 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-11-07T21:37:52.931Z,1541626672.931 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-11-07T21:37:52.931Z,1541626672.931 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-11-07T21:37:52.955Z,1541626672.955 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-11-07T21:37:52.956Z,1541626672.956 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-11-07T21:37:53.244Z,1541626673.244 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-11-07T21:37:53.245Z,1541626673.245 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-11-07T21:37:53.868Z,1541626673.868 [AHRS_M2] Loaded 2018-11-07T21:37:53.868Z,1541626673.868 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2018-11-07T21:37:54.007Z,1541626674.007 [DataOverHttps] Loaded 2018-11-07T21:37:54.007Z,1541626674.007 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-11-07T21:37:54.020Z,1541626674.020 [Depth_Keller] Loaded 2018-11-07T21:37:54.021Z,1541626674.021 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-11-07T21:37:54.026Z,1541626674.026 [DropWeight] Loaded 2018-11-07T21:37:54.026Z,1541626674.026 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-11-07T21:37:54.116Z,1541626674.116 [NAL9602] Loaded 2018-11-07T21:37:54.117Z,1541626674.117 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-11-07T21:37:54.122Z,1541626674.122 [Onboard] Loaded 2018-11-07T21:37:54.122Z,1541626674.122 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-11-07T21:37:54.129Z,1541626674.129 [Radio_Surface] Loaded 2018-11-07T21:37:54.130Z,1541626674.130 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-11-07T21:37:54.131Z,1541626674.131 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408364E0 2018-11-07T21:37:54.131Z,1541626674.131 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 881 2018-11-07T21:37:54.160Z,1541626674.160 [RDI_Pathfinder] Loaded 2018-11-07T21:37:54.160Z,1541626674.160 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2018-11-07T21:37:54.182Z,1541626674.182 [RDI_PathfinderUp] Loaded 2018-11-07T21:37:54.182Z,1541626674.182 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread. 2018-11-07T21:37:54.189Z,1541626674.189 [SCPI] Loaded 2018-11-07T21:37:54.189Z,1541626674.189 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2018-11-07T21:37:56.199Z,1541626676.199 [BPC1] Loaded 2018-11-07T21:37:56.200Z,1541626676.200 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-11-07T21:37:56.200Z,1541626676.200 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-11-07T21:37:56.201Z,1541626676.201 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-11-07T21:37:56.289Z,1541626676.289 [VerticalControl](DEBUG): Construct VerticalControl. 2018-11-07T21:37:56.379Z,1541626676.379 [VerticalControl] Loaded 2018-11-07T21:37:56.379Z,1541626676.379 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-11-07T21:37:56.380Z,1541626676.380 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-11-07T21:37:56.439Z,1541626676.439 [HorizontalControl] Loaded 2018-11-07T21:37:56.439Z,1541626676.439 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-11-07T21:37:56.440Z,1541626676.440 [SpeedControl](DEBUG): Construct SpeedControl. 2018-11-07T21:37:56.442Z,1541626676.442 [SpeedControl] Loaded 2018-11-07T21:37:56.442Z,1541626676.442 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-11-07T21:37:56.443Z,1541626676.443 [LoopControl](DEBUG): Construct LoopControl. 2018-11-07T21:37:56.444Z,1541626676.444 [LoopControl] Loaded 2018-11-07T21:37:56.444Z,1541626676.444 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-11-07T21:37:56.444Z,1541626676.444 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-11-07T21:37:56.445Z,1541626676.445 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-11-07T21:37:56.571Z,1541626676.571 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-11-07T21:37:56.572Z,1541626676.572 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-11-07T21:37:56.781Z,1541626676.781 [Aanderaa_O2] Loaded 2018-11-07T21:37:56.781Z,1541626676.781 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-11-07T21:37:56.866Z,1541626676.866 [CTD_NeilBrown] Loaded 2018-11-07T21:37:56.866Z,1541626676.866 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2018-11-07T21:37:56.867Z,1541626676.867 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409364E0 2018-11-07T21:37:56.867Z,1541626676.867 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 882 2018-11-07T21:37:56.913Z,1541626676.913 [WetLabsSeaOWL_UV_A] Loaded 2018-11-07T21:37:56.913Z,1541626676.913 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2018-11-07T21:37:56.915Z,1541626676.915 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409664E0 2018-11-07T21:37:56.915Z,1541626676.915 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 883 2018-11-07T21:37:56.916Z,1541626676.916 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-11-07T21:37:56.916Z,1541626676.916 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-11-07T21:37:57.018Z,1541626677.018 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-11-07T21:37:57.019Z,1541626677.019 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-11-07T21:37:57.077Z,1541626677.077 [DepthRateCalculator] Loaded 2018-11-07T21:37:57.077Z,1541626677.077 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-11-07T21:37:57.082Z,1541626677.082 [PitchRateCalculator] Loaded 2018-11-07T21:37:57.083Z,1541626677.083 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-11-07T21:37:57.095Z,1541626677.095 [SpeedCalculator] Loaded 2018-11-07T21:37:57.095Z,1541626677.095 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-11-07T21:37:57.117Z,1541626677.117 [TempGradientCalculator] Loaded 2018-11-07T21:37:57.117Z,1541626677.117 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-11-07T21:37:57.122Z,1541626677.122 [YawRateCalculator] Loaded 2018-11-07T21:37:57.123Z,1541626677.123 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-11-07T21:37:57.153Z,1541626677.153 [ElevatorOffsetCalculator] Loaded 2018-11-07T21:37:57.153Z,1541626677.153 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-11-07T21:37:57.154Z,1541626677.154 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-11-07T21:37:57.155Z,1541626677.155 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-11-07T21:37:57.192Z,1541626677.192 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-11-07T21:37:57.196Z,1541626677.196 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-11-07T21:37:57.197Z,1541626677.197 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-11-07T21:37:57.204Z,1541626677.204 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-11-07T21:37:57.205Z,1541626677.205 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2018-11-07T21:37:57.205Z,1541626677.205 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 884 2018-11-07T21:37:57.210Z,1541626677.210 [Supervisor](INFO): Main Thread ID is 795 2018-11-07T21:37:57.210Z,1541626677.210 [Supervisor](DEBUG): Running supervisor. 2018-11-07T21:37:57.211Z,1541626677.211 [CommandLine ThreadHandler](INFO): Handler Thread ID is 885 2018-11-07T21:37:57.213Z,1541626677.213 [controlThread ThreadHandler](INFO): Handler Thread ID is 886 2018-11-07T21:37:57.213Z,1541626677.213 [controlThread](DEBUG): Initializing ControlThread 2018-11-07T21:37:57.214Z,1541626677.214 [SBIT](INFO): Initialize SBIT Component. 2018-11-07T21:37:57.215Z,1541626677.215 [SBIT](IMPORTANT): git: 2018-10-09-34-gf593050 2018-11-07T21:37:57.215Z,1541626677.215 [SBIT](INFO): git hash: f5930504aac459d36ba66e787e98c9e35813b4f6 2018-11-07T21:37:57.215Z,1541626677.215 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-11-07T21:37:57.215Z,1541626677.215 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-11-07T21:37:57.217Z,1541626677.217 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2018-11-07T21:37:57.217Z,1541626677.217 [IBIT](INFO): Initialize IBIT Component. 2018-11-07T21:37:57.218Z,1541626677.218 [CBIT](DEBUG): Initialize CBIT Component. 2018-11-07T21:37:57.218Z,1541626677.218 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-11-07T21:37:57.219Z,1541626677.219 [logger ThreadHandler](INFO): Handler Thread ID is 887 2018-11-07T21:37:57.247Z,1541626677.247 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 888 2018-11-07T21:37:57.253Z,1541626677.253 [Radio_Surface](INFO): Powering up 2018-11-07T21:37:57.259Z,1541626677.259 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 889 2018-11-07T21:37:57.260Z,1541626677.260 [CTD_NeilBrown](INFO): Powering down 2018-11-07T21:37:57.288Z,1541626677.288 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 890 2018-11-07T21:37:57.289Z,1541626677.289 [WetLabsSeaOWL_UV_A](INFO): Powering down 2018-11-07T21:37:57.319Z,1541626677.319 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 891 2018-11-07T21:37:57.324Z,1541626677.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:37:57.324Z,1541626677.324 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:37:57.325Z,1541626677.325 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:37:57.325Z,1541626677.325 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:37:57.326Z,1541626677.326 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:37:57.326Z,1541626677.326 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:37:57.326Z,1541626677.326 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-11-07T21:37:57.327Z,1541626677.327 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-11-07T21:37:57.334Z,1541626677.334 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-11-07T21:37:57.336Z,1541626677.336 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-11-07T21:37:57.337Z,1541626677.337 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-11-07T21:37:57.337Z,1541626677.337 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-11-07T21:37:57.338Z,1541626677.338 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-07T21:37:57.338Z,1541626677.338 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-11-07T21:37:57.339Z,1541626677.339 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-11-07T21:37:57.340Z,1541626677.340 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-11-07T21:37:57.341Z,1541626677.341 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-11-07T21:37:57.342Z,1541626677.342 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-11-07T21:37:57.345Z,1541626677.345 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-11-07T21:37:57.345Z,1541626677.345 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-11-07T21:37:57.345Z,1541626677.345 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-11-07T21:37:57.345Z,1541626677.345 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-11-07T21:37:57.346Z,1541626677.346 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-11-07T21:37:57.346Z,1541626677.346 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-11-07T21:37:57.346Z,1541626677.346 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-11-07T21:37:57.346Z,1541626677.346 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-11-07T21:37:57.346Z,1541626677.346 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-11-07T21:37:57.346Z,1541626677.346 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-11-07T21:37:57.347Z,1541626677.347 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-11-07T21:37:57.347Z,1541626677.347 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-11-07T21:37:57.347Z,1541626677.347 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-11-07T21:37:57.348Z,1541626677.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-11-07T21:37:57.348Z,1541626677.348 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-11-07T21:37:57.348Z,1541626677.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-11-07T21:37:57.359Z,1541626677.359 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-11-07T21:37:57.411Z,1541626677.411 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-07T21:37:57.439Z,1541626677.439 [MissionManager](DEBUG): 2018-11-07T21:37:57.439Z,1541626677.439 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-11-07T21:37:57.525Z,1541626677.525 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-11-07T21:37:57.526Z,1541626677.526 [Default:A.Wait](DEBUG): Construct Wait. 2018-11-07T21:37:57.544Z,1541626677.544 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-07T21:37:57.579Z,1541626677.579 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-11-07T21:37:57.582Z,1541626677.582 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-11-07T21:37:57.604Z,1541626677.604 [Default:E.Execute](DEBUG): Construct Execute. 2018-11-07T21:37:57.622Z,1541626677.622 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2018-11-07T21:37:57.627Z,1541626677.627 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,RDI_PathfinderUp,SCPI,BPC1,Aanderaa_O2,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-11-07T21:37:57.651Z,1541626677.651 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:37:57.789Z,1541626677.789 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-11-07T21:37:58.300Z,1541626678.300 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-07T21:37:58.307Z,1541626678.307 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-07T21:37:58.330Z,1541626678.330 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-07T21:37:58.335Z,1541626678.335 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-07T21:37:58.349Z,1541626678.349 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-07T21:37:58.351Z,1541626678.351 [MassServo](DEBUG): Initializing MassServo. 2018-11-07T21:37:58.381Z,1541626678.381 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-07T21:37:58.387Z,1541626678.387 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-07T21:37:58.393Z,1541626678.393 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-07T21:37:58.399Z,1541626678.399 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-07T21:37:58.541Z,1541626678.541 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-11-07T21:37:58.542Z,1541626678.542 [DropWeight] Hardware Fault, FailCount= 1 2018-11-07T21:37:58.542Z,1541626678.542 [DropWeight](ERROR): Hardware Fault 2018-11-07T21:37:58.651Z,1541626678.651 [RDI_PathfinderUp](INFO): Powering down 2018-11-07T21:37:58.760Z,1541626678.760 [CommandLine](FAULT): Scheduling is paused 2018-11-07T21:37:58.761Z,1541626678.761 [CBIT](INFO): Critical error at 20181107T213758 2018-11-07T21:37:58.761Z,1541626678.761 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-11-07T21:37:58.763Z,1541626678.763 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-11-07T21:37:58.764Z,1541626678.764 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-11-07T21:37:59.267Z,1541626679.267 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-07T21:37:59.267Z,1541626679.267 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-07T21:37:59.267Z,1541626679.267 [BuoyancyServo] Communications Fault, FailCount= 1 2018-11-07T21:37:59.267Z,1541626679.267 [BuoyancyServo](ERROR): Communications Fault 2018-11-07T21:37:59.472Z,1541626679.472 [CBIT](INFO): Critical error at 20181107T213758 2018-11-07T21:37:59.475Z,1541626679.475 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-07T21:37:59.537Z,1541626679.537 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-07T21:37:59.538Z,1541626679.538 [BuoyancyServo](INFO): Powering down 2018-11-07T21:38:01.555Z,1541626681.555 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:01.676Z,1541626681.676 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-07T21:38:01.676Z,1541626681.676 [BuoyancyServo] No Fault, FailCount= 1 2018-11-07T21:38:01.929Z,1541626681.929 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-07T21:38:02.048Z,1541626682.048 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-07T21:38:07.604Z,1541626687.604 [CBIT](CRITICAL): Environmental Failure. Press:14.846547 PSI. Humidity:38%. Temp:25 C. ABORTING MISSION 2018-11-07T21:38:07.978Z,1541626687.978 [CBIT](INFO): Critical error at 20181107T213807 2018-11-07T21:38:08.358Z,1541626688.358 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:38:08.358Z,1541626688.358 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-07T21:38:08.358Z,1541626688.358 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:38:08.383Z,1541626688.383 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:38:08.879Z,1541626688.879 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:38:09.590Z,1541626689.590 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:38:09.590Z,1541626689.590 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-07T21:38:11.135Z,1541626691.135 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2018-11-07T21:38:11.135Z,1541626691.135 [AHRS_M2] Data Fault, FailCount= 1 2018-11-07T21:38:11.135Z,1541626691.135 [AHRS_M2](ERROR): Data Fault 2018-11-07T21:38:11.199Z,1541626691.199 [CBIT](ERROR): Data Fault in component: AHRS_M2 2018-11-07T21:38:11.524Z,1541626691.524 [AHRS_M2](INFO): Powering down 2018-11-07T21:38:15.184Z,1541626695.184 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:38:15.184Z,1541626695.184 [AHRS_M2] No Fault, FailCount= 1 2018-11-07T21:38:15.523Z,1541626695.523 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:38:19.195Z,1541626699.195 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:19.995Z,1541626699.995 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:20.031Z,1541626700.031 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:38:20.031Z,1541626700.031 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-07T21:38:20.031Z,1541626700.031 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:38:20.075Z,1541626700.075 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:38:20.357Z,1541626700.357 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:38:20.357Z,1541626700.357 [RDI_Pathfinder] Communications Fault, FailCount= 1 2018-11-07T21:38:20.357Z,1541626700.357 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:38:20.479Z,1541626700.479 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:38:20.499Z,1541626700.499 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:38:20.831Z,1541626700.831 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:38:21.195Z,1541626701.195 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:21.263Z,1541626701.263 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:38:21.263Z,1541626701.263 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-07T21:38:21.582Z,1541626701.582 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:38:21.582Z,1541626701.582 [RDI_Pathfinder] No Fault, FailCount= 1 2018-11-07T21:38:22.395Z,1541626702.395 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:23.595Z,1541626703.595 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:24.340Z,1541626704.340 [NAL9602](INFO): Powering up NAL9602 2018-11-07T21:38:24.795Z,1541626704.795 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:25.995Z,1541626705.995 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:26.088Z,1541626706.088 [SBIT](IMPORTANT): Beginning Startup BIT 2018-11-07T21:38:26.104Z,1541626706.104 [CBIT](IMPORTANT): Beginning ground fault scan 2018-11-07T21:38:27.995Z,1541626707.995 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:38:28.919Z,1541626708.919 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2018-11-07T21:38:28.919Z,1541626708.919 [AHRS_M2] Data Fault, FailCount= 2 2018-11-07T21:38:28.919Z,1541626708.919 [AHRS_M2](ERROR): Data Fault 2018-11-07T21:38:29.068Z,1541626709.068 [CBIT](ERROR): Data Fault in component: AHRS_M2 2018-11-07T21:38:29.307Z,1541626709.307 [AHRS_M2](INFO): Powering down 2018-11-07T21:38:31.734Z,1541626711.734 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:38:31.734Z,1541626711.734 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-11-07T21:38:31.734Z,1541626711.734 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:38:31.848Z,1541626711.848 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:38:31.849Z,1541626711.849 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-11-07T21:38:32.255Z,1541626712.255 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:38:33.008Z,1541626713.008 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:38:33.008Z,1541626713.008 [AHRS_M2] No Fault, FailCount= 2 2018-11-07T21:38:33.307Z,1541626713.307 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:38:35.312Z,1541626715.312 [NAL9602](INFO): NAL9602 initialized 2018-11-07T21:38:36.831Z,1541626716.831 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:37.439Z,1541626717.439 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:37.560Z,1541626717.560 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.008184 CHAN A1 (24V): 0.003340 CHAN A2 (12V): -0.007267 CHAN A3 (5V): -0.002066 CHAN B0 (3.3V): 0.000444 CHAN B1 (3.15aV): -0.000246 CHAN B2 (3.15bV): 0.000290 CHAN B3 (GND): 0.002383 OPEN: 0.006392 Full Scale Calc: 4.765 mA, -1.589 mA 2018-11-07T21:38:37.679Z,1541626717.679 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:38.291Z,1541626718.291 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:38.723Z,1541626718.723 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:39.155Z,1541626719.155 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:39.604Z,1541626719.604 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:39.807Z,1541626719.807 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:40.431Z,1541626720.431 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:40.899Z,1541626720.899 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:41.663Z,1541626721.663 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:42.247Z,1541626722.247 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:42.731Z,1541626722.731 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:43.207Z,1541626723.207 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:43.711Z,1541626723.711 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:43.711Z,1541626723.711 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:38:43.711Z,1541626723.711 [AHRS_M2] Communications Fault, FailCount= 3 2018-11-07T21:38:43.711Z,1541626723.711 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:38:43.884Z,1541626723.884 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:38:43.890Z,1541626723.890 [AHRS_M2](INFO): Powering down 2018-11-07T21:38:44.335Z,1541626724.335 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:38:44.335Z,1541626724.335 [RDI_Pathfinder] Communications Fault, FailCount= 2 2018-11-07T21:38:44.335Z,1541626724.335 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:38:44.488Z,1541626724.488 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:38:44.803Z,1541626724.803 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:38:45.636Z,1541626725.636 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:38:45.636Z,1541626725.636 [RDI_Pathfinder] No Fault, FailCount= 2 2018-11-07T21:38:47.604Z,1541626727.604 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:38:47.604Z,1541626727.604 [AHRS_M2] No Fault, FailCount= 3 2018-11-07T21:38:47.891Z,1541626727.891 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:38:51.415Z,1541626731.415 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:51.868Z,1541626731.868 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:52.303Z,1541626732.303 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:52.747Z,1541626732.747 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:53.183Z,1541626733.183 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:53.607Z,1541626733.607 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:54.044Z,1541626734.044 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:54.479Z,1541626734.479 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:54.927Z,1541626734.927 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:55.383Z,1541626735.383 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:55.827Z,1541626735.827 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:56.275Z,1541626736.275 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:56.783Z,1541626736.783 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:57.187Z,1541626737.187 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:57.579Z,1541626737.579 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:57.991Z,1541626737.991 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:38:57.991Z,1541626737.991 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:38:57.991Z,1541626737.991 [AHRS_M2] Communications Fault, FailCount= 4 2018-11-07T21:38:57.991Z,1541626737.991 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:38:58.045Z,1541626738.045 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:38:58.063Z,1541626738.063 [AHRS_M2](INFO): Powering down 2018-11-07T21:39:01.714Z,1541626741.714 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:39:01.714Z,1541626741.714 [AHRS_M2] No Fault, FailCount= 4 2018-11-07T21:39:02.063Z,1541626742.063 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:39:05.587Z,1541626745.587 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:06.023Z,1541626746.023 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:06.439Z,1541626746.439 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:06.855Z,1541626746.855 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:07.263Z,1541626747.263 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:07.443Z,1541626747.443 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:07.827Z,1541626747.827 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:08.239Z,1541626748.239 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:08.261Z,1541626748.261 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:39:08.261Z,1541626748.261 [RDI_Pathfinder] Communications Fault, FailCount= 3 2018-11-07T21:39:08.261Z,1541626748.261 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:39:08.720Z,1541626748.720 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:39:08.720Z,1541626748.720 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:39:08.819Z,1541626748.819 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:08.927Z,1541626748.927 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:39:09.054Z,1541626749.054 [CBIT](INFO): Critical error at 20181107T213908 2018-11-07T21:39:09.227Z,1541626749.227 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:09.615Z,1541626749.615 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:10.015Z,1541626750.015 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:10.427Z,1541626750.427 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:10.827Z,1541626750.827 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:11.235Z,1541626751.235 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:11.919Z,1541626751.919 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:12.143Z,1541626752.143 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:39:12.143Z,1541626752.143 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:39:12.143Z,1541626752.143 [AHRS_M2] Communications Fault, FailCount= 5 2018-11-07T21:39:12.143Z,1541626752.143 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:39:12.268Z,1541626752.268 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:39:12.268Z,1541626752.268 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2018-11-07T21:39:12.455Z,1541626752.455 [AHRS_M2](INFO): Powering down 2018-11-07T21:39:12.610Z,1541626752.610 [CBIT](INFO): Critical error at 20181107T213912 2018-11-07T21:39:20.117Z,1541626760.117 [SBIT](IMPORTANT): SBIT PASSED 2018-11-07T21:39:20.212Z,1541626760.212 [CommandLine](IMPORTANT): got command configSet list 2018-11-07T21:39:20.212Z,1541626760.212 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2018-11-07T21:39:20.212Z,1541626760.212 [CommandLine](IMPORTANT): No configSet variables persisted 2018-11-07T21:39:20.509Z,1541626760.509 [MissionManager](IMPORTANT): Started mission Startup 2018-11-07T21:39:20.510Z,1541626760.510 [Startup] Running Loop=1 2018-11-07T21:39:20.510Z,1541626760.510 [Startup](DEBUG): Aggregate::initialize Startup 2018-11-07T21:39:20.510Z,1541626760.510 [Startup:A.GoToSurface] Running Loop=1 2018-11-07T21:39:20.510Z,1541626760.510 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-11-07T21:39:20.511Z,1541626760.511 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-11-07T21:39:20.511Z,1541626760.511 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-11-07T21:39:20.511Z,1541626760.511 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-11-07T21:39:20.512Z,1541626760.512 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-11-07T21:39:20.512Z,1541626760.512 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-11-07T21:39:20.518Z,1541626760.518 [Startup:StartupSatComms] Running Loop=1 2018-11-07T21:39:20.519Z,1541626760.519 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2018-11-07T21:39:20.519Z,1541626760.519 [Startup:StartupSatComms:A] Running Loop=1 2018-11-07T21:39:20.910Z,1541626760.910 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2018-11-07T21:39:57.703Z,1541626797.703 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:39:57.703Z,1541626797.703 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2018-11-07T21:39:57.703Z,1541626797.703 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:39:57.704Z,1541626797.704 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:39:57.705Z,1541626797.705 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2018-11-07T21:39:57.705Z,1541626797.705 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:39:57.774Z,1541626797.774 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:39:57.774Z,1541626797.774 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:39:58.106Z,1541626798.106 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:39:58.106Z,1541626798.106 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2018-11-07T21:39:58.107Z,1541626798.107 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:39:58.107Z,1541626798.107 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2018-11-07T21:39:58.552Z,1541626798.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:39:58.552Z,1541626798.552 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:39:58.553Z,1541626798.553 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:39:58.553Z,1541626798.553 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:39:58.554Z,1541626798.554 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:39:58.554Z,1541626798.554 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:40:20.541Z,1541626820.541 [Startup:StartupSatComms:A](INFO): Timed out from 2018-11-07T21:39:20.5Z 2018-11-07T21:40:20.541Z,1541626820.541 [Startup:StartupSatComms:A] Stopped 2018-11-07T21:40:20.541Z,1541626820.541 [Startup:StartupSatComms:B] Running Loop=1 2018-11-07T21:40:20.913Z,1541626820.913 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-11-07T21:40:21.277Z,1541626821.277 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004418 2018-11-07T21:40:25.227Z,1541626825.227 [DataOverHttps](INFO): Sending 111 bytes from file Logs/20181107T201845/Courier0022.lzma 2018-11-07T21:40:26.025Z,1541626826.025 [DataOverHttps](INFO): Moved sent file to Logs/20181107T201845/Courier0022.lzma.bak 2018-11-07T21:40:26.025Z,1541626826.025 [DataOverHttps](INFO): SBD MOMSN=8808198 2018-11-07T21:40:34.773Z,1541626834.773 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20181107T213326/Courier0000.lzma 2018-11-07T21:40:35.572Z,1541626835.572 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213326/Courier0000.lzma.bak 2018-11-07T21:40:35.573Z,1541626835.573 [DataOverHttps](INFO): SBD MOMSN=8808203 2018-11-07T21:40:44.325Z,1541626844.325 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20181107T213411/Courier0000.lzma 2018-11-07T21:40:45.124Z,1541626845.124 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213411/Courier0000.lzma.bak 2018-11-07T21:40:45.125Z,1541626845.125 [DataOverHttps](INFO): SBD MOMSN=8808209 2018-11-07T21:40:49.225Z,1541626849.225 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2018-11-07T21:40:53.965Z,1541626853.965 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20181107T213444/Courier0000.lzma 2018-11-07T21:40:54.744Z,1541626854.744 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213444/Courier0000.lzma.bak 2018-11-07T21:40:54.745Z,1541626854.745 [DataOverHttps](INFO): SBD MOMSN=8808215 2018-11-07T21:41:03.597Z,1541626863.597 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:41:03.597Z,1541626863.597 [Aanderaa_O2] No Fault, FailCount= 3 2018-11-07T21:41:03.632Z,1541626863.632 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20181107T213516/Courier0000.lzma 2018-11-07T21:41:04.405Z,1541626864.405 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213516/Courier0000.lzma.bak 2018-11-07T21:41:04.405Z,1541626864.405 [DataOverHttps](INFO): SBD MOMSN=8808221 2018-11-07T21:41:19.745Z,1541626879.745 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:41:19.745Z,1541626879.745 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-07T21:41:19.746Z,1541626879.746 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:41:19.777Z,1541626879.777 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:41:19.863Z,1541626879.863 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20181107T213547/Courier0000.lzma 2018-11-07T21:41:20.039Z,1541626880.039 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:41:20.630Z,1541626880.630 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213547/Courier0000.lzma.bak 2018-11-07T21:41:20.630Z,1541626880.630 [DataOverHttps](INFO): SBD MOMSN=8808227 2018-11-07T21:41:20.714Z,1541626880.714 [Startup:StartupSatComms:B](INFO): Timed out from 2018-11-07T21:40:20.5Z 2018-11-07T21:41:20.714Z,1541626880.714 [Startup:StartupSatComms:B] Stopped 2018-11-07T21:41:20.714Z,1541626880.714 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2018-11-07T21:41:20.714Z,1541626880.714 [Startup:StartupSatComms] Stopped 2018-11-07T21:41:20.714Z,1541626880.714 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2018-11-07T21:41:20.723Z,1541626880.723 [Startup](INFO): Completed Startup 2018-11-07T21:41:20.724Z,1541626880.724 [MissionManager](INFO): Startup is completed. 2018-11-07T21:41:20.724Z,1541626880.724 [MissionManager](INFO): Uninitializing Mission Startup 2018-11-07T21:41:20.724Z,1541626880.724 [Startup] Stopped 2018-11-07T21:41:20.724Z,1541626880.724 [Startup](DEBUG): Aggregate::uninitialize Startup 2018-11-07T21:41:20.724Z,1541626880.724 [Startup:A.GoToSurface] Stopped 2018-11-07T21:41:20.724Z,1541626880.724 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-11-07T21:41:20.761Z,1541626880.761 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:41:20.761Z,1541626880.761 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-07T21:41:21.116Z,1541626881.116 [MissionManager](IMPORTANT): Started mission Default 2018-11-07T21:41:21.118Z,1541626881.118 [Default] Running Loop=1 2018-11-07T21:41:21.118Z,1541626881.118 [Default](DEBUG): Aggregate::initialize Default 2018-11-07T21:41:21.118Z,1541626881.118 [Default:B.GoToSurface] Running Loop=1 2018-11-07T21:41:21.135Z,1541626881.135 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-11-07T21:41:21.135Z,1541626881.135 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-11-07T21:41:21.135Z,1541626881.135 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-11-07T21:41:21.136Z,1541626881.136 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-11-07T21:41:21.136Z,1541626881.136 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-11-07T21:41:21.136Z,1541626881.136 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-11-07T21:41:21.137Z,1541626881.137 [Default:A.Wait] Running Loop=1 2018-11-07T21:41:21.137Z,1541626881.137 [Default:A.Wait](DEBUG): Initialize Wait Component. 2018-11-07T21:41:31.337Z,1541626891.337 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:41:31.337Z,1541626891.337 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-07T21:41:31.337Z,1541626891.337 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:41:31.381Z,1541626891.381 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:41:31.859Z,1541626891.859 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:41:32.560Z,1541626892.560 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:41:32.560Z,1541626892.560 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-07T21:41:34.541Z,1541626894.541 [Default:A.Wait](INFO): Done Waiting. 2018-11-07T21:41:34.542Z,1541626894.542 [Default:A.Wait] Stopped 2018-11-07T21:41:34.542Z,1541626894.542 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2018-11-07T21:41:34.941Z,1541626894.941 [Default:CheckIn] Running Loop=1 2018-11-07T21:41:34.942Z,1541626894.942 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-07T21:41:34.942Z,1541626894.942 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-07T21:41:35.345Z,1541626895.345 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2018-11-07T21:41:43.328Z,1541626903.328 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:41:43.329Z,1541626903.329 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-11-07T21:41:43.329Z,1541626903.329 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:41:43.352Z,1541626903.352 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:41:43.353Z,1541626903.353 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-11-07T21:41:43.855Z,1541626903.855 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:41:59.697Z,1541626919.697 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:41:59.697Z,1541626919.697 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2018-11-07T21:41:59.697Z,1541626919.697 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:41:59.699Z,1541626919.699 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:41:59.699Z,1541626919.699 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2018-11-07T21:41:59.699Z,1541626919.699 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:41:59.712Z,1541626919.712 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:41:59.712Z,1541626919.712 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:41:59.851Z,1541626919.851 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:41:59.851Z,1541626919.851 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2018-11-07T21:41:59.852Z,1541626919.852 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:41:59.852Z,1541626919.852 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2018-11-07T21:42:00.182Z,1541626920.182 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:42:00.183Z,1541626920.183 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:42:00.183Z,1541626920.183 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:42:00.184Z,1541626920.184 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:42:00.184Z,1541626920.184 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:42:00.184Z,1541626920.184 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:42:08.584Z,1541626928.584 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:42:08.584Z,1541626928.584 [RDI_Pathfinder] No Fault, FailCount= 3 2018-11-07T21:42:21.355Z,1541626941.355 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout. 2018-11-07T21:42:21.355Z,1541626941.355 [RDI_Pathfinder] Data Fault, FailCount= 1 2018-11-07T21:42:21.356Z,1541626941.355 [RDI_Pathfinder](ERROR): Data Fault 2018-11-07T21:42:21.410Z,1541626941.410 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder 2018-11-07T21:42:21.811Z,1541626941.811 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:42:22.572Z,1541626942.572 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:42:22.572Z,1541626942.572 [RDI_Pathfinder] No Fault, FailCount= 1 2018-11-07T21:42:45.344Z,1541626965.344 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:42:45.344Z,1541626965.344 [RDI_Pathfinder] Communications Fault, FailCount= 2 2018-11-07T21:42:45.345Z,1541626965.345 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:42:45.412Z,1541626965.412 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:42:45.807Z,1541626965.807 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:42:46.581Z,1541626966.581 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:42:46.582Z,1541626966.582 [RDI_Pathfinder] No Fault, FailCount= 2 2018-11-07T21:43:10.033Z,1541626990.033 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:43:10.033Z,1541626990.033 [RDI_Pathfinder] Communications Fault, FailCount= 3 2018-11-07T21:43:10.033Z,1541626990.033 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:43:10.096Z,1541626990.096 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:43:10.096Z,1541626990.096 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:43:10.259Z,1541626990.259 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:43:10.304Z,1541626990.304 [CBIT](INFO): Critical error at 20181107T214310 2018-11-07T21:43:39.312Z,1541627019.312 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-11-07T21:44:00.507Z,1541627040.507 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:44:00.507Z,1541627040.507 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2018-11-07T21:44:00.507Z,1541627040.507 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:44:00.509Z,1541627040.509 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:44:00.509Z,1541627040.509 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2018-11-07T21:44:00.509Z,1541627040.509 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:44:00.578Z,1541627040.578 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:44:00.578Z,1541627040.578 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:44:00.918Z,1541627040.918 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:44:00.939Z,1541627040.939 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2018-11-07T21:44:00.939Z,1541627040.939 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:44:00.939Z,1541627040.939 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2018-11-07T21:44:01.302Z,1541627041.302 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:44:01.303Z,1541627041.303 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:44:01.303Z,1541627041.303 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:44:01.304Z,1541627041.304 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:44:01.304Z,1541627041.304 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:44:01.304Z,1541627041.304 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:44:12.519Z,1541627052.519 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:44:12.519Z,1541627052.519 [AHRS_M2] No Fault, FailCount= 5 2018-11-07T21:44:12.859Z,1541627052.859 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:44:13.712Z,1541627053.712 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:44:13.712Z,1541627053.712 [Aanderaa_O2] No Fault, FailCount= 3 2018-11-07T21:44:15.300Z,1541627055.300 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6. 2018-11-07T21:44:16.155Z,1541627056.155 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:16.555Z,1541627056.555 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:16.955Z,1541627056.955 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:17.355Z,1541627057.355 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:17.755Z,1541627057.755 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:20.615Z,1541627060.615 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:21.011Z,1541627061.011 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:21.411Z,1541627061.411 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:21.811Z,1541627061.811 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:22.211Z,1541627062.211 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:22.611Z,1541627062.611 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:23.011Z,1541627063.011 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:23.011Z,1541627063.011 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:44:23.011Z,1541627063.011 [AHRS_M2] Communications Fault, FailCount= 1 2018-11-07T21:44:23.011Z,1541627063.011 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:44:23.081Z,1541627063.081 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:44:23.315Z,1541627063.315 [AHRS_M2](INFO): Powering down 2018-11-07T21:44:24.155Z,1541627064.155 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:44:24.155Z,1541627064.155 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-07T21:44:24.155Z,1541627064.155 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:44:24.179Z,1541627064.179 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:44:24.667Z,1541627064.667 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:44:25.379Z,1541627065.379 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:44:25.379Z,1541627065.379 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-07T21:44:26.971Z,1541627066.971 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:44:26.971Z,1541627066.971 [AHRS_M2] No Fault, FailCount= 1 2018-11-07T21:44:27.315Z,1541627067.315 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:44:30.615Z,1541627070.615 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:31.015Z,1541627071.015 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:31.411Z,1541627071.411 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:31.815Z,1541627071.815 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:32.211Z,1541627072.211 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:32.611Z,1541627072.611 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:33.011Z,1541627073.011 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:33.415Z,1541627073.415 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:33.811Z,1541627073.811 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:34.215Z,1541627074.215 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:34.615Z,1541627074.615 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:35.003Z,1541627075.003 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:35.407Z,1541627075.407 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:35.811Z,1541627075.811 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:35.838Z,1541627075.838 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:44:35.838Z,1541627075.838 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-07T21:44:35.838Z,1541627075.838 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:44:35.905Z,1541627075.905 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:44:36.211Z,1541627076.211 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:36.359Z,1541627076.359 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:44:36.611Z,1541627076.611 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:37.016Z,1541627077.016 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:37.061Z,1541627077.061 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:44:37.061Z,1541627077.061 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-07T21:44:37.391Z,1541627077.391 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:37.391Z,1541627077.391 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:44:37.391Z,1541627077.391 [AHRS_M2] Communications Fault, FailCount= 2 2018-11-07T21:44:37.391Z,1541627077.391 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:44:37.490Z,1541627077.490 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:44:37.715Z,1541627077.715 [AHRS_M2](INFO): Powering down 2018-11-07T21:44:41.393Z,1541627081.393 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:44:41.393Z,1541627081.393 [AHRS_M2] No Fault, FailCount= 2 2018-11-07T21:44:41.715Z,1541627081.715 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:44:45.015Z,1541627085.015 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:45.415Z,1541627085.415 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:45.815Z,1541627085.815 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:46.215Z,1541627086.215 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:46.611Z,1541627086.611 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:47.011Z,1541627087.011 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:47.415Z,1541627087.415 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:47.811Z,1541627087.811 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:47.848Z,1541627087.848 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:44:47.848Z,1541627087.848 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-11-07T21:44:47.848Z,1541627087.848 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:44:47.905Z,1541627087.905 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:44:47.905Z,1541627087.905 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-11-07T21:44:48.211Z,1541627088.211 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:48.367Z,1541627088.367 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:44:48.591Z,1541627088.591 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:49.015Z,1541627089.015 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:49.391Z,1541627089.391 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:49.811Z,1541627089.811 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:50.191Z,1541627090.191 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:50.591Z,1541627090.591 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:50.991Z,1541627090.991 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:51.403Z,1541627091.403 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:51.795Z,1541627091.795 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:44:51.795Z,1541627091.795 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:44:51.795Z,1541627091.795 [AHRS_M2] Communications Fault, FailCount= 3 2018-11-07T21:44:51.795Z,1541627091.795 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:44:51.873Z,1541627091.873 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:44:52.115Z,1541627092.115 [AHRS_M2](INFO): Powering down 2018-11-07T21:44:56.103Z,1541627096.103 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:44:56.103Z,1541627096.103 [AHRS_M2] No Fault, FailCount= 3 2018-11-07T21:44:56.447Z,1541627096.447 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:44:59.723Z,1541627099.723 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:00.123Z,1541627100.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:00.543Z,1541627100.543 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:00.923Z,1541627100.923 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:01.323Z,1541627101.323 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:01.723Z,1541627101.723 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:02.123Z,1541627102.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:02.529Z,1541627102.529 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:02.947Z,1541627102.947 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:03.343Z,1541627103.343 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:03.743Z,1541627103.743 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:04.123Z,1541627104.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:04.543Z,1541627104.543 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:04.943Z,1541627104.943 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:05.323Z,1541627105.323 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:05.735Z,1541627105.735 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:06.143Z,1541627106.143 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:06.539Z,1541627106.539 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:06.539Z,1541627106.539 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:45:06.539Z,1541627106.539 [AHRS_M2] Communications Fault, FailCount= 4 2018-11-07T21:45:06.539Z,1541627106.539 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:45:06.584Z,1541627106.584 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:45:06.848Z,1541627106.848 [AHRS_M2](INFO): Powering down 2018-11-07T21:45:10.519Z,1541627110.519 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:45:10.519Z,1541627110.519 [AHRS_M2] No Fault, FailCount= 4 2018-11-07T21:45:10.847Z,1541627110.847 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:45:14.123Z,1541627114.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:14.523Z,1541627114.523 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:14.943Z,1541627114.943 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:15.347Z,1541627115.347 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:15.743Z,1541627115.743 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:16.147Z,1541627116.147 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:16.523Z,1541627116.523 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:16.923Z,1541627116.923 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:17.343Z,1541627117.343 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:17.743Z,1541627117.743 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:18.123Z,1541627118.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:18.523Z,1541627118.523 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:18.923Z,1541627118.923 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:19.323Z,1541627119.323 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:19.723Z,1541627119.723 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:20.123Z,1541627120.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:20.523Z,1541627120.523 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:45:21.319Z,1541627121.319 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:22.119Z,1541627122.119 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:23.319Z,1541627123.319 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:24.519Z,1541627124.519 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:25.719Z,1541627125.719 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:26.919Z,1541627126.919 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:28.119Z,1541627128.119 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:45:30.895Z,1541627130.895 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2018-11-07T21:45:30.895Z,1541627130.895 [AHRS_M2] Data Fault, FailCount= 5 2018-11-07T21:45:30.895Z,1541627130.895 [AHRS_M2](ERROR): Data Fault 2018-11-07T21:45:31.072Z,1541627131.072 [CBIT](ERROR): Data Fault in component: AHRS_M2 2018-11-07T21:45:31.073Z,1541627131.073 [CBIT](CRITICAL): Data Fault in component: AHRS_M2 2018-11-07T21:45:31.283Z,1541627131.283 [AHRS_M2](INFO): Powering down 2018-11-07T21:45:31.436Z,1541627131.436 [CBIT](INFO): Critical error at 20181107T214531 2018-11-07T21:46:01.336Z,1541627161.336 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:46:01.337Z,1541627161.337 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2018-11-07T21:46:01.337Z,1541627161.337 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:46:01.338Z,1541627161.338 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:46:01.338Z,1541627161.338 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2018-11-07T21:46:01.338Z,1541627161.338 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:46:01.351Z,1541627161.351 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:46:01.351Z,1541627161.351 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:46:01.767Z,1541627161.767 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:46:01.767Z,1541627161.767 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2018-11-07T21:46:01.768Z,1541627161.768 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:46:01.768Z,1541627161.768 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2018-11-07T21:46:02.122Z,1541627162.122 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:46:02.151Z,1541627162.151 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:46:02.151Z,1541627162.151 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:46:02.152Z,1541627162.152 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:46:02.152Z,1541627162.152 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:46:02.153Z,1541627162.153 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:46:10.395Z,1541627170.395 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:46:10.396Z,1541627170.396 [RDI_Pathfinder] No Fault, FailCount= 3 2018-11-07T21:46:23.174Z,1541627183.174 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout. 2018-11-07T21:46:23.174Z,1541627183.174 [RDI_Pathfinder] Data Fault, FailCount= 1 2018-11-07T21:46:23.174Z,1541627183.174 [RDI_Pathfinder](ERROR): Data Fault 2018-11-07T21:46:23.200Z,1541627183.200 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder 2018-11-07T21:46:23.623Z,1541627183.623 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:46:24.400Z,1541627184.400 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:46:24.400Z,1541627184.400 [RDI_Pathfinder] No Fault, FailCount= 1 2018-11-07T21:46:35.185Z,1541627195.185 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-07T21:41:34.9Z 2018-11-07T21:46:35.185Z,1541627195.185 [Default:CheckIn:Read_GPS] Stopped 2018-11-07T21:46:35.186Z,1541627195.186 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-07T21:46:35.584Z,1541627195.584 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-11-07T21:46:39.551Z,1541627199.551 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181107T213612/Courier0000.lzma 2018-11-07T21:46:40.352Z,1541627200.352 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213612/Courier0000.lzma.bak 2018-11-07T21:46:40.353Z,1541627200.353 [DataOverHttps](INFO): SBD MOMSN=8808272 2018-11-07T21:46:49.045Z,1541627209.045 [DataOverHttps](INFO): Sending 260 bytes from file Logs/20181107T213745/Courier0000.lzma 2018-11-07T21:46:49.844Z,1541627209.844 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213745/Courier0000.lzma.bak 2018-11-07T21:46:49.845Z,1541627209.845 [DataOverHttps](INFO): SBD MOMSN=8808275 2018-11-07T21:46:49.888Z,1541627209.888 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:46:49.888Z,1541627209.888 [RDI_Pathfinder] Communications Fault, FailCount= 2 2018-11-07T21:46:49.888Z,1541627209.888 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:46:49.960Z,1541627209.960 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:46:50.419Z,1541627210.419 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:46:53.772Z,1541627213.772 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:46:53.772Z,1541627213.772 [RDI_Pathfinder] No Fault, FailCount= 2 2018-11-07T21:46:58.521Z,1541627218.521 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20181107T213745/Courier0004.lzma 2018-11-07T21:46:59.320Z,1541627219.320 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213745/Courier0004.lzma.bak 2018-11-07T21:46:59.321Z,1541627219.321 [DataOverHttps](INFO): SBD MOMSN=8808283 2018-11-07T21:47:07.973Z,1541627227.973 [DataOverHttps](INFO): Sending 418 bytes from file Logs/20181107T201845/Express0023.lzma 2018-11-07T21:47:08.772Z,1541627228.772 [DataOverHttps](INFO): Moved sent file to Logs/20181107T201845/Express0023.lzma.bak 2018-11-07T21:47:08.773Z,1541627228.773 [DataOverHttps](INFO): SBD MOMSN=8808287 2018-11-07T21:47:17.429Z,1541627237.429 [DataOverHttps](INFO): Sending 609 bytes from file Logs/20181107T213326/Express0001.lzma 2018-11-07T21:47:17.918Z,1541627237.918 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:47:17.918Z,1541627237.918 [Aanderaa_O2] No Fault, FailCount= 3 2018-11-07T21:47:18.224Z,1541627238.224 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213326/Express0001.lzma.bak 2018-11-07T21:47:18.225Z,1541627238.225 [DataOverHttps](INFO): SBD MOMSN=8808312 2018-11-07T21:47:18.271Z,1541627238.271 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:47:18.271Z,1541627238.271 [RDI_Pathfinder] Communications Fault, FailCount= 3 2018-11-07T21:47:18.272Z,1541627238.272 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:47:18.316Z,1541627238.316 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:47:18.316Z,1541627238.316 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:47:18.887Z,1541627238.887 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:47:18.934Z,1541627238.934 [CBIT](INFO): Critical error at 20181107T214718 2018-11-07T21:47:26.888Z,1541627246.888 [DataOverHttps](INFO): Sending 486 bytes from file Logs/20181107T213411/Express0001.lzma 2018-11-07T21:47:27.684Z,1541627247.684 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213411/Express0001.lzma.bak 2018-11-07T21:47:27.685Z,1541627247.685 [DataOverHttps](INFO): SBD MOMSN=8808330 2018-11-07T21:47:28.513Z,1541627248.513 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:47:28.513Z,1541627248.513 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-07T21:47:28.513Z,1541627248.513 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:47:28.536Z,1541627248.536 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:47:31.699Z,1541627251.699 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:47:32.209Z,1541627252.209 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:47:32.209Z,1541627252.209 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-07T21:47:36.508Z,1541627256.508 [DataOverHttps](INFO): Sending 485 bytes from file Logs/20181107T213444/Express0001.lzma 2018-11-07T21:47:37.284Z,1541627257.284 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213444/Express0001.lzma.bak 2018-11-07T21:47:37.285Z,1541627257.285 [DataOverHttps](INFO): SBD MOMSN=8808341 2018-11-07T21:47:42.852Z,1541627262.852 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:47:42.852Z,1541627262.852 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-07T21:47:42.852Z,1541627262.852 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:47:42.876Z,1541627262.876 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:47:46.039Z,1541627266.039 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:47:46.092Z,1541627266.092 [DataOverHttps](INFO): Sending 486 bytes from file Logs/20181107T213516/Express0001.lzma 2018-11-07T21:47:46.548Z,1541627266.548 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:47:46.548Z,1541627266.548 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-07T21:47:46.892Z,1541627266.892 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213516/Express0001.lzma.bak 2018-11-07T21:47:46.893Z,1541627266.893 [DataOverHttps](INFO): SBD MOMSN=8808352 2018-11-07T21:47:55.587Z,1541627275.587 [DataOverHttps](INFO): Sending 427 bytes from file Logs/20181107T213547/Express0001.lzma 2018-11-07T21:47:56.384Z,1541627276.384 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213547/Express0001.lzma.bak 2018-11-07T21:47:56.385Z,1541627276.385 [DataOverHttps](INFO): SBD MOMSN=8808363 2018-11-07T21:47:57.058Z,1541627277.058 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:47:57.058Z,1541627277.058 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-11-07T21:47:57.058Z,1541627277.058 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:47:57.104Z,1541627277.104 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:47:57.104Z,1541627277.104 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-11-07T21:47:57.319Z,1541627277.319 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:48:05.002Z,1541627285.002 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:48:05.002Z,1541627285.002 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2018-11-07T21:48:05.002Z,1541627285.002 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:48:05.004Z,1541627285.004 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:48:05.004Z,1541627285.004 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2018-11-07T21:48:05.004Z,1541627285.004 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:48:05.073Z,1541627285.073 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:48:05.074Z,1541627285.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:48:05.084Z,1541627285.084 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181107T213612/Express0001.lzma 2018-11-07T21:48:05.141Z,1541627285.141 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:48:05.141Z,1541627285.141 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2018-11-07T21:48:05.141Z,1541627285.141 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:48:05.141Z,1541627285.141 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2018-11-07T21:48:05.534Z,1541627285.534 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:48:05.535Z,1541627285.535 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:48:05.535Z,1541627285.535 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:48:05.536Z,1541627285.536 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:48:05.536Z,1541627285.536 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:48:05.536Z,1541627285.536 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:48:05.884Z,1541627285.884 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213612/Express0001.lzma.bak 2018-11-07T21:48:05.885Z,1541627285.885 [DataOverHttps](INFO): SBD MOMSN=8808372 2018-11-07T21:48:14.562Z,1541627294.562 [DataOverHttps](INFO): Sending 955 bytes from file Logs/20181107T213745/Express0001.lzma 2018-11-07T21:48:15.360Z,1541627295.360 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213745/Express0001.lzma.bak 2018-11-07T21:48:15.361Z,1541627295.361 [DataOverHttps](INFO): SBD MOMSN=8808374 2018-11-07T21:48:24.057Z,1541627304.057 [DataOverHttps](INFO): Sending 458 bytes from file Logs/20181107T213745/Express0005.lzma 2018-11-07T21:48:24.856Z,1541627304.856 [DataOverHttps](INFO): Moved sent file to Logs/20181107T213745/Express0005.lzma.bak 2018-11-07T21:48:24.857Z,1541627304.857 [DataOverHttps](INFO): SBD MOMSN=8808401 2018-11-07T21:48:25.456Z,1541627305.456 [Default:CheckIn:Read_Iridium] Stopped 2018-11-07T21:48:25.456Z,1541627305.456 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-07T21:48:25.456Z,1541627305.456 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-07T21:48:37.616Z,1541627317.616 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-11-07T21:48:37.616Z,1541627317.616 [NAL9602] Data Fault, FailCount= 1 2018-11-07T21:48:37.616Z,1541627317.616 [NAL9602](ERROR): Data Fault 2018-11-07T21:48:37.689Z,1541627317.689 [CBIT](ERROR): Data Fault in component: NAL9602 2018-11-07T21:48:38.016Z,1541627318.016 [NAL9602](INFO): Powering down 2018-11-07T21:48:38.863Z,1541627318.863 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-07T21:48:38.863Z,1541627318.863 [NAL9602] No Fault, FailCount= 1 2018-11-07T21:49:08.360Z,1541627348.360 [NAL9602](INFO): Powering up NAL9602 2018-11-07T21:49:19.560Z,1541627359.560 [NAL9602](INFO): NAL9602 initialized 2018-11-07T21:50:05.915Z,1541627405.915 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:50:05.916Z,1541627405.916 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2018-11-07T21:50:05.916Z,1541627405.916 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:50:05.917Z,1541627405.917 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:50:05.917Z,1541627405.917 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2018-11-07T21:50:05.917Z,1541627405.917 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:50:05.930Z,1541627405.930 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:50:05.931Z,1541627405.931 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:50:06.331Z,1541627406.331 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:50:06.331Z,1541627406.331 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2018-11-07T21:50:06.332Z,1541627406.332 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:50:06.332Z,1541627406.332 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2018-11-07T21:50:06.730Z,1541627406.730 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:50:06.731Z,1541627406.731 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:50:06.731Z,1541627406.731 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:50:06.732Z,1541627406.732 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:50:06.732Z,1541627406.732 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:50:06.732Z,1541627406.732 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:50:18.276Z,1541627418.276 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:50:18.276Z,1541627418.276 [RDI_Pathfinder] No Fault, FailCount= 3 2018-11-07T21:50:27.071Z,1541627427.071 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:50:27.072Z,1541627427.072 [Aanderaa_O2] No Fault, FailCount= 3 2018-11-07T21:50:31.049Z,1541627431.049 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:50:31.049Z,1541627431.049 [AHRS_M2] No Fault, FailCount= 5 2018-11-07T21:50:31.403Z,1541627431.403 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:50:31.434Z,1541627431.434 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout. 2018-11-07T21:50:31.434Z,1541627431.434 [RDI_Pathfinder] Data Fault, FailCount= 1 2018-11-07T21:50:31.434Z,1541627431.434 [RDI_Pathfinder](ERROR): Data Fault 2018-11-07T21:50:31.499Z,1541627431.499 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder 2018-11-07T21:50:31.899Z,1541627431.899 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:50:32.685Z,1541627432.685 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:50:32.685Z,1541627432.685 [RDI_Pathfinder] No Fault, FailCount= 1 2018-11-07T21:50:34.699Z,1541627434.699 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:35.099Z,1541627435.099 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:35.499Z,1541627435.499 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:35.899Z,1541627435.899 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:36.299Z,1541627436.299 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:36.699Z,1541627436.699 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:37.099Z,1541627437.099 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:37.499Z,1541627437.499 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:37.536Z,1541627437.536 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:50:37.536Z,1541627437.536 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-07T21:50:37.536Z,1541627437.536 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:50:37.557Z,1541627437.557 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:50:37.899Z,1541627437.899 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:38.055Z,1541627438.055 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:50:38.299Z,1541627438.299 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:38.699Z,1541627438.699 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:38.784Z,1541627438.784 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:50:38.784Z,1541627438.784 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-07T21:50:39.091Z,1541627439.091 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:39.491Z,1541627439.491 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:39.899Z,1541627439.899 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:40.299Z,1541627440.299 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:40.699Z,1541627440.699 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:41.099Z,1541627441.099 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:41.499Z,1541627441.499 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:41.499Z,1541627441.499 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:50:41.499Z,1541627441.499 [AHRS_M2] Communications Fault, FailCount= 1 2018-11-07T21:50:41.499Z,1541627441.499 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:50:41.575Z,1541627441.575 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:50:41.803Z,1541627441.803 [AHRS_M2](INFO): Powering down 2018-11-07T21:50:45.471Z,1541627445.471 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:50:45.471Z,1541627445.471 [AHRS_M2] No Fault, FailCount= 1 2018-11-07T21:50:45.803Z,1541627445.803 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:50:49.702Z,1541627449.702 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:50:49.702Z,1541627449.702 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-07T21:50:49.702Z,1541627449.702 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:50:49.728Z,1541627449.728 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:50:49.851Z,1541627449.851 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:50.015Z,1541627450.015 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:50:50.231Z,1541627450.231 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:50.631Z,1541627450.631 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:50.728Z,1541627450.728 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-07T21:50:50.728Z,1541627450.728 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-07T21:50:51.031Z,1541627451.031 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:51.431Z,1541627451.431 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:51.831Z,1541627451.831 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:52.223Z,1541627452.223 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:52.631Z,1541627452.631 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:53.031Z,1541627453.031 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:53.431Z,1541627453.431 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:53.831Z,1541627453.831 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:54.231Z,1541627454.231 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:54.631Z,1541627454.631 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:55.023Z,1541627455.023 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:55.423Z,1541627455.423 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:55.460Z,1541627455.460 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:50:55.460Z,1541627455.460 [RDI_Pathfinder] Communications Fault, FailCount= 2 2018-11-07T21:50:55.460Z,1541627455.460 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:50:55.508Z,1541627455.508 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:50:55.831Z,1541627455.831 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:50:55.831Z,1541627455.831 [AHRS_M2](FAULT): Failed to initialize within timeout. 2018-11-07T21:50:55.831Z,1541627455.831 [AHRS_M2] Communications Fault, FailCount= 2 2018-11-07T21:50:55.831Z,1541627455.831 [AHRS_M2](ERROR): Communications Fault 2018-11-07T21:50:55.943Z,1541627455.943 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:50:55.964Z,1541627455.964 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2018-11-07T21:50:56.135Z,1541627456.135 [AHRS_M2](INFO): Powering down 2018-11-07T21:50:56.597Z,1541627456.597 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2018-11-07T21:50:56.597Z,1541627456.597 [RDI_Pathfinder] No Fault, FailCount= 2 2018-11-07T21:50:59.808Z,1541627459.808 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:50:59.808Z,1541627459.808 [AHRS_M2] No Fault, FailCount= 2 2018-11-07T21:51:00.135Z,1541627460.135 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:51:01.373Z,1541627461.373 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-07T21:51:01.373Z,1541627461.373 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-11-07T21:51:01.373Z,1541627461.373 [Aanderaa_O2](ERROR): Communications Fault 2018-11-07T21:51:01.429Z,1541627461.429 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-07T21:51:01.429Z,1541627461.429 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-11-07T21:51:01.888Z,1541627461.888 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:51:03.431Z,1541627463.431 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:03.831Z,1541627463.831 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:04.219Z,1541627464.219 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:04.631Z,1541627464.631 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:05.035Z,1541627465.035 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:05.431Z,1541627465.431 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:05.857Z,1541627465.857 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:06.239Z,1541627466.239 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:06.631Z,1541627466.631 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:07.031Z,1541627467.031 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:07.435Z,1541627467.435 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:07.831Z,1541627467.831 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:08.231Z,1541627468.231 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:09.008Z,1541627469.008 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:09.407Z,1541627469.407 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:10.607Z,1541627470.607 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:11.799Z,1541627471.799 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:12.999Z,1541627472.999 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:14.199Z,1541627474.199 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:15.399Z,1541627475.399 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:16.607Z,1541627476.607 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:17.807Z,1541627477.807 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:19.007Z,1541627479.007 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:19.019Z,1541627479.019 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2018-11-07T21:51:19.019Z,1541627479.019 [AHRS_M2] Data Fault, FailCount= 3 2018-11-07T21:51:19.019Z,1541627479.019 [AHRS_M2](ERROR): Data Fault 2018-11-07T21:51:19.073Z,1541627479.073 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing 2018-11-07T21:51:19.074Z,1541627479.074 [RDI_Pathfinder] Communications Fault, FailCount= 3 2018-11-07T21:51:19.074Z,1541627479.074 [RDI_Pathfinder](ERROR): Communications Fault 2018-11-07T21:51:19.105Z,1541627479.105 [CBIT](ERROR): Data Fault in component: AHRS_M2 2018-11-07T21:51:19.106Z,1541627479.106 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:51:19.106Z,1541627479.106 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder 2018-11-07T21:51:19.335Z,1541627479.335 [AHRS_M2](INFO): Powering down 2018-11-07T21:51:19.519Z,1541627479.519 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:51:19.567Z,1541627479.567 [CBIT](INFO): Critical error at 20181107T215119 2018-11-07T21:51:25.343Z,1541627485.343 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:51:25.343Z,1541627485.343 [AHRS_M2] No Fault, FailCount= 3 2018-11-07T21:51:25.683Z,1541627485.683 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:51:28.959Z,1541627488.959 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:29.379Z,1541627489.379 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:29.779Z,1541627489.779 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:30.159Z,1541627490.159 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:30.559Z,1541627490.559 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:30.959Z,1541627490.959 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:31.371Z,1541627491.371 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:31.763Z,1541627491.763 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:32.183Z,1541627492.183 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:32.559Z,1541627492.559 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:32.959Z,1541627492.959 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:33.359Z,1541627493.359 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:33.759Z,1541627493.759 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:34.159Z,1541627494.159 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:34.559Z,1541627494.559 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:34.959Z,1541627494.959 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:35.359Z,1541627495.359 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout 2018-11-07T21:51:36.155Z,1541627496.155 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:38.155Z,1541627498.155 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:39.355Z,1541627499.355 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:40.555Z,1541627500.555 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:41.755Z,1541627501.755 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:42.955Z,1541627502.955 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:44.155Z,1541627504.155 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:45.355Z,1541627505.355 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:46.095Z,1541627506.095 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2018-11-07T21:51:46.095Z,1541627506.095 [AHRS_M2] Data Fault, FailCount= 4 2018-11-07T21:51:46.095Z,1541627506.095 [AHRS_M2](ERROR): Data Fault 2018-11-07T21:51:46.180Z,1541627506.180 [CBIT](ERROR): Data Fault in component: AHRS_M2 2018-11-07T21:51:46.483Z,1541627506.483 [AHRS_M2](INFO): Powering down 2018-11-07T21:51:50.149Z,1541627510.149 [CBIT](INFO): Clearing failed state for component AHRS_M2 2018-11-07T21:51:50.149Z,1541627510.149 [AHRS_M2] No Fault, FailCount= 4 2018-11-07T21:51:50.483Z,1541627510.483 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2018-11-07T21:51:56.155Z,1541627516.155 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:51:57.355Z,1541627517.355 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:52:01.027Z,1541627521.027 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:52:02.227Z,1541627522.227 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:52:03.427Z,1541627523.427 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout 2018-11-07T21:52:03.767Z,1541627523.767 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 2018-11-07T21:52:03.767Z,1541627523.767 [AHRS_M2] Data Fault, FailCount= 5 2018-11-07T21:52:03.767Z,1541627523.767 [AHRS_M2](ERROR): Data Fault 2018-11-07T21:52:03.840Z,1541627523.840 [CBIT](ERROR): Data Fault in component: AHRS_M2 2018-11-07T21:52:03.841Z,1541627523.841 [CBIT](CRITICAL): Data Fault in component: AHRS_M2 2018-11-07T21:52:04.155Z,1541627524.155 [AHRS_M2](INFO): Powering down 2018-11-07T21:52:04.304Z,1541627524.304 [CBIT](INFO): Critical error at 20181107T215203 2018-11-07T21:52:07.007Z,1541627527.007 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:52:07.007Z,1541627527.007 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2018-11-07T21:52:07.007Z,1541627527.007 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-07T21:52:07.009Z,1541627527.009 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-07T21:52:07.009Z,1541627527.009 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2018-11-07T21:52:07.009Z,1541627527.009 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-07T21:52:07.021Z,1541627527.021 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-07T21:52:07.022Z,1541627527.022 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-07T21:52:07.419Z,1541627527.419 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-07T21:52:07.419Z,1541627527.419 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2018-11-07T21:52:07.419Z,1541627527.419 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-07T21:52:07.419Z,1541627527.419 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2018-11-07T21:52:07.795Z,1541627527.795 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-07T21:52:07.796Z,1541627527.796 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:52:07.796Z,1541627527.796 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:52:07.796Z,1541627527.796 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-07T21:52:07.797Z,1541627527.797 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-07T21:52:07.797Z,1541627527.797 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-07T21:52:58.558Z,1541627578.558 [CBIT](INFO): Clearing failed state for component DropWeight 2018-11-07T21:52:58.558Z,1541627578.558 [DropWeight] No Fault, FailCount= 1 2018-11-07T21:53:12.830Z,1541627592.830 [CommandLine](IMPORTANT): got command restart application 2018-11-07T21:53:13.838Z,1541627593.838 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:13.838Z,1541627593.838 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.839Z,1541627593.839 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-11-07T21:53:13.839Z,1541627593.839 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.840Z,1541627593.840 [CommandLine](INFO): Join timeout helper Thread ID is 975 2018-11-07T21:53:13.840Z,1541627593.840 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-11-07T21:53:13.840Z,1541627593.840 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.841Z,1541627593.841 [NavChartDb](INFO): Join timeout helper Thread ID is 976 2018-11-07T21:53:13.847Z,1541627593.847 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:13.847Z,1541627593.847 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.859Z,1541627593.859 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2018-11-07T21:53:13.859Z,1541627593.859 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.859Z,1541627593.859 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 977 2018-11-07T21:53:13.963Z,1541627593.963 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:13.963Z,1541627593.963 [WetLabsSeaOWL_UV_A](INFO): Powering down 2018-11-07T21:53:13.964Z,1541627593.964 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.986Z,1541627593.986 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2018-11-07T21:53:13.986Z,1541627593.986 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.987Z,1541627593.987 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:13.987Z,1541627593.987 [CTD_NeilBrown](INFO): Powering down 2018-11-07T21:53:13.988Z,1541627593.988 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.988Z,1541627593.988 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 978 2018-11-07T21:53:13.989Z,1541627593.989 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-11-07T21:53:13.989Z,1541627593.989 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:13.989Z,1541627593.989 [Radio_Surface](INFO): Join timeout helper Thread ID is 979 2018-11-07T21:53:14.299Z,1541627594.299 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:14.299Z,1541627594.299 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.308Z,1541627594.308 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-11-07T21:53:14.308Z,1541627594.308 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.308Z,1541627594.308 [logger](INFO): Join timeout helper Thread ID is 980 2018-11-07T21:53:14.327Z,1541627594.327 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:14.327Z,1541627594.327 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.347Z,1541627594.347 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-11-07T21:53:14.348Z,1541627594.348 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.348Z,1541627594.348 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-11-07T21:53:14.348Z,1541627594.348 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.348Z,1541627594.348 [controlThread](INFO): Join timeout helper Thread ID is 981 2018-11-07T21:53:14.447Z,1541627594.447 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-07T21:53:14.447Z,1541627594.447 [controlThread](DEBUG): Uninitializing ControlThread 2018-11-07T21:53:14.448Z,1541627594.448 [AHRS_M2](INFO): Powering down 2018-11-07T21:53:14.449Z,1541627594.449 [NAL9602](INFO): Powering down 2018-11-07T21:53:14.450Z,1541627594.450 [RDI_Pathfinder](INFO): Powering down 2018-11-07T21:53:14.451Z,1541627594.451 [RDI_PathfinderUp](INFO): Powering down 2018-11-07T21:53:14.452Z,1541627594.452 [Aanderaa_O2](INFO): Powering down 2018-11-07T21:53:14.453Z,1541627594.453 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-07T21:53:14.454Z,1541627594.454 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2018-11-07T21:53:14.454Z,1541627594.454 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-11-07T21:53:14.455Z,1541627594.455 [MissionManager](INFO): Uninitializing Mission Default 2018-11-07T21:53:14.455Z,1541627594.455 [Default] Stopped 2018-11-07T21:53:14.455Z,1541627594.455 [Default](DEBUG): Aggregate::uninitialize Default 2018-11-07T21:53:14.455Z,1541627594.455 [Default:B.GoToSurface] Stopped 2018-11-07T21:53:14.455Z,1541627594.455 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-11-07T21:53:14.455Z,1541627594.455 [Default:CheckIn] Stopped 2018-11-07T21:53:14.455Z,1541627594.455 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-07T21:53:14.455Z,1541627594.455 [Default:CheckIn:C.Wait] Stopped 2018-11-07T21:53:14.455Z,1541627594.455 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-07T21:53:14.458Z,1541627594.458 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-11-07T21:53:14.459Z,1541627594.459 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-11-07T21:53:14.459Z,1541627594.459 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-11-07T21:53:14.459Z,1541627594.459 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-11-07T21:53:14.460Z,1541627594.460 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-07T21:53:14.460Z,1541627594.460 [BuoyancyServo](INFO): Powering down 2018-11-07T21:53:14.475Z,1541627594.475 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-07T21:53:14.475Z,1541627594.475 [ElevatorServo](INFO): Powering down 2018-11-07T21:53:14.476Z,1541627594.476 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-07T21:53:14.476Z,1541627594.476 [MassServo](INFO): Powering down 2018-11-07T21:53:14.477Z,1541627594.477 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-07T21:53:14.477Z,1541627594.477 [RudderServo](INFO): Powering down 2018-11-07T21:53:14.478Z,1541627594.478 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-07T21:53:14.478Z,1541627594.478 [ThrusterServo](INFO): Powering down 2018-11-07T21:53:14.479Z,1541627594.479 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-11-07T21:53:14.479Z,1541627594.479 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-11-07T21:53:14.479Z,1541627594.479 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-11-07T21:53:14.480Z,1541627594.480 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.582Z,1541627594.582 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.627Z,1541627594.627 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.629Z,1541627594.629 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.652Z,1541627594.652 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-07T21:53:14.709Z,1541627594.709 [logger ThreadHandler](INFO): Thread cancelled.