2024-04-25T23:35:33.422Z,1714088133.422 [Supervisor](DEBUG): Initializing supervisor. 2024-04-25T23:35:33.427Z,1714088133.427 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-04-25T23:35:33.427Z,1714088133.427 [SyncHandler](INFO): Protected caller Thread ID is 6740 2024-04-25T23:35:33.427Z,1714088133.427 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-04-25T23:35:33.429Z,1714088133.429 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-04-25T23:35:33.429Z,1714088133.429 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6741 2024-04-25T23:35:33.434Z,1714088133.434 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-04-25T23:35:33.452Z,1714088133.452 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-04-25T23:35:33.453Z,1714088133.453 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-04-25T23:35:33.453Z,1714088133.453 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6742 2024-04-25T23:35:33.457Z,1714088133.457 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-04-25T23:35:33.458Z,1714088133.458 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-04-25T23:35:33.458Z,1714088133.458 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6743 2024-04-25T23:35:33.461Z,1714088133.461 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-04-25T23:35:33.461Z,1714088133.461 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-04-25T23:35:33.462Z,1714088133.462 [logger ThreadHandler](INFO): Protected caller Thread ID is 6744 2024-04-25T23:35:33.465Z,1714088133.465 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-04-25T23:35:33.466Z,1714088133.466 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-04-25T23:35:33.467Z,1714088133.467 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-04-25T23:35:33.575Z,1714088133.575 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-04-25T23:35:33.575Z,1714088133.575 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-04-25T23:35:34.350Z,1714088134.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-04-25T23:35:34.350Z,1714088134.350 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-04-25T23:35:34.597Z,1714088134.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-04-25T23:35:34.597Z,1714088134.597 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-04-25T23:35:34.688Z,1714088134.688 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-04-25T23:35:34.831Z,1714088134.831 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-04-25T23:35:34.832Z,1714088134.832 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-04-25T23:35:34.924Z,1714088134.924 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-04-25T23:35:35.045Z,1714088135.045 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-04-25T23:35:35.045Z,1714088135.045 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-04-25T23:35:35.458Z,1714088135.458 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-04-25T23:35:35.458Z,1714088135.458 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-04-25T23:35:36.015Z,1714088136.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-04-25T23:35:36.015Z,1714088136.015 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-04-25T23:35:36.255Z,1714088136.255 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-04-25T23:35:36.256Z,1714088136.256 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-04-25T23:35:36.987Z,1714088136.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-04-25T23:35:36.987Z,1714088136.987 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-04-25T23:35:37.542Z,1714088137.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-04-25T23:35:37.543Z,1714088137.543 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-04-25T23:35:37.849Z,1714088137.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-04-25T23:35:37.849Z,1714088137.849 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-04-25T23:35:38.089Z,1714088138.089 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-04-25T23:35:38.089Z,1714088138.089 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-04-25T23:35:38.482Z,1714088138.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-04-25T23:35:38.483Z,1714088138.483 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-04-25T23:35:38.847Z,1714088138.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-04-25T23:35:38.849Z,1714088138.849 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-04-25T23:35:38.850Z,1714088138.850 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-04-25T23:35:38.946Z,1714088138.946 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-04-25T23:35:39.123Z,1714088139.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-04-25T23:35:39.238Z,1714088139.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-04-25T23:35:39.336Z,1714088139.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-04-25T23:35:39.444Z,1714088139.444 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-04-25T23:35:39.566Z,1714088139.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-04-25T23:35:39.839Z,1714088139.839 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-04-25T23:35:39.839Z,1714088139.839 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-04-25T23:35:39.946Z,1714088139.946 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-04-25T23:35:40.050Z,1714088140.050 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-04-25T23:35:40.205Z,1714088140.205 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-04-25T23:35:40.317Z,1714088140.317 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-04-25T23:35:40.317Z,1714088140.317 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-04-25T23:35:40.331Z,1714088140.331 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-04-25T23:35:40.445Z,1714088140.445 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-04-25T23:35:40.446Z,1714088140.446 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-04-25T23:35:40.498Z,1714088140.498 [VerticalControl](DEBUG): Construct VerticalControl. 2024-04-25T23:35:40.557Z,1714088140.557 [VerticalControl] Loaded 2024-04-25T23:35:40.557Z,1714088140.557 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-04-25T23:35:40.560Z,1714088140.560 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-04-25T23:35:40.606Z,1714088140.606 [HorizontalControl] Loaded 2024-04-25T23:35:40.606Z,1714088140.606 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-04-25T23:35:40.609Z,1714088140.609 [SpeedControl](DEBUG): Construct SpeedControl. 2024-04-25T23:35:40.612Z,1714088140.612 [SpeedControl] Loaded 2024-04-25T23:35:40.612Z,1714088140.612 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-04-25T23:35:40.615Z,1714088140.615 [LoopControl](DEBUG): Construct LoopControl. 2024-04-25T23:35:40.615Z,1714088140.615 [LoopControl] Loaded 2024-04-25T23:35:40.616Z,1714088140.616 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-04-25T23:35:40.616Z,1714088140.616 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-04-25T23:35:40.617Z,1714088140.617 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-04-25T23:35:40.666Z,1714088140.666 [DepthRateCalculator] Loaded 2024-04-25T23:35:40.666Z,1714088140.666 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-04-25T23:35:40.671Z,1714088140.671 [PitchRateCalculator] Loaded 2024-04-25T23:35:40.671Z,1714088140.671 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-04-25T23:35:40.681Z,1714088140.681 [SpeedCalculator] Loaded 2024-04-25T23:35:40.681Z,1714088140.681 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-04-25T23:35:40.685Z,1714088140.685 [YawRateCalculator] Loaded 2024-04-25T23:35:40.685Z,1714088140.685 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-04-25T23:35:40.703Z,1714088140.703 [ElevatorOffsetCalculator] Loaded 2024-04-25T23:35:40.704Z,1714088140.704 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-04-25T23:35:40.704Z,1714088140.704 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-04-25T23:35:40.705Z,1714088140.705 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-04-25T23:35:40.731Z,1714088140.731 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-04-25T23:35:40.732Z,1714088140.732 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-04-25T23:35:40.787Z,1714088140.787 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-04-25T23:35:40.787Z,1714088140.787 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-04-25T23:35:41.120Z,1714088141.120 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-04-25T23:35:41.121Z,1714088141.121 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-04-25T23:35:41.289Z,1714088141.289 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-04-25T23:35:41.290Z,1714088141.290 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-04-25T23:35:42.146Z,1714088142.146 [AHRS_M2] Loaded 2024-04-25T23:35:42.146Z,1714088142.146 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-04-25T23:35:42.181Z,1714088142.181 [BackseatComponent] Loaded 2024-04-25T23:35:42.181Z,1714088142.181 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-04-25T23:35:42.182Z,1714088142.182 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C34E0 2024-04-25T23:35:42.183Z,1714088142.183 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6826 2024-04-25T23:35:42.186Z,1714088142.186 [LcmUniversalReporter] Loaded 2024-04-25T23:35:42.186Z,1714088142.186 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-04-25T23:35:42.992Z,1714088142.992 [BPC1] Loaded 2024-04-25T23:35:42.993Z,1714088142.993 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-04-25T23:35:43.069Z,1714088143.069 [DataOverHttps] Loaded 2024-04-25T23:35:43.069Z,1714088143.069 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-04-25T23:35:43.070Z,1714088143.070 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F34E0 2024-04-25T23:35:43.070Z,1714088143.070 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6827 2024-04-25T23:35:43.090Z,1714088143.090 [Depth_Keller] Loaded 2024-04-25T23:35:43.091Z,1714088143.091 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-04-25T23:35:43.152Z,1714088143.152 [NAL9602] Loaded 2024-04-25T23:35:43.152Z,1714088143.152 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-04-25T23:35:43.182Z,1714088143.182 [Onboard] Loaded 2024-04-25T23:35:43.182Z,1714088143.182 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-04-25T23:35:43.183Z,1714088143.183 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A234E0 2024-04-25T23:35:43.183Z,1714088143.183 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6828 2024-04-25T23:35:43.196Z,1714088143.196 [Power24vConverter] Loaded 2024-04-25T23:35:43.196Z,1714088143.196 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-04-25T23:35:43.209Z,1714088143.209 [Radio_Surface] Loaded 2024-04-25T23:35:43.209Z,1714088143.209 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-04-25T23:35:43.210Z,1714088143.210 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0 2024-04-25T23:35:43.211Z,1714088143.211 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6829 2024-04-25T23:35:43.256Z,1714088143.256 [RDI_Pathfinder] Loaded 2024-04-25T23:35:43.256Z,1714088143.256 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-04-25T23:35:43.347Z,1714088143.347 [DAT] Loaded 2024-04-25T23:35:43.348Z,1714088143.348 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-04-25T23:35:43.349Z,1714088143.349 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0 2024-04-25T23:35:43.349Z,1714088143.349 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6830 2024-04-25T23:35:43.350Z,1714088143.350 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-04-25T23:35:43.350Z,1714088143.350 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-04-25T23:35:43.461Z,1714088143.461 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-04-25T23:35:43.461Z,1714088143.461 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-04-25T23:35:43.475Z,1714088143.475 [NavChart] Loaded 2024-04-25T23:35:43.475Z,1714088143.475 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-04-25T23:35:43.480Z,1714088143.480 [UniversalFixResidualReporter] Loaded 2024-04-25T23:35:43.481Z,1714088143.481 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-04-25T23:35:43.481Z,1714088143.481 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-04-25T23:35:43.482Z,1714088143.482 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-04-25T23:35:43.620Z,1714088143.620 [SBIT](DEBUG): Construct Startup Built In Test. 2024-04-25T23:35:43.629Z,1714088143.629 [SBIT] Loaded 2024-04-25T23:35:43.630Z,1714088143.630 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-04-25T23:35:43.632Z,1714088143.632 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-04-25T23:35:43.645Z,1714088143.645 [IBIT] Loaded 2024-04-25T23:35:43.646Z,1714088143.646 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-04-25T23:35:43.651Z,1714088143.651 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-04-25T23:35:43.757Z,1714088143.757 [CBIT] Loaded 2024-04-25T23:35:43.757Z,1714088143.757 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-04-25T23:35:43.757Z,1714088143.757 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-04-25T23:35:43.758Z,1714088143.758 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-04-25T23:35:43.888Z,1714088143.888 [BuoyancyServo] Loaded 2024-04-25T23:35:43.888Z,1714088143.888 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-04-25T23:35:43.909Z,1714088143.909 [ElevatorServo] Loaded 2024-04-25T23:35:43.909Z,1714088143.909 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-04-25T23:35:43.936Z,1714088143.936 [DockingStepper] Loaded 2024-04-25T23:35:43.937Z,1714088143.937 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-04-25T23:35:43.956Z,1714088143.956 [MassServo] Loaded 2024-04-25T23:35:43.956Z,1714088143.956 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-04-25T23:35:43.975Z,1714088143.975 [RudderServo] Loaded 2024-04-25T23:35:43.975Z,1714088143.975 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-04-25T23:35:43.992Z,1714088143.992 [ThrusterServo] Loaded 2024-04-25T23:35:43.992Z,1714088143.992 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-04-25T23:35:43.993Z,1714088143.993 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-04-25T23:35:43.993Z,1714088143.993 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-04-25T23:35:44.003Z,1714088144.003 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-04-25T23:35:44.004Z,1714088144.004 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-04-25T23:35:44.176Z,1714088144.176 [CTD_Seabird] Loaded 2024-04-25T23:35:44.176Z,1714088144.176 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-04-25T23:35:44.177Z,1714088144.177 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2024-04-25T23:35:44.178Z,1714088144.178 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6831 2024-04-25T23:35:44.210Z,1714088144.210 [ESPComponent] Loaded 2024-04-25T23:35:44.211Z,1714088144.211 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-04-25T23:35:44.230Z,1714088144.230 [PAR_Licor] Loaded 2024-04-25T23:35:44.231Z,1714088144.231 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-04-25T23:35:44.273Z,1714088144.273 [WetLabsBB2FL] Loaded 2024-04-25T23:35:44.274Z,1714088144.274 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-04-25T23:35:44.275Z,1714088144.275 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-04-25T23:35:44.275Z,1714088144.275 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6832 2024-04-25T23:35:44.276Z,1714088144.276 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-04-25T23:35:44.282Z,1714088144.282 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-04-25T23:35:44.285Z,1714088144.285 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-04-25T23:35:44.296Z,1714088144.296 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-04-25T23:35:44.297Z,1714088144.297 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-04-25T23:35:44.297Z,1714088144.297 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6833 2024-04-25T23:35:44.302Z,1714088144.302 [Supervisor](INFO): Main Thread ID is 4326 2024-04-25T23:35:44.302Z,1714088144.302 [Supervisor](DEBUG): Running supervisor. 2024-04-25T23:35:44.303Z,1714088144.303 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6834 2024-04-25T23:35:44.303Z,1714088144.303 [CommandExec](INFO): Initializing the command executive. 2024-04-25T23:35:44.305Z,1714088144.305 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6835 2024-04-25T23:35:44.307Z,1714088144.307 [controlThread ThreadHandler](INFO): Handler Thread ID is 6836 2024-04-25T23:35:44.307Z,1714088144.307 [controlThread](DEBUG): Initializing ControlThread 2024-04-25T23:35:44.308Z,1714088144.308 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-04-25T23:35:44.310Z,1714088144.310 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-04-25T23:35:44.310Z,1714088144.310 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-04-25T23:35:44.311Z,1714088144.311 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-04-25T23:35:44.311Z,1714088144.311 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-04-25T23:35:44.312Z,1714088144.312 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-04-25T23:35:44.312Z,1714088144.312 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-04-25T23:35:44.312Z,1714088144.312 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-04-25T23:35:44.313Z,1714088144.313 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-04-25T23:35:44.318Z,1714088144.318 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-04-25T23:35:44.318Z,1714088144.318 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-04-25T23:35:44.318Z,1714088144.318 [SBIT](INFO): Initialize SBIT Component. 2024-04-25T23:35:44.319Z,1714088144.319 [SBIT](IMPORTANT): git: 2024-04-25 2024-04-25T23:35:44.319Z,1714088144.319 [SBIT](INFO): git hash: 9c8b4752de92409818c57bb73ab755afa5204686 2024-04-25T23:35:44.319Z,1714088144.319 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-04-25T23:35:44.321Z,1714088144.321 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-04-25T23:35:44.322Z,1714088144.322 [SBIT](INFO): Beginning SBIT in 99.000000 seconds. 2024-04-25T23:35:44.322Z,1714088144.322 [IBIT](INFO): Initialize IBIT Component. 2024-04-25T23:35:44.323Z,1714088144.323 [CBIT](DEBUG): Initialize CBIT Component. 2024-04-25T23:35:44.324Z,1714088144.324 [logger ThreadHandler](INFO): Handler Thread ID is 6837 2024-04-25T23:35:44.336Z,1714088144.336 [CBIT](DEBUG): Initialized mux pins. 2024-04-25T23:35:44.336Z,1714088144.336 [CBIT](DEBUG): Initializing the watchdog timer. 2024-04-25T23:35:44.344Z,1714088144.344 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6838 2024-04-25T23:35:44.356Z,1714088144.356 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6839 2024-04-25T23:35:44.358Z,1714088144.358 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-04-25T23:35:44.360Z,1714088144.360 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-04-25T23:35:44.361Z,1714088144.361 [CBIT](DEBUG): Initializing heartbeat. 2024-04-25T23:35:44.369Z,1714088144.369 [Onboard ThreadHandler](INFO): Handler Thread ID is 6840 2024-04-25T23:35:44.386Z,1714088144.386 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6841 2024-04-25T23:35:44.405Z,1714088144.405 [DAT ThreadHandler](INFO): Handler Thread ID is 6842 2024-04-25T23:35:44.406Z,1714088144.406 [DAT](INFO): Powering up 2024-04-25T23:35:44.406Z,1714088144.406 [DAT](DEBUG): Initializing DAT. 2024-04-25T23:35:44.409Z,1714088144.409 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6844 2024-04-25T23:35:44.410Z,1714088144.410 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-25T23:35:44.413Z,1714088144.413 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6846 2024-04-25T23:35:44.417Z,1714088144.417 [WetLabsBB2FL](INFO): Powering up 2024-04-25T23:35:44.418Z,1714088144.418 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6848 2024-04-25T23:35:44.421Z,1714088144.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-04-25T23:35:44.421Z,1714088144.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-04-25T23:35:44.421Z,1714088144.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-04-25T23:35:44.422Z,1714088144.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-04-25T23:35:44.422Z,1714088144.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-04-25T23:35:44.422Z,1714088144.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-04-25T23:35:44.422Z,1714088144.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-04-25T23:35:44.422Z,1714088144.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-04-25T23:35:44.432Z,1714088144.432 [CBIT](DEBUG): Deactivating GF circuits. 2024-04-25T23:35:44.433Z,1714088144.433 [CBIT](DEBUG): Deactivating emergency mode. 2024-04-25T23:35:44.472Z,1714088144.472 [CBIT](DEBUG): Backplane powered. 2024-04-25T23:35:44.477Z,1714088144.477 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-04-25T23:35:44.478Z,1714088144.478 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-04-25T23:35:44.478Z,1714088144.478 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-04-25T23:35:44.479Z,1714088144.479 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-04-25T23:35:44.549Z,1714088144.549 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-04-25T23:35:44.553Z,1714088144.553 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-25T23:35:44.601Z,1714088144.601 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-04-25T23:35:44.602Z,1714088144.602 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-04-25T23:35:44.602Z,1714088144.602 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-04-25T23:35:44.603Z,1714088144.603 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-04-25T23:35:44.792Z,1714088144.792 [Radio_Surface](INFO): Powering up 2024-04-25T23:35:44.949Z,1714088144.949 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-04-25T23:35:44.959Z,1714088144.959 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-04-25T23:35:44.960Z,1714088144.960 [Default:A.Wait](DEBUG): Construct Wait. 2024-04-25T23:35:44.962Z,1714088144.962 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-25T23:35:45.027Z,1714088145.027 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-04-25T23:35:45.046Z,1714088145.046 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-04-25T23:35:45.051Z,1714088145.051 [Default:E.Execute](DEBUG): Construct Execute. 2024-04-25T23:35:45.070Z,1714088145.070 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-04-25T23:35:45.075Z,1714088145.075 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-25T23:35:45.083Z,1714088145.083 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-25T23:35:45.150Z,1714088145.150 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m 2024-04-25T23:35:45.150Z,1714088145.150 [Power24vConverter](INFO): Powering up. 2024-04-25T23:35:45.151Z,1714088145.151 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-04-25T23:35:45.204Z,1714088145.204 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-04-25T23:35:45.238Z,1714088145.238 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-04-25T23:35:45.244Z,1714088145.244 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-04-25T23:35:45.245Z,1714088145.245 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-04-25T23:35:45.252Z,1714088145.252 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-04-25T23:35:45.253Z,1714088145.253 [DockingStepper](INFO): Start 2024-04-25T23:35:45.253Z,1714088145.253 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-04-25T23:35:45.254Z,1714088145.254 [MassServo](DEBUG): Initializing EZServoServo. 2024-04-25T23:35:45.260Z,1714088145.260 [MassServo](DEBUG): Initializing MassServo. 2024-04-25T23:35:45.261Z,1714088145.261 [RudderServo](DEBUG): Initializing EZServoServo. 2024-04-25T23:35:45.268Z,1714088145.268 [RudderServo](DEBUG): Initializing RudderServo. 2024-04-25T23:35:45.269Z,1714088145.269 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-04-25T23:35:45.276Z,1714088145.276 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-04-25T23:35:45.540Z,1714088145.540 [DockingStepper](INFO): Starting 2024-04-25T23:35:45.908Z,1714088145.908 [DockingStepper](INFO): Starting 2024-04-25T23:35:46.433Z,1714088146.433 [DockingStepper](INFO): Starting 2024-04-25T23:35:47.028Z,1714088147.028 [WetLabsBB2FL](INFO): Powering down 2024-04-25T23:35:47.122Z,1714088147.122 [DockingStepper](INFO): Pause 2024-04-25T23:35:54.480Z,1714088154.480 [CBIT](CRITICAL): Environmental Failure. Press:14.483596 PSI. Humidity:41%. Temp:24 C. ABORTING MISSION 2024-04-25T23:35:54.481Z,1714088154.481 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2024-04-25T23:35:54.842Z,1714088154.842 [CommandExec](FAULT): Scheduling is paused 2024-04-25T23:35:54.845Z,1714088154.845 [CBIT](INFO): Critical error at 20240425T233554 2024-04-25T23:35:57.005Z,1714088157.005 [DAT](INFO): DAT read: 2024-04-25T23:35:57.006Z,1714088157.006 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-04-25T23:35:58.769Z,1714088158.769 [DAT](INFO): DAT read: MF Frequency Band 2024-04-25T23:35:58.770Z,1714088158.770 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-04-25T23:35:58.771Z,1714088158.771 [DAT](INFO): DAT read: Apr 25 2024 23:35:43 2024-04-25T23:35:59.777Z,1714088159.777 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-04-25T23:35:59.778Z,1714088159.778 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-04-25T23:35:59.779Z,1714088159.779 [DAT](INFO): commRate: 800 2024-04-25T23:36:01.844Z,1714088161.844 [DAT](INFO): entering command mode 2024-04-25T23:36:02.045Z,1714088162.045 [DAT](INFO): DAT read: 2024-04-25T23:36:02.045Z,1714088162.045 [DAT](INFO): DAT read: user:1> 2024-04-25T23:36:02.045Z,1714088162.045 [DAT](INFO): setting verbose to 3 2024-04-25T23:36:02.297Z,1714088162.297 [DAT](INFO): DAT read: user:1> 2024-04-25T23:36:02.298Z,1714088162.298 [DAT](INFO): DAT read: Verbose | 3 2024-04-25T23:36:02.298Z,1714088162.298 [DAT](INFO): set verbose to 3 2024-04-25T23:36:02.298Z,1714088162.298 [DAT](INFO): setting DatVerbose to 27440 2024-04-25T23:36:02.549Z,1714088162.549 [DAT](INFO): DAT read: user:2> 2024-04-25T23:36:02.550Z,1714088162.550 [DAT](INFO): DAT read: DatVerbose | 27440 2024-04-25T23:36:02.550Z,1714088162.550 [DAT](INFO): set DatVerbose to 27440 2024-04-25T23:36:02.550Z,1714088162.550 [DAT](INFO): setting transmit power to 8 2024-04-25T23:36:02.801Z,1714088162.801 [DAT](INFO): DAT read: user:3> 2024-04-25T23:36:02.802Z,1714088162.802 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-04-25T23:36:02.802Z,1714088162.802 [DAT](INFO): set transmit power to 8 2024-04-25T23:36:02.802Z,1714088162.802 [DAT](INFO): setting local address to 10 2024-04-25T23:36:03.053Z,1714088163.053 [DAT](INFO): DAT read: user:4> 2024-04-25T23:36:03.054Z,1714088163.054 [DAT](INFO): DAT read: LocalAddr | 10 2024-04-25T23:36:03.054Z,1714088163.054 [DAT](INFO): set local address to 10 2024-04-25T23:36:03.055Z,1714088163.055 [DAT](INFO): Setting time to: 23:36:3 And date to:4/25/2024 2024-04-25T23:36:03.305Z,1714088163.305 [DAT](INFO): DAT read: user:5> 2024-04-25T23:36:03.306Z,1714088163.306 [DAT](INFO): DAT read: Thu Apr 25, 2024 23:36:03 2024-04-25T23:36:03.306Z,1714088163.306 [DAT](INFO): Local DAT time set to Thu Apr 25, 2024 23:36:03 2024-04-25T23:36:13.377Z,1714088173.377 [NAL9602](INFO): Powering up NAL9602 2024-04-25T23:36:24.281Z,1714088184.281 [NAL9602](INFO): NAL9602 initialized 2024-04-25T23:36:52.154Z,1714088212.154 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-25T23:37:07.507Z,1714088227.507 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-25T23:37:13.713Z,1714088233.713 [CommandExec](IMPORTANT): got command docking arm 2024-04-25T23:37:13.713Z,1714088233.713 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-04-25T23:37:14.414Z,1714088234.414 [DockingStepper](INFO): Resume 2024-04-25T23:37:14.835Z,1714088234.835 [DockingStepper](INFO): Resuming 2024-04-25T23:37:15.219Z,1714088235.219 [DockingStepper](INFO): Start 2024-04-25T23:37:15.219Z,1714088235.219 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-04-25T23:37:15.627Z,1714088235.627 [DockingStepper](INFO): Starting 2024-04-25T23:37:16.018Z,1714088236.018 [DockingStepper](INFO): Starting 2024-04-25T23:37:16.411Z,1714088236.411 [DockingStepper](INFO): Starting 2024-04-25T23:37:16.862Z,1714088236.862 [DockingStepper](INFO): Changing to mode: 2 2024-04-25T23:37:16.862Z,1714088236.862 [DockingStepper](INFO): Armed mode. 2024-04-25T23:37:22.858Z,1714088242.858 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-25T23:37:24.099Z,1714088244.099 [SBIT](IMPORTANT): Beginning Startup BIT 2024-04-25T23:37:24.103Z,1714088244.103 [CBIT](IMPORTANT): Beginning ground fault scan 2024-04-25T23:37:35.096Z,1714088255.096 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006406 CHAN A1 (24V): 0.001661 CHAN A2 (12V): -0.006350 CHAN A3 (5V): -0.002680 CHAN B0 (3.3V): -0.000345 CHAN B1 (3.15aV): -0.000348 CHAN B2 (3.15bV): -0.000246 CHAN B3 (GND): 0.001877 OPEN: 0.004782 Full Scale: +/- 1 mA 2024-04-25T23:37:37.781Z,1714088257.781 [CommandExec](IMPORTANT): got command docking standby 2024-04-25T23:37:37.781Z,1714088257.781 [CommandExec](IMPORTANT): Switching docking moudle to STANDBY. 2024-04-25T23:37:37.813Z,1714088257.813 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-25T23:37:37.864Z,1714088257.864 [DockingStepper](INFO): Changing to mode: 1 2024-04-25T23:37:37.864Z,1714088257.864 [DockingStepper](INFO): Standby mode. 2024-04-25T23:37:53.967Z,1714088273.967 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-25T23:37:54.647Z,1714088274.647 [CommandExec](IMPORTANT): got command docking arm 2024-04-25T23:37:54.648Z,1714088274.648 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-04-25T23:37:54.837Z,1714088274.837 [DockingStepper](INFO): Changing to mode: 2 2024-04-25T23:37:54.837Z,1714088274.837 [DockingStepper](INFO): Armed mode. 2024-04-25T23:37:59.033Z,1714088279.033 [CommandExec](IMPORTANT): got command docking slide 2024-04-25T23:37:59.033Z,1714088279.033 [CommandExec](IMPORTANT): Switching docking module to SLIDE. 2024-04-25T23:37:59.254Z,1714088279.254 [DockingStepper](INFO): Changing to mode: 4 2024-04-25T23:37:59.254Z,1714088279.254 [DockingStepper](INFO): Slide mode. 2024-04-25T23:38:09.318Z,1714088289.318 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-04-25T23:38:17.859Z,1714088297.859 [SBIT](IMPORTANT): SBIT PASSED 2024-04-25T23:38:17.860Z,1714088297.860 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): DockingStepper.loadAtStartup=1 bool; 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute; 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2024-04-25T23:38:17.861Z,1714088297.861 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): Express linearApproximation downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=700 cubic_centimeter; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): VerticalControl.kpDepth=0.09 radian_per_meter; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): VerticalControl.kpPitchElevator=0.5 none; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): VerticalControl.massDefault=-19.999430 millimeter; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): VerticalControl.stopDepthExcursion=20 meter; 2024-04-25T23:38:17.862Z,1714088297.862 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool; 2024-04-25T23:38:18.227Z,1714088298.227 [MissionManager](IMPORTANT): Started mission Startup 2024-04-25T23:38:18.228Z,1714088298.228 [Startup] Running Loop=1 2024-04-25T23:38:18.228Z,1714088298.228 [Startup](DEBUG): Aggregate::initialize Startup 2024-04-25T23:38:18.228Z,1714088298.228 [Startup:A.GoToSurface] Running Loop=1 2024-04-25T23:38:18.228Z,1714088298.228 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-25T23:38:18.229Z,1714088298.229 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-25T23:38:18.229Z,1714088298.229 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-25T23:38:18.229Z,1714088298.229 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-25T23:38:18.230Z,1714088298.230 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-25T23:38:18.231Z,1714088298.231 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-25T23:38:18.232Z,1714088298.232 [Startup:StartupSatComms] Running Loop=1 2024-04-25T23:38:18.233Z,1714088298.233 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-04-25T23:38:18.233Z,1714088298.233 [Startup:StartupSatComms:A] Running Loop=1 2024-04-25T23:38:18.664Z,1714088298.664 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-04-25T23:38:44.488Z,1714088324.488 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-04-25T23:38:44.489Z,1714088324.489 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T23:38:44.572Z,1714088324.572 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T23:38:44.989Z,1714088324.989 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T23:38:44.989Z,1714088324.989 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-04-25T23:38:47.619Z,1714088327.619 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004991 2024-04-25T23:39:18.427Z,1714088358.427 [Startup:StartupSatComms:A](INFO): Timed out from 2024-04-25T23:38:18.2Z 2024-04-25T23:39:18.427Z,1714088358.427 [Startup:StartupSatComms:A] Stopped 2024-04-25T23:39:18.427Z,1714088358.427 [Startup:StartupSatComms:B] Running Loop=1 2024-04-25T23:39:18.857Z,1714088358.857 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-25T23:39:22.736Z,1714088362.736 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T224033/Courier0022.lzma 2024-04-25T23:39:22.958Z,1714088362.958 [DataOverHttps](INFO): Moved sent file to Logs/20240425T224033/Courier0022.lzma.bak 2024-04-25T23:39:22.958Z,1714088362.958 [DataOverHttps](INFO): SBD MOMSN=19592841 2024-04-25T23:39:23.494Z,1714088363.494 [CommandExec](IMPORTANT): got command get DockingStepper.loadControl 2024-04-25T23:39:23.494Z,1714088363.494 [CommandExec](IMPORTANT): DockingStepper.loadControl /dev/loadB1 2024-04-25T23:39:32.487Z,1714088372.487 [CommandExec](IMPORTANT): got command get DockingStepper.baud 2024-04-25T23:39:32.488Z,1714088372.488 [CommandExec](IMPORTANT): DockingStepper.baud 9600.000000 bps 2024-04-25T23:39:37.956Z,1714088377.956 [DataOverHttps](INFO): Sending 250 bytes from file Logs/20240425T233533/Courier0000.lzma 2024-04-25T23:39:38.959Z,1714088378.959 [DataOverHttps](INFO): Moved sent file to Logs/20240425T233533/Courier0000.lzma.bak 2024-04-25T23:39:38.959Z,1714088378.959 [DataOverHttps](INFO): SBD MOMSN=19592843 2024-04-25T23:39:50.337Z,1714088390.337 [CommandExec](IMPORTANT): got command docking arm 2024-04-25T23:39:50.337Z,1714088390.337 [CommandExec](IMPORTANT): Switching docking moudle to ARM. 2024-04-25T23:39:50.482Z,1714088390.482 [DockingStepper](INFO): Changing to mode: 2 2024-04-25T23:39:50.482Z,1714088390.482 [DockingStepper](INFO): Armed mode. 2024-04-25T23:39:56.808Z,1714088396.808 [DataOverHttps](INFO): Sending 468 bytes from file Logs/20240425T224033/Express0023.lzma 2024-04-25T23:39:57.810Z,1714088397.810 [DataOverHttps](INFO): Moved sent file to Logs/20240425T224033/Express0023.lzma.bak 2024-04-25T23:39:57.810Z,1714088397.810 [DataOverHttps](INFO): SBD MOMSN=19592847 2024-04-25T23:40:03.561Z,1714088403.561 [CommandExec](IMPORTANT): got command docking standby 2024-04-25T23:40:03.561Z,1714088403.561 [CommandExec](IMPORTANT): Switching docking moudle to STANDBY. 2024-04-25T23:40:03.835Z,1714088403.835 [DockingStepper](INFO): Changing to mode: 1 2024-04-25T23:40:03.835Z,1714088403.835 [DockingStepper](INFO): Standby mode. 2024-04-25T23:40:14.058Z,1714088414.058 [DataOverHttps](INFO): Sending 1239 bytes from file Logs/20240425T233533/Express0001.lzma 2024-04-25T23:40:15.058Z,1714088415.058 [DataOverHttps](INFO): Moved sent file to Logs/20240425T233533/Express0001.lzma.bak 2024-04-25T23:40:15.058Z,1714088415.058 [DataOverHttps](INFO): SBD MOMSN=19592862 2024-04-25T23:40:17.161Z,1714088417.161 [Startup:StartupSatComms:B] Stopped 2024-04-25T23:40:17.161Z,1714088417.161 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-04-25T23:40:17.161Z,1714088417.161 [Startup:StartupSatComms] Stopped 2024-04-25T23:40:17.161Z,1714088417.161 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-04-25T23:40:17.162Z,1714088417.162 [Startup](INFO): Completed Startup 2024-04-25T23:40:17.162Z,1714088417.162 [MissionManager](INFO): Startup is completed. 2024-04-25T23:40:17.163Z,1714088417.163 [MissionManager](INFO): Uninitializing Mission Startup 2024-04-25T23:40:17.163Z,1714088417.163 [Startup] Stopped 2024-04-25T23:40:17.163Z,1714088417.163 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-04-25T23:40:17.163Z,1714088417.163 [Startup:A.GoToSurface] Stopped 2024-04-25T23:40:17.163Z,1714088417.163 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-25T23:40:17.567Z,1714088417.567 [MissionManager](IMPORTANT): Started mission Default 2024-04-25T23:40:17.567Z,1714088417.567 [Default] Running Loop=1 2024-04-25T23:40:17.567Z,1714088417.567 [Default](DEBUG): Aggregate::initialize Default 2024-04-25T23:40:17.567Z,1714088417.567 [Default:B.GoToSurface] Running Loop=1 2024-04-25T23:40:17.567Z,1714088417.567 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-25T23:40:17.568Z,1714088417.568 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-25T23:40:17.573Z,1714088417.573 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-25T23:40:17.573Z,1714088417.573 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-25T23:40:17.573Z,1714088417.573 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-25T23:40:17.574Z,1714088417.574 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-25T23:40:17.574Z,1714088417.574 [Default:A.Wait] Running Loop=1 2024-04-25T23:40:17.574Z,1714088417.574 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-04-25T23:40:30.905Z,1714088430.905 [Default:A.Wait](INFO): Done Waiting. 2024-04-25T23:40:30.905Z,1714088430.905 [Default:A.Wait] Stopped 2024-04-25T23:40:30.905Z,1714088430.905 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T23:40:31.301Z,1714088431.301 [Default:CheckIn] Running Loop=1 2024-04-25T23:40:31.301Z,1714088431.301 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T23:40:31.301Z,1714088431.301 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T23:40:31.695Z,1714088431.695 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-04-25T23:40:37.321Z,1714088437.321 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-25T23:40:44.182Z,1714088444.182 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-25T23:40:57.111Z,1714088457.111 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-25T23:41:08.146Z,1714088468.146 [CommandExec](IMPORTANT): got command show variable dockingstepper 2024-04-25T23:41:08.194Z,1714088468.194 [CommandExec](IMPORTANT): DockingStepper.loadAtStartup (bool) 2024-04-25T23:41:08.194Z,1714088468.194 [CommandExec](IMPORTANT): DockingStepper.simulateHardware (bool) 2024-04-25T23:41:08.194Z,1714088468.194 [CommandExec](IMPORTANT): DockingStepper.openValue (count) 2024-04-25T23:41:08.195Z,1714088468.195 [CommandExec](IMPORTANT): DockingStepper.closedValue (count) 2024-04-25T23:41:08.195Z,1714088468.195 [CommandExec](IMPORTANT): DockingStepper.slideValue (count) 2024-04-25T23:41:08.196Z,1714088468.196 [CommandExec](IMPORTANT): DockingStepper.deviationValue (count) 2024-04-25T23:41:08.196Z,1714088468.196 [CommandExec](IMPORTANT): DockingStepper.currLimit (percent) 2024-04-25T23:41:08.197Z,1714088468.197 [CommandExec](IMPORTANT): DockingStepper.velocity (none) 2024-04-25T23:41:08.197Z,1714088468.197 [CommandExec](IMPORTANT): DockingStepper.powerOnTimeout (second) 2024-04-25T23:41:08.265Z,1714088468.265 [CommandExec](IMPORTANT): DockingStepper.loadControl (none) 2024-04-25T23:41:08.265Z,1714088468.265 [CommandExec](IMPORTANT): DockingStepper.uart (none) 2024-04-25T23:41:08.266Z,1714088468.266 [CommandExec](IMPORTANT): DockingStepper.baud (bit_per_second) 2024-04-25T23:41:08.370Z,1714088468.370 [CommandExec](IMPORTANT): DockingStepper.enableBroadcast (bool) 2024-04-25T23:41:08.370Z,1714088468.370 [CommandExec](IMPORTANT): DockingStepper.component_voltage (volt) 2024-04-25T23:41:08.371Z,1714088468.371 [CommandExec](IMPORTANT): DockingStepper.component_avgVoltage (volt) 2024-04-25T23:41:08.371Z,1714088468.371 [CommandExec](IMPORTANT): DockingStepper.component_current (milliampere) 2024-04-25T23:41:08.371Z,1714088468.371 [CommandExec](IMPORTANT): DockingStepper.component_avgCurrent (milliampere) 2024-04-25T23:41:08.372Z,1714088468.372 [CommandExec](IMPORTANT): DockingStepper.armValue (count) 2024-04-25T23:41:08.373Z,1714088468.373 [CommandExec](IMPORTANT): DockingStepper.cableValue (count) 2024-04-25T23:41:10.038Z,1714088470.038 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-25T23:41:22.562Z,1714088482.562 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-25T23:41:24.336Z,1714088484.336 [CommandExec](IMPORTANT): got command get DockingStepper.simulateHardware 2024-04-25T23:41:24.337Z,1714088484.337 [CommandExec](IMPORTANT): DockingStepper.simulateHardware 1 bool 2024-04-25T23:41:27.823Z,1714088487.823 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-04-25T23:41:35.491Z,1714088495.491 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-04-25T23:41:36.874Z,1714088496.874 [CommandExec](IMPORTANT): got command configSet DockingStepper.simulateHardware 0 bool persist 2024-04-25T23:41:36.875Z,1714088496.875 [CommandExec](IMPORTANT): configSet DockingStepper.simulateHardware requires a restart to take effect. 2024-04-25T23:41:36.881Z,1714088496.881 [CommandExec](IMPORTANT): got command restart application 2024-04-25T23:41:37.888Z,1714088497.888 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:37.888Z,1714088497.888 [CommandExec](INFO): Uninitializing the command executive. 2024-04-25T23:41:37.888Z,1714088497.888 [CommandExec](INFO): Uninitializing the command scheduler. 2024-04-25T23:41:37.889Z,1714088497.889 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.088Z,1714088498.088 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-04-25T23:41:38.088Z,1714088498.088 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-04-25T23:41:38.088Z,1714088498.088 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.089Z,1714088498.089 [NavChartDb](INFO): Join timeout helper Thread ID is 6871 2024-04-25T23:41:38.128Z,1714088498.128 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:38.129Z,1714088498.129 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.148Z,1714088498.148 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-04-25T23:41:38.148Z,1714088498.148 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.149Z,1714088498.149 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6872 2024-04-25T23:41:38.400Z,1714088498.400 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:38.401Z,1714088498.401 [WetLabsBB2FL](INFO): Powering down 2024-04-25T23:41:38.401Z,1714088498.401 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.404Z,1714088498.404 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-04-25T23:41:38.404Z,1714088498.404 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.405Z,1714088498.405 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6873 2024-04-25T23:41:38.872Z,1714088498.872 [CTD_Seabird](INFO): Powering down 2024-04-25T23:41:38.884Z,1714088498.884 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:38.884Z,1714088498.884 [CTD_Seabird](INFO): Powering down 2024-04-25T23:41:38.896Z,1714088498.896 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.904Z,1714088498.904 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-04-25T23:41:38.904Z,1714088498.904 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:38.905Z,1714088498.905 [DAT](INFO): Join timeout helper Thread ID is 6874 2024-04-25T23:41:38.980Z,1714088498.980 [DAT](INFO): Powering down 2024-04-25T23:41:39.053Z,1714088499.053 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:39.053Z,1714088499.053 [DAT](INFO): Powering down 2024-04-25T23:41:39.054Z,1714088499.054 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:39.060Z,1714088499.060 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-04-25T23:41:39.060Z,1714088499.060 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:39.061Z,1714088499.061 [Radio_Surface](INFO): Join timeout helper Thread ID is 6875 2024-04-25T23:41:39.296Z,1714088499.296 [Radio_Surface](INFO): Powering down 2024-04-25T23:41:39.297Z,1714088499.297 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:39.297Z,1714088499.297 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:39.313Z,1714088499.313 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-04-25T23:41:39.313Z,1714088499.313 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:39.314Z,1714088499.314 [Onboard](INFO): Join timeout helper Thread ID is 6876 2024-04-25T23:41:39.680Z,1714088499.680 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:39.681Z,1714088499.681 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:39.685Z,1714088499.685 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-04-25T23:41:39.685Z,1714088499.685 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:39.685Z,1714088499.685 [DataOverHttps](INFO): Join timeout helper Thread ID is 6877 2024-04-25T23:41:42.045Z,1714088502.045 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:42.048Z,1714088502.048 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.069Z,1714088502.069 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-04-25T23:41:42.069Z,1714088502.069 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.069Z,1714088502.069 [BackseatComponent](INFO): Join timeout helper Thread ID is 6878 2024-04-25T23:41:42.197Z,1714088502.197 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:42.197Z,1714088502.197 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.209Z,1714088502.209 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-04-25T23:41:42.209Z,1714088502.209 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.209Z,1714088502.209 [logger](INFO): Join timeout helper Thread ID is 6879 2024-04-25T23:41:42.249Z,1714088502.249 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:42.249Z,1714088502.249 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.269Z,1714088502.269 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-04-25T23:41:42.269Z,1714088502.269 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.269Z,1714088502.269 [CommandLine](INFO): Join timeout helper Thread ID is 6880 2024-04-25T23:41:42.288Z,1714088502.288 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:42.289Z,1714088502.289 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.309Z,1714088502.309 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-04-25T23:41:42.309Z,1714088502.309 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.309Z,1714088502.309 [CommandExec](INFO): Join timeout helper Thread ID is 6881 2024-04-25T23:41:42.310Z,1714088502.310 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-04-25T23:41:42.310Z,1714088502.310 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.311Z,1714088502.311 [controlThread](INFO): Join timeout helper Thread ID is 6882 2024-04-25T23:41:42.348Z,1714088502.348 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T23:41:42.349Z,1714088502.349 [controlThread](DEBUG): Uninitializing ControlThread 2024-04-25T23:41:42.349Z,1714088502.349 [AHRS_M2](INFO): Powering down 2024-04-25T23:41:42.421Z,1714088502.421 [NAL9602](INFO): Powering down 2024-04-25T23:41:42.492Z,1714088502.492 [RDI_Pathfinder](INFO): Powering down 2024-04-25T23:41:42.494Z,1714088502.494 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-04-25T23:41:42.495Z,1714088502.495 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-04-25T23:41:42.495Z,1714088502.495 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-04-25T23:41:42.496Z,1714088502.496 [MissionManager](INFO): Uninitializing Mission Default 2024-04-25T23:41:42.496Z,1714088502.496 [Default] Stopped 2024-04-25T23:41:42.496Z,1714088502.496 [Default](DEBUG): Aggregate::uninitialize Default 2024-04-25T23:41:42.496Z,1714088502.496 [Default:B.GoToSurface] Stopped 2024-04-25T23:41:42.496Z,1714088502.496 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-25T23:41:42.496Z,1714088502.496 [Default:CheckIn] Stopped 2024-04-25T23:41:42.496Z,1714088502.496 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T23:41:42.496Z,1714088502.496 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T23:41:42.499Z,1714088502.499 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-04-25T23:41:42.499Z,1714088502.499 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-04-25T23:41:42.500Z,1714088502.500 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-04-25T23:41:42.500Z,1714088502.500 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-04-25T23:41:42.500Z,1714088502.500 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-04-25T23:41:42.501Z,1714088502.501 [BuoyancyServo](INFO): Powering down 2024-04-25T23:41:42.512Z,1714088502.512 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-04-25T23:41:42.512Z,1714088502.512 [ElevatorServo](INFO): Powering down 2024-04-25T23:41:42.513Z,1714088502.513 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-04-25T23:41:42.513Z,1714088502.513 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-04-25T23:41:42.514Z,1714088502.514 [MassServo](INFO): Powering down 2024-04-25T23:41:42.514Z,1714088502.514 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-04-25T23:41:42.514Z,1714088502.514 [RudderServo](INFO): Powering down 2024-04-25T23:41:42.515Z,1714088502.515 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-04-25T23:41:42.515Z,1714088502.515 [ThrusterServo](INFO): Powering down 2024-04-25T23:41:42.516Z,1714088502.516 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-04-25T23:41:42.517Z,1714088502.517 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-04-25T23:41:42.517Z,1714088502.517 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-04-25T23:41:42.517Z,1714088502.517 [CBIT](DEBUG): Powering off loads. 2024-04-25T23:41:42.528Z,1714088502.528 [CBIT](DEBUG): Disabling WDT. 2024-04-25T23:41:42.540Z,1714088502.540 [CBIT](DEBUG): Opening all GF detection circuits. 2024-04-25T23:41:42.541Z,1714088502.541 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.594Z,1714088502.594 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.601Z,1714088502.601 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.603Z,1714088502.603 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.608Z,1714088502.608 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.651Z,1714088502.651 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.711Z,1714088502.711 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.717Z,1714088502.717 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.725Z,1714088502.725 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-25T23:41:42.791Z,1714088502.791 [logger ThreadHandler](INFO): Thread cancelled.