2023-05-16T18:11:01.770Z,1684260661.770 [Supervisor](DEBUG): Initializing supervisor.
2023-05-16T18:11:01.775Z,1684260661.775 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-05-16T18:11:01.776Z,1684260661.776 [SyncHandler](INFO): Protected caller Thread ID is 3542
2023-05-16T18:11:01.776Z,1684260661.776 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-05-16T18:11:01.777Z,1684260661.777 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-05-16T18:11:01.777Z,1684260661.777 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3543
2023-05-16T18:11:01.781Z,1684260661.781 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-05-16T18:11:01.799Z,1684260661.799 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-05-16T18:11:01.800Z,1684260661.800 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-05-16T18:11:01.800Z,1684260661.800 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3544
2023-05-16T18:11:01.804Z,1684260661.804 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-05-16T18:11:01.805Z,1684260661.805 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-05-16T18:11:01.806Z,1684260661.806 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3545
2023-05-16T18:11:01.808Z,1684260661.808 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-05-16T18:11:01.808Z,1684260661.808 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-05-16T18:11:01.809Z,1684260661.809 [logger ThreadHandler](INFO): Protected caller Thread ID is 3546
2023-05-16T18:11:01.813Z,1684260661.813 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-05-16T18:11:01.813Z,1684260661.813 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-05-16T18:11:01.815Z,1684260661.815 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-05-16T18:11:02.035Z,1684260662.035 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-05-16T18:11:02.035Z,1684260662.035 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-05-16T18:11:02.143Z,1684260662.143 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-05-16T18:11:02.144Z,1684260662.144 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-05-16T18:11:02.241Z,1684260662.241 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-05-16T18:11:02.241Z,1684260662.241 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-05-16T18:11:02.717Z,1684260662.717 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-05-16T18:11:02.718Z,1684260662.718 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-05-16T18:11:03.069Z,1684260663.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-05-16T18:11:03.070Z,1684260663.070 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-05-16T18:11:03.416Z,1684260663.416 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-05-16T18:11:03.417Z,1684260663.417 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-05-16T18:11:03.611Z,1684260663.611 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-05-16T18:11:03.611Z,1684260663.611 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-05-16T18:11:03.691Z,1684260663.691 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-05-16T18:11:03.774Z,1684260663.774 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-05-16T18:11:04.180Z,1684260664.180 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-05-16T18:11:04.180Z,1684260664.180 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-05-16T18:11:04.463Z,1684260664.463 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-05-16T18:11:04.464Z,1684260664.464 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-05-16T18:11:04.979Z,1684260664.979 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-05-16T18:11:04.980Z,1684260664.980 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-05-16T18:11:05.197Z,1684260665.197 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-05-16T18:11:05.198Z,1684260665.198 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-05-16T18:11:05.440Z,1684260665.440 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-05-16T18:11:05.441Z,1684260665.441 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-05-16T18:11:05.583Z,1684260665.583 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-05-16T18:11:05.583Z,1684260665.583 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-05-16T18:11:06.396Z,1684260666.396 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-05-16T18:11:06.401Z,1684260666.401 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2023-05-16T18:11:06.402Z,1684260666.402 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2023-05-16T18:11:06.574Z,1684260666.574 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2023-05-16T18:11:07.112Z,1684260667.112 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2023-05-16T18:11:07.590Z,1684260667.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-05-16T18:11:07.590Z,1684260667.590 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2023-05-16T18:11:07.715Z,1684260667.715 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2023-05-16T18:11:07.818Z,1684260667.818 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2023-05-16T18:11:07.912Z,1684260667.912 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2023-05-16T18:11:08.022Z,1684260668.022 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2023-05-16T18:11:08.118Z,1684260668.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2023-05-16T18:11:08.206Z,1684260668.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2023-05-16T18:11:08.307Z,1684260668.307 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2023-05-16T18:11:08.471Z,1684260668.471 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-05-16T18:11:08.486Z,1684260668.486 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-05-16T18:11:08.542Z,1684260668.542 [DepthRateCalculator] Loaded
2023-05-16T18:11:08.542Z,1684260668.542 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-05-16T18:11:08.548Z,1684260668.548 [PitchRateCalculator] Loaded
2023-05-16T18:11:08.548Z,1684260668.548 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-05-16T18:11:08.558Z,1684260668.558 [SpeedCalculator] Loaded
2023-05-16T18:11:08.558Z,1684260668.558 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-05-16T18:11:08.573Z,1684260668.573 [VerticalHomogeneityIndexCalculator] Loaded
2023-05-16T18:11:08.573Z,1684260668.573 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2023-05-16T18:11:08.578Z,1684260668.578 [YawRateCalculator] Loaded
2023-05-16T18:11:08.578Z,1684260668.579 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-05-16T18:11:08.599Z,1684260668.599 [ElevatorOffsetCalculator] Loaded
2023-05-16T18:11:08.600Z,1684260668.600 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-05-16T18:11:08.600Z,1684260668.600 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-05-16T18:11:08.601Z,1684260668.601 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-05-16T18:11:08.630Z,1684260668.630 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-05-16T18:11:08.630Z,1684260668.630 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-05-16T18:11:08.641Z,1684260668.641 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-05-16T18:11:08.641Z,1684260668.641 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-05-16T18:11:09.092Z,1684260669.092 [AHRS_M2] Loaded
2023-05-16T18:11:09.092Z,1684260669.092 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-05-16T18:11:09.128Z,1684260669.128 [BackseatComponent] Loaded
2023-05-16T18:11:09.128Z,1684260669.128 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-05-16T18:11:09.129Z,1684260669.129 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408474E0
2023-05-16T18:11:09.129Z,1684260669.129 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3628
2023-05-16T18:11:09.132Z,1684260669.132 [LcmUniversalReporter] Loaded
2023-05-16T18:11:09.132Z,1684260669.132 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-05-16T18:11:09.943Z,1684260669.943 [BPC1] Loaded
2023-05-16T18:11:09.944Z,1684260669.944 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-05-16T18:11:10.015Z,1684260670.015 [DataOverHttps] Loaded
2023-05-16T18:11:10.015Z,1684260670.015 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-05-16T18:11:10.016Z,1684260670.016 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408774E0
2023-05-16T18:11:10.017Z,1684260670.017 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3629
2023-05-16T18:11:10.037Z,1684260670.037 [Depth_Keller] Loaded
2023-05-16T18:11:10.037Z,1684260670.037 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-05-16T18:11:10.042Z,1684260670.042 [DropWeight] Loaded
2023-05-16T18:11:10.043Z,1684260670.043 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-05-16T18:11:10.105Z,1684260670.105 [NAL9602] Loaded
2023-05-16T18:11:10.105Z,1684260670.105 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-05-16T18:11:10.135Z,1684260670.135 [Onboard] Loaded
2023-05-16T18:11:10.135Z,1684260670.135 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-05-16T18:11:10.136Z,1684260670.136 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408A74E0
2023-05-16T18:11:10.137Z,1684260670.137 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3630
2023-05-16T18:11:10.143Z,1684260670.143 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2023-05-16T18:11:10.154Z,1684260670.154 [PowerOnly] Loaded
2023-05-16T18:11:10.154Z,1684260670.154 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-05-16T18:11:10.166Z,1684260670.166 [Power24vConverter] Loaded
2023-05-16T18:11:10.166Z,1684260670.166 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-05-16T18:11:10.180Z,1684260670.180 [Radio_Surface] Loaded
2023-05-16T18:11:10.181Z,1684260670.181 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-05-16T18:11:10.182Z,1684260670.182 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D74E0
2023-05-16T18:11:10.182Z,1684260670.182 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3631
2023-05-16T18:11:10.205Z,1684260670.205 [Waterlinked] Loaded
2023-05-16T18:11:10.206Z,1684260670.206 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2023-05-16T18:11:10.206Z,1684260670.206 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-05-16T18:11:10.207Z,1684260670.207 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-05-16T18:11:10.330Z,1684260670.330 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-05-16T18:11:10.331Z,1684260670.331 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-05-16T18:11:10.373Z,1684260670.373 [DeadReckonUsingSpeedCalculator] Loaded
2023-05-16T18:11:10.373Z,1684260670.373 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-05-16T18:11:10.386Z,1684260670.386 [NavChart] Loaded
2023-05-16T18:11:10.386Z,1684260670.386 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-05-16T18:11:10.392Z,1684260670.392 [UniversalFixResidualReporter] Loaded
2023-05-16T18:11:10.392Z,1684260670.392 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-05-16T18:11:10.393Z,1684260670.393 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-05-16T18:11:10.393Z,1684260670.393 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-05-16T18:11:10.545Z,1684260670.545 [SBIT](DEBUG): Construct Startup Built In Test.
2023-05-16T18:11:10.559Z,1684260670.559 [SBIT] Loaded
2023-05-16T18:11:10.559Z,1684260670.559 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-05-16T18:11:10.562Z,1684260670.562 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-05-16T18:11:10.574Z,1684260670.574 [IBIT] Loaded
2023-05-16T18:11:10.575Z,1684260670.575 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-05-16T18:11:10.580Z,1684260670.580 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-05-16T18:11:10.682Z,1684260670.682 [CBIT] Loaded
2023-05-16T18:11:10.683Z,1684260670.683 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-05-16T18:11:10.683Z,1684260670.683 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-05-16T18:11:10.684Z,1684260670.684 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-05-16T18:11:10.863Z,1684260670.863 [CTD_Seabird] Loaded
2023-05-16T18:11:10.863Z,1684260670.863 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-05-16T18:11:10.864Z,1684260670.864 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0
2023-05-16T18:11:10.864Z,1684260670.864 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3632
2023-05-16T18:11:10.884Z,1684260670.884 [PAR_Licor] Loaded
2023-05-16T18:11:10.885Z,1684260670.885 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-05-16T18:11:10.916Z,1684260670.916 [WetLabsBB2FL] Loaded
2023-05-16T18:11:10.916Z,1684260670.916 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-05-16T18:11:10.917Z,1684260670.917 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A0B4E0
2023-05-16T18:11:10.918Z,1684260670.918 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3633
2023-05-16T18:11:10.919Z,1684260670.919 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-05-16T18:11:10.919Z,1684260670.919 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-05-16T18:11:11.060Z,1684260671.060 [BuoyancyServo] Loaded
2023-05-16T18:11:11.061Z,1684260671.061 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-05-16T18:11:11.083Z,1684260671.083 [ElevatorServo] Loaded
2023-05-16T18:11:11.083Z,1684260671.083 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-05-16T18:11:11.105Z,1684260671.105 [MassServo] Loaded
2023-05-16T18:11:11.105Z,1684260671.105 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-05-16T18:11:11.125Z,1684260671.125 [RudderServo] Loaded
2023-05-16T18:11:11.126Z,1684260671.126 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-05-16T18:11:11.142Z,1684260671.142 [ThrusterHE] Loaded
2023-05-16T18:11:11.142Z,1684260671.142 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-05-16T18:11:11.142Z,1684260671.142 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-05-16T18:11:11.143Z,1684260671.143 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-05-16T18:11:11.196Z,1684260671.196 [VerticalControl](DEBUG): Construct VerticalControl.
2023-05-16T18:11:11.246Z,1684260671.246 [VerticalControl] Loaded
2023-05-16T18:11:11.246Z,1684260671.246 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-05-16T18:11:11.249Z,1684260671.249 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-05-16T18:11:11.285Z,1684260671.285 [HorizontalControl] Loaded
2023-05-16T18:11:11.285Z,1684260671.285 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-05-16T18:11:11.288Z,1684260671.288 [SpeedControl](DEBUG): Construct SpeedControl.
2023-05-16T18:11:11.290Z,1684260671.290 [SpeedControl] Loaded
2023-05-16T18:11:11.290Z,1684260671.290 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-05-16T18:11:11.293Z,1684260671.293 [LoopControl](DEBUG): Construct LoopControl.
2023-05-16T18:11:11.293Z,1684260671.293 [LoopControl] Loaded
2023-05-16T18:11:11.293Z,1684260671.293 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-05-16T18:11:11.294Z,1684260671.294 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-05-16T18:11:11.294Z,1684260671.294 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-05-16T18:11:11.404Z,1684260671.404 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-05-16T18:11:11.405Z,1684260671.405 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-05-16T18:11:11.833Z,1684260671.833 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-05-16T18:11:11.834Z,1684260671.834 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-05-16T18:11:12.166Z,1684260672.166 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-05-16T18:11:12.166Z,1684260672.166 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-05-16T18:11:12.242Z,1684260672.242 [StratificationFrontDetector](INFO): thresholdVTHI set to: 0.399988 degC
2023-05-16T18:11:12.242Z,1684260672.242 [StratificationFrontDetector](DEBUG): (re)initializing
2023-05-16T18:11:12.242Z,1684260672.242 [StratificationFrontDetector] Loaded
2023-05-16T18:11:12.242Z,1684260672.242 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2023-05-16T18:11:12.243Z,1684260672.243 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-05-16T18:11:12.249Z,1684260672.249 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-05-16T18:11:12.252Z,1684260672.252 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-05-16T18:11:12.263Z,1684260672.263 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-05-16T18:11:12.264Z,1684260672.264 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BB74E0
2023-05-16T18:11:12.264Z,1684260672.264 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3634
2023-05-16T18:11:12.269Z,1684260672.269 [Supervisor](INFO): Main Thread ID is 3541
2023-05-16T18:11:12.269Z,1684260672.269 [Supervisor](DEBUG): Running supervisor.
2023-05-16T18:11:12.269Z,1684260672.269 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3635
2023-05-16T18:11:12.270Z,1684260672.270 [CommandExec](INFO): Initializing the command executive.
2023-05-16T18:11:12.272Z,1684260672.272 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3636
2023-05-16T18:11:12.274Z,1684260672.274 [controlThread ThreadHandler](INFO): Handler Thread ID is 3637
2023-05-16T18:11:12.274Z,1684260672.274 [controlThread](DEBUG): Initializing ControlThread
2023-05-16T18:11:12.275Z,1684260672.275 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-05-16T18:11:12.275Z,1684260672.275 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-05-16T18:11:12.276Z,1684260672.276 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-05-16T18:11:12.276Z,1684260672.276 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2023-05-16T18:11:12.277Z,1684260672.277 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-05-16T18:11:12.277Z,1684260672.277 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-05-16T18:11:12.284Z,1684260672.284 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:11:12.285Z,1684260672.285 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-05-16T18:11:12.285Z,1684260672.285 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-05-16T18:11:12.286Z,1684260672.286 [SBIT](INFO): Initialize SBIT Component.
2023-05-16T18:11:12.286Z,1684260672.286 [SBIT](IMPORTANT): git: 2023-05-11-1-g0756d5a45
2023-05-16T18:11:12.286Z,1684260672.286 [SBIT](INFO): git hash: 0756d5a45b55fc759b5de63a78c860713c4b2bf5
2023-05-16T18:11:12.287Z,1684260672.287 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-05-16T18:11:12.288Z,1684260672.288 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-05-16T18:11:12.289Z,1684260672.289 [SBIT](INFO): Beginning SBIT in 83.000000 seconds.
2023-05-16T18:11:12.289Z,1684260672.289 [IBIT](INFO): Initialize IBIT Component.
2023-05-16T18:11:12.290Z,1684260672.290 [CBIT](DEBUG): Initialize CBIT Component.
2023-05-16T18:11:12.291Z,1684260672.291 [logger ThreadHandler](INFO): Handler Thread ID is 3638
2023-05-16T18:11:12.301Z,1684260672.301 [CBIT](DEBUG): Initialized mux pins.
2023-05-16T18:11:12.301Z,1684260672.301 [CBIT](DEBUG): Initializing the watchdog timer.
2023-05-16T18:11:12.310Z,1684260672.310 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3639
2023-05-16T18:11:12.322Z,1684260672.322 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3640
2023-05-16T18:11:12.323Z,1684260672.323 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-05-16T18:11:12.325Z,1684260672.325 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-05-16T18:11:12.326Z,1684260672.326 [CBIT](DEBUG): Initializing heartbeat.
2023-05-16T18:11:12.334Z,1684260672.334 [Onboard ThreadHandler](INFO): Handler Thread ID is 3641
2023-05-16T18:11:12.351Z,1684260672.351 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3642
2023-05-16T18:11:12.374Z,1684260672.374 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3643
2023-05-16T18:11:12.375Z,1684260672.375 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-16T18:11:12.379Z,1684260672.379 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3645
2023-05-16T18:11:12.382Z,1684260672.382 [WetLabsBB2FL](INFO): Powering up
2023-05-16T18:11:12.383Z,1684260672.383 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3647
2023-05-16T18:11:12.385Z,1684260672.385 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-05-16T18:11:12.386Z,1684260672.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-05-16T18:11:12.386Z,1684260672.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-05-16T18:11:12.386Z,1684260672.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-05-16T18:11:12.386Z,1684260672.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-05-16T18:11:12.386Z,1684260672.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-05-16T18:11:12.387Z,1684260672.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-05-16T18:11:12.387Z,1684260672.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-05-16T18:11:12.397Z,1684260672.397 [CBIT](DEBUG): Deactivating GF circuits.
2023-05-16T18:11:12.397Z,1684260672.397 [CBIT](DEBUG): Deactivating emergency mode.
2023-05-16T18:11:12.437Z,1684260672.437 [CBIT](DEBUG): Backplane powered.
2023-05-16T18:11:12.443Z,1684260672.443 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-05-16T18:11:12.444Z,1684260672.444 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-05-16T18:11:12.445Z,1684260672.445 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-05-16T18:11:12.446Z,1684260672.446 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-05-16T18:11:12.447Z,1684260672.447 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-05-16T18:11:12.469Z,1684260672.469 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T18:11:12.496Z,1684260672.496 [MissionManager](DEBUG):
2023-05-16T18:11:12.497Z,1684260672.497 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-05-16T18:11:12.547Z,1684260672.547 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-05-16T18:11:12.548Z,1684260672.548 [Default:A.Wait](DEBUG): Construct Wait.
2023-05-16T18:11:12.571Z,1684260672.571 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T18:11:12.594Z,1684260672.594 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-16T18:11:12.597Z,1684260672.597 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-16T18:11:12.631Z,1684260672.631 [Default:E.Execute](DEBUG): Construct Execute.
2023-05-16T18:11:12.634Z,1684260672.634 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2023-05-16T18:11:12.639Z,1684260672.639 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-05-16T18:11:12.657Z,1684260672.657 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-05-16T18:11:12.718Z,1684260672.718 [Power24vConverter](INFO): Powering up.
2023-05-16T18:11:12.756Z,1684260672.756 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:11:12.765Z,1684260672.765 [Radio_Surface](INFO): Powering up
2023-05-16T18:11:12.766Z,1684260672.766 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-05-16T18:11:12.767Z,1684260672.767 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:11:12.773Z,1684260672.773 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-05-16T18:11:12.774Z,1684260672.774 [MassServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:11:12.782Z,1684260672.782 [MassServo](DEBUG): Initializing MassServo.
2023-05-16T18:11:12.782Z,1684260672.782 [RudderServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:11:12.790Z,1684260672.790 [RudderServo](DEBUG): Initializing RudderServo.
2023-05-16T18:11:12.791Z,1684260672.791 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-05-16T18:11:12.797Z,1684260672.797 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-05-16T18:11:13.083Z,1684260673.083 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2023-05-16T18:11:13.084Z,1684260673.084 [DropWeight] Hardware Fault, FailCount= 1
2023-05-16T18:11:13.084Z,1684260673.084 [DropWeight](ERROR): Hardware Fault
2023-05-16T18:11:13.119Z,1684260673.119 [CommandExec](FAULT): Scheduling is paused
2023-05-16T18:11:13.119Z,1684260673.119 [CBIT](INFO): Critical error at 20230516T181113
2023-05-16T18:11:13.120Z,1684260673.120 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-05-16T18:11:13.126Z,1684260673.126 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-05-16T18:11:13.127Z,1684260673.127 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-05-16T18:11:13.476Z,1684260673.476 [CBIT](INFO): Critical error at 20230516T181113
2023-05-16T18:11:14.993Z,1684260674.993 [WetLabsBB2FL](INFO): Powering down
2023-05-16T18:11:22.869Z,1684260682.869 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005755
2023-05-16T18:11:40.123Z,1684260700.123 [NAL9602](INFO): Powering up NAL9602
2023-05-16T18:11:47.074Z,1684260707.074 [Waterlinked](INFO): Powering down
2023-05-16T18:11:51.035Z,1684260711.035 [NAL9602](INFO): NAL9602 initialized
2023-05-16T18:12:35.900Z,1684260755.900 [SBIT](IMPORTANT): Beginning Startup BIT
2023-05-16T18:12:35.905Z,1684260755.905 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-16T18:12:44.469Z,1684260764.469 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:12:46.854Z,1684260766.854 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.787960
CHAN A1 (24V): 0.748163
CHAN A2 (12V): 0.410336
CHAN A3 (5V): 0.081055
CHAN B0 (3.3V): 0.039965
CHAN B1 (3.15aV): 0.038958
CHAN B2 (3.15bV): 0.040075
CHAN B3 (GND): -0.018657
OPEN: 0.005497
Full Scale: +/- 1 mA
2023-05-16T18:13:17.546Z,1684260797.546 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:13:30.029Z,1684260810.029 [SBIT](IMPORTANT): SBIT PASSED
2023-05-16T18:13:30.045Z,1684260810.045 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-05-16T18:13:30.046Z,1684260810.046 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2023-05-16T18:13:30.046Z,1684260810.046 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute;
2023-05-16T18:13:30.046Z,1684260810.046 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_salinity_homogeneity_index 0.050000 practical_salinity_unit;
2023-05-16T18:13:30.046Z,1684260810.046 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.050000 celsius;
2023-05-16T18:13:30.046Z,1684260810.046 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_shape 10.000000 count_per_second;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_slope 0.200000 count_per_millimeter;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=281.701195 cubic_centimeter;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): VerticalControl.massDefault=15.762392 millimeter;
2023-05-16T18:13:30.047Z,1684260810.047 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=20 meter;
2023-05-16T18:13:30.048Z,1684260810.048 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=30 meter;
2023-05-16T18:13:30.048Z,1684260810.048 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool;
2023-05-16T18:13:30.449Z,1684260810.449 [MissionManager](IMPORTANT): Started mission Startup
2023-05-16T18:13:30.449Z,1684260810.449 [Startup] Running Loop=1
2023-05-16T18:13:30.449Z,1684260810.449 [Startup](DEBUG): Aggregate::initialize Startup
2023-05-16T18:13:30.450Z,1684260810.450 [Startup:A.GoToSurface] Running Loop=1
2023-05-16T18:13:30.450Z,1684260810.450 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T18:13:30.450Z,1684260810.450 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T18:13:30.451Z,1684260810.451 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T18:13:30.451Z,1684260810.451 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T18:13:30.451Z,1684260810.451 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T18:13:30.452Z,1684260810.452 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T18:13:30.454Z,1684260810.454 [Startup:StartupSatComms] Running Loop=1
2023-05-16T18:13:30.454Z,1684260810.454 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-05-16T18:13:30.454Z,1684260810.454 [Startup:StartupSatComms:A] Running Loop=1
2023-05-16T18:13:30.899Z,1684260810.899 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-05-16T18:14:12.504Z,1684260852.504 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-05-16T18:14:12.505Z,1684260852.505 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:14:12.514Z,1684260852.514 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-05-16T18:14:12.514Z,1684260852.514 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:14:12.573Z,1684260852.573 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:14:12.574Z,1684260852.574 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:14:12.917Z,1684260852.917 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:14:12.917Z,1684260852.917 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-05-16T18:14:12.918Z,1684260852.918 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:14:12.918Z,1684260852.918 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-05-16T18:14:13.247Z,1684260853.247 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:14:24.609Z,1684260864.609 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:14:30.624Z,1684260870.624 [Startup:StartupSatComms:A](INFO): Timed out from 2023-05-16T18:13:30.5Z
2023-05-16T18:14:30.624Z,1684260870.624 [Startup:StartupSatComms:A] Stopped
2023-05-16T18:14:30.624Z,1684260870.624 [Startup:StartupSatComms:B] Running Loop=1
2023-05-16T18:14:31.038Z,1684260871.038 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-16T18:14:37.168Z,1684260877.168 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:14:38.185Z,1684260878.185 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20230516T160653/Courier0028.lzma
2023-05-16T18:14:39.187Z,1684260879.187 [DataOverHttps](INFO): Moved sent file to Logs/20230516T160653/Courier0028.lzma.bak
2023-05-16T18:14:39.187Z,1684260879.187 [DataOverHttps](INFO): SBD MOMSN=18316480
2023-05-16T18:14:50.086Z,1684260890.086 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:14:54.949Z,1684260894.949 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20230516T181101/Courier0000.lzma
2023-05-16T18:14:55.951Z,1684260895.951 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Courier0000.lzma.bak
2023-05-16T18:14:55.951Z,1684260895.951 [DataOverHttps](INFO): SBD MOMSN=18316484
2023-05-16T18:15:02.988Z,1684260902.988 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:15:11.413Z,1684260911.413 [DataOverHttps](INFO): Sending 249 bytes from file Logs/20230516T160653/Express0029.lzma
2023-05-16T18:15:12.415Z,1684260912.415 [DataOverHttps](INFO): Moved sent file to Logs/20230516T160653/Express0029.lzma.bak
2023-05-16T18:15:12.415Z,1684260912.415 [DataOverHttps](INFO): SBD MOMSN=18316489
2023-05-16T18:15:15.953Z,1684260915.953 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:15:28.054Z,1684260928.054 [DataOverHttps](INFO): Sending 1020 bytes from file Logs/20230516T181101/Express0001.lzma
2023-05-16T18:15:29.055Z,1684260929.055 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Express0001.lzma.bak
2023-05-16T18:15:29.055Z,1684260929.055 [DataOverHttps](INFO): SBD MOMSN=18316495
2023-05-16T18:15:30.505Z,1684260930.505 [Startup:StartupSatComms:B] Stopped
2023-05-16T18:15:30.505Z,1684260930.505 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-05-16T18:15:30.505Z,1684260930.505 [Startup:StartupSatComms] Stopped
2023-05-16T18:15:30.505Z,1684260930.505 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-05-16T18:15:30.506Z,1684260930.506 [Startup](INFO): Completed Startup
2023-05-16T18:15:30.506Z,1684260930.506 [MissionManager](INFO): Startup is completed.
2023-05-16T18:15:30.506Z,1684260930.506 [MissionManager](INFO): Uninitializing Mission Startup
2023-05-16T18:15:30.506Z,1684260930.506 [Startup] Stopped
2023-05-16T18:15:30.506Z,1684260930.506 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-05-16T18:15:30.506Z,1684260930.506 [Startup:A.GoToSurface] Stopped
2023-05-16T18:15:30.506Z,1684260930.506 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T18:15:30.840Z,1684260930.840 [MissionManager](IMPORTANT): Started mission Default
2023-05-16T18:15:30.841Z,1684260930.841 [Default] Running Loop=1
2023-05-16T18:15:30.841Z,1684260930.841 [Default](DEBUG): Aggregate::initialize Default
2023-05-16T18:15:30.841Z,1684260930.841 [Default:B.GoToSurface] Running Loop=1
2023-05-16T18:15:30.857Z,1684260930.857 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T18:15:30.858Z,1684260930.858 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T18:15:30.858Z,1684260930.858 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T18:15:30.858Z,1684260930.858 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T18:15:30.858Z,1684260930.858 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T18:15:30.859Z,1684260930.859 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T18:15:30.859Z,1684260930.859 [Default:A.Wait] Running Loop=1
2023-05-16T18:15:30.859Z,1684260930.859 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-05-16T18:15:44.232Z,1684260944.232 [Default:A.Wait](INFO): Done Waiting.
2023-05-16T18:15:44.232Z,1684260944.232 [Default:A.Wait] Stopped
2023-05-16T18:15:44.232Z,1684260944.232 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T18:15:44.582Z,1684260944.582 [Default:CheckIn] Running Loop=1
2023-05-16T18:15:44.582Z,1684260944.582 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-16T18:15:44.583Z,1684260944.583 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-16T18:15:44.977Z,1684260944.977 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-05-16T18:16:10.109Z,1684260970.109 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:16:54.439Z,1684261014.439 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-05-16T18:17:13.434Z,1684261033.434 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-05-16T18:17:13.434Z,1684261033.434 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:17:13.435Z,1684261033.435 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2023-05-16T18:17:13.435Z,1684261033.435 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:17:13.446Z,1684261033.446 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:17:13.446Z,1684261033.446 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:17:13.851Z,1684261033.851 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:17:13.851Z,1684261033.851 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-05-16T18:17:13.851Z,1684261033.851 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:17:13.851Z,1684261033.851 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2023-05-16T18:17:14.254Z,1684261034.254 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:17:46.605Z,1684261066.605 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2023-05-16T18:18:40.706Z,1684261120.706 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-05-16T18:18:40.709Z,1684261120.709 [BPC1](INFO): Received data from all battery sticks.
2023-05-16T18:20:14.427Z,1684261214.427 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-05-16T18:20:14.427Z,1684261214.427 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:20:14.428Z,1684261214.428 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2023-05-16T18:20:14.428Z,1684261214.428 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:20:14.439Z,1684261214.439 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:20:14.439Z,1684261214.439 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:20:14.848Z,1684261214.848 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:20:14.848Z,1684261214.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-05-16T18:20:14.849Z,1684261214.849 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:20:14.849Z,1684261214.849 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2023-05-16T18:20:15.251Z,1684261215.251 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:20:44.746Z,1684261244.746 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-16T18:15:44.6Z
2023-05-16T18:20:44.746Z,1684261244.746 [Default:CheckIn:Read_GPS] Stopped
2023-05-16T18:20:44.746Z,1684261244.746 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-16T18:20:45.129Z,1684261245.129 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-16T18:20:52.862Z,1684261252.862 [CommandExec](IMPORTANT): got command gfscan
2023-05-16T18:20:52.879Z,1684261252.879 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-16T18:20:53.189Z,1684261253.189 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230516T181101/Courier0004.lzma
2023-05-16T18:20:54.191Z,1684261254.191 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Courier0004.lzma.bak
2023-05-16T18:20:54.191Z,1684261254.191 [DataOverHttps](INFO): SBD MOMSN=18316548
2023-05-16T18:21:03.733Z,1684261263.733 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.795917
CHAN A1 (24V): 0.747720
CHAN A2 (12V): 0.415261
CHAN A3 (5V): 0.078137
CHAN B0 (3.3V): 0.035486
CHAN B1 (3.15aV): 0.035347
CHAN B2 (3.15bV): 0.036221
CHAN B3 (GND): -0.021147
OPEN: 0.012224
Full Scale: +/- 1 mA
2023-05-16T18:21:09.669Z,1684261269.669 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20230516T181101/Express0005.lzma
2023-05-16T18:21:10.671Z,1684261270.671 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Express0005.lzma.bak
2023-05-16T18:21:10.672Z,1684261270.672 [DataOverHttps](INFO): SBD MOMSN=18316550
2023-05-16T18:21:12.207Z,1684261272.207 [Default:CheckIn:Read_Iridium] Stopped
2023-05-16T18:21:12.207Z,1684261272.207 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-16T18:21:12.208Z,1684261272.208 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-16T18:21:48.162Z,1684261308.162 [Power24vConverter](INFO): Powering down.
2023-05-16T18:21:53.399Z,1684261313.399 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-16T18:21:53.399Z,1684261313.399 [NAL9602] Data Fault, FailCount= 1
2023-05-16T18:21:53.399Z,1684261313.399 [NAL9602](ERROR): Data Fault
2023-05-16T18:21:53.460Z,1684261313.460 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-16T18:21:53.807Z,1684261313.807 [NAL9602](INFO): Powering down
2023-05-16T18:21:54.628Z,1684261314.628 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-16T18:21:54.629Z,1684261314.629 [NAL9602] No Fault, FailCount= 1
2023-05-16T18:22:24.107Z,1684261344.107 [NAL9602](INFO): Powering up NAL9602
2023-05-16T18:22:35.015Z,1684261355.015 [NAL9602](INFO): NAL9602 initialized
2023-05-16T18:23:15.422Z,1684261395.422 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-05-16T18:23:15.422Z,1684261395.422 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:23:15.423Z,1684261395.423 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2023-05-16T18:23:15.423Z,1684261395.423 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:23:15.476Z,1684261395.476 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:23:15.476Z,1684261395.476 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:23:15.832Z,1684261395.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:23:15.832Z,1684261395.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-05-16T18:23:15.833Z,1684261395.833 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:23:15.833Z,1684261395.833 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2023-05-16T18:23:16.231Z,1684261396.231 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:23:41.079Z,1684261421.079 [DataOverHttps](IMPORTANT): SBD MTMSN=20230516T182340
2023-05-16T18:23:48.294Z,1684261428.294 [DataOverHttps](INFO): Received command: run Maintenance/run_backseat_on_surface.xml
2023-05-16T18:23:48.321Z,1684261428.321 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.xml
2023-05-16T18:23:48.321Z,1684261428.321 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.xml
2023-05-16T18:23:48.379Z,1684261428.379 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2023-05-16T18:23:48.379Z,1684261428.379 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml
2023-05-16T18:23:48.695Z,1684261428.695 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool
2023-05-16T18:23:48.698Z,1684261428.698 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min
2023-05-16T18:23:48.700Z,1684261428.700 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool
2023-05-16T18:23:48.727Z,1684261428.727 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool
2023-05-16T18:23:48.742Z,1684261428.742 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool
2023-05-16T18:23:48.744Z,1684261428.744 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool
2023-05-16T18:23:48.751Z,1684261428.751 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DetectTrough = 0 bool
2023-05-16T18:23:48.755Z,1684261428.755 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count
2023-05-16T18:23:48.774Z,1684261428.774 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count
2023-05-16T18:23:48.781Z,1684261428.781 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 %
2023-05-16T18:23:48.784Z,1684261428.784 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool
2023-05-16T18:23:48.806Z,1684261428.806 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool
2023-05-16T18:23:48.808Z,1684261428.808 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool
2023-05-16T18:23:48.823Z,1684261428.823 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool
2023-05-16T18:23:48.830Z,1684261428.830 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2023-05-16T18:23:48.837Z,1684261428.837 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool
2023-05-16T18:23:48.841Z,1684261428.841 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool
2023-05-16T18:23:48.884Z,1684261428.884 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1 bool
2023-05-16T18:23:48.887Z,1684261428.887 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1 bool
2023-05-16T18:23:48.891Z,1684261428.891 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2023-05-16T18:23:48.911Z,1684261428.911 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool
2023-05-16T18:23:48.914Z,1684261428.914 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count
2023-05-16T18:23:48.961Z,1684261428.961 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count
2023-05-16T18:23:48.964Z,1684261428.964 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakShallowBound = nan m
2023-05-16T18:23:48.983Z,1684261428.983 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDeepBound = nan m
2023-05-16T18:23:48.991Z,1684261428.991 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2023-05-16T18:23:49.010Z,1684261429.010 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlThreshTriggerActive = 0 bool
2023-05-16T18:23:49.012Z,1684261429.012 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlLowerThresh = nan ug/l
2023-05-16T18:23:49.020Z,1684261429.020 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlUpperThresh = nan ug/l
2023-05-16T18:23:49.024Z,1684261429.024 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesThresh = 5.000000 count
2023-05-16T18:23:49.047Z,1684261429.047 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = nan ug/l
2023-05-16T18:23:49.054Z,1684261429.054 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = nan m
2023-05-16T18:23:49.057Z,1684261429.057 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = nan degC
2023-05-16T18:23:49.068Z,1684261429.068 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg
2023-05-16T18:23:49.082Z,1684261429.082 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg
2023-05-16T18:23:49.095Z,1684261429.095 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = nan umol/l
2023-05-16T18:23:49.099Z,1684261429.099 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = nan m
2023-05-16T18:23:49.110Z,1684261429.110 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg
2023-05-16T18:23:49.126Z,1684261429.126 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg
2023-05-16T18:23:49.128Z,1684261429.128 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = nan kg/m3
2023-05-16T18:23:49.131Z,1684261429.131 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = nan m
2023-05-16T18:23:49.134Z,1684261429.134 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg
2023-05-16T18:23:49.137Z,1684261429.137 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg
2023-05-16T18:23:49.157Z,1684261429.157 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = nan ppb
2023-05-16T18:23:49.160Z,1684261429.160 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = nan m
2023-05-16T18:23:49.163Z,1684261429.163 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC
2023-05-16T18:23:49.196Z,1684261429.196 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg
2023-05-16T18:23:49.200Z,1684261429.200 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg
2023-05-16T18:23:49.203Z,1684261429.203 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchFDOMDistance = nan m
2023-05-16T18:23:49.218Z,1684261429.218 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = nan psu
2023-05-16T18:23:49.221Z,1684261429.221 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = nan m
2023-05-16T18:23:49.223Z,1684261429.223 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = nan degC
2023-05-16T18:23:49.226Z,1684261429.226 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg
2023-05-16T18:23:49.249Z,1684261429.249 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg
2023-05-16T18:23:49.252Z,1684261429.252 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = nan ug/l
2023-05-16T18:23:49.255Z,1684261429.255 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = nan m
2023-05-16T18:23:49.258Z,1684261429.258 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg
2023-05-16T18:23:49.298Z,1684261429.298 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg
2023-05-16T18:23:49.302Z,1684261429.302 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m
2023-05-16T18:23:49.305Z,1684261429.305 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = nan psu
2023-05-16T18:23:49.308Z,1684261429.308 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = nan m
2023-05-16T18:23:49.311Z,1684261429.311 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg
2023-05-16T18:23:49.370Z,1684261429.370 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg
2023-05-16T18:23:49.382Z,1684261429.382 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m
2023-05-16T18:23:49.387Z,1684261429.387 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = nan psu
2023-05-16T18:23:49.390Z,1684261429.390 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = nan m
2023-05-16T18:23:49.397Z,1684261429.397 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg
2023-05-16T18:23:49.400Z,1684261429.400 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg
2023-05-16T18:23:49.408Z,1684261429.408 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m
2023-05-16T18:23:49.431Z,1684261429.431 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.TriggeredOnChl = 0 bool
2023-05-16T18:23:49.435Z,1684261429.435 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.ChlTriggering = nan ug/l
2023-05-16T18:23:49.552Z,1684261429.552 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T18:23:49.568Z,1684261429.568 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2023-05-16T18:23:49.659Z,1684261429.659 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T18:23:49.686Z,1684261429.686 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T18:23:49.714Z,1684261429.714 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2023-05-16T18:23:49.795Z,1684261429.795 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T18:23:49.832Z,1684261429.832 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T18:23:49.860Z,1684261429.860 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2023-05-16T18:23:49.902Z,1684261429.902 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2023-05-16T18:23:49.928Z,1684261429.928 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Construct BackseatDriver.
2023-05-16T18:23:49.950Z,1684261429.950 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T18:23:49.996Z,1684261429.996 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-16T18:23:50.007Z,1684261430.007 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-16T18:23:50.023Z,1684261430.023 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute.
2023-05-16T18:23:50.066Z,1684261430.066 [MissionManager](DEBUG):
0
Burn on
Dropped weight due to communications timeout.
5
run_backseat_on_surface mission has been running for
Restarting logs and run_backseat_on_surface mission.
restart logs
2023-05-16T18:23:50.070Z,1684261430.070 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.xml
2023-05-16T18:23:50.187Z,1684261430.187 [Default] Stopped
2023-05-16T18:23:50.188Z,1684261430.188 [Default](DEBUG): Aggregate::uninitialize Default
2023-05-16T18:23:50.188Z,1684261430.188 [Default:B.GoToSurface] Stopped
2023-05-16T18:23:50.188Z,1684261430.188 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T18:23:50.188Z,1684261430.188 [Default:CheckIn] Stopped
2023-05-16T18:23:50.188Z,1684261430.188 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-16T18:23:50.188Z,1684261430.188 [Default:CheckIn:C.Wait] Stopped
2023-05-16T18:23:50.188Z,1684261430.188 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T18:23:50.188Z,1684261430.188 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface
2023-05-16T18:23:50.188Z,1684261430.188 [run_backseat_on_surface] Running Loop=1
2023-05-16T18:23:50.189Z,1684261430.188 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface
2023-05-16T18:23:50.189Z,1684261430.189 [run_backseat_on_surface:Science] Running Loop=1
2023-05-16T18:23:50.189Z,1684261430.189 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science
2023-05-16T18:23:50.189Z,1684261430.189 [run_backseat_on_surface:Science:A] Running Loop=1
2023-05-16T18:23:50.189Z,1684261430.189 [run_backseat_on_surface:Science:B] Running Loop=1
2023-05-16T18:23:50.189Z,1684261430.189 [run_backseat_on_surface:Science:C] Running Loop=1
2023-05-16T18:23:50.201Z,1684261430.201 [run_backseat_on_surface:Science:D] Running Loop=1
2023-05-16T18:23:50.201Z,1684261430.201 [run_backseat_on_surface:Science:E] Running Loop=1
2023-05-16T18:23:50.201Z,1684261430.201 [run_backseat_on_surface:Science:F] Running Loop=1
2023-05-16T18:23:50.201Z,1684261430.201 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1
2023-05-16T18:23:50.201Z,1684261430.201 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1
2023-05-16T18:23:50.202Z,1684261430.202 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl
2023-05-16T18:23:50.202Z,1684261430.202 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T18:23:50.202Z,1684261430.202 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T18:23:50.204Z,1684261430.204 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1
2023-05-16T18:23:50.204Z,1684261430.204 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport
2023-05-16T18:23:50.204Z,1684261430.204 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2023-05-16T18:23:50.204Z,1684261430.204 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2023-05-16T18:23:50.205Z,1684261430.205 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1
2023-05-16T18:23:50.205Z,1684261430.205 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3
2023-05-16T18:23:50.205Z,1684261430.205 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T18:23:50.209Z,1684261430.209 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T18:23:50.215Z,1684261430.215 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1
2023-05-16T18:23:50.215Z,1684261430.215 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil
2023-05-16T18:23:50.215Z,1684261430.215 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T18:23:50.215Z,1684261430.215 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T18:23:50.226Z,1684261430.226 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1
2023-05-16T18:23:50.226Z,1684261430.226 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport
2023-05-16T18:23:50.227Z,1684261430.227 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2023-05-16T18:23:50.227Z,1684261430.227 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2023-05-16T18:23:50.228Z,1684261430.228 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1
2023-05-16T18:23:50.228Z,1684261430.228 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM
2023-05-16T18:23:50.228Z,1684261430.228 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T18:23:50.228Z,1684261430.228 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T18:23:50.248Z,1684261430.248 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1
2023-05-16T18:23:50.248Z,1684261430.248 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity
2023-05-16T18:23:50.249Z,1684261430.249 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T18:23:50.249Z,1684261430.249 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T18:23:50.259Z,1684261430.259 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1
2023-05-16T18:23:50.259Z,1684261430.259 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport
2023-05-16T18:23:50.259Z,1684261430.259 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2023-05-16T18:23:50.259Z,1684261430.259 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2023-05-16T18:23:50.259Z,1684261430.259 [run_backseat_on_surface:Science:ChlThreshTrigger] Running Loop=1
2023-05-16T18:23:50.259Z,1684261430.259 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:ChlThreshTrigger
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2023-05-16T18:23:50.260Z,1684261430.260 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1
2023-05-16T18:23:50.261Z,1684261430.261 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Initialize.
2023-05-16T18:23:50.322Z,1684261430.322 [BackseatComponent](INFO): Powering up
2023-05-16T18:23:50.322Z,1684261430.322 [BackseatComponent](INFO): Subscribing to LCM channels.
2023-05-16T18:23:50.434Z,1684261430.434 [run_backseat_on_surface:C.GoToSurface] Running Loop=1
2023-05-16T18:23:50.434Z,1684261430.434 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T18:23:50.434Z,1684261430.434 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T18:23:50.434Z,1684261430.434 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T18:23:50.435Z,1684261430.435 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T18:23:50.435Z,1684261430.435 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T18:23:50.435Z,1684261430.435 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T18:23:50.436Z,1684261430.436 [run_backseat_on_surface:CheckIn] Running Loop=1
2023-05-16T18:23:50.436Z,1684261430.436 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2023-05-16T18:23:50.437Z,1684261430.437 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2023-05-16T18:23:50.437Z,1684261430.437 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1
2023-05-16T18:23:50.441Z,1684261430.441 [run_backseat_on_surface:Science] Running Loop=1
2023-05-16T18:23:50.442Z,1684261430.442 [run_backseat_on_surface:Science:ChlThreshTrigger] Stopped
2023-05-16T18:23:50.442Z,1684261430.442 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:ChlThreshTrigger
2023-05-16T18:23:50.442Z,1684261430.442 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2023-05-16T18:23:50.442Z,1684261430.442 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2023-05-16T18:23:50.443Z,1684261430.443 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectOil] Stopped
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T18:23:50.444Z,1684261430.444 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:PeakDetectChl] Stopped
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2023-05-16T18:23:50.445Z,1684261430.445 [run_backseat_on_surface:Science:Read_Oil] Stopped
2023-05-16T18:23:50.446Z,1684261430.446 [run_backseat_on_surface:Science:F] Stopped
2023-05-16T18:23:50.446Z,1684261430.446 [run_backseat_on_surface:Science:E] Running Loop=1
2023-05-16T18:23:50.446Z,1684261430.446 [run_backseat_on_surface:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2023-05-16T18:23:50.446Z,1684261430.446 [run_backseat_on_surface:Science:D] Stopped
2023-05-16T18:23:50.446Z,1684261430.446 [run_backseat_on_surface:Science:C] Running Loop=1
2023-05-16T18:23:50.447Z,1684261430.447 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2023-05-16T18:23:50.448Z,1684261430.448 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2023-05-16T18:23:50.448Z,1684261430.448 [run_backseat_on_surface:Science:B] Running Loop=1
2023-05-16T18:23:50.448Z,1684261430.448 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2023-05-16T18:23:50.459Z,1684261430.459 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2023-05-16T18:23:50.459Z,1684261430.459 [run_backseat_on_surface:Science:A] Stopped
2023-05-16T18:23:50.588Z,1684261430.588 [Power24vConverter](INFO): Powering up.
2023-05-16T18:23:50.607Z,1684261430.607 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-05-16T18:23:50.711Z,1684261430.711 [WetLabsBB2FL](INFO): Powering up
2023-05-16T18:24:57.550Z,1684261497.550 [BackseatComponent](IMPORTANT): calanus: Running AyeRIS backseat app. Logging to: 20230516T182454
2023-05-16T18:24:57.585Z,1684261497.585 [BackseatComponent](IMPORTANT): 2023-05-16 18:24:57.289 | INFO | __main__::125 - $ELC,2023-05-16 18:25:12.923,19.940,105.511,0.00,23.61,16.76,23.60,0.16,0.10,14.41,1,0,0,500,1
2023-05-16T18:25:19.060Z,1684261519.060 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_disk_space with code: 1932
2023-05-16T18:25:19.063Z,1684261519.063 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_counts with code: 1933
2023-05-16T18:25:19.066Z,1684261519.066 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_shape with code: 1934
2023-05-16T18:25:19.068Z,1684261519.068 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_size with code: 1935
2023-05-16T18:25:19.071Z,1684261519.071 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_slope with code: 1936
2023-05-16T18:25:25.936Z,1684261525.936 [BackseatComponent](INFO): Created data reader for Depth_Keller.enableBroadcast with code: 1584
2023-05-16T18:25:25.937Z,1684261525.937 [BackseatComponent](INFO): Requesting data from Depth_Keller.enableBroadcast (1584). Requested size is: 1
2023-05-16T18:25:25.939Z,1684261525.939 [BackseatComponent](INFO): Created universal data reader for depth with code: 6
2023-05-16T18:25:25.939Z,1684261525.939 [BackseatComponent](INFO): Requesting data from depth (6). Requested size is: 2
2023-05-16T18:25:26.317Z,1684261526.317 [Depth_Keller](ERROR): Failed to copy Depth_Keller.enableBroadcast's data value to LCM message.
2023-05-16T18:25:26.317Z,1684261526.317 [Depth_Keller](INFO): Activating messaging.
2023-05-16T18:26:13.203Z,1684261573.203 [CBIT](INFO): Clearing failed state for component DropWeight
2023-05-16T18:26:13.203Z,1684261573.203 [DropWeight] No Fault, FailCount= 1
2023-05-16T18:26:16.425Z,1684261576.425 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-05-16T18:26:16.425Z,1684261576.425 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:26:16.426Z,1684261576.426 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2023-05-16T18:26:16.426Z,1684261576.426 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:26:16.439Z,1684261576.439 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:26:16.439Z,1684261576.439 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:26:16.843Z,1684261576.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:26:16.843Z,1684261576.843 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-05-16T18:26:16.843Z,1684261576.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:26:16.843Z,1684261576.843 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2023-05-16T18:26:17.232Z,1684261577.232 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:27:22.351Z,1684261642.351 [DataOverHttps](IMPORTANT): SBD MTMSN=20230516T182721
2023-05-16T18:27:29.749Z,1684261649.749 [DataOverHttps](INFO): Received command: stop
2023-05-16T18:27:29.774Z,1684261649.774 [CommandExec](IMPORTANT): got command stop
2023-05-16T18:27:29.774Z,1684261649.774 [CommandExec](IMPORTANT): Scheduling is paused
2023-05-16T18:27:29.774Z,1684261649.774 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2023-05-16T18:27:29.966Z,1684261649.966 [MissionManager](INFO): MissionManager is completed.
2023-05-16T18:27:29.967Z,1684261649.967 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science:B] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science:C] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science:E] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science:OceanCurrent] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped
2023-05-16T18:27:29.967Z,1684261649.967 [run_backseat_on_surface:B.BackseatDriver] Stopped
2023-05-16T18:27:29.968Z,1684261649.968 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Uninitialize.
2023-05-16T18:27:29.968Z,1684261649.968 [run_backseat_on_surface:C.GoToSurface] Stopped
2023-05-16T18:27:29.968Z,1684261649.968 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T18:27:29.968Z,1684261649.968 [run_backseat_on_surface:CheckIn] Stopped
2023-05-16T18:27:29.968Z,1684261649.968 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2023-05-16T18:27:29.968Z,1684261649.968 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2023-05-16T18:27:30.081Z,1684261650.081 [WetLabsBB2FL](INFO): Powering down
2023-05-16T18:27:30.380Z,1684261650.380 [MissionManager](IMPORTANT): Started mission Default
2023-05-16T18:27:30.380Z,1684261650.380 [Default] Running Loop=1
2023-05-16T18:27:30.380Z,1684261650.380 [Default](DEBUG): Aggregate::initialize Default
2023-05-16T18:27:30.380Z,1684261650.380 [Default:B.GoToSurface] Running Loop=1
2023-05-16T18:27:30.380Z,1684261650.380 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T18:27:30.381Z,1684261650.381 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T18:27:30.381Z,1684261650.381 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T18:27:30.381Z,1684261650.381 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T18:27:30.382Z,1684261650.382 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T18:27:30.382Z,1684261650.382 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T18:27:30.382Z,1684261650.382 [Default:A.Wait] Running Loop=1
2023-05-16T18:27:30.383Z,1684261650.383 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-05-16T18:27:31.712Z,1684261651.712 [BackseatComponent](INFO): Sent LCM shutdown request.
2023-05-16T18:27:43.698Z,1684261663.698 [Default:A.Wait](INFO): Done Waiting.
2023-05-16T18:27:43.698Z,1684261663.698 [Default:A.Wait] Stopped
2023-05-16T18:27:43.698Z,1684261663.698 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T18:27:44.104Z,1684261664.104 [Default:CheckIn] Running Loop=1
2023-05-16T18:27:44.104Z,1684261664.104 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-16T18:27:44.104Z,1684261664.104 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-16T18:27:46.822Z,1684261666.822 [BackseatComponent](INFO): Powering down and starting shutdown timer (15.00 sec).
2023-05-16T18:27:46.822Z,1684261666.822 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2023-05-16T18:27:46.823Z,1684261666.823 [LcmUniversalReporter](INFO): Deactivating messaging.
2023-05-16T18:27:46.906Z,1684261666.906 [Depth_Keller](INFO): Deactivating messaging.
2023-05-16T18:29:17.418Z,1684261757.418 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-05-16T18:29:17.419Z,1684261757.419 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:29:17.420Z,1684261757.420 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2023-05-16T18:29:17.420Z,1684261757.420 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:29:17.430Z,1684261757.430 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:29:17.430Z,1684261757.430 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:29:17.841Z,1684261757.841 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:29:17.841Z,1684261757.841 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-05-16T18:29:17.841Z,1684261757.841 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:29:17.842Z,1684261757.842 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2023-05-16T18:29:18.238Z,1684261758.238 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:32:18.437Z,1684261938.437 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-05-16T18:32:18.437Z,1684261938.437 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:32:18.438Z,1684261938.438 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2023-05-16T18:32:18.438Z,1684261938.438 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:32:18.449Z,1684261938.449 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:32:18.449Z,1684261938.449 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:32:18.825Z,1684261938.825 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:32:18.825Z,1684261938.825 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-05-16T18:32:18.826Z,1684261938.826 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:32:18.826Z,1684261938.826 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2023-05-16T18:32:19.219Z,1684261939.219 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:32:37.391Z,1684261957.391 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-16T18:32:37.391Z,1684261957.391 [NAL9602] Data Fault, FailCount= 2
2023-05-16T18:32:37.391Z,1684261957.391 [NAL9602](ERROR): Data Fault
2023-05-16T18:32:37.446Z,1684261957.446 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-16T18:32:37.795Z,1684261957.795 [NAL9602](INFO): Powering down
2023-05-16T18:32:38.631Z,1684261958.631 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-16T18:32:38.631Z,1684261958.631 [NAL9602] No Fault, FailCount= 2
2023-05-16T18:32:44.300Z,1684261964.300 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-16T18:27:44.1Z
2023-05-16T18:32:44.300Z,1684261964.300 [Default:CheckIn:Read_GPS] Stopped
2023-05-16T18:32:44.300Z,1684261964.300 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-16T18:32:47.277Z,1684261967.277 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230516T181101/Courier0007.lzma
2023-05-16T18:32:47.919Z,1684261967.919 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Courier0007.lzma.bak
2023-05-16T18:32:47.919Z,1684261967.919 [DataOverHttps](INFO): SBD MOMSN=18316599
2023-05-16T18:33:03.227Z,1684261983.227 [DataOverHttps](INFO): Sending 1167 bytes from file Logs/20230516T181101/Express0008.lzma
2023-05-16T18:33:04.227Z,1684261984.227 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Express0008.lzma.bak
2023-05-16T18:33:04.227Z,1684261984.227 [DataOverHttps](INFO): SBD MOMSN=18316601
2023-05-16T18:33:08.167Z,1684261988.167 [NAL9602](INFO): Powering up NAL9602
2023-05-16T18:33:19.079Z,1684261999.079 [NAL9602](INFO): NAL9602 initialized
2023-05-16T18:33:19.601Z,1684261999.601 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230516T181101/Express0011.lzma
2023-05-16T18:33:20.603Z,1684262000.603 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Express0011.lzma.bak
2023-05-16T18:33:20.603Z,1684262000.603 [DataOverHttps](INFO): SBD MOMSN=18316618
2023-05-16T18:33:21.912Z,1684262001.912 [Default:CheckIn:Read_Iridium] Stopped
2023-05-16T18:33:21.913Z,1684262001.913 [Default:CheckIn:C.Wait] Running Loop=1
2023-05-16T18:33:21.913Z,1684262001.913 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-16T18:35:19.482Z,1684262119.482 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-05-16T18:35:19.482Z,1684262119.482 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:35:19.483Z,1684262119.483 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2023-05-16T18:35:19.483Z,1684262119.483 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:35:19.494Z,1684262119.494 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:35:19.495Z,1684262119.495 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:35:19.905Z,1684262119.905 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:35:19.905Z,1684262119.905 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-05-16T18:35:19.905Z,1684262119.905 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:35:19.906Z,1684262119.906 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2023-05-16T18:35:20.279Z,1684262120.279 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:37:47.335Z,1684262267.335 [Power24vConverter](INFO): Powering down.
2023-05-16T18:37:47.754Z,1684262267.754 [Power24vConverter](FAULT): LCB fault: Current Limiter Activated.
2023-05-16T18:37:47.754Z,1684262267.754 [Power24vConverter] Hardware Fault, FailCount= 1
2023-05-16T18:37:47.754Z,1684262267.754 [Power24vConverter](ERROR): Hardware Fault
2023-05-16T18:37:47.779Z,1684262267.779 [CBIT](ERROR): Hardware Fault in component: Power24vConverter
2023-05-16T18:37:48.155Z,1684262268.155 [Power24vConverter](INFO): Powering down.
2023-05-16T18:37:48.970Z,1684262268.970 [CBIT](INFO): Clearing failed state for component Power24vConverter
2023-05-16T18:37:48.970Z,1684262268.970 [Power24vConverter] No Fault, FailCount= 1
2023-05-16T18:37:49.359Z,1684262269.359 [Power24vConverter](INFO): Powering up.
2023-05-16T18:38:20.470Z,1684262300.470 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-05-16T18:38:20.470Z,1684262300.470 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:38:20.471Z,1684262300.471 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2023-05-16T18:38:20.472Z,1684262300.472 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:38:20.482Z,1684262300.482 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:38:20.482Z,1684262300.482 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:38:20.890Z,1684262300.890 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:38:20.890Z,1684262300.890 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-05-16T18:38:20.891Z,1684262300.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:38:20.891Z,1684262300.891 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2023-05-16T18:38:21.279Z,1684262301.279 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:38:22.510Z,1684262302.510 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-16T18:38:22.510Z,1684262302.510 [Default:CheckIn:C.Wait] Stopped
2023-05-16T18:38:22.510Z,1684262302.510 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T18:38:22.511Z,1684262302.511 [Default:CheckIn:D] Running Loop=1
2023-05-16T18:38:22.896Z,1684262302.896 [Default:CheckIn:D] Stopped
2023-05-16T18:38:22.896Z,1684262302.896 [Default:CheckIn:E] Running Loop=1
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.875263 min
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn:E] Stopped
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn] Stopped
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn](INFO): Running loop #2
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn] Running Loop=2
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-16T18:38:23.359Z,1684262303.359 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-16T18:40:11.494Z,1684262411.494 [CommandExec](IMPORTANT): got command quit
2023-05-16T18:40:12.497Z,1684262412.497 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:12.497Z,1684262412.497 [CommandExec](INFO): Uninitializing the command executive.
2023-05-16T18:40:12.498Z,1684262412.498 [CommandExec](INFO): Uninitializing the command scheduler.
2023-05-16T18:40:12.498Z,1684262412.498 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:12.685Z,1684262412.685 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2023-05-16T18:40:12.685Z,1684262412.685 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-05-16T18:40:12.685Z,1684262412.685 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:12.686Z,1684262412.686 [NavChartDb](INFO): Join timeout helper Thread ID is 3678
2023-05-16T18:40:12.949Z,1684262412.949 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:12.950Z,1684262412.950 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:12.961Z,1684262412.961 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-05-16T18:40:12.961Z,1684262412.961 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:12.962Z,1684262412.962 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3679
2023-05-16T18:40:13.393Z,1684262413.393 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:13.394Z,1684262413.394 [WetLabsBB2FL](INFO): Powering down
2023-05-16T18:40:13.394Z,1684262413.394 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:13.405Z,1684262413.405 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-05-16T18:40:13.406Z,1684262413.406 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:13.406Z,1684262413.406 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3680
2023-05-16T18:40:13.685Z,1684262413.685 [CTD_Seabird](INFO): Powering down
2023-05-16T18:40:13.697Z,1684262413.697 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:13.697Z,1684262413.697 [CTD_Seabird](INFO): Powering down
2023-05-16T18:40:13.709Z,1684262413.709 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:13.733Z,1684262413.733 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-05-16T18:40:13.733Z,1684262413.733 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:13.734Z,1684262413.734 [Radio_Surface](INFO): Join timeout helper Thread ID is 3681
2023-05-16T18:40:14.085Z,1684262414.085 [Radio_Surface](INFO): Powering down
2023-05-16T18:40:14.086Z,1684262414.086 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:14.086Z,1684262414.086 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:14.099Z,1684262414.099 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-05-16T18:40:14.099Z,1684262414.099 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:14.100Z,1684262414.100 [Onboard](INFO): Join timeout helper Thread ID is 3682
2023-05-16T18:40:14.997Z,1684262414.997 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-05-16T18:40:18.785Z,1684262418.785 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:18.786Z,1684262418.786 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:18.790Z,1684262418.790 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-05-16T18:40:18.790Z,1684262418.790 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:18.791Z,1684262418.791 [DataOverHttps](INFO): Join timeout helper Thread ID is 3683
2023-05-16T18:40:19.013Z,1684262419.013 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:19.014Z,1684262419.014 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.044Z,1684262419.044 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-05-16T18:40:19.044Z,1684262419.044 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.044Z,1684262419.044 [BackseatComponent](INFO): Join timeout helper Thread ID is 3684
2023-05-16T18:40:19.129Z,1684262419.129 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:19.130Z,1684262419.130 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.145Z,1684262419.145 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-05-16T18:40:19.145Z,1684262419.145 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.158Z,1684262419.158 [logger](INFO): Join timeout helper Thread ID is 3685
2023-05-16T18:40:19.164Z,1684262419.164 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:19.164Z,1684262419.164 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.173Z,1684262419.173 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-05-16T18:40:19.173Z,1684262419.173 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.174Z,1684262419.174 [CommandLine](INFO): Join timeout helper Thread ID is 3686
2023-05-16T18:40:19.249Z,1684262419.249 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:19.250Z,1684262419.250 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.254Z,1684262419.254 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-05-16T18:40:19.254Z,1684262419.254 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.255Z,1684262419.255 [CommandExec](INFO): Join timeout helper Thread ID is 3687
2023-05-16T18:40:19.259Z,1684262419.259 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-05-16T18:40:19.259Z,1684262419.259 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.260Z,1684262419.260 [controlThread](INFO): Join timeout helper Thread ID is 3688
2023-05-16T18:40:19.625Z,1684262419.625 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T18:40:19.626Z,1684262419.626 [controlThread](DEBUG): Uninitializing ControlThread
2023-05-16T18:40:19.626Z,1684262419.626 [AHRS_M2](INFO): Powering down
2023-05-16T18:40:19.698Z,1684262419.698 [NAL9602](INFO): Powering down
2023-05-16T18:40:19.700Z,1684262419.700 [Waterlinked](INFO): Powering down
2023-05-16T18:40:19.701Z,1684262419.701 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-05-16T18:40:19.702Z,1684262419.702 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-05-16T18:40:19.703Z,1684262419.703 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-05-16T18:40:19.703Z,1684262419.703 [MissionManager](INFO): Uninitializing Mission Default
2023-05-16T18:40:19.703Z,1684262419.703 [Default] Stopped
2023-05-16T18:40:19.703Z,1684262419.703 [Default](DEBUG): Aggregate::uninitialize Default
2023-05-16T18:40:19.703Z,1684262419.703 [Default:B.GoToSurface] Stopped
2023-05-16T18:40:19.704Z,1684262419.704 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T18:40:19.704Z,1684262419.704 [Default:CheckIn] Stopped
2023-05-16T18:40:19.704Z,1684262419.704 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-16T18:40:19.704Z,1684262419.704 [Default:CheckIn:Read_GPS] Stopped
2023-05-16T18:40:19.706Z,1684262419.706 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-05-16T18:40:19.707Z,1684262419.707 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-05-16T18:40:19.707Z,1684262419.707 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-05-16T18:40:19.707Z,1684262419.707 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-05-16T18:40:19.708Z,1684262419.708 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-05-16T18:40:19.708Z,1684262419.708 [BuoyancyServo](INFO): Powering down
2023-05-16T18:40:19.721Z,1684262419.721 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-05-16T18:40:19.722Z,1684262419.722 [ElevatorServo](INFO): Powering down
2023-05-16T18:40:19.722Z,1684262419.722 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-05-16T18:40:19.722Z,1684262419.722 [MassServo](INFO): Powering down
2023-05-16T18:40:19.723Z,1684262419.723 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-05-16T18:40:19.723Z,1684262419.723 [RudderServo](INFO): Powering down
2023-05-16T18:40:19.724Z,1684262419.724 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-05-16T18:40:19.724Z,1684262419.724 [ThrusterHE](INFO): Powering down
2023-05-16T18:40:19.725Z,1684262419.725 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-05-16T18:40:19.726Z,1684262419.726 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-05-16T18:40:19.726Z,1684262419.726 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-05-16T18:40:19.726Z,1684262419.726 [CBIT](DEBUG): Powering off loads.
2023-05-16T18:40:19.737Z,1684262419.737 [CBIT](DEBUG): Disabling WDT.
2023-05-16T18:40:19.749Z,1684262419.749 [CBIT](DEBUG): Opening all GF detection circuits.
2023-05-16T18:40:19.750Z,1684262419.750 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.781Z,1684262419.781 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.784Z,1684262419.784 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.790Z,1684262419.790 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.834Z,1684262419.834 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.882Z,1684262419.882 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.885Z,1684262419.885 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.935Z,1684262419.935 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T18:40:19.980Z,1684262419.980 [logger ThreadHandler](INFO): Thread cancelled.