2018-10-19T21:22:05.097Z,1539984125.097 [Supervisor](DEBUG): Initializing supervisor.
2018-10-19T21:22:05.099Z,1539984125.099 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-10-19T21:22:05.100Z,1539984125.100 [SyncHandler](INFO): Protected caller Thread ID is 3409
2018-10-19T21:22:05.100Z,1539984125.100 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-10-19T21:22:05.101Z,1539984125.101 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-10-19T21:22:05.102Z,1539984125.102 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3410
2018-10-19T21:22:05.104Z,1539984125.104 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-10-19T21:22:05.116Z,1539984125.116 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-10-19T21:22:05.117Z,1539984125.117 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-10-19T21:22:05.117Z,1539984125.117 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3411
2018-10-19T21:22:05.118Z,1539984125.118 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-10-19T21:22:05.119Z,1539984125.119 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-10-19T21:22:05.119Z,1539984125.119 [logger ThreadHandler](INFO): Protected caller Thread ID is 3412
2018-10-19T21:22:05.121Z,1539984125.121 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-10-19T21:22:05.122Z,1539984125.122 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-10-19T21:22:05.123Z,1539984125.123 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-10-19T21:22:05.559Z,1539984125.559 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-10-19T21:22:05.559Z,1539984125.559 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-10-19T21:22:06.003Z,1539984126.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-10-19T21:22:06.003Z,1539984126.003 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-10-19T21:22:06.196Z,1539984126.196 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-10-19T21:22:06.196Z,1539984126.196 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-10-19T21:22:06.340Z,1539984126.340 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-10-19T21:22:06.341Z,1539984126.341 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-10-19T21:22:06.776Z,1539984126.776 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-10-19T21:22:06.777Z,1539984126.777 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-10-19T21:22:06.872Z,1539984126.872 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-10-19T21:22:06.872Z,1539984126.872 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-10-19T21:22:07.012Z,1539984127.012 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-10-19T21:22:07.013Z,1539984127.013 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-10-19T21:22:07.112Z,1539984127.112 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-10-19T21:22:07.113Z,1539984127.113 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-10-19T21:22:07.215Z,1539984127.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-10-19T21:22:07.216Z,1539984127.216 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-10-19T21:22:07.557Z,1539984127.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-10-19T21:22:07.558Z,1539984127.558 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-10-19T21:22:07.758Z,1539984127.758 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-10-19T21:22:07.758Z,1539984127.758 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-10-19T21:22:08.101Z,1539984128.101 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-10-19T21:22:08.102Z,1539984128.102 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-10-19T21:22:08.182Z,1539984128.182 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-10-19T21:22:08.998Z,1539984128.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-10-19T21:22:08.998Z,1539984128.998 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-10-19T21:22:09.313Z,1539984129.313 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-10-19T21:22:09.315Z,1539984129.315 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2018-10-19T21:22:09.316Z,1539984129.316 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2018-10-19T21:22:09.400Z,1539984129.400 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2018-10-19T21:22:09.548Z,1539984129.548 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2018-10-19T21:22:09.646Z,1539984129.646 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2018-10-19T21:22:09.816Z,1539984129.816 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2018-10-19T21:22:09.898Z,1539984129.898 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2018-10-19T21:22:10.121Z,1539984130.121 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-10-19T21:22:10.121Z,1539984130.121 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2018-10-19T21:22:10.234Z,1539984130.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2018-10-19T21:22:10.333Z,1539984130.333 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2018-10-19T21:22:10.427Z,1539984130.427 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2018-10-19T21:22:10.529Z,1539984130.529 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2018-10-19T21:22:10.640Z,1539984130.640 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2018-10-19T21:22:10.640Z,1539984130.640 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-10-19T21:22:10.643Z,1539984130.643 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-10-19T21:22:10.687Z,1539984130.687 [DepthRateCalculator] Loaded
2018-10-19T21:22:10.687Z,1539984130.687 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-10-19T21:22:10.693Z,1539984130.693 [PitchRateCalculator] Loaded
2018-10-19T21:22:10.693Z,1539984130.693 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-10-19T21:22:10.709Z,1539984130.709 [SpeedCalculator] Loaded
2018-10-19T21:22:10.709Z,1539984130.709 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-10-19T21:22:10.730Z,1539984130.730 [TempGradientCalculator] Loaded
2018-10-19T21:22:10.730Z,1539984130.730 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-10-19T21:22:10.736Z,1539984130.736 [YawRateCalculator] Loaded
2018-10-19T21:22:10.736Z,1539984130.736 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-10-19T21:22:10.776Z,1539984130.776 [ElevatorOffsetCalculator] Loaded
2018-10-19T21:22:10.776Z,1539984130.776 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-10-19T21:22:10.777Z,1539984130.777 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-10-19T21:22:10.777Z,1539984130.777 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-10-19T21:22:11.019Z,1539984131.019 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-10-19T21:22:11.020Z,1539984131.020 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-10-19T21:22:11.319Z,1539984131.319 [DataOverHttps] Loaded
2018-10-19T21:22:11.320Z,1539984131.320 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-10-19T21:22:11.344Z,1539984131.344 [Depth_Keller] Loaded
2018-10-19T21:22:11.344Z,1539984131.344 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-10-19T21:22:11.349Z,1539984131.349 [DropWeight] Loaded
2018-10-19T21:22:11.349Z,1539984131.349 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-10-19T21:22:11.447Z,1539984131.447 [NAL9602] Loaded
2018-10-19T21:22:11.447Z,1539984131.447 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-10-19T21:22:11.463Z,1539984131.463 [Onboard] Loaded
2018-10-19T21:22:11.463Z,1539984131.463 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-10-19T21:22:11.473Z,1539984131.473 [Radio_Surface] Loaded
2018-10-19T21:22:11.474Z,1539984131.474 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-10-19T21:22:11.475Z,1539984131.475 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C34E0
2018-10-19T21:22:11.475Z,1539984131.475 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3491
2018-10-19T21:22:11.482Z,1539984131.482 [SCPI] Loaded
2018-10-19T21:22:11.482Z,1539984131.482 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-10-19T21:22:13.246Z,1539984133.246 [BPC1] Loaded
2018-10-19T21:22:13.246Z,1539984133.246 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-10-19T21:22:13.246Z,1539984133.246 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-10-19T21:22:13.247Z,1539984133.247 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-10-19T21:22:13.453Z,1539984133.453 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-10-19T21:22:13.457Z,1539984133.457 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-10-19T21:22:13.773Z,1539984133.773 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-10-19T21:22:13.773Z,1539984133.773 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-10-19T21:22:13.931Z,1539984133.931 [DeadReckonUsingSpeedCalculator] Loaded
2018-10-19T21:22:13.931Z,1539984133.931 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-10-19T21:22:13.976Z,1539984133.976 [NavChart] Loaded
2018-10-19T21:22:13.976Z,1539984133.976 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-10-19T21:22:14.003Z,1539984134.003 [UniversalFixResidualReporter] Loaded
2018-10-19T21:22:14.003Z,1539984134.003 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-10-19T21:22:14.003Z,1539984134.003 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-10-19T21:22:14.004Z,1539984134.004 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-10-19T21:22:14.229Z,1539984134.229 [CTD_NeilBrown] Loaded
2018-10-19T21:22:14.229Z,1539984134.229 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-10-19T21:22:14.230Z,1539984134.230 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408CE4E0
2018-10-19T21:22:14.230Z,1539984134.230 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3492
2018-10-19T21:22:14.286Z,1539984134.286 [CTD_Seabird] Loaded
2018-10-19T21:22:14.286Z,1539984134.286 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-10-19T21:22:14.287Z,1539984134.287 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0
2018-10-19T21:22:14.287Z,1539984134.287 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3493
2018-10-19T21:22:14.336Z,1539984134.336 [WetLabsBB2FL] Loaded
2018-10-19T21:22:14.336Z,1539984134.336 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-10-19T21:22:14.337Z,1539984134.337 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4092E4E0
2018-10-19T21:22:14.338Z,1539984134.338 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3494
2018-10-19T21:22:14.338Z,1539984134.338 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-10-19T21:22:14.339Z,1539984134.339 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-10-19T21:22:14.409Z,1539984134.409 [VerticalControl](DEBUG): Construct VerticalControl.
2018-10-19T21:22:14.509Z,1539984134.509 [VerticalControl] Loaded
2018-10-19T21:22:14.509Z,1539984134.509 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-10-19T21:22:14.510Z,1539984134.510 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-10-19T21:22:14.577Z,1539984134.577 [HorizontalControl] Loaded
2018-10-19T21:22:14.578Z,1539984134.578 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-10-19T21:22:14.578Z,1539984134.578 [SpeedControl](DEBUG): Construct SpeedControl.
2018-10-19T21:22:14.583Z,1539984134.583 [SpeedControl] Loaded
2018-10-19T21:22:14.584Z,1539984134.584 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-10-19T21:22:14.584Z,1539984134.584 [LoopControl](DEBUG): Construct LoopControl.
2018-10-19T21:22:14.585Z,1539984134.585 [LoopControl] Loaded
2018-10-19T21:22:14.585Z,1539984134.585 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-10-19T21:22:14.585Z,1539984134.585 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-10-19T21:22:14.586Z,1539984134.586 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-10-19T21:22:14.599Z,1539984134.599 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-10-19T21:22:14.600Z,1539984134.600 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-10-19T21:22:14.732Z,1539984134.732 [SBIT](DEBUG): Construct Startup Built In Test.
2018-10-19T21:22:14.743Z,1539984134.743 [SBIT] Loaded
2018-10-19T21:22:14.743Z,1539984134.743 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-10-19T21:22:14.744Z,1539984134.744 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-10-19T21:22:14.755Z,1539984134.755 [IBIT] Loaded
2018-10-19T21:22:14.756Z,1539984134.756 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-10-19T21:22:14.759Z,1539984134.759 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-10-19T21:22:14.909Z,1539984134.909 [CBIT] Loaded
2018-10-19T21:22:14.909Z,1539984134.909 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-10-19T21:22:14.909Z,1539984134.909 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-10-19T21:22:14.910Z,1539984134.910 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-10-19T21:22:15.012Z,1539984135.012 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-10-19T21:22:15.013Z,1539984135.013 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-10-19T21:22:15.038Z,1539984135.038 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-10-19T21:22:15.038Z,1539984135.038 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-10-19T21:22:15.138Z,1539984135.138 [BuoyancyServo] Loaded
2018-10-19T21:22:15.138Z,1539984135.138 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-10-19T21:22:15.150Z,1539984135.150 [ElevatorServo] Loaded
2018-10-19T21:22:15.150Z,1539984135.150 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-10-19T21:22:15.161Z,1539984135.161 [MassServo] Loaded
2018-10-19T21:22:15.161Z,1539984135.161 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-10-19T21:22:15.172Z,1539984135.172 [RudderServo] Loaded
2018-10-19T21:22:15.173Z,1539984135.173 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-10-19T21:22:15.183Z,1539984135.183 [ThrusterServo] Loaded
2018-10-19T21:22:15.183Z,1539984135.183 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-10-19T21:22:15.184Z,1539984135.184 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-10-19T21:22:15.187Z,1539984135.187 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-10-19T21:22:15.188Z,1539984135.188 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-10-19T21:22:15.195Z,1539984135.195 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-10-19T21:22:15.196Z,1539984135.196 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0
2018-10-19T21:22:15.196Z,1539984135.196 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3495
2018-10-19T21:22:15.201Z,1539984135.201 [Supervisor](INFO): Main Thread ID is 3042
2018-10-19T21:22:15.201Z,1539984135.201 [Supervisor](DEBUG): Running supervisor.
2018-10-19T21:22:15.202Z,1539984135.202 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3496
2018-10-19T21:22:15.204Z,1539984135.204 [controlThread ThreadHandler](INFO): Handler Thread ID is 3497
2018-10-19T21:22:15.205Z,1539984135.205 [controlThread](DEBUG): Initializing ControlThread
2018-10-19T21:22:15.205Z,1539984135.205 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-10-19T21:22:15.206Z,1539984135.206 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-10-19T21:22:15.206Z,1539984135.206 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-10-19T21:22:15.207Z,1539984135.207 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-10-19T21:22:15.207Z,1539984135.207 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-10-19T21:22:15.207Z,1539984135.207 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-10-19T21:22:15.212Z,1539984135.212 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:22:15.213Z,1539984135.213 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:22:15.213Z,1539984135.213 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:22:15.214Z,1539984135.214 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:22:15.214Z,1539984135.214 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:22:15.214Z,1539984135.214 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:22:15.215Z,1539984135.215 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-10-19T21:22:15.215Z,1539984135.215 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-10-19T21:22:15.215Z,1539984135.215 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-10-19T21:22:15.217Z,1539984135.217 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-10-19T21:22:15.218Z,1539984135.218 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-10-19T21:22:15.218Z,1539984135.218 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-10-19T21:22:15.219Z,1539984135.219 [SBIT](INFO): Initialize SBIT Component.
2018-10-19T21:22:15.219Z,1539984135.219 [SBIT](IMPORTANT): git: 2018-10-09-31-g8f1ca26
2018-10-19T21:22:15.219Z,1539984135.219 [SBIT](INFO): git hash: 8f1ca2616133f591d84f59109522710795260801
2018-10-19T21:22:15.220Z,1539984135.220 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-10-19T21:22:15.220Z,1539984135.220 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-10-19T21:22:15.221Z,1539984135.221 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2018-10-19T21:22:15.222Z,1539984135.222 [IBIT](INFO): Initialize IBIT Component.
2018-10-19T21:22:15.222Z,1539984135.222 [CBIT](DEBUG): Initialize CBIT Component.
2018-10-19T21:22:15.223Z,1539984135.223 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-10-19T21:22:15.224Z,1539984135.224 [logger ThreadHandler](INFO): Handler Thread ID is 3498
2018-10-19T21:22:15.241Z,1539984135.241 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3499
2018-10-19T21:22:15.247Z,1539984135.247 [Radio_Surface](INFO): Powering up
2018-10-19T21:22:15.253Z,1539984135.253 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3500
2018-10-19T21:22:15.265Z,1539984135.265 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3501
2018-10-19T21:22:15.266Z,1539984135.266 [CTD_Seabird](INFO): Initializing
2018-10-19T21:22:15.266Z,1539984135.266 [CTD_Seabird](INFO): Checking LCM
2018-10-19T21:22:15.275Z,1539984135.275 [CTD_Seabird](INFO): LCM OK
2018-10-19T21:22:15.275Z,1539984135.275 [CTD_Seabird](INFO): Powering up
2018-10-19T21:22:15.285Z,1539984135.285 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3502
2018-10-19T21:22:15.287Z,1539984135.287 [WetLabsBB2FL](INFO): Powering down
2018-10-19T21:22:15.317Z,1539984135.317 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3503
2018-10-19T21:22:15.320Z,1539984135.320 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-10-19T21:22:15.320Z,1539984135.320 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-10-19T21:22:15.321Z,1539984135.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-10-19T21:22:15.321Z,1539984135.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-10-19T21:22:15.321Z,1539984135.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-10-19T21:22:15.321Z,1539984135.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-10-19T21:22:15.321Z,1539984135.321 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-10-19T21:22:15.321Z,1539984135.321 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-10-19T21:22:15.322Z,1539984135.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-10-19T21:22:15.322Z,1539984135.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-10-19T21:22:15.322Z,1539984135.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-10-19T21:22:15.322Z,1539984135.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-10-19T21:22:15.322Z,1539984135.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-10-19T21:22:15.323Z,1539984135.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-10-19T21:22:15.323Z,1539984135.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-10-19T21:22:15.323Z,1539984135.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-10-19T21:22:15.331Z,1539984135.331 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-10-19T21:22:15.342Z,1539984135.342 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-10-19T21:22:15.365Z,1539984135.365 [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-10-19T21:22:15.366Z,1539984135.366 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-10-19T21:22:15.436Z,1539984135.436 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-10-19T21:22:15.454Z,1539984135.454 [Default:A.Wait](DEBUG): Construct Wait.
2018-10-19T21:22:15.455Z,1539984135.455 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-10-19T21:22:15.492Z,1539984135.492 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-10-19T21:22:15.494Z,1539984135.494 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-10-19T21:22:15.520Z,1539984135.520 [Default:E.Execute](DEBUG): Construct Execute.
2018-10-19T21:22:15.523Z,1539984135.523 [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-10-19T21:22:15.528Z,1539984135.528 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:22:15.549Z,1539984135.549 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-10-19T21:22:15.558Z,1539984135.558 [Depth_Keller](ERROR): Pressure reading out of range: 1624.131348 decibar
2018-10-19T21:22:15.644Z,1539984135.644 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:22:15.644Z,1539984135.644 [Onboard](FAULT): Can't read temperature LSB.
2018-10-19T21:22:15.644Z,1539984135.644 [Onboard] Hardware Fault, FailCount= 1
2018-10-19T21:22:15.644Z,1539984135.644 [Onboard](ERROR): Hardware Fault
2018-10-19T21:22:15.649Z,1539984135.649 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:22:15.650Z,1539984135.650 [Onboard](FAULT): Can't read temperature MSB.
2018-10-19T21:22:15.650Z,1539984135.650 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:22:15.650Z,1539984135.650 [Onboard](FAULT): Can't read pressure LSB.
2018-10-19T21:22:15.651Z,1539984135.651 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:22:15.651Z,1539984135.651 [Onboard](FAULT): Can't read pressure MSB.
2018-10-19T21:22:15.741Z,1539984135.741 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-10-19T21:22:15.965Z,1539984135.965 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:22:15.973Z,1539984135.973 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-10-19T21:22:15.987Z,1539984135.987 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:22:15.993Z,1539984135.993 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-10-19T21:22:15.999Z,1539984135.999 [MassServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:22:16.005Z,1539984136.005 [MassServo](DEBUG): Initializing MassServo.
2018-10-19T21:22:16.018Z,1539984136.018 [RudderServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:22:16.025Z,1539984136.025 [RudderServo](DEBUG): Initializing RudderServo.
2018-10-19T21:22:16.039Z,1539984136.039 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:22:16.045Z,1539984136.045 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-10-19T21:22:16.089Z,1539984136.089 [CBIT](ERROR): Hardware Fault in component: Onboard
2018-10-19T21:22:16.090Z,1539984136.090 [CBIT](CRITICAL): Hardware Fault in component: Onboard
2018-10-19T21:22:16.183Z,1539984136.183 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-10-19T21:22:16.183Z,1539984136.183 [DropWeight] Hardware Fault, FailCount= 1
2018-10-19T21:22:16.183Z,1539984136.183 [DropWeight](ERROR): Hardware Fault
2018-10-19T21:22:16.192Z,1539984136.192 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-10-19T21:22:16.236Z,1539984136.236 [CommandLine](FAULT): Scheduling is paused
2018-10-19T21:22:16.237Z,1539984136.237 [CBIT](INFO): Critical error at 20181019T212216
2018-10-19T21:22:16.237Z,1539984136.237 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-10-19T21:22:16.239Z,1539984136.239 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-10-19T21:22:16.240Z,1539984136.240 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-10-19T21:22:16.869Z,1539984136.869 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2018-10-19T21:22:16.869Z,1539984136.869 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2018-10-19T21:22:16.869Z,1539984136.869 [BuoyancyServo] Communications Fault, FailCount= 1
2018-10-19T21:22:16.869Z,1539984136.869 [BuoyancyServo](ERROR): Communications Fault
2018-10-19T21:22:17.079Z,1539984137.079 [CBIT](INFO): Critical error at 20181019T212216
2018-10-19T21:22:17.081Z,1539984137.081 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2018-10-19T21:22:17.142Z,1539984137.142 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-10-19T21:22:17.143Z,1539984137.143 [BuoyancyServo](INFO): Powering down
2018-10-19T21:22:19.625Z,1539984139.625 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-10-19T21:22:19.625Z,1539984139.625 [BuoyancyServo] No Fault, FailCount= 1
2018-10-19T21:22:19.907Z,1539984139.907 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:22:20.026Z,1539984140.026 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-10-19T21:22:20.729Z,1539984140.729 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-10-19T21:22:20.903Z,1539984140.903 [Radio_Surface](INFO): Powering down
2018-10-19T21:22:21.051Z,1539984141.051 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null &
2018-10-19T21:22:21.073Z,1539984141.073 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd
2018-10-19T21:22:21.393Z,1539984141.393 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-10-19T21:22:21.393Z,1539984141.393 [CTD_Seabird](INFO): Powering down
2018-10-19T21:22:25.226Z,1539984145.226 [CBIT](CRITICAL): Environmental Failure. Press:0.000000 PSI. Humidity:2139112%. Temp:4842728 C. ABORTING MISSION
2018-10-19T21:22:25.616Z,1539984145.616 [CBIT](INFO): Critical error at 20181019T212225
2018-10-19T21:22:41.565Z,1539984161.565 [NAL9602](INFO): Powering up NAL9602
2018-10-19T21:22:43.993Z,1539984163.993 [SBIT](IMPORTANT): Beginning Startup BIT
2018-10-19T21:22:43.998Z,1539984163.998 [CBIT](IMPORTANT): Beginning ground fault scan
2018-10-19T21:22:52.446Z,1539984172.446 [NAL9602](INFO): NAL9602 initialized
2018-10-19T21:22:54.937Z,1539984174.937 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008015
CHAN A1 (24V): 0.001633
CHAN A2 (12V): -0.005397
CHAN A3 (5V): -0.002933
CHAN B0 (3.3V): -0.000922
CHAN B1 (3.15aV): -0.001264
CHAN B2 (3.15bV): -0.001178
CHAN B3 (GND): -0.000245
OPEN: -0.001284
Full Scale Calc: 4.765 mA, -1.589 mA
2018-10-19T21:23:29.113Z,1539984209.113 [BPC1](ERROR): BPC1A: No match for serial number 0211 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2018-10-19T21:23:29.115Z,1539984209.115 [BPC1](ERROR): BPC1B: No match for serial number 01E9 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2018-10-19T21:23:29.115Z,1539984209.115 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-10-19T21:23:29.115Z,1539984209.115 [BPC1] Data Fault, FailCount= 1
2018-10-19T21:23:29.115Z,1539984209.115 [BPC1](ERROR): Data Fault
2018-10-19T21:23:29.410Z,1539984209.410 [CBIT](ERROR): Data Fault in component: BPC1
2018-10-19T21:23:37.947Z,1539984217.947 [SBIT](IMPORTANT): SBIT PASSED
2018-10-19T21:23:37.975Z,1539984217.975 [CommandLine](IMPORTANT): got command configSet list
2018-10-19T21:23:37.975Z,1539984217.975 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-10-19T21:23:37.976Z,1539984217.976 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2018-10-19T21:23:38.318Z,1539984218.318 [MissionManager](IMPORTANT): Started mission Startup
2018-10-19T21:23:38.319Z,1539984218.319 [Startup] Running Loop=1
2018-10-19T21:23:38.319Z,1539984218.319 [Startup](DEBUG): Aggregate::initialize Startup
2018-10-19T21:23:38.319Z,1539984218.319 [Startup:A.GoToSurface] Running Loop=1
2018-10-19T21:23:38.319Z,1539984218.319 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-19T21:23:38.320Z,1539984218.320 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-19T21:23:38.320Z,1539984218.320 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-19T21:23:38.320Z,1539984218.320 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-19T21:23:38.321Z,1539984218.321 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-19T21:23:38.321Z,1539984218.321 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-19T21:23:38.617Z,1539984218.617 [Radio_Surface](INFO): Powering up
2018-10-19T21:23:54.227Z,1539984234.227 [CommandLine](IMPORTANT): got command get DVL_micro.loadAtStartup
2018-10-19T21:23:54.227Z,1539984234.227 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup 0 bool
2018-10-19T21:24:15.529Z,1539984255.529 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:24:15.529Z,1539984255.529 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2018-10-19T21:24:15.529Z,1539984255.529 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:24:15.530Z,1539984255.530 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:24:15.531Z,1539984255.531 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-10-19T21:24:15.531Z,1539984255.531 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:24:15.579Z,1539984255.579 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:24:15.579Z,1539984255.579 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:24:15.949Z,1539984255.949 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:24:15.949Z,1539984255.949 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2018-10-19T21:24:15.950Z,1539984255.950 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:24:15.950Z,1539984255.950 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-10-19T21:24:16.324Z,1539984256.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:24:16.325Z,1539984256.325 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:24:16.325Z,1539984256.325 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:24:16.326Z,1539984256.326 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:24:16.326Z,1539984256.326 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:24:16.327Z,1539984256.327 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:24:41.079Z,1539984281.079 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004359
2018-10-19T21:25:05.484Z,1539984305.484 [Startup:StartupSatComms] Running Loop=1
2018-10-19T21:25:05.484Z,1539984305.484 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-10-19T21:25:05.484Z,1539984305.484 [Startup:StartupSatComms:A] Running Loop=1
2018-10-19T21:25:05.907Z,1539984305.907 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-10-19T21:26:05.844Z,1539984365.844 [Startup:StartupSatComms:A](INFO): Timed out from 2018-10-19T21:25:05.5Z
2018-10-19T21:26:05.844Z,1539984365.844 [Startup:StartupSatComms:A] Stopped
2018-10-19T21:26:05.844Z,1539984365.844 [Startup:StartupSatComms:B] Running Loop=1
2018-10-19T21:26:06.243Z,1539984366.243 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-10-19T21:26:10.991Z,1539984370.991 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181019T195116/Courier0022.lzma
2018-10-19T21:26:11.787Z,1539984371.787 [DataOverHttps](INFO): Moved sent file to Logs/20181019T195116/Courier0022.lzma.bak
2018-10-19T21:26:11.787Z,1539984371.787 [DataOverHttps](INFO): SBD MOMSN=8740818
2018-10-19T21:26:16.502Z,1539984376.502 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:26:16.502Z,1539984376.502 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2018-10-19T21:26:16.502Z,1539984376.502 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:26:16.504Z,1539984376.504 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:26:16.504Z,1539984376.504 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-10-19T21:26:16.504Z,1539984376.504 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:26:16.569Z,1539984376.569 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:26:16.569Z,1539984376.569 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:26:16.641Z,1539984376.641 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:26:16.641Z,1539984376.641 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2018-10-19T21:26:16.642Z,1539984376.642 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:26:16.642Z,1539984376.642 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-10-19T21:26:17.004Z,1539984377.004 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:26:17.005Z,1539984377.005 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:26:17.005Z,1539984377.005 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:26:17.005Z,1539984377.005 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:26:17.006Z,1539984377.006 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:26:17.006Z,1539984377.006 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:26:21.350Z,1539984381.350 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20181019T212205/Courier0000.lzma
2018-10-19T21:26:22.124Z,1539984382.124 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Courier0000.lzma.bak
2018-10-19T21:26:22.124Z,1539984382.124 [DataOverHttps](INFO): SBD MOMSN=8740824
2018-10-19T21:26:31.599Z,1539984391.599 [DataOverHttps](INFO): Sending 724 bytes from file Logs/20181019T195116/Express0023.lzma
2018-10-19T21:26:32.399Z,1539984392.399 [DataOverHttps](INFO): Moved sent file to Logs/20181019T195116/Express0023.lzma.bak
2018-10-19T21:26:32.399Z,1539984392.399 [DataOverHttps](INFO): SBD MOMSN=8740831
2018-10-19T21:26:42.800Z,1539984402.800 [DataOverHttps](INFO): Sending 1094 bytes from file Logs/20181019T212205/Express0001.lzma
2018-10-19T21:26:43.598Z,1539984403.598 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Express0001.lzma.bak
2018-10-19T21:26:43.599Z,1539984403.599 [DataOverHttps](INFO): SBD MOMSN=8740862
2018-10-19T21:26:44.043Z,1539984404.043 [Startup:StartupSatComms:B] Stopped
2018-10-19T21:26:44.043Z,1539984404.043 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-10-19T21:26:44.043Z,1539984404.043 [Startup:StartupSatComms] Stopped
2018-10-19T21:26:44.043Z,1539984404.043 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-10-19T21:26:44.044Z,1539984404.044 [Startup](INFO): Completed Startup
2018-10-19T21:26:44.044Z,1539984404.044 [MissionManager](INFO): Startup is completed.
2018-10-19T21:26:44.044Z,1539984404.044 [MissionManager](INFO): Uninitializing Mission Startup
2018-10-19T21:26:44.044Z,1539984404.044 [Startup] Stopped
2018-10-19T21:26:44.044Z,1539984404.044 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-10-19T21:26:44.044Z,1539984404.044 [Startup:A.GoToSurface] Stopped
2018-10-19T21:26:44.045Z,1539984404.045 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-19T21:26:44.411Z,1539984404.411 [MissionManager](IMPORTANT): Started mission Default
2018-10-19T21:26:44.411Z,1539984404.411 [Default] Running Loop=1
2018-10-19T21:26:44.411Z,1539984404.411 [Default](DEBUG): Aggregate::initialize Default
2018-10-19T21:26:44.411Z,1539984404.411 [Default:B.GoToSurface] Running Loop=1
2018-10-19T21:26:44.412Z,1539984404.412 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-19T21:26:44.412Z,1539984404.412 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-19T21:26:44.412Z,1539984404.412 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-19T21:26:44.412Z,1539984404.412 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-19T21:26:44.413Z,1539984404.413 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-19T21:26:44.413Z,1539984404.413 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-19T21:26:44.414Z,1539984404.414 [Default:A.Wait] Running Loop=1
2018-10-19T21:26:44.414Z,1539984404.414 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-10-19T21:26:57.583Z,1539984417.583 [Default:A.Wait](INFO): Done Waiting.
2018-10-19T21:26:57.584Z,1539984417.584 [Default:A.Wait] Stopped
2018-10-19T21:26:57.584Z,1539984417.584 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-10-19T21:26:57.980Z,1539984417.980 [Default:CheckIn] Running Loop=1
2018-10-19T21:26:57.980Z,1539984417.980 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-19T21:26:57.980Z,1539984417.980 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-19T21:26:58.387Z,1539984418.387 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-10-19T21:27:57.809Z,1539984477.809 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-10-19T21:28:04.585Z,1539984484.585 [CommandLine](IMPORTANT): got command failComponent
2018-10-19T21:28:04.586Z,1539984484.586 [CommandLine](IMPORTANT): Failed components:
2018-10-19T21:28:04.586Z,1539984484.586 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-10-19T21:28:04.586Z,1539984484.586 [CommandLine](IMPORTANT): Onboard: Hardware Fault
2018-10-19T21:28:04.587Z,1539984484.587 [CommandLine](IMPORTANT): BPC1: Data Fault
2018-10-19T21:28:17.059Z,1539984497.059 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:28:17.059Z,1539984497.059 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2018-10-19T21:28:17.059Z,1539984497.059 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:28:17.060Z,1539984497.060 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:28:17.061Z,1539984497.061 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-10-19T21:28:17.061Z,1539984497.061 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:28:17.076Z,1539984497.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:28:17.076Z,1539984497.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:28:17.472Z,1539984497.472 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:28:17.472Z,1539984497.472 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2018-10-19T21:28:17.473Z,1539984497.473 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:28:17.473Z,1539984497.473 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-10-19T21:28:17.875Z,1539984497.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:28:17.876Z,1539984497.876 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:28:17.876Z,1539984497.876 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:28:17.876Z,1539984497.876 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:28:17.877Z,1539984497.877 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:28:17.877Z,1539984497.877 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:28:47.231Z,1539984527.231 [CommandLine](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15.000000 degree
2018-10-19T21:28:47.232Z,1539984527.232 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread.
2018-10-19T21:28:47.523Z,1539984527.523 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:29:10.318Z,1539984550.318 [CommandLine](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15.000000 degree
2018-10-19T21:29:24.010Z,1539984564.010 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:29:24.303Z,1539984564.303 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:30:19.314Z,1539984619.314 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:30:19.314Z,1539984619.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2018-10-19T21:30:19.314Z,1539984619.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:30:19.316Z,1539984619.316 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:30:19.316Z,1539984619.316 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-10-19T21:30:19.316Z,1539984619.316 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:30:19.369Z,1539984619.369 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:30:19.370Z,1539984619.370 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:30:19.429Z,1539984619.429 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:30:19.429Z,1539984619.429 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2018-10-19T21:30:19.429Z,1539984619.429 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:30:19.430Z,1539984619.430 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-10-19T21:30:19.800Z,1539984619.800 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:30:19.801Z,1539984619.801 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:30:19.801Z,1539984619.801 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:30:19.802Z,1539984619.802 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:30:19.802Z,1539984619.802 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:30:19.802Z,1539984619.802 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:31:58.079Z,1539984718.079 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-10-19T21:26:57.0Z
2018-10-19T21:31:58.079Z,1539984718.079 [Default:CheckIn:Read_GPS] Stopped
2018-10-19T21:31:58.079Z,1539984718.079 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-10-19T21:31:58.479Z,1539984718.479 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-10-19T21:32:01.518Z,1539984721.518 [CommandLine](IMPORTANT): got command failComponent
2018-10-19T21:32:01.518Z,1539984721.518 [CommandLine](IMPORTANT): Failed components:
2018-10-19T21:32:01.518Z,1539984721.518 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2018-10-19T21:32:01.518Z,1539984721.518 [CommandLine](IMPORTANT): Onboard: Hardware Fault
2018-10-19T21:32:01.518Z,1539984721.518 [CommandLine](IMPORTANT): BPC1: Data Fault
2018-10-19T21:32:03.364Z,1539984723.364 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20181019T212205/Courier0004.lzma
2018-10-19T21:32:04.137Z,1539984724.137 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Courier0004.lzma.bak
2018-10-19T21:32:04.137Z,1539984724.137 [DataOverHttps](INFO): SBD MOMSN=8740926
2018-10-19T21:32:11.379Z,1539984731.379 [CommandLine](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15.000000 degree
2018-10-19T21:32:11.380Z,1539984731.380 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread.
2018-10-19T21:32:14.381Z,1539984734.381 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:32:14.419Z,1539984734.419 [DataOverHttps](INFO): Sending 436 bytes from file Logs/20181019T212205/Express0005.lzma
2018-10-19T21:32:15.193Z,1539984735.193 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Express0005.lzma.bak
2018-10-19T21:32:15.193Z,1539984735.193 [DataOverHttps](INFO): SBD MOMSN=8740928
2018-10-19T21:32:15.655Z,1539984735.655 [Default:CheckIn:Read_Iridium] Stopped
2018-10-19T21:32:15.655Z,1539984735.655 [Default:CheckIn:C.Wait] Running Loop=1
2018-10-19T21:32:15.655Z,1539984735.655 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-10-19T21:32:20.047Z,1539984740.047 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:32:20.047Z,1539984740.047 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2018-10-19T21:32:20.047Z,1539984740.047 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:32:20.050Z,1539984740.050 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:32:20.050Z,1539984740.050 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-10-19T21:32:20.050Z,1539984740.050 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:32:20.063Z,1539984740.063 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:32:20.064Z,1539984740.064 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:32:20.465Z,1539984740.465 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:32:20.465Z,1539984740.465 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2018-10-19T21:32:20.466Z,1539984740.466 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:32:20.466Z,1539984740.466 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-10-19T21:32:20.816Z,1539984740.816 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:32:20.817Z,1539984740.817 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:32:20.817Z,1539984740.817 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:32:20.818Z,1539984740.818 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:32:20.818Z,1539984740.818 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:32:20.818Z,1539984740.818 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:32:31.983Z,1539984751.983 [CommandLine](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15.000000 degree
2018-10-19T21:32:45.282Z,1539984765.282 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:32:45.662Z,1539984765.662 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:32:55.974Z,1539984775.974 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-10-19T21:32:55.974Z,1539984775.974 [NAL9602] Data Fault, FailCount= 1
2018-10-19T21:32:55.974Z,1539984775.974 [NAL9602](ERROR): Data Fault
2018-10-19T21:32:56.021Z,1539984776.021 [CBIT](ERROR): Data Fault in component: NAL9602
2018-10-19T21:32:56.374Z,1539984776.374 [NAL9602](INFO): Powering down
2018-10-19T21:32:57.212Z,1539984777.212 [CBIT](INFO): Clearing failed state for component NAL9602
2018-10-19T21:32:57.212Z,1539984777.212 [NAL9602] No Fault, FailCount= 1
2018-10-19T21:33:29.769Z,1539984809.769 [NAL9602](INFO): Powering up NAL9602
2018-10-19T21:33:29.877Z,1539984809.877 [CBIT](INFO): Clearing failed state for component BPC1
2018-10-19T21:33:29.877Z,1539984809.877 [BPC1] No Fault, FailCount= 1
2018-10-19T21:33:40.602Z,1539984820.602 [NAL9602](INFO): NAL9602 initialized
2018-10-19T21:33:46.787Z,1539984826.787 [CommandLine](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15.000000 degree
2018-10-19T21:33:46.788Z,1539984826.788 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2018-10-19T21:33:47.039Z,1539984827.039 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:34:02.443Z,1539984842.443 [CommandLine](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15.000000 degree
2018-10-19T21:34:16.367Z,1539984856.367 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:34:16.565Z,1539984856.565 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:34:20.961Z,1539984860.961 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:34:20.961Z,1539984860.961 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2018-10-19T21:34:20.961Z,1539984860.961 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:34:20.963Z,1539984860.963 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:34:20.963Z,1539984860.963 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-10-19T21:34:20.963Z,1539984860.963 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:34:21.038Z,1539984861.038 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:34:21.039Z,1539984861.039 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:34:21.474Z,1539984861.474 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:34:21.474Z,1539984861.474 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2018-10-19T21:34:21.475Z,1539984861.475 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:34:21.475Z,1539984861.475 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-10-19T21:34:21.748Z,1539984861.748 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:34:21.748Z,1539984861.748 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:34:21.748Z,1539984861.748 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:34:21.749Z,1539984861.749 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:34:21.750Z,1539984861.750 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:34:21.750Z,1539984861.750 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:34:39.744Z,1539984879.744 [BPC1](ERROR): BPC1A: No match for serial number 0226 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2018-10-19T21:34:39.746Z,1539984879.746 [BPC1](ERROR): BPC1B: No match for serial number 0273 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2018-10-19T21:34:39.746Z,1539984879.746 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-10-19T21:34:39.746Z,1539984879.746 [BPC1] Data Fault, FailCount= 2
2018-10-19T21:34:39.746Z,1539984879.746 [BPC1](ERROR): Data Fault
2018-10-19T21:34:39.765Z,1539984879.765 [CBIT](ERROR): Data Fault in component: BPC1
2018-10-19T21:36:21.479Z,1539984981.479 [CommandLine](IMPORTANT): got command failComponent hardware MassServo
2018-10-19T21:36:21.479Z,1539984981.479 [MassServo] Hardware Fault, FailCount= 1
2018-10-19T21:36:21.479Z,1539984981.479 [MassServo](ERROR): Hardware Fault
2018-10-19T21:36:21.479Z,1539984981.479 [CommandLine](IMPORTANT): MassServo failureMode is Hardware Fault
2018-10-19T21:36:21.582Z,1539984981.582 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-10-19T21:36:21.583Z,1539984981.583 [MassServo](INFO): Powering down
2018-10-19T21:36:21.588Z,1539984981.588 [CBIT](ERROR): Hardware Fault in component: MassServo
2018-10-19T21:36:21.961Z,1539984981.961 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:36:21.961Z,1539984981.961 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2018-10-19T21:36:21.961Z,1539984981.961 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:36:21.963Z,1539984981.963 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:36:21.963Z,1539984981.963 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2018-10-19T21:36:21.963Z,1539984981.963 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:36:21.997Z,1539984981.997 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:36:21.997Z,1539984981.997 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:36:25.097Z,1539984985.097 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:36:25.097Z,1539984985.097 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2018-10-19T21:36:25.098Z,1539984985.098 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:36:25.098Z,1539984985.098 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2018-10-19T21:36:25.098Z,1539984985.098 [CBIT](INFO): Clearing failed state for component MassServo
2018-10-19T21:36:25.098Z,1539984985.098 [MassServo] No Fault, FailCount= 1
2018-10-19T21:36:25.176Z,1539984985.176 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:36:25.177Z,1539984985.177 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:36:25.177Z,1539984985.177 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:36:25.178Z,1539984985.178 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:36:25.178Z,1539984985.178 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:36:25.178Z,1539984985.178 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:36:25.187Z,1539984985.187 [MassServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:36:25.188Z,1539984985.188 [MassServo](DEBUG): Initializing MassServo.
2018-10-19T21:37:15.677Z,1539985035.677 [CBIT](INFO): Clearing failed state for component Onboard
2018-10-19T21:37:15.677Z,1539985035.677 [Onboard] No Fault, FailCount= 1
2018-10-19T21:37:16.058Z,1539985036.058 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-10-19T21:37:16.058Z,1539985036.058 [Default:CheckIn:C.Wait] Stopped
2018-10-19T21:37:16.058Z,1539985036.058 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-10-19T21:37:16.058Z,1539985036.058 [Default:CheckIn:D] Running Loop=1
2018-10-19T21:37:16.454Z,1539985036.454 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:37:16.454Z,1539985036.454 [Onboard](FAULT): Can't read temperature LSB.
2018-10-19T21:37:16.454Z,1539985036.454 [Onboard] Hardware Fault, FailCount= 1
2018-10-19T21:37:16.454Z,1539985036.454 [Onboard](ERROR): Hardware Fault
2018-10-19T21:37:16.455Z,1539985036.455 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:37:16.455Z,1539985036.455 [Onboard](FAULT): Can't read temperature MSB.
2018-10-19T21:37:16.455Z,1539985036.455 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:37:16.456Z,1539985036.456 [Onboard](FAULT): Can't read pressure LSB.
2018-10-19T21:37:16.456Z,1539985036.456 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:37:16.456Z,1539985036.456 [Onboard](FAULT): Can't read pressure MSB.
2018-10-19T21:37:16.472Z,1539985036.472 [Default:CheckIn:D] Stopped
2018-10-19T21:37:16.472Z,1539985036.472 [Default:CheckIn:E] Running Loop=1
2018-10-19T21:37:16.483Z,1539985036.483 [CBIT](INFO): Clearing failed state for component DropWeight
2018-10-19T21:37:16.483Z,1539985036.483 [DropWeight] No Fault, FailCount= 1
2018-10-19T21:37:16.483Z,1539985036.483 [CBIT](ERROR): Hardware Fault in component: Onboard
2018-10-19T21:37:16.484Z,1539985036.484 [CBIT](CRITICAL): Hardware Fault in component: Onboard
2018-10-19T21:37:16.860Z,1539985036.860 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.534320 min 
2018-10-19T21:37:16.862Z,1539985036.862 [Default:CheckIn:E] Stopped
2018-10-19T21:37:16.862Z,1539985036.862 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-10-19T21:37:16.862Z,1539985036.862 [Default:CheckIn] Stopped
2018-10-19T21:37:16.862Z,1539985036.862 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-19T21:37:16.863Z,1539985036.863 [Default:CheckIn](INFO): Running loop #2
2018-10-19T21:37:16.863Z,1539985036.863 [Default:CheckIn] Running Loop=2
2018-10-19T21:37:16.863Z,1539985036.863 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-19T21:37:16.863Z,1539985036.863 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-19T21:37:16.872Z,1539985036.872 [CBIT](INFO): Critical error at 20181019T213716
2018-10-19T21:38:12.355Z,1539985092.355 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction -20.000000 millimeter
2018-10-19T21:38:12.356Z,1539985092.356 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread.
2018-10-19T21:38:12.532Z,1539985092.532 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:38:25.328Z,1539985105.328 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:38:25.328Z,1539985105.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2018-10-19T21:38:25.328Z,1539985105.328 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:38:25.330Z,1539985105.330 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:38:25.330Z,1539985105.330 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2018-10-19T21:38:25.330Z,1539985105.330 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:38:25.390Z,1539985105.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:38:25.390Z,1539985105.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:38:25.778Z,1539985105.778 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:38:25.778Z,1539985105.778 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2018-10-19T21:38:25.778Z,1539985105.778 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:38:25.778Z,1539985105.778 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2018-10-19T21:38:26.131Z,1539985106.131 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:38:26.132Z,1539985106.132 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:38:26.132Z,1539985106.132 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:38:26.132Z,1539985106.132 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:38:26.133Z,1539985106.133 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:38:26.133Z,1539985106.133 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:39:52.963Z,1539985192.963 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 40.000000 millimeter
2018-10-19T21:40:26.215Z,1539985226.215 [CommandLine](IMPORTANT): got command get depth
2018-10-19T21:40:26.215Z,1539985226.215 [CommandLine](IMPORTANT): depth -4.772697 m
2018-10-19T21:40:26.398Z,1539985226.398 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:40:26.398Z,1539985226.398 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2018-10-19T21:40:26.398Z,1539985226.398 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:40:26.400Z,1539985226.400 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:40:26.400Z,1539985226.400 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2018-10-19T21:40:26.400Z,1539985226.400 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:40:26.494Z,1539985226.494 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:40:26.494Z,1539985226.494 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:40:26.854Z,1539985226.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:40:26.854Z,1539985226.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2018-10-19T21:40:26.854Z,1539985226.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:40:26.854Z,1539985226.854 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2018-10-19T21:40:27.196Z,1539985227.196 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:40:27.196Z,1539985227.196 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:40:27.196Z,1539985227.196 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:40:27.197Z,1539985227.197 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:40:27.197Z,1539985227.197 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:40:27.198Z,1539985227.198 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:40:32.081Z,1539985232.081 [CommandLine](IMPORTANT): got command get depth
2018-10-19T21:40:32.082Z,1539985232.082 [CommandLine](IMPORTANT): depth -4.772313 m
2018-10-19T21:41:51.931Z,1539985311.931 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:41:52.206Z,1539985312.206 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:42:17.181Z,1539985337.181 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-10-19T21:37:16.9Z
2018-10-19T21:42:17.182Z,1539985337.182 [Default:CheckIn:Read_GPS] Stopped
2018-10-19T21:42:17.182Z,1539985337.182 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-10-19T21:42:22.881Z,1539985342.881 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20181019T212205/Courier0007.lzma
2018-10-19T21:42:23.670Z,1539985343.670 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Courier0007.lzma.bak
2018-10-19T21:42:23.671Z,1539985343.671 [DataOverHttps](INFO): SBD MOMSN=8740988
2018-10-19T21:42:28.389Z,1539985348.389 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:42:28.389Z,1539985348.389 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2018-10-19T21:42:28.389Z,1539985348.389 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:42:28.391Z,1539985348.391 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:42:28.391Z,1539985348.391 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2018-10-19T21:42:28.391Z,1539985348.391 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:42:28.465Z,1539985348.465 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:42:28.466Z,1539985348.466 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:42:28.570Z,1539985348.570 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:42:28.570Z,1539985348.570 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2018-10-19T21:42:28.570Z,1539985348.570 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:42:28.570Z,1539985348.570 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2018-10-19T21:42:28.903Z,1539985348.903 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:42:28.903Z,1539985348.903 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:42:28.905Z,1539985348.905 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:42:28.905Z,1539985348.905 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:42:28.906Z,1539985348.906 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:42:28.906Z,1539985348.906 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:42:34.062Z,1539985354.062 [DataOverHttps](INFO): Sending 708 bytes from file Logs/20181019T212205/Express0008.lzma
2018-10-19T21:42:34.859Z,1539985354.859 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Express0008.lzma.bak
2018-10-19T21:42:34.859Z,1539985354.859 [DataOverHttps](INFO): SBD MOMSN=8740991
2018-10-19T21:42:35.323Z,1539985355.323 [Default:CheckIn:Read_Iridium] Stopped
2018-10-19T21:42:35.323Z,1539985355.323 [Default:CheckIn:C.Wait] Running Loop=1
2018-10-19T21:42:35.323Z,1539985355.323 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-10-19T21:43:18.415Z,1539985398.415 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:43:41.579Z,1539985421.579 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-10-19T21:43:41.579Z,1539985421.579 [NAL9602] Data Fault, FailCount= 2
2018-10-19T21:43:41.579Z,1539985421.579 [NAL9602](ERROR): Data Fault
2018-10-19T21:43:41.652Z,1539985421.652 [CBIT](ERROR): Data Fault in component: NAL9602
2018-10-19T21:43:41.978Z,1539985421.978 [NAL9602](INFO): Powering down
2018-10-19T21:43:42.814Z,1539985422.814 [CBIT](INFO): Clearing failed state for component NAL9602
2018-10-19T21:43:42.814Z,1539985422.814 [NAL9602] No Fault, FailCount= 2
2018-10-19T21:44:12.051Z,1539985452.051 [NAL9602](INFO): Powering up NAL9602
2018-10-19T21:44:14.259Z,1539985454.259 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300.000000 revolution_per_minute
2018-10-19T21:44:14.260Z,1539985454.260 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread.
2018-10-19T21:44:14.503Z,1539985454.503 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:44:18.122Z,1539985458.122 [ThrusterServo](FAULT): Overload Error
2018-10-19T21:44:18.122Z,1539985458.122 [ThrusterServo] Hardware Fault, FailCount= 1
2018-10-19T21:44:18.122Z,1539985458.122 [ThrusterServo](ERROR): Hardware Fault
2018-10-19T21:44:18.126Z,1539985458.126 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2018-10-19T21:44:18.474Z,1539985458.474 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-10-19T21:44:18.474Z,1539985458.474 [ThrusterServo](INFO): Powering down
2018-10-19T21:44:19.283Z,1539985459.283 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:44:19.398Z,1539985459.398 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-10-19T21:44:19.402Z,1539985459.402 [CBIT](INFO): Clearing failed state for component ThrusterServo
2018-10-19T21:44:19.402Z,1539985459.402 [ThrusterServo] No Fault, FailCount= 1
2018-10-19T21:44:24.803Z,1539985464.803 [NAL9602](INFO): NAL9602 initialized
2018-10-19T21:44:29.221Z,1539985469.221 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:44:29.221Z,1539985469.221 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2018-10-19T21:44:29.221Z,1539985469.221 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:44:29.223Z,1539985469.223 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:44:29.223Z,1539985469.223 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11
2018-10-19T21:44:29.223Z,1539985469.223 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:44:29.297Z,1539985469.297 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:44:29.297Z,1539985469.297 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:44:29.669Z,1539985469.669 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:44:29.669Z,1539985469.669 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2018-10-19T21:44:29.670Z,1539985469.670 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:44:29.670Z,1539985469.670 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11
2018-10-19T21:44:30.024Z,1539985470.024 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:44:30.025Z,1539985470.025 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:44:30.025Z,1539985470.025 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:44:30.026Z,1539985470.026 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:44:30.026Z,1539985470.026 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:44:30.026Z,1539985470.026 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:44:40.872Z,1539985480.872 [CBIT](INFO): Clearing failed state for component BPC1
2018-10-19T21:44:40.872Z,1539985480.872 [BPC1] No Fault, FailCount= 2
2018-10-19T21:44:43.683Z,1539985483.683 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 600.000000 revolution_per_minute
2018-10-19T21:45:19.011Z,1539985519.011 [CommandLine](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 800.000000 revolution_per_minute
2018-10-19T21:45:26.005Z,1539985526.005 [ThrusterServo](FAULT): Overload Error
2018-10-19T21:45:26.005Z,1539985526.005 [ThrusterServo] Hardware Fault, FailCount= 1
2018-10-19T21:45:26.005Z,1539985526.005 [ThrusterServo](ERROR): Hardware Fault
2018-10-19T21:45:26.009Z,1539985526.009 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2018-10-19T21:45:26.387Z,1539985526.387 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-10-19T21:45:26.387Z,1539985526.387 [ThrusterServo](INFO): Powering down
2018-10-19T21:45:27.211Z,1539985527.211 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:45:27.330Z,1539985527.330 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-10-19T21:45:27.334Z,1539985527.334 [CBIT](INFO): Clearing failed state for component ThrusterServo
2018-10-19T21:45:27.334Z,1539985527.334 [ThrusterServo] No Fault, FailCount= 1
2018-10-19T21:45:33.942Z,1539985533.942 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:45:34.709Z,1539985534.709 [ThrusterServo](FAULT): Overload Error
2018-10-19T21:45:34.709Z,1539985534.709 [ThrusterServo] Hardware Fault, FailCount= 2
2018-10-19T21:45:34.709Z,1539985534.709 [ThrusterServo](ERROR): Hardware Fault
2018-10-19T21:45:34.717Z,1539985534.717 [CBIT](ERROR): Hardware Fault in component: ThrusterServo
2018-10-19T21:45:34.723Z,1539985534.723 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:45:34.810Z,1539985534.810 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-10-19T21:45:34.810Z,1539985534.810 [ThrusterServo](INFO): Powering down
2018-10-19T21:45:35.697Z,1539985535.697 [CBIT](INFO): Clearing failed state for component ThrusterServo
2018-10-19T21:45:35.697Z,1539985535.697 [ThrusterServo] No Fault, FailCount= 2
2018-10-19T21:45:35.970Z,1539985535.970 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:45:35.978Z,1539985535.978 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-10-19T21:45:48.747Z,1539985548.747 [BPC1](ERROR): BPC1A: No match for serial number 0226 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2018-10-19T21:45:48.748Z,1539985548.748 [BPC1](ERROR): BPC1B: No match for serial number 0273 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2018-10-19T21:45:48.748Z,1539985548.748 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-10-19T21:45:48.748Z,1539985548.748 [BPC1] Data Fault, FailCount= 3
2018-10-19T21:45:48.748Z,1539985548.748 [BPC1](ERROR): Data Fault
2018-10-19T21:45:48.806Z,1539985548.806 [CBIT](ERROR): Data Fault in component: BPC1
2018-10-19T21:46:30.301Z,1539985590.301 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:46:30.301Z,1539985590.301 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2018-10-19T21:46:30.301Z,1539985590.301 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:46:30.303Z,1539985590.303 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:46:30.303Z,1539985590.303 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12
2018-10-19T21:46:30.303Z,1539985590.303 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:46:30.317Z,1539985590.317 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:46:30.318Z,1539985590.318 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:46:30.704Z,1539985590.704 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:46:30.704Z,1539985590.704 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2018-10-19T21:46:30.704Z,1539985590.704 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:46:30.705Z,1539985590.705 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12
2018-10-19T21:46:31.080Z,1539985591.080 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:46:31.081Z,1539985591.081 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:46:31.081Z,1539985591.081 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:46:31.081Z,1539985591.081 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:46:31.082Z,1539985591.082 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:46:31.082Z,1539985591.082 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:47:01.055Z,1539985621.055 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100.000000 cubic_centimeter
2018-10-19T21:47:01.056Z,1539985621.056 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2018-10-19T21:47:01.430Z,1539985621.430 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:47:11.951Z,1539985631.951 [CommandLine](IMPORTANT): got command report mod platform_buoyancy_position
2018-10-19T21:47:12.228Z,1539985632.228 [Reporter](INFO): platform_buoyancy_position 951.756840 cc
2018-10-19T21:47:13.836Z,1539985633.836 [Reporter](INFO): platform_buoyancy_position 951.622555 cc
2018-10-19T21:47:14.632Z,1539985634.632 [Reporter](INFO): platform_buoyancy_position 951.756840 cc
2018-10-19T21:47:15.479Z,1539985635.479 [Reporter](INFO): platform_buoyancy_position 938.729732 cc
2018-10-19T21:47:15.876Z,1539985635.876 [Reporter](INFO): platform_buoyancy_position 928.120106 cc
2018-10-19T21:47:16.273Z,1539985636.273 [Reporter](INFO): platform_buoyancy_position 917.241792 cc
2018-10-19T21:47:16.640Z,1539985636.640 [Reporter](INFO): platform_buoyancy_position 906.363537 cc
2018-10-19T21:47:17.036Z,1539985637.036 [Reporter](INFO): platform_buoyancy_position 893.605000 cc
2018-10-19T21:47:20.109Z,1539985640.109 [BuoyancyServo](FAULT): Overload Error
2018-10-19T21:47:20.109Z,1539985640.109 [BuoyancyServo] Hardware Fault, FailCount= 1
2018-10-19T21:47:20.109Z,1539985640.109 [BuoyancyServo](ERROR): Hardware Fault
2018-10-19T21:47:20.164Z,1539985640.164 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2018-10-19T21:47:20.212Z,1539985640.212 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-10-19T21:47:20.213Z,1539985640.213 [BuoyancyServo](INFO): Powering down
2018-10-19T21:47:22.206Z,1539985642.206 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-10-19T21:47:22.206Z,1539985642.206 [BuoyancyServo] No Fault, FailCount= 1
2018-10-19T21:47:22.608Z,1539985642.608 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:47:22.726Z,1539985642.726 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-10-19T21:47:25.406Z,1539985645.406 [Reporter](INFO): platform_buoyancy_position 855.195161 cc
2018-10-19T21:47:25.876Z,1539985645.876 [Reporter](INFO): platform_buoyancy_position 861.507317 cc
2018-10-19T21:47:26.232Z,1539985646.232 [Reporter](INFO): platform_buoyancy_position 861.372915 cc
2018-10-19T21:47:26.663Z,1539985646.663 [Reporter](INFO): platform_buoyancy_position 859.358523 cc
2018-10-19T21:47:27.064Z,1539985647.064 [Reporter](INFO): platform_buoyancy_position 850.629003 cc
2018-10-19T21:47:27.454Z,1539985647.454 [Reporter](INFO): platform_buoyancy_position 848.480209 cc
2018-10-19T21:47:27.854Z,1539985647.854 [Reporter](INFO): platform_buoyancy_position 844.316906 cc
2018-10-19T21:47:28.244Z,1539985648.244 [Reporter](INFO): platform_buoyancy_position 840.019260 cc
2018-10-19T21:47:28.655Z,1539985648.655 [Reporter](INFO): platform_buoyancy_position 835.587387 cc
2018-10-19T21:47:29.059Z,1539985649.059 [Reporter](INFO): platform_buoyancy_position 830.484030 cc
2018-10-19T21:47:29.444Z,1539985649.444 [Reporter](INFO): platform_buoyancy_position 824.977644 cc
2018-10-19T21:47:29.855Z,1539985649.855 [Reporter](INFO): platform_buoyancy_position 820.680056 cc
2018-10-19T21:47:30.258Z,1539985650.258 [Reporter](INFO): platform_buoyancy_position 814.233732 cc
2018-10-19T21:47:30.644Z,1539985650.644 [Reporter](INFO): platform_buoyancy_position 809.801742 cc
2018-10-19T21:47:31.055Z,1539985651.055 [Reporter](INFO): platform_buoyancy_position 803.489704 cc
2018-10-19T21:47:31.461Z,1539985651.461 [Reporter](INFO): platform_buoyancy_position 799.192057 cc
2018-10-19T21:47:31.832Z,1539985651.832 [Reporter](INFO): platform_buoyancy_position 794.760184 cc
2018-10-19T21:47:32.244Z,1539985652.244 [Reporter](INFO): platform_buoyancy_position 788.448087 cc
2018-10-19T21:47:32.656Z,1539985652.656 [Reporter](INFO): platform_buoyancy_position 783.881871 cc
2018-10-19T21:47:33.052Z,1539985653.052 [Reporter](INFO): platform_buoyancy_position 777.569774 cc
2018-10-19T21:47:33.452Z,1539985653.452 [Reporter](INFO): platform_buoyancy_position 773.272128 cc
2018-10-19T21:47:33.859Z,1539985653.859 [Reporter](INFO): platform_buoyancy_position 767.497229 cc
2018-10-19T21:47:34.244Z,1539985654.244 [Reporter](INFO): platform_buoyancy_position 762.662501 cc
2018-10-19T21:47:34.642Z,1539985654.642 [Reporter](INFO): platform_buoyancy_position 758.230570 cc
2018-10-19T21:47:35.031Z,1539985655.031 [Reporter](INFO): platform_buoyancy_position 752.052816 cc
2018-10-19T21:47:35.444Z,1539985655.444 [Reporter](INFO): platform_buoyancy_position 747.486600 cc
2018-10-19T21:47:35.811Z,1539985655.811 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-10-19T21:47:35.811Z,1539985655.811 [Default:CheckIn:C.Wait] Stopped
2018-10-19T21:47:35.811Z,1539985655.811 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-10-19T21:47:35.811Z,1539985655.811 [Default:CheckIn:D] Running Loop=1
2018-10-19T21:47:35.855Z,1539985655.855 [Reporter](INFO): platform_buoyancy_position 741.174503 cc
2018-10-19T21:47:36.201Z,1539985656.201 [Default:CheckIn:D] Stopped
2018-10-19T21:47:36.201Z,1539985656.201 [Default:CheckIn:E] Running Loop=1
2018-10-19T21:47:36.264Z,1539985656.264 [Reporter](INFO): platform_buoyancy_position 736.876915 cc
2018-10-19T21:47:36.598Z,1539985656.598 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.863161 min 
2018-10-19T21:47:36.598Z,1539985656.598 [Default:CheckIn:E] Stopped
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn] Stopped
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn](INFO): Running loop #3
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn] Running Loop=3
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-19T21:47:36.599Z,1539985656.599 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-19T21:47:36.655Z,1539985656.655 [Reporter](INFO): platform_buoyancy_position 730.430475 cc
2018-10-19T21:47:37.049Z,1539985657.049 [Reporter](INFO): platform_buoyancy_position 726.132886 cc
2018-10-19T21:47:37.439Z,1539985657.439 [Reporter](INFO): platform_buoyancy_position 719.686446 cc
2018-10-19T21:47:37.860Z,1539985657.860 [Reporter](INFO): platform_buoyancy_position 715.388858 cc
2018-10-19T21:47:38.240Z,1539985658.240 [Reporter](INFO): platform_buoyancy_position 708.942418 cc
2018-10-19T21:47:38.664Z,1539985658.664 [Reporter](INFO): platform_buoyancy_position 704.644830 cc
2018-10-19T21:47:39.063Z,1539985659.063 [Reporter](INFO): platform_buoyancy_position 698.332791 cc
2018-10-19T21:47:39.456Z,1539985659.456 [Reporter](INFO): platform_buoyancy_position 693.766517 cc
2018-10-19T21:47:39.855Z,1539985659.855 [Reporter](INFO): platform_buoyancy_position 689.334644 cc
2018-10-19T21:47:40.236Z,1539985660.236 [Reporter](INFO): platform_buoyancy_position 683.022605 cc
2018-10-19T21:47:40.652Z,1539985660.652 [Reporter](INFO): platform_buoyancy_position 678.724959 cc
2018-10-19T21:47:41.060Z,1539985661.060 [Reporter](INFO): platform_buoyancy_position 672.412862 cc
2018-10-19T21:47:41.440Z,1539985661.440 [Reporter](INFO): platform_buoyancy_position 667.846703 cc
2018-10-19T21:47:41.852Z,1539985661.852 [Reporter](INFO): platform_buoyancy_position 661.803177 cc
2018-10-19T21:47:42.260Z,1539985662.260 [Reporter](INFO): platform_buoyancy_position 657.371304 cc
2018-10-19T21:47:42.652Z,1539985662.652 [Reporter](INFO): platform_buoyancy_position 651.730632 cc
2018-10-19T21:47:43.040Z,1539985663.040 [Reporter](INFO): platform_buoyancy_position 646.492990 cc
2018-10-19T21:47:43.455Z,1539985663.455 [Reporter](INFO): platform_buoyancy_position 642.195402 cc
2018-10-19T21:47:43.836Z,1539985663.836 [Reporter](INFO): platform_buoyancy_position 635.883247 cc
2018-10-19T21:47:44.240Z,1539985664.240 [Reporter](INFO): platform_buoyancy_position 631.585659 cc
2018-10-19T21:47:44.656Z,1539985664.656 [Reporter](INFO): platform_buoyancy_position 627.019443 cc
2018-10-19T21:47:45.064Z,1539985665.064 [Reporter](INFO): platform_buoyancy_position 620.975974 cc
2018-10-19T21:47:45.456Z,1539985665.456 [Reporter](INFO): platform_buoyancy_position 615.603931 cc
2018-10-19T21:47:45.839Z,1539985665.839 [Reporter](INFO): platform_buoyancy_position 610.097661 cc
2018-10-19T21:47:46.240Z,1539985666.240 [Reporter](INFO): platform_buoyancy_position 605.665788 cc
2018-10-19T21:47:46.652Z,1539985666.652 [Reporter](INFO): platform_buoyancy_position 599.219347 cc
2018-10-19T21:47:47.061Z,1539985667.061 [Reporter](INFO): platform_buoyancy_position 594.921759 cc
2018-10-19T21:47:47.440Z,1539985667.440 [Reporter](INFO): platform_buoyancy_position 588.743947 cc
2018-10-19T21:47:47.864Z,1539985667.864 [Reporter](INFO): platform_buoyancy_position 584.312074 cc
2018-10-19T21:47:48.265Z,1539985668.265 [Reporter](INFO): platform_buoyancy_position 579.611573 cc
2018-10-19T21:47:48.636Z,1539985668.636 [Reporter](INFO): platform_buoyancy_position 573.433761 cc
2018-10-19T21:47:49.052Z,1539985669.052 [Reporter](INFO): platform_buoyancy_position 568.733260 cc
2018-10-19T21:47:49.449Z,1539985669.449 [Reporter](INFO): platform_buoyancy_position 562.824018 cc
2018-10-19T21:47:49.850Z,1539985669.850 [Reporter](INFO): platform_buoyancy_position 558.392145 cc
2018-10-19T21:47:50.252Z,1539985670.252 [Reporter](INFO): platform_buoyancy_position 552.080106 cc
2018-10-19T21:47:50.666Z,1539985670.666 [Reporter](INFO): platform_buoyancy_position 547.648116 cc
2018-10-19T21:47:51.060Z,1539985671.060 [Reporter](INFO): platform_buoyancy_position 541.604648 cc
2018-10-19T21:47:51.459Z,1539985671.459 [Reporter](INFO): platform_buoyancy_position 537.038432 cc
2018-10-19T21:47:51.851Z,1539985671.851 [Reporter](INFO): platform_buoyancy_position 531.532161 cc
2018-10-19T21:47:52.249Z,1539985672.249 [Reporter](INFO): platform_buoyancy_position 526.294461 cc
2018-10-19T21:47:55.316Z,1539985675.316 [Reporter](INFO): platform_buoyancy_position 487.481739 cc
2018-10-19T21:47:55.412Z,1539985675.412 [Reporter](INFO): platform_buoyancy_position 485.332945 cc
2018-10-19T21:47:55.832Z,1539985675.832 [Reporter](INFO): platform_buoyancy_position 481.035328 cc
2018-10-19T21:47:56.223Z,1539985676.223 [Reporter](INFO): platform_buoyancy_position 474.723260 cc
2018-10-19T21:47:56.620Z,1539985676.620 [Reporter](INFO): platform_buoyancy_position 470.022758 cc
2018-10-19T21:47:57.015Z,1539985677.015 [Reporter](INFO): platform_buoyancy_position 463.979261 cc
2018-10-19T21:47:57.396Z,1539985677.396 [Reporter](INFO): platform_buoyancy_position 459.681643 cc
2018-10-19T21:47:57.800Z,1539985677.800 [Reporter](INFO): platform_buoyancy_position 453.235232 cc
2018-10-19T21:47:58.209Z,1539985678.209 [Reporter](INFO): platform_buoyancy_position 448.803359 cc
2018-10-19T21:47:58.623Z,1539985678.623 [Reporter](INFO): platform_buoyancy_position 442.491262 cc
2018-10-19T21:47:59.024Z,1539985679.024 [Reporter](INFO): platform_buoyancy_position 438.059331 cc
2018-10-19T21:47:59.426Z,1539985679.426 [Reporter](INFO): platform_buoyancy_position 431.881519 cc
2018-10-19T21:47:59.776Z,1539985679.776 [Reporter](INFO): platform_buoyancy_position 427.315361 cc
2018-10-19T21:48:00.181Z,1539985680.181 [Reporter](INFO): platform_buoyancy_position 421.137578 cc
2018-10-19T21:48:00.586Z,1539985680.586 [Reporter](INFO): platform_buoyancy_position 416.705618 cc
2018-10-19T21:48:00.992Z,1539985680.992 [Reporter](INFO): platform_buoyancy_position 412.139460 cc
2018-10-19T21:48:01.420Z,1539985681.420 [Reporter](INFO): platform_buoyancy_position 405.961677 cc
2018-10-19T21:48:01.828Z,1539985681.828 [Reporter](INFO): platform_buoyancy_position 401.395460 cc
2018-10-19T21:48:02.208Z,1539985682.208 [Reporter](INFO): platform_buoyancy_position 395.217648 cc
2018-10-19T21:48:02.588Z,1539985682.588 [Reporter](INFO): platform_buoyancy_position 390.920031 cc
2018-10-19T21:48:02.984Z,1539985682.984 [Reporter](INFO): platform_buoyancy_position 386.353815 cc
2018-10-19T21:48:03.400Z,1539985683.400 [Reporter](INFO): platform_buoyancy_position 380.176032 cc
2018-10-19T21:48:03.820Z,1539985683.820 [Reporter](INFO): platform_buoyancy_position 373.729621 cc
2018-10-19T21:48:04.230Z,1539985684.230 [Reporter](INFO): platform_buoyancy_position 369.432062 cc
2018-10-19T21:48:04.584Z,1539985684.584 [Reporter](INFO): platform_buoyancy_position 365.000131 cc
2018-10-19T21:48:04.988Z,1539985684.988 [Reporter](INFO): platform_buoyancy_position 358.688063 cc
2018-10-19T21:48:05.423Z,1539985685.423 [Reporter](INFO): platform_buoyancy_position 354.390446 cc
2018-10-19T21:48:05.804Z,1539985685.804 [Reporter](INFO): platform_buoyancy_position 347.944035 cc
2018-10-19T21:48:06.230Z,1539985686.230 [Reporter](INFO): platform_buoyancy_position 343.512133 cc
2018-10-19T21:48:06.587Z,1539985686.587 [Reporter](INFO): platform_buoyancy_position 337.200006 cc
2018-10-19T21:48:06.984Z,1539985686.984 [Reporter](INFO): platform_buoyancy_position 332.768133 cc
2018-10-19T21:48:07.428Z,1539985687.428 [Reporter](INFO): platform_buoyancy_position 327.664748 cc
2018-10-19T21:48:07.808Z,1539985687.808 [Reporter](INFO): platform_buoyancy_position 322.024105 cc
2018-10-19T21:48:08.220Z,1539985688.220 [Reporter](INFO): platform_buoyancy_position 317.323604 cc
2018-10-19T21:48:08.588Z,1539985688.588 [Reporter](INFO): platform_buoyancy_position 311.414420 cc
2018-10-19T21:48:08.984Z,1539985688.984 [Reporter](INFO): platform_buoyancy_position 306.982547 cc
2018-10-19T21:48:09.430Z,1539985689.430 [Reporter](INFO): platform_buoyancy_position 300.536136 cc
2018-10-19T21:48:09.808Z,1539985689.808 [Reporter](INFO): platform_buoyancy_position 296.238519 cc
2018-10-19T21:48:10.222Z,1539985690.222 [Reporter](INFO): platform_buoyancy_position 289.926422 cc
2018-10-19T21:48:10.580Z,1539985690.580 [Reporter](INFO): platform_buoyancy_position 285.628834 cc
2018-10-19T21:48:10.984Z,1539985690.984 [Reporter](INFO): platform_buoyancy_position 281.196932 cc
2018-10-19T21:48:11.427Z,1539985691.427 [Reporter](INFO): platform_buoyancy_position 274.750550 cc
2018-10-19T21:48:11.822Z,1539985691.822 [Reporter](INFO): platform_buoyancy_position 270.184333 cc
2018-10-19T21:48:12.221Z,1539985692.221 [Reporter](INFO): platform_buoyancy_position 264.140835 cc
2018-10-19T21:48:12.591Z,1539985692.591 [Reporter](INFO): platform_buoyancy_position 259.708933 cc
2018-10-19T21:48:12.678Z,1539985692.678 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:48:12.992Z,1539985692.992 [Reporter](INFO): platform_buoyancy_position 253.396807 cc
2018-10-19T21:48:12.998Z,1539985692.998 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:48:13.456Z,1539985693.456 [Reporter](INFO): platform_buoyancy_position 248.964934 cc
2018-10-19T21:48:13.851Z,1539985693.851 [Reporter](INFO): platform_buoyancy_position 244.667317 cc
2018-10-19T21:48:14.223Z,1539985694.223 [Reporter](INFO): platform_buoyancy_position 242.518523 cc
2018-10-19T21:48:14.588Z,1539985694.588 [Reporter](INFO): platform_buoyancy_position 242.652837 cc
2018-10-19T21:48:14.986Z,1539985694.986 [Reporter](INFO): platform_buoyancy_position 244.667317 cc
2018-10-19T21:48:15.392Z,1539985695.392 [Reporter](INFO): platform_buoyancy_position 248.964934 cc
2018-10-19T21:48:15.808Z,1539985695.808 [Reporter](INFO): platform_buoyancy_position 253.396807 cc
2018-10-19T21:48:16.211Z,1539985696.211 [Reporter](INFO): platform_buoyancy_position 257.694424 cc
2018-10-19T21:48:16.592Z,1539985696.592 [Reporter](INFO): platform_buoyancy_position 263.872236 cc
2018-10-19T21:48:16.988Z,1539985696.988 [Reporter](INFO): platform_buoyancy_position 268.304138 cc
2018-10-19T21:48:17.406Z,1539985697.406 [Reporter](INFO): platform_buoyancy_position 274.079037 cc
2018-10-19T21:48:17.808Z,1539985697.808 [Reporter](INFO): platform_buoyancy_position 279.048138 cc
2018-10-19T21:48:18.208Z,1539985698.208 [Reporter](INFO): platform_buoyancy_position 283.480040 cc
2018-10-19T21:48:18.608Z,1539985698.608 [Reporter](INFO): platform_buoyancy_position 289.657823 cc
2018-10-19T21:48:19.020Z,1539985699.020 [Reporter](INFO): platform_buoyancy_position 294.089725 cc
2018-10-19T21:48:19.404Z,1539985699.404 [Reporter](INFO): platform_buoyancy_position 300.670450 cc
2018-10-19T21:48:19.818Z,1539985699.818 [Reporter](INFO): platform_buoyancy_position 304.833753 cc
2018-10-19T21:48:20.191Z,1539985700.191 [Reporter](INFO): platform_buoyancy_position 310.340023 cc
2018-10-19T21:48:20.592Z,1539985700.592 [Reporter](INFO): platform_buoyancy_position 315.712037 cc
2018-10-19T21:48:20.992Z,1539985700.992 [Reporter](INFO): platform_buoyancy_position 320.009654 cc
2018-10-19T21:48:21.412Z,1539985701.412 [Reporter](INFO): platform_buoyancy_position 326.321722 cc
2018-10-19T21:48:21.819Z,1539985701.819 [Reporter](INFO): platform_buoyancy_position 330.753654 cc
2018-10-19T21:48:22.219Z,1539985702.219 [Reporter](INFO): platform_buoyancy_position 337.065721 cc
2018-10-19T21:48:22.611Z,1539985702.611 [Reporter](INFO): platform_buoyancy_position 341.363339 cc
2018-10-19T21:48:22.992Z,1539985702.992 [Reporter](INFO): platform_buoyancy_position 347.541150 cc
2018-10-19T21:48:23.418Z,1539985703.418 [Reporter](INFO): platform_buoyancy_position 352.241652 cc
2018-10-19T21:48:23.792Z,1539985703.792 [Reporter](INFO): platform_buoyancy_position 356.807868 cc
2018-10-19T21:48:24.215Z,1539985704.215 [Reporter](INFO): platform_buoyancy_position 362.985651 cc
2018-10-19T21:48:24.606Z,1539985704.606 [Reporter](INFO): platform_buoyancy_position 367.283268 cc
2018-10-19T21:48:25.010Z,1539985705.010 [Reporter](INFO): platform_buoyancy_position 373.595336 cc
2018-10-19T21:48:25.416Z,1539985705.416 [Reporter](INFO): platform_buoyancy_position 378.161552 cc
2018-10-19T21:48:25.822Z,1539985705.822 [Reporter](INFO): platform_buoyancy_position 384.205021 cc
2018-10-19T21:48:25.894Z,1539985705.894 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 200.000000 cubic_centimeter
2018-10-19T21:48:25.895Z,1539985705.895 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2018-10-19T21:48:26.196Z,1539985706.196 [Reporter](INFO): platform_buoyancy_position 388.771237 cc
2018-10-19T21:48:26.225Z,1539985706.225 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:48:26.636Z,1539985706.636 [Reporter](INFO): platform_buoyancy_position 395.083363 cc
2018-10-19T21:48:27.031Z,1539985707.031 [Reporter](INFO): platform_buoyancy_position 399.380922 cc
2018-10-19T21:48:27.415Z,1539985707.415 [Reporter](INFO): platform_buoyancy_position 399.783865 cc
2018-10-19T21:48:30.511Z,1539985710.511 [Reporter](INFO): platform_buoyancy_position 369.432062 cc
2018-10-19T21:48:30.975Z,1539985710.975 [Reporter](INFO): platform_buoyancy_position 365.000131 cc
2018-10-19T21:48:31.336Z,1539985711.336 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:48:31.337Z,1539985711.337 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2018-10-19T21:48:31.337Z,1539985711.337 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:48:31.338Z,1539985711.338 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:48:31.339Z,1539985711.339 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13
2018-10-19T21:48:31.339Z,1539985711.339 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:48:31.418Z,1539985711.418 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:48:31.419Z,1539985711.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:48:31.420Z,1539985711.420 [Reporter](INFO): platform_buoyancy_position 358.688063 cc
2018-10-19T21:48:31.770Z,1539985711.770 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:48:31.771Z,1539985711.771 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2018-10-19T21:48:31.771Z,1539985711.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:48:31.771Z,1539985711.771 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13
2018-10-19T21:48:31.773Z,1539985711.773 [Reporter](INFO): platform_buoyancy_position 354.121818 cc
2018-10-19T21:48:32.128Z,1539985712.128 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:48:32.129Z,1539985712.129 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:48:32.130Z,1539985712.130 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:48:32.130Z,1539985712.130 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:48:32.131Z,1539985712.131 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:48:32.131Z,1539985712.131 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:48:32.183Z,1539985712.183 [Reporter](INFO): platform_buoyancy_position 347.944035 cc
2018-10-19T21:48:32.596Z,1539985712.596 [Reporter](INFO): platform_buoyancy_position 343.512133 cc
2018-10-19T21:48:32.996Z,1539985712.996 [Reporter](INFO): platform_buoyancy_position 337.065721 cc
2018-10-19T21:48:33.420Z,1539985713.420 [Reporter](INFO): platform_buoyancy_position 332.633848 cc
2018-10-19T21:48:33.780Z,1539985713.780 [Reporter](INFO): platform_buoyancy_position 326.321722 cc
2018-10-19T21:48:34.180Z,1539985714.180 [Reporter](INFO): platform_buoyancy_position 322.024105 cc
2018-10-19T21:48:34.587Z,1539985714.587 [Reporter](INFO): platform_buoyancy_position 315.712037 cc
2018-10-19T21:48:34.988Z,1539985714.988 [Reporter](INFO): platform_buoyancy_position 311.280164 cc
2018-10-19T21:48:35.388Z,1539985715.388 [Reporter](INFO): platform_buoyancy_position 305.236637 cc
2018-10-19T21:48:35.820Z,1539985715.820 [Reporter](INFO): platform_buoyancy_position 300.670450 cc
2018-10-19T21:48:36.212Z,1539985716.212 [Reporter](INFO): platform_buoyancy_position 295.701320 cc
2018-10-19T21:48:36.586Z,1539985716.586 [Reporter](INFO): platform_buoyancy_position 289.926422 cc
2018-10-19T21:48:36.980Z,1539985716.980 [Reporter](INFO): platform_buoyancy_position 285.494549 cc
2018-10-19T21:48:37.421Z,1539985717.421 [Reporter](INFO): platform_buoyancy_position 279.048138 cc
2018-10-19T21:48:37.792Z,1539985717.792 [Reporter](INFO): platform_buoyancy_position 274.750550 cc
2018-10-19T21:48:38.221Z,1539985718.221 [Reporter](INFO): platform_buoyancy_position 268.438453 cc
2018-10-19T21:48:38.580Z,1539985718.580 [Reporter](INFO): platform_buoyancy_position 264.140835 cc
2018-10-19T21:48:38.982Z,1539985718.982 [Reporter](INFO): platform_buoyancy_position 258.903136 cc
2018-10-19T21:48:39.391Z,1539985719.391 [Reporter](INFO): platform_buoyancy_position 253.262551 cc
2018-10-19T21:48:39.792Z,1539985719.792 [Reporter](INFO): platform_buoyancy_position 248.964934 cc
2018-10-19T21:48:40.188Z,1539985720.188 [Reporter](INFO): platform_buoyancy_position 242.652837 cc
2018-10-19T21:48:40.584Z,1539985720.584 [Reporter](INFO): platform_buoyancy_position 238.220950 cc
2018-10-19T21:48:40.984Z,1539985720.984 [Reporter](INFO): platform_buoyancy_position 232.043123 cc
2018-10-19T21:48:41.384Z,1539985721.384 [Reporter](INFO): platform_buoyancy_position 227.476936 cc
2018-10-19T21:48:41.791Z,1539985721.791 [Reporter](INFO): platform_buoyancy_position 221.164824 cc
2018-10-19T21:48:42.192Z,1539985722.192 [Reporter](INFO): platform_buoyancy_position 216.732937 cc
2018-10-19T21:48:42.584Z,1539985722.584 [Reporter](INFO): platform_buoyancy_position 212.435334 cc
2018-10-19T21:48:43.023Z,1539985723.023 [Reporter](INFO): platform_buoyancy_position 208.137732 cc
2018-10-19T21:48:55.463Z,1539985735.463 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 150.000000 cubic_centimeter
2018-10-19T21:49:00.232Z,1539985740.232 [Reporter](INFO): platform_buoyancy_position 206.123237 cc
2018-10-19T21:49:00.999Z,1539985740.999 [Reporter](INFO): platform_buoyancy_position 205.988923 cc
2018-10-19T21:49:01.396Z,1539985741.396 [Reporter](INFO): platform_buoyancy_position 203.974429 cc
2018-10-19T21:49:02.204Z,1539985742.204 [Reporter](INFO): platform_buoyancy_position 201.825620 cc
2018-10-19T21:49:05.689Z,1539985745.689 [Reporter](INFO): platform_buoyancy_position 191.350220 cc
2018-10-19T21:49:05.800Z,1539985745.800 [Reporter](INFO): platform_buoyancy_position 191.215950 cc
2018-10-19T21:49:06.202Z,1539985746.202 [Reporter](INFO): platform_buoyancy_position 190.678737 cc
2018-10-19T21:49:06.592Z,1539985746.592 [Reporter](INFO): platform_buoyancy_position 188.798527 cc
2018-10-19T21:49:07.355Z,1539985747.355 [Reporter](INFO): platform_buoyancy_position 186.784033 cc
2018-10-19T21:49:07.753Z,1539985747.753 [Reporter](INFO): platform_buoyancy_position 184.635224 cc
2018-10-19T21:49:08.152Z,1539985748.152 [Reporter](INFO): platform_buoyancy_position 184.500910 cc
2018-10-19T21:49:08.587Z,1539985748.587 [Reporter](INFO): platform_buoyancy_position 182.352145 cc
2018-10-19T21:49:08.972Z,1539985748.972 [Reporter](INFO): platform_buoyancy_position 180.337622 cc
2018-10-19T21:49:09.388Z,1539985749.388 [Reporter](INFO): platform_buoyancy_position 180.203337 cc
2018-10-19T21:49:09.763Z,1539985749.763 [Reporter](INFO): platform_buoyancy_position 178.188842 cc
2018-10-19T21:49:10.553Z,1539985750.553 [Reporter](INFO): platform_buoyancy_position 176.040034 cc
2018-10-19T21:49:10.966Z,1539985750.966 [Reporter](INFO): platform_buoyancy_position 175.637120 cc
2018-10-19T21:49:11.376Z,1539985751.376 [Reporter](INFO): platform_buoyancy_position 173.622626 cc
2018-10-19T21:49:11.792Z,1539985751.792 [Reporter](INFO): platform_buoyancy_position 171.742431 cc
2018-10-19T21:49:12.175Z,1539985752.175 [Reporter](INFO): platform_buoyancy_position 171.608117 cc
2018-10-19T21:49:12.560Z,1539985752.560 [Reporter](INFO): platform_buoyancy_position 169.593623 cc
2018-10-19T21:49:12.960Z,1539985752.960 [Reporter](INFO): platform_buoyancy_position 167.444829 cc
2018-10-19T21:49:13.372Z,1539985753.372 [Reporter](INFO): platform_buoyancy_position 167.310514 cc
2018-10-19T21:49:13.760Z,1539985753.760 [Reporter](INFO): platform_buoyancy_position 165.296020 cc
2018-10-19T21:49:14.168Z,1539985754.168 [Reporter](INFO): platform_buoyancy_position 163.281526 cc
2018-10-19T21:49:14.571Z,1539985754.571 [Reporter](INFO): platform_buoyancy_position 163.012941 cc
2018-10-19T21:49:14.960Z,1539985754.960 [Reporter](INFO): platform_buoyancy_position 160.998417 cc
2018-10-19T21:49:15.776Z,1539985755.776 [Reporter](INFO): platform_buoyancy_position 158.849638 cc
2018-10-19T21:49:30.647Z,1539985770.647 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100.000000 cubic_centimeter
2018-10-19T21:49:32.974Z,1539985772.974 [Reporter](INFO): platform_buoyancy_position 158.715338 cc
2018-10-19T21:49:33.380Z,1539985773.380 [Reporter](INFO): platform_buoyancy_position 156.700829 cc
2018-10-19T21:49:33.768Z,1539985773.768 [Reporter](INFO): platform_buoyancy_position 156.566530 cc
2018-10-19T21:49:34.180Z,1539985774.180 [Reporter](INFO): platform_buoyancy_position 156.432216 cc
2018-10-19T21:49:34.568Z,1539985774.568 [Reporter](INFO): platform_buoyancy_position 154.820620 cc
2018-10-19T21:49:34.970Z,1539985774.970 [Reporter](INFO): platform_buoyancy_position 152.403227 cc
2018-10-19T21:49:35.379Z,1539985775.379 [Reporter](INFO): platform_buoyancy_position 152.268927 cc
2018-10-19T21:49:35.780Z,1539985775.780 [Reporter](INFO): platform_buoyancy_position 150.254418 cc
2018-10-19T21:49:36.168Z,1539985776.168 [Reporter](INFO): platform_buoyancy_position 150.120119 cc
2018-10-19T21:49:36.578Z,1539985776.578 [Reporter](INFO): platform_buoyancy_position 148.105624 cc
2018-10-19T21:49:36.968Z,1539985776.968 [Reporter](INFO): platform_buoyancy_position 146.896913 cc
2018-10-19T21:49:37.368Z,1539985777.368 [Reporter](INFO): platform_buoyancy_position 145.956816 cc
2018-10-19T21:49:37.772Z,1539985777.772 [Reporter](INFO): platform_buoyancy_position 145.016718 cc
2018-10-19T21:49:40.874Z,1539985780.874 [Reporter](INFO): platform_buoyancy_position 135.078517 cc
2018-10-19T21:49:40.965Z,1539985780.965 [Reporter](INFO): platform_buoyancy_position 133.332607 cc
2018-10-19T21:49:41.336Z,1539985781.336 [Reporter](INFO): platform_buoyancy_position 132.929723 cc
2018-10-19T21:49:41.764Z,1539985781.764 [Reporter](INFO): platform_buoyancy_position 130.915229 cc
2018-10-19T21:49:42.582Z,1539985782.582 [Reporter](INFO): platform_buoyancy_position 128.766420 cc
2018-10-19T21:49:42.980Z,1539985782.980 [Reporter](INFO): platform_buoyancy_position 126.617611 cc
2018-10-19T21:49:43.380Z,1539985783.380 [Reporter](INFO): platform_buoyancy_position 126.483341 cc
2018-10-19T21:49:43.735Z,1539985783.735 [Reporter](INFO): platform_buoyancy_position 124.603117 cc
2018-10-19T21:49:44.144Z,1539985784.144 [Reporter](INFO): platform_buoyancy_position 124.200233 cc
2018-10-19T21:49:44.540Z,1539985784.540 [Reporter](INFO): platform_buoyancy_position 122.320038 cc
2018-10-19T21:49:44.943Z,1539985784.943 [Reporter](INFO): platform_buoyancy_position 120.439821 cc
2018-10-19T21:49:45.344Z,1539985785.344 [Reporter](INFO): platform_buoyancy_position 120.171237 cc
2018-10-19T21:49:45.756Z,1539985785.756 [Reporter](INFO): platform_buoyancy_position 118.022428 cc
2018-10-19T21:49:46.178Z,1539985786.178 [Reporter](INFO): platform_buoyancy_position 115.873627 cc
2018-10-19T21:49:46.577Z,1539985786.577 [Reporter](INFO): platform_buoyancy_position 115.739320 cc
2018-10-19T21:49:46.940Z,1539985786.940 [Reporter](INFO): platform_buoyancy_position 113.859132 cc
2018-10-19T21:49:47.332Z,1539985787.332 [Reporter](INFO): platform_buoyancy_position 113.590519 cc
2018-10-19T21:49:47.744Z,1539985787.744 [Reporter](INFO): platform_buoyancy_position 111.441710 cc
2018-10-19T21:49:48.140Z,1539985788.140 [Reporter](INFO): platform_buoyancy_position 111.307432 cc
2018-10-19T21:49:48.584Z,1539985788.584 [Reporter](INFO): platform_buoyancy_position 109.427216 cc
2018-10-19T21:50:05.455Z,1539985805.455 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 90.000000 cubic_centimeter
2018-10-19T21:50:07.340Z,1539985807.340 [Reporter](INFO): platform_buoyancy_position 109.292909 cc
2018-10-19T21:50:08.140Z,1539985808.140 [Reporter](INFO): platform_buoyancy_position 107.278414 cc
2018-10-19T21:50:08.568Z,1539985808.568 [Reporter](INFO): platform_buoyancy_position 107.144137 cc
2018-10-19T21:50:08.982Z,1539985808.982 [Reporter](INFO): platform_buoyancy_position 105.129606 cc
2018-10-19T21:50:09.368Z,1539985809.368 [Reporter](INFO): platform_buoyancy_position 104.995328 cc
2018-10-19T21:50:09.740Z,1539985809.740 [Reporter](INFO): platform_buoyancy_position 102.980834 cc
2018-10-19T21:50:10.148Z,1539985810.148 [Reporter](INFO): platform_buoyancy_position 102.846527 cc
2018-10-19T21:50:10.532Z,1539985810.532 [Reporter](INFO): platform_buoyancy_position 100.832032 cc
2018-10-19T21:50:10.948Z,1539985810.948 [Reporter](INFO): platform_buoyancy_position 100.429104 cc
2018-10-19T21:50:11.346Z,1539985811.346 [Reporter](INFO): platform_buoyancy_position 98.683231 cc
2018-10-19T21:50:29.931Z,1539985829.931 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 80.000000 cubic_centimeter
2018-10-19T21:50:31.352Z,1539985831.352 [Reporter](INFO): platform_buoyancy_position 96.534422 cc
2018-10-19T21:50:31.744Z,1539985831.744 [Reporter](INFO): platform_buoyancy_position 98.548917 cc
2018-10-19T21:50:32.143Z,1539985832.143 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2018-10-19T21:50:32.484Z,1539985832.484 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:50:32.484Z,1539985832.484 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2018-10-19T21:50:32.484Z,1539985832.484 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:50:32.486Z,1539985832.486 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:50:32.486Z,1539985832.486 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14
2018-10-19T21:50:32.486Z,1539985832.486 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:50:32.531Z,1539985832.531 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:50:32.531Z,1539985832.531 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:50:32.918Z,1539985832.918 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:50:32.918Z,1539985832.918 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2018-10-19T21:50:32.919Z,1539985832.919 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:50:32.919Z,1539985832.919 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14
2018-10-19T21:50:32.941Z,1539985832.941 [Reporter](INFO): platform_buoyancy_position 94.251314 cc
2018-10-19T21:50:33.264Z,1539985833.264 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:50:33.265Z,1539985833.265 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:50:33.265Z,1539985833.265 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:50:33.266Z,1539985833.266 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:50:33.266Z,1539985833.266 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:50:33.266Z,1539985833.266 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:50:33.343Z,1539985833.343 [Reporter](INFO): platform_buoyancy_position 94.117036 cc
2018-10-19T21:50:33.716Z,1539985833.716 [Reporter](INFO): platform_buoyancy_position 92.236820 cc
2018-10-19T21:50:34.108Z,1539985834.108 [Reporter](INFO): platform_buoyancy_position 91.833921 cc
2018-10-19T21:50:34.554Z,1539985834.554 [Reporter](INFO): platform_buoyancy_position 89.953734 cc
2018-10-19T21:50:58.885Z,1539985858.885 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 70.000000 cubic_centimeter
2018-10-19T21:51:00.316Z,1539985860.316 [Reporter](INFO): platform_buoyancy_position 88.610715 cc
2018-10-19T21:51:00.704Z,1539985860.704 [Reporter](INFO): platform_buoyancy_position 90.088011 cc
2018-10-19T21:51:01.499Z,1539985861.499 [Reporter](INFO): platform_buoyancy_position 88.879337 cc
2018-10-19T21:51:01.880Z,1539985861.880 [Reporter](INFO): platform_buoyancy_position 88.073517 cc
2018-10-19T21:51:02.279Z,1539985862.279 [Reporter](INFO): platform_buoyancy_position 85.656131 cc
2018-10-19T21:51:02.692Z,1539985862.692 [Reporter](INFO): platform_buoyancy_position 85.521817 cc
2018-10-19T21:51:03.080Z,1539985863.080 [Reporter](INFO): platform_buoyancy_position 83.507322 cc
2018-10-19T21:51:03.907Z,1539985863.907 [Reporter](INFO): platform_buoyancy_position 81.358521 cc
2018-10-19T21:51:04.306Z,1539985864.306 [Reporter](INFO): platform_buoyancy_position 80.015532 cc
2018-10-19T21:51:04.676Z,1539985864.676 [Reporter](INFO): platform_buoyancy_position 79.344027 cc
2018-10-19T21:51:27.826Z,1539985887.826 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 60.000000 cubic_centimeter
2018-10-19T21:51:29.452Z,1539985889.452 [Reporter](INFO): platform_buoyancy_position 77.329532 cc
2018-10-19T21:51:29.808Z,1539985889.808 [Reporter](INFO): platform_buoyancy_position 79.075406 cc
2018-10-19T21:51:30.212Z,1539985890.212 [Reporter](INFO): platform_buoyancy_position 77.195218 cc
2018-10-19T21:51:30.608Z,1539985890.608 [Reporter](INFO): platform_buoyancy_position 77.060911 cc
2018-10-19T21:51:30.000Z,1539985891.000 [Reporter](INFO): platform_buoyancy_position 76.926604 cc
2018-10-19T21:51:31.415Z,1539985891.415 [Reporter](INFO): platform_buoyancy_position 74.374911 cc
2018-10-19T21:51:31.808Z,1539985891.808 [Reporter](INFO): platform_buoyancy_position 72.763309 cc
2018-10-19T21:51:32.241Z,1539985892.241 [Reporter](INFO): platform_buoyancy_position 70.883121 cc
2018-10-19T21:51:32.608Z,1539985892.608 [Reporter](INFO): platform_buoyancy_position 70.748807 cc
2018-10-19T21:51:33.008Z,1539985893.008 [Reporter](INFO): platform_buoyancy_position 68.465728 cc
2018-10-19T21:51:56.359Z,1539985916.359 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:51:56.579Z,1539985916.579 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:52:04.616Z,1539985924.616 [Reporter](INFO): platform_buoyancy_position 68.600006 cc
2018-10-19T21:52:05.016Z,1539985925.016 [Reporter](INFO): platform_buoyancy_position 70.614529 cc
2018-10-19T21:52:05.430Z,1539985925.430 [Reporter](INFO): platform_buoyancy_position 74.912110 cc
2018-10-19T21:52:05.784Z,1539985925.784 [Reporter](INFO): platform_buoyancy_position 78.672514 cc
2018-10-19T21:52:06.212Z,1539985926.212 [Reporter](INFO): platform_buoyancy_position 83.641629 cc
2018-10-19T21:52:06.618Z,1539985926.618 [Reporter](INFO): platform_buoyancy_position 88.073517 cc
2018-10-19T21:52:07.017Z,1539985927.017 [Reporter](INFO): platform_buoyancy_position 94.251314 cc
2018-10-19T21:52:07.424Z,1539985927.424 [Reporter](INFO): platform_buoyancy_position 98.548917 cc
2018-10-19T21:52:07.827Z,1539985927.827 [Reporter](INFO): platform_buoyancy_position 104.995328 cc
2018-10-19T21:52:08.204Z,1539985928.204 [Reporter](INFO): platform_buoyancy_position 109.427216 cc
2018-10-19T21:52:08.604Z,1539985928.604 [Reporter](INFO): platform_buoyancy_position 115.739320 cc
2018-10-19T21:52:09.019Z,1539985929.019 [Reporter](INFO): platform_buoyancy_position 120.171237 cc
2018-10-19T21:52:09.404Z,1539985929.404 [Reporter](INFO): platform_buoyancy_position 126.483341 cc
2018-10-19T21:52:09.830Z,1539985929.830 [Reporter](INFO): platform_buoyancy_position 130.780914 cc
2018-10-19T21:52:10.230Z,1539985930.230 [Reporter](INFO): platform_buoyancy_position 135.481416 cc
2018-10-19T21:52:10.616Z,1539985930.616 [Reporter](INFO): platform_buoyancy_position 141.659213 cc
2018-10-19T21:52:11.016Z,1539985931.016 [Reporter](INFO): platform_buoyancy_position 146.091130 cc
2018-10-19T21:52:11.430Z,1539985931.430 [Reporter](INFO): platform_buoyancy_position 152.403227 cc
2018-10-19T21:52:11.804Z,1539985931.804 [Reporter](INFO): platform_buoyancy_position 156.700829 cc
2018-10-19T21:52:12.224Z,1539985932.224 [Reporter](INFO): platform_buoyancy_position 163.147211 cc
2018-10-19T21:52:12.613Z,1539985932.613 [Reporter](INFO): platform_buoyancy_position 167.310514 cc
2018-10-19T21:52:13.018Z,1539985933.018 [Reporter](INFO): platform_buoyancy_position 173.756926 cc
2018-10-19T21:52:13.424Z,1539985933.424 [Reporter](INFO): platform_buoyancy_position 178.054528 cc
2018-10-19T21:52:13.829Z,1539985933.829 [Reporter](INFO): platform_buoyancy_position 182.486416 cc
2018-10-19T21:52:14.216Z,1539985934.216 [Reporter](INFO): platform_buoyancy_position 188.932827 cc
2018-10-19T21:52:14.618Z,1539985934.618 [Reporter](INFO): platform_buoyancy_position 193.499029 cc
2018-10-19T21:52:15.018Z,1539985935.018 [Reporter](INFO): platform_buoyancy_position 199.542541 cc
2018-10-19T21:52:15.416Z,1539985935.416 [Reporter](INFO): platform_buoyancy_position 203.974429 cc
2018-10-19T21:52:15.816Z,1539985935.816 [Reporter](INFO): platform_buoyancy_position 210.286526 cc
2018-10-19T21:52:16.230Z,1539985936.230 [Reporter](INFO): platform_buoyancy_position 214.584143 cc
2018-10-19T21:52:16.616Z,1539985936.616 [CBIT](INFO): Clearing failed state for component Onboard
2018-10-19T21:52:16.616Z,1539985936.616 [Onboard] No Fault, FailCount= 1
2018-10-19T21:52:16.618Z,1539985936.618 [Reporter](INFO): platform_buoyancy_position 219.016016 cc
2018-10-19T21:52:17.013Z,1539985937.013 [Reporter](INFO): platform_buoyancy_position 225.328127 cc
2018-10-19T21:52:17.363Z,1539985937.363 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:52:17.363Z,1539985937.363 [Onboard](FAULT): Can't read temperature LSB.
2018-10-19T21:52:17.363Z,1539985937.363 [Onboard] Hardware Fault, FailCount= 1
2018-10-19T21:52:17.363Z,1539985937.363 [Onboard](ERROR): Hardware Fault
2018-10-19T21:52:17.364Z,1539985937.364 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:52:17.364Z,1539985937.364 [Onboard](FAULT): Can't read temperature MSB.
2018-10-19T21:52:17.365Z,1539985937.365 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:52:17.365Z,1539985937.365 [Onboard](FAULT): Can't read pressure LSB.
2018-10-19T21:52:17.366Z,1539985937.366 [Onboard](ERROR): I2C read error. Can't read 1 bytes.
2018-10-19T21:52:17.366Z,1539985937.366 [Onboard](FAULT): Can't read pressure MSB.
2018-10-19T21:52:17.439Z,1539985937.439 [CBIT](ERROR): Hardware Fault in component: Onboard
2018-10-19T21:52:17.439Z,1539985937.439 [CBIT](CRITICAL): Hardware Fault in component: Onboard
2018-10-19T21:52:17.444Z,1539985937.444 [Reporter](INFO): platform_buoyancy_position 230.028629 cc
2018-10-19T21:52:17.819Z,1539985937.819 [CBIT](INFO): Critical error at 20181019T215217
2018-10-19T21:52:17.823Z,1539985937.823 [Reporter](INFO): platform_buoyancy_position 236.072141 cc
2018-10-19T21:52:18.228Z,1539985938.228 [Reporter](INFO): platform_buoyancy_position 240.504029 cc
2018-10-19T21:52:18.591Z,1539985938.591 [Reporter](INFO): platform_buoyancy_position 246.816140 cc
2018-10-19T21:52:19.008Z,1539985939.008 [Reporter](INFO): platform_buoyancy_position 251.248042 cc
2018-10-19T21:52:19.430Z,1539985939.430 [Reporter](INFO): platform_buoyancy_position 257.560110 cc
2018-10-19T21:52:19.833Z,1539985939.833 [Reporter](INFO): platform_buoyancy_position 261.992041 cc
2018-10-19T21:52:20.228Z,1539985940.228 [Reporter](INFO): platform_buoyancy_position 268.304138 cc
2018-10-19T21:52:20.594Z,1539985940.594 [Reporter](INFO): platform_buoyancy_position 272.601756 cc
2018-10-19T21:52:20.988Z,1539985940.988 [Reporter](INFO): platform_buoyancy_position 277.033629 cc
2018-10-19T21:52:21.416Z,1539985941.416 [Reporter](INFO): platform_buoyancy_position 283.345726 cc
2018-10-19T21:52:21.828Z,1539985941.828 [Reporter](INFO): platform_buoyancy_position 287.777657 cc
2018-10-19T21:52:22.233Z,1539985942.233 [Reporter](INFO): platform_buoyancy_position 294.089725 cc
2018-10-19T21:52:22.592Z,1539985942.592 [Reporter](INFO): platform_buoyancy_position 298.387342 cc
2018-10-19T21:52:22.996Z,1539985942.996 [Reporter](INFO): platform_buoyancy_position 303.759327 cc
2018-10-19T21:52:23.423Z,1539985943.423 [Reporter](INFO): platform_buoyancy_position 309.265626 cc
2018-10-19T21:52:23.796Z,1539985943.796 [Reporter](INFO): platform_buoyancy_position 314.100471 cc
2018-10-19T21:52:24.225Z,1539985944.225 [Reporter](INFO): platform_buoyancy_position 320.009654 cc
2018-10-19T21:52:24.596Z,1539985944.596 [Reporter](INFO): platform_buoyancy_position 324.441527 cc
2018-10-19T21:52:24.994Z,1539985944.994 [Reporter](INFO): platform_buoyancy_position 330.485054 cc
2018-10-19T21:52:25.428Z,1539985945.428 [Reporter](INFO): platform_buoyancy_position 335.051271 cc
2018-10-19T21:52:25.830Z,1539985945.830 [Reporter](INFO): platform_buoyancy_position 341.363339 cc
2018-10-19T21:52:26.230Z,1539985946.230 [Reporter](INFO): platform_buoyancy_position 345.660956 cc
2018-10-19T21:52:26.592Z,1539985946.592 [Reporter](INFO): platform_buoyancy_position 351.973023 cc
2018-10-19T21:52:27.006Z,1539985947.006 [Reporter](INFO): platform_buoyancy_position 356.539240 cc
2018-10-19T21:52:27.400Z,1539985947.400 [Reporter](INFO): platform_buoyancy_position 360.836857 cc
2018-10-19T21:52:27.824Z,1539985947.824 [Reporter](INFO): platform_buoyancy_position 367.283268 cc
2018-10-19T21:52:28.204Z,1539985948.204 [Reporter](INFO): platform_buoyancy_position 371.580885 cc
2018-10-19T21:52:28.593Z,1539985948.593 [Reporter](INFO): platform_buoyancy_position 377.892953 cc
2018-10-19T21:52:28.992Z,1539985948.992 [Reporter](INFO): platform_buoyancy_position 382.190541 cc
2018-10-19T21:52:29.407Z,1539985949.407 [Reporter](INFO): platform_buoyancy_position 388.636952 cc
2018-10-19T21:52:29.800Z,1539985949.800 [Reporter](INFO): platform_buoyancy_position 393.203140 cc
2018-10-19T21:52:30.220Z,1539985950.220 [Reporter](INFO): platform_buoyancy_position 399.380922 cc
2018-10-19T21:52:30.606Z,1539985950.606 [Reporter](INFO): platform_buoyancy_position 403.678539 cc
2018-10-19T21:52:30.992Z,1539985950.992 [Reporter](INFO): platform_buoyancy_position 408.110471 cc
2018-10-19T21:52:31.420Z,1539985951.420 [Reporter](INFO): platform_buoyancy_position 414.556824 cc
2018-10-19T21:52:31.804Z,1539985951.804 [Reporter](INFO): platform_buoyancy_position 418.854441 cc
2018-10-19T21:52:32.204Z,1539985952.204 [Reporter](INFO): platform_buoyancy_position 425.166567 cc
2018-10-19T21:52:32.592Z,1539985952.592 [Reporter](INFO): platform_buoyancy_position 429.464184 cc
2018-10-19T21:52:32.992Z,1539985952.992 [Reporter](INFO): platform_buoyancy_position 434.433226 cc
2018-10-19T21:52:33.358Z,1539985953.358 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:52:33.358Z,1539985953.358 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2018-10-19T21:52:33.358Z,1539985953.358 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:52:33.360Z,1539985953.360 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:52:33.360Z,1539985953.360 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15
2018-10-19T21:52:33.360Z,1539985953.360 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:52:33.399Z,1539985953.399 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:52:33.399Z,1539985953.399 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:52:33.401Z,1539985953.401 [Reporter](INFO): platform_buoyancy_position 440.342468 cc
2018-10-19T21:52:33.799Z,1539985953.799 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:52:33.799Z,1539985953.799 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2018-10-19T21:52:33.799Z,1539985953.799 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:52:33.799Z,1539985953.799 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15
2018-10-19T21:52:33.801Z,1539985953.801 [Reporter](INFO): platform_buoyancy_position 446.654536 cc
2018-10-19T21:52:34.164Z,1539985954.164 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:52:34.165Z,1539985954.165 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:52:34.165Z,1539985954.165 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:52:34.166Z,1539985954.166 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:52:34.166Z,1539985954.166 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:52:34.166Z,1539985954.166 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:52:34.231Z,1539985954.231 [Reporter](INFO): platform_buoyancy_position 450.952153 cc
2018-10-19T21:52:34.596Z,1539985954.596 [Reporter](INFO): platform_buoyancy_position 455.518370 cc
2018-10-19T21:52:37.651Z,1539985957.651 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-10-19T21:47:36.6Z
2018-10-19T21:52:37.651Z,1539985957.651 [Default:CheckIn:Read_GPS] Stopped
2018-10-19T21:52:37.651Z,1539985957.651 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-10-19T21:52:37.704Z,1539985957.704 [Reporter](INFO): platform_buoyancy_position 496.211229 cc
2018-10-19T21:52:37.808Z,1539985957.808 [Reporter](INFO): platform_buoyancy_position 497.957168 cc
2018-10-19T21:52:38.200Z,1539985958.200 [Reporter](INFO): platform_buoyancy_position 502.657669 cc
2018-10-19T21:52:38.600Z,1539985958.600 [Reporter](INFO): platform_buoyancy_position 508.835423 cc
2018-10-19T21:52:38.976Z,1539985958.976 [Reporter](INFO): platform_buoyancy_position 513.401697 cc
2018-10-19T21:52:39.379Z,1539985959.379 [Reporter](INFO): platform_buoyancy_position 518.102199 cc
2018-10-19T21:52:39.776Z,1539985959.776 [Reporter](INFO): platform_buoyancy_position 524.145609 cc
2018-10-19T21:52:40.176Z,1539985960.176 [Reporter](INFO): platform_buoyancy_position 528.443255 cc
2018-10-19T21:52:43.272Z,1539985963.272 [Reporter](INFO): platform_buoyancy_position 569.270458 cc
2018-10-19T21:52:43.281Z,1539985963.281 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20181019T212205/Courier0010.lzma
2018-10-19T21:52:43.400Z,1539985963.400 [Reporter](INFO): platform_buoyancy_position 571.284967 cc
2018-10-19T21:52:43.775Z,1539985963.775 [Reporter](INFO): platform_buoyancy_position 575.582555 cc
2018-10-19T21:52:44.083Z,1539985964.083 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Courier0010.lzma.bak
2018-10-19T21:52:44.083Z,1539985964.083 [DataOverHttps](INFO): SBD MOMSN=8741077
2018-10-19T21:52:44.172Z,1539985964.172 [Reporter](INFO): platform_buoyancy_position 582.028937 cc
2018-10-19T21:52:44.572Z,1539985964.572 [Reporter](INFO): platform_buoyancy_position 586.460868 cc
2018-10-19T21:52:44.970Z,1539985964.970 [Reporter](INFO): platform_buoyancy_position 592.101424 cc
2018-10-19T21:52:45.379Z,1539985965.379 [Reporter](INFO): platform_buoyancy_position 597.204838 cc
2018-10-19T21:52:45.776Z,1539985965.776 [Reporter](INFO): platform_buoyancy_position 601.636770 cc
2018-10-19T21:52:48.839Z,1539985968.839 [Reporter](INFO): platform_buoyancy_position 642.195402 cc
2018-10-19T21:52:48.916Z,1539985968.916 [Reporter](INFO): platform_buoyancy_position 644.344196 cc
2018-10-19T21:52:49.328Z,1539985969.328 [Reporter](INFO): platform_buoyancy_position 648.641784 cc
2018-10-19T21:52:49.723Z,1539985969.723 [Reporter](INFO): platform_buoyancy_position 653.207942 cc
2018-10-19T21:52:50.116Z,1539985970.116 [Reporter](INFO): platform_buoyancy_position 659.520098 cc
2018-10-19T21:52:50.534Z,1539985970.534 [Reporter](INFO): platform_buoyancy_position 665.026368 cc
2018-10-19T21:52:50.929Z,1539985970.929 [Reporter](INFO): platform_buoyancy_position 670.398353 cc
2018-10-19T21:52:51.320Z,1539985971.320 [Reporter](INFO): platform_buoyancy_position 675.636053 cc
2018-10-19T21:52:54.480Z,1539985974.480 [Reporter](INFO): platform_buoyancy_position 717.403367 cc
2018-10-19T21:52:54.491Z,1539985974.491 [DataOverHttps](INFO): Sending 672 bytes from file Logs/20181019T212205/Express0011.lzma
2018-10-19T21:52:54.580Z,1539985974.580 [Reporter](INFO): platform_buoyancy_position 717.671996 cc
2018-10-19T21:52:54.972Z,1539985974.972 [Reporter](INFO): platform_buoyancy_position 723.849807 cc
2018-10-19T21:52:55.290Z,1539985975.290 [DataOverHttps](INFO): Moved sent file to Logs/20181019T212205/Express0011.lzma.bak
2018-10-19T21:52:55.291Z,1539985975.291 [DataOverHttps](INFO): SBD MOMSN=8741080
2018-10-19T21:52:55.383Z,1539985975.383 [Reporter](INFO): platform_buoyancy_position 728.281680 cc
2018-10-19T21:52:55.755Z,1539985975.755 [Default:CheckIn:Read_Iridium] Stopped
2018-10-19T21:52:55.755Z,1539985975.755 [Default:CheckIn:C.Wait] Running Loop=1
2018-10-19T21:52:55.755Z,1539985975.755 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-10-19T21:52:55.821Z,1539985975.821 [Reporter](INFO): platform_buoyancy_position 734.593777 cc
2018-10-19T21:52:56.169Z,1539985976.169 [Reporter](INFO): platform_buoyancy_position 738.891365 cc
2018-10-19T21:52:56.571Z,1539985976.571 [Reporter](INFO): platform_buoyancy_position 743.457582 cc
2018-10-19T21:52:56.960Z,1539985976.960 [Reporter](INFO): platform_buoyancy_position 749.635394 cc
2018-10-19T21:53:00.043Z,1539985980.043 [Reporter](INFO): platform_buoyancy_position 789.522484 cc
2018-10-19T21:53:00.156Z,1539985980.156 [Reporter](INFO): platform_buoyancy_position 790.596881 cc
2018-10-19T21:53:00.532Z,1539985980.532 [Reporter](INFO): platform_buoyancy_position 795.565953 cc
2018-10-19T21:53:00.942Z,1539985980.942 [Reporter](INFO): platform_buoyancy_position 801.206566 cc
2018-10-19T21:53:01.323Z,1539985981.323 [Reporter](INFO): platform_buoyancy_position 805.772783 cc
2018-10-19T21:53:01.711Z,1539985981.711 [Reporter](INFO): platform_buoyancy_position 811.950536 cc
2018-10-19T21:53:02.138Z,1539985982.138 [Reporter](INFO): platform_buoyancy_position 816.382468 cc
2018-10-19T21:53:02.536Z,1539985982.536 [Reporter](INFO): platform_buoyancy_position 822.694565 cc
2018-10-19T21:53:02.944Z,1539985982.944 [Reporter](INFO): platform_buoyancy_position 826.992211 cc
2018-10-19T21:53:03.340Z,1539985983.340 [Reporter](INFO): platform_buoyancy_position 833.438593 cc
2018-10-19T21:53:03.712Z,1539985983.712 [Reporter](INFO): platform_buoyancy_position 837.736181 cc
2018-10-19T21:53:04.121Z,1539985984.121 [Reporter](INFO): platform_buoyancy_position 842.168112 cc
2018-10-19T21:53:04.512Z,1539985984.512 [Reporter](INFO): platform_buoyancy_position 848.614494 cc
2018-10-19T21:53:04.912Z,1539985984.912 [Reporter](INFO): platform_buoyancy_position 852.912082 cc
2018-10-19T21:53:05.336Z,1539985985.336 [Reporter](INFO): platform_buoyancy_position 859.224121 cc
2018-10-19T21:53:05.746Z,1539985985.746 [Reporter](INFO): platform_buoyancy_position 863.656111 cc
2018-10-19T21:53:06.136Z,1539985986.136 [Reporter](INFO): platform_buoyancy_position 869.968149 cc
2018-10-19T21:53:06.542Z,1539985986.542 [Reporter](INFO): platform_buoyancy_position 874.400022 cc
2018-10-19T21:53:06.937Z,1539985986.937 [Reporter](INFO): platform_buoyancy_position 878.966297 cc
2018-10-19T21:53:07.312Z,1539985987.312 [Reporter](INFO): platform_buoyancy_position 885.144051 cc
2018-10-19T21:53:07.712Z,1539985987.712 [Reporter](INFO): platform_buoyancy_position 889.441639 cc
2018-10-19T21:53:08.112Z,1539985988.112 [Reporter](INFO): platform_buoyancy_position 895.753794 cc
2018-10-19T21:53:08.528Z,1539985988.528 [Reporter](INFO): platform_buoyancy_position 900.185667 cc
2018-10-19T21:53:08.943Z,1539985988.943 [Reporter](INFO): platform_buoyancy_position 906.497822 cc
2018-10-19T21:53:09.343Z,1539985989.343 [Reporter](INFO): platform_buoyancy_position 911.063980 cc
2018-10-19T21:53:09.712Z,1539985989.712 [Reporter](INFO): platform_buoyancy_position 917.241792 cc
2018-10-19T21:53:10.136Z,1539985990.136 [Reporter](INFO): platform_buoyancy_position 921.539438 cc
2018-10-19T21:53:10.512Z,1539985990.512 [Reporter](INFO): platform_buoyancy_position 925.971312 cc
2018-10-19T21:53:10.912Z,1539985990.912 [Reporter](INFO): platform_buoyancy_position 932.283350 cc
2018-10-19T21:53:11.337Z,1539985991.337 [Reporter](INFO): platform_buoyancy_position 936.715340 cc
2018-10-19T21:53:11.743Z,1539985991.743 [Reporter](INFO): platform_buoyancy_position 942.893093 cc
2018-10-19T21:53:12.172Z,1539985992.172 [Reporter](INFO): platform_buoyancy_position 947.324967 cc
2018-10-19T21:53:31.815Z,1539986011.815 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000.000000 cubic_centimeter
2018-10-19T21:53:31.816Z,1539986011.816 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2018-10-19T21:53:32.108Z,1539986012.108 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:53:39.316Z,1539986019.316 [Reporter](INFO): platform_buoyancy_position 960.083504 cc
2018-10-19T21:53:40.084Z,1539986020.084 [Reporter](INFO): platform_buoyancy_position 960.352074 cc
2018-10-19T21:53:40.498Z,1539986020.498 [Reporter](INFO): platform_buoyancy_position 953.905634 cc
2018-10-19T21:53:40.906Z,1539986020.906 [Reporter](INFO): platform_buoyancy_position 958.068995 cc
2018-10-19T21:53:41.299Z,1539986021.299 [Reporter](INFO): platform_buoyancy_position 960.352074 cc
2018-10-19T21:53:41.676Z,1539986021.676 [Reporter](INFO): platform_buoyancy_position 962.500868 cc
2018-10-19T21:53:42.091Z,1539986022.091 [Reporter](INFO): platform_buoyancy_position 964.649662 cc
2018-10-19T21:53:42.472Z,1539986022.472 [Reporter](INFO): platform_buoyancy_position 966.798456 cc
2018-10-19T21:53:42.888Z,1539986022.888 [Reporter](INFO): platform_buoyancy_position 968.812965 cc
2018-10-19T21:53:43.275Z,1539986023.275 [Reporter](INFO): platform_buoyancy_position 968.947250 cc
2018-10-19T21:53:43.696Z,1539986023.696 [Reporter](INFO): platform_buoyancy_position 970.961817 cc
2018-10-19T21:53:44.096Z,1539986024.096 [Reporter](INFO): platform_buoyancy_position 973.244896 cc
2018-10-19T21:53:44.868Z,1539986024.868 [Reporter](INFO): platform_buoyancy_position 975.259405 cc
2018-10-19T21:53:45.264Z,1539986025.264 [Reporter](INFO): platform_buoyancy_position 975.393690 cc
2018-10-19T21:53:45.698Z,1539986025.698 [Reporter](INFO): platform_buoyancy_position 977.408257 cc
2018-10-19T21:53:46.084Z,1539986026.084 [Reporter](INFO): platform_buoyancy_position 979.557051 cc
2018-10-19T21:53:46.909Z,1539986026.909 [Reporter](INFO): platform_buoyancy_position 981.705845 cc
2018-10-19T21:53:47.284Z,1539986027.284 [Reporter](INFO): platform_buoyancy_position 981.840072 cc
2018-10-19T21:53:47.664Z,1539986027.664 [Reporter](INFO): platform_buoyancy_position 983.854639 cc
2018-10-19T21:53:48.099Z,1539986028.099 [Reporter](INFO): platform_buoyancy_position 986.137660 cc
2018-10-19T21:53:48.860Z,1539986028.860 [Reporter](INFO): platform_buoyancy_position 988.286454 cc
2018-10-19T21:53:49.284Z,1539986029.284 [Reporter](INFO): platform_buoyancy_position 988.420798 cc
2018-10-19T21:53:49.684Z,1539986029.684 [Reporter](INFO): platform_buoyancy_position 990.301021 cc
2018-10-19T21:54:05.095Z,1539986045.095 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1020.000000 cubic_centimeter
2018-10-19T21:54:06.504Z,1539986046.504 [Reporter](INFO): platform_buoyancy_position 1001.044991 cc
2018-10-19T21:54:09.563Z,1539986049.563 [Reporter](INFO): platform_buoyancy_position 1007.491373 cc
2018-10-19T21:54:10.068Z,1539986050.068 [Reporter](INFO): platform_buoyancy_position 1008.028514 cc
2018-10-19T21:54:10.457Z,1539986050.457 [Reporter](INFO): platform_buoyancy_position 1009.640167 cc
2018-10-19T21:54:10.860Z,1539986050.860 [Reporter](INFO): platform_buoyancy_position 1011.788961 cc
2018-10-19T21:54:22.331Z,1539986062.331 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1050.000000 cubic_centimeter
2018-10-19T21:54:23.663Z,1539986063.663 [Reporter](INFO): platform_buoyancy_position 1022.532932 cc
2018-10-19T21:54:24.028Z,1539986064.028 [Reporter](INFO): platform_buoyancy_position 1022.667275 cc
2018-10-19T21:54:24.464Z,1539986064.464 [Reporter](INFO): platform_buoyancy_position 1022.532932 cc
2018-10-19T21:54:24.869Z,1539986064.869 [Reporter](INFO): platform_buoyancy_position 1016.086549 cc
2018-10-19T21:54:25.268Z,1539986065.268 [Reporter](INFO): platform_buoyancy_position 1020.384138 cc
2018-10-19T21:54:26.420Z,1539986066.420 [Reporter](INFO): platform_buoyancy_position 1020.249911 cc
2018-10-19T21:54:26.836Z,1539986066.836 [Reporter](INFO): platform_buoyancy_position 1020.518481 cc
2018-10-19T21:54:27.575Z,1539986067.575 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-10-19T21:54:27.575Z,1539986067.575 [NAL9602] Data Fault, FailCount= 3
2018-10-19T21:54:27.575Z,1539986067.575 [NAL9602](ERROR): Data Fault
2018-10-19T21:54:27.638Z,1539986067.638 [CBIT](ERROR): Data Fault in component: NAL9602
2018-10-19T21:54:27.640Z,1539986067.640 [Reporter](INFO): platform_buoyancy_position 1020.384138 cc
2018-10-19T21:54:27.978Z,1539986067.978 [NAL9602](INFO): Powering down
2018-10-19T21:54:28.440Z,1539986068.440 [Reporter](INFO): platform_buoyancy_position 1020.518481 cc
2018-10-19T21:54:28.822Z,1539986068.822 [CBIT](INFO): Clearing failed state for component NAL9602
2018-10-19T21:54:28.822Z,1539986068.822 [NAL9602] No Fault, FailCount= 3
2018-10-19T21:54:28.824Z,1539986068.824 [Reporter](INFO): platform_buoyancy_position 1020.384138 cc
2018-10-19T21:54:30.040Z,1539986070.040 [Reporter](INFO): platform_buoyancy_position 1018.772600 cc
2018-10-19T21:54:30.450Z,1539986070.450 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:31.228Z,1539986071.228 [Reporter](INFO): platform_buoyancy_position 1019.309857 cc
2018-10-19T21:54:31.646Z,1539986071.646 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:32.863Z,1539986072.863 [Reporter](INFO): platform_buoyancy_position 1020.249911 cc
2018-10-19T21:54:33.259Z,1539986073.259 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:33.656Z,1539986073.656 [Reporter](INFO): platform_buoyancy_position 1018.369687 cc
2018-10-19T21:54:34.063Z,1539986074.063 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:34.379Z,1539986074.379 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:54:34.379Z,1539986074.379 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2018-10-19T21:54:34.379Z,1539986074.379 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:54:34.381Z,1539986074.381 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:54:34.381Z,1539986074.381 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16
2018-10-19T21:54:34.381Z,1539986074.381 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:54:34.458Z,1539986074.458 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:54:34.459Z,1539986074.459 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:54:34.870Z,1539986074.870 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:54:34.870Z,1539986074.870 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2018-10-19T21:54:34.871Z,1539986074.871 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:54:34.871Z,1539986074.871 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16
2018-10-19T21:54:34.884Z,1539986074.884 [Reporter](INFO): platform_buoyancy_position 1018.772600 cc
2018-10-19T21:54:35.188Z,1539986075.188 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:54:35.189Z,1539986075.189 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:54:35.189Z,1539986075.189 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:54:35.190Z,1539986075.190 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:54:35.190Z,1539986075.190 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:54:35.190Z,1539986075.190 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:54:35.280Z,1539986075.280 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:36.088Z,1539986076.088 [Reporter](INFO): platform_buoyancy_position 1018.638257 cc
2018-10-19T21:54:36.475Z,1539986076.475 [Reporter](INFO): platform_buoyancy_position 1018.235344 cc
2018-10-19T21:54:36.887Z,1539986076.887 [Reporter](INFO): platform_buoyancy_position 1018.638257 cc
2018-10-19T21:54:37.284Z,1539986077.284 [Reporter](INFO): platform_buoyancy_position 1019.175514 cc
2018-10-19T21:54:37.676Z,1539986077.676 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:38.087Z,1539986078.087 [Reporter](INFO): platform_buoyancy_position 1018.369687 cc
2018-10-19T21:54:38.452Z,1539986078.452 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:39.287Z,1539986079.287 [Reporter](INFO): platform_buoyancy_position 1018.772600 cc
2018-10-19T21:54:39.656Z,1539986079.656 [Reporter](INFO): platform_buoyancy_position 1018.504030 cc
2018-10-19T21:54:39.857Z,1539986079.857 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:54:40.069Z,1539986080.069 [BuoyancyServo](FAULT): Overload Error
2018-10-19T21:54:40.069Z,1539986080.069 [BuoyancyServo] Hardware Fault, FailCount= 1
2018-10-19T21:54:40.069Z,1539986080.069 [BuoyancyServo](ERROR): Hardware Fault
2018-10-19T21:54:40.075Z,1539986080.075 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo
2018-10-19T21:54:40.080Z,1539986080.080 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:54:40.410Z,1539986080.410 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-10-19T21:54:40.411Z,1539986080.411 [BuoyancyServo](INFO): Powering down
2018-10-19T21:54:44.762Z,1539986084.762 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-10-19T21:54:44.763Z,1539986084.763 [BuoyancyServo] No Fault, FailCount= 1
2018-10-19T21:54:45.115Z,1539986085.115 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-10-19T21:54:45.230Z,1539986085.230 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-10-19T21:54:47.918Z,1539986087.918 [Reporter](INFO): platform_buoyancy_position 1018.235344 cc
2018-10-19T21:54:48.400Z,1539986088.400 [Reporter](INFO): platform_buoyancy_position 1026.964863 cc
2018-10-19T21:54:49.160Z,1539986089.160 [Reporter](INFO): platform_buoyancy_position 1026.830520 cc
2018-10-19T21:54:49.564Z,1539986089.564 [Reporter](INFO): platform_buoyancy_position 1020.384138 cc
2018-10-19T21:54:51.156Z,1539986091.156 [Reporter](INFO): platform_buoyancy_position 1020.115567 cc
2018-10-19T21:54:51.569Z,1539986091.569 [Reporter](INFO): platform_buoyancy_position 1019.444084 cc
2018-10-19T21:54:51.965Z,1539986091.965 [Reporter](INFO): platform_buoyancy_position 1020.249911 cc
2018-10-19T21:54:52.356Z,1539986092.356 [Reporter](INFO): platform_buoyancy_position 1019.175514 cc
2018-10-19T21:54:52.760Z,1539986092.760 [Reporter](INFO): platform_buoyancy_position 1018.101117 cc
2018-10-19T21:54:53.165Z,1539986093.165 [Reporter](INFO): platform_buoyancy_position 1016.086549 cc
2018-10-19T21:54:53.560Z,1539986093.560 [Reporter](INFO): platform_buoyancy_position 1014.072099 cc
2018-10-19T21:54:53.960Z,1539986093.960 [Reporter](INFO): platform_buoyancy_position 1012.057648 cc
2018-10-19T21:54:54.351Z,1539986094.351 [Reporter](INFO): platform_buoyancy_position 1011.788961 cc
2018-10-19T21:54:54.756Z,1539986094.756 [Reporter](INFO): platform_buoyancy_position 1009.774511 cc
2018-10-19T21:54:55.160Z,1539986095.160 [Reporter](INFO): platform_buoyancy_position 1007.625717 cc
2018-10-19T21:54:55.956Z,1539986095.956 [Reporter](INFO): platform_buoyancy_position 1005.476923 cc
2018-10-19T21:54:56.362Z,1539986096.362 [Reporter](INFO): platform_buoyancy_position 1003.865269 cc
2018-10-19T21:54:56.765Z,1539986096.765 [Reporter](INFO): platform_buoyancy_position 1003.193902 cc
2018-10-19T21:54:57.160Z,1539986097.160 [Reporter](INFO): platform_buoyancy_position 1001.179335 cc
2018-10-19T21:54:57.560Z,1539986097.560 [Reporter](INFO): platform_buoyancy_position 1001.044991 cc
2018-10-19T21:54:57.964Z,1539986097.964 [Reporter](INFO): platform_buoyancy_position 998.896197 cc
2018-10-19T21:54:58.297Z,1539986098.297 [NAL9602](INFO): Powering up NAL9602
2018-10-19T21:54:58.363Z,1539986098.363 [Reporter](INFO): platform_buoyancy_position 997.150317 cc
2018-10-19T21:54:58.772Z,1539986098.772 [Reporter](INFO): platform_buoyancy_position 996.747403 cc
2018-10-19T21:54:59.168Z,1539986099.168 [Reporter](INFO): platform_buoyancy_position 994.598609 cc
2018-10-19T21:54:59.560Z,1539986099.560 [Reporter](INFO): platform_buoyancy_position 994.464266 cc
2018-10-19T21:54:59.973Z,1539986099.973 [Reporter](INFO): platform_buoyancy_position 992.584159 cc
2018-10-19T21:55:00.367Z,1539986100.367 [Reporter](INFO): platform_buoyancy_position 990.569592 cc
2018-10-19T21:55:00.760Z,1539986100.760 [Reporter](INFO): platform_buoyancy_position 990.435248 cc
2018-10-19T21:55:01.168Z,1539986101.168 [Reporter](INFO): platform_buoyancy_position 988.152227 cc
2018-10-19T21:55:01.964Z,1539986101.964 [Reporter](INFO): platform_buoyancy_position 986.003433 cc
2018-10-19T21:55:02.366Z,1539986102.366 [Reporter](INFO): platform_buoyancy_position 984.123209 cc
2018-10-19T21:55:02.767Z,1539986102.767 [Reporter](INFO): platform_buoyancy_position 983.854639 cc
2018-10-19T21:55:03.164Z,1539986103.164 [Reporter](INFO): platform_buoyancy_position 981.840072 cc
2018-10-19T21:55:03.566Z,1539986103.566 [Reporter](INFO): platform_buoyancy_position 981.437159 cc
2018-10-19T21:55:03.973Z,1539986103.973 [Reporter](INFO): platform_buoyancy_position 979.557051 cc
2018-10-19T21:55:04.363Z,1539986104.363 [Reporter](INFO): platform_buoyancy_position 977.542484 cc
2018-10-19T21:55:04.766Z,1539986104.766 [Reporter](INFO): platform_buoyancy_position 977.273914 cc
2018-10-19T21:55:05.167Z,1539986105.167 [Reporter](INFO): platform_buoyancy_position 975.393690 cc
2018-10-19T21:55:05.566Z,1539986105.566 [Reporter](INFO): platform_buoyancy_position 973.244896 cc
2018-10-19T21:55:05.962Z,1539986105.962 [Reporter](INFO): platform_buoyancy_position 973.110611 cc
2018-10-19T21:55:06.370Z,1539986106.370 [Reporter](INFO): platform_buoyancy_position 971.096044 cc
2018-10-19T21:55:06.764Z,1539986106.764 [Reporter](INFO): platform_buoyancy_position 970.827532 cc
2018-10-19T21:55:07.151Z,1539986107.151 [Reporter](INFO): platform_buoyancy_position 968.812965 cc
2018-10-19T21:55:07.539Z,1539986107.539 [Reporter](INFO): platform_buoyancy_position 966.798456 cc
2018-10-19T21:55:08.355Z,1539986108.355 [Reporter](INFO): platform_buoyancy_position 964.515377 cc
2018-10-19T21:55:09.510Z,1539986109.510 [NAL9602](INFO): NAL9602 initialized
2018-10-19T21:55:17.267Z,1539986117.267 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 700.000000 cubic_centimeter
2018-10-19T21:55:17.268Z,1539986117.268 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2018-10-19T21:55:17.532Z,1539986117.532 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-19T21:55:24.712Z,1539986124.712 [Reporter](INFO): platform_buoyancy_position 970.961817 cc
2018-10-19T21:55:25.082Z,1539986125.082 [Reporter](INFO): platform_buoyancy_position 971.096044 cc
2018-10-19T21:55:25.464Z,1539986125.464 [Reporter](INFO): platform_buoyancy_position 968.947250 cc
2018-10-19T21:55:25.865Z,1539986125.865 [Reporter](INFO): platform_buoyancy_position 958.203222 cc
2018-10-19T21:55:26.282Z,1539986126.282 [Reporter](INFO): platform_buoyancy_position 956.188829 cc
2018-10-19T21:55:26.680Z,1539986126.680 [Reporter](INFO): platform_buoyancy_position 953.771349 cc
2018-10-19T21:55:27.076Z,1539986127.076 [Reporter](INFO): platform_buoyancy_position 949.473761 cc
2018-10-19T21:55:27.509Z,1539986127.509 [Reporter](INFO): platform_buoyancy_position 945.176173 cc
2018-10-19T21:55:27.868Z,1539986127.868 [Reporter](INFO): platform_buoyancy_position 940.475729 cc
2018-10-19T21:55:28.268Z,1539986128.268 [Reporter](INFO): platform_buoyancy_position 934.432144 cc
2018-10-19T21:55:28.674Z,1539986128.674 [Reporter](INFO): platform_buoyancy_position 930.134614 cc
2018-10-19T21:55:29.074Z,1539986129.074 [Reporter](INFO): platform_buoyancy_position 924.091088 cc
2018-10-19T21:55:29.464Z,1539986129.464 [Reporter](INFO): platform_buoyancy_position 919.524929 cc
2018-10-19T21:55:29.909Z,1539986129.909 [Reporter](INFO): platform_buoyancy_position 913.078489 cc
2018-10-19T21:55:30.280Z,1539986130.280 [Reporter](INFO): platform_buoyancy_position 908.646616 cc
2018-10-19T21:55:30.668Z,1539986130.668 [Reporter](INFO): platform_buoyancy_position 902.468746 cc
2018-10-19T21:55:31.079Z,1539986131.079 [Reporter](INFO): platform_buoyancy_position 897.902588 cc
2018-10-19T21:55:31.472Z,1539986131.472 [Reporter](INFO): platform_buoyancy_position 893.605000 cc
2018-10-19T21:55:31.868Z,1539986131.868 [Reporter](INFO): platform_buoyancy_position 887.292845 cc
2018-10-19T21:55:32.276Z,1539986132.276 [Reporter](INFO): platform_buoyancy_position 882.995257 cc
2018-10-19T21:55:32.684Z,1539986132.684 [Reporter](INFO): platform_buoyancy_position 876.683218 cc
2018-10-19T21:55:33.109Z,1539986133.109 [Reporter](INFO): platform_buoyancy_position 872.251228 cc
2018-10-19T21:55:33.499Z,1539986133.499 [Reporter](INFO): platform_buoyancy_position 865.670561 cc
2018-10-19T21:55:33.872Z,1539986133.872 [Reporter](INFO): platform_buoyancy_position 861.507317 cc
2018-10-19T21:55:34.274Z,1539986134.274 [Reporter](INFO): platform_buoyancy_position 856.941042 cc
2018-10-19T21:55:34.680Z,1539986134.680 [Reporter](INFO): platform_buoyancy_position 850.629003 cc
2018-10-19T21:55:35.072Z,1539986135.072 [Reporter](INFO): platform_buoyancy_position 846.465700 cc
2018-10-19T21:55:35.474Z,1539986135.474 [Reporter](INFO): platform_buoyancy_position 840.287830 cc
2018-10-19T21:55:35.903Z,1539986135.903 [Reporter](INFO): platform_buoyancy_position 835.587387 cc
2018-10-19T21:55:36.284Z,1539986136.284 [Reporter](INFO): platform_buoyancy_position 829.275290 cc
2018-10-19T21:55:36.676Z,1539986136.676 [Reporter](INFO): platform_buoyancy_position 824.977644 cc
2018-10-19T21:55:37.080Z,1539986137.080 [Reporter](INFO): platform_buoyancy_position 819.874287 cc
2018-10-19T21:55:37.469Z,1539986137.469 [Reporter](INFO): platform_buoyancy_position 814.099389 cc
2018-10-19T21:55:37.872Z,1539986137.872 [Reporter](INFO): platform_buoyancy_position 809.667457 cc
2018-10-19T21:55:38.276Z,1539986138.276 [Reporter](INFO): platform_buoyancy_position 803.489704 cc
2018-10-19T21:55:38.680Z,1539986138.680 [Reporter](INFO): platform_buoyancy_position 799.057772 cc
2018-10-19T21:55:39.080Z,1539986139.080 [Reporter](INFO): platform_buoyancy_position 792.745675 cc
2018-10-19T21:55:39.488Z,1539986139.488 [Reporter](INFO): platform_buoyancy_position 788.313802 cc
2018-10-19T21:55:39.868Z,1539986139.868 [Reporter](INFO): platform_buoyancy_position 783.613301 cc
2018-10-19T21:55:40.272Z,1539986140.272 [Reporter](INFO): platform_buoyancy_position 777.704117 cc
2018-10-19T21:55:40.676Z,1539986140.676 [Reporter](INFO): platform_buoyancy_position 772.869273 cc
2018-10-19T21:55:41.072Z,1539986141.072 [Reporter](INFO): platform_buoyancy_position 766.825746 cc
2018-10-19T21:55:41.474Z,1539986141.474 [Reporter](INFO): platform_buoyancy_position 762.528216 cc
2018-10-19T21:55:41.884Z,1539986141.884 [Reporter](INFO): platform_buoyancy_position 758.096226 cc
2018-10-19T21:55:42.280Z,1539986142.280 [Reporter](INFO): platform_buoyancy_position 751.784188 cc
2018-10-19T21:55:42.674Z,1539986142.674 [Reporter](INFO): platform_buoyancy_position 747.352315 cc
2018-10-19T21:55:43.082Z,1539986143.082 [Reporter](INFO): platform_buoyancy_position 741.040159 cc
2018-10-19T21:55:43.476Z,1539986143.476 [Reporter](INFO): platform_buoyancy_position 736.071030 cc
2018-10-19T21:55:43.874Z,1539986143.874 [Reporter](INFO): platform_buoyancy_position 730.430475 cc
2018-10-19T21:55:44.284Z,1539986144.284 [Reporter](INFO): platform_buoyancy_position 725.595630 cc
2018-10-19T21:55:44.676Z,1539986144.676 [Reporter](INFO): platform_buoyancy_position 719.686446 cc
2018-10-19T21:55:44.754Z,1539986144.754 [CommandLine](IMPORTANT): got command maintain clear
2018-10-19T21:55:45.080Z,1539986145.080 [Reporter](INFO): platform_buoyancy_position 714.985945 cc
2018-10-19T21:55:45.094Z,1539986145.094 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,SCPI,BPC1,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-10-19T21:55:45.522Z,1539986145.522 [Reporter](INFO): platform_buoyancy_position 709.076761 cc
2018-10-19T21:55:45.864Z,1539986145.864 [Reporter](INFO): platform_buoyancy_position 706.793624 cc
2018-10-19T21:55:46.273Z,1539986146.273 [Reporter](INFO): platform_buoyancy_position 706.525112 cc
2018-10-19T21:55:46.689Z,1539986146.689 [Reporter](INFO): platform_buoyancy_position 706.659339 cc
2018-10-19T21:55:47.064Z,1539986147.064 [Reporter](INFO): platform_buoyancy_position 711.091270 cc
2018-10-19T21:55:47.476Z,1539986147.476 [Reporter](INFO): platform_buoyancy_position 715.388858 cc
2018-10-19T21:55:47.888Z,1539986147.888 [Reporter](INFO): platform_buoyancy_position 720.089360 cc
2018-10-19T21:55:48.287Z,1539986148.287 [Reporter](INFO): platform_buoyancy_position 726.132886 cc
2018-10-19T21:55:48.687Z,1539986148.687 [Reporter](INFO): platform_buoyancy_position 730.430475 cc
2018-10-19T21:55:49.084Z,1539986149.084 [Reporter](INFO): platform_buoyancy_position 735.265261 cc
2018-10-19T21:55:49.480Z,1539986149.480 [Reporter](INFO): platform_buoyancy_position 741.174503 cc
2018-10-19T21:55:49.882Z,1539986149.882 [CBIT](INFO): Clearing failed state for component BPC1
2018-10-19T21:55:49.882Z,1539986149.882 [BPC1] No Fault, FailCount= 3
2018-10-19T21:55:49.884Z,1539986149.884 [Reporter](INFO): platform_buoyancy_position 745.337748 cc
2018-10-19T21:55:50.312Z,1539986150.312 [Reporter](INFO): platform_buoyancy_position 751.784188 cc
2018-10-19T21:55:50.687Z,1539986150.687 [Reporter](INFO): platform_buoyancy_position 756.081776 cc
2018-10-19T21:55:51.090Z,1539986151.090 [Reporter](INFO): platform_buoyancy_position 761.722331 cc
2018-10-19T21:55:51.488Z,1539986151.488 [Reporter](INFO): platform_buoyancy_position 766.825746 cc
2018-10-19T21:55:51.873Z,1539986151.873 [Reporter](INFO): platform_buoyancy_position 771.391962 cc
2018-10-19T21:55:52.272Z,1539986152.272 [Reporter](INFO): platform_buoyancy_position 777.569774 cc
2018-10-19T21:55:52.686Z,1539986152.686 [Reporter](INFO): platform_buoyancy_position 782.001647 cc
2018-10-19T21:55:55.748Z,1539986155.748 [Reporter](INFO): platform_buoyancy_position 822.963193 cc
2018-10-19T21:55:55.864Z,1539986155.864 [Reporter](INFO): platform_buoyancy_position 824.843359 cc
2018-10-19T21:55:56.238Z,1539986156.238 [Reporter](INFO): platform_buoyancy_position 829.275290 cc
2018-10-19T21:55:56.648Z,1539986156.648 [Reporter](INFO): platform_buoyancy_position 835.587387 cc
2018-10-19T21:55:57.038Z,1539986157.038 [Reporter](INFO): platform_buoyancy_position 840.019260 cc
2018-10-19T21:55:57.440Z,1539986157.440 [Reporter](INFO): platform_buoyancy_position 844.585476 cc
2018-10-19T21:55:57.849Z,1539986157.849 [Reporter](INFO): platform_buoyancy_position 850.629003 cc
2018-10-19T21:55:58.221Z,1539986158.221 [Reporter](INFO): platform_buoyancy_position 855.195161 cc
2018-10-19T21:55:58.639Z,1539986158.639 [Reporter](INFO): platform_buoyancy_position 861.372915 cc
2018-10-19T21:55:59.040Z,1539986159.040 [Reporter](INFO): platform_buoyancy_position 865.804905 cc
2018-10-19T21:55:59.432Z,1539986159.432 [Reporter](INFO): platform_buoyancy_position 872.116943 cc
2018-10-19T21:55:59.830Z,1539986159.830 [Reporter](INFO): platform_buoyancy_position 876.548816 cc
2018-10-19T21:56:00.242Z,1539986160.242 [Reporter](INFO): platform_buoyancy_position 882.189430 cc
2018-10-19T21:56:00.636Z,1539986160.636 [Reporter](INFO): platform_buoyancy_position 887.292845 cc
2018-10-19T21:56:01.038Z,1539986161.038 [Reporter](INFO): platform_buoyancy_position 892.127689 cc
2018-10-19T21:56:01.440Z,1539986161.440 [Reporter](INFO): platform_buoyancy_position 898.036873 cc
2018-10-19T21:56:01.832Z,1539986161.832 [Reporter](INFO): platform_buoyancy_position 904.348970 cc
2018-10-19T21:56:02.236Z,1539986162.236 [Reporter](INFO): platform_buoyancy_position 908.780901 cc
2018-10-19T21:56:02.640Z,1539986162.640 [Reporter](INFO): platform_buoyancy_position 915.092998 cc
2018-10-19T21:56:03.032Z,1539986163.032 [Reporter](INFO): platform_buoyancy_position 919.524929 cc
2018-10-19T21:56:03.440Z,1539986163.440 [Reporter](INFO): platform_buoyancy_position 923.822518 cc
2018-10-19T21:56:03.837Z,1539986163.837 [Reporter](INFO): platform_buoyancy_position 930.134614 cc
2018-10-19T21:56:04.232Z,1539986164.232 [Reporter](INFO): platform_buoyancy_position 934.566546 cc
2018-10-19T21:56:04.643Z,1539986164.643 [Reporter](INFO): platform_buoyancy_position 938.998419 cc
2018-10-19T21:56:05.076Z,1539986165.076 [Reporter](INFO): platform_buoyancy_position 945.310399 cc
2018-10-19T21:56:35.304Z,1539986195.304 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:56:35.304Z,1539986195.304 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2018-10-19T21:56:35.304Z,1539986195.304 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2018-10-19T21:56:35.306Z,1539986195.306 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-10-19T21:56:35.306Z,1539986195.306 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17
2018-10-19T21:56:35.306Z,1539986195.306 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-19T21:56:35.360Z,1539986195.360 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2018-10-19T21:56:35.361Z,1539986195.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-19T21:56:35.712Z,1539986195.712 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2018-10-19T21:56:35.712Z,1539986195.712 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2018-10-19T21:56:35.713Z,1539986195.713 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-19T21:56:35.713Z,1539986195.713 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17
2018-10-19T21:56:36.100Z,1539986196.100 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-10-19T21:56:36.101Z,1539986196.101 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:56:36.101Z,1539986196.101 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:56:36.102Z,1539986196.102 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-19T21:56:36.102Z,1539986196.102 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-19T21:56:36.103Z,1539986196.103 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-19T21:56:57.707Z,1539986217.707 [BPC1](ERROR): BPC1A: No match for serial number 0226 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2018-10-19T21:56:57.708Z,1539986217.708 [BPC1](ERROR): BPC1B: No match for serial number 0273 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2018-10-19T21:56:57.708Z,1539986217.708 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-10-19T21:56:57.708Z,1539986217.708 [BPC1] Data Fault, FailCount= 4
2018-10-19T21:56:57.708Z,1539986217.708 [BPC1](ERROR): Data Fault
2018-10-19T21:56:57.787Z,1539986217.787 [CBIT](ERROR): Data Fault in component: BPC1
2018-10-19T21:57:56.352Z,1539986276.352 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2018-10-19T21:57:56.353Z,1539986276.353 [Default:CheckIn:C.Wait] Stopped
2018-10-19T21:57:56.353Z,1539986276.353 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-10-19T21:57:56.353Z,1539986276.353 [Default:CheckIn:D] Running Loop=1
2018-10-19T21:57:56.759Z,1539986276.759 [Default:CheckIn:D] Stopped
2018-10-19T21:57:56.759Z,1539986276.759 [Default:CheckIn:E] Running Loop=1
2018-10-19T21:57:57.142Z,1539986277.142 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.205796 min 
2018-10-19T21:57:57.142Z,1539986277.142 [Default:CheckIn:E] Stopped
2018-10-19T21:57:57.142Z,1539986277.142 [Default:CheckIn](INFO): Completed Default:CheckIn
2018-10-19T21:57:57.142Z,1539986277.142 [Default:CheckIn] Stopped
2018-10-19T21:57:57.142Z,1539986277.142 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-19T21:57:57.142Z,1539986277.142 [Default:CheckIn](INFO): Running loop #4
2018-10-19T21:57:57.143Z,1539986277.143 [Default:CheckIn] Running Loop=4
2018-10-19T21:57:57.143Z,1539986277.143 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-19T21:57:57.143Z,1539986277.143 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-19T21:58:15.230Z,1539986295.230 [CommandLine](IMPORTANT): got command quit
2018-10-19T21:58:16.240Z,1539986296.240 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:16.240Z,1539986296.240 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.317Z,1539986296.317 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-10-19T21:58:16.317Z,1539986296.317 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.318Z,1539986296.318 [CommandLine](INFO): Join timeout helper Thread ID is 3563
2018-10-19T21:58:16.321Z,1539986296.321 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-10-19T21:58:16.321Z,1539986296.321 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.322Z,1539986296.322 [NavChartDb](INFO): Join timeout helper Thread ID is 3564
2018-10-19T21:58:16.713Z,1539986296.713 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:16.713Z,1539986296.713 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.729Z,1539986296.729 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-10-19T21:58:16.729Z,1539986296.729 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.729Z,1539986296.729 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3565
2018-10-19T21:58:16.817Z,1539986296.817 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:16.817Z,1539986296.817 [WetLabsBB2FL](INFO): Powering down
2018-10-19T21:58:16.818Z,1539986296.818 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.840Z,1539986296.840 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2018-10-19T21:58:16.841Z,1539986296.841 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:16.841Z,1539986296.841 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3566
2018-10-19T21:58:17.069Z,1539986297.069 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:17.206Z,1539986297.206 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-10-19T21:58:17.207Z,1539986297.207 [CTD_Seabird](INFO): Powering down
2018-10-19T21:58:17.208Z,1539986297.208 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.209Z,1539986297.209 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-10-19T21:58:17.209Z,1539986297.209 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.210Z,1539986297.210 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 3568
2018-10-19T21:58:17.297Z,1539986297.297 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:17.297Z,1539986297.297 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.310Z,1539986297.310 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-10-19T21:58:17.310Z,1539986297.310 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.311Z,1539986297.311 [Radio_Surface](INFO): Join timeout helper Thread ID is 3569
2018-10-19T21:58:17.361Z,1539986297.361 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:17.361Z,1539986297.361 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.370Z,1539986297.370 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-10-19T21:58:17.370Z,1539986297.370 [logger ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.370Z,1539986297.370 [logger](INFO): Join timeout helper Thread ID is 3570
2018-10-19T21:58:17.389Z,1539986297.389 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:17.389Z,1539986297.389 [logger ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.410Z,1539986297.410 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-10-19T21:58:17.410Z,1539986297.410 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.410Z,1539986297.410 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-10-19T21:58:17.410Z,1539986297.410 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.411Z,1539986297.411 [controlThread](INFO): Join timeout helper Thread ID is 3571
2018-10-19T21:58:17.457Z,1539986297.457 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-19T21:58:17.457Z,1539986297.457 [controlThread](DEBUG): Uninitializing ControlThread
2018-10-19T21:58:17.458Z,1539986297.458 [NAL9602](INFO): Powering down
2018-10-19T21:58:17.460Z,1539986297.460 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-10-19T21:58:17.462Z,1539986297.462 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-10-19T21:58:17.462Z,1539986297.462 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-10-19T21:58:17.463Z,1539986297.463 [MissionManager](INFO): Uninitializing Mission Default
2018-10-19T21:58:17.463Z,1539986297.463 [Default] Stopped
2018-10-19T21:58:17.463Z,1539986297.463 [Default](DEBUG): Aggregate::uninitialize Default
2018-10-19T21:58:17.463Z,1539986297.463 [Default:B.GoToSurface] Stopped
2018-10-19T21:58:17.463Z,1539986297.463 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-19T21:58:17.463Z,1539986297.463 [Default:CheckIn] Stopped
2018-10-19T21:58:17.464Z,1539986297.464 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-19T21:58:17.464Z,1539986297.464 [Default:CheckIn:Read_GPS] Stopped
2018-10-19T21:58:17.468Z,1539986297.468 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-10-19T21:58:17.468Z,1539986297.468 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-10-19T21:58:17.468Z,1539986297.468 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-10-19T21:58:17.469Z,1539986297.469 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-10-19T21:58:17.469Z,1539986297.469 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-10-19T21:58:17.469Z,1539986297.469 [BuoyancyServo](INFO): Powering down
2018-10-19T21:58:17.481Z,1539986297.481 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-10-19T21:58:17.481Z,1539986297.481 [ElevatorServo](INFO): Powering down
2018-10-19T21:58:17.482Z,1539986297.482 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-10-19T21:58:17.482Z,1539986297.482 [MassServo](INFO): Powering down
2018-10-19T21:58:17.483Z,1539986297.483 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-10-19T21:58:17.483Z,1539986297.483 [RudderServo](INFO): Powering down
2018-10-19T21:58:17.484Z,1539986297.484 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-10-19T21:58:17.484Z,1539986297.484 [ThrusterServo](INFO): Powering down
2018-10-19T21:58:17.485Z,1539986297.485 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-10-19T21:58:17.485Z,1539986297.485 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-10-19T21:58:17.486Z,1539986297.486 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-10-19T21:58:17.487Z,1539986297.487 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.572Z,1539986297.572 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.612Z,1539986297.612 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.615Z,1539986297.615 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.618Z,1539986297.618 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.666Z,1539986297.666 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-19T21:58:17.724Z,1539986297.724 [logger ThreadHandler](INFO): Thread cancelled.