2018-11-07T22:27:32.383Z,1541629652.383 [Supervisor](DEBUG): Initializing supervisor.
2018-11-07T22:27:32.386Z,1541629652.386 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-11-07T22:27:32.387Z,1541629652.387 [SyncHandler](INFO): Protected caller Thread ID is 915
2018-11-07T22:27:32.387Z,1541629652.387 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-11-07T22:27:32.388Z,1541629652.388 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-11-07T22:27:32.389Z,1541629652.389 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 916
2018-11-07T22:27:32.392Z,1541629652.392 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-11-07T22:27:32.404Z,1541629652.404 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-11-07T22:27:32.405Z,1541629652.405 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-11-07T22:27:32.405Z,1541629652.405 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 917
2018-11-07T22:27:32.406Z,1541629652.406 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-11-07T22:27:32.407Z,1541629652.407 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-11-07T22:27:32.407Z,1541629652.407 [logger ThreadHandler](INFO): Protected caller Thread ID is 918
2018-11-07T22:27:32.409Z,1541629652.409 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-11-07T22:27:32.409Z,1541629652.409 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-11-07T22:27:32.411Z,1541629652.411 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-11-07T22:27:32.736Z,1541629652.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-11-07T22:27:32.737Z,1541629652.737 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-11-07T22:27:33.197Z,1541629653.197 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-11-07T22:27:33.197Z,1541629653.197 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-11-07T22:27:33.545Z,1541629653.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-11-07T22:27:33.546Z,1541629653.546 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-11-07T22:27:33.744Z,1541629653.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-11-07T22:27:33.744Z,1541629653.744 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-11-07T22:27:34.203Z,1541629654.203 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-11-07T22:27:34.203Z,1541629654.203 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-11-07T22:27:34.691Z,1541629654.691 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-11-07T22:27:34.691Z,1541629654.691 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-11-07T22:27:34.796Z,1541629654.796 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-11-07T22:27:34.797Z,1541629654.797 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-11-07T22:27:35.003Z,1541629655.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-11-07T22:27:35.004Z,1541629655.004 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-11-07T22:27:35.149Z,1541629655.149 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-11-07T22:27:35.149Z,1541629655.149 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-11-07T22:27:35.231Z,1541629655.231 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-11-07T22:27:35.493Z,1541629655.493 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-11-07T22:27:35.493Z,1541629655.493 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-11-07T22:27:35.595Z,1541629655.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-11-07T22:27:35.596Z,1541629655.596 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-11-07T22:27:35.693Z,1541629655.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-11-07T22:27:35.693Z,1541629655.693 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-11-07T22:27:35.844Z,1541629655.844 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-11-07T22:27:35.844Z,1541629655.844 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-11-07T22:27:36.164Z,1541629656.164 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-11-07T22:27:36.166Z,1541629656.166 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-11-07T22:27:36.167Z,1541629656.167 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-11-07T22:27:36.300Z,1541629656.300 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-11-07T22:27:36.536Z,1541629656.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-11-07T22:27:36.536Z,1541629656.536 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-11-07T22:27:36.832Z,1541629656.832 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-11-07T22:27:36.967Z,1541629656.967 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-11-07T22:27:37.111Z,1541629657.111 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-11-07T22:27:37.375Z,1541629657.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-11-07T22:27:37.460Z,1541629657.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-11-07T22:27:37.559Z,1541629657.559 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-11-07T22:27:37.653Z,1541629657.653 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-11-07T22:27:37.736Z,1541629657.736 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-11-07T22:27:37.846Z,1541629657.846 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-11-07T22:27:37.847Z,1541629657.847 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-11-07T22:27:37.848Z,1541629657.848 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-11-07T22:27:37.986Z,1541629657.986 [SBIT](DEBUG): Construct Startup Built In Test.
2018-11-07T22:27:38.017Z,1541629658.017 [SBIT] Loaded
2018-11-07T22:27:38.018Z,1541629658.018 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-11-07T22:27:38.018Z,1541629658.018 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-11-07T22:27:38.046Z,1541629658.046 [IBIT] Loaded
2018-11-07T22:27:38.047Z,1541629658.047 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-11-07T22:27:38.050Z,1541629658.050 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-11-07T22:27:38.208Z,1541629658.208 [CBIT] Loaded
2018-11-07T22:27:38.208Z,1541629658.208 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-11-07T22:27:38.209Z,1541629658.209 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-11-07T22:27:38.209Z,1541629658.209 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-11-07T22:27:38.329Z,1541629658.329 [BuoyancyServo] Loaded
2018-11-07T22:27:38.330Z,1541629658.330 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-11-07T22:27:38.345Z,1541629658.345 [ElevatorServo] Loaded
2018-11-07T22:27:38.345Z,1541629658.345 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-11-07T22:27:38.360Z,1541629658.360 [MassServo] Loaded
2018-11-07T22:27:38.360Z,1541629658.360 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-11-07T22:27:38.375Z,1541629658.375 [RudderServo] Loaded
2018-11-07T22:27:38.376Z,1541629658.376 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-11-07T22:27:38.391Z,1541629658.391 [ThrusterServo] Loaded
2018-11-07T22:27:38.391Z,1541629658.391 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-11-07T22:27:38.391Z,1541629658.391 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-11-07T22:27:38.392Z,1541629658.392 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-11-07T22:27:38.493Z,1541629658.493 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-11-07T22:27:38.493Z,1541629658.493 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-11-07T22:27:38.549Z,1541629658.549 [DeadReckonUsingSpeedCalculator] Loaded
2018-11-07T22:27:38.549Z,1541629658.549 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-11-07T22:27:38.566Z,1541629658.566 [NavChart] Loaded
2018-11-07T22:27:38.566Z,1541629658.566 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-11-07T22:27:38.570Z,1541629658.570 [UniversalFixResidualReporter] Loaded
2018-11-07T22:27:38.570Z,1541629658.570 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-11-07T22:27:38.571Z,1541629658.571 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-11-07T22:27:38.571Z,1541629658.571 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-11-07T22:27:38.585Z,1541629658.585 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-11-07T22:27:38.585Z,1541629658.585 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-11-07T22:27:38.844Z,1541629658.844 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-11-07T22:27:38.845Z,1541629658.845 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-11-07T22:27:39.158Z,1541629659.158 [AHRS_M2] Loaded
2018-11-07T22:27:39.159Z,1541629659.159 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-11-07T22:27:39.229Z,1541629659.229 [DataOverHttps] Loaded
2018-11-07T22:27:39.230Z,1541629659.230 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-11-07T22:27:39.243Z,1541629659.243 [Depth_Keller] Loaded
2018-11-07T22:27:39.243Z,1541629659.243 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-11-07T22:27:39.248Z,1541629659.248 [DropWeight] Loaded
2018-11-07T22:27:39.248Z,1541629659.248 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-11-07T22:27:39.342Z,1541629659.342 [NAL9602] Loaded
2018-11-07T22:27:39.342Z,1541629659.342 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-11-07T22:27:39.347Z,1541629659.347 [Onboard] Loaded
2018-11-07T22:27:39.348Z,1541629659.348 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-11-07T22:27:39.355Z,1541629659.355 [Radio_Surface] Loaded
2018-11-07T22:27:39.355Z,1541629659.355 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-11-07T22:27:39.356Z,1541629659.356 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408364E0
2018-11-07T22:27:39.357Z,1541629659.357 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 998
2018-11-07T22:27:39.385Z,1541629659.385 [RDI_Pathfinder] Loaded
2018-11-07T22:27:39.386Z,1541629659.386 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-11-07T22:27:39.408Z,1541629659.408 [RDI_PathfinderUp] Loaded
2018-11-07T22:27:39.408Z,1541629659.408 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2018-11-07T22:27:39.415Z,1541629659.415 [SCPI] Loaded
2018-11-07T22:27:39.415Z,1541629659.415 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-11-07T22:27:41.239Z,1541629661.239 [BPC1] Loaded
2018-11-07T22:27:41.239Z,1541629661.239 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-11-07T22:27:41.239Z,1541629661.239 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-11-07T22:27:41.240Z,1541629661.240 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-11-07T22:27:41.312Z,1541629661.312 [VerticalControl](DEBUG): Construct VerticalControl.
2018-11-07T22:27:41.402Z,1541629661.402 [VerticalControl] Loaded
2018-11-07T22:27:41.402Z,1541629661.402 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-11-07T22:27:41.403Z,1541629661.403 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-11-07T22:27:41.462Z,1541629661.462 [HorizontalControl] Loaded
2018-11-07T22:27:41.462Z,1541629661.462 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-11-07T22:27:41.463Z,1541629661.463 [SpeedControl](DEBUG): Construct SpeedControl.
2018-11-07T22:27:41.465Z,1541629661.465 [SpeedControl] Loaded
2018-11-07T22:27:41.465Z,1541629661.465 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-11-07T22:27:41.466Z,1541629661.466 [LoopControl](DEBUG): Construct LoopControl.
2018-11-07T22:27:41.467Z,1541629661.467 [LoopControl] Loaded
2018-11-07T22:27:41.467Z,1541629661.467 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-11-07T22:27:41.468Z,1541629661.468 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-11-07T22:27:41.468Z,1541629661.468 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-11-07T22:27:41.621Z,1541629661.621 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-11-07T22:27:41.621Z,1541629661.621 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-11-07T22:27:41.963Z,1541629661.963 [Aanderaa_O2] Loaded
2018-11-07T22:27:41.963Z,1541629661.963 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-11-07T22:27:42.119Z,1541629662.119 [CTD_NeilBrown] Loaded
2018-11-07T22:27:42.119Z,1541629662.119 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-11-07T22:27:42.121Z,1541629662.121 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409364E0
2018-11-07T22:27:42.121Z,1541629662.121 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 999
2018-11-07T22:27:42.167Z,1541629662.167 [WetLabsSeaOWL_UV_A] Loaded
2018-11-07T22:27:42.167Z,1541629662.167 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-11-07T22:27:42.168Z,1541629662.168 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409664E0
2018-11-07T22:27:42.169Z,1541629662.169 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1000
2018-11-07T22:27:42.169Z,1541629662.169 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-11-07T22:27:42.170Z,1541629662.170 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-11-07T22:27:42.236Z,1541629662.236 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-11-07T22:27:42.237Z,1541629662.237 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-11-07T22:27:42.280Z,1541629662.280 [DepthRateCalculator] Loaded
2018-11-07T22:27:42.280Z,1541629662.280 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-11-07T22:27:42.286Z,1541629662.286 [PitchRateCalculator] Loaded
2018-11-07T22:27:42.286Z,1541629662.286 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-11-07T22:27:42.298Z,1541629662.298 [SpeedCalculator] Loaded
2018-11-07T22:27:42.299Z,1541629662.299 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-11-07T22:27:42.320Z,1541629662.320 [TempGradientCalculator] Loaded
2018-11-07T22:27:42.321Z,1541629662.321 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-11-07T22:27:42.326Z,1541629662.326 [YawRateCalculator] Loaded
2018-11-07T22:27:42.327Z,1541629662.327 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-11-07T22:27:42.357Z,1541629662.357 [ElevatorOffsetCalculator] Loaded
2018-11-07T22:27:42.357Z,1541629662.357 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-11-07T22:27:42.358Z,1541629662.358 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-11-07T22:27:42.358Z,1541629662.358 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-11-07T22:27:42.384Z,1541629662.384 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-11-07T22:27:42.388Z,1541629662.388 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-11-07T22:27:42.389Z,1541629662.389 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-11-07T22:27:42.395Z,1541629662.395 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-11-07T22:27:42.396Z,1541629662.396 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2018-11-07T22:27:42.397Z,1541629662.397 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1001
2018-11-07T22:27:42.401Z,1541629662.401 [Supervisor](INFO): Main Thread ID is 795
2018-11-07T22:27:42.401Z,1541629662.401 [Supervisor](DEBUG): Running supervisor.
2018-11-07T22:27:42.402Z,1541629662.402 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1002
2018-11-07T22:27:42.405Z,1541629662.405 [controlThread ThreadHandler](INFO): Handler Thread ID is 1003
2018-11-07T22:27:42.405Z,1541629662.405 [controlThread](DEBUG): Initializing ControlThread
2018-11-07T22:27:42.406Z,1541629662.406 [SBIT](INFO): Initialize SBIT Component.
2018-11-07T22:27:42.406Z,1541629662.406 [SBIT](IMPORTANT): git: 2018-10-09-36-g6180f29
2018-11-07T22:27:42.407Z,1541629662.407 [SBIT](INFO): git hash: 6180f296723eb7a23c89bee0a0e9d0952585955a
2018-11-07T22:27:42.407Z,1541629662.407 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-11-07T22:27:42.407Z,1541629662.407 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-11-07T22:27:42.408Z,1541629662.408 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2018-11-07T22:27:42.409Z,1541629662.409 [IBIT](INFO): Initialize IBIT Component.
2018-11-07T22:27:42.410Z,1541629662.410 [CBIT](DEBUG): Initialize CBIT Component.
2018-11-07T22:27:42.410Z,1541629662.410 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-11-07T22:27:42.411Z,1541629662.411 [logger ThreadHandler](INFO): Handler Thread ID is 1004
2018-11-07T22:27:42.439Z,1541629662.439 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1005
2018-11-07T22:27:42.444Z,1541629662.444 [Radio_Surface](INFO): Powering up
2018-11-07T22:27:42.463Z,1541629662.463 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1006
2018-11-07T22:27:42.464Z,1541629662.464 [CTD_NeilBrown](INFO): Powering down
2018-11-07T22:27:42.491Z,1541629662.491 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1007
2018-11-07T22:27:42.491Z,1541629662.491 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-11-07T22:27:42.519Z,1541629662.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:27:42.520Z,1541629662.520 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:27:42.521Z,1541629662.521 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:27:42.521Z,1541629662.521 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:27:42.522Z,1541629662.522 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:27:42.522Z,1541629662.522 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:27:42.522Z,1541629662.522 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-11-07T22:27:42.523Z,1541629662.523 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-11-07T22:27:42.529Z,1541629662.529 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-11-07T22:27:42.531Z,1541629662.531 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-11-07T22:27:42.532Z,1541629662.532 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-11-07T22:27:42.533Z,1541629662.533 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-11-07T22:27:42.533Z,1541629662.533 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-11-07T22:27:42.534Z,1541629662.534 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-11-07T22:27:42.535Z,1541629662.535 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1008
2018-11-07T22:27:42.538Z,1541629662.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-11-07T22:27:42.538Z,1541629662.538 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-11-07T22:27:42.539Z,1541629662.539 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-11-07T22:27:42.539Z,1541629662.539 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-11-07T22:27:42.539Z,1541629662.539 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-11-07T22:27:42.539Z,1541629662.539 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-11-07T22:27:42.539Z,1541629662.539 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-11-07T22:27:42.540Z,1541629662.540 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-11-07T22:27:42.540Z,1541629662.540 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-11-07T22:27:42.540Z,1541629662.540 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-11-07T22:27:42.540Z,1541629662.540 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-11-07T22:27:42.540Z,1541629662.540 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-11-07T22:27:42.541Z,1541629662.541 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-11-07T22:27:42.541Z,1541629662.541 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-11-07T22:27:42.541Z,1541629662.541 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-11-07T22:27:42.541Z,1541629662.541 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-11-07T22:27:42.558Z,1541629662.558 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-11-07T22:27:42.559Z,1541629662.559 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-11-07T22:27:42.559Z,1541629662.559 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-11-07T22:27:42.560Z,1541629662.560 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-11-07T22:27:42.561Z,1541629662.561 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-11-07T22:27:42.596Z,1541629662.596 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-11-07T22:27:42.636Z,1541629662.636 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2018-11-07T22:27:42.637Z,1541629662.637 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-11-07T22:27:42.712Z,1541629662.712 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-11-07T22:27:42.713Z,1541629662.713 [Default:A.Wait](DEBUG): Construct Wait.
2018-11-07T22:27:42.715Z,1541629662.715 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-11-07T22:27:42.734Z,1541629662.734 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-11-07T22:27:42.753Z,1541629662.753 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-11-07T22:27:42.786Z,1541629662.786 [Default:E.Execute](DEBUG): Construct Execute.
2018-11-07T22:27:42.790Z,1541629662.790 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2018-11-07T22:27:42.803Z,1541629662.803 [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-07T22:27:42.831Z,1541629662.831 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:27:42.931Z,1541629662.931 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-11-07T22:27:42.963Z,1541629662.963 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-11-07T22:27:43.161Z,1541629663.161 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-11-07T22:27:43.367Z,1541629663.367 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-11-07T22:27:43.375Z,1541629663.375 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-11-07T22:27:43.389Z,1541629663.389 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-11-07T22:27:43.395Z,1541629663.395 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-11-07T22:27:43.401Z,1541629663.401 [MassServo](DEBUG): Initializing EZServoServo.
2018-11-07T22:27:43.407Z,1541629663.407 [MassServo](DEBUG): Initializing MassServo.
2018-11-07T22:27:43.420Z,1541629663.420 [RudderServo](DEBUG): Initializing EZServoServo.
2018-11-07T22:27:43.427Z,1541629663.427 [RudderServo](DEBUG): Initializing RudderServo.
2018-11-07T22:27:43.440Z,1541629663.440 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-11-07T22:27:43.447Z,1541629663.447 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-11-07T22:27:43.605Z,1541629663.605 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-11-07T22:27:43.605Z,1541629663.605 [DropWeight] Hardware Fault, FailCount= 1
2018-11-07T22:27:43.605Z,1541629663.605 [DropWeight](ERROR): Hardware Fault
2018-11-07T22:27:43.710Z,1541629663.710 [RDI_PathfinderUp](INFO): Powering down
2018-11-07T22:27:43.771Z,1541629663.771 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-11-07T22:27:43.807Z,1541629663.807 [CommandLine](FAULT): Scheduling is paused
2018-11-07T22:27:43.807Z,1541629663.807 [CBIT](INFO): Critical error at 20181107T222743
2018-11-07T22:27:43.808Z,1541629663.808 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-11-07T22:27:43.810Z,1541629663.810 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-11-07T22:27:43.810Z,1541629663.810 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-11-07T22:27:44.380Z,1541629664.380 [CBIT](INFO): Critical error at 20181107T222743
2018-11-07T22:27:46.314Z,1541629666.314 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:46.730Z,1541629666.730 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:47.190Z,1541629667.190 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:47.870Z,1541629667.870 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:48.490Z,1541629668.490 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:49.170Z,1541629669.170 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:49.622Z,1541629669.622 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:50.050Z,1541629670.050 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:50.478Z,1541629670.478 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:50.914Z,1541629670.914 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:51.334Z,1541629671.334 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:51.762Z,1541629671.762 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:52.270Z,1541629672.270 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:52.678Z,1541629672.678 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:52.735Z,1541629672.735 [CBIT](CRITICAL): Environmental Failure. Press:14.766271 PSI. Humidity:39%. Temp:25 C. ABORTING MISSION
2018-11-07T22:27:53.070Z,1541629673.070 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:27:53.070Z,1541629673.070 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:27:53.071Z,1541629673.071 [AHRS_M2] Communications Fault, FailCount= 1
2018-11-07T22:27:53.071Z,1541629673.071 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:27:53.122Z,1541629673.122 [CBIT](INFO): Critical error at 20181107T222752
2018-11-07T22:27:53.132Z,1541629673.132 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:27:53.163Z,1541629673.163 [AHRS_M2](INFO): Powering down
2018-11-07T22:27:53.313Z,1541629673.313 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:27:53.313Z,1541629673.313 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-11-07T22:27:53.313Z,1541629673.313 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:27:53.370Z,1541629673.370 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:27:53.690Z,1541629673.690 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:27:54.390Z,1541629674.390 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:27:54.391Z,1541629674.391 [Aanderaa_O2] No Fault, FailCount= 1
2018-11-07T22:27:56.807Z,1541629676.807 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:27:56.807Z,1541629676.807 [AHRS_M2] No Fault, FailCount= 1
2018-11-07T22:27:57.147Z,1541629677.147 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:28:00.670Z,1541629680.670 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:01.086Z,1541629681.086 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:01.482Z,1541629681.482 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:01.898Z,1541629681.898 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:02.326Z,1541629682.326 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:02.742Z,1541629682.742 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:03.142Z,1541629683.142 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:03.527Z,1541629683.527 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:03.926Z,1541629683.926 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:04.350Z,1541629684.350 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:04.754Z,1541629684.754 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:04.777Z,1541629684.777 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:28:04.777Z,1541629684.777 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-11-07T22:28:04.777Z,1541629684.777 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:28:04.802Z,1541629684.802 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:28:05.130Z,1541629685.130 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:05.278Z,1541629685.278 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:28:05.658Z,1541629685.658 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:05.680Z,1541629685.680 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:28:05.680Z,1541629685.680 [RDI_Pathfinder] Communications Fault, FailCount= 1
2018-11-07T22:28:05.680Z,1541629685.680 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:28:05.726Z,1541629685.726 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:28:06.066Z,1541629686.066 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:06.158Z,1541629686.158 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:28:06.180Z,1541629686.180 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:28:06.181Z,1541629686.181 [Aanderaa_O2] No Fault, FailCount= 2
2018-11-07T22:28:06.526Z,1541629686.526 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:06.954Z,1541629686.954 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:07.030Z,1541629687.030 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:28:07.030Z,1541629687.030 [RDI_Pathfinder] No Fault, FailCount= 1
2018-11-07T22:28:07.371Z,1541629687.371 [CommandLine](IMPORTANT): got command failComponent
2018-11-07T22:28:07.371Z,1541629687.371 [CommandLine](IMPORTANT): Failed components:
2018-11-07T22:28:07.371Z,1541629687.371 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-11-07T22:28:07.376Z,1541629687.376 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:07.376Z,1541629687.376 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:28:07.376Z,1541629687.376 [AHRS_M2] Communications Fault, FailCount= 2
2018-11-07T22:28:07.376Z,1541629687.376 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:28:07.457Z,1541629687.457 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:28:07.476Z,1541629687.476 [AHRS_M2](INFO): Powering down
2018-11-07T22:28:09.484Z,1541629689.484 [NAL9602](INFO): Powering up NAL9602
2018-11-07T22:28:11.144Z,1541629691.144 [SBIT](IMPORTANT): Beginning Startup BIT
2018-11-07T22:28:11.147Z,1541629691.147 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:28:11.148Z,1541629691.148 [AHRS_M2] No Fault, FailCount= 2
2018-11-07T22:28:11.148Z,1541629691.148 [CBIT](IMPORTANT): Beginning ground fault scan
2018-11-07T22:28:11.478Z,1541629691.478 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:28:15.090Z,1541629695.090 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:15.747Z,1541629695.747 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:16.222Z,1541629696.222 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:16.245Z,1541629696.245 [CommandLine](IMPORTANT): got command failComponent
2018-11-07T22:28:16.245Z,1541629696.245 [CommandLine](IMPORTANT): Failed components:
2018-11-07T22:28:16.245Z,1541629696.245 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-11-07T22:28:16.659Z,1541629696.659 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:28:16.659Z,1541629696.659 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-11-07T22:28:16.659Z,1541629696.659 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:28:16.731Z,1541629696.731 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:28:16.731Z,1541629696.731 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-11-07T22:28:17.066Z,1541629697.066 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:28:17.222Z,1541629697.222 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:28:20.612Z,1541629700.612 [NAL9602](INFO): NAL9602 initialized
2018-11-07T22:28:21.928Z,1541629701.928 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008803
CHAN A1 (24V): 0.003475
CHAN A2 (12V): -0.006900
CHAN A3 (5V): -0.001821
CHAN B0 (3.3V): 0.000266
CHAN B1 (3.15aV): -0.000076
CHAN B2 (3.15bV): 0.000108
CHAN B3 (GND): 0.002287
OPEN: 0.005032
Full Scale Calc: 4.765 mA, -1.589 mA
2018-11-07T22:28:22.267Z,1541629702.267 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:28:26.770Z,1541629706.770 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:28:26.770Z,1541629706.770 [AHRS_M2] Data Fault, FailCount= 3
2018-11-07T22:28:26.770Z,1541629706.770 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:28:26.952Z,1541629706.952 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:28:27.159Z,1541629707.159 [AHRS_M2](INFO): Powering down
2018-11-07T22:28:29.598Z,1541629709.598 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:28:29.598Z,1541629709.598 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-11-07T22:28:29.598Z,1541629709.598 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:28:29.720Z,1541629709.720 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:28:30.062Z,1541629710.062 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:28:30.891Z,1541629710.891 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:28:30.892Z,1541629710.892 [AHRS_M2] No Fault, FailCount= 3
2018-11-07T22:28:30.892Z,1541629710.892 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:28:30.892Z,1541629710.892 [RDI_Pathfinder] No Fault, FailCount= 2
2018-11-07T22:28:31.159Z,1541629711.159 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:28:34.682Z,1541629714.682 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:35.123Z,1541629715.123 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:35.570Z,1541629715.570 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:36.018Z,1541629716.018 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:36.446Z,1541629716.446 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:36.894Z,1541629716.894 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:37.362Z,1541629717.362 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:37.806Z,1541629717.806 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:38.262Z,1541629718.262 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:38.698Z,1541629718.698 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:39.132Z,1541629719.132 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:39.551Z,1541629719.551 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:40.034Z,1541629720.034 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:40.498Z,1541629720.498 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:40.934Z,1541629720.934 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:41.390Z,1541629721.390 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:41.390Z,1541629721.390 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:28:41.390Z,1541629721.390 [AHRS_M2] Communications Fault, FailCount= 4
2018-11-07T22:28:41.391Z,1541629721.391 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:28:41.492Z,1541629721.492 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:28:41.499Z,1541629721.499 [AHRS_M2](INFO): Powering down
2018-11-07T22:28:45.167Z,1541629725.167 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:28:45.167Z,1541629725.167 [AHRS_M2] No Fault, FailCount= 4
2018-11-07T22:28:45.502Z,1541629725.502 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:28:49.026Z,1541629729.026 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:49.431Z,1541629729.431 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:49.838Z,1541629729.838 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:50.274Z,1541629730.274 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:50.714Z,1541629730.714 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:51.154Z,1541629731.154 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:51.590Z,1541629731.590 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:28:52.158Z,1541629732.158 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:28:53.828Z,1541629733.828 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:28:53.828Z,1541629733.828 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-11-07T22:28:53.828Z,1541629733.828 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:28:53.939Z,1541629733.939 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:28:53.940Z,1541629733.940 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:28:54.303Z,1541629734.303 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:28:54.441Z,1541629734.441 [CBIT](INFO): Critical error at 20181107T222853
2018-11-07T22:29:01.802Z,1541629741.802 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:29:01.802Z,1541629741.802 [AHRS_M2] Data Fault, FailCount= 5
2018-11-07T22:29:01.802Z,1541629741.802 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:29:01.890Z,1541629741.890 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:29:01.890Z,1541629741.890 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-11-07T22:29:02.191Z,1541629742.191 [AHRS_M2](INFO): Powering down
2018-11-07T22:29:02.300Z,1541629742.300 [CBIT](INFO): Critical error at 20181107T222901
2018-11-07T22:29:04.663Z,1541629744.663 [SBIT](IMPORTANT): SBIT PASSED
2018-11-07T22:29:04.756Z,1541629744.756 [CommandLine](IMPORTANT): got command configSet list
2018-11-07T22:29:04.756Z,1541629744.756 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-11-07T22:29:04.756Z,1541629744.756 [CommandLine](IMPORTANT): No configSet variables persisted
2018-11-07T22:29:05.044Z,1541629745.044 [MissionManager](IMPORTANT): Started mission Startup
2018-11-07T22:29:05.045Z,1541629745.045 [Startup] Running Loop=1
2018-11-07T22:29:05.045Z,1541629745.045 [Startup](DEBUG): Aggregate::initialize Startup
2018-11-07T22:29:05.045Z,1541629745.045 [Startup:A.GoToSurface] Running Loop=1
2018-11-07T22:29:05.045Z,1541629745.045 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-11-07T22:29:05.046Z,1541629745.046 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-11-07T22:29:05.046Z,1541629745.046 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-11-07T22:29:05.046Z,1541629745.046 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-11-07T22:29:05.047Z,1541629745.047 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-11-07T22:29:05.047Z,1541629745.047 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-11-07T22:29:05.053Z,1541629745.053 [Startup:StartupSatComms] Running Loop=1
2018-11-07T22:29:05.053Z,1541629745.053 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-11-07T22:29:05.053Z,1541629745.053 [Startup:StartupSatComms:A] Running Loop=1
2018-11-07T22:29:05.445Z,1541629745.445 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-11-07T22:29:42.638Z,1541629782.638 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:29:42.638Z,1541629782.638 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-11-07T22:29:42.638Z,1541629782.638 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:29:42.640Z,1541629782.640 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:29:42.640Z,1541629782.640 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-11-07T22:29:42.640Z,1541629782.640 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:29:42.687Z,1541629782.687 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:29:42.688Z,1541629782.688 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:29:43.074Z,1541629783.074 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:29:43.074Z,1541629783.074 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-11-07T22:29:43.075Z,1541629783.075 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:29:43.075Z,1541629783.075 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-11-07T22:29:43.431Z,1541629783.431 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:29:43.431Z,1541629783.431 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:29:43.431Z,1541629783.431 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:29:43.432Z,1541629783.432 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:29:43.432Z,1541629783.432 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:29:43.432Z,1541629783.432 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:30:05.426Z,1541629805.426 [Startup:StartupSatComms:A](INFO): Timed out from 2018-11-07T22:29:05.1Z
2018-11-07T22:30:05.426Z,1541629805.426 [Startup:StartupSatComms:A] Stopped
2018-11-07T22:30:05.427Z,1541629805.427 [Startup:StartupSatComms:B] Running Loop=1
2018-11-07T22:30:05.833Z,1541629805.833 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-11-07T22:30:25.948Z,1541629825.948 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004319
2018-11-07T22:30:29.916Z,1541629829.916 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20181107T215339/Courier0013.lzma
2018-11-07T22:30:30.708Z,1541629830.708 [DataOverHttps](INFO): Moved sent file to Logs/20181107T215339/Courier0013.lzma.bak
2018-11-07T22:30:30.708Z,1541629830.708 [DataOverHttps](INFO): SBD MOMSN=8808796
2018-11-07T22:30:39.668Z,1541629839.668 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20181107T222347/Courier0000.lzma
2018-11-07T22:30:40.468Z,1541629840.468 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222347/Courier0000.lzma.bak
2018-11-07T22:30:40.468Z,1541629840.468 [DataOverHttps](INFO): SBD MOMSN=8808799
2018-11-07T22:30:49.570Z,1541629849.570 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:30:49.570Z,1541629849.570 [Aanderaa_O2] No Fault, FailCount= 3
2018-11-07T22:30:49.607Z,1541629849.607 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20181107T222418/Courier0000.lzma
2018-11-07T22:30:50.380Z,1541629850.380 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222418/Courier0000.lzma.bak
2018-11-07T22:30:50.380Z,1541629850.380 [DataOverHttps](INFO): SBD MOMSN=8808805
2018-11-07T22:30:59.224Z,1541629859.224 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20181107T222449/Courier0000.lzma
2018-11-07T22:31:00.016Z,1541629860.016 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222449/Courier0000.lzma.bak
2018-11-07T22:31:00.016Z,1541629860.016 [DataOverHttps](INFO): SBD MOMSN=8808811
2018-11-07T22:31:00.058Z,1541629860.058 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:31:00.058Z,1541629860.058 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-11-07T22:31:00.058Z,1541629860.058 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:31:00.075Z,1541629860.075 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:31:00.731Z,1541629860.731 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:31:05.851Z,1541629865.851 [Startup:StartupSatComms:B](INFO): Timed out from 2018-11-07T22:30:05.4Z
2018-11-07T22:31:05.851Z,1541629865.851 [Startup:StartupSatComms:B] Stopped
2018-11-07T22:31:05.852Z,1541629865.852 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-11-07T22:31:05.852Z,1541629865.852 [Startup:StartupSatComms] Stopped
2018-11-07T22:31:05.852Z,1541629865.852 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-11-07T22:31:05.853Z,1541629865.853 [Startup](INFO): Completed Startup
2018-11-07T22:31:05.853Z,1541629865.853 [MissionManager](INFO): Startup is completed.
2018-11-07T22:31:05.853Z,1541629865.853 [MissionManager](INFO): Uninitializing Mission Startup
2018-11-07T22:31:05.853Z,1541629865.853 [Startup] Stopped
2018-11-07T22:31:05.853Z,1541629865.853 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-11-07T22:31:05.853Z,1541629865.853 [Startup:A.GoToSurface] Stopped
2018-11-07T22:31:05.853Z,1541629865.853 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-11-07T22:31:05.877Z,1541629865.877 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:31:05.877Z,1541629865.877 [Aanderaa_O2] No Fault, FailCount= 1
2018-11-07T22:31:05.988Z,1541629865.988 [MissionManager](IMPORTANT): Started mission Default
2018-11-07T22:31:05.989Z,1541629865.989 [Default] Running Loop=1
2018-11-07T22:31:05.989Z,1541629865.989 [Default](DEBUG): Aggregate::initialize Default
2018-11-07T22:31:05.989Z,1541629865.989 [Default:B.GoToSurface] Running Loop=1
2018-11-07T22:31:05.989Z,1541629865.989 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-11-07T22:31:05.989Z,1541629865.989 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-11-07T22:31:05.990Z,1541629865.990 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-11-07T22:31:05.990Z,1541629865.990 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-11-07T22:31:05.996Z,1541629865.996 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-11-07T22:31:05.998Z,1541629865.998 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-11-07T22:31:05.999Z,1541629865.999 [Default:A.Wait] Running Loop=1
2018-11-07T22:31:05.999Z,1541629865.999 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-11-07T22:31:14.289Z,1541629874.289 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181107T222520/Courier0000.lzma
2018-11-07T22:31:15.069Z,1541629875.069 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222520/Courier0000.lzma.bak
2018-11-07T22:31:15.069Z,1541629875.069 [DataOverHttps](INFO): SBD MOMSN=8808817
2018-11-07T22:31:16.292Z,1541629876.292 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:31:16.292Z,1541629876.292 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-11-07T22:31:16.292Z,1541629876.292 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:31:16.381Z,1541629876.381 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:31:16.815Z,1541629876.815 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:31:17.556Z,1541629877.556 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:31:17.557Z,1541629877.557 [Aanderaa_O2] No Fault, FailCount= 2
2018-11-07T22:31:19.118Z,1541629879.118 [Default:A.Wait](INFO): Done Waiting.
2018-11-07T22:31:19.138Z,1541629879.138 [Default:A.Wait] Stopped
2018-11-07T22:31:19.138Z,1541629879.138 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-11-07T22:31:19.517Z,1541629879.517 [Default:CheckIn] Running Loop=1
2018-11-07T22:31:19.517Z,1541629879.517 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-11-07T22:31:19.518Z,1541629879.518 [Default:CheckIn:Read_GPS] Running Loop=1
2018-11-07T22:31:19.933Z,1541629879.933 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-11-07T22:31:28.289Z,1541629888.289 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:31:28.289Z,1541629888.289 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-11-07T22:31:28.290Z,1541629888.290 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:31:28.381Z,1541629888.381 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:31:28.381Z,1541629888.381 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-11-07T22:31:28.811Z,1541629888.811 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:31:45.846Z,1541629905.846 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:31:45.846Z,1541629905.846 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-11-07T22:31:45.847Z,1541629905.847 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:31:45.848Z,1541629905.848 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:31:45.848Z,1541629905.848 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-11-07T22:31:45.848Z,1541629905.848 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:31:45.862Z,1541629905.862 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:31:45.862Z,1541629905.862 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:31:45.991Z,1541629905.991 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:31:45.991Z,1541629905.991 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-11-07T22:31:45.991Z,1541629905.991 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:31:45.991Z,1541629905.991 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-11-07T22:31:46.347Z,1541629906.347 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:31:46.348Z,1541629906.348 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:31:46.348Z,1541629906.348 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:31:46.349Z,1541629906.349 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:31:46.349Z,1541629906.349 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:31:46.349Z,1541629906.349 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:31:53.923Z,1541629913.923 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:31:53.923Z,1541629913.923 [RDI_Pathfinder] No Fault, FailCount= 3
2018-11-07T22:32:06.702Z,1541629926.702 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-11-07T22:32:06.702Z,1541629926.702 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-11-07T22:32:06.702Z,1541629926.702 [RDI_Pathfinder](ERROR): Data Fault
2018-11-07T22:32:06.766Z,1541629926.766 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-11-07T22:32:07.179Z,1541629927.179 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:32:07.943Z,1541629927.943 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:32:07.943Z,1541629927.943 [RDI_Pathfinder] No Fault, FailCount= 1
2018-11-07T22:32:31.038Z,1541629951.038 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:32:31.039Z,1541629951.039 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-11-07T22:32:31.039Z,1541629951.039 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:32:31.060Z,1541629951.060 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:32:31.506Z,1541629951.506 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:32:32.267Z,1541629952.267 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:32:32.267Z,1541629952.267 [RDI_Pathfinder] No Fault, FailCount= 2
2018-11-07T22:32:56.123Z,1541629976.123 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:32:56.123Z,1541629976.123 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-11-07T22:32:56.123Z,1541629976.123 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:32:56.192Z,1541629976.192 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:32:56.192Z,1541629976.192 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:32:56.327Z,1541629976.327 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:32:56.349Z,1541629976.349 [CBIT](INFO): Critical error at 20181107T223256
2018-11-07T22:33:24.608Z,1541630004.608 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-11-07T22:33:46.613Z,1541630026.613 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:33:46.613Z,1541630026.613 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-11-07T22:33:46.613Z,1541630026.613 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:33:46.615Z,1541630026.615 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:33:46.615Z,1541630026.615 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-11-07T22:33:46.615Z,1541630026.615 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:33:46.628Z,1541630026.628 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:33:46.628Z,1541630026.628 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:33:47.019Z,1541630027.019 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:33:47.019Z,1541630027.019 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-11-07T22:33:47.019Z,1541630027.019 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:33:47.019Z,1541630027.019 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-11-07T22:33:47.410Z,1541630027.410 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:33:47.410Z,1541630027.410 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:33:47.411Z,1541630027.411 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:33:47.411Z,1541630027.411 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:33:47.412Z,1541630027.412 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:33:47.412Z,1541630027.412 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:33:50.610Z,1541630030.610 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5.
2018-11-07T22:33:58.640Z,1541630038.640 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:33:58.640Z,1541630038.640 [Aanderaa_O2] No Fault, FailCount= 3
2018-11-07T22:34:01.840Z,1541630041.840 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:34:01.841Z,1541630041.841 [AHRS_M2] No Fault, FailCount= 5
2018-11-07T22:34:02.167Z,1541630042.167 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:34:06.606Z,1541630046.606 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:06.998Z,1541630046.998 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:07.398Z,1541630047.398 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:07.798Z,1541630047.798 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:08.198Z,1541630048.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:08.598Z,1541630048.598 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:09.002Z,1541630049.002 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:09.044Z,1541630049.044 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:34:09.044Z,1541630049.044 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-11-07T22:34:09.044Z,1541630049.044 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:34:09.062Z,1541630049.062 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:34:09.398Z,1541630049.398 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:09.558Z,1541630049.558 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:34:09.798Z,1541630049.798 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:10.198Z,1541630050.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:10.259Z,1541630050.259 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:34:10.259Z,1541630050.259 [Aanderaa_O2] No Fault, FailCount= 1
2018-11-07T22:34:10.598Z,1541630050.598 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:10.998Z,1541630050.998 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:11.398Z,1541630051.398 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:11.798Z,1541630051.798 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:12.198Z,1541630052.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:12.198Z,1541630052.198 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:34:12.199Z,1541630052.199 [AHRS_M2] Communications Fault, FailCount= 1
2018-11-07T22:34:12.199Z,1541630052.199 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:34:12.283Z,1541630052.283 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:34:12.503Z,1541630052.503 [AHRS_M2](INFO): Powering down
2018-11-07T22:34:16.154Z,1541630056.154 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:34:16.155Z,1541630056.155 [AHRS_M2] No Fault, FailCount= 1
2018-11-07T22:34:16.503Z,1541630056.503 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:34:19.802Z,1541630059.802 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:20.198Z,1541630060.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:20.598Z,1541630060.598 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:20.645Z,1541630060.645 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:34:20.645Z,1541630060.645 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-11-07T22:34:20.645Z,1541630060.645 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:34:20.664Z,1541630060.664 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:34:21.002Z,1541630061.002 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:21.139Z,1541630061.139 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:34:21.402Z,1541630061.402 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:21.802Z,1541630061.802 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:21.867Z,1541630061.867 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:34:21.867Z,1541630061.867 [Aanderaa_O2] No Fault, FailCount= 2
2018-11-07T22:34:22.198Z,1541630062.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:22.602Z,1541630062.602 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:23.002Z,1541630063.002 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:23.402Z,1541630063.402 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:23.802Z,1541630063.802 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:24.198Z,1541630064.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:24.598Z,1541630064.598 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:24.998Z,1541630064.998 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:25.402Z,1541630065.402 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:25.802Z,1541630065.802 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:26.198Z,1541630066.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:26.602Z,1541630066.602 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:26.602Z,1541630066.602 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:34:26.602Z,1541630066.602 [AHRS_M2] Communications Fault, FailCount= 2
2018-11-07T22:34:26.603Z,1541630066.603 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:34:26.677Z,1541630066.677 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:34:26.903Z,1541630066.903 [AHRS_M2](INFO): Powering down
2018-11-07T22:34:30.573Z,1541630070.573 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:34:30.573Z,1541630070.573 [AHRS_M2] No Fault, FailCount= 2
2018-11-07T22:34:30.903Z,1541630070.903 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:34:32.534Z,1541630072.534 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:34:32.534Z,1541630072.534 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-11-07T22:34:32.535Z,1541630072.535 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:34:32.586Z,1541630072.586 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:34:32.586Z,1541630072.586 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-11-07T22:34:33.058Z,1541630073.058 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:34:34.198Z,1541630074.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:34.578Z,1541630074.578 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:34.998Z,1541630074.998 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:35.398Z,1541630075.398 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:35.778Z,1541630075.778 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:36.198Z,1541630076.198 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:36.974Z,1541630076.974 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:37.374Z,1541630077.374 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:37.774Z,1541630077.774 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:42.110Z,1541630082.110 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:44.510Z,1541630084.510 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:45.710Z,1541630085.710 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:46.910Z,1541630086.910 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:46.922Z,1541630086.922 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:34:46.922Z,1541630086.922 [AHRS_M2] Data Fault, FailCount= 3
2018-11-07T22:34:46.922Z,1541630086.922 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:34:47.003Z,1541630087.003 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:34:47.239Z,1541630087.239 [AHRS_M2](INFO): Powering down
2018-11-07T22:34:50.895Z,1541630090.895 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:34:50.895Z,1541630090.895 [AHRS_M2] No Fault, FailCount= 3
2018-11-07T22:34:51.239Z,1541630091.239 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:34:54.514Z,1541630094.514 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:54.914Z,1541630094.914 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:34:55.710Z,1541630095.710 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:56.510Z,1541630096.510 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:57.710Z,1541630097.710 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:34:58.902Z,1541630098.902 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:00.102Z,1541630100.102 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:01.302Z,1541630101.302 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:02.502Z,1541630102.502 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:03.702Z,1541630103.702 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:04.902Z,1541630104.902 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:05.650Z,1541630105.650 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:35:05.650Z,1541630105.650 [AHRS_M2] Data Fault, FailCount= 4
2018-11-07T22:35:05.650Z,1541630105.650 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:35:05.722Z,1541630105.722 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:35:06.039Z,1541630106.039 [AHRS_M2](INFO): Powering down
2018-11-07T22:35:09.692Z,1541630109.692 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:35:09.692Z,1541630109.692 [AHRS_M2] No Fault, FailCount= 4
2018-11-07T22:35:10.039Z,1541630110.039 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:35:13.710Z,1541630113.710 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:16.873Z,1541630116.873 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:17.678Z,1541630117.678 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:18.878Z,1541630118.878 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:20.078Z,1541630120.078 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:21.278Z,1541630121.278 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:22.478Z,1541630122.478 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:23.678Z,1541630123.678 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:35:23.690Z,1541630123.690 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:35:23.690Z,1541630123.690 [AHRS_M2] Data Fault, FailCount= 5
2018-11-07T22:35:23.690Z,1541630123.690 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:35:23.785Z,1541630123.785 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:35:23.786Z,1541630123.786 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-11-07T22:35:24.007Z,1541630124.007 [AHRS_M2](INFO): Powering down
2018-11-07T22:35:24.128Z,1541630124.128 [CBIT](INFO): Critical error at 20181107T223523
2018-11-07T22:35:47.637Z,1541630147.637 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:35:47.637Z,1541630147.637 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-11-07T22:35:47.637Z,1541630147.637 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:35:47.639Z,1541630147.639 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:35:47.639Z,1541630147.639 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-11-07T22:35:47.639Z,1541630147.639 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:35:47.651Z,1541630147.651 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:35:47.652Z,1541630147.652 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:35:48.066Z,1541630148.066 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:35:48.066Z,1541630148.066 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-11-07T22:35:48.067Z,1541630148.067 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:35:48.067Z,1541630148.067 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-11-07T22:35:48.454Z,1541630148.454 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:35:48.455Z,1541630148.455 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:35:48.455Z,1541630148.455 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:35:48.455Z,1541630148.455 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:35:48.456Z,1541630148.456 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:35:48.456Z,1541630148.456 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:35:56.405Z,1541630156.405 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:35:56.405Z,1541630156.405 [RDI_Pathfinder] No Fault, FailCount= 3
2018-11-07T22:36:09.203Z,1541630169.203 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-11-07T22:36:09.203Z,1541630169.203 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-11-07T22:36:09.203Z,1541630169.203 [RDI_Pathfinder](ERROR): Data Fault
2018-11-07T22:36:09.226Z,1541630169.226 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-11-07T22:36:09.662Z,1541630169.662 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:36:10.440Z,1541630170.440 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:36:10.440Z,1541630170.440 [RDI_Pathfinder] No Fault, FailCount= 1
2018-11-07T22:36:19.594Z,1541630179.594 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-07T22:31:19.5Z
2018-11-07T22:36:19.594Z,1541630179.594 [Default:CheckIn:Read_GPS] Stopped
2018-11-07T22:36:19.594Z,1541630179.594 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-11-07T22:36:20.001Z,1541630180.001 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-11-07T22:36:24.004Z,1541630184.004 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20181107T222650/Courier0000.lzma
2018-11-07T22:36:24.776Z,1541630184.776 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222650/Courier0000.lzma.bak
2018-11-07T22:36:24.776Z,1541630184.776 [DataOverHttps](INFO): SBD MOMSN=8808857
2018-11-07T22:36:33.473Z,1541630193.473 [DataOverHttps](INFO): Sending 265 bytes from file Logs/20181107T222732/Courier0000.lzma
2018-11-07T22:36:34.272Z,1541630194.272 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222732/Courier0000.lzma.bak
2018-11-07T22:36:34.272Z,1541630194.272 [DataOverHttps](INFO): SBD MOMSN=8808863
2018-11-07T22:36:34.305Z,1541630194.305 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:36:34.305Z,1541630194.305 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-11-07T22:36:34.305Z,1541630194.305 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:36:34.353Z,1541630194.353 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:36:34.859Z,1541630194.859 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:36:38.303Z,1541630198.303 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:36:38.303Z,1541630198.303 [RDI_Pathfinder] No Fault, FailCount= 2
2018-11-07T22:36:44.130Z,1541630204.130 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20181107T222732/Courier0004.lzma
2018-11-07T22:36:44.929Z,1541630204.929 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222732/Courier0004.lzma.bak
2018-11-07T22:36:44.929Z,1541630204.929 [DataOverHttps](INFO): SBD MOMSN=8808871
2018-11-07T22:37:02.051Z,1541630222.051 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20181107T215339/Express0014.lzma
2018-11-07T22:37:02.548Z,1541630222.548 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:37:02.548Z,1541630222.548 [Aanderaa_O2] No Fault, FailCount= 3
2018-11-07T22:37:02.852Z,1541630222.852 [DataOverHttps](INFO): Moved sent file to Logs/20181107T215339/Express0014.lzma.bak
2018-11-07T22:37:02.852Z,1541630222.852 [DataOverHttps](INFO): SBD MOMSN=8808875
2018-11-07T22:37:03.665Z,1541630223.665 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:37:03.665Z,1541630223.665 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-11-07T22:37:03.666Z,1541630223.666 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:37:03.755Z,1541630223.755 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:37:03.755Z,1541630223.755 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:37:03.899Z,1541630223.899 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:37:03.918Z,1541630223.918 [CBIT](INFO): Critical error at 20181107T223703
2018-11-07T22:37:15.427Z,1541630235.427 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:37:15.428Z,1541630235.428 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-11-07T22:37:15.428Z,1541630235.428 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:37:15.446Z,1541630235.446 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:37:15.497Z,1541630235.497 [DataOverHttps](INFO): Sending 485 bytes from file Logs/20181107T222347/Express0001.lzma
2018-11-07T22:37:15.679Z,1541630235.679 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:37:16.284Z,1541630236.284 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222347/Express0001.lzma.bak
2018-11-07T22:37:16.284Z,1541630236.284 [DataOverHttps](INFO): SBD MOMSN=8808878
2018-11-07T22:37:16.346Z,1541630236.346 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:37:16.346Z,1541630236.346 [Aanderaa_O2] No Fault, FailCount= 1
2018-11-07T22:37:25.599Z,1541630245.599 [DataOverHttps](INFO): Sending 501 bytes from file Logs/20181107T222418/Express0001.lzma
2018-11-07T22:37:26.396Z,1541630246.396 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222418/Express0001.lzma.bak
2018-11-07T22:37:26.396Z,1541630246.396 [DataOverHttps](INFO): SBD MOMSN=8808889
2018-11-07T22:37:27.004Z,1541630247.004 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:37:27.004Z,1541630247.004 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-11-07T22:37:27.004Z,1541630247.004 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:37:27.048Z,1541630247.048 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:37:27.338Z,1541630247.338 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:37:30.452Z,1541630250.452 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:37:30.452Z,1541630250.452 [Aanderaa_O2] No Fault, FailCount= 2
2018-11-07T22:37:35.092Z,1541630255.092 [DataOverHttps](INFO): Sending 502 bytes from file Logs/20181107T222449/Express0001.lzma
2018-11-07T22:37:35.872Z,1541630255.872 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222449/Express0001.lzma.bak
2018-11-07T22:37:35.872Z,1541630255.872 [DataOverHttps](INFO): SBD MOMSN=8808900
2018-11-07T22:37:41.052Z,1541630261.052 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:37:41.052Z,1541630261.052 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-11-07T22:37:41.052Z,1541630261.052 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:37:41.076Z,1541630261.076 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:37:41.076Z,1541630261.076 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-11-07T22:37:41.566Z,1541630261.566 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:37:44.567Z,1541630264.567 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181107T222520/Express0001.lzma
2018-11-07T22:37:45.368Z,1541630265.368 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222520/Express0001.lzma.bak
2018-11-07T22:37:45.368Z,1541630265.368 [DataOverHttps](INFO): SBD MOMSN=8808911
2018-11-07T22:37:49.295Z,1541630269.295 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:37:49.295Z,1541630269.295 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2018-11-07T22:37:49.295Z,1541630269.295 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:37:49.296Z,1541630269.296 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:37:49.297Z,1541630269.297 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-11-07T22:37:49.297Z,1541630269.297 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:37:49.309Z,1541630269.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:37:49.310Z,1541630269.310 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:37:49.431Z,1541630269.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:37:49.431Z,1541630269.431 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2018-11-07T22:37:49.431Z,1541630269.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:37:49.431Z,1541630269.431 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-11-07T22:37:49.770Z,1541630269.770 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:37:49.771Z,1541630269.771 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:37:49.771Z,1541630269.771 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:37:49.771Z,1541630269.771 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:37:49.772Z,1541630269.772 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:37:49.772Z,1541630269.772 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:37:54.382Z,1541630274.382 [DataOverHttps](INFO): Sending 556 bytes from file Logs/20181107T222650/Express0001.lzma
2018-11-07T22:37:55.180Z,1541630275.180 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222650/Express0001.lzma.bak
2018-11-07T22:37:55.180Z,1541630275.180 [DataOverHttps](INFO): SBD MOMSN=8808913
2018-11-07T22:38:03.841Z,1541630283.841 [DataOverHttps](INFO): Sending 998 bytes from file Logs/20181107T222732/Express0001.lzma
2018-11-07T22:38:04.636Z,1541630284.636 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222732/Express0001.lzma.bak
2018-11-07T22:38:04.636Z,1541630284.636 [DataOverHttps](INFO): SBD MOMSN=8808927
2018-11-07T22:38:13.349Z,1541630293.349 [DataOverHttps](INFO): Sending 463 bytes from file Logs/20181107T222732/Express0005.lzma
2018-11-07T22:38:14.140Z,1541630294.140 [DataOverHttps](INFO): Moved sent file to Logs/20181107T222732/Express0005.lzma.bak
2018-11-07T22:38:14.140Z,1541630294.140 [DataOverHttps](INFO): SBD MOMSN=8808959
2018-11-07T22:38:14.776Z,1541630294.776 [Default:CheckIn:Read_Iridium] Stopped
2018-11-07T22:38:14.777Z,1541630294.777 [Default:CheckIn:C.Wait] Running Loop=1
2018-11-07T22:38:14.777Z,1541630294.777 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-11-07T22:38:21.696Z,1541630301.696 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-11-07T22:38:21.696Z,1541630301.696 [NAL9602] Data Fault, FailCount= 1
2018-11-07T22:38:21.696Z,1541630301.696 [NAL9602](ERROR): Data Fault
2018-11-07T22:38:21.763Z,1541630301.763 [CBIT](ERROR): Data Fault in component: NAL9602
2018-11-07T22:38:22.095Z,1541630302.095 [NAL9602](INFO): Powering down
2018-11-07T22:38:22.933Z,1541630302.933 [CBIT](INFO): Clearing failed state for component NAL9602
2018-11-07T22:38:22.933Z,1541630302.933 [NAL9602] No Fault, FailCount= 1
2018-11-07T22:38:53.570Z,1541630333.570 [NAL9602](INFO): Powering up NAL9602
2018-11-07T22:39:04.432Z,1541630344.432 [NAL9602](INFO): NAL9602 initialized
2018-11-07T22:39:50.014Z,1541630390.014 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:39:50.014Z,1541630390.014 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2018-11-07T22:39:50.014Z,1541630390.014 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:39:50.016Z,1541630390.016 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:39:50.016Z,1541630390.016 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-11-07T22:39:50.016Z,1541630390.016 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:39:50.066Z,1541630390.066 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:39:50.066Z,1541630390.066 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:39:50.426Z,1541630390.426 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:39:50.426Z,1541630390.426 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2018-11-07T22:39:50.447Z,1541630390.447 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:39:50.447Z,1541630390.447 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-11-07T22:39:50.814Z,1541630390.814 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:39:50.814Z,1541630390.814 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:39:50.815Z,1541630390.815 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:39:50.815Z,1541630390.815 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:39:50.815Z,1541630390.815 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:39:50.816Z,1541630390.816 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:40:03.923Z,1541630403.923 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:40:03.924Z,1541630403.924 [RDI_Pathfinder] No Fault, FailCount= 3
2018-11-07T22:40:11.175Z,1541630411.175 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:40:11.175Z,1541630411.175 [Aanderaa_O2] No Fault, FailCount= 3
2018-11-07T22:40:16.759Z,1541630416.759 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-11-07T22:40:16.759Z,1541630416.759 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-11-07T22:40:16.759Z,1541630416.759 [RDI_Pathfinder](ERROR): Data Fault
2018-11-07T22:40:16.783Z,1541630416.783 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-11-07T22:40:17.231Z,1541630417.231 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:40:18.018Z,1541630418.018 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:40:18.019Z,1541630418.019 [RDI_Pathfinder] No Fault, FailCount= 1
2018-11-07T22:40:21.965Z,1541630421.965 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:40:21.965Z,1541630421.965 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-11-07T22:40:21.965Z,1541630421.965 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:40:21.988Z,1541630421.988 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:40:22.483Z,1541630422.483 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:40:23.180Z,1541630423.180 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:40:23.180Z,1541630423.180 [Aanderaa_O2] No Fault, FailCount= 1
2018-11-07T22:40:24.015Z,1541630424.015 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:40:24.015Z,1541630424.015 [AHRS_M2] No Fault, FailCount= 5
2018-11-07T22:40:24.331Z,1541630424.331 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:40:27.626Z,1541630427.626 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:28.026Z,1541630428.026 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:28.426Z,1541630428.426 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:28.826Z,1541630428.826 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:29.226Z,1541630429.226 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:29.626Z,1541630429.626 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:30.026Z,1541630430.026 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:30.426Z,1541630430.426 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:30.826Z,1541630430.826 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:31.226Z,1541630431.226 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:31.626Z,1541630431.626 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:32.026Z,1541630432.026 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:32.426Z,1541630432.426 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:32.830Z,1541630432.830 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:33.226Z,1541630433.226 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:33.626Z,1541630433.626 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:33.674Z,1541630433.674 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:40:33.674Z,1541630433.674 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-11-07T22:40:33.674Z,1541630433.674 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:40:33.727Z,1541630433.727 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:40:34.026Z,1541630434.026 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:34.167Z,1541630434.167 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:40:34.426Z,1541630434.426 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:34.426Z,1541630434.426 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:40:34.426Z,1541630434.426 [AHRS_M2] Communications Fault, FailCount= 1
2018-11-07T22:40:34.427Z,1541630434.427 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:40:34.488Z,1541630434.488 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:40:34.731Z,1541630434.731 [AHRS_M2](INFO): Powering down
2018-11-07T22:40:34.879Z,1541630434.879 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:40:34.879Z,1541630434.879 [Aanderaa_O2] No Fault, FailCount= 2
2018-11-07T22:40:39.546Z,1541630439.546 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:40:39.546Z,1541630439.546 [AHRS_M2] No Fault, FailCount= 1
2018-11-07T22:40:39.891Z,1541630439.891 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:40:40.729Z,1541630440.729 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:40:40.729Z,1541630440.729 [RDI_Pathfinder] Communications Fault, FailCount= 2
2018-11-07T22:40:40.729Z,1541630440.729 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:40:40.756Z,1541630440.756 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:40:41.198Z,1541630441.198 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:40:41.948Z,1541630441.948 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:40:41.948Z,1541630441.948 [RDI_Pathfinder] No Fault, FailCount= 2
2018-11-07T22:40:43.186Z,1541630443.186 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:43.586Z,1541630443.586 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:43.986Z,1541630443.986 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:44.386Z,1541630444.386 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:44.786Z,1541630444.786 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:45.178Z,1541630445.178 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:45.199Z,1541630445.199 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:40:45.199Z,1541630445.199 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-11-07T22:40:45.199Z,1541630445.199 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:40:45.229Z,1541630445.229 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:40:45.230Z,1541630445.230 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-11-07T22:40:45.574Z,1541630445.574 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:45.714Z,1541630445.714 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:40:45.990Z,1541630445.990 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:46.386Z,1541630446.386 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:46.786Z,1541630446.786 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:47.186Z,1541630447.186 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:47.590Z,1541630447.590 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:47.978Z,1541630447.978 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:48.379Z,1541630448.379 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:48.778Z,1541630448.778 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:49.178Z,1541630449.178 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:49.590Z,1541630449.590 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:49.978Z,1541630449.978 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2018-11-07T22:40:49.978Z,1541630449.978 [AHRS_M2](FAULT): Failed to initialize within timeout.
2018-11-07T22:40:49.979Z,1541630449.979 [AHRS_M2] Communications Fault, FailCount= 2
2018-11-07T22:40:49.979Z,1541630449.979 [AHRS_M2](ERROR): Communications Fault
2018-11-07T22:40:50.067Z,1541630450.067 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-11-07T22:40:50.291Z,1541630450.291 [AHRS_M2](INFO): Powering down
2018-11-07T22:40:53.956Z,1541630453.956 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:40:53.956Z,1541630453.956 [AHRS_M2] No Fault, FailCount= 2
2018-11-07T22:40:54.291Z,1541630454.291 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:40:57.962Z,1541630457.962 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:40:58.762Z,1541630458.762 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:40:59.962Z,1541630459.962 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:01.162Z,1541630461.162 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:02.362Z,1541630462.362 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:03.562Z,1541630463.562 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:04.762Z,1541630464.762 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:04.818Z,1541630464.818 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2018-11-07T22:41:04.819Z,1541630464.819 [RDI_Pathfinder] Communications Fault, FailCount= 3
2018-11-07T22:41:04.819Z,1541630464.819 [RDI_Pathfinder](ERROR): Communications Fault
2018-11-07T22:41:04.851Z,1541630464.851 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:41:04.851Z,1541630464.851 [CBIT](CRITICAL): Communications Fault in component: RDI_Pathfinder
2018-11-07T22:41:05.222Z,1541630465.222 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:41:05.246Z,1541630465.246 [CBIT](INFO): Critical error at 20181107T224104
2018-11-07T22:41:05.962Z,1541630465.962 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:07.154Z,1541630467.154 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:07.902Z,1541630467.902 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:41:07.902Z,1541630467.902 [AHRS_M2] Data Fault, FailCount= 3
2018-11-07T22:41:07.903Z,1541630467.903 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:41:08.032Z,1541630468.032 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:41:08.291Z,1541630468.291 [AHRS_M2](INFO): Powering down
2018-11-07T22:41:14.352Z,1541630474.352 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:41:14.352Z,1541630474.352 [AHRS_M2] No Fault, FailCount= 3
2018-11-07T22:41:14.639Z,1541630474.639 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:41:18.310Z,1541630478.310 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:19.110Z,1541630479.110 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:20.310Z,1541630480.310 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:21.510Z,1541630481.510 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:22.710Z,1541630482.710 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:23.910Z,1541630483.910 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:25.110Z,1541630485.110 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:26.310Z,1541630486.310 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:27.510Z,1541630487.510 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:28.250Z,1541630488.250 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:41:28.250Z,1541630488.250 [AHRS_M2] Data Fault, FailCount= 4
2018-11-07T22:41:28.250Z,1541630488.250 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:41:28.340Z,1541630488.340 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:41:28.639Z,1541630488.639 [AHRS_M2](INFO): Powering down
2018-11-07T22:41:32.292Z,1541630492.292 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-11-07T22:41:32.293Z,1541630492.293 [AHRS_M2] No Fault, FailCount= 4
2018-11-07T22:41:32.638Z,1541630492.638 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-11-07T22:41:36.310Z,1541630496.310 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:38.310Z,1541630498.310 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:39.510Z,1541630499.510 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:40.710Z,1541630500.710 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:45.510Z,1541630505.510 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-11-07T22:41:46.250Z,1541630506.250 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2018-11-07T22:41:46.250Z,1541630506.250 [AHRS_M2] Data Fault, FailCount= 5
2018-11-07T22:41:46.250Z,1541630506.250 [AHRS_M2](ERROR): Data Fault
2018-11-07T22:41:46.333Z,1541630506.333 [CBIT](ERROR): Data Fault in component: AHRS_M2
2018-11-07T22:41:46.334Z,1541630506.334 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2018-11-07T22:41:46.639Z,1541630506.639 [AHRS_M2](INFO): Powering down
2018-11-07T22:41:49.453Z,1541630509.453 [CBIT](INFO): Critical error at 20181107T224146
2018-11-07T22:41:51.103Z,1541630511.103 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:41:51.103Z,1541630511.103 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2018-11-07T22:41:51.103Z,1541630511.103 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:41:51.104Z,1541630511.104 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:41:51.104Z,1541630511.104 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2018-11-07T22:41:51.105Z,1541630511.105 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:41:51.117Z,1541630511.117 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:41:51.118Z,1541630511.118 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:41:51.507Z,1541630511.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:41:51.507Z,1541630511.507 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2018-11-07T22:41:51.507Z,1541630511.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:41:51.507Z,1541630511.507 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2018-11-07T22:41:51.906Z,1541630511.906 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:41:51.907Z,1541630511.907 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:41:51.907Z,1541630511.907 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:41:51.907Z,1541630511.907 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:41:51.908Z,1541630511.908 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:41:51.908Z,1541630511.908 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:42:43.899Z,1541630563.899 [CBIT](INFO): Clearing failed state for component DropWeight
2018-11-07T22:42:43.899Z,1541630563.899 [DropWeight] No Fault, FailCount= 1
2018-11-07T22:43:15.016Z,1541630595.016 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-11-07T22:43:15.017Z,1541630595.017 [Default:CheckIn:C.Wait] Stopped
2018-11-07T22:43:15.017Z,1541630595.017 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-11-07T22:43:15.017Z,1541630595.017 [Default:CheckIn:D] Running Loop=1
2018-11-07T22:43:15.415Z,1541630595.415 [Default:CheckIn:D] Stopped
2018-11-07T22:43:15.415Z,1541630595.415 [Default:CheckIn:E] Running Loop=1
2018-11-07T22:43:15.440Z,1541630595.440 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:43:15.440Z,1541630595.440 [Aanderaa_O2] No Fault, FailCount= 3
2018-11-07T22:43:15.813Z,1541630595.813 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.157066 min 
2018-11-07T22:43:15.815Z,1541630595.815 [Default:CheckIn:E] Stopped
2018-11-07T22:43:15.815Z,1541630595.815 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-11-07T22:43:15.815Z,1541630595.815 [Default:CheckIn] Stopped
2018-11-07T22:43:15.816Z,1541630595.816 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-11-07T22:43:15.816Z,1541630595.816 [Default:CheckIn](INFO): Running loop #2
2018-11-07T22:43:15.816Z,1541630595.816 [Default:CheckIn] Running Loop=2
2018-11-07T22:43:15.816Z,1541630595.816 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-11-07T22:43:15.816Z,1541630595.816 [Default:CheckIn:Read_GPS] Running Loop=1
2018-11-07T22:43:25.812Z,1541630605.812 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:43:25.812Z,1541630605.812 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-11-07T22:43:25.812Z,1541630605.812 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:43:25.830Z,1541630605.830 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:43:26.327Z,1541630606.327 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:43:27.027Z,1541630607.027 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:43:27.027Z,1541630607.027 [Aanderaa_O2] No Fault, FailCount= 1
2018-11-07T22:43:37.410Z,1541630617.410 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:43:37.410Z,1541630617.410 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-11-07T22:43:37.410Z,1541630617.410 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:43:37.436Z,1541630617.436 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:43:37.906Z,1541630617.906 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:43:38.622Z,1541630618.622 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-11-07T22:43:38.622Z,1541630618.622 [Aanderaa_O2] No Fault, FailCount= 2
2018-11-07T22:43:49.400Z,1541630629.400 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-11-07T22:43:49.400Z,1541630629.400 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-11-07T22:43:49.400Z,1541630629.400 [Aanderaa_O2](ERROR): Communications Fault
2018-11-07T22:43:49.453Z,1541630629.453 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-11-07T22:43:49.453Z,1541630629.453 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-11-07T22:43:49.903Z,1541630629.903 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:43:52.209Z,1541630632.209 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:43:52.209Z,1541630632.209 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2018-11-07T22:43:52.209Z,1541630632.209 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-11-07T22:43:52.211Z,1541630632.211 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-11-07T22:43:52.211Z,1541630632.211 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2018-11-07T22:43:52.211Z,1541630632.211 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-11-07T22:43:52.244Z,1541630632.244 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-11-07T22:43:52.244Z,1541630632.244 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-11-07T22:43:52.644Z,1541630632.644 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-11-07T22:43:52.644Z,1541630632.644 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2018-11-07T22:43:52.644Z,1541630632.644 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-11-07T22:43:52.644Z,1541630632.644 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2018-11-07T22:43:52.000Z,1541630633.000 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-11-07T22:43:53.000Z,1541630633.000 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:43:53.000Z,1541630633.000 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:43:53.001Z,1541630633.001 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-11-07T22:43:53.001Z,1541630633.001 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-11-07T22:43:53.002Z,1541630633.002 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-11-07T22:44:05.015Z,1541630645.015 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:44:05.015Z,1541630645.015 [RDI_Pathfinder] No Fault, FailCount= 3
2018-11-07T22:44:18.141Z,1541630658.141 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2018-11-07T22:44:18.141Z,1541630658.141 [RDI_Pathfinder] Data Fault, FailCount= 1
2018-11-07T22:44:18.141Z,1541630658.141 [RDI_Pathfinder](ERROR): Data Fault
2018-11-07T22:44:18.204Z,1541630658.204 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2018-11-07T22:44:18.631Z,1541630658.631 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:44:19.383Z,1541630659.383 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2018-11-07T22:44:19.383Z,1541630659.383 [RDI_Pathfinder] No Fault, FailCount= 1
2018-11-07T22:44:24.792Z,1541630664.792 [CommandLine](IMPORTANT): got command restart application
2018-11-07T22:44:25.801Z,1541630665.801 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:25.802Z,1541630665.802 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:25.946Z,1541630665.946 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-11-07T22:44:25.946Z,1541630665.946 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:25.947Z,1541630665.947 [CommandLine](INFO): Join timeout helper Thread ID is 1108
2018-11-07T22:44:25.947Z,1541630665.947 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-11-07T22:44:25.948Z,1541630665.948 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:25.948Z,1541630665.948 [NavChartDb](INFO): Join timeout helper Thread ID is 1109
2018-11-07T22:44:25.950Z,1541630665.950 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:25.951Z,1541630665.951 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:25.974Z,1541630665.974 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-11-07T22:44:25.974Z,1541630665.974 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:25.975Z,1541630665.975 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1110
2018-11-07T22:44:26.251Z,1541630666.251 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:26.251Z,1541630666.251 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-11-07T22:44:26.251Z,1541630666.251 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:26.262Z,1541630666.262 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-11-07T22:44:26.262Z,1541630666.262 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:26.263Z,1541630666.263 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1111
2018-11-07T22:44:26.611Z,1541630666.611 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:26.611Z,1541630666.611 [CTD_NeilBrown](INFO): Powering down
2018-11-07T22:44:26.612Z,1541630666.612 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:26.630Z,1541630666.630 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-11-07T22:44:26.630Z,1541630666.630 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:26.631Z,1541630666.631 [Radio_Surface](INFO): Join timeout helper Thread ID is 1112
2018-11-07T22:44:26.967Z,1541630666.967 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:26.967Z,1541630666.967 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:26.987Z,1541630666.987 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-11-07T22:44:26.987Z,1541630666.987 [logger ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:26.988Z,1541630666.988 [logger](INFO): Join timeout helper Thread ID is 1113
2018-11-07T22:44:27.023Z,1541630667.023 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:27.023Z,1541630667.023 [logger ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.027Z,1541630667.027 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-11-07T22:44:27.027Z,1541630667.027 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.027Z,1541630667.027 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-11-07T22:44:27.027Z,1541630667.027 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.028Z,1541630667.028 [controlThread](INFO): Join timeout helper Thread ID is 1114
2018-11-07T22:44:27.314Z,1541630667.314 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-11-07T22:44:27.315Z,1541630667.315 [controlThread](DEBUG): Uninitializing ControlThread
2018-11-07T22:44:27.315Z,1541630667.315 [AHRS_M2](INFO): Powering down
2018-11-07T22:44:27.316Z,1541630667.316 [NAL9602](INFO): Powering down
2018-11-07T22:44:27.386Z,1541630667.386 [RDI_Pathfinder](INFO): Powering down
2018-11-07T22:44:27.387Z,1541630667.387 [RDI_PathfinderUp](INFO): Powering down
2018-11-07T22:44:27.389Z,1541630667.389 [Aanderaa_O2](INFO): Powering down
2018-11-07T22:44:27.390Z,1541630667.390 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-11-07T22:44:27.391Z,1541630667.391 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-11-07T22:44:27.391Z,1541630667.391 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-11-07T22:44:27.392Z,1541630667.392 [MissionManager](INFO): Uninitializing Mission Default
2018-11-07T22:44:27.392Z,1541630667.392 [Default] Stopped
2018-11-07T22:44:27.392Z,1541630667.392 [Default](DEBUG): Aggregate::uninitialize Default
2018-11-07T22:44:27.392Z,1541630667.392 [Default:B.GoToSurface] Stopped
2018-11-07T22:44:27.392Z,1541630667.392 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-11-07T22:44:27.392Z,1541630667.392 [Default:CheckIn] Stopped
2018-11-07T22:44:27.392Z,1541630667.392 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-11-07T22:44:27.392Z,1541630667.392 [Default:CheckIn:Read_GPS] Stopped
2018-11-07T22:44:27.396Z,1541630667.396 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-11-07T22:44:27.396Z,1541630667.396 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-11-07T22:44:27.396Z,1541630667.396 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-11-07T22:44:27.397Z,1541630667.397 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-11-07T22:44:27.397Z,1541630667.397 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-11-07T22:44:27.397Z,1541630667.397 [BuoyancyServo](INFO): Powering down
2018-11-07T22:44:27.410Z,1541630667.410 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-11-07T22:44:27.411Z,1541630667.411 [ElevatorServo](INFO): Powering down
2018-11-07T22:44:27.411Z,1541630667.411 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-11-07T22:44:27.412Z,1541630667.412 [MassServo](INFO): Powering down
2018-11-07T22:44:27.412Z,1541630667.412 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-11-07T22:44:27.412Z,1541630667.412 [RudderServo](INFO): Powering down
2018-11-07T22:44:27.413Z,1541630667.413 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-11-07T22:44:27.413Z,1541630667.413 [ThrusterServo](INFO): Powering down
2018-11-07T22:44:27.414Z,1541630667.414 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-11-07T22:44:27.415Z,1541630667.415 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-11-07T22:44:27.415Z,1541630667.415 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-11-07T22:44:27.416Z,1541630667.416 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.522Z,1541630667.522 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.568Z,1541630667.568 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.570Z,1541630667.570 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.597Z,1541630667.597 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-11-07T22:44:27.656Z,1541630667.656 [logger ThreadHandler](INFO): Thread cancelled.