2025-04-11T20:17:46.432Z,1744402666.432 [Supervisor](DEBUG): Initializing supervisor. 2025-04-11T20:17:46.436Z,1744402666.436 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-04-11T20:17:46.437Z,1744402666.437 [SyncHandler](INFO): Protected caller Thread ID is 839 2025-04-11T20:17:46.437Z,1744402666.437 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-04-11T20:17:46.438Z,1744402666.438 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-04-11T20:17:46.438Z,1744402666.438 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840 2025-04-11T20:17:46.442Z,1744402666.442 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-04-11T20:17:46.460Z,1744402666.460 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-04-11T20:17:46.461Z,1744402666.461 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-04-11T20:17:46.461Z,1744402666.461 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841 2025-04-11T20:17:46.466Z,1744402666.466 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-04-11T20:17:46.466Z,1744402666.466 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-04-11T20:17:46.467Z,1744402666.467 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842 2025-04-11T20:17:46.469Z,1744402666.469 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-04-11T20:17:46.470Z,1744402666.470 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-04-11T20:17:46.470Z,1744402666.470 [logger ThreadHandler](INFO): Protected caller Thread ID is 843 2025-04-11T20:17:46.474Z,1744402666.474 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-04-11T20:17:46.474Z,1744402666.474 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-04-11T20:17:46.479Z,1744402666.479 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-04-11T20:17:46.586Z,1744402666.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-04-11T20:17:46.588Z,1744402666.588 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-04-11T20:17:47.464Z,1744402667.464 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-04-11T20:17:47.466Z,1744402667.466 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-04-11T20:17:47.703Z,1744402667.703 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-04-11T20:17:47.705Z,1744402667.705 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-04-11T20:17:47.795Z,1744402667.795 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-04-11T20:17:47.934Z,1744402667.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-04-11T20:17:47.936Z,1744402667.936 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-04-11T20:17:48.027Z,1744402668.027 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-04-11T20:17:48.144Z,1744402668.144 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-04-11T20:17:48.145Z,1744402668.145 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-04-11T20:17:48.550Z,1744402668.550 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-04-11T20:17:48.552Z,1744402668.552 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-04-11T20:17:49.087Z,1744402669.087 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-04-11T20:17:49.089Z,1744402669.089 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-04-11T20:17:49.315Z,1744402669.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-04-11T20:17:49.317Z,1744402669.317 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-04-11T20:17:49.531Z,1744402669.531 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-04-11T20:17:49.531Z,1744402669.531 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-04-11T20:17:50.551Z,1744402670.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-04-11T20:17:50.553Z,1744402670.553 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-04-11T20:17:50.856Z,1744402670.856 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-04-11T20:17:50.857Z,1744402670.857 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-04-11T20:17:51.099Z,1744402671.099 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-04-11T20:17:51.099Z,1744402671.099 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-04-11T20:17:51.483Z,1744402671.483 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-04-11T20:17:51.485Z,1744402671.485 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-04-11T20:17:51.841Z,1744402671.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-04-11T20:17:51.843Z,1744402671.843 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2025-04-11T20:17:51.845Z,1744402671.845 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2025-04-11T20:17:51.938Z,1744402671.938 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2025-04-11T20:17:52.114Z,1744402672.114 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2025-04-11T20:17:52.229Z,1744402672.229 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2025-04-11T20:17:52.333Z,1744402672.333 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2025-04-11T20:17:52.449Z,1744402672.449 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2025-04-11T20:17:52.544Z,1744402672.544 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2025-04-11T20:17:52.649Z,1744402672.649 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2025-04-11T20:17:52.769Z,1744402672.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2025-04-11T20:17:53.043Z,1744402673.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-04-11T20:17:53.043Z,1744402673.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2025-04-11T20:17:53.138Z,1744402673.138 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2025-04-11T20:17:53.241Z,1744402673.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2025-04-11T20:17:53.392Z,1744402673.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2025-04-11T20:17:53.502Z,1744402673.502 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2025-04-11T20:17:53.503Z,1744402673.503 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-04-11T20:17:53.518Z,1744402673.518 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-04-11T20:17:53.689Z,1744402673.689 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-04-11T20:17:53.690Z,1744402673.690 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-04-11T20:17:53.761Z,1744402673.761 [VerticalControl](DEBUG): Construct VerticalControl. 2025-04-11T20:17:53.821Z,1744402673.821 [VerticalControl] Loaded 2025-04-11T20:17:53.821Z,1744402673.821 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-04-11T20:17:53.824Z,1744402673.824 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-04-11T20:17:53.873Z,1744402673.873 [HorizontalControl] Loaded 2025-04-11T20:17:53.873Z,1744402673.873 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-04-11T20:17:53.875Z,1744402673.875 [SpeedControl](DEBUG): Construct SpeedControl. 2025-04-11T20:17:53.878Z,1744402673.878 [SpeedControl] Loaded 2025-04-11T20:17:53.878Z,1744402673.878 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-04-11T20:17:53.881Z,1744402673.881 [LoopControl](DEBUG): Construct LoopControl. 2025-04-11T20:17:53.882Z,1744402673.882 [LoopControl] Loaded 2025-04-11T20:17:53.882Z,1744402673.882 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-04-11T20:17:53.882Z,1744402673.882 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-04-11T20:17:53.883Z,1744402673.883 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-04-11T20:17:53.955Z,1744402673.955 [DepthRateCalculator] Loaded 2025-04-11T20:17:53.955Z,1744402673.955 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-04-11T20:17:53.960Z,1744402673.960 [PitchRateCalculator] Loaded 2025-04-11T20:17:53.960Z,1744402673.960 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-04-11T20:17:53.971Z,1744402673.971 [SpeedCalculator] Loaded 2025-04-11T20:17:53.971Z,1744402673.971 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-04-11T20:17:53.975Z,1744402673.975 [YawRateCalculator] Loaded 2025-04-11T20:17:53.975Z,1744402673.975 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-04-11T20:17:53.994Z,1744402673.994 [ElevatorOffsetCalculator] Loaded 2025-04-11T20:17:53.994Z,1744402673.994 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-04-11T20:17:53.995Z,1744402673.995 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-04-11T20:17:53.996Z,1744402673.996 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-04-11T20:17:54.039Z,1744402674.039 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-04-11T20:17:54.041Z,1744402674.041 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-04-11T20:17:54.126Z,1744402674.126 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-04-11T20:17:54.127Z,1744402674.127 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-04-11T20:17:54.537Z,1744402674.537 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-04-11T20:17:54.537Z,1744402674.537 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-04-11T20:17:55.098Z,1744402675.098 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-04-11T20:17:55.098Z,1744402675.098 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-04-11T20:17:55.979Z,1744402675.979 [AHRS_M2] Loaded 2025-04-11T20:17:55.979Z,1744402675.979 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-04-11T20:17:56.232Z,1744402676.232 [BackseatComponent] Loaded 2025-04-11T20:17:56.232Z,1744402676.232 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-04-11T20:17:56.233Z,1744402676.233 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409E24E0 2025-04-11T20:17:56.233Z,1744402676.233 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 933 2025-04-11T20:17:56.236Z,1744402676.236 [LcmUniversalReporter] Loaded 2025-04-11T20:17:56.236Z,1744402676.236 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-04-11T20:17:57.058Z,1744402677.058 [BPC1] Loaded 2025-04-11T20:17:57.058Z,1744402677.058 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-04-11T20:17:57.154Z,1744402677.154 [DAT] Loaded 2025-04-11T20:17:57.155Z,1744402677.155 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-04-11T20:17:57.156Z,1744402677.156 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A124E0 2025-04-11T20:17:57.156Z,1744402677.156 [DAT ThreadHandler](INFO): Protected caller Thread ID is 934 2025-04-11T20:17:57.299Z,1744402677.299 [DataOverHttps] Loaded 2025-04-11T20:17:57.300Z,1744402677.300 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-04-11T20:17:57.301Z,1744402677.301 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A424E0 2025-04-11T20:17:57.301Z,1744402677.301 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 935 2025-04-11T20:17:57.324Z,1744402677.324 [Depth_Keller] Loaded 2025-04-11T20:17:57.325Z,1744402677.325 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-04-11T20:17:57.330Z,1744402677.330 [DropWeight] Loaded 2025-04-11T20:17:57.330Z,1744402677.330 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-04-11T20:17:57.395Z,1744402677.395 [NAL9602] Loaded 2025-04-11T20:17:57.396Z,1744402677.396 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-04-11T20:17:57.425Z,1744402677.425 [Onboard] Loaded 2025-04-11T20:17:57.425Z,1744402677.425 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-04-11T20:17:57.426Z,1744402677.426 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A724E0 2025-04-11T20:17:57.427Z,1744402677.427 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 936 2025-04-11T20:17:57.441Z,1744402677.441 [Power24vConverter] Loaded 2025-04-11T20:17:57.441Z,1744402677.441 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-04-11T20:17:57.457Z,1744402677.457 [Radio_Surface] Loaded 2025-04-11T20:17:57.457Z,1744402677.457 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-04-11T20:17:57.458Z,1744402677.458 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AA24E0 2025-04-11T20:17:57.459Z,1744402677.459 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 937 2025-04-11T20:17:57.506Z,1744402677.506 [RDI_Pathfinder] Loaded 2025-04-11T20:17:57.506Z,1744402677.506 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2025-04-11T20:17:57.521Z,1744402677.521 [Sonardyne_Nano] Loaded 2025-04-11T20:17:57.521Z,1744402677.521 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-04-11T20:17:57.585Z,1744402677.585 [TrnDataBridge] Loaded 2025-04-11T20:17:57.585Z,1744402677.585 [ComponentRegistry](DEBUG): Component "TrnDataBridge" handled in its own thread. 2025-04-11T20:17:57.586Z,1744402677.586 [TrnDataBridge ThreadHandler](DEBUG): Created PCaller Thread at 40AD24E0 2025-04-11T20:17:57.587Z,1744402677.587 [TrnDataBridge ThreadHandler](INFO): Protected caller Thread ID is 938 2025-04-11T20:17:57.587Z,1744402677.587 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-04-11T20:17:57.588Z,1744402677.588 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-04-11T20:17:57.721Z,1744402677.721 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-04-11T20:17:57.722Z,1744402677.722 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-04-11T20:17:57.736Z,1744402677.736 [NavChart] Loaded 2025-04-11T20:17:57.736Z,1744402677.736 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-04-11T20:17:57.742Z,1744402677.742 [UniversalFixResidualReporter] Loaded 2025-04-11T20:17:57.742Z,1744402677.742 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-04-11T20:17:57.743Z,1744402677.743 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-04-11T20:17:57.745Z,1744402677.745 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-04-11T20:17:57.915Z,1744402677.915 [SBIT](DEBUG): Construct Startup Built In Test. 2025-04-11T20:17:57.924Z,1744402677.924 [SBIT] Loaded 2025-04-11T20:17:57.925Z,1744402677.925 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-04-11T20:17:57.927Z,1744402677.927 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-04-11T20:17:57.941Z,1744402677.941 [IBIT] Loaded 2025-04-11T20:17:57.941Z,1744402677.941 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-04-11T20:17:57.947Z,1744402677.947 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-04-11T20:17:58.052Z,1744402678.052 [CBIT] Loaded 2025-04-11T20:17:58.053Z,1744402678.053 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-04-11T20:17:58.053Z,1744402678.053 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-04-11T20:17:58.054Z,1744402678.054 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-04-11T20:17:58.217Z,1744402678.217 [BuoyancyServo] Loaded 2025-04-11T20:17:58.217Z,1744402678.217 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-04-11T20:17:58.241Z,1744402678.241 [ElevatorServo] Loaded 2025-04-11T20:17:58.241Z,1744402678.241 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-04-11T20:17:58.272Z,1744402678.272 [DockingStepper] Loaded 2025-04-11T20:17:58.273Z,1744402678.273 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2025-04-11T20:17:58.295Z,1744402678.295 [MassServo] Loaded 2025-04-11T20:17:58.295Z,1744402678.295 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-04-11T20:17:58.316Z,1744402678.316 [RudderServo] Loaded 2025-04-11T20:17:58.316Z,1744402678.316 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-04-11T20:17:58.336Z,1744402678.336 [ThrusterServo] Loaded 2025-04-11T20:17:58.336Z,1744402678.336 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2025-04-11T20:17:58.337Z,1744402678.337 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-04-11T20:17:58.338Z,1744402678.338 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-04-11T20:17:58.353Z,1744402678.353 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-04-11T20:17:58.354Z,1744402678.354 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-04-11T20:17:58.580Z,1744402678.580 [CTD_Seabird] Loaded 2025-04-11T20:17:58.581Z,1744402678.581 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-04-11T20:17:58.582Z,1744402678.582 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C1F4E0 2025-04-11T20:17:58.582Z,1744402678.582 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 939 2025-04-11T20:17:58.605Z,1744402678.605 [PAR_Licor] Loaded 2025-04-11T20:17:58.605Z,1744402678.605 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-04-11T20:17:58.651Z,1744402678.651 [WetLabsBB2FL] Loaded 2025-04-11T20:17:58.651Z,1744402678.651 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-04-11T20:17:58.652Z,1744402678.652 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C4F4E0 2025-04-11T20:17:58.653Z,1744402678.653 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 940 2025-04-11T20:17:58.674Z,1744402678.674 [WetLabsUBAT] Loaded 2025-04-11T20:17:58.674Z,1744402678.674 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2025-04-11T20:17:58.675Z,1744402678.675 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C7F4E0 2025-04-11T20:17:58.676Z,1744402678.676 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 941 2025-04-11T20:17:58.676Z,1744402678.676 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-04-11T20:17:58.683Z,1744402678.683 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-04-11T20:17:58.686Z,1744402678.686 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-04-11T20:17:58.697Z,1744402678.697 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-04-11T20:17:58.698Z,1744402678.698 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40CAF4E0 2025-04-11T20:17:58.699Z,1744402678.699 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 942 2025-04-11T20:17:58.703Z,1744402678.703 [Supervisor](INFO): Main Thread ID is 830 2025-04-11T20:17:58.703Z,1744402678.703 [Supervisor](DEBUG): Running supervisor. 2025-04-11T20:17:58.704Z,1744402678.704 [CommandExec ThreadHandler](INFO): Handler Thread ID is 943 2025-04-11T20:17:58.704Z,1744402678.704 [CommandExec](INFO): Initializing the command executive. 2025-04-11T20:17:58.706Z,1744402678.706 [CommandLine ThreadHandler](INFO): Handler Thread ID is 944 2025-04-11T20:17:58.708Z,1744402678.708 [controlThread ThreadHandler](INFO): Handler Thread ID is 945 2025-04-11T20:17:58.708Z,1744402678.708 [controlThread](DEBUG): Initializing ControlThread 2025-04-11T20:17:58.709Z,1744402678.709 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-04-11T20:17:58.711Z,1744402678.711 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-04-11T20:17:58.712Z,1744402678.712 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-04-11T20:17:58.712Z,1744402678.712 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-04-11T20:17:58.712Z,1744402678.712 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-04-11T20:17:58.713Z,1744402678.713 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-04-11T20:17:58.713Z,1744402678.713 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-04-11T20:17:58.714Z,1744402678.714 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-04-11T20:17:58.714Z,1744402678.714 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-04-11T20:17:58.718Z,1744402678.718 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-04-11T20:17:58.719Z,1744402678.719 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-04-11T20:17:58.719Z,1744402678.719 [SBIT](INFO): Initialize SBIT Component. 2025-04-11T20:17:58.720Z,1744402678.720 [SBIT](IMPORTANT): git: 2025-01-23 2025-04-11T20:17:58.720Z,1744402678.720 [SBIT](INFO): git hash: e941ed7ca4296489cfe1bf7015177657c0080d4b 2025-04-11T20:17:58.720Z,1744402678.720 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-04-11T20:17:58.721Z,1744402678.721 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-04-11T20:17:58.722Z,1744402678.722 [SBIT](INFO): Beginning SBIT in 101.000000 seconds. 2025-04-11T20:17:58.723Z,1744402678.723 [IBIT](INFO): Initialize IBIT Component. 2025-04-11T20:17:58.724Z,1744402678.724 [CBIT](DEBUG): Initialize CBIT Component. 2025-04-11T20:17:58.725Z,1744402678.725 [logger ThreadHandler](INFO): Handler Thread ID is 946 2025-04-11T20:17:58.736Z,1744402678.736 [CBIT](DEBUG): Initialized mux pins. 2025-04-11T20:17:58.736Z,1744402678.736 [CBIT](DEBUG): Initializing the watchdog timer. 2025-04-11T20:17:58.744Z,1744402678.744 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 947 2025-04-11T20:17:58.756Z,1744402678.756 [DAT ThreadHandler](INFO): Handler Thread ID is 948 2025-04-11T20:17:58.757Z,1744402678.757 [DAT](INFO): Powering up 2025-04-11T20:17:58.757Z,1744402678.757 [DAT](DEBUG): Initializing DAT. 2025-04-11T20:17:58.760Z,1744402678.760 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-04-11T20:17:58.760Z,1744402678.760 [CBIT](DEBUG): Initializing heartbeat. 2025-04-11T20:17:58.762Z,1744402678.762 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 950 2025-04-11T20:17:58.764Z,1744402678.764 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-04-11T20:17:58.772Z,1744402678.772 [Onboard ThreadHandler](INFO): Handler Thread ID is 951 2025-04-11T20:17:58.803Z,1744402678.803 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 952 2025-04-11T20:17:58.820Z,1744402678.820 [TrnDataBridge ThreadHandler](INFO): Handler Thread ID is 953 2025-04-11T20:17:58.821Z,1744402678.821 [TrnDataBridge](INFO): Start 2025-04-11T20:17:58.821Z,1744402678.821 [TrnDataBridge](IMPORTANT): LCM Instance1 2025-04-11T20:17:58.832Z,1744402678.832 [CBIT](DEBUG): Deactivating GF circuits. 2025-04-11T20:17:58.832Z,1744402678.832 [CBIT](DEBUG): Deactivating emergency mode. 2025-04-11T20:17:58.848Z,1744402678.848 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 955 2025-04-11T20:17:58.856Z,1744402678.856 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-11T20:17:58.872Z,1744402678.872 [CBIT](DEBUG): Backplane powered. 2025-04-11T20:17:58.900Z,1744402678.900 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-04-11T20:17:58.901Z,1744402678.901 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2025-04-11T20:17:58.901Z,1744402678.901 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2025-04-11T20:17:58.902Z,1744402678.902 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 957 2025-04-11T20:17:58.907Z,1744402678.907 [WetLabsBB2FL](INFO): Powering up 2025-04-11T20:17:58.913Z,1744402678.913 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2025-04-11T20:17:58.928Z,1744402678.928 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2025-04-11T20:17:58.929Z,1744402678.929 [MissionManager](ERROR): Top node has no child nodes: Mission 2025-04-11T20:17:58.929Z,1744402678.929 [MissionManager](ERROR): Could not load startup mission. 2025-04-11T20:17:58.929Z,1744402678.929 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl 2025-04-11T20:17:58.930Z,1744402678.930 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl 2025-04-11T20:17:58.931Z,1744402678.931 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 959 2025-04-11T20:17:58.933Z,1744402678.933 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl 2025-04-11T20:17:58.936Z,1744402678.936 [WetLabsUBAT](INFO): Powering up 2025-04-11T20:17:58.956Z,1744402678.956 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 961 2025-04-11T20:17:58.966Z,1744402678.966 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-04-11T20:17:58.966Z,1744402678.966 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-04-11T20:17:58.966Z,1744402678.966 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-04-11T20:17:58.966Z,1744402678.966 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-04-11T20:17:58.966Z,1744402678.966 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-04-11T20:17:58.967Z,1744402678.967 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-04-11T20:17:58.967Z,1744402678.967 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-04-11T20:17:58.967Z,1744402678.967 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-04-11T20:17:59.204Z,1744402679.204 [Radio_Surface](INFO): Powering up 2025-04-11T20:17:59.522Z,1744402679.522 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into: 0 6 10 1 3 30 Timed out while trying to detach from dock at current depth of . Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-04-11T20:17:59.549Z,1744402679.549 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min 2025-04-11T20:17:59.569Z,1744402679.569 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h 2025-04-11T20:17:59.573Z,1744402679.573 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count 2025-04-11T20:17:59.593Z,1744402679.593 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s 2025-04-11T20:17:59.597Z,1744402679.597 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count 2025-04-11T20:17:59.605Z,1744402679.605 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min 2025-04-11T20:17:59.607Z,1744402679.607 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait. 2025-04-11T20:17:59.757Z,1744402679.757 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct. 2025-04-11T20:17:59.757Z,1744402679.757 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2025-04-11T20:17:59.826Z,1744402679.826 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-11T20:17:59.847Z,1744402679.847 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-04-11T20:17:59.869Z,1744402679.869 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-04-11T20:17:59.875Z,1744402679.875 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute. 2025-04-11T20:17:59.896Z,1744402679.896 [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 DefaultWithUndock { arguments { ElapsedSinceDefaultStarted = 0 minute DetachTimeout = 6 hour """ Maximum time duration for the vehicle to detach form the dock. """ TransponderCode = Dock:Dock.transponderCode """ Dock transponder address. """ TrackingUpdatePeriod = 10 second """ Time duration between acoustic range queries while the mission is detaching from the dock. """ NumberOfPings = 1 count """ Number of pings requested each time. """ DriftTimeout = 3 minute """ How long to allow vehicle to drift away from dock before retrying reverse """ } 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 = 30 second } aggregate LeaveDock { run in sequence timeout duration=DetachTimeout { syslog important "Timed out while trying to detach from dock at current depth of " + Universal:depth~meter + "." } # Acoustic tracking directives behavior Estimation:TrackAcousticContact { run while ( Universal:depth > Control:VerticalControl.surfaceThreshold ) set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } # Leave the dock behavior Dock:Undock { run in sequence set driftTimeout = DriftTimeout } } aggregate SurfaceDefault { run in sequence # This mission assumes open water so from here on it's the same old default that's always used 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=P2H { 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-04-11T20:17:59.908Z,1744402679.908 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2025-04-11T20:17:59.916Z,1744402679.916 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-11T20:18:00.061Z,1744402680.061 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2025-04-11T20:18:00.062Z,1744402680.062 [Power24vConverter](INFO): Powering up. 2025-04-11T20:18:00.063Z,1744402680.063 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2025-04-11T20:18:00.077Z,1744402680.077 [Sonardyne_Nano](INFO): Initializing. 2025-04-11T20:18:00.104Z,1744402680.104 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-11T20:18:00.118Z,1744402680.118 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-04-11T20:18:00.124Z,1744402680.124 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-04-11T20:18:00.125Z,1744402680.125 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-04-11T20:18:00.133Z,1744402680.133 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-04-11T20:18:00.133Z,1744402680.133 [DockingStepper](INFO): Start 2025-04-11T20:18:00.134Z,1744402680.134 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-04-11T20:18:00.144Z,1744402680.144 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-04-11T20:18:00.145Z,1744402680.145 [MassServo](DEBUG): Initializing EZServoServo. 2025-04-11T20:18:00.152Z,1744402680.152 [MassServo](DEBUG): Initializing MassServo. 2025-04-11T20:18:00.153Z,1744402680.153 [RudderServo](DEBUG): Initializing EZServoServo. 2025-04-11T20:18:00.161Z,1744402680.161 [RudderServo](DEBUG): Initializing RudderServo. 2025-04-11T20:18:00.162Z,1744402680.162 [ThrusterServo](DEBUG): Initializing EZServoServo. 2025-04-11T20:18:00.168Z,1744402680.168 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2025-04-11T20:18:00.360Z,1744402680.360 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-04-11T20:18:00.360Z,1744402680.360 [DropWeight] Hardware Fault, FailCount= 1 2025-04-11T20:18:00.360Z,1744402680.360 [DropWeight](ERROR): Hardware Fault 2025-04-11T20:18:00.387Z,1744402680.387 [DockingStepper](INFO): Starting 2025-04-11T20:18:00.397Z,1744402680.397 [CommandExec](FAULT): Scheduling is paused 2025-04-11T20:18:00.397Z,1744402680.397 [CBIT](INFO): Critical error at 20250411T201800 2025-04-11T20:18:00.398Z,1744402680.398 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-04-11T20:18:00.408Z,1744402680.408 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-04-11T20:18:00.409Z,1744402680.409 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-04-11T20:18:00.743Z,1744402680.743 [DockingStepper](INFO): Starting 2025-04-11T20:18:00.753Z,1744402680.753 [CBIT](INFO): Critical error at 20250411T201800 2025-04-11T20:18:01.269Z,1744402681.269 [DockingStepper](INFO): Starting 2025-04-11T20:18:01.321Z,1744402681.321 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2025-04-11T20:18:01.544Z,1744402681.544 [WetLabsBB2FL](INFO): Powering down 2025-04-11T20:18:01.551Z,1744402681.551 [DockingStepper](INFO): Starting 2025-04-11T20:18:01.970Z,1744402681.970 [DockingStepper](INFO): Starting 2025-04-11T20:18:02.342Z,1744402682.342 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-04-11T20:18:02.404Z,1744402682.404 [DockingStepper](INFO): Starting 2025-04-11T20:18:02.816Z,1744402682.816 [DockingStepper](INFO): Starting 2025-04-11T20:18:02.841Z,1744402682.841 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-04-11T20:18:03.249Z,1744402683.249 [DockingStepper](INFO): Starting 2025-04-11T20:18:03.596Z,1744402683.596 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2025-04-11T20:18:04.013Z,1744402684.013 [DockingStepper](INFO): Pause 2025-04-11T20:18:04.457Z,1744402684.457 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2025-04-11T20:18:04.457Z,1744402684.457 [Radio_Surface](INFO): No local IP found 2025-04-11T20:18:08.240Z,1744402688.240 [WetLabsUBAT](INFO): Powering down 2025-04-11T20:18:09.020Z,1744402689.020 [CBIT](CRITICAL): Environmental Failure. Press:14.441754 PSI. Humidity:42%. Temp:24 C. ABORTING MISSION 2025-04-11T20:18:09.362Z,1744402689.362 [CBIT](INFO): Critical error at 20250411T201809 2025-04-11T20:18:13.120Z,1744402693.120 [DAT](INFO): DAT read: 2025-04-11T20:18:13.122Z,1744402693.122 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-11T20:18:22.193Z,1744402702.193 [DAT](INFO): DAT read: MF Frequency Band 2025-04-11T20:18:22.194Z,1744402702.194 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2025-04-11T20:18:22.194Z,1744402702.194 [DAT](INFO): DAT read: Apr 11 2025 20:15:55 2025-04-11T20:18:23.203Z,1744402703.203 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-11T20:18:23.453Z,1744402703.453 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2025-04-11T20:18:23.454Z,1744402703.454 [DAT](INFO): commRate: 600 2025-04-11T20:18:25.520Z,1744402705.520 [DAT](INFO): entering command mode 2025-04-11T20:18:25.720Z,1744402705.720 [DAT](INFO): DAT read: 2025-04-11T20:18:25.721Z,1744402705.721 [DAT](INFO): DAT read: user:1> 2025-04-11T20:18:25.721Z,1744402705.721 [DAT](INFO): setting verbose to 3 2025-04-11T20:18:25.973Z,1744402705.973 [DAT](INFO): DAT read: user:1> 2025-04-11T20:18:25.974Z,1744402705.974 [DAT](INFO): DAT read: Verbose | 3 2025-04-11T20:18:25.975Z,1744402705.975 [DAT](INFO): set verbose to 3 2025-04-11T20:18:25.975Z,1744402705.975 [DAT](INFO): setting DatVerbose to 27440 2025-04-11T20:18:26.225Z,1744402706.225 [DAT](INFO): DAT read: user:2> 2025-04-11T20:18:26.225Z,1744402706.225 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-11T20:18:26.226Z,1744402706.226 [DAT](INFO): set DatVerbose to 27440 2025-04-11T20:18:26.226Z,1744402706.226 [DAT](INFO): setting transmit power to 8 2025-04-11T20:18:26.477Z,1744402706.477 [DAT](INFO): DAT read: user:3> 2025-04-11T20:18:26.477Z,1744402706.477 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-11T20:18:26.478Z,1744402706.478 [DAT](INFO): set transmit power to 8 2025-04-11T20:18:26.478Z,1744402706.478 [DAT](INFO): setting local address to 10 2025-04-11T20:18:26.729Z,1744402706.729 [DAT](INFO): DAT read: user:4> 2025-04-11T20:18:26.730Z,1744402706.730 [DAT](INFO): DAT read: LocalAddr | 10 2025-04-11T20:18:26.731Z,1744402706.731 [DAT](INFO): set local address to 10 2025-04-11T20:18:26.760Z,1744402706.760 [DAT](INFO): Setting time to: 20:18:26 And date to:4/11/2025 2025-04-11T20:18:26.981Z,1744402706.981 [DAT](INFO): DAT read: user:5> 2025-04-11T20:18:26.981Z,1744402706.981 [DAT](INFO): DAT read: Fri Apr 11, 2025 20:18:26 2025-04-11T20:18:26.982Z,1744402706.982 [DAT](INFO): Local DAT time set to Fri Apr 11, 2025 20:18:26 2025-04-11T20:18:27.477Z,1744402707.477 [NAL9602](INFO): Powering up NAL9602 2025-04-11T20:18:38.385Z,1744402718.385 [NAL9602](INFO): NAL9602 initialized 2025-04-11T20:19:20.819Z,1744402760.819 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-11T20:19:40.246Z,1744402780.246 [SBIT](IMPORTANT): Beginning Startup BIT 2025-04-11T20:19:40.250Z,1744402780.250 [CBIT](IMPORTANT): Beginning ground fault scan 2025-04-11T20:19:51.740Z,1744402791.740 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010661 CHAN A1 (24V): -0.029538 CHAN A2 (12V): -0.007398 CHAN A3 (5V): -0.002252 CHAN B0 (3.3V): -0.000472 CHAN B1 (3.15aV): 0.000093 CHAN B2 (3.15bV): 0.000602 CHAN B3 (GND): 0.001716 OPEN: -0.003714 Full Scale: +/- 1 mA 2025-04-11T20:20:33.668Z,1744402833.668 [SBIT](IMPORTANT): SBIT PASSED 2025-04-11T20:20:33.669Z,1744402833.669 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-04-11T20:20:33.671Z,1744402833.671 [SBIT](IMPORTANT): CBIT.gf24Offset=173 microampere; 2025-04-11T20:20:33.671Z,1744402833.671 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-04-11T20:20:33.676Z,1744402833.676 [SBIT](IMPORTANT): DAT.convertPhaseDataToDirection=0 bool; 2025-04-11T20:20:33.677Z,1744402833.677 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count; 2025-04-11T20:20:33.677Z,1744402833.677 [SBIT](IMPORTANT): DockingStepper.slideValue=10700 count; 2025-04-11T20:20:33.678Z,1744402833.678 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2025-04-11T20:20:33.678Z,1744402833.678 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2025-04-11T20:20:33.679Z,1744402833.679 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree; 2025-04-11T20:20:33.679Z,1744402833.679 [SBIT](IMPORTANT): TrnDataBridge.loadAtStartup=1 bool; 2025-04-11T20:20:33.679Z,1744402833.679 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=460.577328 cubic_centimeter; 2025-04-11T20:20:33.684Z,1744402833.684 [SBIT](IMPORTANT): VerticalControl.massDefault=20.377216 millimeter; 2025-04-11T20:20:34.046Z,1744402834.046 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2025-04-11T20:20:34.046Z,1744402834.046 [DefaultWithUndock] Running Loop=1 2025-04-11T20:20:34.046Z,1744402834.046 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2025-04-11T20:20:34.046Z,1744402834.046 [DefaultWithUndock:A.Wait] Running Loop=1 2025-04-11T20:20:34.046Z,1744402834.046 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2025-04-11T20:20:49.918Z,1744402849.918 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004399 2025-04-11T20:20:50.916Z,1744402850.916 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:20:58.949Z,1744402858.949 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-04-11T20:20:58.949Z,1744402858.949 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-11T20:20:58.959Z,1744402858.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-11T20:20:59.362Z,1744402859.362 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-11T20:20:59.362Z,1744402859.362 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-04-11T20:21:00.523Z,1744402860.523 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:A.Wait] Stopped 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:LeaveDock] Running Loop=1 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2025-04-11T20:21:04.190Z,1744402864.190 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2025-04-11T20:21:04.191Z,1744402864.191 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2025-04-11T20:21:04.191Z,1744402864.191 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2025-04-11T20:21:04.191Z,1744402864.191 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2025-04-11T20:21:04.606Z,1744402864.606 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2025-04-11T20:21:04.606Z,1744402864.606 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2025-04-11T20:21:04.607Z,1744402864.607 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth -0.213378 m. 2025-04-11T20:21:04.608Z,1744402864.608 [DefaultWithUndock:LeaveDock:A.] Stopped 2025-04-11T20:21:04.608Z,1744402864.608 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact. 2025-04-11T20:21:04.617Z,1744402864.617 [DockingStepper](INFO): Resume 2025-04-11T20:21:05.072Z,1744402865.072 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2025-04-11T20:21:05.093Z,1744402865.093 [DockingStepper](INFO): Resuming 2025-04-11T20:21:05.408Z,1744402865.408 [DockingStepper](INFO): Start 2025-04-11T20:21:05.408Z,1744402865.408 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-04-11T20:21:05.526Z,1744402865.526 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-04-11T20:21:05.824Z,1744402865.824 [DockingStepper](INFO): Starting 2025-04-11T20:21:06.211Z,1744402866.211 [DockingStepper](INFO): Starting 2025-04-11T20:21:06.731Z,1744402866.731 [DockingStepper](INFO): Starting 2025-04-11T20:21:06.785Z,1744402866.785 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2025-04-11T20:21:07.069Z,1744402867.069 [DockingStepper](INFO): Starting 2025-04-11T20:21:07.437Z,1744402867.437 [DockingStepper](INFO): Starting 2025-04-11T20:21:07.945Z,1744402867.945 [DockingStepper](INFO): Starting 2025-04-11T20:21:08.249Z,1744402868.249 [DockingStepper](INFO): Starting 2025-04-11T20:21:08.277Z,1744402868.277 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-04-11T20:21:08.650Z,1744402868.650 [DockingStepper](INFO): Starting 2025-04-11T20:21:09.106Z,1744402869.106 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:16.691Z,1744402876.691 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:25.193Z,1744402885.193 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby. 2025-04-11T20:21:25.449Z,1744402885.449 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:25.610Z,1744402885.610 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby. 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:LeaveDock] Stopped 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1 2025-04-11T20:21:26.007Z,1744402886.007 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-11T20:21:26.008Z,1744402886.008 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-11T20:21:26.009Z,1744402886.009 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-11T20:21:26.009Z,1744402886.009 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-11T20:21:26.009Z,1744402886.009 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-11T20:21:26.010Z,1744402886.010 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-11T20:21:26.010Z,1744402886.010 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-11T20:21:26.420Z,1744402886.420 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2025-04-11T20:21:26.420Z,1744402886.420 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2025-04-11T20:21:26.420Z,1744402886.420 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2025-04-11T20:21:26.561Z,1744402886.561 [DockingStepper](INFO): Pause 2025-04-11T20:21:26.827Z,1744402886.827 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-11T20:21:34.133Z,1744402894.133 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:42.609Z,1744402902.609 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:51.129Z,1744402911.129 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:21:59.613Z,1744402919.613 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:08.117Z,1744402928.117 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:16.589Z,1744402936.589 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:25.015Z,1744402945.015 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:33.393Z,1744402953.393 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:42.053Z,1744402962.053 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:51.289Z,1744402971.289 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:22:51.523Z,1744402971.523 [CommandExec](IMPORTANT): got command get Dock.dock_cable_present 2025-04-11T20:22:51.524Z,1744402971.524 [CommandExec](IMPORTANT): Dock.dock_cable_present 1 bool 2025-04-11T20:22:59.765Z,1744402979.765 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:03.202Z,1744402983.202 [CommandExec](IMPORTANT): got command get Dock.dock_voltage_present 2025-04-11T20:23:03.203Z,1744402983.203 [CommandExec](IMPORTANT): Dock.dock_voltage_present 0 bool 2025-04-11T20:23:08.957Z,1744402988.957 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:14.038Z,1744402994.038 [CommandExec](IMPORTANT): got command docking standby 2025-04-11T20:23:14.038Z,1744402994.038 [CommandExec](IMPORTANT): Switching docking module to STANDBY. 2025-04-11T20:23:14.733Z,1744402994.733 [DockingStepper](INFO): Resume 2025-04-11T20:23:15.175Z,1744402995.175 [DockingStepper](INFO): Resuming 2025-04-11T20:23:15.483Z,1744402995.483 [DockingStepper](INFO): Start 2025-04-11T20:23:15.484Z,1744402995.484 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-04-11T20:23:15.597Z,1744402995.597 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-04-11T20:23:15.927Z,1744402995.927 [DockingStepper](INFO): Starting 2025-04-11T20:23:16.346Z,1744402996.346 [DockingStepper](INFO): Starting 2025-04-11T20:23:16.760Z,1744402996.760 [DockingStepper](INFO): Starting 2025-04-11T20:23:16.809Z,1744402996.809 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2025-04-11T20:23:17.146Z,1744402997.146 [DockingStepper](INFO): Starting 2025-04-11T20:23:17.433Z,1744402997.433 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:17.504Z,1744402997.504 [DockingStepper](INFO): Starting 2025-04-11T20:23:17.921Z,1744402997.921 [DockingStepper](INFO): Starting 2025-04-11T20:23:18.309Z,1744402998.309 [DockingStepper](INFO): Starting 2025-04-11T20:23:18.341Z,1744402998.341 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-04-11T20:23:18.757Z,1744402998.757 [DockingStepper](INFO): Starting 2025-04-11T20:23:19.142Z,1744402999.142 [DockingStepper](INFO): Changing to mode: 1 2025-04-11T20:23:19.143Z,1744402999.143 [DockingStepper](INFO): Standby mode. 2025-04-11T20:23:26.061Z,1744403006.061 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:27.113Z,1744403007.113 [CommandExec](IMPORTANT): got command report mod Dock.dock_voltage_present 2025-04-11T20:23:27.275Z,1744403007.275 [Reporter](INFO): Dock.dock_voltage_present 1 bool 2025-04-11T20:23:34.605Z,1744403014.605 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:42.134Z,1744403022.134 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-11T20:23:44.125Z,1744403024.125 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:45.901Z,1744403025.901 [CommandExec](IMPORTANT): got command get platform_battery_discharging 2025-04-11T20:23:45.901Z,1744403025.901 [CommandExec](IMPORTANT): platform_battery_discharging 0 bool 2025-04-11T20:23:52.730Z,1744403032.730 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:23:59.942Z,1744403039.942 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-04-11T20:23:59.942Z,1744403039.942 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-11T20:24:00.003Z,1744403040.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-11T20:24:00.413Z,1744403040.413 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-11T20:24:00.413Z,1744403040.413 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-04-11T20:24:01.249Z,1744403041.249 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:24:09.941Z,1744403049.941 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:24:18.569Z,1744403058.569 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:24:28.245Z,1744403068.245 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:24:36.789Z,1744403076.789 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:24:44.401Z,1744403084.401 [CommandExec](IMPORTANT): got command get platform_battery_voltage 2025-04-11T20:24:44.401Z,1744403084.401 [CommandExec](IMPORTANT): platform_battery_voltage 16.056000 V 2025-04-11T20:24:46.881Z,1744403086.881 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:24:55.635Z,1744403095.635 [CommandExec](IMPORTANT): got command get platform_battery_voltage 2025-04-11T20:24:55.635Z,1744403095.635 [CommandExec](IMPORTANT): platform_battery_voltage 16.056000 V 2025-04-11T20:24:56.405Z,1744403096.405 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:25:05.025Z,1744403105.025 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:25:13.525Z,1744403113.525 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:25:22.289Z,1744403122.289 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:25:30.901Z,1744403130.901 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:25:32.490Z,1744403132.490 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-11T20:25:39.406Z,1744403139.406 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:25:58.363Z,1744403158.363 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2025-04-11T20:26:02.003Z,1744403162.003 [Reporter](INFO): Dock.dock_voltage_present 1 bool 2025-04-11T20:26:10.533Z,1744403170.533 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:26:19.225Z,1744403179.225 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:26:26.622Z,1744403186.622 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-11T20:26:26.644Z,1744403186.644 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](INFO): Timed out from 2025-04-11T20:21:26.4Z 2025-04-11T20:26:26.644Z,1744403186.644 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2025-04-11T20:26:26.645Z,1744403186.645 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2025-04-11T20:26:27.020Z,1744403187.020 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-11T20:26:40.369Z,1744403200.369 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250411T162439/Courier0064.lzma 2025-04-11T20:26:41.370Z,1744403201.370 [DataOverHttps](INFO): Moved sent file to Logs/20250411T162439/Courier0064.lzma.bak 2025-04-11T20:26:41.371Z,1744403201.371 [DataOverHttps](INFO): SBD MOMSN=24618423 2025-04-11T20:26:59.402Z,1744403219.402 [DataOverHttps](INFO): Sending 355 bytes from file Logs/20250411T201559/Courier0000.lzma 2025-04-11T20:27:00.402Z,1744403220.402 [DataOverHttps](INFO): Moved sent file to Logs/20250411T201559/Courier0000.lzma.bak 2025-04-11T20:27:00.402Z,1744403220.402 [DataOverHttps](INFO): SBD MOMSN=24618425 2025-04-11T20:27:00.950Z,1744403220.950 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-04-11T20:27:00.950Z,1744403220.950 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-11T20:27:01.014Z,1744403221.014 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-11T20:27:01.403Z,1744403221.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-11T20:27:01.403Z,1744403221.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-04-11T20:27:06.649Z,1744403226.649 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-11T20:27:19.484Z,1744403239.484 [DataOverHttps](INFO): Sending 314 bytes from file Logs/20250411T201746/Courier0000.lzma 2025-04-11T20:27:20.486Z,1744403240.486 [DataOverHttps](INFO): Moved sent file to Logs/20250411T201746/Courier0000.lzma.bak 2025-04-11T20:27:20.486Z,1744403240.486 [DataOverHttps](INFO): SBD MOMSN=24618432 2025-04-11T20:27:40.494Z,1744403260.494 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20250411T162439/Express0065.lzma 2025-04-11T20:27:41.486Z,1744403261.486 [DataOverHttps](INFO): Moved sent file to Logs/20250411T162439/Express0065.lzma.bak 2025-04-11T20:27:41.486Z,1744403261.486 [DataOverHttps](INFO): SBD MOMSN=24618438 2025-04-11T20:28:02.745Z,1744403282.745 [DataOverHttps](INFO): Sending 513 bytes from file Logs/20250411T201559/Express0001.lzma 2025-04-11T20:28:03.742Z,1744403283.742 [DataOverHttps](INFO): Moved sent file to Logs/20250411T201559/Express0001.lzma.bak 2025-04-11T20:28:03.743Z,1744403283.743 [DataOverHttps](INFO): SBD MOMSN=24618440 2025-04-11T20:28:23.435Z,1744403303.435 [DataOverHttps](INFO): Sending 1358 bytes from file Logs/20250411T201746/Express0001.lzma 2025-04-11T20:28:24.434Z,1744403304.434 [DataOverHttps](INFO): Moved sent file to Logs/20250411T201746/Express0001.lzma.bak 2025-04-11T20:28:24.434Z,1744403304.434 [DataOverHttps](INFO): SBD MOMSN=24618451 2025-04-11T20:28:29.423Z,1744403309.423 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2025-04-11T20:28:29.423Z,1744403309.423 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2025-04-11T20:28:29.423Z,1744403309.423 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-04-11T20:28:39.486Z,1744403319.486 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-04-11T20:28:39.486Z,1744403319.486 [NAL9602] Data Fault, FailCount= 1 2025-04-11T20:28:39.486Z,1744403319.486 [NAL9602](ERROR): Data Fault 2025-04-11T20:28:39.624Z,1744403319.624 [CBIT](ERROR): Data Fault in component: NAL9602 2025-04-11T20:28:39.900Z,1744403319.900 [NAL9602](INFO): Powering down 2025-04-11T20:28:40.813Z,1744403320.813 [CBIT](INFO): Clearing failed state for component NAL9602 2025-04-11T20:28:40.813Z,1744403320.813 [NAL9602] No Fault, FailCount= 1 2025-04-11T20:28:50.309Z,1744403330.309 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:28:59.009Z,1744403339.009 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:07.449Z,1744403347.449 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:10.202Z,1744403350.202 [NAL9602](INFO): Powering up NAL9602 2025-04-11T20:29:15.953Z,1744403355.953 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:21.094Z,1744403361.094 [NAL9602](INFO): NAL9602 initialized 2025-04-11T20:29:24.577Z,1744403364.577 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:33.185Z,1744403373.185 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:41.841Z,1744403381.841 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:50.485Z,1744403390.485 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:29:59.169Z,1744403399.169 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:01.922Z,1744403401.922 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-04-11T20:30:01.922Z,1744403401.922 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-11T20:30:01.978Z,1744403401.978 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-11T20:30:02.386Z,1744403402.386 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-11T20:30:02.386Z,1744403402.386 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-04-11T20:30:07.873Z,1744403407.873 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:16.486Z,1744403416.486 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:25.161Z,1744403425.161 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:33.809Z,1744403433.809 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:42.401Z,1744403442.401 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:51.025Z,1744403451.025 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:30:57.708Z,1744403457.708 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-11T20:30:59.589Z,1744403459.589 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:31:08.157Z,1744403468.157 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:31:16.953Z,1744403476.953 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:31:25.539Z,1744403485.539 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:31:34.137Z,1744403494.137 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:31:42.805Z,1744403502.805 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:31:51.401Z,1744403511.401 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:00.117Z,1744403520.117 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:08.738Z,1744403528.738 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:17.265Z,1744403537.265 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:25.929Z,1744403545.929 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:33.041Z,1744403553.041 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-04-11T20:32:34.529Z,1744403554.529 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:41.690Z,1744403561.690 [CommandExec](IMPORTANT): got command strobe off 2025-04-11T20:32:41.690Z,1744403561.690 [CommandExec](IMPORTANT): Deactivating strobe 2025-04-11T20:32:43.125Z,1744403563.125 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:32:52.129Z,1744403572.129 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:00.565Z,1744403580.565 [CBIT](INFO): Clearing failed state for component DropWeight 2025-04-11T20:33:00.566Z,1744403580.566 [DropWeight] No Fault, FailCount= 1 2025-04-11T20:33:00.765Z,1744403580.765 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:02.969Z,1744403582.969 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-04-11T20:33:02.969Z,1744403582.969 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-11T20:33:03.041Z,1744403583.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-11T20:33:03.397Z,1744403583.397 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-11T20:33:03.397Z,1744403583.397 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-04-11T20:33:09.429Z,1744403589.429 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:17.941Z,1744403597.941 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:26.686Z,1744403606.686 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:28.896Z,1744403608.896 [CBIT](FAULT): WATER ALARM BOW. 2025-04-11T20:33:28.897Z,1744403608.897 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2025-04-11T20:33:29.228Z,1744403609.228 [CBIT](FAULT): WATER ALARM BOW. 2025-04-11T20:33:29.233Z,1744403609.233 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2025-04-11T20:33:29.640Z,1744403609.640 [CBIT](FAULT): WATER ALARM BOW. 2025-04-11T20:33:29.641Z,1744403609.641 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3 2025-04-11T20:33:29.983Z,1744403609.983 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting. 2025-04-11T20:33:29.983Z,1744403609.983 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2025-04-11T20:33:29.983Z,1744403609.983 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-04-11T20:33:29.983Z,1744403609.983 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1 2025-04-11T20:33:30.048Z,1744403610.048 [CBIT](FAULT): WATER ALARM BOW. 2025-04-11T20:33:30.060Z,1744403610.060 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL: BOW. BURNWIRE ACTIVATED 2025-04-11T20:33:30.061Z,1744403610.061 [CBIT](IMPORTANT): No ESP to power off. 2025-04-11T20:33:30.385Z,1744403610.385 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped 2025-04-11T20:33:30.386Z,1744403610.386 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1 2025-04-11T20:33:30.459Z,1744403610.459 [CBIT](INFO): Critical error at 20250411T203330 2025-04-11T20:33:30.836Z,1744403610.836 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 12.938993 min 2025-04-11T20:33:30.836Z,1744403610.836 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped 2025-04-11T20:33:30.836Z,1744403610.836 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn 2025-04-11T20:33:30.836Z,1744403610.836 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2025-04-11T20:33:30.840Z,1744403610.840 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2025-04-11T20:33:30.840Z,1744403610.840 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2 2025-04-11T20:33:30.841Z,1744403610.841 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2 2025-04-11T20:33:30.841Z,1744403610.841 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2025-04-11T20:33:30.841Z,1744403610.841 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2025-04-11T20:33:31.169Z,1744403611.169 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-04-11T20:33:31.170Z,1744403611.170 [DropWeight] Hardware Fault, FailCount= 1 2025-04-11T20:33:31.170Z,1744403611.170 [DropWeight](ERROR): Hardware Fault 2025-04-11T20:33:31.291Z,1744403611.291 [CBIT](INFO): Critical error at 20250411T203331 2025-04-11T20:33:31.294Z,1744403611.294 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-04-11T20:33:31.294Z,1744403611.294 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-04-11T20:33:31.671Z,1744403611.671 [CBIT](INFO): Critical error at 20250411T203331 2025-04-11T20:33:35.569Z,1744403615.569 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:44.173Z,1744403624.173 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:33:52.841Z,1744403632.841 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:34:01.425Z,1744403641.425 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:34:10.045Z,1744403650.045 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:34:15.671Z,1744403655.671 [CommandExec](IMPORTANT): got command restart application 2025-04-11T20:34:16.673Z,1744403656.673 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:16.674Z,1744403656.674 [CommandExec](INFO): Uninitializing the command executive. 2025-04-11T20:34:16.674Z,1744403656.674 [CommandExec](INFO): Uninitializing the command scheduler. 2025-04-11T20:34:16.675Z,1744403656.675 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:16.804Z,1744403656.804 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-04-11T20:34:16.804Z,1744403656.804 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-04-11T20:34:16.805Z,1744403656.805 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:16.805Z,1744403656.805 [NavChartDb](INFO): Join timeout helper Thread ID is 1046 2025-04-11T20:34:17.088Z,1744403657.088 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:17.089Z,1744403657.089 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:17.092Z,1744403657.092 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2025-04-11T20:34:17.092Z,1744403657.092 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:17.093Z,1744403657.093 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1047 2025-04-11T20:34:17.405Z,1744403657.405 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:17.405Z,1744403657.405 [WetLabsUBAT](INFO): Powering down 2025-04-11T20:34:17.405Z,1744403657.405 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:17.416Z,1744403657.416 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-04-11T20:34:17.416Z,1744403657.416 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:17.417Z,1744403657.417 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1048 2025-04-11T20:34:17.524Z,1744403657.524 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:17.525Z,1744403657.525 [WetLabsBB2FL](INFO): Powering down 2025-04-11T20:34:17.525Z,1744403657.525 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:17.536Z,1744403657.536 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-04-11T20:34:17.537Z,1744403657.537 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:17.537Z,1744403657.537 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1049 2025-04-11T20:34:18.065Z,1744403658.065 [CTD_Seabird](INFO): Powering down 2025-04-11T20:34:18.084Z,1744403658.084 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:18.085Z,1744403658.085 [CTD_Seabird](INFO): Powering down 2025-04-11T20:34:18.101Z,1744403658.101 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:18.104Z,1744403658.104 [ComponentRegistry](INFO): Shutting down TrnDataBridge ThreadHandler 2025-04-11T20:34:18.105Z,1744403658.105 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:18.105Z,1744403658.105 [TrnDataBridge](INFO): Join timeout helper Thread ID is 1050 2025-04-11T20:34:18.321Z,1744403658.321 [TrnDataBridge ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:18.322Z,1744403658.322 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:18.325Z,1744403658.325 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-04-11T20:34:18.325Z,1744403658.325 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:18.326Z,1744403658.326 [Radio_Surface](INFO): Join timeout helper Thread ID is 1051 2025-04-11T20:34:18.413Z,1744403658.413 [Radio_Surface](INFO): Powering down 2025-04-11T20:34:18.413Z,1744403658.413 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:18.414Z,1744403658.414 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:18.429Z,1744403658.429 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-04-11T20:34:18.429Z,1744403658.429 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:18.430Z,1744403658.430 [Onboard](INFO): Join timeout helper Thread ID is 1052 2025-04-11T20:34:18.769Z,1744403658.769 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-04-11T20:34:18.769Z,1744403658.769 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-11T20:34:20.665Z,1744403660.665 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:20.665Z,1744403660.665 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:20.675Z,1744403660.675 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-04-11T20:34:20.675Z,1744403660.675 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:20.677Z,1744403660.677 [DataOverHttps](INFO): Join timeout helper Thread ID is 1053 2025-04-11T20:34:20.777Z,1744403660.777 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:20.778Z,1744403660.778 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:20.797Z,1744403660.797 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-04-11T20:34:20.797Z,1744403660.797 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:20.798Z,1744403660.798 [DAT](INFO): Join timeout helper Thread ID is 1054 2025-04-11T20:34:20.893Z,1744403660.893 [DAT](INFO): Powering down 2025-04-11T20:34:20.965Z,1744403660.965 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:20.965Z,1744403660.965 [DAT](INFO): Powering down 2025-04-11T20:34:20.967Z,1744403660.967 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:20.973Z,1744403660.973 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-04-11T20:34:20.973Z,1744403660.973 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:20.974Z,1744403660.974 [BackseatComponent](INFO): Join timeout helper Thread ID is 1055 2025-04-11T20:34:21.124Z,1744403661.124 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:21.125Z,1744403661.125 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.133Z,1744403661.133 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-04-11T20:34:21.133Z,1744403661.133 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.134Z,1744403661.134 [logger](INFO): Join timeout helper Thread ID is 1056 2025-04-11T20:34:21.164Z,1744403661.164 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:21.165Z,1744403661.165 [logger ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.173Z,1744403661.173 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-04-11T20:34:21.173Z,1744403661.173 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.173Z,1744403661.173 [CommandLine](INFO): Join timeout helper Thread ID is 1057 2025-04-11T20:34:21.232Z,1744403661.232 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:21.233Z,1744403661.233 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.253Z,1744403661.253 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-04-11T20:34:21.253Z,1744403661.253 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.253Z,1744403661.253 [CommandExec](INFO): Join timeout helper Thread ID is 1058 2025-04-11T20:34:21.255Z,1744403661.255 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-04-11T20:34:21.255Z,1744403661.255 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.255Z,1744403661.255 [controlThread](INFO): Join timeout helper Thread ID is 1059 2025-04-11T20:34:21.260Z,1744403661.260 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-04-11T20:34:21.261Z,1744403661.261 [controlThread](DEBUG): Uninitializing ControlThread 2025-04-11T20:34:21.261Z,1744403661.261 [AHRS_M2](INFO): Powering down 2025-04-11T20:34:21.334Z,1744403661.334 [NAL9602](INFO): Powering down 2025-04-11T20:34:21.404Z,1744403661.404 [RDI_Pathfinder](INFO): Powering down 2025-04-11T20:34:21.405Z,1744403661.405 [Sonardyne_Nano](INFO): Powering down 2025-04-11T20:34:21.525Z,1744403661.525 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-04-11T20:34:21.526Z,1744403661.526 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-04-11T20:34:21.526Z,1744403661.526 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-04-11T20:34:21.527Z,1744403661.527 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock] Stopped 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock:SurfaceDefault] Stopped 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Stopped 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-11T20:34:21.527Z,1744403661.527 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2025-04-11T20:34:21.528Z,1744403661.528 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2025-04-11T20:34:21.528Z,1744403661.528 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2025-04-11T20:34:21.536Z,1744403661.536 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-04-11T20:34:21.536Z,1744403661.536 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-04-11T20:34:21.536Z,1744403661.536 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-04-11T20:34:21.537Z,1744403661.537 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-04-11T20:34:21.537Z,1744403661.537 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-04-11T20:34:21.537Z,1744403661.537 [BuoyancyServo](INFO): Powering down 2025-04-11T20:34:21.548Z,1744403661.548 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-04-11T20:34:21.549Z,1744403661.549 [ElevatorServo](INFO): Powering down 2025-04-11T20:34:21.549Z,1744403661.549 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2025-04-11T20:34:21.550Z,1744403661.550 [DockingStepper](INFO): Powering down 2025-04-11T20:34:21.550Z,1744403661.550 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-04-11T20:34:21.550Z,1744403661.550 [MassServo](INFO): Powering down 2025-04-11T20:34:21.551Z,1744403661.551 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-04-11T20:34:21.551Z,1744403661.551 [RudderServo](INFO): Powering down 2025-04-11T20:34:21.552Z,1744403661.552 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2025-04-11T20:34:21.552Z,1744403661.552 [ThrusterServo](INFO): Powering down 2025-04-11T20:34:21.553Z,1744403661.553 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-04-11T20:34:21.554Z,1744403661.554 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-04-11T20:34:21.554Z,1744403661.554 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-04-11T20:34:21.554Z,1744403661.554 [CBIT](DEBUG): Powering off loads. 2025-04-11T20:34:21.564Z,1744403661.564 [CBIT](DEBUG): Disabling WDT. 2025-04-11T20:34:21.576Z,1744403661.576 [CBIT](DEBUG): Opening all GF detection circuits. 2025-04-11T20:34:21.577Z,1744403661.577 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.647Z,1744403661.647 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.656Z,1744403661.656 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.658Z,1744403661.658 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.664Z,1744403661.664 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.670Z,1744403661.670 [DAT ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.712Z,1744403661.712 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.891Z,1744403661.891 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.893Z,1744403661.893 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.897Z,1744403661.897 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.905Z,1744403661.905 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-04-11T20:34:21.969Z,1744403661.969 [logger ThreadHandler](INFO): Thread cancelled.