2019-03-26T20:20:02.210Z,1553631602.210 [Supervisor](DEBUG): Initializing supervisor.
2019-03-26T20:20:02.212Z,1553631602.212 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-03-26T20:20:02.213Z,1553631602.213 [SyncHandler](INFO): Protected caller Thread ID is 8778
2019-03-26T20:20:02.214Z,1553631602.214 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-03-26T20:20:02.215Z,1553631602.215 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-03-26T20:20:02.215Z,1553631602.215 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8779
2019-03-26T20:20:02.218Z,1553631602.218 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-03-26T20:20:02.230Z,1553631602.230 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-03-26T20:20:02.231Z,1553631602.231 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-03-26T20:20:02.231Z,1553631602.231 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8780
2019-03-26T20:20:02.232Z,1553631602.232 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-03-26T20:20:02.233Z,1553631602.233 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-03-26T20:20:02.234Z,1553631602.234 [logger ThreadHandler](INFO): Protected caller Thread ID is 8781
2019-03-26T20:20:02.236Z,1553631602.236 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-03-26T20:20:02.236Z,1553631602.236 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-03-26T20:20:02.238Z,1553631602.238 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-03-26T20:20:02.671Z,1553631602.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-03-26T20:20:02.672Z,1553631602.672 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-03-26T20:20:02.819Z,1553631602.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-03-26T20:20:02.820Z,1553631602.820 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-03-26T20:20:02.901Z,1553631602.901 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-03-26T20:20:03.002Z,1553631603.002 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-03-26T20:20:03.002Z,1553631603.002 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-03-26T20:20:03.099Z,1553631603.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-03-26T20:20:03.100Z,1553631603.100 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-03-26T20:20:03.480Z,1553631603.480 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-03-26T20:20:03.481Z,1553631603.481 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-03-26T20:20:03.585Z,1553631603.585 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-03-26T20:20:03.586Z,1553631603.586 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-03-26T20:20:04.061Z,1553631604.061 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-03-26T20:20:04.061Z,1553631604.061 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-03-26T20:20:04.269Z,1553631604.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-03-26T20:20:04.269Z,1553631604.269 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-03-26T20:20:04.582Z,1553631604.582 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-03-26T20:20:04.582Z,1553631604.582 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-03-26T20:20:04.801Z,1553631604.801 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-03-26T20:20:04.801Z,1553631604.801 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-03-26T20:20:04.946Z,1553631604.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-03-26T20:20:04.947Z,1553631604.947 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-03-26T20:20:05.453Z,1553631605.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-03-26T20:20:05.454Z,1553631605.454 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-03-26T20:20:05.799Z,1553631605.799 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-03-26T20:20:05.799Z,1553631605.799 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-03-26T20:20:06.010Z,1553631606.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-03-26T20:20:06.012Z,1553631606.012 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2019-03-26T20:20:06.013Z,1553631606.013 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2019-03-26T20:20:06.197Z,1553631606.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2019-03-26T20:20:06.311Z,1553631606.311 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2019-03-26T20:20:06.557Z,1553631606.557 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2019-03-26T20:20:06.676Z,1553631606.676 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2019-03-26T20:20:07.191Z,1553631607.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-03-26T20:20:07.192Z,1553631607.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2019-03-26T20:20:07.421Z,1553631607.421 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2019-03-26T20:20:07.533Z,1553631607.533 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2019-03-26T20:20:07.629Z,1553631607.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2019-03-26T20:20:07.783Z,1553631607.783 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2019-03-26T20:20:07.886Z,1553631607.886 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2019-03-26T20:20:07.987Z,1553631607.987 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2019-03-26T20:20:07.988Z,1553631607.988 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-03-26T20:20:07.996Z,1553631607.996 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-03-26T20:20:08.010Z,1553631608.010 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-03-26T20:20:08.010Z,1553631608.010 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-03-26T20:20:08.080Z,1553631608.080 [VerticalControl](DEBUG): Construct VerticalControl.
2019-03-26T20:20:08.196Z,1553631608.196 [VerticalControl] Loaded
2019-03-26T20:20:08.196Z,1553631608.196 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-03-26T20:20:08.197Z,1553631608.197 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-03-26T20:20:08.267Z,1553631608.267 [HorizontalControl] Loaded
2019-03-26T20:20:08.267Z,1553631608.267 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-03-26T20:20:08.268Z,1553631608.268 [SpeedControl](DEBUG): Construct SpeedControl.
2019-03-26T20:20:08.273Z,1553631608.273 [SpeedControl] Loaded
2019-03-26T20:20:08.274Z,1553631608.274 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-03-26T20:20:08.274Z,1553631608.274 [LoopControl](DEBUG): Construct LoopControl.
2019-03-26T20:20:08.275Z,1553631608.275 [LoopControl] Loaded
2019-03-26T20:20:08.275Z,1553631608.275 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-03-26T20:20:08.276Z,1553631608.276 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-03-26T20:20:08.276Z,1553631608.276 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-03-26T20:20:08.403Z,1553631608.403 [BuoyancyServo] Loaded
2019-03-26T20:20:08.403Z,1553631608.403 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-03-26T20:20:08.415Z,1553631608.415 [ElevatorServo] Loaded
2019-03-26T20:20:08.415Z,1553631608.415 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-03-26T20:20:08.426Z,1553631608.426 [MassServo] Loaded
2019-03-26T20:20:08.426Z,1553631608.426 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-03-26T20:20:08.437Z,1553631608.437 [RudderServo] Loaded
2019-03-26T20:20:08.438Z,1553631608.438 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-03-26T20:20:08.448Z,1553631608.448 [ThrusterServo] Loaded
2019-03-26T20:20:08.449Z,1553631608.449 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-03-26T20:20:08.449Z,1553631608.449 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-03-26T20:20:08.450Z,1553631608.450 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-03-26T20:20:08.492Z,1553631608.492 [DepthRateCalculator] Loaded
2019-03-26T20:20:08.492Z,1553631608.492 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-03-26T20:20:08.498Z,1553631608.498 [PitchRateCalculator] Loaded
2019-03-26T20:20:08.498Z,1553631608.498 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-03-26T20:20:08.513Z,1553631608.513 [SpeedCalculator] Loaded
2019-03-26T20:20:08.513Z,1553631608.513 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-03-26T20:20:08.535Z,1553631608.535 [TempGradientCalculator] Loaded
2019-03-26T20:20:08.535Z,1553631608.535 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-03-26T20:20:08.540Z,1553631608.540 [YawRateCalculator] Loaded
2019-03-26T20:20:08.540Z,1553631608.540 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-03-26T20:20:08.571Z,1553631608.571 [ElevatorOffsetCalculator] Loaded
2019-03-26T20:20:08.571Z,1553631608.571 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-03-26T20:20:08.571Z,1553631608.571 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-03-26T20:20:08.572Z,1553631608.572 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-03-26T20:20:08.679Z,1553631608.679 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-03-26T20:20:08.680Z,1553631608.680 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-03-26T20:20:08.740Z,1553631608.740 [DeadReckonUsingSpeedCalculator] Loaded
2019-03-26T20:20:08.740Z,1553631608.740 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-03-26T20:20:08.761Z,1553631608.761 [NavChart] Loaded
2019-03-26T20:20:08.761Z,1553631608.761 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-03-26T20:20:08.766Z,1553631608.766 [UniversalFixResidualReporter] Loaded
2019-03-26T20:20:08.766Z,1553631608.766 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-03-26T20:20:08.766Z,1553631608.766 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-03-26T20:20:08.767Z,1553631608.767 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-03-26T20:20:09.091Z,1553631609.091 [DataOverHttps] Loaded
2019-03-26T20:20:09.091Z,1553631609.091 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-03-26T20:20:09.092Z,1553631609.092 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408004E0
2019-03-26T20:20:09.093Z,1553631609.093 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8860
2019-03-26T20:20:09.106Z,1553631609.106 [Depth_Keller] Loaded
2019-03-26T20:20:09.107Z,1553631609.107 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-03-26T20:20:09.208Z,1553631609.208 [NAL9602] Loaded
2019-03-26T20:20:09.208Z,1553631609.208 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-03-26T20:20:09.224Z,1553631609.224 [Onboard] Loaded
2019-03-26T20:20:09.224Z,1553631609.224 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-03-26T20:20:09.228Z,1553631609.228 [Radio_Surface] Loaded
2019-03-26T20:20:09.228Z,1553631609.228 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-03-26T20:20:09.229Z,1553631609.229 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408304E0
2019-03-26T20:20:09.229Z,1553631609.229 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8861
2019-03-26T20:20:10.794Z,1553631610.794 [BPC1] Loaded
2019-03-26T20:20:10.795Z,1553631610.795 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-03-26T20:20:10.795Z,1553631610.795 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-03-26T20:20:10.796Z,1553631610.796 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-03-26T20:20:10.862Z,1553631610.862 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-03-26T20:20:10.862Z,1553631610.862 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-03-26T20:20:10.965Z,1553631610.965 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-03-26T20:20:10.966Z,1553631610.966 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-03-26T20:20:10.994Z,1553631610.994 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-03-26T20:20:10.994Z,1553631610.994 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-03-26T20:20:11.253Z,1553631611.253 [CTD_NeilBrown] Loaded
2019-03-26T20:20:11.254Z,1553631611.254 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-03-26T20:20:11.255Z,1553631611.255 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409BD4E0
2019-03-26T20:20:11.255Z,1553631611.255 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 8862
2019-03-26T20:20:11.305Z,1553631611.305 [WetLabsBB2FL] Loaded
2019-03-26T20:20:11.305Z,1553631611.305 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-03-26T20:20:11.306Z,1553631611.306 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409ED4E0
2019-03-26T20:20:11.307Z,1553631611.307 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8863
2019-03-26T20:20:11.307Z,1553631611.307 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-03-26T20:20:11.308Z,1553631611.308 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-03-26T20:20:11.844Z,1553631611.844 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-03-26T20:20:11.845Z,1553631611.845 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-03-26T20:20:11.986Z,1553631611.986 [SBIT](DEBUG): Construct Startup Built In Test.
2019-03-26T20:20:11.998Z,1553631611.998 [SBIT] Loaded
2019-03-26T20:20:11.998Z,1553631611.998 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-03-26T20:20:11.998Z,1553631611.998 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-03-26T20:20:12.010Z,1553631612.010 [IBIT] Loaded
2019-03-26T20:20:12.010Z,1553631612.010 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-03-26T20:20:12.013Z,1553631612.013 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-03-26T20:20:12.154Z,1553631612.154 [CBIT] Loaded
2019-03-26T20:20:12.154Z,1553631612.154 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-03-26T20:20:12.155Z,1553631612.155 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-03-26T20:20:12.158Z,1553631612.158 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-03-26T20:20:12.159Z,1553631612.159 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-03-26T20:20:12.166Z,1553631612.166 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-03-26T20:20:12.167Z,1553631612.167 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AC54E0
2019-03-26T20:20:12.167Z,1553631612.167 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8864
2019-03-26T20:20:12.172Z,1553631612.172 [Supervisor](INFO): Main Thread ID is 8651
2019-03-26T20:20:12.172Z,1553631612.172 [Supervisor](DEBUG): Running supervisor.
2019-03-26T20:20:12.173Z,1553631612.173 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8865
2019-03-26T20:20:12.175Z,1553631612.175 [controlThread ThreadHandler](INFO): Handler Thread ID is 8866
2019-03-26T20:20:12.175Z,1553631612.175 [controlThread](DEBUG): Initializing ControlThread
2019-03-26T20:20:12.176Z,1553631612.176 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-03-26T20:20:12.178Z,1553631612.178 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-03-26T20:20:12.179Z,1553631612.179 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-03-26T20:20:12.179Z,1553631612.179 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-03-26T20:20:12.180Z,1553631612.180 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-03-26T20:20:12.181Z,1553631612.181 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-03-26T20:20:12.181Z,1553631612.181 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-03-26T20:20:12.181Z,1553631612.181 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-03-26T20:20:12.182Z,1553631612.182 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-03-26T20:20:12.182Z,1553631612.182 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-03-26T20:20:12.183Z,1553631612.183 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T20:20:12.184Z,1553631612.184 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-03-26T20:20:12.184Z,1553631612.184 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-03-26T20:20:12.186Z,1553631612.186 [SBIT](INFO): Initialize SBIT Component.
2019-03-26T20:20:12.186Z,1553631612.186 [SBIT](IMPORTANT): git: 2019-03-18-20-g4336029
2019-03-26T20:20:12.186Z,1553631612.186 [SBIT](INFO): git hash: 43360290761fa8e184e08b6c4c716ce6b43e4afe
2019-03-26T20:20:12.187Z,1553631612.187 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-03-26T20:20:12.188Z,1553631612.188 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-03-26T20:20:12.189Z,1553631612.189 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-03-26T20:20:12.189Z,1553631612.189 [IBIT](INFO): Initialize IBIT Component.
2019-03-26T20:20:12.190Z,1553631612.190 [CBIT](DEBUG): Initialize CBIT Component.
2019-03-26T20:20:12.191Z,1553631612.191 [logger ThreadHandler](INFO): Handler Thread ID is 8867
2019-03-26T20:20:12.201Z,1553631612.201 [CBIT](DEBUG): Initialized mux pins.
2019-03-26T20:20:12.201Z,1553631612.201 [CBIT](DEBUG): Initializing the watchdog timer.
2019-03-26T20:20:12.209Z,1553631612.209 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8868
2019-03-26T20:20:12.210Z,1553631612.210 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-03-26T20:20:12.221Z,1553631612.221 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8869
2019-03-26T20:20:12.225Z,1553631612.225 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-03-26T20:20:12.225Z,1553631612.225 [CBIT](DEBUG): Initializing heartbeat.
2019-03-26T20:20:12.233Z,1553631612.233 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 8870
2019-03-26T20:20:12.241Z,1553631612.241 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8871
2019-03-26T20:20:12.242Z,1553631612.242 [WetLabsBB2FL](INFO): Powering down
2019-03-26T20:20:12.273Z,1553631612.273 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8872
2019-03-26T20:20:12.276Z,1553631612.276 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-03-26T20:20:12.277Z,1553631612.277 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-03-26T20:20:12.277Z,1553631612.277 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-03-26T20:20:12.277Z,1553631612.277 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-03-26T20:20:12.277Z,1553631612.277 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-03-26T20:20:12.277Z,1553631612.277 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-03-26T20:20:12.278Z,1553631612.278 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-03-26T20:20:12.278Z,1553631612.278 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-03-26T20:20:12.278Z,1553631612.278 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-03-26T20:20:12.278Z,1553631612.278 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-03-26T20:20:12.279Z,1553631612.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-03-26T20:20:12.279Z,1553631612.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-03-26T20:20:12.279Z,1553631612.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-03-26T20:20:12.279Z,1553631612.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-03-26T20:20:12.279Z,1553631612.279 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-03-26T20:20:12.279Z,1553631612.279 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-03-26T20:20:12.297Z,1553631612.297 [CBIT](DEBUG): Deactivating GF circuits.
2019-03-26T20:20:12.297Z,1553631612.297 [CBIT](DEBUG): Deactivating emergency mode.
2019-03-26T20:20:12.333Z,1553631612.333 [CBIT](DEBUG): Backplane powered.
2019-03-26T20:20:12.334Z,1553631612.334 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-03-26T20:20:12.344Z,1553631612.344 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-26T20:20:12.354Z,1553631612.354 [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>


2019-03-26T20:20:12.355Z,1553631612.355 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-03-26T20:20:12.425Z,1553631612.425 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-03-26T20:20:12.426Z,1553631612.426 [Default:A.Wait](DEBUG): Construct Wait.
2019-03-26T20:20:12.428Z,1553631612.428 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-03-26T20:20:12.475Z,1553631612.475 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-03-26T20:20:12.478Z,1553631612.478 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-03-26T20:20:12.506Z,1553631612.506 [Default:E.Execute](DEBUG): Construct Execute.
2019-03-26T20:20:12.519Z,1553631612.519 [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>


2019-03-26T20:20:12.524Z,1553631612.524 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,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,
2019-03-26T20:20:12.625Z,1553631612.625 [Radio_Surface](INFO): Powering up
2019-03-26T20:20:12.646Z,1553631612.646 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:12.653Z,1553631612.653 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:20:12.654Z,1553631612.654 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:12.661Z,1553631612.661 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T20:20:12.662Z,1553631612.662 [MassServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:12.681Z,1553631612.681 [MassServo](DEBUG): Initializing MassServo.
2019-03-26T20:20:12.682Z,1553631612.682 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:12.689Z,1553631612.689 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T20:20:12.690Z,1553631612.690 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:12.697Z,1553631612.697 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-03-26T20:20:17.461Z,1553631617.461 [RudderServo](FAULT): Overload Error
2019-03-26T20:20:17.461Z,1553631617.461 [RudderServo] Hardware Fault, FailCount= 1
2019-03-26T20:20:17.461Z,1553631617.461 [RudderServo](ERROR): Hardware Fault
2019-03-26T20:20:17.501Z,1553631617.501 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-26T20:20:17.854Z,1553631617.854 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T20:20:17.854Z,1553631617.854 [RudderServo](INFO): Powering down
2019-03-26T20:20:18.786Z,1553631618.786 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:18.906Z,1553631618.906 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T20:20:18.910Z,1553631618.910 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-26T20:20:18.910Z,1553631618.910 [RudderServo] No Fault, FailCount= 1
2019-03-26T20:20:21.353Z,1553631621.353 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:20:21.353Z,1553631621.353 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:20:21.353Z,1553631621.353 [BuoyancyServo] Communications Fault, FailCount= 1
2019-03-26T20:20:21.353Z,1553631621.353 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:20:21.421Z,1553631621.421 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:20:23.072Z,1553631623.072 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:20:23.072Z,1553631623.072 [BuoyancyServo](INFO): Powering down
2019-03-26T20:20:23.493Z,1553631623.493 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:20:23.493Z,1553631623.493 [BuoyancyServo] Hardware Fault, FailCount= 1
2019-03-26T20:20:23.493Z,1553631623.493 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:20:23.521Z,1553631623.521 [RudderServo](FAULT): Overload Error
2019-03-26T20:20:23.521Z,1553631623.521 [RudderServo] Hardware Fault, FailCount= 2
2019-03-26T20:20:23.521Z,1553631623.521 [RudderServo](ERROR): Hardware Fault
2019-03-26T20:20:23.561Z,1553631623.561 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-26T20:20:23.877Z,1553631623.877 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T20:20:23.878Z,1553631623.878 [RudderServo](INFO): Powering down
2019-03-26T20:20:23.894Z,1553631623.894 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:20:23.894Z,1553631623.894 [BuoyancyServo] No Fault, FailCount= 1
2019-03-26T20:20:24.284Z,1553631624.284 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:24.293Z,1553631624.293 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:20:24.686Z,1553631624.686 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:24.806Z,1553631624.806 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T20:20:24.810Z,1553631624.810 [CBIT](INFO): Clearing failed state for component RudderServo
2019-03-26T20:20:24.810Z,1553631624.810 [RudderServo] No Fault, FailCount= 2
2019-03-26T20:20:29.441Z,1553631629.441 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:20:29.441Z,1553631629.441 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:20:29.441Z,1553631629.441 [BuoyancyServo] Communications Fault, FailCount= 2
2019-03-26T20:20:29.441Z,1553631629.441 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:20:29.469Z,1553631629.469 [RudderServo](FAULT): Overload Error
2019-03-26T20:20:29.469Z,1553631629.469 [RudderServo] Hardware Fault, FailCount= 3
2019-03-26T20:20:29.469Z,1553631629.469 [RudderServo](ERROR): Hardware Fault
2019-03-26T20:20:29.509Z,1553631629.509 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:20:29.509Z,1553631629.509 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-03-26T20:20:29.509Z,1553631629.509 [CBIT](CRITICAL): Hardware Fault in component: RudderServo
2019-03-26T20:20:29.582Z,1553631629.582 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T20:20:29.582Z,1553631629.582 [RudderServo](INFO): Powering down
2019-03-26T20:20:29.584Z,1553631629.584 [CommandLine](FAULT): Scheduling is paused
2019-03-26T20:20:29.584Z,1553631629.584 [CBIT](INFO): Critical error at 20190326T202029
2019-03-26T20:20:29.597Z,1553631629.597 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-03-26T20:20:30.354Z,1553631630.354 [RudderServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:30.474Z,1553631630.474 [RudderServo](DEBUG): Initializing RudderServo.
2019-03-26T20:20:31.156Z,1553631631.156 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:20:31.156Z,1553631631.156 [BuoyancyServo](INFO): Powering down
2019-03-26T20:20:31.568Z,1553631631.568 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:20:31.568Z,1553631631.568 [BuoyancyServo] Hardware Fault, FailCount= 2
2019-03-26T20:20:31.569Z,1553631631.569 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:20:31.968Z,1553631631.968 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:20:31.969Z,1553631631.969 [BuoyancyServo] No Fault, FailCount= 2
2019-03-26T20:20:32.368Z,1553631632.368 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:32.373Z,1553631632.373 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:20:37.121Z,1553631637.121 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:20:37.121Z,1553631637.121 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:20:37.121Z,1553631637.121 [BuoyancyServo] Communications Fault, FailCount= 3
2019-03-26T20:20:37.122Z,1553631637.122 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:20:37.126Z,1553631637.126 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:20:38.832Z,1553631638.832 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:20:38.832Z,1553631638.832 [BuoyancyServo](INFO): Powering down
2019-03-26T20:20:39.214Z,1553631639.214 [NAL9602](INFO): Powering up NAL9602
2019-03-26T20:20:39.240Z,1553631639.240 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:20:39.240Z,1553631639.240 [BuoyancyServo] Hardware Fault, FailCount= 3
2019-03-26T20:20:39.241Z,1553631639.241 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:20:39.661Z,1553631639.661 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:20:39.661Z,1553631639.661 [BuoyancyServo] No Fault, FailCount= 3
2019-03-26T20:20:40.058Z,1553631640.058 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:40.065Z,1553631640.065 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:20:40.854Z,1553631640.854 [SBIT](IMPORTANT): Beginning Startup BIT
2019-03-26T20:20:40.858Z,1553631640.858 [CBIT](IMPORTANT): Beginning ground fault scan
2019-03-26T20:20:42.925Z,1553631642.925 [ElevatorServo](FAULT): Overload Error
2019-03-26T20:20:42.925Z,1553631642.925 [ElevatorServo] Hardware Fault, FailCount= 1
2019-03-26T20:20:42.925Z,1553631642.925 [ElevatorServo](ERROR): Hardware Fault
2019-03-26T20:20:43.349Z,1553631643.349 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-26T20:20:43.417Z,1553631643.417 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T20:20:43.417Z,1553631643.417 [ElevatorServo](INFO): Powering down
2019-03-26T20:20:44.222Z,1553631644.222 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:44.342Z,1553631644.342 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T20:20:44.385Z,1553631644.385 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-26T20:20:44.385Z,1553631644.385 [ElevatorServo] No Fault, FailCount= 1
2019-03-26T20:20:45.077Z,1553631645.077 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:20:45.077Z,1553631645.077 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:20:45.077Z,1553631645.077 [BuoyancyServo] Communications Fault, FailCount= 4
2019-03-26T20:20:45.077Z,1553631645.077 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:20:45.118Z,1553631645.118 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:20:47.018Z,1553631647.018 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:20:47.018Z,1553631647.018 [BuoyancyServo](INFO): Powering down
2019-03-26T20:20:47.422Z,1553631647.422 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:20:47.422Z,1553631647.422 [BuoyancyServo] Hardware Fault, FailCount= 4
2019-03-26T20:20:47.423Z,1553631647.423 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:20:47.933Z,1553631647.933 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:20:47.933Z,1553631647.933 [BuoyancyServo] No Fault, FailCount= 4
2019-03-26T20:20:48.241Z,1553631648.241 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:48.249Z,1553631648.249 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:20:49.545Z,1553631649.545 [ElevatorServo](FAULT): Overload Error
2019-03-26T20:20:49.545Z,1553631649.545 [ElevatorServo] Hardware Fault, FailCount= 2
2019-03-26T20:20:49.545Z,1553631649.545 [ElevatorServo](ERROR): Hardware Fault
2019-03-26T20:20:49.622Z,1553631649.622 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-26T20:20:49.861Z,1553631649.861 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T20:20:49.861Z,1553631649.861 [ElevatorServo](INFO): Powering down
2019-03-26T20:20:50.226Z,1553631650.226 [NAL9602](INFO): NAL9602 initialized
2019-03-26T20:20:50.674Z,1553631650.674 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:50.790Z,1553631650.790 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T20:20:50.834Z,1553631650.834 [CBIT](INFO): Clearing failed state for component ElevatorServo
2019-03-26T20:20:50.834Z,1553631650.834 [ElevatorServo] No Fault, FailCount= 2
2019-03-26T20:20:51.045Z,1553631651.045 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:20:52.058Z,1553631652.058 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.007944
CHAN A1 (24V): 0.001280
CHAN A2 (12V): -0.067922
CHAN A3 (5V): -0.002930
CHAN B0 (3.3V): -0.001079
CHAN B1 (3.15aV): -0.000808
CHAN B2 (3.15bV): -0.000617
CHAN B3 (GND): -0.000338
OPEN: -0.001466
Full Scale Calc: 4.765 mA, -1.589 mA
2019-03-26T20:20:53.817Z,1553631653.817 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:20:53.817Z,1553631653.817 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:20:53.817Z,1553631653.817 [BuoyancyServo] Communications Fault, FailCount= 5
2019-03-26T20:20:53.817Z,1553631653.817 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:20:53.879Z,1553631653.879 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-26T20:20:53.879Z,1553631653.879 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-26T20:20:53.882Z,1553631653.882 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:20:55.533Z,1553631655.533 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:20:55.533Z,1553631655.533 [BuoyancyServo](INFO): Powering down
2019-03-26T20:20:55.685Z,1553631655.685 [ElevatorServo](FAULT): Overload Error
2019-03-26T20:20:55.685Z,1553631655.685 [ElevatorServo] Hardware Fault, FailCount= 3
2019-03-26T20:20:55.685Z,1553631655.685 [ElevatorServo](ERROR): Hardware Fault
2019-03-26T20:20:55.773Z,1553631655.773 [CBIT](ERROR): Hardware Fault in component: ElevatorServo
2019-03-26T20:20:55.773Z,1553631655.773 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo
2019-03-26T20:20:55.937Z,1553631655.937 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:20:55.937Z,1553631655.937 [BuoyancyServo] Hardware Fault, FailCount= 5
2019-03-26T20:20:55.938Z,1553631655.938 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:20:55.938Z,1553631655.938 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T20:20:55.938Z,1553631655.938 [ElevatorServo](INFO): Powering down
2019-03-26T20:20:56.315Z,1553631656.315 [CBIT](INFO): Critical error at 20190326T202055
2019-03-26T20:20:56.402Z,1553631656.402 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:20:56.402Z,1553631656.402 [BuoyancyServo] No Fault, FailCount= 5
2019-03-26T20:20:56.757Z,1553631656.757 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:56.765Z,1553631656.765 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:20:56.766Z,1553631656.766 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:20:56.882Z,1553631656.882 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-03-26T20:21:01.909Z,1553631661.909 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:21:01.909Z,1553631661.909 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:21:01.909Z,1553631661.909 [BuoyancyServo] Communications Fault, FailCount= 6
2019-03-26T20:21:01.909Z,1553631661.909 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:21:01.954Z,1553631661.954 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:21:03.641Z,1553631663.641 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:21:03.641Z,1553631663.641 [BuoyancyServo](INFO): Powering down
2019-03-26T20:21:04.040Z,1553631664.040 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:21:04.040Z,1553631664.040 [BuoyancyServo] Hardware Fault, FailCount= 6
2019-03-26T20:21:04.040Z,1553631664.040 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:21:04.489Z,1553631664.489 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:21:04.489Z,1553631664.489 [BuoyancyServo] No Fault, FailCount= 6
2019-03-26T20:21:04.857Z,1553631664.857 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:21:04.858Z,1553631664.858 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:21:10.005Z,1553631670.005 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:21:10.005Z,1553631670.005 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:21:10.005Z,1553631670.005 [BuoyancyServo] Communications Fault, FailCount= 7
2019-03-26T20:21:10.005Z,1553631670.005 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:21:10.050Z,1553631670.050 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:21:11.705Z,1553631671.705 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:21:11.705Z,1553631671.705 [BuoyancyServo](INFO): Powering down
2019-03-26T20:21:12.101Z,1553631672.101 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:21:12.101Z,1553631672.101 [BuoyancyServo] Hardware Fault, FailCount= 7
2019-03-26T20:21:12.101Z,1553631672.101 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:21:12.509Z,1553631672.509 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:21:12.509Z,1553631672.509 [BuoyancyServo] No Fault, FailCount= 7
2019-03-26T20:21:12.914Z,1553631672.914 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:21:12.915Z,1553631672.915 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:21:18.069Z,1553631678.069 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:21:18.069Z,1553631678.069 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:21:18.069Z,1553631678.069 [BuoyancyServo] Communications Fault, FailCount= 8
2019-03-26T20:21:18.069Z,1553631678.069 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:21:18.074Z,1553631678.074 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:21:19.792Z,1553631679.792 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:21:19.793Z,1553631679.793 [BuoyancyServo](INFO): Powering down
2019-03-26T20:21:20.201Z,1553631680.201 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:21:20.201Z,1553631680.201 [BuoyancyServo] Hardware Fault, FailCount= 8
2019-03-26T20:21:20.201Z,1553631680.201 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:21:20.203Z,1553631680.203 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-26T20:21:20.203Z,1553631680.203 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-26T20:21:20.203Z,1553631680.203 [SBIT](FAULT): Control surface position failure.
2019-03-26T20:21:20.613Z,1553631680.613 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:21:20.613Z,1553631680.613 [BuoyancyServo] No Fault, FailCount= 8
2019-03-26T20:21:21.000Z,1553631681.000 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:21:21.001Z,1553631681.001 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:21:26.245Z,1553631686.245 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:21:26.245Z,1553631686.245 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:21:26.245Z,1553631686.245 [BuoyancyServo] Communications Fault, FailCount= 9
2019-03-26T20:21:26.245Z,1553631686.245 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:21:26.286Z,1553631686.286 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:21:27.998Z,1553631687.998 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:21:27.998Z,1553631687.998 [BuoyancyServo](INFO): Powering down
2019-03-26T20:21:28.350Z,1553631688.350 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:21:28.396Z,1553631688.396 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:21:28.396Z,1553631688.396 [BuoyancyServo] Hardware Fault, FailCount= 9
2019-03-26T20:21:28.396Z,1553631688.396 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:21:28.829Z,1553631688.829 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:21:28.829Z,1553631688.829 [BuoyancyServo] No Fault, FailCount= 9
2019-03-26T20:21:29.174Z,1553631689.174 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:21:29.175Z,1553631689.175 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:21:33.639Z,1553631693.639 [SBIT](ERROR): Could not read elevatorAngleReader_.
2019-03-26T20:21:33.639Z,1553631693.639 [SBIT](ERROR): Could not read rudderAngleReader_.
2019-03-26T20:21:33.639Z,1553631693.639 [SBIT](FAULT): Control surface position failure.
2019-03-26T20:21:34.329Z,1553631694.329 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:21:34.329Z,1553631694.329 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:21:34.329Z,1553631694.329 [BuoyancyServo] Communications Fault, FailCount= 10
2019-03-26T20:21:34.329Z,1553631694.329 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:21:34.330Z,1553631694.330 [SBIT](CRITICAL): SBIT FAILED
2019-03-26T20:21:34.345Z,1553631694.345 [CBIT](INFO): Critical error at 20190326T202134
2019-03-26T20:21:34.347Z,1553631694.347 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:21:34.348Z,1553631694.348 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo
2019-03-26T20:21:34.386Z,1553631694.386 [CommandLine](IMPORTANT): got command configSet list
2019-03-26T20:21:34.387Z,1553631694.387 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-03-26T20:21:34.387Z,1553631694.387 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-03-26T20:21:34.387Z,1553631694.387 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=40 minute;

2019-03-26T20:21:34.388Z,1553631694.388 [CommandLine](IMPORTANT): BPC1.batteryStickCommsTimeout=6 hour;

2019-03-26T20:21:34.388Z,1553631694.388 [CommandLine](IMPORTANT): CBIT.vehicleOpen=1 bool;

2019-03-26T20:21:34.388Z,1553631694.388 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-03-26T20:21:34.388Z,1553631694.388 [CommandLine](IMPORTANT): Depth_Keller.offset=-0.13 decibar;

2019-03-26T20:21:34.388Z,1553631694.388 [CommandLine](IMPORTANT): Depth_Keller.scale=45.92 micropascal;

2019-03-26T20:21:34.388Z,1553631694.388 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-03-26T20:21:34.451Z,1553631694.451 [MissionManager](IMPORTANT): Started mission Startup
2019-03-26T20:21:34.451Z,1553631694.451 [Startup] Running Loop=1
2019-03-26T20:21:34.451Z,1553631694.451 [Startup](DEBUG): Aggregate::initialize Startup
2019-03-26T20:21:34.451Z,1553631694.451 [Startup:A.GoToSurface] Running Loop=1
2019-03-26T20:21:34.451Z,1553631694.451 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-26T20:21:34.452Z,1553631694.452 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-26T20:21:34.452Z,1553631694.452 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-26T20:21:34.453Z,1553631694.453 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-26T20:21:34.453Z,1553631694.453 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-26T20:21:34.453Z,1553631694.453 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-26T20:21:34.455Z,1553631694.455 [Startup:StartupSatComms] Running Loop=1
2019-03-26T20:21:34.455Z,1553631694.455 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-03-26T20:21:34.455Z,1553631694.455 [Startup:StartupSatComms:A] Running Loop=1
2019-03-26T20:21:34.478Z,1553631694.478 [CBIT](INFO): Critical error at 20190326T202134
2019-03-26T20:21:34.843Z,1553631694.843 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-03-26T20:21:36.050Z,1553631696.050 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:21:36.050Z,1553631696.050 [BuoyancyServo](INFO): Powering down
2019-03-26T20:21:36.439Z,1553631696.439 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:21:36.439Z,1553631696.439 [BuoyancyServo] Hardware Fault, FailCount= 10
2019-03-26T20:21:36.439Z,1553631696.439 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:21:43.701Z,1553631703.701 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:21:59.456Z,1553631719.456 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:22:12.408Z,1553631732.408 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T20:22:12.408Z,1553631732.408 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-03-26T20:22:12.408Z,1553631732.408 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T20:22:12.410Z,1553631732.410 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T20:22:12.410Z,1553631732.410 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-03-26T20:22:12.410Z,1553631732.410 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T20:22:12.420Z,1553631732.420 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T20:22:12.420Z,1553631732.420 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T20:22:12.821Z,1553631732.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T20:22:12.821Z,1553631732.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-03-26T20:22:12.821Z,1553631732.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T20:22:12.821Z,1553631732.821 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-03-26T20:22:13.192Z,1553631733.192 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T20:22:15.620Z,1553631735.620 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:22:30.969Z,1553631750.969 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:22:34.622Z,1553631754.622 [Startup:StartupSatComms:A](INFO): Timed out from 2019-03-26T20:21:34.5Z
2019-03-26T20:22:34.622Z,1553631754.622 [Startup:StartupSatComms:A] Stopped
2019-03-26T20:22:34.622Z,1553631754.622 [Startup:StartupSatComms:B] Running Loop=1
2019-03-26T20:22:35.014Z,1553631755.014 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-03-26T20:22:38.222Z,1553631758.222 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004454
2019-03-26T20:22:42.970Z,1553631762.970 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20190325T205327/Courier0349.lzma
2019-03-26T20:22:43.775Z,1553631763.775 [DataOverHttps](INFO): Moved sent file to Logs/20190325T205327/Courier0349.lzma.bak
2019-03-26T20:22:43.775Z,1553631763.775 [DataOverHttps](INFO): SBD MOMSN=10251456
2019-03-26T20:22:45.977Z,1553631765.977 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:22:59.590Z,1553631779.590 [DataOverHttps](INFO): Sending 99 bytes from file Logs/20190326T165044/Courier0000.lzma
2019-03-26T20:23:00.394Z,1553631780.394 [DataOverHttps](INFO): Moved sent file to Logs/20190326T165044/Courier0000.lzma.bak
2019-03-26T20:23:00.394Z,1553631780.394 [DataOverHttps](INFO): SBD MOMSN=10251459
2019-03-26T20:23:01.341Z,1553631781.341 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:23:10.716Z,1553631790.716 [DataOverHttps](INFO): Sending 99 bytes from file Logs/20190326T183434/Courier0000.lzma
2019-03-26T20:23:11.522Z,1553631791.522 [DataOverHttps](INFO): Moved sent file to Logs/20190326T183434/Courier0000.lzma.bak
2019-03-26T20:23:11.522Z,1553631791.522 [DataOverHttps](INFO): SBD MOMSN=10251463
2019-03-26T20:23:16.281Z,1553631796.281 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:23:21.788Z,1553631801.788 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20190326T201839/Courier0000.lzma
2019-03-26T20:23:22.594Z,1553631802.594 [DataOverHttps](INFO): Moved sent file to Logs/20190326T201839/Courier0000.lzma.bak
2019-03-26T20:23:22.594Z,1553631802.594 [DataOverHttps](INFO): SBD MOMSN=10251467
2019-03-26T20:23:31.628Z,1553631811.628 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2019-03-26T20:23:32.800Z,1553631812.800 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20190326T202002/Courier0000.lzma
2019-03-26T20:23:33.606Z,1553631813.606 [DataOverHttps](INFO): Moved sent file to Logs/20190326T202002/Courier0000.lzma.bak
2019-03-26T20:23:33.606Z,1553631813.606 [DataOverHttps](INFO): SBD MOMSN=10251472
2019-03-26T20:23:34.477Z,1553631814.477 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:23:34.477Z,1553631814.477 [BuoyancyServo] No Fault, FailCount= 10
2019-03-26T20:23:34.890Z,1553631814.890 [Startup:StartupSatComms:B](INFO): Timed out from 2019-03-26T20:22:34.6Z
2019-03-26T20:23:34.890Z,1553631814.890 [Startup:StartupSatComms:B] Stopped
2019-03-26T20:23:34.890Z,1553631814.890 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-03-26T20:23:34.890Z,1553631814.890 [Startup:StartupSatComms] Stopped
2019-03-26T20:23:34.890Z,1553631814.890 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-03-26T20:23:34.891Z,1553631814.891 [Startup](INFO): Completed Startup
2019-03-26T20:23:34.891Z,1553631814.891 [MissionManager](INFO): Startup is completed.
2019-03-26T20:23:34.891Z,1553631814.891 [MissionManager](INFO): Uninitializing Mission Startup
2019-03-26T20:23:34.891Z,1553631814.891 [Startup] Stopped
2019-03-26T20:23:34.892Z,1553631814.892 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-03-26T20:23:34.892Z,1553631814.892 [Startup:A.GoToSurface] Stopped
2019-03-26T20:23:34.892Z,1553631814.892 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-26T20:23:34.921Z,1553631814.921 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:23:34.929Z,1553631814.929 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:23:35.281Z,1553631815.281 [MissionManager](IMPORTANT): Started mission Default
2019-03-26T20:23:35.281Z,1553631815.281 [Default] Running Loop=1
2019-03-26T20:23:35.282Z,1553631815.282 [Default](DEBUG): Aggregate::initialize Default
2019-03-26T20:23:35.282Z,1553631815.282 [Default:B.GoToSurface] Running Loop=1
2019-03-26T20:23:35.282Z,1553631815.282 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-03-26T20:23:35.282Z,1553631815.282 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-03-26T20:23:35.282Z,1553631815.282 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-03-26T20:23:35.283Z,1553631815.283 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-03-26T20:23:35.283Z,1553631815.283 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-03-26T20:23:35.283Z,1553631815.283 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-03-26T20:23:35.283Z,1553631815.283 [Default:A.Wait] Running Loop=1
2019-03-26T20:23:35.284Z,1553631815.284 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-03-26T20:23:40.457Z,1553631820.457 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:23:40.457Z,1553631820.457 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:23:40.457Z,1553631820.457 [BuoyancyServo] Communications Fault, FailCount= 1
2019-03-26T20:23:40.457Z,1553631820.457 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:23:40.461Z,1553631820.461 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:23:42.558Z,1553631822.558 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:23:42.558Z,1553631822.558 [BuoyancyServo](INFO): Powering down
2019-03-26T20:23:42.954Z,1553631822.954 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:23:42.954Z,1553631822.954 [BuoyancyServo] Hardware Fault, FailCount= 1
2019-03-26T20:23:42.954Z,1553631822.954 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:23:43.369Z,1553631823.369 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:23:43.369Z,1553631823.369 [BuoyancyServo] No Fault, FailCount= 1
2019-03-26T20:23:43.770Z,1553631823.770 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:23:43.777Z,1553631823.777 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:23:44.198Z,1553631824.198 [DataOverHttps](INFO): Sending 429 bytes from file Logs/20190325T205327/Express0350.lzma
2019-03-26T20:23:45.003Z,1553631825.003 [DataOverHttps](INFO): Moved sent file to Logs/20190325T205327/Express0350.lzma.bak
2019-03-26T20:23:45.003Z,1553631825.003 [DataOverHttps](INFO): SBD MOMSN=10251479
2019-03-26T20:23:48.622Z,1553631828.622 [Default:A.Wait](INFO): Done Waiting.
2019-03-26T20:23:48.622Z,1553631828.622 [Default:A.Wait] Stopped
2019-03-26T20:23:48.622Z,1553631828.622 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-03-26T20:23:48.933Z,1553631828.933 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:23:48.933Z,1553631828.933 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:23:48.933Z,1553631828.933 [BuoyancyServo] Communications Fault, FailCount= 2
2019-03-26T20:23:48.933Z,1553631828.933 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:23:48.937Z,1553631828.937 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:23:49.022Z,1553631829.022 [Default:CheckIn] Running Loop=1
2019-03-26T20:23:49.023Z,1553631829.023 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-03-26T20:23:49.023Z,1553631829.023 [Default:CheckIn:Read_GPS] Running Loop=1
2019-03-26T20:23:49.426Z,1553631829.426 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-03-26T20:23:50.650Z,1553631830.650 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:23:50.650Z,1553631830.650 [BuoyancyServo](INFO): Powering down
2019-03-26T20:23:51.049Z,1553631831.049 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:23:51.049Z,1553631831.049 [BuoyancyServo] Hardware Fault, FailCount= 2
2019-03-26T20:23:51.049Z,1553631831.049 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:23:51.449Z,1553631831.449 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:23:51.449Z,1553631831.449 [BuoyancyServo] No Fault, FailCount= 2
2019-03-26T20:23:51.854Z,1553631831.854 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:23:51.855Z,1553631831.855 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:23:57.411Z,1553631837.411 [CommandLine](IMPORTANT): got command report touch platform_buoyancy_position
2019-03-26T20:23:57.421Z,1553631837.421 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:23:57.421Z,1553631837.421 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:23:57.421Z,1553631837.421 [BuoyancyServo] Communications Fault, FailCount= 3
2019-03-26T20:23:57.421Z,1553631837.421 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:23:57.425Z,1553631837.425 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:23:59.114Z,1553631839.114 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:23:59.115Z,1553631839.115 [BuoyancyServo](INFO): Powering down
2019-03-26T20:23:59.519Z,1553631839.519 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:23:59.519Z,1553631839.519 [BuoyancyServo] Hardware Fault, FailCount= 3
2019-03-26T20:23:59.519Z,1553631839.519 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:23:59.922Z,1553631839.922 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:23:59.922Z,1553631839.922 [BuoyancyServo] No Fault, FailCount= 3
2019-03-26T20:24:00.328Z,1553631840.328 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:00.329Z,1553631840.329 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:03.626Z,1553631843.626 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:04.002Z,1553631844.002 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:04.402Z,1553631844.402 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:05.077Z,1553631845.077 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:05.077Z,1553631845.077 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:05.077Z,1553631845.077 [BuoyancyServo] Communications Fault, FailCount= 4
2019-03-26T20:24:05.077Z,1553631845.077 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:05.081Z,1553631845.081 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:06.801Z,1553631846.801 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:06.801Z,1553631846.801 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:07.214Z,1553631847.214 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:07.214Z,1553631847.214 [BuoyancyServo] Hardware Fault, FailCount= 4
2019-03-26T20:24:07.214Z,1553631847.214 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:24:07.674Z,1553631847.674 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:24:07.674Z,1553631847.674 [BuoyancyServo] No Fault, FailCount= 4
2019-03-26T20:24:08.033Z,1553631848.033 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:08.034Z,1553631848.034 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:11.722Z,1553631851.722 [Reporter](INFO): platform_buoyancy_position 94.385620 cc
2019-03-26T20:24:12.082Z,1553631852.082 [Reporter](INFO): platform_buoyancy_position 95.325714 cc
2019-03-26T20:24:12.494Z,1553631852.494 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:12.908Z,1553631852.908 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:13.249Z,1553631853.249 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T20:24:13.249Z,1553631853.249 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-03-26T20:24:13.249Z,1553631853.249 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T20:24:13.251Z,1553631853.251 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T20:24:13.251Z,1553631853.251 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-03-26T20:24:13.251Z,1553631853.251 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T20:24:13.561Z,1553631853.561 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:13.561Z,1553631853.561 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:13.561Z,1553631853.561 [BuoyancyServo] Communications Fault, FailCount= 5
2019-03-26T20:24:13.561Z,1553631853.561 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:13.565Z,1553631853.565 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:13.566Z,1553631853.566 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T20:24:13.566Z,1553631853.566 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T20:24:13.702Z,1553631853.702 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T20:24:13.702Z,1553631853.702 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-03-26T20:24:13.703Z,1553631853.703 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T20:24:13.703Z,1553631853.703 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-03-26T20:24:14.060Z,1553631854.060 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T20:24:15.292Z,1553631855.292 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:15.293Z,1553631855.293 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:15.754Z,1553631855.754 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:15.754Z,1553631855.754 [BuoyancyServo] Hardware Fault, FailCount= 5
2019-03-26T20:24:15.754Z,1553631855.754 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:24:16.097Z,1553631856.097 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:24:16.097Z,1553631856.097 [BuoyancyServo] No Fault, FailCount= 5
2019-03-26T20:24:16.490Z,1553631856.490 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:16.497Z,1553631856.497 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:19.794Z,1553631859.794 [Reporter](INFO): platform_buoyancy_position 96.131531 cc
2019-03-26T20:24:20.158Z,1553631860.158 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:20.562Z,1553631860.562 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:21.305Z,1553631861.305 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:21.305Z,1553631861.305 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:21.305Z,1553631861.305 [BuoyancyServo] Communications Fault, FailCount= 6
2019-03-26T20:24:21.305Z,1553631861.305 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:21.310Z,1553631861.310 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:22.977Z,1553631862.977 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:22.977Z,1553631862.977 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:23.382Z,1553631863.382 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:23.382Z,1553631863.382 [BuoyancyServo] Hardware Fault, FailCount= 6
2019-03-26T20:24:23.382Z,1553631863.382 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:24:23.777Z,1553631863.777 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:24:23.777Z,1553631863.777 [BuoyancyServo] No Fault, FailCount= 6
2019-03-26T20:24:24.177Z,1553631864.177 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:24.178Z,1553631864.178 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:27.491Z,1553631867.491 [Reporter](INFO): platform_buoyancy_position 96.265808 cc
2019-03-26T20:24:27.854Z,1553631867.854 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:28.322Z,1553631868.322 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:28.945Z,1553631868.945 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:28.945Z,1553631868.945 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:28.945Z,1553631868.945 [BuoyancyServo] Communications Fault, FailCount= 7
2019-03-26T20:24:28.945Z,1553631868.945 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:28.950Z,1553631868.950 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:30.638Z,1553631870.638 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:30.638Z,1553631870.638 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:31.042Z,1553631871.042 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:31.042Z,1553631871.042 [BuoyancyServo] Hardware Fault, FailCount= 7
2019-03-26T20:24:31.042Z,1553631871.042 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:24:31.449Z,1553631871.449 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:24:31.449Z,1553631871.449 [BuoyancyServo] No Fault, FailCount= 7
2019-03-26T20:24:31.854Z,1553631871.854 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:31.855Z,1553631871.855 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:35.170Z,1553631875.170 [Reporter](INFO): platform_buoyancy_position 94.385620 cc
2019-03-26T20:24:35.538Z,1553631875.538 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:35.922Z,1553631875.922 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:36.337Z,1553631876.337 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:37.001Z,1553631877.001 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:37.001Z,1553631877.001 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:37.001Z,1553631877.001 [BuoyancyServo] Communications Fault, FailCount= 8
2019-03-26T20:24:37.001Z,1553631877.001 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:37.005Z,1553631877.005 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:38.736Z,1553631878.736 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:38.736Z,1553631878.736 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:39.142Z,1553631879.142 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:39.142Z,1553631879.142 [BuoyancyServo] Hardware Fault, FailCount= 8
2019-03-26T20:24:39.142Z,1553631879.142 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:24:39.533Z,1553631879.533 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:24:39.533Z,1553631879.533 [BuoyancyServo] No Fault, FailCount= 8
2019-03-26T20:24:39.937Z,1553631879.937 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:39.938Z,1553631879.938 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:43.654Z,1553631883.654 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:44.034Z,1553631884.034 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:44.414Z,1553631884.414 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:45.093Z,1553631885.093 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:45.093Z,1553631885.093 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:45.093Z,1553631885.093 [BuoyancyServo] Communications Fault, FailCount= 9
2019-03-26T20:24:45.093Z,1553631885.093 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:45.097Z,1553631885.097 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:46.798Z,1553631886.798 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:46.798Z,1553631886.798 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:47.203Z,1553631887.203 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:47.203Z,1553631887.203 [BuoyancyServo] Hardware Fault, FailCount= 9
2019-03-26T20:24:47.203Z,1553631887.203 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:24:47.613Z,1553631887.613 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-03-26T20:24:47.613Z,1553631887.613 [BuoyancyServo] No Fault, FailCount= 9
2019-03-26T20:24:48.064Z,1553631888.064 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:24:48.065Z,1553631888.065 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:24:51.714Z,1553631891.714 [Reporter](INFO): platform_buoyancy_position 94.519928 cc
2019-03-26T20:24:52.086Z,1553631892.086 [Reporter](INFO): platform_buoyancy_position 95.191437 cc
2019-03-26T20:24:52.498Z,1553631892.498 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:24:52.890Z,1553631892.890 [Reporter](INFO): platform_buoyancy_position 96.534424 cc
2019-03-26T20:24:53.581Z,1553631893.581 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:24:53.581Z,1553631893.581 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:24:53.581Z,1553631893.581 [BuoyancyServo] Communications Fault, FailCount= 10
2019-03-26T20:24:53.581Z,1553631893.581 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:24:53.586Z,1553631893.586 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:53.586Z,1553631893.586 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo
2019-03-26T20:24:53.703Z,1553631893.703 [CBIT](INFO): Critical error at 20190326T202453
2019-03-26T20:24:55.290Z,1553631895.290 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:24:55.290Z,1553631895.290 [BuoyancyServo](INFO): Powering down
2019-03-26T20:24:55.702Z,1553631895.702 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:24:55.702Z,1553631895.702 [BuoyancyServo] Hardware Fault, FailCount= 10
2019-03-26T20:24:55.703Z,1553631895.703 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:25:23.999Z,1553631923.999 [CommandLine](IMPORTANT): got command failComponent 
2019-03-26T20:25:23.999Z,1553631923.999 [CommandLine](IMPORTANT): Failed components:
2019-03-26T20:25:23.999Z,1553631923.999 [CommandLine](IMPORTANT): BuoyancyServo: Hardware Fault
2019-03-26T20:25:23.999Z,1553631923.999 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault
2019-03-26T20:25:23.999Z,1553631923.999 [CommandLine](IMPORTANT): RudderServo: Hardware Fault
2019-03-26T20:25:34.247Z,1553631934.247 [CommandLine](IMPORTANT): got command failComponent none BuoyancyServo
2019-03-26T20:25:34.247Z,1553631934.247 [BuoyancyServo] No Fault, FailCount= 10
2019-03-26T20:25:34.247Z,1553631934.247 [CommandLine](IMPORTANT): BuoyancyServo failureMode is No Fault
2019-03-26T20:25:34.467Z,1553631934.467 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:25:34.468Z,1553631934.468 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:25:37.766Z,1553631937.766 [Reporter](INFO): platform_buoyancy_position 94.519928 cc
2019-03-26T20:25:38.142Z,1553631938.142 [Reporter](INFO): platform_buoyancy_position 96.265808 cc
2019-03-26T20:25:38.559Z,1553631938.559 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:25:38.950Z,1553631938.950 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:25:39.625Z,1553631939.625 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:25:39.625Z,1553631939.625 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:25:39.625Z,1553631939.625 [BuoyancyServo] Communications Fault, FailCount= 11
2019-03-26T20:25:39.625Z,1553631939.625 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:25:39.629Z,1553631939.629 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:25:39.630Z,1553631939.630 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo
2019-03-26T20:25:39.775Z,1553631939.775 [CBIT](INFO): Critical error at 20190326T202539
2019-03-26T20:25:41.362Z,1553631941.362 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:25:41.362Z,1553631941.362 [BuoyancyServo](INFO): Powering down
2019-03-26T20:25:41.823Z,1553631941.823 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:25:41.823Z,1553631941.823 [BuoyancyServo] Hardware Fault, FailCount= 11
2019-03-26T20:25:41.823Z,1553631941.823 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:25:53.848Z,1553631953.848 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-03-26T20:25:54.661Z,1553631954.661 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:25:58.705Z,1553631958.705 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:01.529Z,1553631961.529 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:03.549Z,1553631963.549 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:05.573Z,1553631965.573 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:08.805Z,1553631968.805 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:11.633Z,1553631971.633 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:14.064Z,1553631974.064 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T20:26:14.065Z,1553631974.065 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-03-26T20:26:14.065Z,1553631974.065 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-03-26T20:26:14.066Z,1553631974.066 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-03-26T20:26:14.066Z,1553631974.066 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-03-26T20:26:14.066Z,1553631974.066 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-03-26T20:26:14.076Z,1553631974.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-03-26T20:26:14.076Z,1553631974.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-03-26T20:26:14.484Z,1553631974.484 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-03-26T20:26:14.484Z,1553631974.484 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-03-26T20:26:14.485Z,1553631974.485 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-03-26T20:26:14.485Z,1553631974.485 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-03-26T20:26:14.865Z,1553631974.865 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:14.944Z,1553631974.944 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-03-26T20:26:17.693Z,1553631977.693 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:20.517Z,1553631980.517 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:22.541Z,1553631982.541 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:24.561Z,1553631984.561 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:26.581Z,1553631986.581 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:29.813Z,1553631989.813 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:32.637Z,1553631992.637 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:35.873Z,1553631995.873 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:38.697Z,1553631998.697 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:41.529Z,1553632001.529 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:43.549Z,1553632003.549 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:45.569Z,1553632005.569 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:48.801Z,1553632008.801 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:48.943Z,1553632008.943 [CommandLine](IMPORTANT): got command failComponent none BuoyancyServo
2019-03-26T20:26:48.943Z,1553632008.943 [BuoyancyServo] No Fault, FailCount= 11
2019-03-26T20:26:48.943Z,1553632008.943 [CommandLine](IMPORTANT): BuoyancyServo failureMode is No Fault
2019-03-26T20:26:49.234Z,1553632009.234 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-03-26T20:26:49.234Z,1553632009.234 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-03-26T20:26:51.629Z,1553632011.629 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:52.938Z,1553632012.938 [Reporter](INFO): platform_buoyancy_position 94.922821 cc
2019-03-26T20:26:53.302Z,1553632013.302 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:26:53.693Z,1553632013.693 [Reporter](INFO): platform_buoyancy_position 96.400116 cc
2019-03-26T20:26:54.165Z,1553632014.165 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-03-26T20:26:54.165Z,1553632014.165 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-03-26T20:26:54.165Z,1553632014.165 [BuoyancyServo] Communications Fault, FailCount= 12
2019-03-26T20:26:54.165Z,1553632014.165 [BuoyancyServo](ERROR): Communications Fault
2019-03-26T20:26:54.169Z,1553632014.169 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-03-26T20:26:54.170Z,1553632014.170 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo
2019-03-26T20:26:54.479Z,1553632014.479 [CBIT](INFO): Critical error at 20190326T202654
2019-03-26T20:26:54.861Z,1553632014.861 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:26:56.094Z,1553632016.094 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:26:56.094Z,1553632016.094 [BuoyancyServo](INFO): Powering down
2019-03-26T20:26:56.495Z,1553632016.495 [BuoyancyServo](FAULT): LCB fault:  Current Limiter Activated.
2019-03-26T20:26:56.495Z,1553632016.495 [BuoyancyServo] Hardware Fault, FailCount= 12
2019-03-26T20:26:56.495Z,1553632016.495 [BuoyancyServo](ERROR): Hardware Fault
2019-03-26T20:26:57.689Z,1553632017.689 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:00.921Z,1553632020.921 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:03.749Z,1553632023.749 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:06.577Z,1553632026.577 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:09.809Z,1553632029.809 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:12.633Z,1553632032.633 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:15.869Z,1553632035.869 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:18.697Z,1553632038.697 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:21.525Z,1553632041.525 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:23.545Z,1553632043.545 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:25.565Z,1553632045.565 [NAL9602](DEBUG): Fix Requested
2019-03-26T20:27:26.173Z,1553632046.173 [CommandLine](IMPORTANT): got command quit
2019-03-26T20:27:27.178Z,1553632047.178 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:27.178Z,1553632047.178 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.245Z,1553632047.245 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-03-26T20:27:27.245Z,1553632047.245 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.246Z,1553632047.246 [CommandLine](INFO): Join timeout helper Thread ID is 8908
2019-03-26T20:27:27.246Z,1553632047.246 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-03-26T20:27:27.246Z,1553632047.246 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.247Z,1553632047.247 [NavChartDb](INFO): Join timeout helper Thread ID is 8909
2019-03-26T20:27:27.329Z,1553632047.329 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:27.329Z,1553632047.329 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.345Z,1553632047.345 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-03-26T20:27:27.345Z,1553632047.345 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.345Z,1553632047.345 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8910
2019-03-26T20:27:27.353Z,1553632047.353 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:27.353Z,1553632047.353 [WetLabsBB2FL](INFO): Powering down
2019-03-26T20:27:27.354Z,1553632047.354 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.365Z,1553632047.365 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-03-26T20:27:27.365Z,1553632047.365 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.365Z,1553632047.365 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 8911
2019-03-26T20:27:27.485Z,1553632047.485 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:27.485Z,1553632047.485 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.505Z,1553632047.505 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-03-26T20:27:27.505Z,1553632047.505 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.505Z,1553632047.505 [Radio_Surface](INFO): Join timeout helper Thread ID is 8912
2019-03-26T20:27:27.765Z,1553632047.765 [Radio_Surface](INFO): Powering down
2019-03-26T20:27:27.766Z,1553632047.766 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:27.766Z,1553632047.766 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.774Z,1553632047.774 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-03-26T20:27:27.774Z,1553632047.774 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:27.774Z,1553632047.774 [DataOverHttps](INFO): Join timeout helper Thread ID is 8913
2019-03-26T20:27:28.109Z,1553632048.109 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:28.109Z,1553632048.109 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.114Z,1553632048.114 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-03-26T20:27:28.114Z,1553632048.114 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.114Z,1553632048.114 [logger](INFO): Join timeout helper Thread ID is 8914
2019-03-26T20:27:28.117Z,1553632048.117 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:28.117Z,1553632048.117 [logger ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.133Z,1553632048.133 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-03-26T20:27:28.134Z,1553632048.134 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.134Z,1553632048.134 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-03-26T20:27:28.134Z,1553632048.134 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.134Z,1553632048.134 [controlThread](INFO): Join timeout helper Thread ID is 8915
2019-03-26T20:27:28.369Z,1553632048.369 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-03-26T20:27:28.369Z,1553632048.369 [controlThread](DEBUG): Uninitializing ControlThread
2019-03-26T20:27:28.370Z,1553632048.370 [NAL9602](INFO): Powering down
2019-03-26T20:27:28.371Z,1553632048.371 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-03-26T20:27:28.372Z,1553632048.372 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-03-26T20:27:28.372Z,1553632048.372 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-03-26T20:27:28.373Z,1553632048.373 [MissionManager](INFO): Uninitializing Mission Default
2019-03-26T20:27:28.373Z,1553632048.373 [Default] Stopped
2019-03-26T20:27:28.373Z,1553632048.373 [Default](DEBUG): Aggregate::uninitialize Default
2019-03-26T20:27:28.373Z,1553632048.373 [Default:B.GoToSurface] Stopped
2019-03-26T20:27:28.373Z,1553632048.373 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-03-26T20:27:28.373Z,1553632048.373 [Default:CheckIn] Stopped
2019-03-26T20:27:28.373Z,1553632048.374 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-03-26T20:27:28.374Z,1553632048.374 [Default:CheckIn:Read_GPS] Stopped
2019-03-26T20:27:28.376Z,1553632048.376 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-03-26T20:27:28.376Z,1553632048.376 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-03-26T20:27:28.376Z,1553632048.376 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-03-26T20:27:28.376Z,1553632048.376 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-03-26T20:27:28.377Z,1553632048.377 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-03-26T20:27:28.377Z,1553632048.377 [BuoyancyServo](INFO): Powering down
2019-03-26T20:27:28.389Z,1553632048.389 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-03-26T20:27:28.389Z,1553632048.389 [ElevatorServo](INFO): Powering down
2019-03-26T20:27:28.390Z,1553632048.390 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-03-26T20:27:28.390Z,1553632048.390 [MassServo](INFO): Powering down
2019-03-26T20:27:28.391Z,1553632048.391 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-03-26T20:27:28.391Z,1553632048.391 [RudderServo](INFO): Powering down
2019-03-26T20:27:28.392Z,1553632048.392 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-03-26T20:27:28.392Z,1553632048.392 [ThrusterServo](INFO): Powering down
2019-03-26T20:27:28.392Z,1553632048.392 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-03-26T20:27:28.393Z,1553632048.393 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-03-26T20:27:28.393Z,1553632048.393 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-03-26T20:27:28.393Z,1553632048.393 [CBIT](DEBUG): Powering off loads.
2019-03-26T20:27:28.405Z,1553632048.405 [CBIT](DEBUG): Disabling WDT.
2019-03-26T20:27:28.417Z,1553632048.417 [CBIT](DEBUG): Opening all GF detection circuits.
2019-03-26T20:27:28.418Z,1553632048.418 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.744Z,1553632048.744 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.749Z,1553632048.749 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.780Z,1553632048.780 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.783Z,1553632048.783 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.813Z,1553632048.813 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-03-26T20:27:28.870Z,1553632048.870 [logger ThreadHandler](INFO): Thread cancelled.