2025-03-10T19:44:53.346Z,1741635893.346 [Supervisor](DEBUG): Initializing supervisor. 2025-03-10T19:44:53.351Z,1741635893.351 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-03-10T19:44:53.352Z,1741635893.352 [SyncHandler](INFO): Protected caller Thread ID is 4557 2025-03-10T19:44:53.352Z,1741635893.352 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-03-10T19:44:53.354Z,1741635893.354 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-03-10T19:44:53.354Z,1741635893.354 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4558 2025-03-10T19:44:53.358Z,1741635893.358 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-03-10T19:44:53.378Z,1741635893.378 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-03-10T19:44:53.379Z,1741635893.379 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-03-10T19:44:53.379Z,1741635893.379 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4559 2025-03-10T19:44:53.383Z,1741635893.383 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-03-10T19:44:53.384Z,1741635893.384 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-03-10T19:44:53.385Z,1741635893.385 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4560 2025-03-10T19:44:53.387Z,1741635893.387 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-03-10T19:44:53.388Z,1741635893.388 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-03-10T19:44:53.388Z,1741635893.388 [logger ThreadHandler](INFO): Protected caller Thread ID is 4561 2025-03-10T19:44:53.392Z,1741635893.392 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-03-10T19:44:53.393Z,1741635893.393 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-03-10T19:44:53.394Z,1741635893.394 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-03-10T19:44:53.670Z,1741635893.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-03-10T19:44:53.670Z,1741635893.670 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-03-10T19:44:53.762Z,1741635893.762 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-03-10T19:44:54.298Z,1741635894.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-03-10T19:44:54.299Z,1741635894.299 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-03-10T19:44:54.653Z,1741635894.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-03-10T19:44:54.654Z,1741635894.654 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-03-10T19:44:54.762Z,1741635894.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-03-10T19:44:54.762Z,1741635894.762 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-03-10T19:44:55.194Z,1741635895.194 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-03-10T19:44:55.194Z,1741635895.194 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-03-10T19:44:55.434Z,1741635895.434 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-03-10T19:44:55.435Z,1741635895.435 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-03-10T19:44:55.976Z,1741635895.976 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-03-10T19:44:55.976Z,1741635895.976 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-03-10T19:44:56.125Z,1741635896.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-03-10T19:44:56.125Z,1741635896.125 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-03-10T19:44:56.216Z,1741635896.216 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-03-10T19:44:57.069Z,1741635897.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-03-10T19:44:57.069Z,1741635897.069 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-03-10T19:44:57.459Z,1741635897.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-03-10T19:44:57.460Z,1741635897.460 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-03-10T19:44:57.665Z,1741635897.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-03-10T19:44:57.665Z,1741635897.665 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-03-10T19:44:57.894Z,1741635897.894 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-03-10T19:44:57.894Z,1741635897.894 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-03-10T19:44:58.410Z,1741635898.410 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-03-10T19:44:58.410Z,1741635898.410 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-03-10T19:44:58.671Z,1741635898.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-03-10T19:44:58.673Z,1741635898.673 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2025-03-10T19:44:58.674Z,1741635898.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2025-03-10T19:44:58.772Z,1741635898.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2025-03-10T19:44:58.885Z,1741635898.885 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2025-03-10T19:44:58.980Z,1741635898.980 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2025-03-10T19:44:59.095Z,1741635899.095 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2025-03-10T19:44:59.199Z,1741635899.199 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2025-03-10T19:44:59.328Z,1741635899.328 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2025-03-10T19:44:59.493Z,1741635899.493 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2025-03-10T19:44:59.656Z,1741635899.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2025-03-10T19:44:59.777Z,1741635899.777 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2025-03-10T19:45:00.054Z,1741635900.054 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-03-10T19:45:00.055Z,1741635900.055 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2025-03-10T19:45:00.056Z,1741635900.056 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-03-10T19:45:00.064Z,1741635900.064 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-03-10T19:45:00.118Z,1741635900.118 [VerticalControl](DEBUG): Construct VerticalControl. 2025-03-10T19:45:00.181Z,1741635900.181 [VerticalControl] Loaded 2025-03-10T19:45:00.181Z,1741635900.181 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-03-10T19:45:00.184Z,1741635900.184 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-03-10T19:45:00.230Z,1741635900.230 [HorizontalControl] Loaded 2025-03-10T19:45:00.230Z,1741635900.230 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-03-10T19:45:00.233Z,1741635900.233 [SpeedControl](DEBUG): Construct SpeedControl. 2025-03-10T19:45:00.236Z,1741635900.236 [SpeedControl] Loaded 2025-03-10T19:45:00.237Z,1741635900.237 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-03-10T19:45:00.239Z,1741635900.239 [LoopControl](DEBUG): Construct LoopControl. 2025-03-10T19:45:00.240Z,1741635900.240 [LoopControl] Loaded 2025-03-10T19:45:00.240Z,1741635900.240 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-03-10T19:45:00.241Z,1741635900.241 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-03-10T19:45:00.241Z,1741635900.241 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-03-10T19:45:00.252Z,1741635900.252 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-03-10T19:45:00.252Z,1741635900.252 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-03-10T19:45:00.430Z,1741635900.430 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-03-10T19:45:00.431Z,1741635900.431 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-03-10T19:45:00.591Z,1741635900.591 [BuoyancyServo] Loaded 2025-03-10T19:45:00.592Z,1741635900.592 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-03-10T19:45:00.614Z,1741635900.614 [ElevatorServo] Loaded 2025-03-10T19:45:00.614Z,1741635900.614 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-03-10T19:45:00.637Z,1741635900.637 [MassServo] Loaded 2025-03-10T19:45:00.637Z,1741635900.637 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-03-10T19:45:00.657Z,1741635900.657 [RudderServo] Loaded 2025-03-10T19:45:00.658Z,1741635900.658 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-03-10T19:45:00.675Z,1741635900.675 [ThrusterHE] Loaded 2025-03-10T19:45:00.676Z,1741635900.676 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-03-10T19:45:00.676Z,1741635900.676 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-03-10T19:45:00.676Z,1741635900.676 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-03-10T19:45:00.790Z,1741635900.790 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-03-10T19:45:00.790Z,1741635900.790 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-03-10T19:45:00.804Z,1741635900.804 [NavChart] Loaded 2025-03-10T19:45:00.804Z,1741635900.804 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-03-10T19:45:00.810Z,1741635900.810 [UniversalFixResidualReporter] Loaded 2025-03-10T19:45:00.810Z,1741635900.810 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-03-10T19:45:00.811Z,1741635900.811 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-03-10T19:45:00.811Z,1741635900.811 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-03-10T19:45:00.871Z,1741635900.871 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-03-10T19:45:00.871Z,1741635900.871 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-03-10T19:45:01.349Z,1741635901.349 [AHRS_M2] Loaded 2025-03-10T19:45:01.350Z,1741635901.350 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-03-10T19:45:02.168Z,1741635902.168 [BPC1] Loaded 2025-03-10T19:45:02.169Z,1741635902.169 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-03-10T19:45:02.269Z,1741635902.269 [DAT] Loaded 2025-03-10T19:45:02.269Z,1741635902.269 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-03-10T19:45:02.270Z,1741635902.270 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4094B4E0 2025-03-10T19:45:02.270Z,1741635902.270 [DAT ThreadHandler](INFO): Protected caller Thread ID is 4640 2025-03-10T19:45:02.346Z,1741635902.346 [DataOverHttps] Loaded 2025-03-10T19:45:02.346Z,1741635902.346 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-03-10T19:45:02.347Z,1741635902.347 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4097B4E0 2025-03-10T19:45:02.347Z,1741635902.347 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4641 2025-03-10T19:45:02.371Z,1741635902.371 [Depth_Keller] Loaded 2025-03-10T19:45:02.371Z,1741635902.371 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-03-10T19:45:02.376Z,1741635902.376 [DropWeight] Loaded 2025-03-10T19:45:02.376Z,1741635902.376 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-03-10T19:45:02.442Z,1741635902.442 [NAL9602] Loaded 2025-03-10T19:45:02.442Z,1741635902.442 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-03-10T19:45:02.473Z,1741635902.473 [Onboard] Loaded 2025-03-10T19:45:02.473Z,1741635902.473 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-03-10T19:45:02.474Z,1741635902.474 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409AB4E0 2025-03-10T19:45:02.474Z,1741635902.474 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4642 2025-03-10T19:45:02.489Z,1741635902.489 [Power24vConverter] Loaded 2025-03-10T19:45:02.489Z,1741635902.489 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-03-10T19:45:02.505Z,1741635902.505 [Radio_Surface] Loaded 2025-03-10T19:45:02.505Z,1741635902.505 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-03-10T19:45:02.506Z,1741635902.506 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0 2025-03-10T19:45:02.507Z,1741635902.507 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4643 2025-03-10T19:45:02.522Z,1741635902.522 [Sonardyne_Nano] Loaded 2025-03-10T19:45:02.523Z,1741635902.523 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-03-10T19:45:02.523Z,1741635902.523 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-03-10T19:45:02.524Z,1741635902.524 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-03-10T19:45:02.575Z,1741635902.575 [DepthRateCalculator] Loaded 2025-03-10T19:45:02.575Z,1741635902.575 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-03-10T19:45:02.580Z,1741635902.580 [PitchRateCalculator] Loaded 2025-03-10T19:45:02.581Z,1741635902.581 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-03-10T19:45:02.589Z,1741635902.589 [SpeedCalculator] Loaded 2025-03-10T19:45:02.590Z,1741635902.590 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-03-10T19:45:02.594Z,1741635902.594 [YawRateCalculator] Loaded 2025-03-10T19:45:02.594Z,1741635902.594 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-03-10T19:45:02.613Z,1741635902.613 [ElevatorOffsetCalculator] Loaded 2025-03-10T19:45:02.614Z,1741635902.614 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-03-10T19:45:02.614Z,1741635902.614 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-03-10T19:45:02.615Z,1741635902.615 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-03-10T19:45:02.743Z,1741635902.743 [CANONSampler] Loaded 2025-03-10T19:45:02.744Z,1741635902.744 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2025-03-10T19:45:02.877Z,1741635902.877 [CTD_Seabird] Loaded 2025-03-10T19:45:02.878Z,1741635902.878 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-03-10T19:45:02.879Z,1741635902.879 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A964E0 2025-03-10T19:45:02.879Z,1741635902.879 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4644 2025-03-10T19:45:02.976Z,1741635902.976 [PAR_Licor] Loaded 2025-03-10T19:45:02.976Z,1741635902.976 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-03-10T19:45:03.050Z,1741635903.050 [WetLabsBB2FL] Loaded 2025-03-10T19:45:03.051Z,1741635903.051 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-03-10T19:45:03.052Z,1741635903.052 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AC64E0 2025-03-10T19:45:03.052Z,1741635903.052 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4645 2025-03-10T19:45:03.053Z,1741635903.053 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-03-10T19:45:03.053Z,1741635903.053 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-03-10T19:45:03.117Z,1741635903.117 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-03-10T19:45:03.118Z,1741635903.118 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-03-10T19:45:03.614Z,1741635903.614 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-03-10T19:45:03.615Z,1741635903.615 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-03-10T19:45:03.777Z,1741635903.777 [SBIT](DEBUG): Construct Startup Built In Test. 2025-03-10T19:45:03.787Z,1741635903.787 [SBIT] Loaded 2025-03-10T19:45:03.787Z,1741635903.787 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-03-10T19:45:03.790Z,1741635903.790 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-03-10T19:45:03.803Z,1741635903.803 [IBIT] Loaded 2025-03-10T19:45:03.803Z,1741635903.803 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-03-10T19:45:03.808Z,1741635903.808 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-03-10T19:45:03.890Z,1741635903.890 [CBIT] Loaded 2025-03-10T19:45:03.890Z,1741635903.890 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-03-10T19:45:03.923Z,1741635903.923 [GFScanner] Loaded 2025-03-10T19:45:03.923Z,1741635903.923 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-03-10T19:45:03.924Z,1741635903.924 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-03-10T19:45:03.924Z,1741635903.924 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-03-10T19:45:04.056Z,1741635904.056 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-03-10T19:45:04.063Z,1741635904.063 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-03-10T19:45:04.066Z,1741635904.066 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-03-10T19:45:04.077Z,1741635904.077 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-03-10T19:45:04.078Z,1741635904.078 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C354E0 2025-03-10T19:45:04.078Z,1741635904.078 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4646 2025-03-10T19:45:04.083Z,1741635904.083 [Supervisor](INFO): Main Thread ID is 3600 2025-03-10T19:45:04.083Z,1741635904.083 [Supervisor](DEBUG): Running supervisor. 2025-03-10T19:45:04.084Z,1741635904.084 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4647 2025-03-10T19:45:04.084Z,1741635904.084 [CommandExec](INFO): Initializing the command executive. 2025-03-10T19:45:04.086Z,1741635904.086 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4648 2025-03-10T19:45:04.088Z,1741635904.088 [controlThread ThreadHandler](INFO): Handler Thread ID is 4649 2025-03-10T19:45:04.088Z,1741635904.088 [controlThread](DEBUG): Initializing ControlThread 2025-03-10T19:45:04.089Z,1741635904.089 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-03-10T19:45:04.091Z,1741635904.091 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-03-10T19:45:04.092Z,1741635904.092 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-03-10T19:45:04.092Z,1741635904.092 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-03-10T19:45:04.094Z,1741635904.094 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-03-10T19:45:04.095Z,1741635904.095 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-03-10T19:45:04.101Z,1741635904.101 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-03-10T19:45:04.102Z,1741635904.102 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-03-10T19:45:04.102Z,1741635904.102 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-03-10T19:45:04.102Z,1741635904.102 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-03-10T19:45:04.103Z,1741635904.103 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-03-10T19:45:04.108Z,1741635904.108 [SBIT](INFO): Initialize SBIT Component. 2025-03-10T19:45:04.108Z,1741635904.108 [SBIT](IMPORTANT): git: 2025-03-10 2025-03-10T19:45:04.108Z,1741635904.108 [SBIT](INFO): git hash: ed984fb97dc40cbcfe09dec37ea56a9b8070d839 2025-03-10T19:45:04.109Z,1741635904.109 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-03-10T19:45:04.110Z,1741635904.110 [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 2025-03-10T19:45:04.111Z,1741635904.111 [SBIT](INFO): Beginning SBIT in 53.000000 seconds. 2025-03-10T19:45:04.112Z,1741635904.112 [IBIT](INFO): Initialize IBIT Component. 2025-03-10T19:45:04.113Z,1741635904.113 [CBIT](DEBUG): Initialize CBIT Component. 2025-03-10T19:45:04.114Z,1741635904.114 [logger ThreadHandler](INFO): Handler Thread ID is 4650 2025-03-10T19:45:04.123Z,1741635904.123 [CBIT](DEBUG): Initialized mux pins. 2025-03-10T19:45:04.124Z,1741635904.124 [CBIT](DEBUG): Initializing the watchdog timer. 2025-03-10T19:45:04.132Z,1741635904.132 [DAT ThreadHandler](INFO): Handler Thread ID is 4651 2025-03-10T19:45:04.133Z,1741635904.133 [DAT](INFO): Powering up 2025-03-10T19:45:04.133Z,1741635904.133 [DAT](DEBUG): Initializing DAT. 2025-03-10T19:45:04.137Z,1741635904.137 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4653 2025-03-10T19:45:04.139Z,1741635904.139 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-03-10T19:45:04.148Z,1741635904.148 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-03-10T19:45:04.148Z,1741635904.148 [CBIT](DEBUG): Initializing heartbeat. 2025-03-10T19:45:04.149Z,1741635904.149 [Onboard ThreadHandler](INFO): Handler Thread ID is 4654 2025-03-10T19:45:04.169Z,1741635904.169 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4655 2025-03-10T19:45:04.184Z,1741635904.184 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4656 2025-03-10T19:45:04.185Z,1741635904.185 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-10T19:45:04.189Z,1741635904.189 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4658 2025-03-10T19:45:04.192Z,1741635904.192 [WetLabsBB2FL](INFO): Powering up 2025-03-10T19:45:04.193Z,1741635904.193 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4660 2025-03-10T19:45:04.196Z,1741635904.196 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-03-10T19:45:04.196Z,1741635904.196 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-03-10T19:45:04.196Z,1741635904.196 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-03-10T19:45:04.197Z,1741635904.197 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-03-10T19:45:04.197Z,1741635904.197 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-03-10T19:45:04.197Z,1741635904.197 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-03-10T19:45:04.197Z,1741635904.197 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-03-10T19:45:04.197Z,1741635904.197 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-03-10T19:45:04.219Z,1741635904.219 [CBIT](DEBUG): Deactivating emergency mode. 2025-03-10T19:45:04.259Z,1741635904.259 [CBIT](DEBUG): Backplane powered. 2025-03-10T19:45:04.260Z,1741635904.260 [GFScanner](DEBUG): Initializing GFScanner 2025-03-10T19:45:04.260Z,1741635904.260 [GFScanner](DEBUG): Deactivating GF circuits. 2025-03-10T19:45:04.264Z,1741635904.264 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-03-10T19:45:04.265Z,1741635904.265 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-03-10T19:45:04.265Z,1741635904.265 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-03-10T19:45:04.267Z,1741635904.267 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-03-10T19:45:04.336Z,1741635904.336 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-03-10T19:45:04.340Z,1741635904.340 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-03-10T19:45:04.385Z,1741635904.385 [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 } } } 2025-03-10T19:45:04.386Z,1741635904.386 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-03-10T19:45:04.386Z,1741635904.386 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-03-10T19:45:04.396Z,1741635904.396 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-03-10T19:45:04.572Z,1741635904.572 [Radio_Surface](INFO): Powering up 2025-03-10T19:45:04.692Z,1741635904.692 [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 2025-03-10T19:45:04.703Z,1741635904.703 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-03-10T19:45:04.724Z,1741635904.724 [Default:A.Wait](DEBUG): Construct Wait. 2025-03-10T19:45:04.727Z,1741635904.727 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-03-10T19:45:04.768Z,1741635904.768 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-03-10T19:45:04.771Z,1741635904.771 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-03-10T19:45:04.802Z,1741635904.802 [Default:E.Execute](DEBUG): Construct Execute. 2025-03-10T19:45:04.805Z,1741635904.805 [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" } } 2025-03-10T19:45:04.816Z,1741635904.816 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,Reporter,LogSplitter, 2025-03-10T19:45:04.828Z,1741635904.828 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-10T19:45:04.906Z,1741635904.906 [Power24vConverter](INFO): Powering up. 2025-03-10T19:45:04.907Z,1741635904.907 [Sonardyne_Nano](INFO): Initializing. 2025-03-10T19:45:04.920Z,1741635904.920 [CANONSampler](INFO): Powering down 2025-03-10T19:45:04.957Z,1741635904.957 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-03-10T19:45:04.964Z,1741635904.964 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-03-10T19:45:04.965Z,1741635904.965 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-03-10T19:45:04.972Z,1741635904.972 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-03-10T19:45:04.973Z,1741635904.973 [MassServo](DEBUG): Initializing EZServoServo. 2025-03-10T19:45:04.980Z,1741635904.980 [MassServo](DEBUG): Initializing MassServo. 2025-03-10T19:45:04.981Z,1741635904.981 [RudderServo](DEBUG): Initializing EZServoServo. 2025-03-10T19:45:04.988Z,1741635904.988 [RudderServo](DEBUG): Initializing RudderServo. 2025-03-10T19:45:04.989Z,1741635904.989 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-03-10T19:45:04.996Z,1741635904.996 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-03-10T19:45:05.257Z,1741635905.257 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-03-10T19:45:05.257Z,1741635905.257 [DropWeight] Hardware Fault, FailCount= 1 2025-03-10T19:45:05.257Z,1741635905.257 [DropWeight](ERROR): Hardware Fault 2025-03-10T19:45:05.298Z,1741635905.298 [CommandExec](FAULT): Scheduling is paused 2025-03-10T19:45:05.299Z,1741635905.299 [CBIT](INFO): Critical error at 20250310T194505 2025-03-10T19:45:05.299Z,1741635905.299 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-03-10T19:45:05.309Z,1741635905.309 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-03-10T19:45:05.310Z,1741635905.310 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-03-10T19:45:05.654Z,1741635905.654 [CBIT](INFO): Critical error at 20250310T194505 2025-03-10T19:45:06.300Z,1741635906.300 [WetLabsBB2FL](INFO): Powering down 2025-03-10T19:45:06.846Z,1741635906.846 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-03-10T19:45:08.132Z,1741635908.132 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2109 2025-03-10T19:45:10.724Z,1741635910.724 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-03-10T19:45:15.724Z,1741635915.724 [DAT](INFO): DAT read: 2025-03-10T19:45:15.725Z,1741635915.725 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-03-10T19:45:17.236Z,1741635917.236 [DAT](INFO): DAT read: MF Frequency Band 2025-03-10T19:45:17.238Z,1741635917.238 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-03-10T19:45:17.238Z,1741635917.238 [DAT](INFO): DAT read: Mar 10 2025 19:45:12 2025-03-10T19:45:18.246Z,1741635918.246 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-03-10T19:45:18.247Z,1741635918.247 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-03-10T19:45:18.248Z,1741635918.248 [DAT](INFO): commRate: 1200 2025-03-10T19:45:20.312Z,1741635920.312 [DAT](INFO): entering command mode 2025-03-10T19:45:20.512Z,1741635920.512 [DAT](INFO): DAT read: 2025-03-10T19:45:20.513Z,1741635920.513 [DAT](INFO): DAT read: user:1> 2025-03-10T19:45:20.513Z,1741635920.513 [DAT](INFO): setting verbose to 3 2025-03-10T19:45:20.764Z,1741635920.764 [DAT](INFO): DAT read: user:1> 2025-03-10T19:45:20.765Z,1741635920.765 [DAT](INFO): DAT read: Verbose | 3 2025-03-10T19:45:20.766Z,1741635920.766 [DAT](INFO): set verbose to 3 2025-03-10T19:45:20.766Z,1741635920.766 [DAT](INFO): setting DatVerbose to 27440 2025-03-10T19:45:21.016Z,1741635921.016 [DAT](INFO): DAT read: user:2> 2025-03-10T19:45:21.017Z,1741635921.017 [DAT](INFO): DAT read: DatVerbose | 27440 2025-03-10T19:45:21.018Z,1741635921.018 [DAT](INFO): set DatVerbose to 27440 2025-03-10T19:45:21.018Z,1741635921.018 [DAT](INFO): setting transmit power to 8 2025-03-10T19:45:21.269Z,1741635921.269 [DAT](INFO): DAT read: user:3> 2025-03-10T19:45:21.270Z,1741635921.270 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-03-10T19:45:21.270Z,1741635921.270 [DAT](INFO): set transmit power to 8 2025-03-10T19:45:21.270Z,1741635921.270 [DAT](INFO): setting local address to 8 2025-03-10T19:45:21.520Z,1741635921.520 [DAT](INFO): DAT read: user:4> 2025-03-10T19:45:21.521Z,1741635921.521 [DAT](INFO): DAT read: LocalAddr | 8 2025-03-10T19:45:21.522Z,1741635921.522 [DAT](INFO): set local address to 8 2025-03-10T19:45:21.523Z,1741635921.523 [DAT](INFO): Setting time to: 19:45:21 And date to:3/10/2025 2025-03-10T19:45:21.772Z,1741635921.772 [DAT](INFO): DAT read: user:5> 2025-03-10T19:45:21.773Z,1741635921.773 [DAT](INFO): DAT read: Mon Mar 10, 2025 19:45:21 2025-03-10T19:45:21.773Z,1741635921.773 [DAT](INFO): Local DAT time set to Mon Mar 10, 2025 19:45:21 2025-03-10T19:45:32.705Z,1741635932.705 [NAL9602](INFO): Powering up NAL9602 2025-03-10T19:45:43.621Z,1741635943.621 [NAL9602](INFO): NAL9602 initialized 2025-03-10T19:45:57.809Z,1741635957.809 [SBIT](IMPORTANT): Beginning Startup BIT 2025-03-10T19:45:57.813Z,1741635957.813 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-03-10T19:46:02.281Z,1741635962.281 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.002128 CHAN A1 (24V): 0.000572 CHAN A2 (12V): -0.002632 CHAN A3 (5V): -0.001304 CHAN B0 (3.3V): -0.000195 CHAN B1 (3.15aV): 0.000236 CHAN B2 (3.15bV): -0.000084 CHAN B3 (GND): 0.000224 OPEN: -0.000903 Full Scale: +/- 1 mA 2025-03-10T19:46:10.854Z,1741635970.854 [SBIT](FAULT): Rudder: EXPECTED:15.000000 ACTUAL:14.797676 2025-03-10T19:46:25.626Z,1741635985.626 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-03-10T19:46:45.462Z,1741636005.462 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7). 2025-03-10T19:46:51.547Z,1741636011.547 [SBIT](CRITICAL): SBIT FAILED 2025-03-10T19:46:51.547Z,1741636011.547 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-03-10T19:46:51.548Z,1741636011.548 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=11 count; 2025-03-10T19:46:51.548Z,1741636011.548 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter; 2025-03-10T19:46:51.548Z,1741636011.548 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2025-03-10T19:46:51.549Z,1741636011.549 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-03-10T19:46:51.549Z,1741636011.549 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-03-10T19:46:51.549Z,1741636011.549 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=355.541360 cubic_centimeter; 2025-03-10T19:46:51.549Z,1741636011.549 [SBIT](IMPORTANT): VerticalControl.massDefault=8.472520 millimeter; 2025-03-10T19:46:51.550Z,1741636011.550 [CBIT](INFO): Critical error at 20250310T194651 2025-03-10T19:46:51.953Z,1741636011.953 [MissionManager](IMPORTANT): Started mission Startup 2025-03-10T19:46:51.954Z,1741636011.954 [Startup] Running Loop=1 2025-03-10T19:46:51.954Z,1741636011.954 [Startup](DEBUG): Aggregate::initialize Startup 2025-03-10T19:46:51.954Z,1741636011.954 [Startup:A.GoToSurface] Running Loop=1 2025-03-10T19:46:51.954Z,1741636011.954 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-10T19:46:51.954Z,1741636011.954 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-10T19:46:51.955Z,1741636011.955 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-10T19:46:51.955Z,1741636011.955 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-10T19:46:51.956Z,1741636011.956 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-10T19:46:51.956Z,1741636011.956 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-10T19:46:51.957Z,1741636011.957 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-10T19:46:51.958Z,1741636011.958 [Startup:StartupSatComms] Running Loop=1 2025-03-10T19:46:51.958Z,1741636011.958 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-03-10T19:46:51.958Z,1741636011.958 [Startup:StartupSatComms:A] Running Loop=1 2025-03-10T19:46:52.350Z,1741636012.350 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-03-10T19:47:27.126Z,1741636047.126 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-03-10T19:47:36.258Z,1741636056.258 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004400 2025-03-10T19:47:50.967Z,1741636070.967 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-03-10T19:47:52.144Z,1741636072.144 [Startup:StartupSatComms:A](INFO): Timed out from 2025-03-10T19:46:51.0Z 2025-03-10T19:47:52.145Z,1741636072.145 [Startup:StartupSatComms:A] Stopped 2025-03-10T19:47:52.145Z,1741636072.145 [Startup:StartupSatComms:B] Running Loop=1 2025-03-10T19:47:52.542Z,1741636072.542 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-10T19:47:59.619Z,1741636079.619 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250310T192829/Courier0007.lzma 2025-03-10T19:48:00.622Z,1741636080.622 [DataOverHttps](INFO): Moved sent file to Logs/20250310T192829/Courier0007.lzma.bak 2025-03-10T19:48:00.622Z,1741636080.622 [DataOverHttps](INFO): SBD MOMSN=24150290 2025-03-10T19:48:04.373Z,1741636084.373 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-03-10T19:48:04.373Z,1741636084.373 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T19:48:04.548Z,1741636084.548 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T19:48:04.924Z,1741636084.924 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T19:48:04.924Z,1741636084.924 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-03-10T19:48:16.552Z,1741636096.552 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20250310T194453/Courier0000.lzma 2025-03-10T19:48:17.553Z,1741636097.553 [DataOverHttps](INFO): Moved sent file to Logs/20250310T194453/Courier0000.lzma.bak 2025-03-10T19:48:17.553Z,1741636097.553 [DataOverHttps](INFO): SBD MOMSN=24150292 2025-03-10T19:48:33.452Z,1741636113.452 [DataOverHttps](INFO): Sending 274 bytes from file Logs/20250310T192829/Express0008.lzma 2025-03-10T19:48:34.453Z,1741636114.453 [DataOverHttps](INFO): Moved sent file to Logs/20250310T192829/Express0008.lzma.bak 2025-03-10T19:48:34.453Z,1741636114.453 [DataOverHttps](INFO): SBD MOMSN=24150298 2025-03-10T19:48:50.477Z,1741636130.477 [DataOverHttps](INFO): Sending 917 bytes from file Logs/20250310T194453/Express0001.lzma 2025-03-10T19:48:51.477Z,1741636131.477 [DataOverHttps](INFO): Moved sent file to Logs/20250310T194453/Express0001.lzma.bak 2025-03-10T19:48:51.477Z,1741636131.477 [DataOverHttps](INFO): SBD MOMSN=24150305 2025-03-10T19:48:52.420Z,1741636132.420 [Startup:StartupSatComms:B](INFO): Timed out from 2025-03-10T19:47:52.1Z 2025-03-10T19:48:52.420Z,1741636132.420 [Startup:StartupSatComms:B] Stopped 2025-03-10T19:48:52.420Z,1741636132.420 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-03-10T19:48:52.420Z,1741636132.420 [Startup:StartupSatComms] Stopped 2025-03-10T19:48:52.420Z,1741636132.420 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-03-10T19:48:52.421Z,1741636132.421 [Startup](INFO): Completed Startup 2025-03-10T19:48:52.421Z,1741636132.421 [MissionManager](INFO): Startup is completed. 2025-03-10T19:48:52.421Z,1741636132.421 [MissionManager](INFO): Uninitializing Mission Startup 2025-03-10T19:48:52.421Z,1741636132.421 [Startup] Stopped 2025-03-10T19:48:52.421Z,1741636132.421 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-03-10T19:48:52.422Z,1741636132.422 [Startup:A.GoToSurface] Stopped 2025-03-10T19:48:52.422Z,1741636132.422 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-10T19:48:52.833Z,1741636132.833 [MissionManager](IMPORTANT): Started mission Default 2025-03-10T19:48:52.833Z,1741636132.833 [Default] Running Loop=1 2025-03-10T19:48:52.833Z,1741636132.833 [Default](DEBUG): Aggregate::initialize Default 2025-03-10T19:48:52.833Z,1741636132.833 [Default:B.GoToSurface] Running Loop=1 2025-03-10T19:48:52.834Z,1741636132.834 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-10T19:48:52.834Z,1741636132.834 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-10T19:48:52.834Z,1741636132.834 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-10T19:48:52.834Z,1741636132.834 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-10T19:48:52.835Z,1741636132.835 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-10T19:48:52.835Z,1741636132.835 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-10T19:48:52.837Z,1741636132.837 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-10T19:48:52.837Z,1741636132.837 [Default:A.Wait] Running Loop=1 2025-03-10T19:48:52.837Z,1741636132.837 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-03-10T19:49:05.391Z,1741636145.391 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-03-10T19:49:06.170Z,1741636146.170 [Default:A.Wait](INFO): Done Waiting. 2025-03-10T19:49:06.170Z,1741636146.170 [Default:A.Wait] Stopped 2025-03-10T19:49:06.170Z,1741636146.170 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T19:49:06.606Z,1741636146.606 [Default:CheckIn] Running Loop=1 2025-03-10T19:49:06.606Z,1741636146.606 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T19:49:06.606Z,1741636146.606 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T19:49:06.994Z,1741636146.994 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-03-10T19:49:17.911Z,1741636157.911 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-03-10T19:50:47.549Z,1741636247.549 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-10T19:51:05.341Z,1741636265.341 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-03-10T19:51:05.341Z,1741636265.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T19:51:05.492Z,1741636265.492 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T19:51:05.908Z,1741636265.908 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T19:51:05.908Z,1741636265.908 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-03-10T19:51:20.330Z,1741636280.330 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-03-10T19:54:06.324Z,1741636446.324 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-03-10T19:54:06.324Z,1741636446.324 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T19:54:06.468Z,1741636446.468 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T19:54:06.734Z,1741636446.734 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T19:49:06.6Z 2025-03-10T19:54:06.735Z,1741636446.735 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T19:54:06.735Z,1741636446.735 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T19:54:06.881Z,1741636446.881 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T19:54:06.881Z,1741636446.881 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-03-10T19:54:07.133Z,1741636447.133 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-10T19:54:12.774Z,1741636452.774 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-03-10T19:54:12.780Z,1741636452.780 [BPC1](INFO): Calculating totals. Valid battery stick count: 47. Valid reserve battery stick count: 4. 2025-03-10T19:54:12.783Z,1741636452.783 [BPC1](INFO): Received data from all battery sticks. 2025-03-10T19:54:14.439Z,1741636454.439 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250310T194453/Courier0004.lzma 2025-03-10T19:54:15.441Z,1741636455.441 [DataOverHttps](INFO): Moved sent file to Logs/20250310T194453/Courier0004.lzma.bak 2025-03-10T19:54:15.441Z,1741636455.441 [DataOverHttps](INFO): SBD MOMSN=24150338 2025-03-10T19:54:25.255Z,1741636465.255 [CommandExec](IMPORTANT): got command configSet RudderServo.offsetAngle 1 degree 2025-03-10T19:54:30.345Z,1741636470.345 [CommandExec](IMPORTANT): got command configSet RudderServo.offsetAngle 1 degree persist 2025-03-10T19:54:33.728Z,1741636473.728 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20250310T194453/Express0005.lzma 2025-03-10T19:54:34.729Z,1741636474.729 [DataOverHttps](INFO): Moved sent file to Logs/20250310T194453/Express0005.lzma.bak 2025-03-10T19:54:34.730Z,1741636474.730 [DataOverHttps](INFO): SBD MOMSN=24150340 2025-03-10T19:54:36.247Z,1741636476.247 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T19:54:36.247Z,1741636476.247 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T19:54:36.247Z,1741636476.247 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T19:54:42.881Z,1741636482.881 [CommandExec](IMPORTANT): got command get RudderServo.offsetAngle 2025-03-10T19:54:42.881Z,1741636482.881 [CommandExec](IMPORTANT): RudderServo.offsetAngle 1.000000 arcdeg 2025-03-10T19:55:44.489Z,1741636544.489 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T19:55:44.489Z,1741636544.489 [NAL9602] Data Fault, FailCount= 1 2025-03-10T19:55:44.489Z,1741636544.489 [NAL9602](ERROR): Data Fault 2025-03-10T19:55:44.535Z,1741636544.535 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T19:55:44.889Z,1741636544.889 [NAL9602](INFO): Powering down 2025-03-10T19:55:45.726Z,1741636545.726 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T19:55:45.727Z,1741636545.727 [NAL9602] No Fault, FailCount= 1 2025-03-10T19:56:15.193Z,1741636575.193 [NAL9602](INFO): Powering up NAL9602 2025-03-10T19:56:26.106Z,1741636586.106 [NAL9602](INFO): NAL9602 initialized 2025-03-10T19:57:07.328Z,1741636627.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-03-10T19:57:07.328Z,1741636627.328 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T19:57:07.351Z,1741636627.351 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T19:57:07.729Z,1741636627.729 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T19:57:07.729Z,1741636627.729 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-03-10T19:58:37.473Z,1741636717.473 [CommandExec](IMPORTANT): got command restart application 2025-03-10T19:58:38.476Z,1741636718.476 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:38.476Z,1741636718.476 [CommandExec](INFO): Uninitializing the command executive. 2025-03-10T19:58:38.476Z,1741636718.476 [CommandExec](INFO): Uninitializing the command scheduler. 2025-03-10T19:58:38.476Z,1741636718.476 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:38.556Z,1741636718.556 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-03-10T19:58:38.556Z,1741636718.556 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-03-10T19:58:38.556Z,1741636718.556 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:38.557Z,1741636718.557 [NavChartDb](INFO): Join timeout helper Thread ID is 4681 2025-03-10T19:58:38.752Z,1741636718.752 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:38.752Z,1741636718.752 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:38.756Z,1741636718.756 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-03-10T19:58:38.756Z,1741636718.756 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:38.756Z,1741636718.756 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4682 2025-03-10T19:58:38.892Z,1741636718.892 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:38.892Z,1741636718.892 [WetLabsBB2FL](INFO): Powering down 2025-03-10T19:58:38.893Z,1741636718.893 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:38.899Z,1741636718.899 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-03-10T19:58:38.900Z,1741636718.900 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:38.900Z,1741636718.900 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4683 2025-03-10T19:58:39.584Z,1741636719.584 [CTD_Seabird](INFO): Powering down 2025-03-10T19:58:39.602Z,1741636719.602 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:39.604Z,1741636719.604 [CTD_Seabird](INFO): Powering down 2025-03-10T19:58:39.616Z,1741636719.616 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:39.632Z,1741636719.632 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-03-10T19:58:39.632Z,1741636719.632 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:39.633Z,1741636719.633 [Radio_Surface](INFO): Join timeout helper Thread ID is 4684 2025-03-10T19:58:39.952Z,1741636719.952 [Radio_Surface](INFO): Powering down 2025-03-10T19:58:39.952Z,1741636719.952 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:39.953Z,1741636719.953 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:39.965Z,1741636719.965 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-03-10T19:58:39.965Z,1741636719.965 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:39.965Z,1741636719.965 [Onboard](INFO): Join timeout helper Thread ID is 4685 2025-03-10T19:58:44.828Z,1741636724.828 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:44.828Z,1741636724.828 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:44.848Z,1741636724.848 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-03-10T19:58:44.848Z,1741636724.848 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:44.849Z,1741636724.849 [DataOverHttps](INFO): Join timeout helper Thread ID is 4686 2025-03-10T19:58:45.112Z,1741636725.112 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:45.113Z,1741636725.113 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.116Z,1741636725.116 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-03-10T19:58:45.116Z,1741636725.116 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.117Z,1741636725.117 [DAT](INFO): Join timeout helper Thread ID is 4687 2025-03-10T19:58:45.144Z,1741636725.144 [DAT](INFO): Powering down 2025-03-10T19:58:45.216Z,1741636725.216 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:45.216Z,1741636725.216 [DAT](INFO): Powering down 2025-03-10T19:58:45.224Z,1741636725.224 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.244Z,1741636725.244 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-03-10T19:58:45.244Z,1741636725.244 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.245Z,1741636725.245 [logger](INFO): Join timeout helper Thread ID is 4688 2025-03-10T19:58:45.280Z,1741636725.280 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:45.280Z,1741636725.280 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.288Z,1741636725.288 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-03-10T19:58:45.288Z,1741636725.288 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.289Z,1741636725.289 [CommandLine](INFO): Join timeout helper Thread ID is 4689 2025-03-10T19:58:45.292Z,1741636725.292 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:45.292Z,1741636725.292 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.308Z,1741636725.308 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-03-10T19:58:45.308Z,1741636725.308 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.309Z,1741636725.309 [CommandExec](INFO): Join timeout helper Thread ID is 4690 2025-03-10T19:58:45.310Z,1741636725.310 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-03-10T19:58:45.310Z,1741636725.310 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.311Z,1741636725.311 [controlThread](INFO): Join timeout helper Thread ID is 4691 2025-03-10T19:58:45.464Z,1741636725.464 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T19:58:45.464Z,1741636725.464 [controlThread](DEBUG): Uninitializing ControlThread 2025-03-10T19:58:45.464Z,1741636725.464 [AHRS_M2](INFO): Powering down 2025-03-10T19:58:45.536Z,1741636725.536 [NAL9602](INFO): Powering down 2025-03-10T19:58:45.538Z,1741636725.538 [Sonardyne_Nano](INFO): Powering down 2025-03-10T19:58:45.657Z,1741636725.657 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-03-10T19:58:45.658Z,1741636725.658 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-03-10T19:58:45.658Z,1741636725.658 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-03-10T19:58:45.659Z,1741636725.659 [MissionManager](INFO): Uninitializing Mission Default 2025-03-10T19:58:45.659Z,1741636725.659 [Default] Stopped 2025-03-10T19:58:45.659Z,1741636725.659 [Default](DEBUG): Aggregate::uninitialize Default 2025-03-10T19:58:45.659Z,1741636725.659 [Default:B.GoToSurface] Stopped 2025-03-10T19:58:45.659Z,1741636725.659 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-10T19:58:45.659Z,1741636725.659 [Default:CheckIn] Stopped 2025-03-10T19:58:45.660Z,1741636725.660 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T19:58:45.660Z,1741636725.660 [Default:CheckIn:C.Wait] Stopped 2025-03-10T19:58:45.660Z,1741636725.660 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T19:58:45.663Z,1741636725.663 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-03-10T19:58:45.663Z,1741636725.663 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-03-10T19:58:45.664Z,1741636725.664 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-03-10T19:58:45.664Z,1741636725.664 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-03-10T19:58:45.664Z,1741636725.664 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-03-10T19:58:45.664Z,1741636725.664 [BuoyancyServo](INFO): Powering down 2025-03-10T19:58:45.676Z,1741636725.676 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-03-10T19:58:45.676Z,1741636725.676 [ElevatorServo](INFO): Powering down 2025-03-10T19:58:45.677Z,1741636725.677 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-03-10T19:58:45.677Z,1741636725.677 [MassServo](INFO): Powering down 2025-03-10T19:58:45.678Z,1741636725.678 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-03-10T19:58:45.678Z,1741636725.678 [RudderServo](INFO): Powering down 2025-03-10T19:58:45.678Z,1741636725.678 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-03-10T19:58:45.679Z,1741636725.679 [ThrusterHE](INFO): Powering down 2025-03-10T19:58:45.679Z,1741636725.679 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-03-10T19:58:45.680Z,1741636725.680 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-03-10T19:58:45.680Z,1741636725.680 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-03-10T19:58:45.680Z,1741636725.680 [CBIT](DEBUG): Powering off loads. 2025-03-10T19:58:45.691Z,1741636725.691 [CBIT](DEBUG): Disabling WDT. 2025-03-10T19:58:45.704Z,1741636725.704 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-10T19:58:45.704Z,1741636725.704 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-03-10T19:58:45.705Z,1741636725.705 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.749Z,1741636725.749 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.752Z,1741636725.752 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.758Z,1741636725.758 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.764Z,1741636725.764 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.838Z,1741636725.838 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.842Z,1741636725.842 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.866Z,1741636725.866 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-10T19:58:45.866Z,1741636725.866 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-03-10T19:58:45.886Z,1741636725.886 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-10T19:58:45.951Z,1741636725.951 [logger ThreadHandler](INFO): Thread cancelled.