2018-07-12T21:12:33.052Z,1531429953.052 [Supervisor](DEBUG): Initializing supervisor.
2018-07-12T21:12:33.055Z,1531429953.055 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-07-12T21:12:33.056Z,1531429953.056 [SyncHandler](INFO): Protected caller Thread ID is 917
2018-07-12T21:12:33.057Z,1531429953.057 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-07-12T21:12:33.058Z,1531429953.058 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-07-12T21:12:33.058Z,1531429953.058 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 918
2018-07-12T21:12:33.061Z,1531429953.061 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-07-12T21:12:33.074Z,1531429953.074 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-07-12T21:12:33.075Z,1531429953.075 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-07-12T21:12:33.075Z,1531429953.075 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 919
2018-07-12T21:12:33.076Z,1531429953.076 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-07-12T21:12:33.077Z,1531429953.077 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-07-12T21:12:33.078Z,1531429953.078 [logger ThreadHandler](INFO): Protected caller Thread ID is 920
2018-07-12T21:12:33.079Z,1531429953.079 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-07-12T21:12:33.080Z,1531429953.080 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-07-12T21:12:33.081Z,1531429953.081 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-07-12T21:12:33.290Z,1531429953.290 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-07-12T21:12:33.291Z,1531429953.291 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-07-12T21:12:33.439Z,1531429953.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-07-12T21:12:33.440Z,1531429953.440 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-07-12T21:12:33.817Z,1531429953.817 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-07-12T21:12:33.817Z,1531429953.817 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-07-12T21:12:33.961Z,1531429953.961 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-07-12T21:12:33.961Z,1531429953.961 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-07-12T21:12:34.043Z,1531429954.043 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-07-12T21:12:34.258Z,1531429954.258 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-07-12T21:12:34.259Z,1531429954.259 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-07-12T21:12:34.360Z,1531429954.360 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-07-12T21:12:34.360Z,1531429954.360 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-07-12T21:12:34.722Z,1531429954.722 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-07-12T21:12:34.723Z,1531429954.723 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-07-12T21:12:35.206Z,1531429955.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-07-12T21:12:35.206Z,1531429955.206 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-07-12T21:12:35.535Z,1531429955.535 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-07-12T21:12:35.535Z,1531429955.535 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-07-12T21:12:36.074Z,1531429956.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-07-12T21:12:36.075Z,1531429956.075 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-07-12T21:12:36.302Z,1531429956.302 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-07-12T21:12:36.302Z,1531429956.302 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-07-12T21:12:36.403Z,1531429956.403 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-07-12T21:12:36.404Z,1531429956.404 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-07-12T21:12:37.099Z,1531429957.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-07-12T21:12:37.099Z,1531429957.099 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-07-12T21:12:37.210Z,1531429957.210 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-07-12T21:12:37.212Z,1531429957.212 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-07-12T21:12:37.213Z,1531429957.213 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-07-12T21:12:37.453Z,1531429957.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-07-12T21:12:37.454Z,1531429957.454 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-07-12T21:12:37.556Z,1531429957.556 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-07-12T21:12:37.652Z,1531429957.652 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-07-12T21:12:37.758Z,1531429957.758 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-07-12T21:12:37.846Z,1531429957.846 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-07-12T21:12:38.208Z,1531429958.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-07-12T21:12:38.389Z,1531429958.389 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-07-12T21:12:38.503Z,1531429958.503 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-07-12T21:12:38.589Z,1531429958.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-07-12T21:12:38.674Z,1531429958.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-07-12T21:12:38.881Z,1531429958.881 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/root/
2018-07-12T21:12:38.882Z,1531429958.882 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-07-12T21:12:38.889Z,1531429958.889 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-07-12T21:12:39.026Z,1531429959.026 [SBIT](DEBUG): Construct Startup Built In Test.
2018-07-12T21:12:39.058Z,1531429959.058 [SBIT] Loaded
2018-07-12T21:12:39.058Z,1531429959.058 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-07-12T21:12:39.059Z,1531429959.059 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-07-12T21:12:39.088Z,1531429959.088 [IBIT] Loaded
2018-07-12T21:12:39.088Z,1531429959.088 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-07-12T21:12:39.092Z,1531429959.092 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-07-12T21:12:39.257Z,1531429959.257 [CBIT] Loaded
2018-07-12T21:12:39.257Z,1531429959.257 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-07-12T21:12:39.258Z,1531429959.258 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-07-12T21:12:39.258Z,1531429959.258 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-07-12T21:12:39.330Z,1531429959.330 [VerticalControl](DEBUG): Construct VerticalControl.
2018-07-12T21:12:39.435Z,1531429959.435 [VerticalControl] Loaded
2018-07-12T21:12:39.435Z,1531429959.435 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-07-12T21:12:39.436Z,1531429959.436 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-07-12T21:12:39.500Z,1531429959.500 [HorizontalControl] Loaded
2018-07-12T21:12:39.500Z,1531429959.500 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-07-12T21:12:39.501Z,1531429959.501 [SpeedControl](DEBUG): Construct SpeedControl.
2018-07-12T21:12:39.507Z,1531429959.507 [SpeedControl] Loaded
2018-07-12T21:12:39.507Z,1531429959.507 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-07-12T21:12:39.508Z,1531429959.508 [LoopControl](DEBUG): Construct LoopControl.
2018-07-12T21:12:39.508Z,1531429959.508 [LoopControl] Loaded
2018-07-12T21:12:39.509Z,1531429959.509 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-07-12T21:12:39.509Z,1531429959.509 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-07-12T21:12:39.510Z,1531429959.510 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-07-12T21:12:39.553Z,1531429959.553 [DepthRateCalculator] Loaded
2018-07-12T21:12:39.553Z,1531429959.553 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-07-12T21:12:39.559Z,1531429959.559 [PitchRateCalculator] Loaded
2018-07-12T21:12:39.559Z,1531429959.559 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-07-12T21:12:39.576Z,1531429959.576 [SpeedCalculator] Loaded
2018-07-12T21:12:39.576Z,1531429959.576 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-07-12T21:12:39.599Z,1531429959.599 [TempGradientCalculator] Loaded
2018-07-12T21:12:39.599Z,1531429959.599 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-07-12T21:12:39.615Z,1531429959.615 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-07-12T21:12:39.616Z,1531429959.616 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-07-12T21:12:39.621Z,1531429959.621 [YawRateCalculator] Loaded
2018-07-12T21:12:39.622Z,1531429959.622 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-07-12T21:12:39.652Z,1531429959.652 [ElevatorOffsetCalculator] Loaded
2018-07-12T21:12:39.653Z,1531429959.653 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-07-12T21:12:39.653Z,1531429959.653 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-07-12T21:12:39.654Z,1531429959.654 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-07-12T21:12:39.740Z,1531429959.740 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-07-12T21:12:39.741Z,1531429959.741 [StratificationFrontDetector](DEBUG): (re)initializing
2018-07-12T21:12:39.741Z,1531429959.741 [StratificationFrontDetector] Loaded
2018-07-12T21:12:39.741Z,1531429959.741 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-07-12T21:12:39.742Z,1531429959.742 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-07-12T21:12:39.742Z,1531429959.742 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-07-12T21:12:40.001Z,1531429960.001 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-07-12T21:12:40.001Z,1531429960.001 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-07-12T21:12:40.103Z,1531429960.103 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-07-12T21:12:40.103Z,1531429960.103 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-07-12T21:12:40.161Z,1531429960.161 [DeadReckonUsingSpeedCalculator] Loaded
2018-07-12T21:12:40.161Z,1531429960.161 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-07-12T21:12:40.179Z,1531429960.179 [NavChart] Loaded
2018-07-12T21:12:40.180Z,1531429960.180 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-07-12T21:12:40.184Z,1531429960.184 [UniversalFixResidualReporter] Loaded
2018-07-12T21:12:40.184Z,1531429960.184 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-07-12T21:12:40.184Z,1531429960.184 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-07-12T21:12:40.185Z,1531429960.185 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-07-12T21:12:40.198Z,1531429960.198 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-07-12T21:12:40.199Z,1531429960.199 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-07-12T21:12:40.361Z,1531429960.361 [Aanderaa_O2] Loaded
2018-07-12T21:12:40.361Z,1531429960.361 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-07-12T21:12:40.444Z,1531429960.444 [CTD_NeilBrown] Loaded
2018-07-12T21:12:40.444Z,1531429960.444 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-07-12T21:12:40.445Z,1531429960.445 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406D24E0
2018-07-12T21:12:40.446Z,1531429960.446 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 999
2018-07-12T21:12:40.461Z,1531429960.461 [PAR_Licor] Loaded
2018-07-12T21:12:40.461Z,1531429960.461 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-07-12T21:12:40.513Z,1531429960.513 [WetLabsBB2FL] Loaded
2018-07-12T21:12:40.514Z,1531429960.514 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-07-12T21:12:40.515Z,1531429960.515 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407024E0
2018-07-12T21:12:40.515Z,1531429960.515 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1000
2018-07-12T21:12:40.562Z,1531429960.562 [WetLabsSeaOWL_UV_A] Loaded
2018-07-12T21:12:40.562Z,1531429960.562 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-07-12T21:12:40.563Z,1531429960.563 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 407324E0
2018-07-12T21:12:40.563Z,1531429960.563 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1001
2018-07-12T21:12:40.564Z,1531429960.564 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-07-12T21:12:40.564Z,1531429960.564 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-07-12T21:12:40.865Z,1531429960.865 [AHRS_M2] Loaded
2018-07-12T21:12:40.865Z,1531429960.865 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-07-12T21:12:40.938Z,1531429960.938 [DataOverHttps] Loaded
2018-07-12T21:12:40.938Z,1531429960.938 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-07-12T21:12:40.952Z,1531429960.952 [Depth_Keller] Loaded
2018-07-12T21:12:40.953Z,1531429960.953 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-07-12T21:12:40.958Z,1531429960.958 [DropWeight] Loaded
2018-07-12T21:12:40.958Z,1531429960.958 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-07-12T21:12:41.054Z,1531429961.054 [NAL9602] Loaded
2018-07-12T21:12:41.055Z,1531429961.055 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-07-12T21:12:41.060Z,1531429961.060 [Onboard] Loaded
2018-07-12T21:12:41.060Z,1531429961.060 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-07-12T21:12:41.067Z,1531429961.067 [Radio_Surface] Loaded
2018-07-12T21:12:41.068Z,1531429961.068 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-07-12T21:12:41.069Z,1531429961.069 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409884E0
2018-07-12T21:12:41.069Z,1531429961.069 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1002
2018-07-12T21:12:41.099Z,1531429961.099 [RDI_Pathfinder] Loaded
2018-07-12T21:12:41.100Z,1531429961.100 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-07-12T21:12:41.106Z,1531429961.106 [SCPI] Loaded
2018-07-12T21:12:41.107Z,1531429961.107 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-07-12T21:12:43.002Z,1531429963.002 [BPC1] Loaded
2018-07-12T21:12:43.002Z,1531429963.002 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-07-12T21:12:43.002Z,1531429963.002 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-07-12T21:12:43.003Z,1531429963.003 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-07-12T21:12:43.159Z,1531429963.159 [BuoyancyServo] Loaded
2018-07-12T21:12:43.159Z,1531429963.159 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-07-12T21:12:43.171Z,1531429963.171 [ElevatorServo] Loaded
2018-07-12T21:12:43.171Z,1531429963.171 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-07-12T21:12:43.183Z,1531429963.183 [MassServo] Loaded
2018-07-12T21:12:43.183Z,1531429963.183 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-07-12T21:12:43.195Z,1531429963.195 [RudderServo] Loaded
2018-07-12T21:12:43.196Z,1531429963.196 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-07-12T21:12:43.207Z,1531429963.207 [ThrusterServo] Loaded
2018-07-12T21:12:43.207Z,1531429963.207 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-07-12T21:12:43.208Z,1531429963.208 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-07-12T21:12:43.208Z,1531429963.208 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-07-12T21:12:43.315Z,1531429963.315 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-07-12T21:12:43.315Z,1531429963.315 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-07-12T21:12:43.341Z,1531429963.341 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-07-12T21:12:43.345Z,1531429963.345 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-07-12T21:12:43.345Z,1531429963.345 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-07-12T21:12:43.352Z,1531429963.352 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-07-12T21:12:43.354Z,1531429963.354 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A314E0
2018-07-12T21:12:43.354Z,1531429963.354 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1003
2018-07-12T21:12:43.359Z,1531429963.359 [Supervisor](INFO): Main Thread ID is 795
2018-07-12T21:12:43.359Z,1531429963.359 [Supervisor](DEBUG): Running supervisor.
2018-07-12T21:12:43.360Z,1531429963.360 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1004
2018-07-12T21:12:43.362Z,1531429963.362 [controlThread ThreadHandler](INFO): Handler Thread ID is 1005
2018-07-12T21:12:43.363Z,1531429963.363 [controlThread](DEBUG): Initializing ControlThread
2018-07-12T21:12:43.363Z,1531429963.363 [SBIT](INFO): Initialize SBIT Component.
2018-07-12T21:12:43.364Z,1531429963.364 [SBIT](IMPORTANT): git: 2018-06-03-17-gbdf8474
2018-07-12T21:12:43.364Z,1531429963.364 [SBIT](INFO): git hash: bdf847407d9faffe74fd7e88a9e899f3511e6e11
2018-07-12T21:12:43.365Z,1531429963.365 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-07-12T21:12:43.366Z,1531429963.366 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-07-12T21:12:43.367Z,1531429963.367 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2018-07-12T21:12:43.368Z,1531429963.368 [IBIT](INFO): Initialize IBIT Component.
2018-07-12T21:12:43.369Z,1531429963.369 [CBIT](DEBUG): Initialize CBIT Component.
2018-07-12T21:12:43.369Z,1531429963.369 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-07-12T21:12:43.370Z,1531429963.370 [logger ThreadHandler](INFO): Handler Thread ID is 1006
2018-07-12T21:12:43.397Z,1531429963.397 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1007
2018-07-12T21:12:43.398Z,1531429963.398 [CTD_NeilBrown](INFO): Powering down
2018-07-12T21:12:43.433Z,1531429963.433 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1008
2018-07-12T21:12:43.453Z,1531429963.453 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1009
2018-07-12T21:12:43.454Z,1531429963.454 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-07-12T21:12:43.477Z,1531429963.477 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-07-12T21:12:43.479Z,1531429963.479 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-07-12T21:12:43.480Z,1531429963.480 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-07-12T21:12:43.480Z,1531429963.480 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-07-12T21:12:43.480Z,1531429963.480 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-07-12T21:12:43.481Z,1531429963.481 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-07-12T21:12:43.481Z,1531429963.481 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-07-12T21:12:43.481Z,1531429963.481 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-07-12T21:12:43.482Z,1531429963.482 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-07-12T21:12:43.483Z,1531429963.483 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-07-12T21:12:43.483Z,1531429963.483 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-07-12T21:12:43.484Z,1531429963.484 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-12T21:12:43.485Z,1531429963.485 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-12T21:12:43.485Z,1531429963.485 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-12T21:12:43.485Z,1531429963.485 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-12T21:12:43.486Z,1531429963.486 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-12T21:12:43.486Z,1531429963.486 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-12T21:12:43.487Z,1531429963.487 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-07-12T21:12:43.487Z,1531429963.487 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-07-12T21:12:43.501Z,1531429963.501 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1010
2018-07-12T21:12:43.507Z,1531429963.507 [Radio_Surface](INFO): Powering up
2018-07-12T21:12:43.516Z,1531429963.516 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-07-12T21:12:43.517Z,1531429963.517 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1011
2018-07-12T21:12:43.521Z,1531429963.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-07-12T21:12:43.521Z,1531429963.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-07-12T21:12:43.521Z,1531429963.521 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-07-12T21:12:43.521Z,1531429963.521 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-07-12T21:12:43.522Z,1531429963.522 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-07-12T21:12:43.522Z,1531429963.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-07-12T21:12:43.522Z,1531429963.522 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-07-12T21:12:43.522Z,1531429963.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-07-12T21:12:43.523Z,1531429963.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-07-12T21:12:43.523Z,1531429963.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-07-12T21:12:43.523Z,1531429963.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-07-12T21:12:43.523Z,1531429963.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-07-12T21:12:43.523Z,1531429963.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-07-12T21:12:43.524Z,1531429963.524 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-07-12T21:12:43.524Z,1531429963.524 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-07-12T21:12:43.524Z,1531429963.524 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-07-12T21:12:43.572Z,1531429963.572 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-07-12T21:12:43.611Z,1531429963.611 [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-07-12T21:12:43.612Z,1531429963.612 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-07-12T21:12:43.703Z,1531429963.703 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-07-12T21:12:43.729Z,1531429963.729 [Default:A.Wait](DEBUG): Construct Wait.
2018-07-12T21:12:43.730Z,1531429963.730 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-07-12T21:12:43.750Z,1531429963.750 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-07-12T21:12:43.752Z,1531429963.752 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-07-12T21:12:43.798Z,1531429963.798 [Default:E.Execute](DEBUG): Construct Execute.
2018-07-12T21:12:43.810Z,1531429963.810 [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 300</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-07-12T21:12:43.816Z,1531429963.816 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,PAR_Licor,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-07-12T21:12:43.925Z,1531429963.925 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-07-12T21:12:43.981Z,1531429963.981 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-07-12T21:12:44.014Z,1531429964.014 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-07-12T21:12:44.261Z,1531429964.261 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-07-12T21:12:44.478Z,1531429964.478 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:44.517Z,1531429964.517 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:44.733Z,1531429964.733 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-07-12T21:12:44.741Z,1531429964.741 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-07-12T21:12:44.756Z,1531429964.756 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-07-12T21:12:44.761Z,1531429964.761 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-07-12T21:12:44.768Z,1531429964.768 [MassServo](DEBUG): Initializing EZServoServo.
2018-07-12T21:12:44.773Z,1531429964.773 [MassServo](DEBUG): Initializing MassServo.
2018-07-12T21:12:44.779Z,1531429964.779 [RudderServo](DEBUG): Initializing EZServoServo.
2018-07-12T21:12:44.785Z,1531429964.785 [RudderServo](DEBUG): Initializing RudderServo.
2018-07-12T21:12:44.791Z,1531429964.791 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-07-12T21:12:44.801Z,1531429964.801 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-07-12T21:12:45.026Z,1531429965.026 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-07-12T21:12:45.026Z,1531429965.026 [DropWeight] Hardware Fault, FailCount= 1
2018-07-12T21:12:45.026Z,1531429965.026 [DropWeight](ERROR): Hardware Fault
2018-07-12T21:12:45.054Z,1531429965.054 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-07-12T21:12:45.067Z,1531429965.067 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:45.068Z,1531429965.068 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:45.090Z,1531429965.090 [CommandLine](FAULT): Scheduling is paused
2018-07-12T21:12:45.090Z,1531429965.090 [CBIT](INFO): Critical error at 20180712T211245
2018-07-12T21:12:45.091Z,1531429965.091 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-07-12T21:12:45.109Z,1531429965.109 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-07-12T21:12:45.110Z,1531429965.110 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-07-12T21:12:45.338Z,1531429965.338 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:12:45.338Z,1531429965.338 [Aanderaa_O2] Data Fault, FailCount= 1
2018-07-12T21:12:45.338Z,1531429965.338 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:12:45.669Z,1531429965.669 [AHRS_M2](ERROR): Stop data-stream UART error: serial timeout
2018-07-12T21:12:45.700Z,1531429965.700 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:45.713Z,1531429965.713 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:46.003Z,1531429966.003 [CBIT](INFO): Critical error at 20180712T211245
2018-07-12T21:12:46.005Z,1531429966.005 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:12:46.133Z,1531429966.133 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:12:46.545Z,1531429966.545 [AHRS_M2](ERROR): Stop data-stream UART error: serial timeout
2018-07-12T21:12:46.593Z,1531429966.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:46.595Z,1531429966.595 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:46.921Z,1531429966.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:46.922Z,1531429966.922 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:47.097Z,1531429967.097 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:47.098Z,1531429967.098 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:47.241Z,1531429967.241 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:12:47.241Z,1531429967.241 [Aanderaa_O2] No Fault, FailCount= 1
2018-07-12T21:12:47.507Z,1531429967.507 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:47.518Z,1531429967.518 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:47.905Z,1531429967.905 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:47.906Z,1531429967.906 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:48.335Z,1531429968.335 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:48.336Z,1531429968.336 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:48.725Z,1531429968.725 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:48.726Z,1531429968.726 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:49.288Z,1531429969.288 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:49.301Z,1531429969.301 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:49.694Z,1531429969.694 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:49.695Z,1531429969.695 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:50.102Z,1531429970.102 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:50.103Z,1531429970.103 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:50.478Z,1531429970.478 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:50.479Z,1531429970.479 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:50.842Z,1531429970.842 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:50.843Z,1531429970.843 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:51.254Z,1531429971.254 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:51.255Z,1531429971.255 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:51.650Z,1531429971.650 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:51.651Z,1531429971.651 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:52.086Z,1531429972.086 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:52.087Z,1531429972.087 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:52.482Z,1531429972.482 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:52.483Z,1531429972.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:52.891Z,1531429972.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:52.901Z,1531429972.901 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:53.282Z,1531429973.282 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:53.283Z,1531429973.283 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:53.679Z,1531429973.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:53.680Z,1531429973.680 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:54.075Z,1531429974.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:54.085Z,1531429974.085 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:54.482Z,1531429974.482 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:54.483Z,1531429974.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:54.858Z,1531429974.858 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:54.859Z,1531429974.859 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:55.257Z,1531429975.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:55.259Z,1531429975.259 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:55.657Z,1531429975.657 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:55.658Z,1531429975.658 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:56.053Z,1531429976.053 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:56.055Z,1531429976.055 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:56.462Z,1531429976.462 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:56.463Z,1531429976.463 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:56.851Z,1531429976.851 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:56.852Z,1531429976.852 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:57.262Z,1531429977.262 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:57.263Z,1531429977.263 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:57.606Z,1531429977.606 [Aanderaa_O2](FAULT): Timed out starting
2018-07-12T21:12:57.607Z,1531429977.607 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-07-12T21:12:57.607Z,1531429977.607 [Aanderaa_O2](ERROR): Communications Fault
2018-07-12T21:12:57.726Z,1531429977.726 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:57.727Z,1531429977.727 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:57.748Z,1531429977.748 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-07-12T21:12:58.125Z,1531429978.125 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:12:58.211Z,1531429978.211 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:58.212Z,1531429978.212 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:58.481Z,1531429978.481 [AHRS_M2](ERROR): Read RFS packet UART error: serial timeout
2018-07-12T21:12:58.560Z,1531429978.560 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:58.570Z,1531429978.570 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-07-12T21:12:58.985Z,1531429978.985 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:12:58.985Z,1531429978.985 [Aanderaa_O2] No Fault, FailCount= 2
2018-07-12T21:13:00.807Z,1531429980.807 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:13:00.807Z,1531429980.807 [Aanderaa_O2] Data Fault, FailCount= 3
2018-07-12T21:13:00.807Z,1531429980.807 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:13:00.919Z,1531429980.919 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:13:00.919Z,1531429980.919 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2018-07-12T21:13:01.325Z,1531429981.325 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:13:08.084Z,1531429988.084 [SBIT](IMPORTANT): Beginning Startup BIT
2018-07-12T21:13:08.089Z,1531429988.089 [CBIT](IMPORTANT): Beginning ground fault scan
2018-07-12T21:13:11.406Z,1531429991.406 [NAL9602](INFO): Powering up NAL9602
2018-07-12T21:13:19.591Z,1531429999.591 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.015345
CHAN A1 (24V): -0.018164
CHAN A2 (12V): -0.007341
CHAN A3 (5V): -0.002227
CHAN B0 (3.3V): 0.000299
CHAN B1 (3.15aV): 0.000152
CHAN B2 (3.15bV): -0.000223
CHAN B3 (GND): 0.002272
OPEN: 0.004355
Full Scale Calc: 4.765 mA, -1.589 mA
2018-07-12T21:13:22.606Z,1531430002.606 [NAL9602](INFO): NAL9602 initialized
2018-07-12T21:14:02.292Z,1531430042.292 [SBIT](IMPORTANT): SBIT PASSED
2018-07-12T21:14:02.358Z,1531430042.358 [CommandLine](IMPORTANT): got command configSet list
2018-07-12T21:14:02.359Z,1531430042.359 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-07-12T21:14:02.360Z,1531430042.360 [CommandLine](IMPORTANT): BuoyancyServo.limitHi=9575 count;

2018-07-12T21:14:02.360Z,1531430042.360 [CommandLine](IMPORTANT): BuoyancyServo.limitLo=1200 count;

2018-07-12T21:14:02.360Z,1531430042.360 [CommandLine](IMPORTANT): BuoyancyServo.offsetVolume=200 cubic_centimeter;

2018-07-12T21:14:02.360Z,1531430042.360 [CommandLine](IMPORTANT): VerticalControl.buoyancyDefault=1070 cubic_centimeter;

2018-07-12T21:14:02.361Z,1531430042.361 [CommandLine](IMPORTANT): VerticalControl.buoyancyLimitHiCC=1075 cubic_centimeter;

2018-07-12T21:14:02.361Z,1531430042.361 [CommandLine](IMPORTANT): VerticalControl.buoyancyLimitLoCC=100 cubic_centimeter;

2018-07-12T21:14:02.361Z,1531430042.361 [CommandLine](IMPORTANT): VerticalControl.massDefault=1 millimeter;

2018-07-12T21:14:02.708Z,1531430042.708 [MissionManager](IMPORTANT): Started mission Startup
2018-07-12T21:14:02.710Z,1531430042.710 [Startup] Running Loop=1
2018-07-12T21:14:02.710Z,1531430042.710 [Startup](DEBUG): Aggregate::initialize Startup
2018-07-12T21:14:02.710Z,1531430042.710 [Startup:A.GoToSurface] Running Loop=1
2018-07-12T21:14:02.710Z,1531430042.710 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-07-12T21:14:02.711Z,1531430042.711 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-07-12T21:14:02.711Z,1531430042.711 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-07-12T21:14:02.712Z,1531430042.712 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-07-12T21:14:02.712Z,1531430042.712 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-07-12T21:14:02.713Z,1531430042.713 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-07-12T21:14:02.719Z,1531430042.719 [Startup:StartupSatComms] Running Loop=1
2018-07-12T21:14:02.719Z,1531430042.719 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-07-12T21:14:02.720Z,1531430042.720 [Startup:StartupSatComms:A] Running Loop=1
2018-07-12T21:14:03.047Z,1531430043.047 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-07-12T21:15:03.062Z,1531430103.062 [Startup:StartupSatComms:A](INFO): Timed out from 2018-07-12T21:14:02.7Z
2018-07-12T21:15:03.062Z,1531430103.062 [Startup:StartupSatComms:A] Stopped
2018-07-12T21:15:03.062Z,1531430103.062 [Startup:StartupSatComms:B] Running Loop=1
2018-07-12T21:15:03.440Z,1531430103.440 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-07-12T21:15:31.086Z,1531430131.086 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:15:31.086Z,1531430131.086 [Aanderaa_O2] No Fault, FailCount= 3
2018-07-12T21:15:32.987Z,1531430132.987 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:15:32.987Z,1531430132.987 [Aanderaa_O2] Data Fault, FailCount= 1
2018-07-12T21:15:32.987Z,1531430132.987 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:15:33.086Z,1531430133.086 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:15:33.501Z,1531430133.501 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:15:34.266Z,1531430134.266 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:15:34.266Z,1531430134.266 [Aanderaa_O2] No Fault, FailCount= 1
2018-07-12T21:15:36.186Z,1531430136.186 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:15:36.187Z,1531430136.187 [Aanderaa_O2] Data Fault, FailCount= 2
2018-07-12T21:15:36.187Z,1531430136.187 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:15:36.302Z,1531430136.302 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:15:36.701Z,1531430136.701 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:15:37.493Z,1531430137.493 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:15:37.493Z,1531430137.493 [Aanderaa_O2] No Fault, FailCount= 2
2018-07-12T21:15:39.387Z,1531430139.387 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:15:39.387Z,1531430139.387 [Aanderaa_O2] Data Fault, FailCount= 3
2018-07-12T21:15:39.387Z,1531430139.387 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:15:39.486Z,1531430139.486 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:15:39.487Z,1531430139.487 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2018-07-12T21:15:39.908Z,1531430139.908 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:15:43.862Z,1531430143.862 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-12T21:15:43.862Z,1531430143.862 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-07-12T21:15:43.862Z,1531430143.862 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-07-12T21:15:43.864Z,1531430143.864 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-12T21:15:43.864Z,1531430143.864 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-07-12T21:15:43.864Z,1531430143.864 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-07-12T21:15:43.901Z,1531430143.901 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-07-12T21:15:43.902Z,1531430143.902 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-07-12T21:15:44.286Z,1531430144.286 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-07-12T21:15:44.286Z,1531430144.286 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-07-12T21:15:44.287Z,1531430144.287 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-07-12T21:15:44.287Z,1531430144.287 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-07-12T21:15:44.649Z,1531430144.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-12T21:15:44.649Z,1531430144.649 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-12T21:15:44.650Z,1531430144.650 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-12T21:15:44.650Z,1531430144.650 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-12T21:15:44.650Z,1531430144.650 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-12T21:15:44.651Z,1531430144.651 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-12T21:15:45.145Z,1531430145.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.3 s old, using for 20.0 s.
2018-07-12T21:15:48.314Z,1531430148.314 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.5 s old, using for 20.0 s.
2018-07-12T21:15:48.479Z,1531430148.479 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.6 s old, using for 20.0 s.
2018-07-12T21:15:48.831Z,1531430148.831 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.0 s old, using for 20.0 s.
2018-07-12T21:15:49.166Z,1531430149.166 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004406
2018-07-12T21:15:49.235Z,1531430149.235 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.4 s old, using for 20.0 s.
2018-07-12T21:15:49.624Z,1531430149.624 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.8 s old, using for 20.0 s.
2018-07-12T21:15:50.027Z,1531430150.027 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.2 s old, using for 20.0 s.
2018-07-12T21:15:53.246Z,1531430153.246 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.4 s old, using for 20.0 s.
2018-07-12T21:15:53.324Z,1531430153.324 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20180712T210822/Courier0000.lzma
2018-07-12T21:15:53.429Z,1531430153.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-07-12T21:15:53.804Z,1531430153.804 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.9 s old, using for 20.0 s.
2018-07-12T21:15:54.110Z,1531430154.110 [DataOverHttps](INFO): Moved sent file to Logs/20180712T210822/Courier0000.lzma.bak
2018-07-12T21:15:54.110Z,1531430154.110 [DataOverHttps](INFO): SBD MOMSN=8366439
2018-07-12T21:15:54.199Z,1531430154.199 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.3 s old, using for 20.0 s.
2018-07-12T21:15:54.581Z,1531430154.581 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.7 s old, using for 20.0 s.
2018-07-12T21:15:54.980Z,1531430154.980 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.1 s old, using for 20.0 s.
2018-07-12T21:15:55.361Z,1531430155.361 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.5 s old, using for 20.0 s.
2018-07-12T21:15:55.753Z,1531430155.753 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.9 s old, using for 20.0 s.
2018-07-12T21:15:59.166Z,1531430159.166 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.3 s old, using for 20.0 s.
2018-07-12T21:15:59.344Z,1531430159.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.5 s old, using for 20.0 s.
2018-07-12T21:15:59.749Z,1531430159.749 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.9 s old, using for 20.0 s.
2018-07-12T21:16:00.141Z,1531430160.141 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.3 s old, using for 20.0 s.
2018-07-12T21:16:00.486Z,1531430160.486 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.6 s old, using for 20.0 s.
2018-07-12T21:16:00.896Z,1531430160.896 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.0 s old, using for 20.0 s.
2018-07-12T21:16:04.105Z,1531430164.105 [Startup:StartupSatComms:B](INFO): Timed out from 2018-07-12T21:15:03.1Z
2018-07-12T21:16:04.105Z,1531430164.105 [Startup:StartupSatComms:B] Stopped
2018-07-12T21:16:04.105Z,1531430164.105 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-07-12T21:16:04.106Z,1531430164.106 [Startup:StartupSatComms] Stopped
2018-07-12T21:16:04.106Z,1531430164.106 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-07-12T21:16:04.107Z,1531430164.107 [Startup](INFO): Completed Startup
2018-07-12T21:16:04.107Z,1531430164.107 [MissionManager](INFO): Startup is completed.
2018-07-12T21:16:04.107Z,1531430164.107 [MissionManager](INFO): Uninitializing Mission Startup
2018-07-12T21:16:04.107Z,1531430164.107 [Startup] Stopped
2018-07-12T21:16:04.107Z,1531430164.107 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-07-12T21:16:04.107Z,1531430164.107 [Startup:A.GoToSurface] Stopped
2018-07-12T21:16:04.108Z,1531430164.108 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-07-12T21:16:04.210Z,1531430164.210 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20180712T211233/Courier0000.lzma
2018-07-12T21:16:04.310Z,1531430164.310 [MissionManager](IMPORTANT): Started mission Default
2018-07-12T21:16:04.310Z,1531430164.310 [Default] Running Loop=1
2018-07-12T21:16:04.310Z,1531430164.310 [Default](DEBUG): Aggregate::initialize Default
2018-07-12T21:16:04.310Z,1531430164.310 [Default:B.GoToSurface] Running Loop=1
2018-07-12T21:16:04.310Z,1531430164.310 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-07-12T21:16:04.311Z,1531430164.311 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-07-12T21:16:04.311Z,1531430164.311 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-07-12T21:16:04.311Z,1531430164.311 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-07-12T21:16:04.312Z,1531430164.312 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-07-12T21:16:04.312Z,1531430164.312 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-07-12T21:16:04.312Z,1531430164.312 [Default:A.Wait] Running Loop=1
2018-07-12T21:16:04.313Z,1531430164.313 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-07-12T21:16:04.938Z,1531430164.938 [DataOverHttps](INFO): Moved sent file to Logs/20180712T211233/Courier0000.lzma.bak
2018-07-12T21:16:04.939Z,1531430164.939 [DataOverHttps](INFO): SBD MOMSN=8366443
2018-07-12T21:16:17.564Z,1531430177.564 [Default:A.Wait](INFO): Done Waiting.
2018-07-12T21:16:17.564Z,1531430177.564 [Default:A.Wait] Stopped
2018-07-12T21:16:17.564Z,1531430177.564 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-07-12T21:16:17.981Z,1531430177.981 [Default:CheckIn] Running Loop=1
2018-07-12T21:16:17.982Z,1531430177.982 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-07-12T21:16:17.982Z,1531430177.982 [Default:CheckIn:Read_GPS] Running Loop=1
2018-07-12T21:16:18.369Z,1531430178.369 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-07-12T21:18:09.511Z,1531430289.511 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:18:09.512Z,1531430289.512 [Aanderaa_O2] No Fault, FailCount= 3
2018-07-12T21:18:11.355Z,1531430291.355 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:18:11.355Z,1531430291.355 [Aanderaa_O2] Data Fault, FailCount= 1
2018-07-12T21:18:11.355Z,1531430291.355 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:18:11.439Z,1531430291.439 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:18:11.869Z,1531430291.869 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:18:12.635Z,1531430292.635 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:18:12.635Z,1531430292.635 [Aanderaa_O2] No Fault, FailCount= 1
2018-07-12T21:18:14.554Z,1531430294.554 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:18:14.555Z,1531430294.555 [Aanderaa_O2] Data Fault, FailCount= 2
2018-07-12T21:18:14.555Z,1531430294.555 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:18:14.649Z,1531430294.649 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:18:15.077Z,1531430295.077 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:18:15.828Z,1531430295.828 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-07-12T21:18:15.833Z,1531430295.833 [Aanderaa_O2] No Fault, FailCount= 2
2018-07-12T21:18:17.754Z,1531430297.754 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	651	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2018-07-12T21:18:17.755Z,1531430297.755 [Aanderaa_O2] Data Fault, FailCount= 3
2018-07-12T21:18:17.755Z,1531430297.755 [Aanderaa_O2](ERROR): Data Fault
2018-07-12T21:18:17.851Z,1531430297.851 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2018-07-12T21:18:17.852Z,1531430297.852 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2018-07-12T21:18:18.271Z,1531430298.271 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:18:25.767Z,1531430305.767 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-07-12T21:18:45.020Z,1531430325.020 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-12T21:18:45.020Z,1531430325.020 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-07-12T21:18:45.020Z,1531430325.020 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-07-12T21:18:45.022Z,1531430325.022 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-07-12T21:18:45.023Z,1531430325.023 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-07-12T21:18:45.023Z,1531430325.023 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-07-12T21:18:45.052Z,1531430325.052 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-07-12T21:18:45.052Z,1531430325.052 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-07-12T21:18:45.432Z,1531430325.432 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-07-12T21:18:45.432Z,1531430325.432 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-07-12T21:18:45.432Z,1531430325.432 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-07-12T21:18:45.432Z,1531430325.432 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-07-12T21:18:45.816Z,1531430325.816 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-07-12T21:18:45.816Z,1531430325.816 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-07-12T21:18:45.816Z,1531430325.816 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-07-12T21:18:45.817Z,1531430325.817 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-07-12T21:18:45.817Z,1531430325.817 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-07-12T21:18:45.818Z,1531430325.818 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-07-12T21:18:46.253Z,1531430326.253 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2018-07-12T21:18:46.633Z,1531430326.633 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2018-07-12T21:18:47.046Z,1531430327.046 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2018-07-12T21:18:47.412Z,1531430327.412 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2018-07-12T21:18:47.827Z,1531430327.827 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2018-07-12T21:18:48.218Z,1531430328.218 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2018-07-12T21:18:48.611Z,1531430328.611 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2018-07-12T21:18:49.016Z,1531430329.016 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2018-07-12T21:18:49.436Z,1531430329.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2018-07-12T21:18:49.839Z,1531430329.839 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2018-07-12T21:18:50.219Z,1531430330.219 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2018-07-12T21:18:50.652Z,1531430330.652 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2018-07-12T21:18:51.010Z,1531430331.010 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2018-07-12T21:18:51.408Z,1531430331.408 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2018-07-12T21:18:51.818Z,1531430331.818 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2018-07-12T21:18:52.220Z,1531430332.220 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2018-07-12T21:18:52.614Z,1531430332.614 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2018-07-12T21:18:53.032Z,1531430333.032 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2018-07-12T21:18:53.420Z,1531430333.420 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2018-07-12T21:18:53.816Z,1531430333.816 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2018-07-12T21:18:54.216Z,1531430334.216 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2018-07-12T21:18:54.615Z,1531430334.615 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2018-07-12T21:18:55.021Z,1531430335.021 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2018-07-12T21:18:55.436Z,1531430335.436 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2018-07-12T21:18:55.841Z,1531430335.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2018-07-12T21:18:56.230Z,1531430336.230 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2018-07-12T21:18:56.622Z,1531430336.622 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2018-07-12T21:18:57.051Z,1531430337.051 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2018-07-12T21:18:57.397Z,1531430337.397 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2018-07-12T21:18:57.832Z,1531430337.832 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2018-07-12T21:18:58.223Z,1531430338.223 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2018-07-12T21:18:58.658Z,1531430338.658 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2018-07-12T21:18:59.027Z,1531430339.027 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2018-07-12T21:18:59.400Z,1531430339.400 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2018-07-12T21:18:59.837Z,1531430339.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2018-07-12T21:19:00.243Z,1531430340.243 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2018-07-12T21:19:00.638Z,1531430340.638 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2018-07-12T21:19:01.041Z,1531430341.041 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2018-07-12T21:19:01.437Z,1531430341.437 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2018-07-12T21:19:01.820Z,1531430341.820 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2018-07-12T21:19:02.209Z,1531430342.209 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2018-07-12T21:19:02.606Z,1531430342.606 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2018-07-12T21:19:03.025Z,1531430343.025 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2018-07-12T21:19:03.408Z,1531430343.408 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2018-07-12T21:19:03.821Z,1531430343.821 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2018-07-12T21:19:04.224Z,1531430344.224 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2018-07-12T21:19:04.616Z,1531430344.616 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2018-07-12T21:19:15.293Z,1531430355.293 [CommandLine](IMPORTANT): got command quit
2018-07-12T21:19:16.300Z,1531430356.300 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:16.300Z,1531430356.300 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.409Z,1531430356.409 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-07-12T21:19:16.409Z,1531430356.409 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.410Z,1531430356.410 [CommandLine](INFO): Join timeout helper Thread ID is 1038
2018-07-12T21:19:16.417Z,1531430356.417 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-07-12T21:19:16.417Z,1531430356.417 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.417Z,1531430356.417 [NavChartDb](INFO): Join timeout helper Thread ID is 1039
2018-07-12T21:19:16.557Z,1531430356.557 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:16.557Z,1531430356.557 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.565Z,1531430356.565 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-07-12T21:19:16.565Z,1531430356.565 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.566Z,1531430356.566 [Radio_Surface](INFO): Join timeout helper Thread ID is 1040
2018-07-12T21:19:16.881Z,1531430356.881 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:16.881Z,1531430356.881 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.889Z,1531430356.889 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-07-12T21:19:16.889Z,1531430356.889 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:16.889Z,1531430356.889 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1041
2018-07-12T21:19:17.285Z,1531430357.285 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:17.285Z,1531430357.285 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-07-12T21:19:17.286Z,1531430357.286 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.293Z,1531430357.293 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-07-12T21:19:17.293Z,1531430357.293 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.293Z,1531430357.293 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1042
2018-07-12T21:19:17.321Z,1531430357.321 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:17.321Z,1531430357.321 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.334Z,1531430357.334 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-07-12T21:19:17.334Z,1531430357.334 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.334Z,1531430357.334 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1043
2018-07-12T21:19:17.466Z,1531430357.466 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:17.467Z,1531430357.467 [CTD_NeilBrown](INFO): Powering down
2018-07-12T21:19:17.467Z,1531430357.467 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.474Z,1531430357.474 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-07-12T21:19:17.474Z,1531430357.474 [logger ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.474Z,1531430357.474 [logger](INFO): Join timeout helper Thread ID is 1044
2018-07-12T21:19:17.525Z,1531430357.525 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:17.525Z,1531430357.525 [logger ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.533Z,1531430357.533 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-07-12T21:19:17.534Z,1531430357.534 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.534Z,1531430357.534 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-07-12T21:19:17.534Z,1531430357.534 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.534Z,1531430357.534 [controlThread](INFO): Join timeout helper Thread ID is 1045
2018-07-12T21:19:17.587Z,1531430357.587 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-07-12T21:19:17.588Z,1531430357.588 [controlThread](DEBUG): Uninitializing ControlThread
2018-07-12T21:19:17.588Z,1531430357.588 [Aanderaa_O2](INFO): Powering down
2018-07-12T21:19:17.589Z,1531430357.589 [AHRS_M2](INFO): Powering down
2018-07-12T21:19:17.662Z,1531430357.662 [NAL9602](INFO): Powering down
2018-07-12T21:19:17.733Z,1531430357.733 [RDI_Pathfinder](INFO): Powering down
2018-07-12T21:19:17.735Z,1531430357.735 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-07-12T21:19:17.736Z,1531430357.736 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-07-12T21:19:17.737Z,1531430357.737 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-07-12T21:19:17.738Z,1531430357.738 [MissionManager](INFO): Uninitializing Mission Default
2018-07-12T21:19:17.738Z,1531430357.738 [Default] Stopped
2018-07-12T21:19:17.738Z,1531430357.738 [Default](DEBUG): Aggregate::uninitialize Default
2018-07-12T21:19:17.738Z,1531430357.738 [Default:B.GoToSurface] Stopped
2018-07-12T21:19:17.738Z,1531430357.738 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-07-12T21:19:17.738Z,1531430357.738 [Default:CheckIn] Stopped
2018-07-12T21:19:17.738Z,1531430357.738 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-07-12T21:19:17.738Z,1531430357.738 [Default:CheckIn:Read_GPS] Stopped
2018-07-12T21:19:17.742Z,1531430357.742 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-07-12T21:19:17.742Z,1531430357.742 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-07-12T21:19:17.742Z,1531430357.742 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-07-12T21:19:17.742Z,1531430357.742 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-07-12T21:19:17.743Z,1531430357.743 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-07-12T21:19:17.743Z,1531430357.743 [BuoyancyServo](INFO): Powering down
2018-07-12T21:19:17.757Z,1531430357.757 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-07-12T21:19:17.757Z,1531430357.757 [ElevatorServo](INFO): Powering down
2018-07-12T21:19:17.758Z,1531430357.758 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-07-12T21:19:17.758Z,1531430357.758 [MassServo](INFO): Powering down
2018-07-12T21:19:17.759Z,1531430357.759 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-07-12T21:19:17.759Z,1531430357.759 [RudderServo](INFO): Powering down
2018-07-12T21:19:17.760Z,1531430357.760 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-07-12T21:19:17.760Z,1531430357.760 [ThrusterServo](INFO): Powering down
2018-07-12T21:19:17.761Z,1531430357.761 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-07-12T21:19:17.761Z,1531430357.761 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-07-12T21:19:17.762Z,1531430357.762 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-07-12T21:19:17.763Z,1531430357.763 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.821Z,1531430357.821 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.824Z,1531430357.824 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.827Z,1531430357.827 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.886Z,1531430357.886 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.928Z,1531430357.928 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-07-12T21:19:17.983Z,1531430357.983 [logger ThreadHandler](INFO): Thread cancelled.