2025-06-02T14:52:52.430Z,1748875972.430 [Supervisor](DEBUG): Initializing supervisor. 2025-06-02T14:52:52.435Z,1748875972.435 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-06-02T14:52:52.435Z,1748875972.435 [SyncHandler](INFO): Protected caller Thread ID is 3866 2025-06-02T14:52:52.436Z,1748875972.436 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-06-02T14:52:52.437Z,1748875972.437 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-06-02T14:52:52.437Z,1748875972.437 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3867 2025-06-02T14:52:52.442Z,1748875972.442 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-06-02T14:52:52.463Z,1748875972.463 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-06-02T14:52:52.464Z,1748875972.464 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-06-02T14:52:52.464Z,1748875972.464 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3868 2025-06-02T14:52:52.468Z,1748875972.468 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-06-02T14:52:52.470Z,1748875972.470 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-06-02T14:52:52.470Z,1748875972.470 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3869 2025-06-02T14:52:52.472Z,1748875972.472 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-06-02T14:52:52.473Z,1748875972.473 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-06-02T14:52:52.474Z,1748875972.474 [logger ThreadHandler](INFO): Protected caller Thread ID is 3870 2025-06-02T14:52:52.478Z,1748875972.478 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-06-02T14:52:52.478Z,1748875972.478 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-06-02T14:52:52.483Z,1748875972.483 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-06-02T14:52:52.653Z,1748875972.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-06-02T14:52:52.655Z,1748875972.655 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-06-02T14:52:52.887Z,1748875972.887 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-06-02T14:52:52.889Z,1748875972.889 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-06-02T14:52:53.159Z,1748875973.159 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-06-02T14:52:53.161Z,1748875973.161 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-06-02T14:52:53.278Z,1748875973.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-06-02T14:52:53.280Z,1748875973.280 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-06-02T14:52:54.043Z,1748875974.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-06-02T14:52:54.044Z,1748875974.044 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-06-02T14:52:54.566Z,1748875974.566 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-06-02T14:52:54.567Z,1748875974.567 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-06-02T14:52:55.123Z,1748875975.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-06-02T14:52:55.124Z,1748875975.124 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-06-02T14:52:55.551Z,1748875975.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-06-02T14:52:55.552Z,1748875975.552 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-06-02T14:52:55.914Z,1748875975.914 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-06-02T14:52:55.915Z,1748875975.915 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-06-02T14:52:56.304Z,1748875976.304 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-06-02T14:52:56.305Z,1748875976.305 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-06-02T14:52:56.815Z,1748875976.815 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-06-02T14:52:56.906Z,1748875976.906 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-06-02T14:52:57.118Z,1748875977.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-06-02T14:52:57.120Z,1748875977.120 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-06-02T14:52:57.223Z,1748875977.223 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-06-02T14:52:57.223Z,1748875977.223 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-06-02T14:52:57.313Z,1748875977.313 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-06-02T14:52:57.510Z,1748875977.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-06-02T14:52:57.510Z,1748875977.510 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-06-02T14:52:57.768Z,1748875977.768 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-06-02T14:52:57.770Z,1748875977.770 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-06-02T14:52:57.774Z,1748875977.774 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-06-02T14:52:57.867Z,1748875977.867 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-06-02T14:52:58.143Z,1748875978.143 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-06-02T14:52:58.144Z,1748875978.144 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-06-02T14:52:58.239Z,1748875978.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-06-02T14:52:58.420Z,1748875978.420 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-06-02T14:52:58.531Z,1748875978.531 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-06-02T14:52:58.651Z,1748875978.651 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-06-02T14:52:58.774Z,1748875978.774 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-06-02T14:52:58.879Z,1748875978.879 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-06-02T14:52:59.051Z,1748875979.051 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-06-02T14:52:59.158Z,1748875979.158 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-06-02T14:52:59.255Z,1748875979.255 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-06-02T14:52:59.363Z,1748875979.363 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-06-02T14:52:59.461Z,1748875979.461 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2025-06-02T14:52:59.461Z,1748875979.461 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-06-02T14:52:59.478Z,1748875979.478 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-06-02T14:52:59.695Z,1748875979.695 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-06-02T14:52:59.695Z,1748875979.695 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-06-02T14:52:59.887Z,1748875979.887 [BuoyancyServo] Loaded 2025-06-02T14:52:59.888Z,1748875979.888 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-06-02T14:52:59.911Z,1748875979.911 [ElevatorServo] Loaded 2025-06-02T14:52:59.912Z,1748875979.912 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-06-02T14:52:59.935Z,1748875979.935 [MassServo] Loaded 2025-06-02T14:52:59.935Z,1748875979.935 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-06-02T14:52:59.957Z,1748875979.957 [RudderServo] Loaded 2025-06-02T14:52:59.958Z,1748875979.958 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-06-02T14:52:59.976Z,1748875979.976 [ThrusterHE] Loaded 2025-06-02T14:52:59.976Z,1748875979.976 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-06-02T14:52:59.977Z,1748875979.977 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-06-02T14:52:59.977Z,1748875979.977 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-06-02T14:53:00.177Z,1748875980.177 [SBIT](DEBUG): Construct Startup Built In Test. 2025-06-02T14:53:00.192Z,1748875980.192 [SBIT] Loaded 2025-06-02T14:53:00.193Z,1748875980.193 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-06-02T14:53:00.195Z,1748875980.195 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-06-02T14:53:00.217Z,1748875980.217 [IBIT] Loaded 2025-06-02T14:53:00.217Z,1748875980.217 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-06-02T14:53:00.223Z,1748875980.223 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-06-02T14:53:00.418Z,1748875980.418 [CBIT] Loaded 2025-06-02T14:53:00.418Z,1748875980.418 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-06-02T14:53:00.450Z,1748875980.450 [GFScanner] Loaded 2025-06-02T14:53:00.450Z,1748875980.450 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-06-02T14:53:00.451Z,1748875980.451 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-06-02T14:53:00.451Z,1748875980.451 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-06-02T14:53:00.665Z,1748875980.665 [CTD_Seabird] Loaded 2025-06-02T14:53:00.665Z,1748875980.665 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-06-02T14:53:00.666Z,1748875980.666 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406864E0 2025-06-02T14:53:00.667Z,1748875980.667 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3958 2025-06-02T14:53:00.702Z,1748875980.702 [ESPComponent] Loaded 2025-06-02T14:53:00.702Z,1748875980.702 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-06-02T14:53:00.724Z,1748875980.724 [PAR_Licor] Loaded 2025-06-02T14:53:00.725Z,1748875980.725 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-06-02T14:53:00.771Z,1748875980.771 [WetLabsBB2FL] Loaded 2025-06-02T14:53:00.771Z,1748875980.771 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-06-02T14:53:00.772Z,1748875980.772 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B64E0 2025-06-02T14:53:00.772Z,1748875980.772 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3959 2025-06-02T14:53:00.773Z,1748875980.773 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-06-02T14:53:00.774Z,1748875980.774 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-06-02T14:53:00.843Z,1748875980.843 [DepthRateCalculator] Loaded 2025-06-02T14:53:00.843Z,1748875980.843 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-06-02T14:53:00.848Z,1748875980.848 [PitchRateCalculator] Loaded 2025-06-02T14:53:00.849Z,1748875980.849 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-06-02T14:53:00.859Z,1748875980.859 [SpeedCalculator] Loaded 2025-06-02T14:53:00.860Z,1748875980.860 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-06-02T14:53:00.864Z,1748875980.864 [YawRateCalculator] Loaded 2025-06-02T14:53:00.865Z,1748875980.865 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-06-02T14:53:00.885Z,1748875980.885 [ElevatorOffsetCalculator] Loaded 2025-06-02T14:53:00.885Z,1748875980.885 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-06-02T14:53:00.886Z,1748875980.886 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-06-02T14:53:00.886Z,1748875980.886 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-06-02T14:53:01.053Z,1748875981.053 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-06-02T14:53:01.053Z,1748875981.053 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-06-02T14:53:01.097Z,1748875981.097 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-06-02T14:53:01.098Z,1748875981.098 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-06-02T14:53:01.234Z,1748875981.234 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-06-02T14:53:01.235Z,1748875981.235 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-06-02T14:53:01.249Z,1748875981.249 [NavChart] Loaded 2025-06-02T14:53:01.249Z,1748875981.249 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-06-02T14:53:01.255Z,1748875981.255 [UniversalFixResidualReporter] Loaded 2025-06-02T14:53:01.255Z,1748875981.255 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-06-02T14:53:01.256Z,1748875981.256 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-06-02T14:53:01.256Z,1748875981.256 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-06-02T14:53:01.903Z,1748875981.903 [AHRS_M2] Loaded 2025-06-02T14:53:01.904Z,1748875981.904 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-06-02T14:53:01.943Z,1748875981.943 [BackseatComponent] Loaded 2025-06-02T14:53:01.943Z,1748875981.943 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-06-02T14:53:01.944Z,1748875981.944 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0 2025-06-02T14:53:01.945Z,1748875981.945 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3960 2025-06-02T14:53:01.948Z,1748875981.948 [LcmUniversalReporter] Loaded 2025-06-02T14:53:01.948Z,1748875981.948 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-06-02T14:53:03.191Z,1748875983.191 [BPC1] Loaded 2025-06-02T14:53:03.192Z,1748875983.192 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-06-02T14:53:03.304Z,1748875983.304 [DAT] Loaded 2025-06-02T14:53:03.305Z,1748875983.305 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-06-02T14:53:03.306Z,1748875983.306 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB24E0 2025-06-02T14:53:03.306Z,1748875983.306 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3961 2025-06-02T14:53:03.485Z,1748875983.485 [DataOverHttps] Loaded 2025-06-02T14:53:03.486Z,1748875983.486 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-06-02T14:53:03.487Z,1748875983.487 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0 2025-06-02T14:53:03.487Z,1748875983.487 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3962 2025-06-02T14:53:03.511Z,1748875983.511 [Depth_Keller] Loaded 2025-06-02T14:53:03.511Z,1748875983.511 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-06-02T14:53:03.516Z,1748875983.516 [DropWeight] Loaded 2025-06-02T14:53:03.516Z,1748875983.516 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-06-02T14:53:03.580Z,1748875983.580 [NAL9602] Loaded 2025-06-02T14:53:03.580Z,1748875983.580 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-06-02T14:53:03.606Z,1748875983.606 [Onboard] Loaded 2025-06-02T14:53:03.607Z,1748875983.607 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-06-02T14:53:03.608Z,1748875983.608 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B124E0 2025-06-02T14:53:03.608Z,1748875983.608 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3963 2025-06-02T14:53:03.614Z,1748875983.614 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1 2025-06-02T14:53:03.628Z,1748875983.628 [PowerOnly] Loaded 2025-06-02T14:53:03.628Z,1748875983.628 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-06-02T14:53:03.643Z,1748875983.643 [Power24vConverter] Loaded 2025-06-02T14:53:03.643Z,1748875983.643 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-06-02T14:53:03.659Z,1748875983.659 [Radio_Surface] Loaded 2025-06-02T14:53:03.659Z,1748875983.659 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-06-02T14:53:03.660Z,1748875983.660 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B424E0 2025-06-02T14:53:03.661Z,1748875983.661 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3964 2025-06-02T14:53:03.677Z,1748875983.677 [Sonardyne_Nano] Loaded 2025-06-02T14:53:03.678Z,1748875983.678 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-06-02T14:53:03.678Z,1748875983.678 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-06-02T14:53:03.679Z,1748875983.679 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-06-02T14:53:03.762Z,1748875983.762 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-06-02T14:53:03.762Z,1748875983.762 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-06-02T14:53:03.832Z,1748875983.832 [VerticalControl](DEBUG): Construct VerticalControl. 2025-06-02T14:53:03.885Z,1748875983.885 [VerticalControl] Loaded 2025-06-02T14:53:03.885Z,1748875983.885 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-06-02T14:53:03.888Z,1748875983.888 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-06-02T14:53:03.934Z,1748875983.934 [HorizontalControl] Loaded 2025-06-02T14:53:03.934Z,1748875983.934 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-06-02T14:53:03.937Z,1748875983.937 [SpeedControl](DEBUG): Construct SpeedControl. 2025-06-02T14:53:03.938Z,1748875983.938 [SpeedControl] Loaded 2025-06-02T14:53:03.939Z,1748875983.939 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-06-02T14:53:03.942Z,1748875983.942 [LoopControl](DEBUG): Construct LoopControl. 2025-06-02T14:53:03.942Z,1748875983.942 [LoopControl] Loaded 2025-06-02T14:53:03.943Z,1748875983.943 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-06-02T14:53:03.943Z,1748875983.943 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-06-02T14:53:03.944Z,1748875983.944 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-06-02T14:53:03.957Z,1748875983.957 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-06-02T14:53:03.958Z,1748875983.958 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-06-02T14:53:04.369Z,1748875984.369 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-06-02T14:53:04.376Z,1748875984.376 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-06-02T14:53:04.379Z,1748875984.379 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-06-02T14:53:04.390Z,1748875984.390 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-06-02T14:53:04.391Z,1748875984.391 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0 2025-06-02T14:53:04.392Z,1748875984.392 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3965 2025-06-02T14:53:04.396Z,1748875984.396 [Supervisor](INFO): Main Thread ID is 822 2025-06-02T14:53:04.396Z,1748875984.396 [Supervisor](DEBUG): Running supervisor. 2025-06-02T14:53:04.397Z,1748875984.397 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3966 2025-06-02T14:53:04.398Z,1748875984.398 [CommandExec](INFO): Initializing the command executive. 2025-06-02T14:53:04.399Z,1748875984.399 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3967 2025-06-02T14:53:04.401Z,1748875984.401 [controlThread ThreadHandler](INFO): Handler Thread ID is 3968 2025-06-02T14:53:04.402Z,1748875984.402 [controlThread](DEBUG): Initializing ControlThread 2025-06-02T14:53:04.404Z,1748875984.404 [SBIT](INFO): Initialize SBIT Component. 2025-06-02T14:53:04.404Z,1748875984.404 [SBIT](IMPORTANT): git: 2025-05-29 2025-06-02T14:53:04.404Z,1748875984.404 [SBIT](INFO): git hash: c78c975c7bb2a66b27244d2837f68dff299fa024 2025-06-02T14:53:04.405Z,1748875984.405 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-06-02T14:53:04.406Z,1748875984.406 [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-06-02T14:53:04.407Z,1748875984.407 [SBIT](INFO): Beginning SBIT in 125.000000 seconds. 2025-06-02T14:53:04.408Z,1748875984.408 [IBIT](INFO): Initialize IBIT Component. 2025-06-02T14:53:04.409Z,1748875984.409 [CBIT](DEBUG): Initialize CBIT Component. 2025-06-02T14:53:04.410Z,1748875984.410 [logger ThreadHandler](INFO): Handler Thread ID is 3969 2025-06-02T14:53:04.421Z,1748875984.421 [CBIT](DEBUG): Initialized mux pins. 2025-06-02T14:53:04.421Z,1748875984.421 [CBIT](DEBUG): Initializing the watchdog timer. 2025-06-02T14:53:04.430Z,1748875984.430 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3970 2025-06-02T14:53:04.430Z,1748875984.430 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-06-02T14:53:04.435Z,1748875984.435 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3972 2025-06-02T14:53:04.438Z,1748875984.438 [WetLabsBB2FL](INFO): Powering up 2025-06-02T14:53:04.439Z,1748875984.439 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3974 2025-06-02T14:53:04.445Z,1748875984.445 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-06-02T14:53:04.446Z,1748875984.446 [CBIT](DEBUG): Initializing heartbeat. 2025-06-02T14:53:04.447Z,1748875984.447 [DAT ThreadHandler](INFO): Handler Thread ID is 3975 2025-06-02T14:53:04.448Z,1748875984.448 [DAT](INFO): Powering up 2025-06-02T14:53:04.448Z,1748875984.448 [DAT](DEBUG): Initializing DAT. 2025-06-02T14:53:04.451Z,1748875984.451 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3977 2025-06-02T14:53:04.452Z,1748875984.452 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-06-02T14:53:04.474Z,1748875984.474 [Onboard ThreadHandler](INFO): Handler Thread ID is 3978 2025-06-02T14:53:04.491Z,1748875984.491 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3979 2025-06-02T14:53:04.513Z,1748875984.513 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3980 2025-06-02T14:53:04.517Z,1748875984.517 [CBIT](DEBUG): Deactivating emergency mode. 2025-06-02T14:53:04.522Z,1748875984.522 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-06-02T14:53:04.522Z,1748875984.522 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-06-02T14:53:04.523Z,1748875984.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-06-02T14:53:04.523Z,1748875984.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-06-02T14:53:04.523Z,1748875984.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-06-02T14:53:04.523Z,1748875984.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-06-02T14:53:04.523Z,1748875984.523 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-06-02T14:53:04.523Z,1748875984.523 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-06-02T14:53:04.557Z,1748875984.557 [CBIT](DEBUG): Backplane powered. 2025-06-02T14:53:04.558Z,1748875984.558 [GFScanner](DEBUG): Initializing GFScanner 2025-06-02T14:53:04.558Z,1748875984.558 [GFScanner](DEBUG): Deactivating GF circuits. 2025-06-02T14:53:04.566Z,1748875984.566 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-06-02T14:53:04.566Z,1748875984.566 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-06-02T14:53:04.566Z,1748875984.566 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-06-02T14:53:04.567Z,1748875984.567 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-06-02T14:53:04.567Z,1748875984.567 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-06-02T14:53:04.568Z,1748875984.568 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-06-02T14:53:04.569Z,1748875984.569 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-06-02T14:53:04.572Z,1748875984.572 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-06-02T14:53:04.578Z,1748875984.578 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-06-02T14:53:04.579Z,1748875984.579 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-06-02T14:53:04.580Z,1748875984.580 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-06-02T14:53:04.580Z,1748875984.580 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-06-02T14:53:04.589Z,1748875984.589 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-06-02T14:53:04.590Z,1748875984.590 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-06-02T14:53:04.596Z,1748875984.596 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-06-02T14:53:04.669Z,1748875984.669 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-06-02T14:53:04.686Z,1748875984.686 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-02T14:53:04.718Z,1748875984.718 [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-06-02T14:53:04.730Z,1748875984.730 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-06-02T14:53:04.730Z,1748875984.730 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-06-02T14:53:04.745Z,1748875984.745 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-06-02T14:53:04.898Z,1748875984.898 [Radio_Surface](INFO): Powering up 2025-06-02T14:53:05.047Z,1748875985.047 [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-06-02T14:53:05.072Z,1748875985.072 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-06-02T14:53:05.098Z,1748875985.098 [Default:A.Wait](DEBUG): Construct Wait. 2025-06-02T14:53:05.100Z,1748875985.100 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-02T14:53:05.147Z,1748875985.147 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-06-02T14:53:05.150Z,1748875985.150 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-06-02T14:53:05.164Z,1748875985.164 [Default:E.Execute](DEBUG): Construct Execute. 2025-06-02T14:53:05.168Z,1748875985.168 [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-06-02T14:53:05.186Z,1748875985.186 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,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-06-02T14:53:05.195Z,1748875985.195 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-02T14:53:05.258Z,1748875985.258 [Depth_Keller](INFO): Initializing. 2025-06-02T14:53:05.260Z,1748875985.260 [PowerOnly](INFO): Powering up loadControl 2025-06-02T14:53:05.278Z,1748875985.278 [Power24vConverter](INFO): Powering up. 2025-06-02T14:53:05.279Z,1748875985.279 [Sonardyne_Nano](INFO): Initializing. 2025-06-02T14:53:05.306Z,1748875985.306 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-06-02T14:53:05.328Z,1748875985.328 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-02T14:53:05.334Z,1748875985.334 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-02T14:53:05.335Z,1748875985.335 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-02T14:53:05.342Z,1748875985.342 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-02T14:53:05.343Z,1748875985.343 [MassServo](DEBUG): Initializing EZServoServo. 2025-06-02T14:53:05.350Z,1748875985.350 [MassServo](DEBUG): Initializing MassServo. 2025-06-02T14:53:05.350Z,1748875985.350 [RudderServo](DEBUG): Initializing EZServoServo. 2025-06-02T14:53:05.358Z,1748875985.358 [RudderServo](DEBUG): Initializing RudderServo. 2025-06-02T14:53:05.358Z,1748875985.358 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-06-02T14:53:05.366Z,1748875985.366 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-06-02T14:53:07.050Z,1748875987.050 [WetLabsBB2FL](INFO): Powering down 2025-06-02T14:53:07.220Z,1748875987.220 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-02T14:53:08.506Z,1748875988.506 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-06-02T14:53:16.546Z,1748875996.546 [DAT](INFO): DAT read: 2025-06-02T14:53:16.547Z,1748875996.547 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-02T14:53:18.310Z,1748875998.310 [DAT](INFO): DAT read: MF Frequency Band 2025-06-02T14:53:18.311Z,1748875998.311 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-02T14:53:18.312Z,1748875998.312 [DAT](INFO): DAT read: Jun 2 2025 14:53:24 2025-06-02T14:53:19.571Z,1748875999.571 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-06-02T14:53:19.572Z,1748875999.572 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-06-02T14:53:19.572Z,1748875999.572 [DAT](INFO): commRate: 1200 2025-06-02T14:53:21.637Z,1748876001.637 [DAT](INFO): entering command mode 2025-06-02T14:53:21.838Z,1748876001.838 [DAT](INFO): DAT read: 2025-06-02T14:53:21.839Z,1748876001.839 [DAT](INFO): DAT read: user:1> 2025-06-02T14:53:21.839Z,1748876001.839 [DAT](INFO): setting verbose to 3 2025-06-02T14:53:22.090Z,1748876002.090 [DAT](INFO): DAT read: user:1> 2025-06-02T14:53:22.091Z,1748876002.091 [DAT](INFO): DAT read: Verbose | 3 2025-06-02T14:53:22.092Z,1748876002.092 [DAT](INFO): set verbose to 3 2025-06-02T14:53:22.092Z,1748876002.092 [DAT](INFO): setting DatVerbose to 27440 2025-06-02T14:53:22.343Z,1748876002.343 [DAT](INFO): DAT read: user:2> 2025-06-02T14:53:22.344Z,1748876002.344 [DAT](INFO): DAT read: DatVerbose | 27440 2025-06-02T14:53:22.344Z,1748876002.344 [DAT](INFO): set DatVerbose to 27440 2025-06-02T14:53:22.344Z,1748876002.344 [DAT](INFO): setting transmit power to 8 2025-06-02T14:53:22.594Z,1748876002.594 [DAT](INFO): DAT read: user:3> 2025-06-02T14:53:22.595Z,1748876002.595 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-06-02T14:53:22.595Z,1748876002.595 [DAT](INFO): set transmit power to 8 2025-06-02T14:53:22.596Z,1748876002.596 [DAT](INFO): setting local address to 5 2025-06-02T14:53:22.846Z,1748876002.846 [DAT](INFO): DAT read: user:4> 2025-06-02T14:53:22.847Z,1748876002.847 [DAT](INFO): DAT read: LocalAddr | 5 2025-06-02T14:53:22.847Z,1748876002.847 [DAT](INFO): set local address to 5 2025-06-02T14:53:22.849Z,1748876002.849 [DAT](INFO): Setting time to: 14:53:22 And date to:6/2/2025 2025-06-02T14:53:23.098Z,1748876003.098 [DAT](INFO): DAT read: user:5> 2025-06-02T14:53:23.099Z,1748876003.099 [DAT](INFO): DAT read: Mon Jun 2, 2025 14:53:22 2025-06-02T14:53:23.100Z,1748876003.100 [DAT](INFO): Local DAT time set to Mon Jun 2, 2025 14:53:22 2025-06-02T14:53:33.915Z,1748876013.915 [NAL9602](INFO): Powering up NAL9602 2025-06-02T14:53:44.821Z,1748876024.821 [NAL9602](INFO): NAL9602 initialized 2025-06-02T14:55:10.102Z,1748876110.102 [SBIT](IMPORTANT): Beginning Startup BIT 2025-06-02T14:55:10.107Z,1748876110.107 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-02T14:55:14.671Z,1748876114.671 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.003867 CHAN A1 (24V): 0.006112 CHAN A2 (12V): -0.005464 CHAN A3 (5V): -0.004296 CHAN B0 (3.3V): -0.002456 CHAN B1 (3.15aV): -0.001802 CHAN B2 (3.15bV): -0.001603 CHAN B3 (GND): -0.001318 OPEN: 0.006954 Full Scale: +/- 1 mA 2025-06-02T14:55:16.848Z,1748876116.848 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004791 2025-06-02T14:55:21.049Z,1748876121.049 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T14:56:04.266Z,1748876164.266 [SBIT](IMPORTANT): SBIT PASSED 2025-06-02T14:56:04.267Z,1748876164.267 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-06-02T14:56:04.267Z,1748876164.267 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2025-06-02T14:56:04.267Z,1748876164.267 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-06-02T14:56:04.267Z,1748876164.267 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-06-02T14:56:04.268Z,1748876164.268 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=0 bool; 2025-06-02T14:56:04.269Z,1748876164.269 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=266.500578 cubic_centimeter; 2025-06-02T14:56:04.269Z,1748876164.269 [SBIT](IMPORTANT): VerticalControl.massDefault=26.489817 millimeter; 2025-06-02T14:56:04.690Z,1748876164.690 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-06-02T14:56:04.690Z,1748876164.690 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-02T14:56:04.692Z,1748876164.692 [MissionManager](IMPORTANT): Started mission Startup 2025-06-02T14:56:04.692Z,1748876164.692 [Startup] Running Loop=1 2025-06-02T14:56:04.692Z,1748876164.692 [Startup](DEBUG): Aggregate::initialize Startup 2025-06-02T14:56:04.692Z,1748876164.692 [Startup:A.GoToSurface] Running Loop=1 2025-06-02T14:56:04.692Z,1748876164.692 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-02T14:56:04.693Z,1748876164.693 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-02T14:56:04.693Z,1748876164.693 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-02T14:56:04.694Z,1748876164.694 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-02T14:56:04.694Z,1748876164.694 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-02T14:56:04.694Z,1748876164.694 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-02T14:56:04.695Z,1748876164.695 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-02T14:56:04.697Z,1748876164.697 [Startup:StartupSatComms] Running Loop=1 2025-06-02T14:56:04.697Z,1748876164.697 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-06-02T14:56:04.697Z,1748876164.697 [Startup:StartupSatComms:A] Running Loop=1 2025-06-02T14:56:04.707Z,1748876164.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-02T14:56:05.063Z,1748876165.063 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-06-02T14:56:05.073Z,1748876165.073 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-02T14:56:05.073Z,1748876165.073 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-06-02T14:56:20.863Z,1748876180.863 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T14:57:04.875Z,1748876224.875 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-02T14:56:04.7Z 2025-06-02T14:57:04.875Z,1748876224.875 [Startup:StartupSatComms:A] Stopped 2025-06-02T14:57:04.875Z,1748876224.875 [Startup:StartupSatComms:B] Running Loop=1 2025-06-02T14:57:05.252Z,1748876225.252 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-02T14:57:11.710Z,1748876231.710 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250602T145252/Courier0000.lzma 2025-06-02T14:57:12.711Z,1748876232.711 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Courier0000.lzma.bak 2025-06-02T14:57:12.712Z,1748876232.712 [DataOverHttps](INFO): SBD MOMSN=25072330 2025-06-02T14:57:28.520Z,1748876248.520 [DataOverHttps](INFO): Sending 1055 bytes from file Logs/20250602T145252/Express0001.lzma 2025-06-02T14:57:29.519Z,1748876249.519 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Express0001.lzma.bak 2025-06-02T14:57:29.519Z,1748876249.519 [DataOverHttps](INFO): SBD MOMSN=25072333 2025-06-02T14:57:30.704Z,1748876250.704 [Startup:StartupSatComms:B] Stopped 2025-06-02T14:57:30.704Z,1748876250.704 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-06-02T14:57:30.704Z,1748876250.704 [Startup:StartupSatComms] Stopped 2025-06-02T14:57:30.704Z,1748876250.704 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-06-02T14:57:30.705Z,1748876250.705 [Startup](INFO): Completed Startup 2025-06-02T14:57:30.705Z,1748876250.705 [MissionManager](INFO): Startup is completed. 2025-06-02T14:57:30.705Z,1748876250.705 [MissionManager](INFO): Uninitializing Mission Startup 2025-06-02T14:57:30.706Z,1748876250.706 [Startup] Stopped 2025-06-02T14:57:30.706Z,1748876250.706 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-06-02T14:57:30.706Z,1748876250.706 [Startup:A.GoToSurface] Stopped 2025-06-02T14:57:30.706Z,1748876250.706 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-02T14:57:31.111Z,1748876251.111 [MissionManager](IMPORTANT): Started mission Default 2025-06-02T14:57:31.111Z,1748876251.111 [Default] Running Loop=1 2025-06-02T14:57:31.111Z,1748876251.111 [Default](DEBUG): Aggregate::initialize Default 2025-06-02T14:57:31.111Z,1748876251.111 [Default:B.GoToSurface] Running Loop=1 2025-06-02T14:57:31.111Z,1748876251.111 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-02T14:57:31.111Z,1748876251.111 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-02T14:57:31.112Z,1748876251.112 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-02T14:57:31.112Z,1748876251.112 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-02T14:57:31.112Z,1748876251.112 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-02T14:57:31.113Z,1748876251.113 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-02T14:57:31.113Z,1748876251.113 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-02T14:57:31.113Z,1748876251.113 [Default:A.Wait] Running Loop=1 2025-06-02T14:57:31.113Z,1748876251.113 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-06-02T14:57:44.438Z,1748876264.438 [Default:A.Wait](INFO): Done Waiting. 2025-06-02T14:57:44.438Z,1748876264.438 [Default:A.Wait] Stopped 2025-06-02T14:57:44.438Z,1748876264.438 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-06-02T14:57:44.875Z,1748876264.875 [Default:CheckIn] Running Loop=1 2025-06-02T14:57:44.876Z,1748876264.876 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-02T14:57:44.876Z,1748876264.876 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-02T14:57:45.275Z,1748876265.275 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-06-02T14:58:26.490Z,1748876306.490 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T14:58:47.863Z,1748876327.863 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-06-02T14:58:52.758Z,1748876332.758 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T14:59:05.665Z,1748876345.665 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-06-02T14:59:05.665Z,1748876345.665 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-02T14:59:05.707Z,1748876345.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-02T14:59:06.187Z,1748876346.187 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-02T14:59:06.187Z,1748876346.187 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-06-02T15:00:30.938Z,1748876430.938 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:35.733Z,1748876435.733 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:37.062Z,1748876437.062 [CommandExec](IMPORTANT): got command failComponent 2025-06-02T15:00:37.063Z,1748876437.063 [CommandExec](IMPORTANT): Failed components: 2025-06-02T15:00:37.063Z,1748876437.063 [CommandExec](IMPORTANT): No failed Components. 2025-06-02T15:00:38.564Z,1748876438.564 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:41.390Z,1748876441.390 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:44.214Z,1748876444.214 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:47.041Z,1748876447.041 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:49.904Z,1748876449.904 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:52.699Z,1748876452.699 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:55.530Z,1748876455.530 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:00:58.354Z,1748876458.354 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:01.188Z,1748876461.188 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:04.010Z,1748876464.010 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:07.642Z,1748876467.642 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:10.475Z,1748876470.475 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:13.709Z,1748876473.709 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:16.534Z,1748876476.534 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:19.363Z,1748876479.363 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:22.186Z,1748876482.186 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:25.016Z,1748876485.016 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:27.846Z,1748876487.846 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:30.675Z,1748876490.675 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:33.498Z,1748876493.498 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:36.730Z,1748876496.730 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:39.559Z,1748876499.559 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:42.387Z,1748876502.387 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:45.214Z,1748876505.214 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:48.045Z,1748876508.045 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:51.278Z,1748876511.278 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:54.912Z,1748876514.912 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:01:57.739Z,1748876517.739 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:00.974Z,1748876520.974 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:04.205Z,1748876524.205 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:06.662Z,1748876526.662 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-06-02T15:02:06.662Z,1748876526.662 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-02T15:02:06.681Z,1748876526.681 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-02T15:02:07.095Z,1748876527.095 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-02T15:02:07.095Z,1748876527.095 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-06-02T15:02:07.435Z,1748876527.435 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:10.667Z,1748876530.667 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:13.498Z,1748876533.498 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:16.326Z,1748876536.326 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:17.739Z,1748876537.739 [CommandExec](IMPORTANT): got command strobe off 2025-06-02T15:02:17.739Z,1748876537.739 [CommandExec](IMPORTANT): Deactivating strobe 2025-06-02T15:02:19.156Z,1748876539.156 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:21.981Z,1748876541.981 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:25.210Z,1748876545.210 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:28.042Z,1748876548.042 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:28.914Z,1748876548.914 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:30.872Z,1748876550.872 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:34.106Z,1748876554.106 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:36.931Z,1748876556.931 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:40.157Z,1748876560.157 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:42.987Z,1748876562.987 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:45.059Z,1748876565.059 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-02T14:57:44.9Z 2025-06-02T15:02:45.059Z,1748876565.059 [Default:CheckIn:Read_GPS] Stopped 2025-06-02T15:02:45.059Z,1748876565.059 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-02T15:02:45.427Z,1748876565.427 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-02T15:02:45.851Z,1748876565.851 [Default:CheckIn:Read_Iridium] Stopped 2025-06-02T15:02:45.851Z,1748876565.851 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-02T15:02:45.851Z,1748876565.851 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-02T15:02:46.218Z,1748876566.218 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:49.046Z,1748876569.046 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:52.281Z,1748876572.281 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:02:55.106Z,1748876575.106 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:03:06.401Z,1748876586.401 [CommandExec](IMPORTANT): got command configSet list 2025-06-02T15:03:06.401Z,1748876586.401 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-06-02T15:03:06.410Z,1748876586.410 [CommandExec](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2025-06-02T15:03:06.411Z,1748876586.411 [CommandExec](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-06-02T15:03:06.411Z,1748876586.411 [CommandExec](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2025-06-02T15:03:06.412Z,1748876586.412 [CommandExec](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2025-06-02T15:03:06.413Z,1748876586.413 [CommandExec](IMPORTANT): ESPComponent.sampleTimeout=5 minute; 2025-06-02T15:03:06.418Z,1748876586.418 [CommandExec](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2025-06-02T15:03:06.418Z,1748876586.418 [CommandExec](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2025-06-02T15:03:06.419Z,1748876586.419 [CommandExec](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2025-06-02T15:03:06.420Z,1748876586.420 [CommandExec](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-06-02T15:03:06.420Z,1748876586.420 [CommandExec](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-06-02T15:03:06.424Z,1748876586.424 [CommandExec](IMPORTANT): ThrusterHE.bestEffortMode=0 bool; 2025-06-02T15:03:06.425Z,1748876586.425 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=266.500578 cubic_centimeter; 2025-06-02T15:03:06.466Z,1748876586.466 [CommandExec](IMPORTANT): VerticalControl.massDefault=26.489817 millimeter; 2025-06-02T15:03:29.912Z,1748876609.912 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:03:44.057Z,1748876624.057 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:03:46.012Z,1748876626.012 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-02T15:03:46.013Z,1748876626.013 [NAL9602] Data Fault, FailCount= 1 2025-06-02T15:03:46.013Z,1748876626.013 [NAL9602](ERROR): Data Fault 2025-06-02T15:03:46.034Z,1748876626.034 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-02T15:03:46.420Z,1748876626.420 [NAL9602](INFO): Powering down 2025-06-02T15:03:47.257Z,1748876627.257 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-02T15:03:47.258Z,1748876627.258 [NAL9602] No Fault, FailCount= 1 2025-06-02T15:04:14.351Z,1748876654.351 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:04:16.721Z,1748876656.721 [NAL9602](INFO): Powering up NAL9602 2025-06-02T15:04:27.624Z,1748876667.624 [NAL9602](INFO): NAL9602 initialized 2025-06-02T15:04:55.184Z,1748876695.184 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:05:00.004Z,1748876700.004 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:05:07.626Z,1748876707.626 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-06-02T15:05:07.626Z,1748876707.626 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-02T15:05:07.659Z,1748876707.659 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-02T15:05:08.071Z,1748876708.071 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-02T15:05:08.071Z,1748876708.071 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-06-02T15:06:09.894Z,1748876769.894 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:06:33.722Z,1748876793.722 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:06:37.367Z,1748876797.367 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:06:47.055Z,1748876807.055 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:06:50.303Z,1748876810.303 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:07:46.408Z,1748876866.408 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-02T15:07:46.408Z,1748876866.408 [Default:CheckIn:C.Wait] Stopped 2025-06-02T15:07:46.408Z,1748876866.408 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-02T15:07:46.408Z,1748876866.408 [Default:CheckIn:D] Running Loop=1 2025-06-02T15:07:46.808Z,1748876866.808 [Default:CheckIn:D] Stopped 2025-06-02T15:07:46.808Z,1748876866.808 [Default:CheckIn:E] Running Loop=1 2025-06-02T15:07:47.208Z,1748876867.208 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.261617 min 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn:E] Stopped 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn] Stopped 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn](INFO): Running loop #2 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn] Running Loop=2 2025-06-02T15:07:47.209Z,1748876867.209 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-02T15:07:47.210Z,1748876867.210 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-02T15:07:55.339Z,1748876875.339 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:08:08.638Z,1748876888.638 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-06-02T15:08:08.638Z,1748876888.638 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-02T15:08:08.675Z,1748876888.675 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-02T15:08:09.051Z,1748876889.051 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-02T15:08:09.051Z,1748876889.051 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-06-02T15:08:58.753Z,1748876938.753 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-02T15:09:54.984Z,1748876994.984 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-02T15:10:10.243Z,1748877010.243 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 5. 2025-06-02T15:10:10.246Z,1748877010.246 [BPC1](INFO): Received data from all battery sticks. 2025-06-02T15:10:58.711Z,1748877058.711 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,151058.00,A,3648.15911,N,12147.27760,W,0.350,0.00,020625,,,A*70 2025-06-02T15:10:58.714Z,1748877058.714 [NAL9602](INFO): GPS fix at 20250602T151058: (36.802652, -121.787960) 2025-06-02T15:10:58.725Z,1748877058.725 [Default:CheckIn:Read_GPS] Stopped 2025-06-02T15:10:58.726Z,1748877058.726 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-02T15:11:07.933Z,1748877067.933 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250602T145252/Courier0004.lzma 2025-06-02T15:11:08.935Z,1748877068.935 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Courier0004.lzma.bak 2025-06-02T15:11:08.935Z,1748877068.935 [DataOverHttps](INFO): SBD MOMSN=25072470 2025-06-02T15:11:25.026Z,1748877085.026 [DataOverHttps](INFO): Sending 290 bytes from file Logs/20250602T145252/Courier0007.lzma 2025-06-02T15:11:26.027Z,1748877086.027 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Courier0007.lzma.bak 2025-06-02T15:11:26.027Z,1748877086.027 [DataOverHttps](INFO): SBD MOMSN=25072472 2025-06-02T15:11:31.446Z,1748877091.446 [NAL9602](INFO): Not Powering down - fast GPS 2025-06-02T15:11:42.022Z,1748877102.022 [DataOverHttps](INFO): Sending 314 bytes from file Logs/20250602T145252/Express0005.lzma 2025-06-02T15:11:43.023Z,1748877103.023 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Express0005.lzma.bak 2025-06-02T15:11:43.023Z,1748877103.023 [DataOverHttps](INFO): SBD MOMSN=25072475 2025-06-02T15:11:58.859Z,1748877118.859 [DataOverHttps](INFO): Sending 817 bytes from file Logs/20250602T145252/Express0008.lzma 2025-06-02T15:11:59.859Z,1748877119.859 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Express0008.lzma.bak 2025-06-02T15:11:59.859Z,1748877119.859 [DataOverHttps](INFO): SBD MOMSN=25072484 2025-06-02T15:12:00.935Z,1748877120.935 [Default:CheckIn:Read_Iridium] Stopped 2025-06-02T15:12:00.935Z,1748877120.935 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-02T15:12:00.935Z,1748877120.935 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-02T15:17:01.512Z,1748877421.512 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-02T15:17:01.512Z,1748877421.512 [Default:CheckIn:C.Wait] Stopped 2025-06-02T15:17:01.512Z,1748877421.512 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-02T15:17:01.513Z,1748877421.513 [Default:CheckIn:D] Running Loop=1 2025-06-02T15:17:01.921Z,1748877421.921 [Default:CheckIn:D] Stopped 2025-06-02T15:17:01.921Z,1748877421.921 [Default:CheckIn:E] Running Loop=1 2025-06-02T15:17:02.321Z,1748877422.321 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.513501 min 2025-06-02T15:17:02.321Z,1748877422.321 [Default:CheckIn:E] Stopped 2025-06-02T15:17:02.321Z,1748877422.321 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-02T15:17:02.321Z,1748877422.321 [Default:CheckIn] Stopped 2025-06-02T15:17:02.321Z,1748877422.321 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-02T15:17:02.321Z,1748877422.321 [Default:CheckIn](INFO): Running loop #3 2025-06-02T15:17:02.337Z,1748877422.337 [Default:CheckIn] Running Loop=3 2025-06-02T15:17:02.337Z,1748877422.337 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-02T15:17:02.338Z,1748877422.338 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-02T15:17:04.336Z,1748877424.336 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,151703.00,A,3648.16577,N,12147.28528,W,0.253,64.66,020625,,,A*47 2025-06-02T15:17:04.339Z,1748877424.339 [NAL9602](INFO): GPS fix at 20250602T151703: (36.802763, -121.788088) 2025-06-02T15:17:04.349Z,1748877424.349 [Default:CheckIn:Read_GPS] Stopped 2025-06-02T15:17:04.349Z,1748877424.349 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-02T15:17:12.281Z,1748877432.281 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250602T145252/Courier0010.lzma 2025-06-02T15:17:13.283Z,1748877433.283 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Courier0010.lzma.bak 2025-06-02T15:17:13.283Z,1748877433.283 [DataOverHttps](INFO): SBD MOMSN=25072509 2025-06-02T15:17:29.189Z,1748877449.189 [DataOverHttps](INFO): Sending 164 bytes from file Logs/20250602T145252/Express0011.lzma 2025-06-02T15:17:30.191Z,1748877450.191 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Express0011.lzma.bak 2025-06-02T15:17:30.192Z,1748877450.192 [DataOverHttps](INFO): SBD MOMSN=25072512 2025-06-02T15:17:31.409Z,1748877451.409 [Default:CheckIn:Read_Iridium] Stopped 2025-06-02T15:17:31.409Z,1748877451.409 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-02T15:17:31.409Z,1748877451.409 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-02T15:19:24.116Z,1748877564.116 [NAL9602](INFO): SBD MO Status=2, MOMSN=20820, MT Status=2, MTMSN=0 2025-06-02T15:19:24.116Z,1748877564.116 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-06-02T15:19:41.488Z,1748877581.488 [NAL9602](INFO): SBD MO Status=2, MOMSN=20820, MT Status=2, MTMSN=0 2025-06-02T15:19:41.488Z,1748877581.488 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-06-02T15:22:06.129Z,1748877726.129 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-06-02T15:22:31.996Z,1748877751.996 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-02T15:22:31.996Z,1748877751.996 [Default:CheckIn:C.Wait] Stopped 2025-06-02T15:22:31.996Z,1748877751.996 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-02T15:22:31.996Z,1748877751.996 [Default:CheckIn:D] Running Loop=1 2025-06-02T15:22:32.401Z,1748877752.401 [Default:CheckIn:D] Stopped 2025-06-02T15:22:32.401Z,1748877752.401 [Default:CheckIn:E] Running Loop=1 2025-06-02T15:22:32.818Z,1748877752.818 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.021505 min 2025-06-02T15:22:32.818Z,1748877752.818 [Default:CheckIn:E] Stopped 2025-06-02T15:22:32.818Z,1748877752.818 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-02T15:22:32.818Z,1748877752.818 [Default:CheckIn] Stopped 2025-06-02T15:22:32.819Z,1748877752.819 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-02T15:22:32.819Z,1748877752.819 [Default:CheckIn](INFO): Running loop #4 2025-06-02T15:22:32.819Z,1748877752.819 [Default:CheckIn] Running Loop=4 2025-06-02T15:22:32.819Z,1748877752.819 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-02T15:22:32.819Z,1748877752.819 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-02T15:22:34.811Z,1748877754.811 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152234.00,A,3648.16000,N,12147.28409,W,0.078,333.98,020625,,,A*79 2025-06-02T15:22:34.814Z,1748877754.814 [NAL9602](INFO): GPS fix at 20250602T152234: (36.802667, -121.788068) 2025-06-02T15:22:34.825Z,1748877754.825 [Default:CheckIn:Read_GPS] Stopped 2025-06-02T15:22:34.825Z,1748877754.825 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-02T15:22:42.593Z,1748877762.593 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250602T145252/Courier0013.lzma 2025-06-02T15:22:43.595Z,1748877763.595 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Courier0013.lzma.bak 2025-06-02T15:22:43.595Z,1748877763.595 [DataOverHttps](INFO): SBD MOMSN=25072571 2025-06-02T15:22:59.426Z,1748877779.426 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20250602T145252/Express0014.lzma 2025-06-02T15:23:00.427Z,1748877780.427 [DataOverHttps](INFO): Moved sent file to Logs/20250602T145252/Express0014.lzma.bak 2025-06-02T15:23:00.427Z,1748877780.427 [DataOverHttps](INFO): SBD MOMSN=25072574 2025-06-02T15:23:01.521Z,1748877781.521 [Default:CheckIn:Read_Iridium] Stopped 2025-06-02T15:23:01.522Z,1748877781.522 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-02T15:23:01.522Z,1748877781.522 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-02T15:23:07.562Z,1748877787.562 [NAL9602](INFO): Not Powering down - fast GPS 2025-06-02T15:24:21.563Z,1748877861.563 [CommandExec](IMPORTANT): got command restart application 2025-06-02T15:24:22.565Z,1748877862.565 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2025-06-02T15:24:22.566Z,1748877862.566 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:22.566Z,1748877862.566 [CommandExec](INFO): Uninitializing the command executive. 2025-06-02T15:24:22.566Z,1748877862.566 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-02T15:24:22.566Z,1748877862.566 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:22.681Z,1748877862.681 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-02T15:24:22.681Z,1748877862.681 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-02T15:24:22.682Z,1748877862.682 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:22.682Z,1748877862.682 [NavChartDb](INFO): Join timeout helper Thread ID is 4028 2025-06-02T15:24:22.858Z,1748877862.858 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:22.858Z,1748877862.858 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:22.879Z,1748877862.879 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-02T15:24:22.879Z,1748877862.879 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:22.880Z,1748877862.880 [Radio_Surface](INFO): Join timeout helper Thread ID is 4029 2025-06-02T15:24:23.238Z,1748877863.238 [Radio_Surface](INFO): Powering down 2025-06-02T15:24:23.238Z,1748877863.238 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:23.239Z,1748877863.239 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:23.249Z,1748877863.249 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-06-02T15:24:23.249Z,1748877863.249 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:23.250Z,1748877863.250 [Onboard](INFO): Join timeout helper Thread ID is 4030 2025-06-02T15:24:23.326Z,1748877863.326 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-06-02T15:24:26.042Z,1748877866.042 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:26.042Z,1748877866.042 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.061Z,1748877866.061 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-06-02T15:24:26.061Z,1748877866.061 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.062Z,1748877866.062 [DataOverHttps](INFO): Join timeout helper Thread ID is 4031 2025-06-02T15:24:26.338Z,1748877866.338 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:26.338Z,1748877866.338 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.344Z,1748877866.344 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-06-02T15:24:26.344Z,1748877866.344 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.345Z,1748877866.345 [DAT](INFO): Join timeout helper Thread ID is 4032 2025-06-02T15:24:26.486Z,1748877866.486 [DAT](INFO): Powering down 2025-06-02T15:24:26.554Z,1748877866.554 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:26.554Z,1748877866.554 [DAT](INFO): Powering down 2025-06-02T15:24:26.555Z,1748877866.555 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.574Z,1748877866.574 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-06-02T15:24:26.575Z,1748877866.575 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.575Z,1748877866.575 [BackseatComponent](INFO): Join timeout helper Thread ID is 4033 2025-06-02T15:24:26.698Z,1748877866.698 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:26.698Z,1748877866.698 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.718Z,1748877866.718 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-06-02T15:24:26.718Z,1748877866.718 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:26.719Z,1748877866.719 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4034 2025-06-02T15:24:27.214Z,1748877867.214 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:27.214Z,1748877867.214 [WetLabsBB2FL](INFO): Powering down 2025-06-02T15:24:27.215Z,1748877867.215 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.216Z,1748877867.216 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-06-02T15:24:27.216Z,1748877867.216 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.216Z,1748877867.216 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4035 2025-06-02T15:24:27.381Z,1748877867.381 [CTD_Seabird](INFO): Powering down 2025-06-02T15:24:27.393Z,1748877867.393 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:27.394Z,1748877867.394 [CTD_Seabird](INFO): Powering down 2025-06-02T15:24:27.413Z,1748877867.413 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.424Z,1748877867.424 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-06-02T15:24:27.424Z,1748877867.424 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.425Z,1748877867.425 [logger](INFO): Join timeout helper Thread ID is 4036 2025-06-02T15:24:27.449Z,1748877867.449 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:27.449Z,1748877867.449 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.451Z,1748877867.451 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-06-02T15:24:27.451Z,1748877867.451 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.451Z,1748877867.451 [CommandLine](INFO): Join timeout helper Thread ID is 4037 2025-06-02T15:24:27.550Z,1748877867.550 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:27.550Z,1748877867.550 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.558Z,1748877867.558 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-06-02T15:24:27.558Z,1748877867.558 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.559Z,1748877867.559 [CommandExec](INFO): Join timeout helper Thread ID is 4038 2025-06-02T15:24:27.562Z,1748877867.562 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-06-02T15:24:27.562Z,1748877867.562 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.563Z,1748877867.563 [controlThread](INFO): Join timeout helper Thread ID is 4039 2025-06-02T15:24:27.584Z,1748877867.584 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-02T15:24:27.584Z,1748877867.584 [controlThread](DEBUG): Uninitializing ControlThread 2025-06-02T15:24:27.584Z,1748877867.584 [AHRS_M2](INFO): Powering down 2025-06-02T15:24:27.662Z,1748877867.662 [NAL9602](INFO): Powering down 2025-06-02T15:24:27.663Z,1748877867.663 [Sonardyne_Nano](INFO): Powering down 2025-06-02T15:24:27.870Z,1748877867.870 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-06-02T15:24:27.870Z,1748877867.870 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-06-02T15:24:27.871Z,1748877867.871 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-06-02T15:24:27.871Z,1748877867.871 [MissionManager](INFO): Uninitializing Mission Default 2025-06-02T15:24:27.872Z,1748877867.872 [Default] Stopped 2025-06-02T15:24:27.872Z,1748877867.872 [Default](DEBUG): Aggregate::uninitialize Default 2025-06-02T15:24:27.872Z,1748877867.872 [Default:B.GoToSurface] Stopped 2025-06-02T15:24:27.872Z,1748877867.872 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-02T15:24:27.872Z,1748877867.872 [Default:CheckIn] Stopped 2025-06-02T15:24:27.872Z,1748877867.872 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-02T15:24:27.872Z,1748877867.872 [Default:CheckIn:C.Wait] Stopped 2025-06-02T15:24:27.872Z,1748877867.872 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-02T15:24:27.875Z,1748877867.875 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-06-02T15:24:27.876Z,1748877867.876 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-06-02T15:24:27.876Z,1748877867.876 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-06-02T15:24:27.876Z,1748877867.876 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-06-02T15:24:27.876Z,1748877867.876 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-06-02T15:24:27.877Z,1748877867.877 [BuoyancyServo](INFO): Powering down 2025-06-02T15:24:27.890Z,1748877867.890 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-02T15:24:27.890Z,1748877867.890 [ElevatorServo](INFO): Powering down 2025-06-02T15:24:27.891Z,1748877867.891 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-06-02T15:24:27.891Z,1748877867.891 [MassServo](INFO): Powering down 2025-06-02T15:24:27.891Z,1748877867.891 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-06-02T15:24:27.892Z,1748877867.892 [RudderServo](INFO): Powering down 2025-06-02T15:24:27.892Z,1748877867.892 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-06-02T15:24:27.892Z,1748877867.892 [ThrusterHE](INFO): Powering down 2025-06-02T15:24:27.893Z,1748877867.893 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-06-02T15:24:27.894Z,1748877867.894 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-06-02T15:24:27.894Z,1748877867.894 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-06-02T15:24:27.894Z,1748877867.894 [CBIT](DEBUG): Powering off loads. 2025-06-02T15:24:27.905Z,1748877867.905 [CBIT](DEBUG): Disabling WDT. 2025-06-02T15:24:27.917Z,1748877867.917 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-06-02T15:24:27.918Z,1748877867.918 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-06-02T15:24:27.919Z,1748877867.919 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.948Z,1748877867.948 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-06-02T15:24:27.948Z,1748877867.948 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-06-02T15:24:27.964Z,1748877867.964 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:27.971Z,1748877867.971 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.004Z,1748877868.004 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.007Z,1748877868.007 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.014Z,1748877868.014 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.020Z,1748877868.020 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.065Z,1748877868.065 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.119Z,1748877868.119 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-02T15:24:28.179Z,1748877868.179 [logger ThreadHandler](INFO): Thread cancelled.