2025-08-13T23:31:20.876Z,1755127880.876 [Supervisor](DEBUG): Initializing supervisor.
2025-08-13T23:31:20.880Z,1755127880.880 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-08-13T23:31:20.881Z,1755127880.881 [SyncHandler](INFO): Protected caller Thread ID is 1224
2025-08-13T23:31:20.881Z,1755127880.881 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-08-13T23:31:20.882Z,1755127880.882 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-08-13T23:31:20.883Z,1755127880.883 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1225
2025-08-13T23:31:20.887Z,1755127880.887 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-08-13T23:31:20.907Z,1755127880.907 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-08-13T23:31:20.908Z,1755127880.908 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-08-13T23:31:20.908Z,1755127880.908 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1226
2025-08-13T23:31:20.912Z,1755127880.912 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-08-13T23:31:20.913Z,1755127880.913 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-08-13T23:31:20.914Z,1755127880.914 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1227
2025-08-13T23:31:20.916Z,1755127880.916 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-08-13T23:31:20.917Z,1755127880.917 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-08-13T23:31:20.917Z,1755127880.917 [logger ThreadHandler](INFO): Protected caller Thread ID is 1228
2025-08-13T23:31:20.921Z,1755127880.921 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-08-13T23:31:20.921Z,1755127880.921 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-08-13T23:31:20.923Z,1755127880.923 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-08-13T23:31:21.049Z,1755127881.049 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-08-13T23:31:21.050Z,1755127881.050 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-08-13T23:31:21.283Z,1755127881.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-08-13T23:31:21.283Z,1755127881.283 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-08-13T23:31:21.554Z,1755127881.554 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-08-13T23:31:21.555Z,1755127881.555 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-08-13T23:31:21.673Z,1755127881.673 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-08-13T23:31:21.674Z,1755127881.674 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-08-13T23:31:22.437Z,1755127882.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-08-13T23:31:22.437Z,1755127882.437 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-08-13T23:31:22.959Z,1755127882.959 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-08-13T23:31:22.960Z,1755127882.960 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-08-13T23:31:23.598Z,1755127883.598 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-08-13T23:31:23.599Z,1755127883.599 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-08-13T23:31:24.233Z,1755127884.233 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-08-13T23:31:24.234Z,1755127884.234 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-08-13T23:31:24.597Z,1755127884.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-08-13T23:31:24.598Z,1755127884.598 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-08-13T23:31:25.064Z,1755127885.064 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-08-13T23:31:25.065Z,1755127885.065 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-08-13T23:31:25.301Z,1755127885.301 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-08-13T23:31:25.302Z,1755127885.302 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-08-13T23:31:25.455Z,1755127885.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-08-13T23:31:25.456Z,1755127885.456 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-08-13T23:31:25.560Z,1755127885.560 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-08-13T23:31:25.561Z,1755127885.561 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-08-13T23:31:25.653Z,1755127885.653 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-08-13T23:31:25.850Z,1755127885.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-08-13T23:31:25.850Z,1755127885.850 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-08-13T23:31:26.110Z,1755127886.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-08-13T23:31:26.112Z,1755127886.112 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2025-08-13T23:31:26.113Z,1755127886.113 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2025-08-13T23:31:26.208Z,1755127886.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2025-08-13T23:31:26.486Z,1755127886.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-08-13T23:31:26.487Z,1755127886.487 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2025-08-13T23:31:26.584Z,1755127886.584 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2025-08-13T23:31:26.766Z,1755127886.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2025-08-13T23:31:26.878Z,1755127886.878 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2025-08-13T23:31:27.001Z,1755127887.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2025-08-13T23:31:27.126Z,1755127887.126 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2025-08-13T23:31:27.233Z,1755127887.233 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2025-08-13T23:31:27.407Z,1755127887.407 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2025-08-13T23:31:27.516Z,1755127887.516 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg
2025-08-13T23:31:27.613Z,1755127887.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2025-08-13T23:31:27.723Z,1755127887.723 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2025-08-13T23:31:27.823Z,1755127887.823 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2025-08-13T23:31:27.824Z,1755127887.824 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-08-13T23:31:27.831Z,1755127887.831 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-08-13T23:31:28.019Z,1755127888.019 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-08-13T23:31:28.019Z,1755127888.019 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-08-13T23:31:28.185Z,1755127888.185 [BuoyancyServo] Loaded
2025-08-13T23:31:28.185Z,1755127888.185 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-08-13T23:31:28.209Z,1755127888.209 [ElevatorServo] Loaded
2025-08-13T23:31:28.209Z,1755127888.209 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-08-13T23:31:28.232Z,1755127888.232 [MassServo] Loaded
2025-08-13T23:31:28.233Z,1755127888.233 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-08-13T23:31:28.255Z,1755127888.255 [RudderServo] Loaded
2025-08-13T23:31:28.255Z,1755127888.255 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-08-13T23:31:28.273Z,1755127888.273 [ThrusterHE] Loaded
2025-08-13T23:31:28.273Z,1755127888.273 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-08-13T23:31:28.274Z,1755127888.274 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-08-13T23:31:28.274Z,1755127888.274 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-08-13T23:31:28.445Z,1755127888.445 [SBIT](DEBUG): Construct Startup Built In Test.
2025-08-13T23:31:28.460Z,1755127888.460 [SBIT] Loaded
2025-08-13T23:31:28.460Z,1755127888.460 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-08-13T23:31:28.463Z,1755127888.463 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-08-13T23:31:28.484Z,1755127888.484 [IBIT] Loaded
2025-08-13T23:31:28.485Z,1755127888.485 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-08-13T23:31:28.490Z,1755127888.490 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-08-13T23:31:28.686Z,1755127888.686 [CBIT] Loaded
2025-08-13T23:31:28.686Z,1755127888.686 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-08-13T23:31:28.717Z,1755127888.717 [GFScanner] Loaded
2025-08-13T23:31:28.717Z,1755127888.717 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-08-13T23:31:28.717Z,1755127888.717 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-08-13T23:31:28.718Z,1755127888.718 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-08-13T23:31:29.265Z,1755127889.265 [CTD_Seabird] Loaded
2025-08-13T23:31:29.265Z,1755127889.265 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-08-13T23:31:29.266Z,1755127889.266 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406864E0
2025-08-13T23:31:29.267Z,1755127889.267 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1316
2025-08-13T23:31:29.416Z,1755127889.416 [ESPComponent] Loaded
2025-08-13T23:31:29.416Z,1755127889.416 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-08-13T23:31:29.446Z,1755127889.446 [PAR_Licor] Loaded
2025-08-13T23:31:29.446Z,1755127889.446 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-08-13T23:31:29.514Z,1755127889.514 [WetLabsBB2FL] Loaded
2025-08-13T23:31:29.514Z,1755127889.514 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-08-13T23:31:29.515Z,1755127889.515 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B64E0
2025-08-13T23:31:29.515Z,1755127889.515 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1317
2025-08-13T23:31:29.516Z,1755127889.516 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-08-13T23:31:29.517Z,1755127889.517 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-08-13T23:31:29.658Z,1755127889.658 [DepthRateCalculator] Loaded
2025-08-13T23:31:29.658Z,1755127889.658 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-08-13T23:31:29.663Z,1755127889.663 [PitchRateCalculator] Loaded
2025-08-13T23:31:29.664Z,1755127889.664 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-08-13T23:31:29.674Z,1755127889.674 [SpeedCalculator] Loaded
2025-08-13T23:31:29.674Z,1755127889.674 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-08-13T23:31:29.679Z,1755127889.679 [YawRateCalculator] Loaded
2025-08-13T23:31:29.679Z,1755127889.679 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-08-13T23:31:29.699Z,1755127889.699 [ElevatorOffsetCalculator] Loaded
2025-08-13T23:31:29.699Z,1755127889.699 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-08-13T23:31:29.700Z,1755127889.700 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-08-13T23:31:29.700Z,1755127889.700 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-08-13T23:31:30.114Z,1755127890.114 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-08-13T23:31:30.114Z,1755127890.114 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-08-13T23:31:30.220Z,1755127890.220 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-08-13T23:31:30.221Z,1755127890.221 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-08-13T23:31:30.552Z,1755127890.552 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-08-13T23:31:30.553Z,1755127890.553 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-08-13T23:31:30.567Z,1755127890.567 [NavChart] Loaded
2025-08-13T23:31:30.567Z,1755127890.567 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-08-13T23:31:30.573Z,1755127890.573 [UniversalFixResidualReporter] Loaded
2025-08-13T23:31:30.573Z,1755127890.573 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-08-13T23:31:30.573Z,1755127890.573 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-08-13T23:31:30.574Z,1755127890.574 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-08-13T23:31:32.290Z,1755127892.290 [AHRS_M2] Loaded
2025-08-13T23:31:32.290Z,1755127892.290 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-08-13T23:31:32.372Z,1755127892.372 [BackseatComponent] Loaded
2025-08-13T23:31:32.373Z,1755127892.373 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-08-13T23:31:32.374Z,1755127892.374 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0
2025-08-13T23:31:32.374Z,1755127892.374 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1318
2025-08-13T23:31:32.377Z,1755127892.377 [LcmUniversalReporter] Loaded
2025-08-13T23:31:32.377Z,1755127892.377 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-08-13T23:31:33.129Z,1755127893.129 [BPC1] Loaded
2025-08-13T23:31:33.129Z,1755127893.129 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-08-13T23:31:33.231Z,1755127893.231 [DAT] Loaded
2025-08-13T23:31:33.232Z,1755127893.232 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-08-13T23:31:33.233Z,1755127893.233 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB24E0
2025-08-13T23:31:33.233Z,1755127893.233 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1319
2025-08-13T23:31:33.306Z,1755127893.306 [DataOverHttps] Loaded
2025-08-13T23:31:33.307Z,1755127893.307 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-08-13T23:31:33.308Z,1755127893.308 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0
2025-08-13T23:31:33.308Z,1755127893.308 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1320
2025-08-13T23:31:33.332Z,1755127893.332 [Depth_Keller] Loaded
2025-08-13T23:31:33.332Z,1755127893.332 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-08-13T23:31:33.337Z,1755127893.337 [DropWeight] Loaded
2025-08-13T23:31:33.338Z,1755127893.338 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-08-13T23:31:33.379Z,1755127893.379 [DVL_micro] Loaded
2025-08-13T23:31:33.380Z,1755127893.380 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2025-08-13T23:31:33.443Z,1755127893.443 [NAL9602] Loaded
2025-08-13T23:31:33.443Z,1755127893.443 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-08-13T23:31:33.470Z,1755127893.470 [Onboard] Loaded
2025-08-13T23:31:33.470Z,1755127893.470 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-08-13T23:31:33.471Z,1755127893.471 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B124E0
2025-08-13T23:31:33.472Z,1755127893.472 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1321
2025-08-13T23:31:33.478Z,1755127893.478 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1
2025-08-13T23:31:33.492Z,1755127893.492 [PowerOnly] Loaded
2025-08-13T23:31:33.492Z,1755127893.492 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2025-08-13T23:31:33.507Z,1755127893.507 [Power24vConverter] Loaded
2025-08-13T23:31:33.507Z,1755127893.507 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-08-13T23:31:33.523Z,1755127893.523 [Radio_Surface] Loaded
2025-08-13T23:31:33.524Z,1755127893.524 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-08-13T23:31:33.525Z,1755127893.525 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B424E0
2025-08-13T23:31:33.525Z,1755127893.525 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1322
2025-08-13T23:31:33.541Z,1755127893.541 [Sonardyne_Nano] Loaded
2025-08-13T23:31:33.541Z,1755127893.541 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-08-13T23:31:33.542Z,1755127893.542 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-08-13T23:31:33.542Z,1755127893.542 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-08-13T23:31:33.605Z,1755127893.605 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-08-13T23:31:33.605Z,1755127893.605 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-08-13T23:31:33.660Z,1755127893.660 [VerticalControl](DEBUG): Construct VerticalControl.
2025-08-13T23:31:33.713Z,1755127893.713 [VerticalControl] Loaded
2025-08-13T23:31:33.713Z,1755127893.713 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-08-13T23:31:33.716Z,1755127893.716 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-08-13T23:31:33.760Z,1755127893.760 [HorizontalControl] Loaded
2025-08-13T23:31:33.761Z,1755127893.761 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-08-13T23:31:33.763Z,1755127893.763 [SpeedControl](DEBUG): Construct SpeedControl.
2025-08-13T23:31:33.765Z,1755127893.765 [SpeedControl] Loaded
2025-08-13T23:31:33.765Z,1755127893.765 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-08-13T23:31:33.768Z,1755127893.768 [LoopControl](DEBUG): Construct LoopControl.
2025-08-13T23:31:33.768Z,1755127893.768 [LoopControl] Loaded
2025-08-13T23:31:33.769Z,1755127893.769 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-08-13T23:31:33.769Z,1755127893.769 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-08-13T23:31:33.770Z,1755127893.770 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-08-13T23:31:33.780Z,1755127893.780 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-08-13T23:31:33.781Z,1755127893.781 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-08-13T23:31:34.145Z,1755127894.145 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-08-13T23:31:34.152Z,1755127894.152 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-08-13T23:31:34.155Z,1755127894.155 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-08-13T23:31:34.166Z,1755127894.166 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-08-13T23:31:34.167Z,1755127894.167 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0
2025-08-13T23:31:34.168Z,1755127894.168 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1323
2025-08-13T23:31:34.172Z,1755127894.172 [Supervisor](INFO): Main Thread ID is 8718
2025-08-13T23:31:34.172Z,1755127894.172 [Supervisor](DEBUG): Running supervisor.
2025-08-13T23:31:34.173Z,1755127894.173 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1324
2025-08-13T23:31:34.173Z,1755127894.173 [CommandExec](INFO): Initializing the command executive.
2025-08-13T23:31:34.175Z,1755127894.175 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1325
2025-08-13T23:31:34.178Z,1755127894.178 [controlThread ThreadHandler](INFO): Handler Thread ID is 1326
2025-08-13T23:31:34.179Z,1755127894.179 [controlThread](DEBUG): Initializing ControlThread
2025-08-13T23:31:34.181Z,1755127894.181 [SBIT](INFO): Initialize SBIT Component.
2025-08-13T23:31:34.181Z,1755127894.181 [SBIT](IMPORTANT): git: 2025-05-29
2025-08-13T23:31:34.181Z,1755127894.181 [SBIT](INFO): git hash: c78c975c7bb2a66b27244d2837f68dff299fa024
2025-08-13T23:31:34.182Z,1755127894.182 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-08-13T23:31:34.183Z,1755127894.183 [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-08-13T23:31:34.184Z,1755127894.184 [SBIT](INFO): Beginning SBIT in 147.000000 seconds.
2025-08-13T23:31:34.185Z,1755127894.185 [IBIT](INFO): Initialize IBIT Component.
2025-08-13T23:31:34.186Z,1755127894.186 [CBIT](DEBUG): Initialize CBIT Component.
2025-08-13T23:31:34.187Z,1755127894.187 [logger ThreadHandler](INFO): Handler Thread ID is 1327
2025-08-13T23:31:34.200Z,1755127894.200 [CBIT](DEBUG): Initialized mux pins.
2025-08-13T23:31:34.200Z,1755127894.200 [CBIT](DEBUG): Initializing the watchdog timer.
2025-08-13T23:31:34.212Z,1755127894.212 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1328
2025-08-13T23:31:34.213Z,1755127894.213 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-08-13T23:31:34.217Z,1755127894.217 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1330
2025-08-13T23:31:34.220Z,1755127894.220 [WetLabsBB2FL](INFO): Powering up
2025-08-13T23:31:34.222Z,1755127894.222 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1332
2025-08-13T23:31:34.224Z,1755127894.224 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-08-13T23:31:34.224Z,1755127894.224 [CBIT](DEBUG): Initializing heartbeat.
2025-08-13T23:31:34.238Z,1755127894.238 [DAT ThreadHandler](INFO): Handler Thread ID is 1333
2025-08-13T23:31:34.239Z,1755127894.239 [DAT](INFO): Powering up
2025-08-13T23:31:34.239Z,1755127894.239 [DAT](DEBUG): Initializing DAT.
2025-08-13T23:31:34.248Z,1755127894.248 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1335
2025-08-13T23:31:34.250Z,1755127894.250 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-08-13T23:31:34.260Z,1755127894.260 [Onboard ThreadHandler](INFO): Handler Thread ID is 1336
2025-08-13T23:31:34.278Z,1755127894.278 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1337
2025-08-13T23:31:34.293Z,1755127894.293 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1338
2025-08-13T23:31:34.295Z,1755127894.295 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-08-13T23:31:34.295Z,1755127894.295 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-08-13T23:31:34.296Z,1755127894.296 [CBIT](DEBUG): Deactivating emergency mode.
2025-08-13T23:31:34.296Z,1755127894.296 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-08-13T23:31:34.296Z,1755127894.296 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-08-13T23:31:34.296Z,1755127894.296 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-08-13T23:31:34.296Z,1755127894.296 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-08-13T23:31:34.297Z,1755127894.297 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-08-13T23:31:34.297Z,1755127894.297 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-08-13T23:31:34.336Z,1755127894.336 [CBIT](DEBUG): Backplane powered.
2025-08-13T23:31:34.336Z,1755127894.336 [GFScanner](DEBUG): Initializing GFScanner
2025-08-13T23:31:34.336Z,1755127894.336 [GFScanner](DEBUG): Deactivating GF circuits.
2025-08-13T23:31:34.344Z,1755127894.344 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-08-13T23:31:34.345Z,1755127894.345 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-08-13T23:31:34.345Z,1755127894.345 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-08-13T23:31:34.345Z,1755127894.345 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-08-13T23:31:34.346Z,1755127894.346 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-08-13T23:31:34.347Z,1755127894.347 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-08-13T23:31:34.347Z,1755127894.347 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-08-13T23:31:34.351Z,1755127894.351 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-08-13T23:31:34.361Z,1755127894.361 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-08-13T23:31:34.361Z,1755127894.361 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-08-13T23:31:34.362Z,1755127894.362 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-08-13T23:31:34.362Z,1755127894.362 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-08-13T23:31:34.363Z,1755127894.363 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-08-13T23:31:34.363Z,1755127894.363 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-08-13T23:31:34.373Z,1755127894.373 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-08-13T23:31:34.458Z,1755127894.458 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-08-13T23:31:34.463Z,1755127894.463 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-13T23:31:34.504Z,1755127894.504 [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-08-13T23:31:34.505Z,1755127894.505 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-08-13T23:31:34.505Z,1755127894.505 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-08-13T23:31:34.506Z,1755127894.506 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-08-13T23:31:34.692Z,1755127894.692 [Radio_Surface](INFO): Powering up
2025-08-13T23:31:34.952Z,1755127894.952 [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-08-13T23:31:34.958Z,1755127894.958 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-08-13T23:31:34.959Z,1755127894.959 [Default:A.Wait](DEBUG): Construct Wait.
2025-08-13T23:31:34.978Z,1755127894.978 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-13T23:31:35.011Z,1755127895.011 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-08-13T23:31:35.029Z,1755127895.029 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-08-13T23:31:35.035Z,1755127895.035 [Default:E.Execute](DEBUG): Construct Execute.
2025-08-13T23:31:35.054Z,1755127895.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 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-08-13T23:31:35.059Z,1755127895.059 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-08-13T23:31:35.070Z,1755127895.070 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-08-13T23:31:35.128Z,1755127895.128 [Depth_Keller](INFO): Initializing.
2025-08-13T23:31:35.138Z,1755127895.138 [PowerOnly](INFO): Powering up loadControl
2025-08-13T23:31:35.156Z,1755127895.156 [Power24vConverter](INFO): Powering up.
2025-08-13T23:31:35.157Z,1755127895.157 [Sonardyne_Nano](INFO): Initializing.
2025-08-13T23:31:35.184Z,1755127895.184 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-08-13T23:31:35.207Z,1755127895.207 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-08-13T23:31:35.213Z,1755127895.213 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-08-13T23:31:35.214Z,1755127895.214 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-08-13T23:31:35.220Z,1755127895.220 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-08-13T23:31:35.221Z,1755127895.221 [MassServo](DEBUG): Initializing EZServoServo.
2025-08-13T23:31:35.228Z,1755127895.228 [MassServo](DEBUG): Initializing MassServo.
2025-08-13T23:31:35.229Z,1755127895.229 [RudderServo](DEBUG): Initializing EZServoServo.
2025-08-13T23:31:35.236Z,1755127895.236 [RudderServo](DEBUG): Initializing RudderServo.
2025-08-13T23:31:35.237Z,1755127895.237 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-08-13T23:31:35.244Z,1755127895.244 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-08-13T23:31:35.522Z,1755127895.522 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-08-13T23:31:35.522Z,1755127895.522 [DropWeight] Hardware Fault, FailCount= 1
2025-08-13T23:31:35.522Z,1755127895.522 [DropWeight](ERROR): Hardware Fault
2025-08-13T23:31:35.550Z,1755127895.550 [CommandExec](FAULT): Scheduling is paused
2025-08-13T23:31:35.550Z,1755127895.550 [CBIT](INFO): Critical error at 20250813T233135
2025-08-13T23:31:35.550Z,1755127895.550 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-08-13T23:31:35.561Z,1755127895.561 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-08-13T23:31:35.561Z,1755127895.561 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-08-13T23:31:35.926Z,1755127895.926 [CBIT](INFO): Critical error at 20250813T233135
2025-08-13T23:31:36.832Z,1755127896.832 [WetLabsBB2FL](INFO): Powering down
2025-08-13T23:31:37.095Z,1755127897.095 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-08-13T23:31:38.737Z,1755127898.737 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2025-08-13T23:31:46.360Z,1755127906.360 [DAT](INFO): DAT read:
2025-08-13T23:31:46.362Z,1755127906.362 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-08-13T23:31:48.125Z,1755127908.125 [DAT](INFO): DAT read: MF Frequency Band
2025-08-13T23:31:48.126Z,1755127908.126 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2025-08-13T23:31:48.127Z,1755127908.127 [DAT](INFO): DAT read: Aug 13 2025 23:31:42
2025-08-13T23:31:49.385Z,1755127909.385 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-08-13T23:31:49.386Z,1755127909.386 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2025-08-13T23:31:49.386Z,1755127909.386 [DAT](INFO): commRate: 1200
2025-08-13T23:31:51.452Z,1755127911.452 [DAT](INFO): entering command mode
2025-08-13T23:31:51.652Z,1755127911.652 [DAT](INFO): DAT read:
2025-08-13T23:31:51.653Z,1755127911.653 [DAT](INFO): DAT read: user:1>
2025-08-13T23:31:51.653Z,1755127911.653 [DAT](INFO): setting verbose to 3
2025-08-13T23:31:51.905Z,1755127911.905 [DAT](INFO): DAT read: user:1>
2025-08-13T23:31:51.906Z,1755127911.906 [DAT](INFO): DAT read: Verbose | 3
2025-08-13T23:31:51.906Z,1755127911.906 [DAT](INFO): set verbose to 3
2025-08-13T23:31:51.906Z,1755127911.906 [DAT](INFO): setting DatVerbose to 27440
2025-08-13T23:31:52.157Z,1755127912.157 [DAT](INFO): DAT read: user:2>
2025-08-13T23:31:52.158Z,1755127912.158 [DAT](INFO): DAT read: DatVerbose | 27440
2025-08-13T23:31:52.158Z,1755127912.158 [DAT](INFO): set DatVerbose to 27440
2025-08-13T23:31:52.158Z,1755127912.158 [DAT](INFO): setting transmit power to 8
2025-08-13T23:31:52.409Z,1755127912.409 [DAT](INFO): DAT read: user:3>
2025-08-13T23:31:52.410Z,1755127912.410 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-08-13T23:31:52.410Z,1755127912.410 [DAT](INFO): set transmit power to 8
2025-08-13T23:31:52.410Z,1755127912.410 [DAT](INFO): setting local address to 5
2025-08-13T23:31:52.661Z,1755127912.661 [DAT](INFO): DAT read: user:4>
2025-08-13T23:31:52.662Z,1755127912.662 [DAT](INFO): DAT read: LocalAddr | 5
2025-08-13T23:31:52.662Z,1755127912.662 [DAT](INFO): set local address to 5
2025-08-13T23:31:52.663Z,1755127912.663 [DAT](INFO): Setting time to: 23:31:52 And date to:8/13/2025
2025-08-13T23:31:52.913Z,1755127912.913 [DAT](INFO): DAT read: user:5>
2025-08-13T23:31:52.914Z,1755127912.914 [DAT](INFO): DAT read: Wed Aug 13, 2025 23:31:52
2025-08-13T23:31:52.915Z,1755127912.915 [DAT](INFO): Local DAT time set to Wed Aug 13, 2025 23:31:52
2025-08-13T23:32:03.795Z,1755127923.795 [NAL9602](INFO): Powering up NAL9602
2025-08-13T23:32:14.678Z,1755127934.678 [NAL9602](INFO): NAL9602 initialized
2025-08-13T23:33:56.287Z,1755128036.287 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004286
2025-08-13T23:34:01.758Z,1755128041.758 [SBIT](IMPORTANT): Beginning Startup BIT
2025-08-13T23:34:01.764Z,1755128041.764 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:34:06.389Z,1755128046.389 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.019296
CHAN A1 (24V): 0.042977
CHAN A2 (12V): 0.007614
CHAN A3 (5V): -0.004696
CHAN B0 (3.3V): -0.005028
CHAN B1 (3.15aV): -0.004371
CHAN B2 (3.15bV): -0.004457
CHAN B3 (GND): -0.009037
OPEN: 0.007021
Full Scale: +/- 1 mA
2025-08-13T23:34:17.089Z,1755128057.089 [CommandExec](IMPORTANT): got command failComponent
2025-08-13T23:34:17.090Z,1755128057.090 [CommandExec](IMPORTANT): Failed components:
2025-08-13T23:34:17.090Z,1755128057.090 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2025-08-13T23:34:20.313Z,1755128060.313 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:34:20.590Z,1755128060.590 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:34:25.091Z,1755128065.091 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.017333
CHAN A1 (24V): 0.039009
CHAN A2 (12V): 0.006642
CHAN A3 (5V): -0.005183
CHAN B0 (3.3V): -0.006252
CHAN B1 (3.15aV): -0.005192
CHAN B2 (3.15bV): -0.004595
CHAN B3 (GND): -0.008912
OPEN: 0.006891
Full Scale: +/- 1 mA
2025-08-13T23:34:34.728Z,1755128074.728 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-08-13T23:34:34.728Z,1755128074.728 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-08-13T23:34:34.738Z,1755128074.738 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-08-13T23:34:35.217Z,1755128075.217 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-08-13T23:34:35.217Z,1755128075.217 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-08-13T23:34:55.114Z,1755128095.114 [SBIT](IMPORTANT): SBIT PASSED
2025-08-13T23:34:55.114Z,1755128095.114 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-08-13T23:34:55.115Z,1755128095.115 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;
2025-08-13T23:34:55.115Z,1755128095.115 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;
2025-08-13T23:34:55.117Z,1755128095.117 [SBIT](IMPORTANT): ElevatorServo.currLimit=20 percent;
2025-08-13T23:34:55.117Z,1755128095.117 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=1 bool;
2025-08-13T23:34:55.117Z,1755128095.117 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=264.941384 cubic_centimeter;
2025-08-13T23:34:55.118Z,1755128095.118 [SBIT](IMPORTANT): VerticalControl.massDefault=31.919755 millimeter;
2025-08-13T23:34:55.513Z,1755128095.513 [MissionManager](IMPORTANT): Started mission Startup
2025-08-13T23:34:55.513Z,1755128095.513 [Startup] Running Loop=1
2025-08-13T23:34:55.514Z,1755128095.514 [Startup](DEBUG): Aggregate::initialize Startup
2025-08-13T23:34:55.514Z,1755128095.514 [Startup:A.GoToSurface] Running Loop=1
2025-08-13T23:34:55.514Z,1755128095.514 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-13T23:34:55.514Z,1755128095.514 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-13T23:34:55.515Z,1755128095.515 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-13T23:34:55.515Z,1755128095.515 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-13T23:34:55.515Z,1755128095.515 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-13T23:34:55.516Z,1755128095.516 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-13T23:34:55.516Z,1755128095.516 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-13T23:34:55.518Z,1755128095.518 [Startup:StartupSatComms] Running Loop=1
2025-08-13T23:34:55.518Z,1755128095.518 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-08-13T23:34:55.518Z,1755128095.518 [Startup:StartupSatComms:A] Running Loop=1
2025-08-13T23:34:55.915Z,1755128095.915 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-08-13T23:34:59.141Z,1755128099.141 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:34:59.171Z,1755128099.171 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:35:03.613Z,1755128103.613 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.016455
CHAN A1 (24V): 0.039639
CHAN A2 (12V): 0.007413
CHAN A3 (5V): -0.003902
CHAN B0 (3.3V): -0.004057
CHAN B1 (3.15aV): -0.004106
CHAN B2 (3.15bV): -0.003771
CHAN B3 (GND): -0.008063
OPEN: 0.007468
Full Scale: +/- 1 mA
2025-08-13T23:35:55.714Z,1755128155.714 [Startup:StartupSatComms:A](INFO): Timed out from 2025-08-13T23:34:55.5Z
2025-08-13T23:35:55.714Z,1755128155.714 [Startup:StartupSatComms:A] Stopped
2025-08-13T23:35:55.714Z,1755128155.714 [Startup:StartupSatComms:B] Running Loop=1
2025-08-13T23:35:56.121Z,1755128156.121 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-13T23:36:06.407Z,1755128166.407 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250813T182313/Courier0133.lzma
2025-08-13T23:36:12.257Z,1755128172.257 [NAL9602](INFO): SBD MO Status=2, MOMSN=21838, MT Status=2, MTMSN=0
2025-08-13T23:36:12.257Z,1755128172.257 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-13T23:36:17.450Z,1755128177.450 [DataOverHttps](INFO): Moved sent file to Logs/20250813T182313/Courier0133.lzma.bak
2025-08-13T23:36:17.451Z,1755128177.451 [DataOverHttps](INFO): SBD MOMSN=25848622
2025-08-13T23:36:43.452Z,1755128203.452 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20250813T233120/Courier0000.lzma
2025-08-13T23:36:53.881Z,1755128213.881 [NAL9602](INFO): SBD MO Status=2, MOMSN=21838, MT Status=2, MTMSN=0
2025-08-13T23:36:53.881Z,1755128213.881 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-13T23:36:54.494Z,1755128214.494 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0000.lzma.bak
2025-08-13T23:36:54.494Z,1755128214.494 [DataOverHttps](INFO): SBD MOMSN=25848630
2025-08-13T23:36:55.914Z,1755128215.914 [Startup:StartupSatComms:B](INFO): Timed out from 2025-08-13T23:35:55.7Z
2025-08-13T23:36:55.914Z,1755128215.914 [Startup:StartupSatComms:B] Stopped
2025-08-13T23:36:55.914Z,1755128215.914 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-08-13T23:36:55.914Z,1755128215.914 [Startup:StartupSatComms] Stopped
2025-08-13T23:36:55.915Z,1755128215.915 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-08-13T23:36:55.920Z,1755128215.920 [Startup](INFO): Completed Startup
2025-08-13T23:36:55.920Z,1755128215.920 [MissionManager](INFO): Startup is completed.
2025-08-13T23:36:55.920Z,1755128215.920 [MissionManager](INFO): Uninitializing Mission Startup
2025-08-13T23:36:55.920Z,1755128215.920 [Startup] Stopped
2025-08-13T23:36:55.920Z,1755128215.920 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-08-13T23:36:55.920Z,1755128215.920 [Startup:A.GoToSurface] Stopped
2025-08-13T23:36:55.920Z,1755128215.920 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-13T23:36:56.309Z,1755128216.309 [MissionManager](IMPORTANT): Started mission Default
2025-08-13T23:36:56.310Z,1755128216.310 [Default] Running Loop=1
2025-08-13T23:36:56.310Z,1755128216.310 [Default](DEBUG): Aggregate::initialize Default
2025-08-13T23:36:56.310Z,1755128216.310 [Default:B.GoToSurface] Running Loop=1
2025-08-13T23:36:56.310Z,1755128216.310 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-13T23:36:56.310Z,1755128216.310 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-08-13T23:36:56.310Z,1755128216.310 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-08-13T23:36:56.311Z,1755128216.311 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-08-13T23:36:56.311Z,1755128216.311 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-08-13T23:36:56.311Z,1755128216.311 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-13T23:36:56.390Z,1755128216.390 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-13T23:36:56.412Z,1755128216.412 [Default:A.Wait] Running Loop=1
2025-08-13T23:36:56.413Z,1755128216.413 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-08-13T23:37:09.674Z,1755128229.674 [Default:A.Wait](INFO): Done Waiting.
2025-08-13T23:37:09.674Z,1755128229.674 [Default:A.Wait] Stopped
2025-08-13T23:37:09.674Z,1755128229.674 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-08-13T23:37:10.085Z,1755128230.085 [Default:CheckIn] Running Loop=1
2025-08-13T23:37:10.085Z,1755128230.085 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-13T23:37:10.086Z,1755128230.086 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-13T23:37:10.392Z,1755128230.392 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-13T23:37:14.635Z,1755128234.635 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-08-13T23:37:14.659Z,1755128234.659 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread.
2025-08-13T23:37:14.677Z,1755128234.677 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-08-13T23:37:17.927Z,1755128237.927 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-13T23:37:22.829Z,1755128242.829 [CommandExec](IMPORTANT): got command strobe off
2025-08-13T23:37:22.829Z,1755128242.829 [CommandExec](IMPORTANT): Deactivating strobe
2025-08-13T23:37:24.768Z,1755128244.768 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233648.00,A,3648.16485,N,12147.27995,W,0.156,308.41,130825,,,D*76
2025-08-13T23:37:24.771Z,1755128244.771 [NAL9602](INFO): GPS fix at 20250813T233648: (36.802748, -121.787999)
2025-08-13T23:37:24.816Z,1755128244.816 [Default:CheckIn:Read_GPS] Stopped
2025-08-13T23:37:24.816Z,1755128244.816 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-13T23:37:25.219Z,1755128245.219 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-13T23:37:35.462Z,1755128255.462 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-08-13T23:37:37.527Z,1755128257.527 [DataOverHttps](INFO): Sending 112 bytes from file Logs/20250813T182313/Express0134.lzma
2025-08-13T23:37:48.570Z,1755128268.570 [DataOverHttps](INFO): Moved sent file to Logs/20250813T182313/Express0134.lzma.bak
2025-08-13T23:37:48.570Z,1755128268.570 [DataOverHttps](INFO): SBD MOMSN=25848638
2025-08-13T23:37:56.922Z,1755128276.922 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-13T23:38:06.745Z,1755128286.745 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree
2025-08-13T23:38:07.265Z,1755128287.265 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:38:07.465Z,1755128287.465 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:38:12.482Z,1755128292.482 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.014599
CHAN A1 (24V): 0.035714
CHAN A2 (12V): 0.005536
CHAN A3 (5V): -0.005452
CHAN B0 (3.3V): -0.005328
CHAN B1 (3.15aV): -0.004824
CHAN B2 (3.15bV): -0.004848
CHAN B3 (GND): -0.008962
OPEN: 0.007366
Full Scale: +/- 1 mA
2025-08-13T23:38:16.440Z,1755128296.440 [DataOverHttps](INFO): Sending 225 bytes from file Logs/20250813T233120/Courier0004.lzma
2025-08-13T23:38:27.482Z,1755128307.482 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0004.lzma.bak
2025-08-13T23:38:27.482Z,1755128307.482 [DataOverHttps](INFO): SBD MOMSN=25848649
2025-08-13T23:38:36.114Z,1755128316.114 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree
2025-08-13T23:38:43.117Z,1755128323.117 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:38:43.233Z,1755128323.233 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:38:47.554Z,1755128327.554 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.013351
CHAN A1 (24V): 0.037376
CHAN A2 (12V): 0.006896
CHAN A3 (5V): -0.003490
CHAN B0 (3.3V): -0.003656
CHAN B1 (3.15aV): -0.004321
CHAN B2 (3.15bV): -0.003315
CHAN B3 (GND): -0.007595
OPEN: 0.007515
Full Scale: +/- 1 mA
2025-08-13T23:38:57.351Z,1755128337.351 [DataOverHttps](INFO): Sending 1064 bytes from file Logs/20250813T233120/Express0001.lzma
2025-08-13T23:39:06.616Z,1755128346.616 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree
2025-08-13T23:39:08.398Z,1755128348.398 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0001.lzma.bak
2025-08-13T23:39:08.398Z,1755128348.398 [DataOverHttps](INFO): SBD MOMSN=25848653
2025-08-13T23:39:12.733Z,1755128352.733 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-13T23:39:12.734Z,1755128352.734 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6.
2025-08-13T23:39:12.778Z,1755128352.778 [BPC1](INFO): Received data from all battery sticks.
2025-08-13T23:39:38.763Z,1755128378.763 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree
2025-08-13T23:39:38.855Z,1755128378.855 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread.
2025-08-13T23:39:39.019Z,1755128379.019 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-08-13T23:39:41.748Z,1755128381.748 [DataOverHttps](INFO): Sending 493 bytes from file Logs/20250813T233120/Express0005.lzma
2025-08-13T23:39:52.798Z,1755128392.798 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0005.lzma.bak
2025-08-13T23:39:52.798Z,1755128392.798 [DataOverHttps](INFO): SBD MOMSN=25848682
2025-08-13T23:39:55.927Z,1755128395.927 [Default:CheckIn:Read_Iridium] Stopped
2025-08-13T23:39:55.927Z,1755128395.927 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-13T23:39:55.927Z,1755128395.927 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-13T23:39:57.729Z,1755128397.729 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree
2025-08-13T23:40:00.749Z,1755128400.749 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:40:00.833Z,1755128400.833 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:40:05.265Z,1755128405.265 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.016697
CHAN A1 (24V): 0.038380
CHAN A2 (12V): 0.007500
CHAN A3 (5V): -0.003681
CHAN B0 (3.3V): -0.003957
CHAN B1 (3.15aV): -0.003924
CHAN B2 (3.15bV): -0.003871
CHAN B3 (GND): -0.007848
OPEN: 0.007236
Full Scale: +/- 1 mA
2025-08-13T23:44:56.523Z,1755128696.523 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-13T23:44:56.523Z,1755128696.523 [Default:CheckIn:C.Wait] Stopped
2025-08-13T23:44:56.523Z,1755128696.523 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-13T23:44:56.523Z,1755128696.523 [Default:CheckIn:D] Running Loop=1
2025-08-13T23:44:56.925Z,1755128696.925 [Default:CheckIn:D] Stopped
2025-08-13T23:44:56.925Z,1755128696.925 [Default:CheckIn:E] Running Loop=1
2025-08-13T23:44:57.330Z,1755128697.330 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.010260 min
2025-08-13T23:44:57.330Z,1755128697.330 [Default:CheckIn:E] Stopped
2025-08-13T23:44:57.330Z,1755128697.330 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-13T23:44:57.330Z,1755128697.330 [Default:CheckIn] Stopped
2025-08-13T23:44:57.330Z,1755128697.330 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-13T23:44:57.331Z,1755128697.331 [Default:CheckIn](INFO): Running loop #2
2025-08-13T23:44:57.331Z,1755128697.331 [Default:CheckIn] Running Loop=2
2025-08-13T23:44:57.331Z,1755128697.331 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-13T23:44:57.331Z,1755128697.331 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-13T23:44:59.333Z,1755128699.333 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234422.00,A,3648.16667,N,12147.28124,W,0.408,318.93,130825,,,D*7C
2025-08-13T23:44:59.351Z,1755128699.351 [NAL9602](INFO): GPS fix at 20250813T234422: (36.802778, -121.788021)
2025-08-13T23:44:59.374Z,1755128699.374 [Default:CheckIn:Read_GPS] Stopped
2025-08-13T23:44:59.374Z,1755128699.374 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-13T23:45:01.208Z,1755128701.208 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20250813T233120/Courier0007.lzma
2025-08-13T23:45:11.470Z,1755128711.470 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0007.lzma.bak
2025-08-13T23:45:11.470Z,1755128711.470 [DataOverHttps](INFO): SBD MOMSN=25848689
2025-08-13T23:45:21.977Z,1755128721.977 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB1
2025-08-13T23:45:26.153Z,1755128726.153 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:45:26.424Z,1755128726.424 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:45:30.039Z,1755128730.039 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-08-13T23:45:30.116Z,1755128730.116 [NAL9602](ERROR): received:
+CSQ:0
OK838, 2, 0, 0, 0
OK
2025-08-13T23:45:30.868Z,1755128730.868 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012968
CHAN A1 (24V): 0.031782
CHAN A2 (12V): 0.006202
CHAN A3 (5V): -0.002630
CHAN B0 (3.3V): -0.003221
CHAN B1 (3.15aV): -0.003054
CHAN B2 (3.15bV): -0.002341
CHAN B3 (GND): -0.006084
OPEN: 0.006884
Full Scale: +/- 1 mA
2025-08-13T23:45:38.973Z,1755128738.973 [DataOverHttps](INFO): Sending 595 bytes from file Logs/20250813T233120/Express0008.lzma
2025-08-13T23:45:50.014Z,1755128750.014 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0008.lzma.bak
2025-08-13T23:45:50.014Z,1755128750.014 [DataOverHttps](INFO): SBD MOMSN=25848692
2025-08-13T23:45:52.301Z,1755128752.301 [Default:CheckIn:Read_Iridium] Stopped
2025-08-13T23:45:52.301Z,1755128752.301 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-13T23:45:52.301Z,1755128752.301 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-13T23:45:55.117Z,1755128755.117 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:45:55.135Z,1755128755.135 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:45:59.569Z,1755128759.569 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.013019
CHAN A1 (24V): 0.032609
CHAN A2 (12V): 0.005621
CHAN A3 (5V): -0.003001
CHAN B0 (3.3V): -0.002976
CHAN B1 (3.15aV): -0.002942
CHAN B2 (3.15bV): -0.002976
CHAN B3 (GND): -0.006259
OPEN: 0.006813
Full Scale: +/- 1 mA
2025-08-13T23:46:01.793Z,1755128761.793 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:46:01.978Z,1755128761.978 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:46:03.357Z,1755128763.357 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:46:06.415Z,1755128766.415 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010299
CHAN A1 (24V): 0.029778
CHAN A2 (12V): 0.004401
CHAN A3 (5V): -0.004016
CHAN B0 (3.3V): -0.003992
CHAN B1 (3.15aV): -0.004475
CHAN B2 (3.15bV): -0.003489
CHAN B3 (GND): -0.007010
OPEN: 0.006197
Full Scale: +/- 1 mA
2025-08-13T23:46:08.765Z,1755128768.765 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:46:08.866Z,1755128768.866 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:46:13.295Z,1755128773.295 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010052
CHAN A1 (24V): 0.029240
CHAN A2 (12V): 0.003364
CHAN A3 (5V): -0.004853
CHAN B0 (3.3V): -0.004653
CHAN B1 (3.15aV): -0.004227
CHAN B2 (3.15bV): -0.003703
CHAN B3 (GND): -0.007655
OPEN: 0.005851
Full Scale: +/- 1 mA
2025-08-13T23:46:15.629Z,1755128775.629 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:46:15.721Z,1755128775.721 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:46:20.152Z,1755128780.152 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010073
CHAN A1 (24V): 0.028608
CHAN A2 (12V): 0.002925
CHAN A3 (5V): -0.005632
CHAN B0 (3.3V): -0.004884
CHAN B1 (3.15aV): -0.004789
CHAN B2 (3.15bV): -0.004684
CHAN B3 (GND): -0.008525
OPEN: 0.005788
Full Scale: +/- 1 mA
2025-08-13T23:46:31.442Z,1755128791.442 [NAL9602](INFO): SBD MO Status=2, MOMSN=21838, MT Status=2, MTMSN=0
2025-08-13T23:46:31.442Z,1755128791.442 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-13T23:46:36.045Z,1755128796.045 [CBIT](INFO): Clearing failed state for component DropWeight
2025-08-13T23:46:36.045Z,1755128796.045 [DropWeight] No Fault, FailCount= 1
2025-08-13T23:47:06.893Z,1755128826.893 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:47:07.020Z,1755128827.020 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:47:11.519Z,1755128831.519 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.017550
CHAN A1 (24V): 0.045558
CHAN A2 (12V): 0.007591
CHAN A3 (5V): -0.006035
CHAN B0 (3.3V): -0.005874
CHAN B1 (3.15aV): -0.005069
CHAN B2 (3.15bV): -0.004021
CHAN B3 (GND): -0.009072
OPEN: 0.007248
Full Scale: +/- 1 mA
2025-08-13T23:48:33.881Z,1755128913.881 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3
2025-08-13T23:48:41.581Z,1755128921.581 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:48:41.969Z,1755128921.969 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:48:46.398Z,1755128926.398 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.011196
CHAN A1 (24V): 0.029720
CHAN A2 (12V): 0.005347
CHAN A3 (5V): -0.002043
CHAN B0 (3.3V): -0.002458
CHAN B1 (3.15aV): -0.002648
CHAN B2 (3.15bV): -0.002268
CHAN B3 (GND): -0.005942
OPEN: 0.006886
Full Scale: +/- 1 mA
2025-08-13T23:48:50.449Z,1755128930.449 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:48:50.508Z,1755128930.508 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:48:54.941Z,1755128934.941 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010079
CHAN A1 (24V): 0.028716
CHAN A2 (12V): 0.004245
CHAN A3 (5V): -0.003404
CHAN B0 (3.3V): -0.003629
CHAN B1 (3.15aV): -0.003444
CHAN B2 (3.15bV): -0.003009
CHAN B3 (GND): -0.006660
OPEN: 0.006636
Full Scale: +/- 1 mA
2025-08-13T23:48:57.833Z,1755128937.833 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:48:58.152Z,1755128938.152 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:49:02.595Z,1755128942.595 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.006035
CHAN A1 (24V): 0.027023
CHAN A2 (12V): 0.004267
CHAN A3 (5V): -0.003764
CHAN B0 (3.3V): -0.003661
CHAN B1 (3.15aV): -0.003753
CHAN B2 (3.15bV): -0.003748
CHAN B3 (GND): -0.007213
OPEN: 0.005977
Full Scale: +/- 1 mA
2025-08-13T23:49:05.221Z,1755128945.221 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:49:05.409Z,1755128945.409 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:49:09.851Z,1755128949.851 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008016
CHAN A1 (24V): 0.026461
CHAN A2 (12V): 0.002788
CHAN A3 (5V): -0.004179
CHAN B0 (3.3V): -0.003891
CHAN B1 (3.15aV): -0.003715
CHAN B2 (3.15bV): -0.004140
CHAN B3 (GND): -0.006598
OPEN: 0.006071
Full Scale: +/- 1 mA
2025-08-13T23:49:13.833Z,1755128953.833 [CommandExec](IMPORTANT): got command strobe off
2025-08-13T23:49:13.833Z,1755128953.833 [CommandExec](IMPORTANT): Deactivating strobe
2025-08-13T23:49:20.725Z,1755128960.725 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:49:20.807Z,1755128960.807 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:49:25.210Z,1755128965.210 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.009717
CHAN A1 (24V): 0.027721
CHAN A2 (12V): 0.004312
CHAN A3 (5V): -0.002933
CHAN B0 (3.3V): -0.002623
CHAN B1 (3.15aV): -0.003109
CHAN B2 (3.15bV): -0.002751
CHAN B3 (GND): -0.006010
OPEN: 0.006462
Full Scale: +/- 1 mA
2025-08-13T23:49:42.721Z,1755128982.721 [CommandExec](IMPORTANT): got command ! echo d > /dev/loadC3
2025-08-13T23:49:45.117Z,1755128985.117 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:49:45.214Z,1755128985.214 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:49:49.481Z,1755128989.481 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.009383
CHAN A1 (24V): 0.028587
CHAN A2 (12V): 0.004597
CHAN A3 (5V): -0.002381
CHAN B0 (3.3V): -0.002202
CHAN B1 (3.15aV): -0.002483
CHAN B2 (3.15bV): -0.002739
CHAN B3 (GND): -0.005218
OPEN: 0.007125
Full Scale: +/- 1 mA
2025-08-13T23:49:53.245Z,1755128993.245 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:49:53.463Z,1755128993.463 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:49:57.923Z,1755128997.923 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.004663
CHAN A1 (24V): 0.026833
CHAN A2 (12V): 0.003536
CHAN A3 (5V): -0.003907
CHAN B0 (3.3V): -0.003594
CHAN B1 (3.15aV): -0.003174
CHAN B2 (3.15bV): -0.002712
CHAN B3 (GND): -0.006203
OPEN: 0.006557
Full Scale: +/- 1 mA
2025-08-13T23:50:01.118Z,1755129001.118 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-13T23:50:01.889Z,1755129001.889 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:50:01.949Z,1755129001.949 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:50:06.432Z,1755129006.432 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008459
CHAN A1 (24V): 0.026141
CHAN A2 (12V): 0.003232
CHAN A3 (5V): -0.003617
CHAN B0 (3.3V): -0.003779
CHAN B1 (3.15aV): -0.004250
CHAN B2 (3.15bV): -0.003221
CHAN B3 (GND): -0.005747
OPEN: 0.006189
Full Scale: +/- 1 mA
2025-08-13T23:50:09.396Z,1755129009.396 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:50:09.617Z,1755129009.617 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:50:14.073Z,1755129014.073 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008003
CHAN A1 (24V): 0.026209
CHAN A2 (12V): 0.002722
CHAN A3 (5V): -0.003822
CHAN B0 (3.3V): -0.003826
CHAN B1 (3.15aV): -0.004063
CHAN B2 (3.15bV): -0.003786
CHAN B3 (GND): -0.007016
OPEN: 0.005957
Full Scale: +/- 1 mA
2025-08-13T23:50:16.573Z,1755129016.573 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:50:16.923Z,1755129016.923 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:50:21.392Z,1755129021.392 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.007404
CHAN A1 (24V): 0.025576
CHAN A2 (12V): 0.002576
CHAN A3 (5V): -0.005008
CHAN B0 (3.3V): -0.004154
CHAN B1 (3.15aV): -0.004524
CHAN B2 (3.15bV): -0.004306
CHAN B3 (GND): -0.006613
OPEN: 0.006047
Full Scale: +/- 1 mA
2025-08-13T23:50:26.153Z,1755129026.153 [CommandExec](IMPORTANT): got command ! echo d > /dev/loadB1
2025-08-13T23:50:27.949Z,1755129027.949 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:50:28.218Z,1755129028.218 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:50:30.341Z,1755129030.341 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:50:31.817Z,1755129031.817 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-13T23:50:32.661Z,1755129032.661 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008569
CHAN A1 (24V): 0.026464
CHAN A2 (12V): 0.003073
CHAN A3 (5V): -0.003594
CHAN B0 (3.3V): -0.003714
CHAN B1 (3.15aV): -0.004074
CHAN B2 (3.15bV): -0.003377
CHAN B3 (GND): -0.006392
OPEN: 0.006475
Full Scale: +/- 1 mA
2025-08-13T23:50:35.161Z,1755129035.161 [CommandExec](IMPORTANT): got command gfscan
2025-08-13T23:50:35.522Z,1755129035.522 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-13T23:50:39.921Z,1755129039.921 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.007583
CHAN A1 (24V): 0.025615
CHAN A2 (12V): 0.002497
CHAN A3 (5V): -0.004164
CHAN B0 (3.3V): -0.004139
CHAN B1 (3.15aV): -0.004027
CHAN B2 (3.15bV): -0.004072
CHAN B3 (GND): -0.006843
OPEN: 0.006559
Full Scale: +/- 1 mA
2025-08-13T23:50:52.863Z,1755129052.863 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-13T23:50:52.868Z,1755129052.868 [Default:CheckIn:C.Wait] Stopped
2025-08-13T23:50:52.868Z,1755129052.868 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-13T23:50:52.868Z,1755129052.868 [Default:CheckIn:D] Running Loop=1
2025-08-13T23:50:53.243Z,1755129053.243 [Default:CheckIn:D] Stopped
2025-08-13T23:50:53.243Z,1755129053.243 [Default:CheckIn:E] Running Loop=1
2025-08-13T23:50:53.646Z,1755129053.646 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.948894 min
2025-08-13T23:50:53.646Z,1755129053.646 [Default:CheckIn:E] Stopped
2025-08-13T23:50:53.646Z,1755129053.646 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-13T23:50:53.646Z,1755129053.646 [Default:CheckIn] Stopped
2025-08-13T23:50:53.646Z,1755129053.646 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-13T23:50:53.646Z,1755129053.646 [Default:CheckIn](INFO): Running loop #3
2025-08-13T23:50:53.647Z,1755129053.647 [Default:CheckIn] Running Loop=3
2025-08-13T23:50:53.647Z,1755129053.647 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-13T23:50:53.647Z,1755129053.647 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-13T23:50:55.654Z,1755129055.654 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235019.00,A,3648.16431,N,12147.27560,W,0.447,234.72,130825,,,D*70
2025-08-13T23:50:55.656Z,1755129055.656 [NAL9602](INFO): GPS fix at 20250813T235019: (36.802738, -121.787927)
2025-08-13T23:50:55.692Z,1755129055.692 [Default:CheckIn:Read_GPS] Stopped
2025-08-13T23:50:55.692Z,1755129055.692 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-13T23:51:16.559Z,1755129076.559 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250813T233120/Courier0010.lzma
2025-08-13T23:51:26.171Z,1755129086.171 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-08-13T23:51:26.248Z,1755129086.248 [NAL9602](ERROR): received:
+CSQ:0
OK838, 2, 0, 0, 0
OK
2025-08-13T23:51:27.602Z,1755129087.602 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0010.lzma.bak
2025-08-13T23:51:27.603Z,1755129087.603 [DataOverHttps](INFO): SBD MOMSN=25848719
2025-08-13T23:51:55.649Z,1755129115.649 [DataOverHttps](INFO): Sending 1198 bytes from file Logs/20250813T233120/Express0011.lzma
2025-08-13T23:52:06.686Z,1755129126.686 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0011.lzma.bak
2025-08-13T23:52:06.686Z,1755129126.686 [DataOverHttps](INFO): SBD MOMSN=25848722
2025-08-13T23:52:09.024Z,1755129129.024 [Default:CheckIn:Read_Iridium] Stopped
2025-08-13T23:52:09.024Z,1755129129.024 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-13T23:52:09.024Z,1755129129.024 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-13T23:55:58.061Z,1755129358.061 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-13T23:56:28.778Z,1755129388.778 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-13T23:57:09.653Z,1755129429.653 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-13T23:57:09.653Z,1755129429.653 [Default:CheckIn:C.Wait] Stopped
2025-08-13T23:57:09.654Z,1755129429.654 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-13T23:57:09.654Z,1755129429.654 [Default:CheckIn:D] Running Loop=1
2025-08-13T23:57:10.105Z,1755129430.105 [Default:CheckIn:D] Stopped
2025-08-13T23:57:10.105Z,1755129430.105 [Default:CheckIn:E] Running Loop=1
2025-08-13T23:57:10.462Z,1755129430.462 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.229917 min
2025-08-13T23:57:10.462Z,1755129430.462 [Default:CheckIn:E] Stopped
2025-08-13T23:57:10.462Z,1755129430.462 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-13T23:57:10.462Z,1755129430.462 [Default:CheckIn] Stopped
2025-08-13T23:57:10.462Z,1755129430.462 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-13T23:57:10.463Z,1755129430.463 [Default:CheckIn](INFO): Running loop #4
2025-08-13T23:57:10.463Z,1755129430.463 [Default:CheckIn] Running Loop=4
2025-08-13T23:57:10.463Z,1755129430.463 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-13T23:57:10.463Z,1755129430.463 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-13T23:57:12.427Z,1755129432.427 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235635.00,A,3648.16163,N,12147.28299,W,0.097,234.72,130825,,,D*7D
2025-08-13T23:57:12.431Z,1755129432.431 [NAL9602](INFO): GPS fix at 20250813T235635: (36.802694, -121.788050)
2025-08-13T23:57:12.454Z,1755129432.454 [Default:CheckIn:Read_GPS] Stopped
2025-08-13T23:57:12.454Z,1755129432.454 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-13T23:57:14.336Z,1755129434.336 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250813T233120/Courier0013.lzma
2025-08-13T23:57:25.382Z,1755129445.382 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0013.lzma.bak
2025-08-13T23:57:25.382Z,1755129445.382 [DataOverHttps](INFO): SBD MOMSN=25848793
2025-08-13T23:57:43.066Z,1755129463.066 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-08-13T23:57:43.148Z,1755129463.148 [NAL9602](ERROR): received:
+CSQ:0
OK838, 2, 0, 0, 0
OK
2025-08-13T23:57:53.080Z,1755129473.080 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20250813T233120/Express0014.lzma
2025-08-13T23:58:04.122Z,1755129484.122 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0014.lzma.bak
2025-08-13T23:58:04.122Z,1755129484.122 [DataOverHttps](INFO): SBD MOMSN=25848796
2025-08-13T23:58:06.531Z,1755129486.531 [Default:CheckIn:Read_Iridium] Stopped
2025-08-13T23:58:06.531Z,1755129486.531 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-13T23:58:06.531Z,1755129486.531 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-14T00:02:15.015Z,1755129735.015 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-14T00:02:45.721Z,1755129765.721 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-14T00:03:07.207Z,1755129787.207 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-14T00:03:07.207Z,1755129787.207 [Default:CheckIn:C.Wait] Stopped
2025-08-14T00:03:07.207Z,1755129787.207 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-14T00:03:07.207Z,1755129787.207 [Default:CheckIn:D] Running Loop=1
2025-08-14T00:03:07.636Z,1755129787.636 [Default:CheckIn:D] Stopped
2025-08-14T00:03:07.636Z,1755129787.636 [Default:CheckIn:E] Running Loop=1
2025-08-14T00:03:08.020Z,1755129788.020 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.188774 min
2025-08-14T00:03:08.020Z,1755129788.020 [Default:CheckIn:E] Stopped
2025-08-14T00:03:08.020Z,1755129788.020 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-14T00:03:08.020Z,1755129788.020 [Default:CheckIn] Stopped
2025-08-14T00:03:08.020Z,1755129788.020 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-14T00:03:08.021Z,1755129788.021 [Default:CheckIn](INFO): Running loop #5
2025-08-14T00:03:08.021Z,1755129788.021 [Default:CheckIn] Running Loop=5
2025-08-14T00:03:08.021Z,1755129788.021 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-14T00:03:08.021Z,1755129788.021 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-14T00:03:09.982Z,1755129789.982 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000233.00,A,3648.16556,N,12147.27417,W,0.408,280.20,140825,,,D*7B
2025-08-14T00:03:09.985Z,1755129789.985 [NAL9602](INFO): GPS fix at 20250814T000233: (36.802759, -121.787903)
2025-08-14T00:03:09.995Z,1755129789.995 [Default:CheckIn:Read_GPS] Stopped
2025-08-14T00:03:09.995Z,1755129789.995 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-14T00:03:27.175Z,1755129807.175 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250813T233120/Courier0016.lzma
2025-08-14T00:03:33.569Z,1755129813.569 [DVL_micro](ERROR): Failed to parse:
:SA,-00.99,+11.86,351.7
2025-08-14T00:03:38.218Z,1755129818.218 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0016.lzma.bak
2025-08-14T00:03:38.218Z,1755129818.218 [DataOverHttps](INFO): SBD MOMSN=25848800
2025-08-14T00:04:05.532Z,1755129845.532 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20250813T233120/Express0017.lzma
2025-08-14T00:04:16.582Z,1755129856.582 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0017.lzma.bak
2025-08-14T00:04:16.582Z,1755129856.582 [DataOverHttps](INFO): SBD MOMSN=25848803
2025-08-14T00:04:18.868Z,1755129858.868 [Default:CheckIn:Read_Iridium] Stopped
2025-08-14T00:04:18.868Z,1755129858.868 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-14T00:04:18.868Z,1755129858.868 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-14T00:08:12.442Z,1755130092.442 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-14T00:08:43.134Z,1755130123.134 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-14T00:09:19.524Z,1755130159.524 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-14T00:09:19.525Z,1755130159.525 [Default:CheckIn:C.Wait] Stopped
2025-08-14T00:09:19.525Z,1755130159.525 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-14T00:09:19.525Z,1755130159.525 [Default:CheckIn:D] Running Loop=1
2025-08-14T00:09:19.952Z,1755130159.952 [Default:CheckIn:D] Stopped
2025-08-14T00:09:19.952Z,1755130159.952 [Default:CheckIn:E] Running Loop=1
2025-08-14T00:09:20.321Z,1755130160.321 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.394039 min
2025-08-14T00:09:20.321Z,1755130160.321 [Default:CheckIn:E] Stopped
2025-08-14T00:09:20.321Z,1755130160.321 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-14T00:09:20.321Z,1755130160.321 [Default:CheckIn] Stopped
2025-08-14T00:09:20.322Z,1755130160.322 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-14T00:09:20.322Z,1755130160.322 [Default:CheckIn](INFO): Running loop #6
2025-08-14T00:09:20.322Z,1755130160.322 [Default:CheckIn] Running Loop=6
2025-08-14T00:09:20.322Z,1755130160.322 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-14T00:09:20.322Z,1755130160.322 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-14T00:09:22.329Z,1755130162.329 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000845.00,A,3648.16226,N,12147.28568,W,0.486,120.60,140825,,,D*7D
2025-08-14T00:09:22.331Z,1755130162.331 [NAL9602](INFO): GPS fix at 20250814T000845: (36.802704, -121.788095)
2025-08-14T00:09:22.342Z,1755130162.342 [Default:CheckIn:Read_GPS] Stopped
2025-08-14T00:09:22.342Z,1755130162.342 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-14T00:09:40.465Z,1755130180.465 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250813T233120/Courier0019.lzma
2025-08-14T00:09:51.502Z,1755130191.502 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0019.lzma.bak
2025-08-14T00:09:51.502Z,1755130191.502 [DataOverHttps](INFO): SBD MOMSN=25848811
2025-08-14T00:09:53.062Z,1755130193.062 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-08-14T00:09:53.144Z,1755130193.144 [NAL9602](ERROR): received:
+CSQ:0
OK838, 2, 0, 0, 0
OK
2025-08-14T00:10:19.148Z,1755130219.148 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20250813T233120/Express0020.lzma
2025-08-14T00:10:30.190Z,1755130230.190 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0020.lzma.bak
2025-08-14T00:10:30.190Z,1755130230.190 [DataOverHttps](INFO): SBD MOMSN=25848814
2025-08-14T00:10:32.672Z,1755130232.672 [Default:CheckIn:Read_Iridium] Stopped
2025-08-14T00:10:32.672Z,1755130232.672 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-14T00:10:32.672Z,1755130232.672 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-14T00:12:03.981Z,1755130323.981 [DVL_micro](ERROR): Failed to parse:
2025-08-14T00:14:24.164Z,1755130464.164 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-14T00:14:54.872Z,1755130494.872 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-14T00:15:33.279Z,1755130533.279 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-14T00:15:33.280Z,1755130533.280 [Default:CheckIn:C.Wait] Stopped
2025-08-14T00:15:33.280Z,1755130533.280 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-14T00:15:33.280Z,1755130533.280 [Default:CheckIn:D] Running Loop=1
2025-08-14T00:15:33.687Z,1755130533.687 [Default:CheckIn:D] Stopped
2025-08-14T00:15:33.687Z,1755130533.687 [Default:CheckIn:E] Running Loop=1
2025-08-14T00:15:34.070Z,1755130534.070 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.622949 min
2025-08-14T00:15:34.070Z,1755130534.070 [Default:CheckIn:E] Stopped
2025-08-14T00:15:34.070Z,1755130534.070 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-14T00:15:34.070Z,1755130534.070 [Default:CheckIn] Stopped
2025-08-14T00:15:34.071Z,1755130534.071 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-14T00:15:34.071Z,1755130534.071 [Default:CheckIn](INFO): Running loop #7
2025-08-14T00:15:34.071Z,1755130534.071 [Default:CheckIn] Running Loop=7
2025-08-14T00:15:34.071Z,1755130534.071 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-14T00:15:34.071Z,1755130534.071 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-14T00:15:36.093Z,1755130536.093 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001459.00,A,3648.16494,N,12147.28124,W,0.194,26.83,140825,,,D*42
2025-08-14T00:15:36.095Z,1755130536.095 [NAL9602](INFO): GPS fix at 20250814T001459: (36.802749, -121.788021)
2025-08-14T00:15:36.105Z,1755130536.105 [Default:CheckIn:Read_GPS] Stopped
2025-08-14T00:15:36.105Z,1755130536.105 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-14T00:15:52.747Z,1755130552.747 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250813T233120/Courier0022.lzma
2025-08-14T00:16:03.790Z,1755130563.790 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0022.lzma.bak
2025-08-14T00:16:03.790Z,1755130563.790 [DataOverHttps](INFO): SBD MOMSN=25848819
2025-08-14T00:16:06.788Z,1755130566.788 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-08-14T00:16:06.868Z,1755130566.868 [NAL9602](ERROR): received:
+CSQ:0
OK838, 2, 0, 0, 0
OK
2025-08-14T00:16:31.904Z,1755130591.904 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20250813T233120/Express0023.lzma
2025-08-14T00:16:37.503Z,1755130597.503 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-08-14T00:16:37.503Z,1755130597.503 [DropWeight] Hardware Fault, FailCount= 1
2025-08-14T00:16:37.503Z,1755130597.503 [DropWeight](ERROR): Hardware Fault
2025-08-14T00:16:37.563Z,1755130597.563 [CBIT](INFO): Critical error at 20250814T001637
2025-08-14T00:16:37.569Z,1755130597.569 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-08-14T00:16:37.570Z,1755130597.570 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-08-14T00:16:37.941Z,1755130597.941 [CBIT](INFO): Critical error at 20250814T001637
2025-08-14T00:16:42.958Z,1755130602.958 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0023.lzma.bak
2025-08-14T00:16:42.958Z,1755130602.958 [DataOverHttps](INFO): SBD MOMSN=25848822
2025-08-14T00:16:45.608Z,1755130605.608 [Default:CheckIn:Read_Iridium] Stopped
2025-08-14T00:16:45.608Z,1755130605.608 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-14T00:16:45.609Z,1755130605.609 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-14T00:20:37.908Z,1755130837.908 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-14T00:21:08.617Z,1755130868.617 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-14T00:21:46.209Z,1755130906.209 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-08-14T00:21:46.210Z,1755130906.210 [Default:CheckIn:C.Wait] Stopped
2025-08-14T00:21:46.210Z,1755130906.210 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-14T00:21:46.210Z,1755130906.210 [Default:CheckIn:D] Running Loop=1
2025-08-14T00:21:46.616Z,1755130906.616 [Default:CheckIn:D] Stopped
2025-08-14T00:21:46.616Z,1755130906.616 [Default:CheckIn:E] Running Loop=1
2025-08-14T00:21:47.052Z,1755130907.052 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.838367 min
2025-08-14T00:21:47.052Z,1755130907.052 [Default:CheckIn:E] Stopped
2025-08-14T00:21:47.053Z,1755130907.053 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-08-14T00:21:47.053Z,1755130907.053 [Default:CheckIn] Stopped
2025-08-14T00:21:47.053Z,1755130907.053 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-14T00:21:47.054Z,1755130907.054 [Default:CheckIn](INFO): Running loop #8
2025-08-14T00:21:47.054Z,1755130907.054 [Default:CheckIn] Running Loop=8
2025-08-14T00:21:47.055Z,1755130907.055 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-08-14T00:21:47.055Z,1755130907.055 [Default:CheckIn:Read_GPS] Running Loop=1
2025-08-14T00:21:49.019Z,1755130909.019 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002112.00,A,3648.16163,N,12147.27857,W,0.233,154.53,140825,,,D*73
2025-08-14T00:21:49.022Z,1755130909.022 [NAL9602](INFO): GPS fix at 20250814T002112: (36.802694, -121.787976)
2025-08-14T00:21:49.032Z,1755130909.032 [Default:CheckIn:Read_GPS] Stopped
2025-08-14T00:21:49.032Z,1755130909.032 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-08-14T00:22:06.924Z,1755130926.924 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250813T233120/Courier0025.lzma
2025-08-14T00:22:17.966Z,1755130937.966 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Courier0025.lzma.bak
2025-08-14T00:22:17.966Z,1755130937.966 [DataOverHttps](INFO): SBD MOMSN=25848852
2025-08-14T00:22:19.718Z,1755130939.718 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-08-14T00:22:19.792Z,1755130939.792 [NAL9602](ERROR): received:
+CSQ:0
OK838, 2, 0, 0, 0
OK
2025-08-14T00:22:45.342Z,1755130965.342 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20250813T233120/Express0026.lzma
2025-08-14T00:22:56.382Z,1755130976.382 [DataOverHttps](INFO): Moved sent file to Logs/20250813T233120/Express0026.lzma.bak
2025-08-14T00:22:56.382Z,1755130976.382 [DataOverHttps](INFO): SBD MOMSN=25848863
2025-08-14T00:22:58.973Z,1755130978.973 [Default:CheckIn:Read_Iridium] Stopped
2025-08-14T00:22:58.973Z,1755130978.973 [Default:CheckIn:C.Wait] Running Loop=1
2025-08-14T00:22:58.973Z,1755130978.973 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-08-14T00:26:51.212Z,1755131211.212 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-14T00:27:21.913Z,1755131241.913 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-14T00:27:48.728Z,1755131268.728 [CommandExec](IMPORTANT): got command quit
2025-08-14T00:27:49.732Z,1755131269.732 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:49.732Z,1755131269.732 [CommandExec](INFO): Uninitializing the command executive.
2025-08-14T00:27:49.732Z,1755131269.732 [CommandExec](INFO): Uninitializing the command scheduler.
2025-08-14T00:27:49.732Z,1755131269.732 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:49.864Z,1755131269.864 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-08-14T00:27:49.864Z,1755131269.864 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-08-14T00:27:49.864Z,1755131269.864 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:49.865Z,1755131269.865 [NavChartDb](INFO): Join timeout helper Thread ID is 1511
2025-08-14T00:27:50.104Z,1755131270.104 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:50.104Z,1755131270.104 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:50.124Z,1755131270.124 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-08-14T00:27:50.124Z,1755131270.124 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:50.124Z,1755131270.124 [Radio_Surface](INFO): Join timeout helper Thread ID is 1512
2025-08-14T00:27:50.436Z,1755131270.436 [Radio_Surface](INFO): Powering down
2025-08-14T00:27:50.437Z,1755131270.437 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:50.437Z,1755131270.437 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:50.448Z,1755131270.448 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-08-14T00:27:50.448Z,1755131270.448 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:50.448Z,1755131270.448 [Onboard](INFO): Join timeout helper Thread ID is 1513
2025-08-14T00:27:50.716Z,1755131270.716 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-14T00:27:52.112Z,1755131272.112 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:52.112Z,1755131272.112 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:52.116Z,1755131272.116 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-08-14T00:27:52.116Z,1755131272.116 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:52.116Z,1755131272.116 [DataOverHttps](INFO): Join timeout helper Thread ID is 1514
2025-08-14T00:27:52.724Z,1755131272.724 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:52.725Z,1755131272.725 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:52.728Z,1755131272.728 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-08-14T00:27:52.728Z,1755131272.728 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:52.729Z,1755131272.729 [DAT](INFO): Join timeout helper Thread ID is 1515
2025-08-14T00:27:52.916Z,1755131272.916 [DAT](INFO): Powering down
2025-08-14T00:27:52.989Z,1755131272.989 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:52.989Z,1755131272.989 [DAT](INFO): Powering down
2025-08-14T00:27:52.990Z,1755131272.990 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.017Z,1755131273.017 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-08-14T00:27:53.017Z,1755131273.017 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.018Z,1755131273.018 [BackseatComponent](INFO): Join timeout helper Thread ID is 1516
2025-08-14T00:27:53.108Z,1755131273.108 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:53.108Z,1755131273.108 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.129Z,1755131273.129 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-08-14T00:27:53.129Z,1755131273.129 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.129Z,1755131273.129 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1517
2025-08-14T00:27:53.256Z,1755131273.256 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:53.257Z,1755131273.257 [WetLabsBB2FL](INFO): Powering down
2025-08-14T00:27:53.257Z,1755131273.257 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.277Z,1755131273.277 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-08-14T00:27:53.277Z,1755131273.277 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.277Z,1755131273.277 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1518
2025-08-14T00:27:53.388Z,1755131273.388 [CTD_Seabird](INFO): Powering down
2025-08-14T00:27:53.400Z,1755131273.400 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:53.400Z,1755131273.400 [CTD_Seabird](INFO): Powering down
2025-08-14T00:27:53.412Z,1755131273.412 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.417Z,1755131273.417 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-08-14T00:27:53.417Z,1755131273.417 [logger ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.417Z,1755131273.417 [logger](INFO): Join timeout helper Thread ID is 1519
2025-08-14T00:27:53.436Z,1755131273.436 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:53.436Z,1755131273.436 [logger ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.445Z,1755131273.445 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-08-14T00:27:53.445Z,1755131273.445 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.445Z,1755131273.445 [CommandLine](INFO): Join timeout helper Thread ID is 1520
2025-08-14T00:27:53.524Z,1755131273.524 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:53.524Z,1755131273.524 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.532Z,1755131273.532 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-08-14T00:27:53.533Z,1755131273.533 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.533Z,1755131273.533 [CommandExec](INFO): Join timeout helper Thread ID is 1521
2025-08-14T00:27:53.534Z,1755131273.534 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-08-14T00:27:53.534Z,1755131273.534 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:53.535Z,1755131273.535 [controlThread](INFO): Join timeout helper Thread ID is 1522
2025-08-14T00:27:53.808Z,1755131273.808 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-08-14T00:27:53.808Z,1755131273.808 [controlThread](DEBUG): Uninitializing ControlThread
2025-08-14T00:27:53.809Z,1755131273.809 [AHRS_M2](INFO): Powering down
2025-08-14T00:27:53.984Z,1755131273.984 [DVL_micro](INFO): Powering down
2025-08-14T00:27:53.985Z,1755131273.985 [NAL9602](INFO): Powering down
2025-08-14T00:27:53.986Z,1755131273.986 [Sonardyne_Nano](INFO): Powering down
2025-08-14T00:27:54.192Z,1755131274.192 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-08-14T00:27:54.193Z,1755131274.193 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-08-14T00:27:54.193Z,1755131274.193 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-08-14T00:27:54.194Z,1755131274.194 [MissionManager](INFO): Uninitializing Mission Default
2025-08-14T00:27:54.194Z,1755131274.194 [Default] Stopped
2025-08-14T00:27:54.194Z,1755131274.194 [Default](DEBUG): Aggregate::uninitialize Default
2025-08-14T00:27:54.194Z,1755131274.194 [Default:B.GoToSurface] Stopped
2025-08-14T00:27:54.194Z,1755131274.194 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-14T00:27:54.194Z,1755131274.194 [Default:CheckIn] Stopped
2025-08-14T00:27:54.194Z,1755131274.194 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-14T00:27:54.194Z,1755131274.194 [Default:CheckIn:C.Wait] Stopped
2025-08-14T00:27:54.194Z,1755131274.194 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-08-14T00:27:54.197Z,1755131274.197 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-08-14T00:27:54.198Z,1755131274.198 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-08-14T00:27:54.198Z,1755131274.198 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-08-14T00:27:54.198Z,1755131274.198 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-08-14T00:27:54.199Z,1755131274.199 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-08-14T00:27:54.199Z,1755131274.199 [BuoyancyServo](INFO): Powering down
2025-08-14T00:27:54.212Z,1755131274.212 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-08-14T00:27:54.212Z,1755131274.212 [ElevatorServo](INFO): Powering down
2025-08-14T00:27:54.213Z,1755131274.213 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-08-14T00:27:54.213Z,1755131274.213 [MassServo](INFO): Powering down
2025-08-14T00:27:54.214Z,1755131274.214 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-08-14T00:27:54.214Z,1755131274.214 [RudderServo](INFO): Powering down
2025-08-14T00:27:54.215Z,1755131274.215 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-08-14T00:27:54.215Z,1755131274.215 [ThrusterHE](INFO): Powering down
2025-08-14T00:27:54.216Z,1755131274.216 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-08-14T00:27:54.216Z,1755131274.216 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-08-14T00:27:54.216Z,1755131274.216 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-08-14T00:27:54.216Z,1755131274.216 [CBIT](DEBUG): Powering off loads.
2025-08-14T00:27:54.228Z,1755131274.228 [CBIT](DEBUG): Disabling WDT.
2025-08-14T00:27:54.240Z,1755131274.240 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-08-14T00:27:54.240Z,1755131274.240 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-08-14T00:27:54.241Z,1755131274.241 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.271Z,1755131274.271 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-08-14T00:27:54.271Z,1755131274.271 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-08-14T00:27:54.286Z,1755131274.286 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.293Z,1755131274.293 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.326Z,1755131274.326 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.329Z,1755131274.329 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.337Z,1755131274.337 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.343Z,1755131274.343 [DAT ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.385Z,1755131274.385 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.443Z,1755131274.443 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-08-14T00:27:54.519Z,1755131274.519 [logger ThreadHandler](INFO): Thread cancelled.