2025-10-14T18:41:08.609Z,1760467268.609 [Supervisor](DEBUG): Initializing supervisor. 2025-10-14T18:41:08.614Z,1760467268.614 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-10-14T18:41:08.614Z,1760467268.614 [SyncHandler](INFO): Protected caller Thread ID is 7616 2025-10-14T18:41:08.615Z,1760467268.615 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-10-14T18:41:08.616Z,1760467268.616 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-10-14T18:41:08.616Z,1760467268.616 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7617 2025-10-14T18:41:08.620Z,1760467268.620 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-10-14T18:41:08.641Z,1760467268.641 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-10-14T18:41:08.642Z,1760467268.642 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-10-14T18:41:08.642Z,1760467268.642 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7618 2025-10-14T18:41:08.646Z,1760467268.646 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-10-14T18:41:08.647Z,1760467268.647 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-10-14T18:41:08.648Z,1760467268.648 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7619 2025-10-14T18:41:08.650Z,1760467268.650 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-10-14T18:41:08.651Z,1760467268.651 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-10-14T18:41:08.651Z,1760467268.651 [logger ThreadHandler](INFO): Protected caller Thread ID is 7620 2025-10-14T18:41:08.655Z,1760467268.655 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-10-14T18:41:08.655Z,1760467268.655 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-10-14T18:41:08.657Z,1760467268.657 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-10-14T18:41:09.013Z,1760467269.013 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-10-14T18:41:09.014Z,1760467269.014 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-10-14T18:41:09.292Z,1760467269.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-10-14T18:41:09.293Z,1760467269.293 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-10-14T18:41:09.824Z,1760467269.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-10-14T18:41:09.824Z,1760467269.824 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-10-14T18:41:10.077Z,1760467270.077 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-10-14T18:41:10.078Z,1760467270.078 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-10-14T18:41:10.315Z,1760467270.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-10-14T18:41:10.316Z,1760467270.316 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-10-14T18:41:11.153Z,1760467271.153 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-10-14T18:41:11.153Z,1760467271.153 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-10-14T18:41:11.584Z,1760467271.584 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-10-14T18:41:11.585Z,1760467271.585 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-10-14T18:41:11.707Z,1760467271.707 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-10-14T18:41:11.707Z,1760467271.707 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-10-14T18:41:11.798Z,1760467271.798 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-10-14T18:41:11.993Z,1760467271.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-10-14T18:41:11.994Z,1760467271.994 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-10-14T18:41:12.104Z,1760467272.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-10-14T18:41:12.104Z,1760467272.104 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-10-14T18:41:12.338Z,1760467272.338 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-10-14T18:41:12.338Z,1760467272.338 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-10-14T18:41:12.489Z,1760467272.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-10-14T18:41:12.489Z,1760467272.489 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-10-14T18:41:12.594Z,1760467272.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-10-14T18:41:12.595Z,1760467272.595 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-10-14T18:41:13.273Z,1760467273.273 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-10-14T18:41:13.274Z,1760467273.274 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-10-14T18:41:14.015Z,1760467274.015 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-10-14T18:41:14.017Z,1760467274.017 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/ 2025-10-14T18:41:14.018Z,1760467274.018 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg 2025-10-14T18:41:14.135Z,1760467274.135 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg 2025-10-14T18:41:14.419Z,1760467274.419 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-10-14T18:41:14.420Z,1760467274.420 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg 2025-10-14T18:41:14.534Z,1760467274.534 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg 2025-10-14T18:41:14.642Z,1760467274.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg 2025-10-14T18:41:14.763Z,1760467274.763 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg 2025-10-14T18:41:14.911Z,1760467274.911 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg 2025-10-14T18:41:15.021Z,1760467275.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg 2025-10-14T18:41:15.142Z,1760467275.142 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg 2025-10-14T18:41:15.236Z,1760467275.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg 2025-10-14T18:41:15.362Z,1760467275.362 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg 2025-10-14T18:41:15.460Z,1760467275.460 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/root/ 2025-10-14T18:41:15.460Z,1760467275.460 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-10-14T18:41:15.470Z,1760467275.470 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-10-14T18:41:15.481Z,1760467275.481 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-10-14T18:41:15.481Z,1760467275.481 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-10-14T18:41:15.598Z,1760467275.598 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-10-14T18:41:15.598Z,1760467275.598 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-10-14T18:41:15.639Z,1760467275.639 [DeadReckonWithRespectToSeafloor] Loaded 2025-10-14T18:41:15.639Z,1760467275.639 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2025-10-14T18:41:15.653Z,1760467275.653 [NavChart] Loaded 2025-10-14T18:41:15.653Z,1760467275.653 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-10-14T18:41:15.659Z,1760467275.659 [UniversalFixResidualReporter] Loaded 2025-10-14T18:41:15.659Z,1760467275.659 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-10-14T18:41:15.659Z,1760467275.659 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-10-14T18:41:15.660Z,1760467275.660 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-10-14T18:41:16.172Z,1760467276.172 [AHRS_M2] Loaded 2025-10-14T18:41:16.172Z,1760467276.172 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-10-14T18:41:16.211Z,1760467276.211 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3 2025-10-14T18:41:16.212Z,1760467276.212 [BackseatComponent] Loaded 2025-10-14T18:41:16.212Z,1760467276.212 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-10-14T18:41:16.213Z,1760467276.213 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4085E4E0 2025-10-14T18:41:16.214Z,1760467276.214 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7702 2025-10-14T18:41:16.216Z,1760467276.216 [LcmUniversalReporter] Loaded 2025-10-14T18:41:16.217Z,1760467276.217 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-10-14T18:41:17.054Z,1760467277.054 [BPC1] Loaded 2025-10-14T18:41:17.054Z,1760467277.054 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-10-14T18:41:17.153Z,1760467277.153 [DAT] Loaded 2025-10-14T18:41:17.153Z,1760467277.153 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-10-14T18:41:17.154Z,1760467277.154 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4088E4E0 2025-10-14T18:41:17.155Z,1760467277.155 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7703 2025-10-14T18:41:17.229Z,1760467277.229 [DataOverHttps] Loaded 2025-10-14T18:41:17.229Z,1760467277.229 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-10-14T18:41:17.230Z,1760467277.230 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408BE4E0 2025-10-14T18:41:17.231Z,1760467277.231 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7704 2025-10-14T18:41:17.253Z,1760467277.253 [DepthKeller33X] Loaded 2025-10-14T18:41:17.254Z,1760467277.254 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread. 2025-10-14T18:41:17.259Z,1760467277.259 [DropWeight] Loaded 2025-10-14T18:41:17.259Z,1760467277.259 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-10-14T18:41:17.323Z,1760467277.323 [NAL9602] Loaded 2025-10-14T18:41:17.323Z,1760467277.323 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-10-14T18:41:17.353Z,1760467277.353 [Onboard] Loaded 2025-10-14T18:41:17.354Z,1760467277.354 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-10-14T18:41:17.355Z,1760467277.355 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408EE4E0 2025-10-14T18:41:17.355Z,1760467277.355 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7705 2025-10-14T18:41:17.370Z,1760467277.370 [Power24vConverter] Loaded 2025-10-14T18:41:17.370Z,1760467277.370 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-10-14T18:41:17.387Z,1760467277.387 [Radio_Surface] Loaded 2025-10-14T18:41:17.387Z,1760467277.387 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-10-14T18:41:17.388Z,1760467277.388 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4091E4E0 2025-10-14T18:41:17.388Z,1760467277.388 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7706 2025-10-14T18:41:17.435Z,1760467277.435 [RDI_Pathfinder] Loaded 2025-10-14T18:41:17.435Z,1760467277.435 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2025-10-14T18:41:17.451Z,1760467277.451 [Sonardyne_Nano] Loaded 2025-10-14T18:41:17.451Z,1760467277.451 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-10-14T18:41:17.451Z,1760467277.451 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-10-14T18:41:17.452Z,1760467277.452 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-10-14T18:41:17.504Z,1760467277.504 [DepthRateCalculator] Loaded 2025-10-14T18:41:17.504Z,1760467277.504 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-10-14T18:41:17.509Z,1760467277.509 [PitchRateCalculator] Loaded 2025-10-14T18:41:17.510Z,1760467277.510 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-10-14T18:41:17.519Z,1760467277.519 [SpeedCalculator] Loaded 2025-10-14T18:41:17.519Z,1760467277.519 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-10-14T18:41:17.524Z,1760467277.524 [YawRateCalculator] Loaded 2025-10-14T18:41:17.524Z,1760467277.524 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-10-14T18:41:17.548Z,1760467277.548 [ElevatorOffsetCalculator] Loaded 2025-10-14T18:41:17.548Z,1760467277.548 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-10-14T18:41:17.548Z,1760467277.548 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-10-14T18:41:17.549Z,1760467277.549 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-10-14T18:41:17.610Z,1760467277.610 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-10-14T18:41:17.610Z,1760467277.610 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-10-14T18:41:17.751Z,1760467277.751 [BuoyancyServo] Loaded 2025-10-14T18:41:17.751Z,1760467277.751 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-10-14T18:41:17.776Z,1760467277.776 [ElevatorServo] Loaded 2025-10-14T18:41:17.776Z,1760467277.776 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-10-14T18:41:17.799Z,1760467277.799 [MassServo] Loaded 2025-10-14T18:41:17.800Z,1760467277.800 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-10-14T18:41:17.823Z,1760467277.823 [RudderServo] Loaded 2025-10-14T18:41:17.823Z,1760467277.823 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-10-14T18:41:17.841Z,1760467277.841 [ThrusterHE] Loaded 2025-10-14T18:41:17.841Z,1760467277.841 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-10-14T18:41:17.842Z,1760467277.842 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-10-14T18:41:17.842Z,1760467277.842 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-10-14T18:41:18.017Z,1760467278.017 [CTD_Seabird] Loaded 2025-10-14T18:41:18.017Z,1760467278.017 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-10-14T18:41:18.018Z,1760467278.018 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0 2025-10-14T18:41:18.019Z,1760467278.019 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7707 2025-10-14T18:41:18.040Z,1760467278.040 [RBRTridente] Loaded 2025-10-14T18:41:18.040Z,1760467278.040 [ComponentRegistry](DEBUG): Component "RBRTridente" handled in its own thread. 2025-10-14T18:41:18.041Z,1760467278.041 [RBRTridente ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0 2025-10-14T18:41:18.042Z,1760467278.042 [RBRTridente ThreadHandler](INFO): Protected caller Thread ID is 7708 2025-10-14T18:41:18.043Z,1760467278.043 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-10-14T18:41:18.043Z,1760467278.043 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-10-14T18:41:18.181Z,1760467278.181 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-10-14T18:41:18.181Z,1760467278.181 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-10-14T18:41:18.362Z,1760467278.362 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-10-14T18:41:18.363Z,1760467278.363 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-10-14T18:41:19.214Z,1760467279.214 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-10-14T18:41:19.214Z,1760467279.214 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-10-14T18:41:19.270Z,1760467279.270 [VerticalControl](DEBUG): Construct VerticalControl. 2025-10-14T18:41:19.324Z,1760467279.324 [VerticalControl] Loaded 2025-10-14T18:41:19.324Z,1760467279.324 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-10-14T18:41:19.327Z,1760467279.327 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-10-14T18:41:19.375Z,1760467279.375 [HorizontalControl] Loaded 2025-10-14T18:41:19.375Z,1760467279.375 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-10-14T18:41:19.378Z,1760467279.378 [SpeedControl](DEBUG): Construct SpeedControl. 2025-10-14T18:41:19.379Z,1760467279.379 [SpeedControl] Loaded 2025-10-14T18:41:19.380Z,1760467279.380 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-10-14T18:41:19.383Z,1760467279.383 [LoopControl](DEBUG): Construct LoopControl. 2025-10-14T18:41:19.383Z,1760467279.383 [LoopControl] Loaded 2025-10-14T18:41:19.383Z,1760467279.383 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-10-14T18:41:19.384Z,1760467279.384 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-10-14T18:41:19.384Z,1760467279.384 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-10-14T18:41:19.547Z,1760467279.547 [SBIT](DEBUG): Construct Startup Built In Test. 2025-10-14T18:41:19.556Z,1760467279.556 [SBIT] Loaded 2025-10-14T18:41:19.556Z,1760467279.556 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-10-14T18:41:19.559Z,1760467279.559 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-10-14T18:41:19.572Z,1760467279.572 [IBIT] Loaded 2025-10-14T18:41:19.573Z,1760467279.573 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-10-14T18:41:19.578Z,1760467279.578 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-10-14T18:41:19.660Z,1760467279.660 [CBIT] Loaded 2025-10-14T18:41:19.660Z,1760467279.660 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-10-14T18:41:19.693Z,1760467279.693 [GFScanner] Loaded 2025-10-14T18:41:19.694Z,1760467279.694 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-10-14T18:41:19.694Z,1760467279.694 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-10-14T18:41:19.694Z,1760467279.694 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-10-14T18:41:19.724Z,1760467279.724 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-10-14T18:41:19.730Z,1760467279.730 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-10-14T18:41:19.733Z,1760467279.733 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-10-14T18:41:19.745Z,1760467279.745 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-10-14T18:41:19.746Z,1760467279.746 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0 2025-10-14T18:41:19.746Z,1760467279.746 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7709 2025-10-14T18:41:19.751Z,1760467279.751 [Supervisor](INFO): Main Thread ID is 7455 2025-10-14T18:41:19.751Z,1760467279.751 [Supervisor](DEBUG): Running supervisor. 2025-10-14T18:41:19.751Z,1760467279.751 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7710 2025-10-14T18:41:19.752Z,1760467279.752 [CommandExec](INFO): Initializing the command executive. 2025-10-14T18:41:19.754Z,1760467279.754 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7711 2025-10-14T18:41:19.756Z,1760467279.756 [controlThread ThreadHandler](INFO): Handler Thread ID is 7712 2025-10-14T18:41:19.756Z,1760467279.756 [controlThread](DEBUG): Initializing ControlThread 2025-10-14T18:41:19.758Z,1760467279.758 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-10-14T18:41:19.758Z,1760467279.758 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-10-14T18:41:19.762Z,1760467279.762 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-10-14T18:41:19.762Z,1760467279.762 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-10-14T18:41:19.762Z,1760467279.762 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-10-14T18:41:19.763Z,1760467279.763 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-10-14T18:41:19.763Z,1760467279.763 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-10-14T18:41:19.765Z,1760467279.765 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-10-14T18:41:19.766Z,1760467279.766 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-10-14T18:41:19.767Z,1760467279.767 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-10-14T18:41:19.768Z,1760467279.768 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-10-14T18:41:19.768Z,1760467279.768 [SBIT](INFO): Initialize SBIT Component. 2025-10-14T18:41:19.768Z,1760467279.768 [SBIT](IMPORTANT): git: 2025-09-11 2025-10-14T18:41:19.769Z,1760467279.769 [SBIT](INFO): git hash: 809a1152453d4a7797fa86b43c86e80bc3a54567 2025-10-14T18:41:19.769Z,1760467279.769 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-10-14T18:41:19.770Z,1760467279.770 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023 2025-10-14T18:41:19.771Z,1760467279.771 [SBIT](INFO): Beginning SBIT in 95.000000 seconds. 2025-10-14T18:41:19.772Z,1760467279.772 [IBIT](INFO): Initialize IBIT Component. 2025-10-14T18:41:19.772Z,1760467279.772 [CBIT](DEBUG): Initialize CBIT Component. 2025-10-14T18:41:19.773Z,1760467279.773 [logger ThreadHandler](INFO): Handler Thread ID is 7713 2025-10-14T18:41:19.785Z,1760467279.785 [CBIT](DEBUG): Initialized mux pins. 2025-10-14T18:41:19.785Z,1760467279.785 [CBIT](DEBUG): Initializing the watchdog timer. 2025-10-14T18:41:19.794Z,1760467279.794 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7714 2025-10-14T18:41:19.809Z,1760467279.809 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-10-14T18:41:19.809Z,1760467279.809 [CBIT](DEBUG): Initializing heartbeat. 2025-10-14T18:41:19.810Z,1760467279.810 [DAT ThreadHandler](INFO): Handler Thread ID is 7715 2025-10-14T18:41:19.811Z,1760467279.811 [DAT](INFO): Powering up 2025-10-14T18:41:19.811Z,1760467279.811 [DAT](DEBUG): Initializing DAT. 2025-10-14T18:41:19.815Z,1760467279.815 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7717 2025-10-14T18:41:19.816Z,1760467279.816 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-10-14T18:41:19.838Z,1760467279.838 [Onboard ThreadHandler](INFO): Handler Thread ID is 7718 2025-10-14T18:41:19.856Z,1760467279.856 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7719 2025-10-14T18:41:19.874Z,1760467279.874 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7720 2025-10-14T18:41:19.874Z,1760467279.874 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-10-14T18:41:19.878Z,1760467279.878 [RBRTridente ThreadHandler](INFO): Handler Thread ID is 7722 2025-10-14T18:41:19.879Z,1760467279.879 [RBRTridente](INFO): Start 2025-10-14T18:41:19.881Z,1760467279.881 [CBIT](DEBUG): Deactivating emergency mode. 2025-10-14T18:41:19.882Z,1760467279.882 [RBRTridente](INFO): Powering up 2025-10-14T18:41:19.883Z,1760467279.883 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7724 2025-10-14T18:41:19.886Z,1760467279.886 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-10-14T18:41:19.886Z,1760467279.886 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-10-14T18:41:19.886Z,1760467279.886 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-10-14T18:41:19.886Z,1760467279.886 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-10-14T18:41:19.886Z,1760467279.886 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-10-14T18:41:19.886Z,1760467279.886 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-10-14T18:41:19.887Z,1760467279.887 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-10-14T18:41:19.887Z,1760467279.887 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-10-14T18:41:19.921Z,1760467279.921 [CBIT](DEBUG): Backplane powered. 2025-10-14T18:41:19.922Z,1760467279.922 [GFScanner](DEBUG): Initializing GFScanner 2025-10-14T18:41:19.922Z,1760467279.922 [GFScanner](DEBUG): Deactivating GF circuits. 2025-10-14T18:41:19.926Z,1760467279.926 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-10-14T18:41:19.927Z,1760467279.927 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-10-14T18:41:19.927Z,1760467279.927 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-10-14T18:41:19.928Z,1760467279.928 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-10-14T18:41:20.000Z,1760467280.000 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-10-14T18:41:20.005Z,1760467280.005 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-10-14T18:41:20.054Z,1760467280.054 [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-10-14T18:41:20.055Z,1760467280.055 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-10-14T18:41:20.055Z,1760467280.055 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-10-14T18:41:20.057Z,1760467280.057 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-10-14T18:41:20.265Z,1760467280.265 [Radio_Surface](INFO): Powering up 2025-10-14T18:41:20.281Z,1760467280.281 [RBRTridente](INFO): Starting 2025-10-14T18:41:20.366Z,1760467280.366 [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-10-14T18:41:20.391Z,1760467280.391 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-10-14T18:41:20.392Z,1760467280.392 [Default:A.Wait](DEBUG): Construct Wait. 2025-10-14T18:41:20.395Z,1760467280.395 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-10-14T18:41:20.441Z,1760467280.441 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-10-14T18:41:20.443Z,1760467280.443 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-10-14T18:41:20.458Z,1760467280.458 [Default:E.Execute](DEBUG): Construct Execute. 2025-10-14T18:41:20.461Z,1760467280.461 [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-10-14T18:41:20.489Z,1760467280.489 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-10-14T18:41:20.501Z,1760467280.501 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-10-14T18:41:20.567Z,1760467280.567 [DepthKeller33X](INFO): Initializing. 2025-10-14T18:41:20.586Z,1760467280.586 [Power24vConverter](INFO): Powering up. 2025-10-14T18:41:20.587Z,1760467280.587 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2025-10-14T18:41:20.594Z,1760467280.594 [Sonardyne_Nano](INFO): Initializing. 2025-10-14T18:41:20.613Z,1760467280.613 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-10-14T18:41:20.625Z,1760467280.625 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:20.626Z,1760467280.626 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-10-14T18:41:20.627Z,1760467280.627 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:20.633Z,1760467280.633 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:41:20.634Z,1760467280.634 [MassServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:20.641Z,1760467280.641 [MassServo](DEBUG): Initializing MassServo. 2025-10-14T18:41:20.642Z,1760467280.642 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:20.650Z,1760467280.650 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:41:20.650Z,1760467280.650 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:20.657Z,1760467280.657 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-10-14T18:41:20.685Z,1760467280.685 [RBRTridente](INFO): Stop 2025-10-14T18:41:20.757Z,1760467280.757 [RBRTridente](INFO): Powering down 2025-10-14T18:41:20.943Z,1760467280.943 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-10-14T18:41:20.943Z,1760467280.943 [DropWeight] Hardware Fault, FailCount= 1 2025-10-14T18:41:20.943Z,1760467280.943 [DropWeight](ERROR): Hardware Fault 2025-10-14T18:41:20.950Z,1760467280.950 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-10-14T18:41:20.967Z,1760467280.967 [CommandExec](FAULT): Scheduling is paused 2025-10-14T18:41:20.967Z,1760467280.967 [CBIT](INFO): Critical error at 20251014T184120 2025-10-14T18:41:20.968Z,1760467280.968 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-10-14T18:41:20.978Z,1760467280.978 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-10-14T18:41:20.979Z,1760467280.979 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-10-14T18:41:21.089Z,1760467281.089 [RBRTridente](INFO): Stopping 2025-10-14T18:41:21.309Z,1760467281.309 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-10-14T18:41:21.318Z,1760467281.318 [CBIT](INFO): Critical error at 20251014T184120 2025-10-14T18:41:21.709Z,1760467281.709 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-10-14T18:41:22.135Z,1760467282.135 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-10-14T18:41:22.548Z,1760467282.548 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-10-14T18:41:23.820Z,1760467283.820 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-10-14T18:41:25.878Z,1760467285.878 [RudderServo](FAULT): Overload Error 2025-10-14T18:41:25.878Z,1760467285.878 [RudderServo] Hardware Fault, FailCount= 1 2025-10-14T18:41:25.878Z,1760467285.878 [RudderServo](ERROR): Hardware Fault 2025-10-14T18:41:26.001Z,1760467286.001 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-10-14T18:41:26.258Z,1760467286.258 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-10-14T18:41:26.258Z,1760467286.258 [RudderServo](INFO): Powering down 2025-10-14T18:41:26.921Z,1760467286.921 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-10-14T18:41:27.058Z,1760467287.058 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:27.178Z,1760467287.178 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:41:27.184Z,1760467287.184 [CBIT](INFO): Clearing failed state for component RudderServo 2025-10-14T18:41:27.184Z,1760467287.184 [RudderServo] No Fault, FailCount= 1 2025-10-14T18:41:31.150Z,1760467291.150 [DAT](INFO): DAT read: 2025-10-14T18:41:31.151Z,1760467291.151 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-10-14T18:41:32.342Z,1760467292.342 [RudderServo](FAULT): Overload Error 2025-10-14T18:41:32.342Z,1760467292.342 [RudderServo] Hardware Fault, FailCount= 2 2025-10-14T18:41:32.342Z,1760467292.342 [RudderServo](ERROR): Hardware Fault 2025-10-14T18:41:32.449Z,1760467292.449 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-10-14T18:41:32.663Z,1760467292.663 [DAT](INFO): DAT read: MF Frequency Band 2025-10-14T18:41:32.664Z,1760467292.664 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.0 2025-10-14T18:41:32.664Z,1760467292.664 [DAT](INFO): DAT read: Oct 14 2025 18:41:27 2025-10-14T18:41:32.798Z,1760467292.798 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-10-14T18:41:32.798Z,1760467292.798 [RudderServo](INFO): Powering down 2025-10-14T18:41:33.626Z,1760467293.626 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:33.671Z,1760467293.671 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-10-14T18:41:33.672Z,1760467293.672 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2025-10-14T18:41:33.673Z,1760467293.673 [DAT](INFO): commRate: 600 2025-10-14T18:41:33.746Z,1760467293.746 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:41:33.752Z,1760467293.752 [CBIT](INFO): Clearing failed state for component RudderServo 2025-10-14T18:41:33.752Z,1760467293.752 [RudderServo] No Fault, FailCount= 2 2025-10-14T18:41:35.738Z,1760467295.738 [DAT](INFO): entering command mode 2025-10-14T18:41:35.938Z,1760467295.938 [DAT](INFO): DAT read: 2025-10-14T18:41:35.939Z,1760467295.939 [DAT](INFO): DAT read: user:1> 2025-10-14T18:41:35.939Z,1760467295.939 [DAT](INFO): setting verbose to 3 2025-10-14T18:41:36.190Z,1760467296.190 [DAT](INFO): DAT read: user:1> 2025-10-14T18:41:36.191Z,1760467296.191 [DAT](INFO): DAT read: Verbose | 3 2025-10-14T18:41:36.191Z,1760467296.191 [DAT](INFO): set verbose to 3 2025-10-14T18:41:36.192Z,1760467296.192 [DAT](INFO): setting DatVerbose to 27440 2025-10-14T18:41:36.442Z,1760467296.442 [DAT](INFO): DAT read: user:2> 2025-10-14T18:41:36.443Z,1760467296.443 [DAT](INFO): DAT read: DatVerbose | 27440 2025-10-14T18:41:36.444Z,1760467296.444 [DAT](INFO): set DatVerbose to 27440 2025-10-14T18:41:36.444Z,1760467296.444 [DAT](INFO): setting transmit power to 8 2025-10-14T18:41:36.694Z,1760467296.694 [DAT](INFO): DAT read: user:3> 2025-10-14T18:41:36.695Z,1760467296.695 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-10-14T18:41:36.695Z,1760467296.695 [DAT](INFO): set transmit power to 8 2025-10-14T18:41:36.695Z,1760467296.695 [DAT](INFO): setting local address to 3 2025-10-14T18:41:36.948Z,1760467296.948 [DAT](INFO): DAT read: user:4> 2025-10-14T18:41:36.951Z,1760467296.951 [DAT](INFO): DAT read: LocalAddr | 3 2025-10-14T18:41:36.952Z,1760467296.952 [DAT](INFO): set local address to 3 2025-10-14T18:41:36.956Z,1760467296.956 [DAT](INFO): Setting time to: 18:41:36 And date to:10/14/2025 2025-10-14T18:41:37.198Z,1760467297.198 [DAT](INFO): DAT read: user:5> 2025-10-14T18:41:37.199Z,1760467297.199 [DAT](INFO): DAT read: Tue Oct 14, 2025 18:41:36 2025-10-14T18:41:37.199Z,1760467297.199 [DAT](INFO): Local DAT time set to Tue Oct 14, 2025 18:41:36 2025-10-14T18:41:39.370Z,1760467299.370 [RudderServo](FAULT): Overload Error 2025-10-14T18:41:39.370Z,1760467299.370 [RudderServo] Hardware Fault, FailCount= 3 2025-10-14T18:41:39.370Z,1760467299.370 [RudderServo](ERROR): Hardware Fault 2025-10-14T18:41:39.482Z,1760467299.482 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-10-14T18:41:39.482Z,1760467299.482 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2025-10-14T18:41:39.578Z,1760467299.578 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-10-14T18:41:39.578Z,1760467299.578 [RudderServo](INFO): Powering down 2025-10-14T18:41:39.581Z,1760467299.581 [CBIT](INFO): Critical error at 20251014T184139 2025-10-14T18:41:40.358Z,1760467300.358 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:41:40.479Z,1760467300.479 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:41:47.593Z,1760467307.593 [NAL9602](INFO): Powering up NAL9602 2025-10-14T18:41:58.515Z,1760467318.515 [NAL9602](INFO): NAL9602 initialized 2025-10-14T18:42:35.279Z,1760467355.279 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00071120041535,35.0, +0.0,1526.9, 0 2025-10-14T18:42:37.279Z,1760467357.279 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-10-14T18:42:53.442Z,1760467373.442 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-10-14T18:42:55.502Z,1760467375.502 [SBIT](IMPORTANT): Beginning Startup BIT 2025-10-14T18:42:55.509Z,1760467375.509 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-10-14T18:42:57.261Z,1760467377.261 [ElevatorServo](FAULT): Overload Error 2025-10-14T18:42:57.261Z,1760467377.261 [ElevatorServo] Hardware Fault, FailCount= 1 2025-10-14T18:42:57.261Z,1760467377.261 [ElevatorServo](ERROR): Hardware Fault 2025-10-14T18:42:57.372Z,1760467377.372 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-10-14T18:42:57.513Z,1760467377.513 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-10-14T18:42:57.513Z,1760467377.513 [ElevatorServo](INFO): Powering down 2025-10-14T18:42:58.338Z,1760467378.338 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:42:58.458Z,1760467378.458 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:42:58.493Z,1760467378.493 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-10-14T18:42:58.493Z,1760467378.493 [ElevatorServo] No Fault, FailCount= 1 2025-10-14T18:43:00.011Z,1760467380.011 [GFScanner](IMPORTANT): Low side ground fault detected mA: CHAN A0 (Batt): 0.943311 CHAN A1 (24V): 0.880895 CHAN A2 (12V): 0.969288 CHAN A3 (5V): 0.036176 CHAN B0 (3.3V): -0.409885 CHAN B1 (3.15aV): -0.775673 CHAN B2 (3.15bV): -0.782763 CHAN B3 (GND): -0.895801 OPEN: -0.012221 Full Scale: +/- 1 mA 2025-10-14T18:43:03.345Z,1760467383.345 [ElevatorServo](FAULT): Overload Error 2025-10-14T18:43:03.345Z,1760467383.345 [ElevatorServo] Hardware Fault, FailCount= 2 2025-10-14T18:43:03.345Z,1760467383.345 [ElevatorServo](ERROR): Hardware Fault 2025-10-14T18:43:03.467Z,1760467383.467 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-10-14T18:43:03.604Z,1760467383.604 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-10-14T18:43:03.604Z,1760467383.604 [ElevatorServo](INFO): Powering down 2025-10-14T18:43:04.387Z,1760467384.387 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:43:04.507Z,1760467384.507 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:43:04.513Z,1760467384.513 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-10-14T18:43:04.513Z,1760467384.513 [ElevatorServo] No Fault, FailCount= 2 2025-10-14T18:43:08.847Z,1760467388.847 [SBIT](ERROR): Could not read rudderAngleReader_. 2025-10-14T18:43:09.665Z,1760467389.665 [ElevatorServo](FAULT): Overload Error 2025-10-14T18:43:09.666Z,1760467389.666 [ElevatorServo] Hardware Fault, FailCount= 3 2025-10-14T18:43:09.666Z,1760467389.666 [ElevatorServo](ERROR): Hardware Fault 2025-10-14T18:43:09.782Z,1760467389.782 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-10-14T18:43:09.783Z,1760467389.783 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2025-10-14T18:43:10.038Z,1760467390.038 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-10-14T18:43:10.038Z,1760467390.038 [ElevatorServo](INFO): Powering down 2025-10-14T18:43:10.041Z,1760467390.041 [CBIT](INFO): Critical error at 20251014T184309 2025-10-14T18:43:10.857Z,1760467390.857 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:43:10.980Z,1760467390.980 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:43:15.313Z,1760467395.313 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2025-10-14T18:43:15.313Z,1760467395.313 [RDI_Pathfinder] Communications Fault, FailCount= 1 2025-10-14T18:43:15.313Z,1760467395.313 [RDI_Pathfinder](ERROR): Communications Fault 2025-10-14T18:43:15.363Z,1760467395.363 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2025-10-14T18:43:15.758Z,1760467395.758 [RDI_Pathfinder](INFO): Powering down 2025-10-14T18:43:16.522Z,1760467396.522 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2025-10-14T18:43:16.522Z,1760467396.522 [RDI_Pathfinder] No Fault, FailCount= 1 2025-10-14T18:43:16.876Z,1760467396.876 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2025-10-14T18:43:31.820Z,1760467411.820 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004733 2025-10-14T18:43:35.556Z,1760467415.556 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-10-14T18:43:35.556Z,1760467415.556 [SBIT](ERROR): Could not read rudderAngleReader_. 2025-10-14T18:43:35.556Z,1760467415.556 [SBIT](FAULT): Control surface position failure. 2025-10-14T18:43:39.191Z,1760467419.191 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-10-14T18:43:49.251Z,1760467429.251 [SBIT](ERROR): Could not read elevatorAngleReader_. 2025-10-14T18:43:49.251Z,1760467429.251 [SBIT](ERROR): Could not read rudderAngleReader_. 2025-10-14T18:43:49.251Z,1760467429.251 [SBIT](FAULT): Control surface position failure. 2025-10-14T18:43:49.630Z,1760467429.630 [SBIT](CRITICAL): SBIT FAILED 2025-10-14T18:43:49.630Z,1760467429.630 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-10-14T18:43:49.631Z,1760467429.631 [SBIT](IMPORTANT): 2025-10-14T18:43:49.631Z,1760467429.631 [SBIT](IMPORTANT): BPC1.loadAtStartup=1 bool; 2025-10-14T18:43:49.631Z,1760467429.631 [SBIT](IMPORTANT): BuoyancyServo.limitLo=2800 count; 2025-10-14T18:43:49.631Z,1760467429.631 [SBIT](IMPORTANT): CBIT.abortDepth=1480 meter; 2025-10-14T18:43:49.632Z,1760467429.632 [SBIT](IMPORTANT): CBIT.stopDepth=1400 meter; 2025-10-14T18:43:49.632Z,1760467429.632 [SBIT](IMPORTANT): Express linearApproximation Onboard.Temperature 1.000000 degree; 2025-10-14T18:43:49.632Z,1760467429.632 [SBIT](IMPORTANT): Express linearApproximation platform_buoyancy_position 100.000000 cubic_centimeter; 2025-10-14T18:43:49.632Z,1760467429.632 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=1275 cubic_centimeter; 2025-10-14T18:43:49.632Z,1760467429.632 [SBIT](IMPORTANT): VerticalControl.dropWtOverrideDelay=20 minute; 2025-10-14T18:43:49.632Z,1760467429.632 [SBIT](IMPORTANT): VerticalControl.massDefault=-18.753875 millimeter; 2025-10-14T18:43:49.634Z,1760467429.634 [CBIT](INFO): Critical error at 20251014T184349 2025-10-14T18:43:50.038Z,1760467430.038 [MissionManager](IMPORTANT): Started mission Startup 2025-10-14T18:43:50.038Z,1760467430.038 [Startup] Running Loop=1 2025-10-14T18:43:50.038Z,1760467430.038 [Startup](DEBUG): Aggregate::initialize Startup 2025-10-14T18:43:50.038Z,1760467430.038 [Startup:A.GoToSurface] Running Loop=1 2025-10-14T18:43:50.038Z,1760467430.038 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-10-14T18:43:50.039Z,1760467430.039 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-10-14T18:43:50.039Z,1760467430.039 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-10-14T18:43:50.040Z,1760467430.040 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-10-14T18:43:50.040Z,1760467430.040 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-10-14T18:43:50.040Z,1760467430.040 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-10-14T18:43:50.041Z,1760467430.041 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-10-14T18:43:50.055Z,1760467430.055 [Startup:StartupSatComms] Running Loop=1 2025-10-14T18:43:50.055Z,1760467430.055 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-10-14T18:43:50.055Z,1760467430.055 [Startup:StartupSatComms:A] Running Loop=1 2025-10-14T18:43:50.458Z,1760467430.458 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-10-14T18:44:19.936Z,1760467459.936 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-10-14T18:44:19.936Z,1760467459.936 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-10-14T18:44:19.937Z,1760467459.937 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-10-14T18:44:19.937Z,1760467459.937 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-10-14T18:44:19.956Z,1760467459.956 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-10-14T18:44:19.956Z,1760467459.956 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-10-14T18:44:20.356Z,1760467460.356 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-10-14T18:44:20.356Z,1760467460.356 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-10-14T18:44:20.357Z,1760467460.357 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-10-14T18:44:20.357Z,1760467460.357 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-10-14T18:44:45.443Z,1760467485.443 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00071120062553,35.0, +2.0,1527.0, 0 2025-10-14T18:44:50.215Z,1760467490.215 [Startup:StartupSatComms:A](INFO): Timed out from 2025-10-14T18:43:50.1Z 2025-10-14T18:44:50.215Z,1760467490.215 [Startup:StartupSatComms:A] Stopped 2025-10-14T18:44:50.215Z,1760467490.215 [Startup:StartupSatComms:B] Running Loop=1 2025-10-14T18:44:50.622Z,1760467490.622 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-10-14T18:44:55.119Z,1760467495.119 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00071120063553,35.0, +22.1, 0.0,1527.0RA, 0.00, 0.00, 0.00, 0.00, 0.00 2025-10-14T18:44:58.706Z,1760467498.706 [DataOverHttps](INFO): Sending 89 bytes from file Logs/20251014T183448/Courier0004.lzma 2025-10-14T18:44:59.708Z,1760467499.708 [DataOverHttps](INFO): Moved sent file to Logs/20251014T183448/Courier0004.lzma.bak 2025-10-14T18:44:59.708Z,1760467499.708 [DataOverHttps](INFO): SBD MOMSN=26199976 2025-10-14T18:45:17.961Z,1760467517.961 [DataOverHttps](INFO): Sending 299 bytes from file Logs/20251014T184108/Courier0000.lzma 2025-10-14T18:45:18.963Z,1760467518.963 [DataOverHttps](INFO): Moved sent file to Logs/20251014T184108/Courier0000.lzma.bak 2025-10-14T18:45:18.964Z,1760467518.964 [DataOverHttps](INFO): SBD MOMSN=26199979 2025-10-14T18:45:39.029Z,1760467539.029 [DataOverHttps](INFO): Sending 562 bytes from file Logs/20251014T183448/Express0005.lzma 2025-10-14T18:45:40.021Z,1760467540.021 [DataOverHttps](INFO): Moved sent file to Logs/20251014T183448/Express0005.lzma.bak 2025-10-14T18:45:40.021Z,1760467540.021 [DataOverHttps](INFO): SBD MOMSN=26199987 2025-10-14T18:45:50.423Z,1760467550.423 [Startup:StartupSatComms:B](INFO): Timed out from 2025-10-14T18:44:50.2Z 2025-10-14T18:45:50.423Z,1760467550.423 [Startup:StartupSatComms:B] Stopped 2025-10-14T18:45:50.423Z,1760467550.423 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-10-14T18:45:50.424Z,1760467550.424 [Startup:StartupSatComms] Stopped 2025-10-14T18:45:50.424Z,1760467550.424 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-10-14T18:45:50.425Z,1760467550.425 [Startup](INFO): Completed Startup 2025-10-14T18:45:50.426Z,1760467550.426 [MissionManager](INFO): Startup is completed. 2025-10-14T18:45:50.426Z,1760467550.426 [MissionManager](INFO): Uninitializing Mission Startup 2025-10-14T18:45:50.426Z,1760467550.426 [Startup] Stopped 2025-10-14T18:45:50.426Z,1760467550.426 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-10-14T18:45:50.426Z,1760467550.426 [Startup:A.GoToSurface] Stopped 2025-10-14T18:45:50.427Z,1760467550.427 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-10-14T18:45:50.824Z,1760467550.824 [MissionManager](IMPORTANT): Started mission Default 2025-10-14T18:45:50.824Z,1760467550.824 [Default] Running Loop=1 2025-10-14T18:45:50.824Z,1760467550.824 [Default](DEBUG): Aggregate::initialize Default 2025-10-14T18:45:50.824Z,1760467550.824 [Default:B.GoToSurface] Running Loop=1 2025-10-14T18:45:50.824Z,1760467550.824 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-10-14T18:45:50.824Z,1760467550.824 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-10-14T18:45:50.825Z,1760467550.825 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-10-14T18:45:50.825Z,1760467550.825 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-10-14T18:45:50.825Z,1760467550.825 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-10-14T18:45:50.826Z,1760467550.826 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-10-14T18:45:50.826Z,1760467550.826 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-10-14T18:45:50.826Z,1760467550.826 [Default:A.Wait] Running Loop=1 2025-10-14T18:45:50.826Z,1760467550.826 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-10-14T18:45:56.574Z,1760467556.574 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-10-14T18:45:59.848Z,1760467559.848 [DataOverHttps](INFO): Sending 1227 bytes from file Logs/20251014T184108/Express0001.lzma 2025-10-14T18:46:00.847Z,1760467560.847 [DataOverHttps](INFO): Moved sent file to Logs/20251014T184108/Express0001.lzma.bak 2025-10-14T18:46:00.848Z,1760467560.848 [DataOverHttps](INFO): SBD MOMSN=26200013 2025-10-14T18:46:04.155Z,1760467564.155 [Default:A.Wait](INFO): Done Waiting. 2025-10-14T18:46:04.155Z,1760467564.155 [Default:A.Wait] Stopped 2025-10-14T18:46:04.155Z,1760467564.155 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-10-14T18:46:04.563Z,1760467564.563 [Default:CheckIn] Running Loop=1 2025-10-14T18:46:04.563Z,1760467564.563 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-10-14T18:46:04.564Z,1760467564.564 [Default:CheckIn:Read_GPS] Running Loop=1 2025-10-14T18:46:04.959Z,1760467564.959 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-10-14T18:46:09.446Z,1760467569.446 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-10-14T18:46:22.376Z,1760467582.376 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-10-14T18:47:01.906Z,1760467621.906 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-10-14T18:47:20.906Z,1760467640.906 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-10-14T18:47:20.906Z,1760467640.906 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-10-14T18:47:20.907Z,1760467640.907 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-10-14T18:47:20.907Z,1760467640.907 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-10-14T18:47:20.933Z,1760467640.933 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-10-14T18:47:20.937Z,1760467640.937 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-10-14T18:47:21.353Z,1760467641.353 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-10-14T18:47:21.353Z,1760467641.353 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-10-14T18:47:21.354Z,1760467641.354 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-10-14T18:47:21.354Z,1760467641.354 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-10-14T18:47:57.719Z,1760467677.719 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-10-14T18:48:08.627Z,1760467688.627 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-10-14T18:48:11.067Z,1760467691.067 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-10-14T18:48:24.342Z,1760467704.342 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5. 2025-10-14T18:48:24.345Z,1760467704.345 [BPC1](INFO): Received data from all battery sticks. 2025-10-14T18:48:37.939Z,1760467717.939 [CommandExec](IMPORTANT): got command failComponent 2025-10-14T18:48:37.939Z,1760467717.939 [CommandExec](IMPORTANT): Failed components: 2025-10-14T18:48:37.939Z,1760467717.939 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-10-14T18:48:37.939Z,1760467717.939 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2025-10-14T18:48:37.939Z,1760467717.939 [CommandExec](IMPORTANT): RudderServo: Hardware Fault 2025-10-14T18:50:21.927Z,1760467821.927 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-10-14T18:50:21.927Z,1760467821.927 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-10-14T18:50:21.929Z,1760467821.929 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2025-10-14T18:50:21.929Z,1760467821.929 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-10-14T18:50:21.939Z,1760467821.939 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-10-14T18:50:21.939Z,1760467821.939 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-10-14T18:50:22.337Z,1760467822.337 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-10-14T18:50:22.337Z,1760467822.337 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-10-14T18:50:22.337Z,1760467822.337 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-10-14T18:50:22.337Z,1760467822.337 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2025-10-14T18:51:04.719Z,1760467864.719 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-10-14T18:46:04.6Z 2025-10-14T18:51:04.719Z,1760467864.719 [Default:CheckIn:Read_GPS] Stopped 2025-10-14T18:51:04.719Z,1760467864.719 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-10-14T18:51:05.164Z,1760467865.164 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-10-14T18:51:08.209Z,1760467868.209 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20251014T184108/Courier0004.lzma 2025-10-14T18:51:09.215Z,1760467869.215 [DataOverHttps](INFO): Moved sent file to Logs/20251014T184108/Courier0004.lzma.bak 2025-10-14T18:51:09.215Z,1760467869.215 [DataOverHttps](INFO): SBD MOMSN=26200109 2025-10-14T18:51:29.426Z,1760467889.426 [DataOverHttps](INFO): Sending 360 bytes from file Logs/20251014T184108/Express0005.lzma 2025-10-14T18:51:30.427Z,1760467890.427 [DataOverHttps](INFO): Moved sent file to Logs/20251014T184108/Express0005.lzma.bak 2025-10-14T18:51:30.427Z,1760467890.427 [DataOverHttps](INFO): SBD MOMSN=26200115 2025-10-14T18:51:34.762Z,1760467894.762 [Default:CheckIn:Read_Iridium] Stopped 2025-10-14T18:51:34.762Z,1760467894.762 [Default:CheckIn:C.Wait] Running Loop=1 2025-10-14T18:51:34.762Z,1760467894.762 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-10-14T18:52:01.810Z,1760467921.810 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-10-14T18:52:01.810Z,1760467921.810 [NAL9602] Data Fault, FailCount= 1 2025-10-14T18:52:01.810Z,1760467921.810 [NAL9602](ERROR): Data Fault 2025-10-14T18:52:01.826Z,1760467921.826 [CBIT](ERROR): Data Fault in component: NAL9602 2025-10-14T18:52:02.213Z,1760467922.213 [NAL9602](INFO): Powering down 2025-10-14T18:52:03.074Z,1760467923.074 [CBIT](INFO): Clearing failed state for component NAL9602 2025-10-14T18:52:03.074Z,1760467923.074 [NAL9602] No Fault, FailCount= 1 2025-10-14T18:52:32.522Z,1760467952.522 [NAL9602](INFO): Powering up NAL9602 2025-10-14T18:52:43.325Z,1760467963.325 [NAL9602](INFO): NAL9602 initialized 2025-10-14T18:53:22.960Z,1760468002.960 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-10-14T18:53:22.960Z,1760468002.960 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-10-14T18:53:22.961Z,1760468002.961 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4 2025-10-14T18:53:22.961Z,1760468002.961 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-10-14T18:53:23.004Z,1760468003.004 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-10-14T18:53:23.004Z,1760468003.004 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-10-14T18:53:23.418Z,1760468003.418 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-10-14T18:53:23.418Z,1760468003.418 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-10-14T18:53:23.418Z,1760468003.418 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-10-14T18:53:23.418Z,1760468003.418 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4 2025-10-14T18:53:39.170Z,1760468019.170 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-8,-32768,V 2025-10-14T18:56:15.106Z,1760468175.106 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00071120175553,35., 0.0,1527.5, 0 2025-10-14T18:56:21.237Z,1760468181.237 [CBIT](INFO): Clearing failed state for component DropWeight 2025-10-14T18:56:21.238Z,1760468181.238 [DropWeight] No Fault, FailCount= 1 2025-10-14T18:56:23.938Z,1760468183.938 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-10-14T18:56:23.938Z,1760468183.938 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-10-14T18:56:23.941Z,1760468183.941 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5 2025-10-14T18:56:23.941Z,1760468183.941 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-10-14T18:56:23.987Z,1760468183.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-10-14T18:56:23.999Z,1760468183.999 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-10-14T18:56:24.362Z,1760468184.362 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-10-14T18:56:24.362Z,1760468184.362 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-10-14T18:56:24.362Z,1760468184.362 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-10-14T18:56:24.362Z,1760468184.362 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5 2025-10-14T18:56:29.286Z,1760468189.286 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, +13.01, -0.7515.35, 0.00,775.99 2025-10-14T18:56:35.291Z,1760468195.291 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-10-14T18:56:35.291Z,1760468195.291 [Default:CheckIn:C.Wait] Stopped 2025-10-14T18:56:35.291Z,1760468195.291 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-10-14T18:56:35.292Z,1760468195.292 [Default:CheckIn:D] Running Loop=1 2025-10-14T18:56:35.645Z,1760468195.645 [Default:CheckIn:D] Stopped 2025-10-14T18:56:35.645Z,1760468195.645 [Default:CheckIn:E] Running Loop=1 2025-10-14T18:56:36.066Z,1760468196.066 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.747010 min 2025-10-14T18:56:36.066Z,1760468196.066 [Default:CheckIn:E] Stopped 2025-10-14T18:56:36.067Z,1760468196.067 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-10-14T18:56:36.067Z,1760468196.067 [Default:CheckIn] Stopped 2025-10-14T18:56:36.068Z,1760468196.068 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-10-14T18:56:36.068Z,1760468196.068 [Default:CheckIn](INFO): Running loop #2 2025-10-14T18:56:36.068Z,1760468196.068 [Default:CheckIn] Running Loop=2 2025-10-14T18:56:36.068Z,1760468196.068 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-10-14T18:56:36.068Z,1760468196.068 [Default:CheckIn:Read_GPS] Running Loop=1 2025-10-14T18:56:39.378Z,1760468199.378 [CBIT](INFO): Clearing failed state for component RudderServo 2025-10-14T18:56:39.379Z,1760468199.379 [RudderServo] No Fault, FailCount= 3 2025-10-14T18:56:43.775Z,1760468203.775 [RudderServo](FAULT): Overload Error 2025-10-14T18:56:43.775Z,1760468203.775 [RudderServo] Hardware Fault, FailCount= 1 2025-10-14T18:56:43.775Z,1760468203.775 [RudderServo](ERROR): Hardware Fault 2025-10-14T18:56:43.891Z,1760468203.891 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-10-14T18:56:44.128Z,1760468204.128 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-10-14T18:56:44.128Z,1760468204.128 [RudderServo](INFO): Powering down 2025-10-14T18:56:44.953Z,1760468204.953 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:56:45.068Z,1760468205.068 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:56:45.072Z,1760468205.072 [CBIT](INFO): Clearing failed state for component RudderServo 2025-10-14T18:56:45.072Z,1760468205.072 [RudderServo] No Fault, FailCount= 1 2025-10-14T18:56:50.243Z,1760468210.243 [RudderServo](FAULT): Overload Error 2025-10-14T18:56:50.243Z,1760468210.243 [RudderServo] Hardware Fault, FailCount= 2 2025-10-14T18:56:50.243Z,1760468210.243 [RudderServo](ERROR): Hardware Fault 2025-10-14T18:56:50.360Z,1760468210.360 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-10-14T18:56:50.622Z,1760468210.622 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-10-14T18:56:50.622Z,1760468210.622 [RudderServo](INFO): Powering down 2025-10-14T18:56:51.425Z,1760468211.425 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:56:51.544Z,1760468211.544 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:56:51.548Z,1760468211.548 [CBIT](INFO): Clearing failed state for component RudderServo 2025-10-14T18:56:51.548Z,1760468211.548 [RudderServo] No Fault, FailCount= 2 2025-10-14T18:56:57.199Z,1760468217.199 [RudderServo](FAULT): Overload Error 2025-10-14T18:56:57.199Z,1760468217.199 [RudderServo] Hardware Fault, FailCount= 3 2025-10-14T18:56:57.199Z,1760468217.199 [RudderServo](ERROR): Hardware Fault 2025-10-14T18:56:57.312Z,1760468217.312 [CBIT](ERROR): Hardware Fault in component: RudderServo 2025-10-14T18:56:57.312Z,1760468217.312 [CBIT](CRITICAL): Hardware Fault in component: RudderServo 2025-10-14T18:56:57.462Z,1760468217.462 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-10-14T18:56:57.462Z,1760468217.462 [RudderServo](INFO): Powering down 2025-10-14T18:56:57.472Z,1760468217.472 [CBIT](INFO): Critical error at 20251014T185657 2025-10-14T18:56:58.274Z,1760468218.274 [RudderServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:56:58.388Z,1760468218.388 [RudderServo](DEBUG): Initializing RudderServo. 2025-10-14T18:57:51.198Z,1760468271.198 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00 2025-10-14T18:58:09.805Z,1760468289.805 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-10-14T18:58:09.805Z,1760468289.805 [ElevatorServo] No Fault, FailCount= 3 2025-10-14T18:58:14.299Z,1760468294.299 [ElevatorServo](FAULT): Overload Error 2025-10-14T18:58:14.299Z,1760468294.299 [ElevatorServo] Hardware Fault, FailCount= 1 2025-10-14T18:58:14.299Z,1760468294.299 [ElevatorServo](ERROR): Hardware Fault 2025-10-14T18:58:14.413Z,1760468294.413 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-10-14T18:58:14.675Z,1760468294.675 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-10-14T18:58:14.675Z,1760468294.675 [ElevatorServo](INFO): Powering down 2025-10-14T18:58:15.431Z,1760468295.431 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:58:15.548Z,1760468295.548 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:58:15.556Z,1760468295.556 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-10-14T18:58:15.557Z,1760468295.557 [ElevatorServo] No Fault, FailCount= 1 2025-10-14T18:58:20.743Z,1760468300.743 [ElevatorServo](FAULT): Overload Error 2025-10-14T18:58:20.743Z,1760468300.743 [ElevatorServo] Hardware Fault, FailCount= 2 2025-10-14T18:58:20.743Z,1760468300.743 [ElevatorServo](ERROR): Hardware Fault 2025-10-14T18:58:20.848Z,1760468300.848 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-10-14T18:58:21.112Z,1760468301.112 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, -0.96, -18.36, 64.00 2025-10-14T18:58:21.138Z,1760468301.138 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-10-14T18:58:21.139Z,1760468301.139 [ElevatorServo](INFO): Powering down 2025-10-14T18:58:21.914Z,1760468301.914 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:58:22.028Z,1760468302.028 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:58:22.032Z,1760468302.032 [CBIT](INFO): Clearing failed state for component ElevatorServo 2025-10-14T18:58:22.032Z,1760468302.032 [ElevatorServo] No Fault, FailCount= 2 2025-10-14T18:58:27.271Z,1760468307.271 [ElevatorServo](FAULT): Overload Error 2025-10-14T18:58:27.271Z,1760468307.271 [ElevatorServo] Hardware Fault, FailCount= 3 2025-10-14T18:58:27.271Z,1760468307.271 [ElevatorServo](ERROR): Hardware Fault 2025-10-14T18:58:27.385Z,1760468307.385 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2025-10-14T18:58:27.385Z,1760468307.385 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2025-10-14T18:58:27.576Z,1760468307.576 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-10-14T18:58:27.576Z,1760468307.576 [ElevatorServo](INFO): Powering down 2025-10-14T18:58:27.599Z,1760468307.599 [CBIT](INFO): Critical error at 20251014T185827 2025-10-14T18:58:28.359Z,1760468308.359 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-10-14T18:58:28.473Z,1760468308.473 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-10-14T18:59:24.972Z,1760468364.972 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2025-10-14T18:59:24.973Z,1760468364.973 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-10-14T18:59:24.974Z,1760468364.974 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6 2025-10-14T18:59:24.974Z,1760468364.974 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-10-14T18:59:24.987Z,1760468364.987 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-10-14T18:59:24.987Z,1760468364.987 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-10-14T18:59:25.400Z,1760468365.400 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-10-14T18:59:25.400Z,1760468365.400 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2025-10-14T18:59:25.401Z,1760468365.401 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-10-14T18:59:25.401Z,1760468365.401 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6 2025-10-14T19:00:34.984Z,1760468434.984 [CommandExec](IMPORTANT): got command restart system 2025-10-14T19:00:37.235Z,1760468437.235 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:37.236Z,1760468437.236 [CommandExec](INFO): Uninitializing the command executive. 2025-10-14T19:00:37.236Z,1760468437.236 [CommandExec](INFO): Uninitializing the command scheduler. 2025-10-14T19:00:37.236Z,1760468437.236 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:37.263Z,1760468437.263 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-10-14T19:00:37.263Z,1760468437.263 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-10-14T19:00:37.263Z,1760468437.263 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:37.264Z,1760468437.264 [NavChartDb](INFO): Join timeout helper Thread ID is 7792 2025-10-14T19:00:37.395Z,1760468437.395 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:37.395Z,1760468437.395 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:37.403Z,1760468437.403 [ComponentRegistry](INFO): Shutting down RBRTridente ThreadHandler 2025-10-14T19:00:37.403Z,1760468437.403 [RBRTridente ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:37.404Z,1760468437.404 [RBRTridente](INFO): Join timeout helper Thread ID is 7793 2025-10-14T19:00:37.420Z,1760468437.420 [RBRTridente ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:37.420Z,1760468437.420 [RBRTridente](INFO): Powering down 2025-10-14T19:00:37.422Z,1760468437.422 [RBRTridente ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:37.424Z,1760468437.424 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-10-14T19:00:37.424Z,1760468437.424 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:37.424Z,1760468437.424 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7794 2025-10-14T19:00:37.975Z,1760468437.975 [CTD_Seabird](INFO): Powering down 2025-10-14T19:00:37.987Z,1760468437.987 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:37.987Z,1760468437.987 [CTD_Seabird](INFO): Powering down 2025-10-14T19:00:37.999Z,1760468437.999 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:38.009Z,1760468438.009 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-10-14T19:00:38.010Z,1760468438.010 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:38.010Z,1760468438.010 [Radio_Surface](INFO): Join timeout helper Thread ID is 7795 2025-10-14T19:00:38.171Z,1760468438.171 [Radio_Surface](INFO): Powering down 2025-10-14T19:00:38.172Z,1760468438.172 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:38.172Z,1760468438.172 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:38.183Z,1760468438.183 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-10-14T19:00:38.184Z,1760468438.184 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:38.184Z,1760468438.184 [Onboard](INFO): Join timeout helper Thread ID is 7796 2025-10-14T19:00:41.080Z,1760468441.080 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:41.080Z,1760468441.080 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.097Z,1760468441.097 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-10-14T19:00:41.098Z,1760468441.098 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.098Z,1760468441.098 [DataOverHttps](INFO): Join timeout helper Thread ID is 7797 2025-10-14T19:00:41.556Z,1760468441.556 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:41.561Z,1760468441.561 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.583Z,1760468441.583 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-10-14T19:00:41.584Z,1760468441.584 [DAT ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.584Z,1760468441.584 [DAT](INFO): Join timeout helper Thread ID is 7798 2025-10-14T19:00:41.619Z,1760468441.619 [DAT](INFO): Powering down 2025-10-14T19:00:41.700Z,1760468441.700 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:41.700Z,1760468441.700 [DAT](INFO): Powering down 2025-10-14T19:00:41.701Z,1760468441.701 [DAT ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.704Z,1760468441.704 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-10-14T19:00:41.704Z,1760468441.704 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.704Z,1760468441.704 [BackseatComponent](INFO): Join timeout helper Thread ID is 7799 2025-10-14T19:00:41.712Z,1760468441.712 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:41.713Z,1760468441.713 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.716Z,1760468441.716 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-10-14T19:00:41.716Z,1760468441.716 [logger ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.716Z,1760468441.716 [logger](INFO): Join timeout helper Thread ID is 7800 2025-10-14T19:00:41.748Z,1760468441.748 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:41.748Z,1760468441.748 [logger ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.756Z,1760468441.756 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-10-14T19:00:41.756Z,1760468441.756 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.756Z,1760468441.756 [CommandLine](INFO): Join timeout helper Thread ID is 7801 2025-10-14T19:00:41.780Z,1760468441.780 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:41.780Z,1760468441.780 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.784Z,1760468441.784 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-10-14T19:00:41.784Z,1760468441.784 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.784Z,1760468441.784 [CommandExec](INFO): Join timeout helper Thread ID is 7802 2025-10-14T19:00:41.796Z,1760468441.796 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-10-14T19:00:41.796Z,1760468441.796 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-10-14T19:00:41.797Z,1760468441.797 [controlThread](INFO): Join timeout helper Thread ID is 7803 2025-10-14T19:00:42.059Z,1760468442.059 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-10-14T19:00:42.059Z,1760468442.059 [controlThread](DEBUG): Uninitializing ControlThread 2025-10-14T19:00:42.060Z,1760468442.060 [AHRS_M2](INFO): Powering down 2025-10-14T19:00:42.132Z,1760468442.132 [DepthKeller33X](INFO): Powering down 2025-10-14T19:00:42.228Z,1760468442.228 [NAL9602](INFO): Powering down 2025-10-14T19:00:42.299Z,1760468442.299 [RDI_Pathfinder](INFO): Powering down 2025-10-14T19:00:42.300Z,1760468442.300 [Sonardyne_Nano](INFO): Powering down 2025-10-14T19:00:42.419Z,1760468442.419 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-10-14T19:00:42.420Z,1760468442.420 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-10-14T19:00:42.421Z,1760468442.421 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-10-14T19:00:42.421Z,1760468442.421 [MissionManager](INFO): Uninitializing Mission Default 2025-10-14T19:00:42.421Z,1760468442.421 [Default] Stopped 2025-10-14T19:00:42.422Z,1760468442.422 [Default](DEBUG): Aggregate::uninitialize Default 2025-10-14T19:00:42.422Z,1760468442.422 [Default:B.GoToSurface] Stopped 2025-10-14T19:00:42.422Z,1760468442.422 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-10-14T19:00:42.422Z,1760468442.422 [Default:CheckIn] Stopped 2025-10-14T19:00:42.422Z,1760468442.422 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-10-14T19:00:42.422Z,1760468442.422 [Default:CheckIn:Read_GPS] Stopped 2025-10-14T19:00:42.426Z,1760468442.426 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-10-14T19:00: