2025-06-17T22:36:29.705Z,1750199789.705 [Supervisor](DEBUG): Initializing supervisor. 2025-06-17T22:36:29.710Z,1750199789.710 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-06-17T22:36:29.710Z,1750199789.710 [SyncHandler](INFO): Protected caller Thread ID is 1802 2025-06-17T22:36:29.711Z,1750199789.711 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-06-17T22:36:29.712Z,1750199789.712 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-06-17T22:36:29.713Z,1750199789.713 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1803 2025-06-17T22:36:29.717Z,1750199789.717 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-06-17T22:36:29.737Z,1750199789.737 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-06-17T22:36:29.738Z,1750199789.738 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-06-17T22:36:29.739Z,1750199789.739 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1804 2025-06-17T22:36:29.743Z,1750199789.743 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-06-17T22:36:29.744Z,1750199789.744 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-06-17T22:36:29.745Z,1750199789.745 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1805 2025-06-17T22:36:29.747Z,1750199789.747 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-06-17T22:36:29.748Z,1750199789.748 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-06-17T22:36:29.748Z,1750199789.748 [logger ThreadHandler](INFO): Protected caller Thread ID is 1806 2025-06-17T22:36:29.752Z,1750199789.752 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-06-17T22:36:29.753Z,1750199789.753 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-06-17T22:36:29.754Z,1750199789.754 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-06-17T22:36:29.859Z,1750199789.859 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-06-17T22:36:29.860Z,1750199789.860 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-06-17T22:36:30.090Z,1750199790.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-06-17T22:36:30.091Z,1750199790.091 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-06-17T22:36:30.361Z,1750199790.361 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-06-17T22:36:30.362Z,1750199790.362 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-06-17T22:36:30.477Z,1750199790.477 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-06-17T22:36:30.478Z,1750199790.478 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-06-17T22:36:31.237Z,1750199791.237 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-06-17T22:36:31.238Z,1750199791.238 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-06-17T22:36:31.757Z,1750199791.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-06-17T22:36:31.758Z,1750199791.758 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-06-17T22:36:32.311Z,1750199792.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-06-17T22:36:32.312Z,1750199792.312 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-06-17T22:36:32.736Z,1750199792.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-06-17T22:36:32.737Z,1750199792.737 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-06-17T22:36:33.098Z,1750199793.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-06-17T22:36:33.098Z,1750199793.098 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-06-17T22:36:33.486Z,1750199793.486 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-06-17T22:36:33.487Z,1750199793.487 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-06-17T22:36:33.720Z,1750199793.720 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-06-17T22:36:33.721Z,1750199793.721 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-06-17T22:36:33.919Z,1750199793.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-06-17T22:36:33.919Z,1750199793.919 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-06-17T22:36:34.121Z,1750199794.121 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-06-17T22:36:34.122Z,1750199794.122 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-06-17T22:36:34.296Z,1750199794.296 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-06-17T22:36:34.701Z,1750199794.701 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-06-17T22:36:34.701Z,1750199794.701 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-06-17T22:36:34.963Z,1750199794.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-06-17T22:36:34.965Z,1750199794.965 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-06-17T22:36:34.966Z,1750199794.966 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-06-17T22:36:35.059Z,1750199795.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-06-17T22:36:35.335Z,1750199795.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-06-17T22:36:35.336Z,1750199795.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-06-17T22:36:35.430Z,1750199795.430 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-06-17T22:36:35.610Z,1750199795.610 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-06-17T22:36:35.721Z,1750199795.721 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-06-17T22:36:35.841Z,1750199795.841 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-06-17T22:36:35.964Z,1750199795.964 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-06-17T22:36:36.068Z,1750199796.068 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-06-17T22:36:36.240Z,1750199796.240 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-06-17T22:36:36.357Z,1750199796.357 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-06-17T22:36:36.452Z,1750199796.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-06-17T22:36:36.560Z,1750199796.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-06-17T22:36:36.658Z,1750199796.658 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2025-06-17T22:36:36.658Z,1750199796.658 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-06-17T22:36:36.669Z,1750199796.669 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-06-17T22:36:36.858Z,1750199796.858 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-06-17T22:36:36.859Z,1750199796.859 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-06-17T22:36:37.030Z,1750199797.030 [BuoyancyServo] Loaded 2025-06-17T22:36:37.030Z,1750199797.030 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-06-17T22:36:37.054Z,1750199797.054 [ElevatorServo] Loaded 2025-06-17T22:36:37.054Z,1750199797.054 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-06-17T22:36:37.076Z,1750199797.076 [MassServo] Loaded 2025-06-17T22:36:37.077Z,1750199797.077 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-06-17T22:36:37.099Z,1750199797.099 [RudderServo] Loaded 2025-06-17T22:36:37.099Z,1750199797.099 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-06-17T22:36:37.117Z,1750199797.117 [ThrusterHE] Loaded 2025-06-17T22:36:37.117Z,1750199797.117 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-06-17T22:36:37.118Z,1750199797.118 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-06-17T22:36:37.118Z,1750199797.118 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-06-17T22:36:37.290Z,1750199797.290 [SBIT](DEBUG): Construct Startup Built In Test. 2025-06-17T22:36:37.305Z,1750199797.305 [SBIT] Loaded 2025-06-17T22:36:37.306Z,1750199797.306 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-06-17T22:36:37.308Z,1750199797.308 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-06-17T22:36:37.330Z,1750199797.330 [IBIT] Loaded 2025-06-17T22:36:37.330Z,1750199797.330 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-06-17T22:36:37.335Z,1750199797.335 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-06-17T22:36:37.530Z,1750199797.530 [CBIT] Loaded 2025-06-17T22:36:37.530Z,1750199797.530 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-06-17T22:36:37.561Z,1750199797.561 [GFScanner] Loaded 2025-06-17T22:36:37.561Z,1750199797.561 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-06-17T22:36:37.562Z,1750199797.562 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-06-17T22:36:37.563Z,1750199797.563 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-06-17T22:36:37.737Z,1750199797.737 [CTD_Seabird] Loaded 2025-06-17T22:36:37.737Z,1750199797.737 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-06-17T22:36:37.739Z,1750199797.739 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406864E0 2025-06-17T22:36:37.739Z,1750199797.739 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1894 2025-06-17T22:36:37.774Z,1750199797.774 [ESPComponent] Loaded 2025-06-17T22:36:37.774Z,1750199797.774 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-06-17T22:36:37.797Z,1750199797.797 [PAR_Licor] Loaded 2025-06-17T22:36:37.797Z,1750199797.797 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-06-17T22:36:37.842Z,1750199797.842 [WetLabsBB2FL] Loaded 2025-06-17T22:36:37.842Z,1750199797.842 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-06-17T22:36:37.843Z,1750199797.843 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B64E0 2025-06-17T22:36:37.844Z,1750199797.844 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1895 2025-06-17T22:36:37.845Z,1750199797.845 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-06-17T22:36:37.845Z,1750199797.845 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-06-17T22:36:37.898Z,1750199797.898 [DepthRateCalculator] Loaded 2025-06-17T22:36:37.899Z,1750199797.899 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-06-17T22:36:37.904Z,1750199797.904 [PitchRateCalculator] Loaded 2025-06-17T22:36:37.904Z,1750199797.904 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-06-17T22:36:37.915Z,1750199797.915 [SpeedCalculator] Loaded 2025-06-17T22:36:37.915Z,1750199797.915 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-06-17T22:36:37.920Z,1750199797.920 [YawRateCalculator] Loaded 2025-06-17T22:36:37.920Z,1750199797.920 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-06-17T22:36:37.940Z,1750199797.940 [ElevatorOffsetCalculator] Loaded 2025-06-17T22:36:37.940Z,1750199797.940 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-06-17T22:36:37.941Z,1750199797.941 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-06-17T22:36:37.941Z,1750199797.941 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-06-17T22:36:38.085Z,1750199798.085 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-06-17T22:36:38.086Z,1750199798.086 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-06-17T22:36:38.116Z,1750199798.116 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-06-17T22:36:38.117Z,1750199798.117 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-06-17T22:36:38.233Z,1750199798.233 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-06-17T22:36:38.234Z,1750199798.234 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-06-17T22:36:38.248Z,1750199798.248 [NavChart] Loaded 2025-06-17T22:36:38.248Z,1750199798.248 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-06-17T22:36:38.254Z,1750199798.254 [UniversalFixResidualReporter] Loaded 2025-06-17T22:36:38.254Z,1750199798.254 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-06-17T22:36:38.255Z,1750199798.255 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-06-17T22:36:38.255Z,1750199798.255 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-06-17T22:36:38.766Z,1750199798.766 [AHRS_M2] Loaded 2025-06-17T22:36:38.766Z,1750199798.766 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-06-17T22:36:38.805Z,1750199798.805 [BackseatComponent] Loaded 2025-06-17T22:36:38.806Z,1750199798.806 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-06-17T22:36:38.807Z,1750199798.807 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0 2025-06-17T22:36:38.807Z,1750199798.807 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1896 2025-06-17T22:36:38.810Z,1750199798.810 [LcmUniversalReporter] Loaded 2025-06-17T22:36:38.810Z,1750199798.810 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-06-17T22:36:39.828Z,1750199799.828 [BPC1] Loaded 2025-06-17T22:36:39.828Z,1750199799.828 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-06-17T22:36:40.024Z,1750199800.024 [DAT] Loaded 2025-06-17T22:36:40.025Z,1750199800.025 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-06-17T22:36:40.026Z,1750199800.026 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AB24E0 2025-06-17T22:36:40.026Z,1750199800.026 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1897 2025-06-17T22:36:40.166Z,1750199800.166 [DataOverHttps] Loaded 2025-06-17T22:36:40.166Z,1750199800.166 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-06-17T22:36:40.167Z,1750199800.167 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AE24E0 2025-06-17T22:36:40.167Z,1750199800.167 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1898 2025-06-17T22:36:40.191Z,1750199800.191 [Depth_Keller] Loaded 2025-06-17T22:36:40.192Z,1750199800.192 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-06-17T22:36:40.197Z,1750199800.197 [DropWeight] Loaded 2025-06-17T22:36:40.197Z,1750199800.197 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-06-17T22:36:40.238Z,1750199800.238 [DVL_micro] Loaded 2025-06-17T22:36:40.239Z,1750199800.239 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-06-17T22:36:40.303Z,1750199800.303 [NAL9602] Loaded 2025-06-17T22:36:40.303Z,1750199800.303 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-06-17T22:36:40.329Z,1750199800.329 [Onboard] Loaded 2025-06-17T22:36:40.329Z,1750199800.329 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-06-17T22:36:40.330Z,1750199800.330 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B124E0 2025-06-17T22:36:40.331Z,1750199800.331 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1899 2025-06-17T22:36:40.337Z,1750199800.337 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1 2025-06-17T22:36:40.351Z,1750199800.351 [PowerOnly] Loaded 2025-06-17T22:36:40.351Z,1750199800.351 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-06-17T22:36:40.365Z,1750199800.365 [Power24vConverter] Loaded 2025-06-17T22:36:40.366Z,1750199800.366 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-06-17T22:36:40.382Z,1750199800.382 [Radio_Surface] Loaded 2025-06-17T22:36:40.383Z,1750199800.383 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-06-17T22:36:40.384Z,1750199800.384 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B424E0 2025-06-17T22:36:40.384Z,1750199800.384 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1900 2025-06-17T22:36:40.400Z,1750199800.400 [Sonardyne_Nano] Loaded 2025-06-17T22:36:40.400Z,1750199800.400 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-06-17T22:36:40.401Z,1750199800.401 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-06-17T22:36:40.401Z,1750199800.401 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-06-17T22:36:40.464Z,1750199800.464 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-06-17T22:36:40.465Z,1750199800.465 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-06-17T22:36:40.521Z,1750199800.521 [VerticalControl](DEBUG): Construct VerticalControl. 2025-06-17T22:36:40.574Z,1750199800.574 [VerticalControl] Loaded 2025-06-17T22:36:40.574Z,1750199800.574 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-06-17T22:36:40.577Z,1750199800.577 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-06-17T22:36:40.622Z,1750199800.622 [HorizontalControl] Loaded 2025-06-17T22:36:40.622Z,1750199800.622 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-06-17T22:36:40.625Z,1750199800.625 [SpeedControl](DEBUG): Construct SpeedControl. 2025-06-17T22:36:40.627Z,1750199800.627 [SpeedControl] Loaded 2025-06-17T22:36:40.627Z,1750199800.627 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-06-17T22:36:40.630Z,1750199800.630 [LoopControl](DEBUG): Construct LoopControl. 2025-06-17T22:36:40.630Z,1750199800.630 [LoopControl] Loaded 2025-06-17T22:36:40.631Z,1750199800.631 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-06-17T22:36:40.631Z,1750199800.631 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-06-17T22:36:40.632Z,1750199800.632 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-06-17T22:36:40.643Z,1750199800.643 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-06-17T22:36:40.643Z,1750199800.643 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-06-17T22:36:41.013Z,1750199801.013 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-06-17T22:36:41.019Z,1750199801.019 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-06-17T22:36:41.022Z,1750199801.022 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-06-17T22:36:41.034Z,1750199801.034 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-06-17T22:36:41.035Z,1750199801.035 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C684E0 2025-06-17T22:36:41.035Z,1750199801.035 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1901 2025-06-17T22:36:41.040Z,1750199801.040 [Supervisor](INFO): Main Thread ID is 827 2025-06-17T22:36:41.040Z,1750199801.040 [Supervisor](DEBUG): Running supervisor. 2025-06-17T22:36:41.040Z,1750199801.040 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1902 2025-06-17T22:36:41.041Z,1750199801.041 [CommandExec](INFO): Initializing the command executive. 2025-06-17T22:36:41.043Z,1750199801.043 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1903 2025-06-17T22:36:41.045Z,1750199801.045 [controlThread ThreadHandler](INFO): Handler Thread ID is 1904 2025-06-17T22:36:41.045Z,1750199801.045 [controlThread](DEBUG): Initializing ControlThread 2025-06-17T22:36:41.047Z,1750199801.047 [SBIT](INFO): Initialize SBIT Component. 2025-06-17T22:36:41.048Z,1750199801.048 [SBIT](IMPORTANT): git: 2025-05-29 2025-06-17T22:36:41.048Z,1750199801.048 [SBIT](INFO): git hash: c78c975c7bb2a66b27244d2837f68dff299fa024 2025-06-17T22:36:41.048Z,1750199801.048 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-06-17T22:36:41.050Z,1750199801.050 [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-17T22:36:41.051Z,1750199801.051 [SBIT](INFO): Beginning SBIT in 151.000000 seconds. 2025-06-17T22:36:41.051Z,1750199801.051 [IBIT](INFO): Initialize IBIT Component. 2025-06-17T22:36:41.052Z,1750199801.052 [CBIT](DEBUG): Initialize CBIT Component. 2025-06-17T22:36:41.053Z,1750199801.053 [logger ThreadHandler](INFO): Handler Thread ID is 1905 2025-06-17T22:36:41.064Z,1750199801.064 [CBIT](DEBUG): Initialized mux pins. 2025-06-17T22:36:41.064Z,1750199801.064 [CBIT](DEBUG): Initializing the watchdog timer. 2025-06-17T22:36:41.072Z,1750199801.072 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1906 2025-06-17T22:36:41.073Z,1750199801.073 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-06-17T22:36:41.078Z,1750199801.078 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1908 2025-06-17T22:36:41.080Z,1750199801.080 [WetLabsBB2FL](INFO): Powering up 2025-06-17T22:36:41.082Z,1750199801.082 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1910 2025-06-17T22:36:41.088Z,1750199801.088 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-06-17T22:36:41.088Z,1750199801.088 [CBIT](DEBUG): Initializing heartbeat. 2025-06-17T22:36:41.089Z,1750199801.089 [DAT ThreadHandler](INFO): Handler Thread ID is 1911 2025-06-17T22:36:41.090Z,1750199801.090 [DAT](INFO): Powering up 2025-06-17T22:36:41.090Z,1750199801.090 [DAT](DEBUG): Initializing DAT. 2025-06-17T22:36:41.093Z,1750199801.093 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1913 2025-06-17T22:36:41.095Z,1750199801.095 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-06-17T22:36:41.105Z,1750199801.105 [Onboard ThreadHandler](INFO): Handler Thread ID is 1914 2025-06-17T22:36:41.122Z,1750199801.122 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1915 2025-06-17T22:36:41.140Z,1750199801.140 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1916 2025-06-17T22:36:41.147Z,1750199801.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-06-17T22:36:41.147Z,1750199801.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-06-17T22:36:41.147Z,1750199801.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-06-17T22:36:41.147Z,1750199801.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-06-17T22:36:41.147Z,1750199801.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-06-17T22:36:41.147Z,1750199801.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-06-17T22:36:41.148Z,1750199801.148 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-06-17T22:36:41.148Z,1750199801.148 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-06-17T22:36:41.160Z,1750199801.160 [CBIT](DEBUG): Deactivating emergency mode. 2025-06-17T22:36:41.200Z,1750199801.200 [CBIT](DEBUG): Backplane powered. 2025-06-17T22:36:41.200Z,1750199801.200 [GFScanner](DEBUG): Initializing GFScanner 2025-06-17T22:36:41.200Z,1750199801.200 [GFScanner](DEBUG): Deactivating GF circuits. 2025-06-17T22:36:41.208Z,1750199801.208 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-06-17T22:36:41.209Z,1750199801.209 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-06-17T22:36:41.209Z,1750199801.209 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-06-17T22:36:41.209Z,1750199801.209 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-06-17T22:36:41.210Z,1750199801.210 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-06-17T22:36:41.211Z,1750199801.211 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-06-17T22:36:41.211Z,1750199801.211 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-06-17T22:36:41.215Z,1750199801.215 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-06-17T22:36:41.221Z,1750199801.221 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-06-17T22:36:41.221Z,1750199801.221 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-06-17T22:36:41.222Z,1750199801.222 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-06-17T22:36:41.222Z,1750199801.222 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-06-17T22:36:41.223Z,1750199801.223 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-06-17T22:36:41.223Z,1750199801.223 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-06-17T22:36:41.233Z,1750199801.233 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-06-17T22:36:41.311Z,1750199801.311 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-06-17T22:36:41.315Z,1750199801.315 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-17T22:36:41.388Z,1750199801.388 [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-17T22:36:41.389Z,1750199801.389 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-06-17T22:36:41.389Z,1750199801.389 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-06-17T22:36:41.390Z,1750199801.390 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-06-17T22:36:41.528Z,1750199801.528 [Radio_Surface](INFO): Powering up 2025-06-17T22:36:41.705Z,1750199801.705 [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-17T22:36:41.731Z,1750199801.731 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-06-17T22:36:41.732Z,1750199801.732 [Default:A.Wait](DEBUG): Construct Wait. 2025-06-17T22:36:41.735Z,1750199801.735 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-17T22:36:41.776Z,1750199801.776 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-06-17T22:36:41.779Z,1750199801.779 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-06-17T22:36:41.805Z,1750199801.805 [Default:E.Execute](DEBUG): Construct Execute. 2025-06-17T22:36:41.824Z,1750199801.824 [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-17T22:36:41.829Z,1750199801.829 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-06-17T22:36:41.851Z,1750199801.851 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-17T22:36:41.920Z,1750199801.920 [Depth_Keller](INFO): Initializing. 2025-06-17T22:36:41.924Z,1750199801.924 [PowerOnly](INFO): Powering up loadControl 2025-06-17T22:36:41.940Z,1750199801.940 [Power24vConverter](INFO): Powering up. 2025-06-17T22:36:41.941Z,1750199801.941 [Sonardyne_Nano](INFO): Initializing. 2025-06-17T22:36:41.968Z,1750199801.968 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-06-17T22:36:41.995Z,1750199801.995 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-17T22:36:42.000Z,1750199802.000 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-17T22:36:42.001Z,1750199802.001 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-17T22:36:42.008Z,1750199802.008 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-17T22:36:42.009Z,1750199802.009 [MassServo](DEBUG): Initializing EZServoServo. 2025-06-17T22:36:42.016Z,1750199802.016 [MassServo](DEBUG): Initializing MassServo. 2025-06-17T22:36:42.017Z,1750199802.017 [RudderServo](DEBUG): Initializing EZServoServo. 2025-06-17T22:36:42.024Z,1750199802.024 [RudderServo](DEBUG): Initializing RudderServo. 2025-06-17T22:36:42.025Z,1750199802.025 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-06-17T22:36:42.032Z,1750199802.032 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-06-17T22:36:42.292Z,1750199802.292 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-06-17T22:36:42.292Z,1750199802.292 [DropWeight] Hardware Fault, FailCount= 1 2025-06-17T22:36:42.292Z,1750199802.292 [DropWeight](ERROR): Hardware Fault 2025-06-17T22:36:42.319Z,1750199802.319 [CommandExec](FAULT): Scheduling is paused 2025-06-17T22:36:42.319Z,1750199802.319 [CBIT](INFO): Critical error at 20250617T223642 2025-06-17T22:36:42.319Z,1750199802.319 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-06-17T22:36:42.330Z,1750199802.330 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-06-17T22:36:42.331Z,1750199802.331 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-06-17T22:36:42.690Z,1750199802.690 [CBIT](INFO): Critical error at 20250617T223642 2025-06-17T22:36:43.692Z,1750199803.692 [WetLabsBB2FL](INFO): Powering down 2025-06-17T22:36:44.268Z,1750199804.268 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-17T22:36:45.518Z,1750199805.518 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-06-17T22:36:48.105Z,1750199808.105 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-06-17T22:36:53.193Z,1750199813.193 [DAT](INFO): DAT read: 2025-06-17T22:36:53.194Z,1750199813.194 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-17T22:36:54.957Z,1750199814.957 [DAT](INFO): DAT read: MF Frequency Band 2025-06-17T22:36:54.958Z,1750199814.958 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-17T22:36:54.959Z,1750199814.959 [DAT](INFO): DAT read: Jun 17 2025 22:36:49 2025-06-17T22:36:56.217Z,1750199816.217 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-06-17T22:36:56.218Z,1750199816.218 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-06-17T22:36:56.218Z,1750199816.218 [DAT](INFO): commRate: 1200 2025-06-17T22:36:58.284Z,1750199818.284 [DAT](INFO): entering command mode 2025-06-17T22:36:58.484Z,1750199818.484 [DAT](INFO): DAT read: 2025-06-17T22:36:58.485Z,1750199818.485 [DAT](INFO): DAT read: user:1> 2025-06-17T22:36:58.485Z,1750199818.485 [DAT](INFO): setting verbose to 3 2025-06-17T22:36:58.737Z,1750199818.737 [DAT](INFO): DAT read: user:1> 2025-06-17T22:36:58.738Z,1750199818.738 [DAT](INFO): DAT read: Verbose | 3 2025-06-17T22:36:58.738Z,1750199818.738 [DAT](INFO): set verbose to 3 2025-06-17T22:36:58.738Z,1750199818.738 [DAT](INFO): setting DatVerbose to 27440 2025-06-17T22:36:58.989Z,1750199818.989 [DAT](INFO): DAT read: user:2> 2025-06-17T22:36:58.990Z,1750199818.990 [DAT](INFO): DAT read: DatVerbose | 27440 2025-06-17T22:36:58.990Z,1750199818.990 [DAT](INFO): set DatVerbose to 27440 2025-06-17T22:36:58.990Z,1750199818.990 [DAT](INFO): setting transmit power to 8 2025-06-17T22:36:59.240Z,1750199819.240 [DAT](INFO): DAT read: user:3> 2025-06-17T22:36:59.241Z,1750199819.241 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-06-17T22:36:59.242Z,1750199819.242 [DAT](INFO): set transmit power to 8 2025-06-17T22:36:59.242Z,1750199819.242 [DAT](INFO): setting local address to 5 2025-06-17T22:36:59.493Z,1750199819.493 [DAT](INFO): DAT read: user:4> 2025-06-17T22:36:59.494Z,1750199819.494 [DAT](INFO): DAT read: LocalAddr | 5 2025-06-17T22:36:59.494Z,1750199819.494 [DAT](INFO): set local address to 5 2025-06-17T22:36:59.495Z,1750199819.495 [DAT](INFO): Setting time to: 22:36:59 And date to:6/17/2025 2025-06-17T22:36:59.745Z,1750199819.745 [DAT](INFO): DAT read: user:5> 2025-06-17T22:36:59.747Z,1750199819.747 [DAT](INFO): DAT read: Tue Jun 17, 2025 22:36:59 2025-06-17T22:36:59.747Z,1750199819.747 [DAT](INFO): Local DAT time set to Tue Jun 17, 2025 22:36:59 2025-06-17T22:37:10.582Z,1750199830.582 [NAL9602](INFO): Powering up NAL9602 2025-06-17T22:37:21.467Z,1750199841.467 [NAL9602](INFO): NAL9602 initialized 2025-06-17T22:37:26.254Z,1750199846.254 [CommandExec](IMPORTANT): got command strobe off 2025-06-17T22:37:26.254Z,1750199846.254 [CommandExec](IMPORTANT): Deactivating strobe 2025-06-17T22:38:52.998Z,1750199932.998 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004441 2025-06-17T22:39:12.626Z,1750199952.626 [SBIT](IMPORTANT): Beginning Startup BIT 2025-06-17T22:39:12.631Z,1750199952.631 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-17T22:39:17.125Z,1750199957.125 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.086005 CHAN A1 (24V): 0.100540 CHAN A2 (12V): -0.000393 CHAN A3 (5V): -0.033751 CHAN B0 (3.3V): -0.023841 CHAN B1 (3.15aV): -0.019383 CHAN B2 (3.15bV): -0.013300 CHAN B3 (GND): -0.028845 OPEN: 0.007399 Full Scale: +/- 1 mA 2025-06-17T22:39:41.384Z,1750199981.384 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-06-17T22:39:41.384Z,1750199981.384 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:39:41.395Z,1750199981.395 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:39:41.790Z,1750199981.790 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:39:41.790Z,1750199981.790 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-06-17T22:39:45.420Z,1750199985.420 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-17T22:40:06.800Z,1750200006.800 [SBIT](IMPORTANT): SBIT PASSED 2025-06-17T22:40:06.800Z,1750200006.800 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-06-17T22:40:06.801Z,1750200006.801 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2025-06-17T22:40:06.801Z,1750200006.801 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool; 2025-06-17T22:40:06.801Z,1750200006.801 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=1 bool; 2025-06-17T22:40:06.801Z,1750200006.801 [SBIT](IMPORTANT): ElevatorServo.currLimit=20 percent; 2025-06-17T22:40:06.801Z,1750200006.801 [SBIT](IMPORTANT): Express linearApproximation PowerOnly.component_avgCurrent_loadControl 50.000000 milliampere; 2025-06-17T22:40:06.801Z,1750200006.801 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-20 ampere_hour; 2025-06-17T22:40:06.802Z,1750200006.802 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=10 volt; 2025-06-17T22:40:06.802Z,1750200006.802 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=1 bool; 2025-06-17T22:40:06.802Z,1750200006.802 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=269.964190 cubic_centimeter; 2025-06-17T22:40:06.802Z,1750200006.802 [SBIT](IMPORTANT): VerticalControl.massDefault=32.772906 millimeter; 2025-06-17T22:40:06.802Z,1750200006.802 [SBIT](IMPORTANT): Waypoint.wptRecalcBearing=1 bool; 2025-06-17T22:40:07.198Z,1750200007.198 [MissionManager](IMPORTANT): Started mission Startup 2025-06-17T22:40:07.198Z,1750200007.198 [Startup] Running Loop=1 2025-06-17T22:40:07.199Z,1750200007.199 [Startup](DEBUG): Aggregate::initialize Startup 2025-06-17T22:40:07.199Z,1750200007.199 [Startup:A.GoToSurface] Running Loop=1 2025-06-17T22:40:07.199Z,1750200007.199 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-17T22:40:07.199Z,1750200007.199 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-17T22:40:07.200Z,1750200007.200 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-17T22:40:07.201Z,1750200007.201 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-17T22:40:07.201Z,1750200007.201 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-17T22:40:07.202Z,1750200007.202 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-17T22:40:07.202Z,1750200007.202 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-17T22:40:07.220Z,1750200007.220 [Startup:StartupSatComms] Running Loop=1 2025-06-17T22:40:07.220Z,1750200007.220 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-06-17T22:40:07.220Z,1750200007.220 [Startup:StartupSatComms:A] Running Loop=1 2025-06-17T22:40:07.610Z,1750200007.610 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-06-17T22:40:14.780Z,1750200014.780 [CommandExec](IMPORTANT): got command failComponent 2025-06-17T22:40:14.781Z,1750200014.781 [CommandExec](IMPORTANT): Failed components: 2025-06-17T22:40:14.781Z,1750200014.781 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-06-17T22:40:27.069Z,1750200027.069 [CommandExec](IMPORTANT): got command failComponent 2025-06-17T22:40:27.069Z,1750200027.069 [CommandExec](IMPORTANT): Failed components: 2025-06-17T22:40:27.069Z,1750200027.069 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-06-17T22:40:39.567Z,1750200039.567 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-17T22:41:07.418Z,1750200067.418 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-17T22:40:07.2Z 2025-06-17T22:41:07.418Z,1750200067.418 [Startup:StartupSatComms:A] Stopped 2025-06-17T22:41:07.418Z,1750200067.418 [Startup:StartupSatComms:B] Running Loop=1 2025-06-17T22:41:07.802Z,1750200067.802 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-17T22:41:15.028Z,1750200075.028 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250617T222824/Courier0004.lzma 2025-06-17T22:41:16.030Z,1750200076.030 [DataOverHttps](INFO): Moved sent file to Logs/20250617T222824/Courier0004.lzma.bak 2025-06-17T22:41:16.030Z,1750200076.030 [DataOverHttps](INFO): SBD MOMSN=25223881 2025-06-17T22:41:32.047Z,1750200092.047 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20250617T223629/Courier0000.lzma 2025-06-17T22:41:33.043Z,1750200093.043 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0000.lzma.bak 2025-06-17T22:41:33.043Z,1750200093.043 [DataOverHttps](INFO): SBD MOMSN=25223883 2025-06-17T22:41:38.772Z,1750200098.772 [CommandExec](IMPORTANT): got command failComponent 2025-06-17T22:41:38.773Z,1750200098.773 [CommandExec](IMPORTANT): Failed components: 2025-06-17T22:41:38.773Z,1750200098.773 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-06-17T22:41:50.277Z,1750200110.277 [DataOverHttps](INFO): Sending 340 bytes from file Logs/20250617T222824/Express0005.lzma 2025-06-17T22:41:51.278Z,1750200111.278 [DataOverHttps](INFO): Moved sent file to Logs/20250617T222824/Express0005.lzma.bak 2025-06-17T22:41:51.278Z,1750200111.278 [DataOverHttps](INFO): SBD MOMSN=25223888 2025-06-17T22:42:07.210Z,1750200127.210 [DataOverHttps](INFO): Sending 1186 bytes from file Logs/20250617T223629/Express0001.lzma 2025-06-17T22:42:07.627Z,1750200127.627 [Startup:StartupSatComms:B](INFO): Timed out from 2025-06-17T22:41:07.4Z 2025-06-17T22:42:07.627Z,1750200127.627 [Startup:StartupSatComms:B] Stopped 2025-06-17T22:42:07.628Z,1750200127.628 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-06-17T22:42:07.628Z,1750200127.628 [Startup:StartupSatComms] Stopped 2025-06-17T22:42:07.628Z,1750200127.628 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-06-17T22:42:07.629Z,1750200127.629 [Startup](INFO): Completed Startup 2025-06-17T22:42:07.629Z,1750200127.629 [MissionManager](INFO): Startup is completed. 2025-06-17T22:42:07.629Z,1750200127.629 [MissionManager](INFO): Uninitializing Mission Startup 2025-06-17T22:42:07.629Z,1750200127.629 [Startup] Stopped 2025-06-17T22:42:07.629Z,1750200127.629 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-06-17T22:42:07.629Z,1750200127.629 [Startup:A.GoToSurface] Stopped 2025-06-17T22:42:07.630Z,1750200127.630 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-17T22:42:08.027Z,1750200128.027 [MissionManager](IMPORTANT): Started mission Default 2025-06-17T22:42:08.027Z,1750200128.027 [Default] Running Loop=1 2025-06-17T22:42:08.027Z,1750200128.027 [Default](DEBUG): Aggregate::initialize Default 2025-06-17T22:42:08.028Z,1750200128.028 [Default:B.GoToSurface] Running Loop=1 2025-06-17T22:42:08.028Z,1750200128.028 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-17T22:42:08.028Z,1750200128.028 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-17T22:42:08.028Z,1750200128.028 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-17T22:42:08.029Z,1750200128.029 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-17T22:42:08.029Z,1750200128.029 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-17T22:42:08.029Z,1750200128.029 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-17T22:42:08.030Z,1750200128.030 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-17T22:42:08.030Z,1750200128.030 [Default:A.Wait] Running Loop=1 2025-06-17T22:42:08.030Z,1750200128.030 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-06-17T22:42:08.210Z,1750200128.210 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0001.lzma.bak 2025-06-17T22:42:08.210Z,1750200128.210 [DataOverHttps](INFO): SBD MOMSN=25223898 2025-06-17T22:42:21.353Z,1750200141.353 [CommandExec](IMPORTANT): got command failComponent 2025-06-17T22:42:21.353Z,1750200141.353 [CommandExec](IMPORTANT): Failed components: 2025-06-17T22:42:21.353Z,1750200141.353 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2025-06-17T22:42:21.357Z,1750200141.357 [Default:A.Wait](INFO): Done Waiting. 2025-06-17T22:42:21.357Z,1750200141.357 [Default:A.Wait] Stopped 2025-06-17T22:42:21.357Z,1750200141.357 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T22:42:21.759Z,1750200141.759 [Default:CheckIn] Running Loop=1 2025-06-17T22:42:21.759Z,1750200141.759 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T22:42:21.759Z,1750200141.759 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T22:42:22.158Z,1750200142.158 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-06-17T22:42:24.571Z,1750200144.571 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-06-17T22:42:42.443Z,1750200162.443 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-06-17T22:42:42.443Z,1750200162.443 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:42:42.519Z,1750200162.519 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:42:42.854Z,1750200162.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:42:42.854Z,1750200162.854 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-06-17T22:43:36.969Z,1750200216.969 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-06-17T22:45:11.469Z,1750200311.469 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-06-17T22:45:11.469Z,1750200311.469 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-06-17T22:45:11.470Z,1750200311.470 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2025-06-17T22:45:11.474Z,1750200311.474 [BPC1](INFO): Received data from all battery sticks. 2025-06-17T22:45:43.403Z,1750200343.403 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-06-17T22:45:43.403Z,1750200343.403 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:45:43.423Z,1750200343.423 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:45:43.811Z,1750200343.811 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:45:43.811Z,1750200343.811 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-06-17T22:47:21.963Z,1750200441.963 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T22:42:21.8Z 2025-06-17T22:47:21.963Z,1750200441.963 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T22:47:21.963Z,1750200441.963 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T22:47:22.366Z,1750200442.366 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-17T22:47:22.765Z,1750200442.765 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T22:47:22.765Z,1750200442.765 [NAL9602] Data Fault, FailCount= 1 2025-06-17T22:47:22.765Z,1750200442.765 [NAL9602](ERROR): Data Fault 2025-06-17T22:47:22.795Z,1750200442.795 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T22:47:23.182Z,1750200443.182 [NAL9602](INFO): Powering down 2025-06-17T22:47:23.993Z,1750200443.993 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T22:47:23.993Z,1750200443.993 [NAL9602] No Fault, FailCount= 1 2025-06-17T22:47:28.841Z,1750200448.841 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250617T223629/Courier0004.lzma 2025-06-17T22:47:29.842Z,1750200449.842 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0004.lzma.bak 2025-06-17T22:47:29.843Z,1750200449.843 [DataOverHttps](INFO): SBD MOMSN=25223937 2025-06-17T22:47:48.212Z,1750200468.212 [DataOverHttps](INFO): Sending 281 bytes from file Logs/20250617T223629/Express0005.lzma 2025-06-17T22:47:49.214Z,1750200469.214 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0005.lzma.bak 2025-06-17T22:47:49.214Z,1750200469.214 [DataOverHttps](INFO): SBD MOMSN=25223939 2025-06-17T22:47:51.076Z,1750200471.076 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T22:47:51.076Z,1750200471.076 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T22:47:51.077Z,1750200471.077 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T22:47:53.482Z,1750200473.482 [NAL9602](INFO): Powering up NAL9602 2025-06-17T22:48:04.391Z,1750200484.391 [NAL9602](INFO): NAL9602 initialized 2025-06-17T22:48:44.397Z,1750200524.397 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-06-17T22:48:44.397Z,1750200524.397 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:48:44.430Z,1750200524.430 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:48:44.838Z,1750200524.838 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:48:44.839Z,1750200524.839 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-06-17T22:51:42.575Z,1750200702.575 [CBIT](INFO): Clearing failed state for component DropWeight 2025-06-17T22:51:42.575Z,1750200702.575 [DropWeight] No Fault, FailCount= 1 2025-06-17T22:51:45.403Z,1750200705.403 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-06-17T22:51:45.403Z,1750200705.403 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:51:45.432Z,1750200705.432 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:51:45.857Z,1750200705.857 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:51:45.857Z,1750200705.857 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-06-17T22:52:51.661Z,1750200771.661 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T22:52:51.661Z,1750200771.661 [Default:CheckIn:C.Wait] Stopped 2025-06-17T22:52:51.661Z,1750200771.661 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T22:52:51.662Z,1750200771.662 [Default:CheckIn:D] Running Loop=1 2025-06-17T22:52:52.090Z,1750200772.090 [Default:CheckIn:D] Stopped 2025-06-17T22:52:52.090Z,1750200772.090 [Default:CheckIn:E] Running Loop=1 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.734376 min 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn:E] Stopped 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn] Stopped 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn](INFO): Running loop #2 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn] Running Loop=2 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T22:52:52.482Z,1750200772.482 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T22:54:46.382Z,1750200886.382 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2025-06-17T22:54:46.382Z,1750200886.382 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:54:46.393Z,1750200886.393 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:54:46.796Z,1750200886.796 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:54:46.796Z,1750200886.796 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2025-06-17T22:57:47.378Z,1750201067.378 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2025-06-17T22:57:47.378Z,1750201067.378 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T22:57:47.389Z,1750201067.389 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T22:57:47.814Z,1750201067.814 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T22:57:47.814Z,1750201067.814 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2025-06-17T22:57:52.646Z,1750201072.646 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T22:52:52.5Z 2025-06-17T22:57:52.646Z,1750201072.646 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T22:57:52.646Z,1750201072.646 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T22:58:00.051Z,1750201080.051 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250617T223629/Courier0007.lzma 2025-06-17T22:58:01.054Z,1750201081.054 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0007.lzma.bak 2025-06-17T22:58:01.054Z,1750201081.054 [DataOverHttps](INFO): SBD MOMSN=25223961 2025-06-17T22:58:07.978Z,1750201087.978 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T22:58:07.979Z,1750201087.979 [NAL9602] Data Fault, FailCount= 2 2025-06-17T22:58:07.979Z,1750201087.979 [NAL9602](ERROR): Data Fault 2025-06-17T22:58:08.023Z,1750201088.023 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T22:58:08.382Z,1750201088.382 [NAL9602](INFO): Powering down 2025-06-17T22:58:09.210Z,1750201089.210 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T22:58:09.210Z,1750201089.210 [NAL9602] No Fault, FailCount= 2 2025-06-17T22:58:16.836Z,1750201096.836 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20250617T223629/Express0008.lzma 2025-06-17T22:58:17.838Z,1750201097.838 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0008.lzma.bak 2025-06-17T22:58:17.838Z,1750201097.838 [DataOverHttps](INFO): SBD MOMSN=25223963 2025-06-17T22:58:19.717Z,1750201099.717 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T22:58:19.717Z,1750201099.717 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T22:58:19.718Z,1750201099.718 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T22:58:38.674Z,1750201118.674 [NAL9602](INFO): Powering up NAL9602 2025-06-17T22:58:49.600Z,1750201129.600 [NAL9602](INFO): NAL9602 initialized 2025-06-17T23:00:48.400Z,1750201248.400 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2025-06-17T23:00:48.400Z,1750201248.400 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:00:48.411Z,1750201248.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:00:48.810Z,1750201248.810 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:00:48.810Z,1750201248.810 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2025-06-17T23:03:20.312Z,1750201400.312 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T23:03:20.312Z,1750201400.312 [Default:CheckIn:C.Wait] Stopped 2025-06-17T23:03:20.312Z,1750201400.312 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T23:03:20.312Z,1750201400.312 [Default:CheckIn:D] Running Loop=1 2025-06-17T23:03:20.693Z,1750201400.693 [Default:CheckIn:D] Stopped 2025-06-17T23:03:20.693Z,1750201400.693 [Default:CheckIn:E] Running Loop=1 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.211098 min 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn:E] Stopped 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn] Stopped 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn](INFO): Running loop #3 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn] Running Loop=3 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T23:03:21.118Z,1750201401.118 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T23:03:49.399Z,1750201429.399 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2025-06-17T23:03:49.399Z,1750201429.399 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:03:49.451Z,1750201429.451 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:03:49.842Z,1750201429.842 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:03:49.842Z,1750201429.842 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2025-06-17T23:06:50.368Z,1750201610.368 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2025-06-17T23:06:50.368Z,1750201610.368 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:06:50.379Z,1750201610.379 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:06:50.787Z,1750201610.787 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:06:50.788Z,1750201610.788 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2025-06-17T23:08:21.300Z,1750201701.300 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T23:03:21.1Z 2025-06-17T23:08:21.300Z,1750201701.300 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T23:08:21.300Z,1750201701.300 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T23:08:28.983Z,1750201708.983 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250617T223629/Courier0010.lzma 2025-06-17T23:08:29.987Z,1750201709.987 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0010.lzma.bak 2025-06-17T23:08:29.987Z,1750201709.987 [DataOverHttps](INFO): SBD MOMSN=25223979 2025-06-17T23:08:48.008Z,1750201728.008 [DataOverHttps](INFO): Sending 164 bytes from file Logs/20250617T223629/Express0011.lzma 2025-06-17T23:08:48.998Z,1750201728.998 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0011.lzma.bak 2025-06-17T23:08:48.998Z,1750201728.998 [DataOverHttps](INFO): SBD MOMSN=25223981 2025-06-17T23:08:50.770Z,1750201730.770 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T23:08:50.770Z,1750201730.770 [NAL9602] Data Fault, FailCount= 3 2025-06-17T23:08:50.770Z,1750201730.770 [NAL9602](ERROR): Data Fault 2025-06-17T23:08:50.777Z,1750201730.777 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T23:08:50.777Z,1750201730.777 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T23:08:50.777Z,1750201730.777 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T23:08:50.787Z,1750201730.787 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T23:08:51.184Z,1750201731.184 [NAL9602](INFO): Powering down 2025-06-17T23:08:51.990Z,1750201731.990 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T23:08:51.991Z,1750201731.991 [NAL9602] No Fault, FailCount= 3 2025-06-17T23:09:21.467Z,1750201761.467 [NAL9602](INFO): Powering up NAL9602 2025-06-17T23:09:32.375Z,1750201772.375 [NAL9602](INFO): NAL9602 initialized 2025-06-17T23:09:51.377Z,1750201791.377 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2025-06-17T23:09:51.377Z,1750201791.377 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:09:51.387Z,1750201791.387 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:09:51.809Z,1750201791.809 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:09:51.810Z,1750201791.810 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2025-06-17T23:12:52.385Z,1750201972.385 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2025-06-17T23:12:52.385Z,1750201972.385 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:12:52.395Z,1750201972.395 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:12:52.804Z,1750201972.804 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:12:52.805Z,1750201972.805 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2025-06-17T23:13:51.373Z,1750202031.373 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T23:13:51.373Z,1750202031.373 [Default:CheckIn:C.Wait] Stopped 2025-06-17T23:13:51.373Z,1750202031.373 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T23:13:51.373Z,1750202031.373 [Default:CheckIn:D] Running Loop=1 2025-06-17T23:13:51.777Z,1750202031.777 [Default:CheckIn:D] Stopped 2025-06-17T23:13:51.777Z,1750202031.777 [Default:CheckIn:E] Running Loop=1 2025-06-17T23:13:52.155Z,1750202032.155 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.729167 min 2025-06-17T23:13:52.155Z,1750202032.155 [Default:CheckIn:E] Stopped 2025-06-17T23:13:52.155Z,1750202032.155 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T23:13:52.155Z,1750202032.155 [Default:CheckIn] Stopped 2025-06-17T23:13:52.155Z,1750202032.155 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T23:13:52.155Z,1750202032.155 [Default:CheckIn](INFO): Running loop #4 2025-06-17T23:13:52.156Z,1750202032.156 [Default:CheckIn] Running Loop=4 2025-06-17T23:13:52.156Z,1750202032.156 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T23:13:52.156Z,1750202032.156 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T23:15:53.364Z,1750202153.364 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2025-06-17T23:15:53.364Z,1750202153.364 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:15:53.375Z,1750202153.375 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:15:53.798Z,1750202153.798 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:15:53.798Z,1750202153.798 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2025-06-17T23:17:59.505Z,1750202279.505 [CommandExec](IMPORTANT): got command burn off 2025-06-17T23:17:59.505Z,1750202279.505 [CommandExec](IMPORTANT): Deactivating dropweight wire 2025-06-17T23:18:52.366Z,1750202332.366 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T23:13:52.2Z 2025-06-17T23:18:52.366Z,1750202332.366 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T23:18:52.366Z,1750202332.366 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T23:18:54.359Z,1750202334.359 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2025-06-17T23:18:54.359Z,1750202334.359 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:18:54.392Z,1750202334.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:18:54.798Z,1750202334.798 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:18:54.798Z,1750202334.798 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2025-06-17T23:18:59.999Z,1750202339.999 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250617T223629/Courier0013.lzma 2025-06-17T23:19:01.004Z,1750202341.004 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0013.lzma.bak 2025-06-17T23:19:01.004Z,1750202341.004 [DataOverHttps](INFO): SBD MOMSN=25223997 2025-06-17T23:19:16.892Z,1750202356.892 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20250617T223629/Express0014.lzma 2025-06-17T23:19:17.894Z,1750202357.894 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0014.lzma.bak 2025-06-17T23:19:17.894Z,1750202357.894 [DataOverHttps](INFO): SBD MOMSN=25223999 2025-06-17T23:19:19.811Z,1750202359.811 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T23:19:19.811Z,1750202359.811 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T23:19:19.811Z,1750202359.811 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T23:19:33.945Z,1750202373.945 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T23:19:33.945Z,1750202373.945 [NAL9602] Data Fault, FailCount= 4 2025-06-17T23:19:33.945Z,1750202373.945 [NAL9602](ERROR): Data Fault 2025-06-17T23:19:33.962Z,1750202373.962 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T23:19:34.366Z,1750202374.366 [NAL9602](INFO): Powering down 2025-06-17T23:19:35.171Z,1750202375.171 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T23:19:35.171Z,1750202375.171 [NAL9602] No Fault, FailCount= 4 2025-06-17T23:20:04.646Z,1750202404.646 [NAL9602](INFO): Powering up NAL9602 2025-06-17T23:20:15.555Z,1750202415.555 [NAL9602](INFO): NAL9602 initialized 2025-06-17T23:21:44.045Z,1750202504.045 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-06-17T23:21:44.045Z,1750202504.045 [DropWeight] Hardware Fault, FailCount= 1 2025-06-17T23:21:44.045Z,1750202504.045 [DropWeight](ERROR): Hardware Fault 2025-06-17T23:21:44.141Z,1750202504.141 [CBIT](INFO): Critical error at 20250617T232144 2025-06-17T23:21:44.160Z,1750202504.160 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-06-17T23:21:44.161Z,1750202504.161 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-06-17T23:21:44.524Z,1750202504.524 [CBIT](INFO): Critical error at 20250617T232144 2025-06-17T23:21:55.392Z,1750202515.392 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2025-06-17T23:21:55.392Z,1750202515.392 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:21:55.411Z,1750202515.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:21:55.817Z,1750202515.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:21:55.817Z,1750202515.817 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2025-06-17T23:22:26.494Z,1750202546.494 [DVL_micro](ERROR): Failed to parse: :SA,-01.76,+04.97,229.5 2025-06-17T23:24:20.435Z,1750202660.435 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T23:24:20.435Z,1750202660.435 [Default:CheckIn:C.Wait] Stopped 2025-06-17T23:24:20.435Z,1750202660.435 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T23:24:20.435Z,1750202660.435 [Default:CheckIn:D] Running Loop=1 2025-06-17T23:24:20.841Z,1750202660.841 [Default:CheckIn:D] Stopped 2025-06-17T23:24:20.841Z,1750202660.841 [Default:CheckIn:E] Running Loop=1 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.213558 min 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn:E] Stopped 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn] Stopped 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn](INFO): Running loop #5 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn] Running Loop=5 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T23:24:21.230Z,1750202661.230 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T23:24:56.379Z,1750202696.379 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2025-06-17T23:24:56.379Z,1750202696.379 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:24:56.390Z,1750202696.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:24:56.858Z,1750202696.858 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:24:56.858Z,1750202696.858 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2025-06-17T23:27:57.358Z,1750202877.358 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2025-06-17T23:27:57.358Z,1750202877.358 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:27:57.385Z,1750202877.385 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:27:57.765Z,1750202877.765 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:27:57.766Z,1750202877.766 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2025-06-17T23:29:21.383Z,1750202961.383 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T23:24:21.2Z 2025-06-17T23:29:21.383Z,1750202961.383 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T23:29:21.384Z,1750202961.384 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T23:29:28.932Z,1750202968.932 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20250617T223629/Courier0016.lzma 2025-06-17T23:29:29.935Z,1750202969.935 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0016.lzma.bak 2025-06-17T23:29:29.935Z,1750202969.935 [DataOverHttps](INFO): SBD MOMSN=25224032 2025-06-17T23:29:48.633Z,1750202988.633 [DataOverHttps](INFO): Sending 173 bytes from file Logs/20250617T223629/Express0017.lzma 2025-06-17T23:29:49.634Z,1750202989.634 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0017.lzma.bak 2025-06-17T23:29:49.634Z,1750202989.634 [DataOverHttps](INFO): SBD MOMSN=25224036 2025-06-17T23:29:51.315Z,1750202991.315 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T23:29:51.315Z,1750202991.315 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T23:29:51.315Z,1750202991.315 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T23:30:17.953Z,1750203017.953 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T23:30:17.953Z,1750203017.953 [NAL9602] Data Fault, FailCount= 5 2025-06-17T23:30:17.953Z,1750203017.953 [NAL9602](ERROR): Data Fault 2025-06-17T23:30:17.971Z,1750203017.971 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T23:30:17.971Z,1750203017.971 [CBIT](CRITICAL): Data Fault in component: NAL9602 2025-06-17T23:30:18.354Z,1750203018.354 [NAL9602](INFO): Powering down 2025-06-17T23:30:18.370Z,1750203018.370 [CBIT](INFO): Critical error at 20250617T233017 2025-06-17T23:30:58.451Z,1750203058.451 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2025-06-17T23:30:58.451Z,1750203058.451 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:30:58.479Z,1750203058.479 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:30:58.921Z,1750203058.921 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:30:58.921Z,1750203058.921 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2025-06-17T23:32:18.353Z,1750203138.353 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T23:32:18.353Z,1750203138.353 [NAL9602] No Fault, FailCount= 5 2025-06-17T23:32:18.739Z,1750203138.739 [NAL9602](INFO): Powering up NAL9602 2025-06-17T23:32:29.654Z,1750203149.654 [NAL9602](INFO): NAL9602 initialized 2025-06-17T23:33:59.364Z,1750203239.364 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2025-06-17T23:33:59.364Z,1750203239.364 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:33:59.390Z,1750203239.390 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:33:59.796Z,1750203239.796 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:33:59.796Z,1750203239.796 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2025-06-17T23:34:51.885Z,1750203291.885 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T23:34:51.885Z,1750203291.885 [Default:CheckIn:C.Wait] Stopped 2025-06-17T23:34:51.885Z,1750203291.885 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T23:34:51.886Z,1750203291.886 [Default:CheckIn:D] Running Loop=1 2025-06-17T23:34:52.301Z,1750203292.301 [Default:CheckIn:D] Stopped 2025-06-17T23:34:52.301Z,1750203292.301 [Default:CheckIn:E] Running Loop=1 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.737899 min 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn:E] Stopped 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn] Stopped 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn](INFO): Running loop #6 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn] Running Loop=6 2025-06-17T23:34:52.697Z,1750203292.697 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T23:34:52.698Z,1750203292.698 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T23:36:44.216Z,1750203404.216 [CBIT](INFO): Clearing failed state for component DropWeight 2025-06-17T23:36:44.217Z,1750203404.217 [DropWeight] No Fault, FailCount= 1 2025-06-17T23:37:00.348Z,1750203420.348 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2025-06-17T23:37:00.348Z,1750203420.348 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:37:00.359Z,1750203420.359 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:37:00.774Z,1750203420.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:37:00.774Z,1750203420.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2025-06-17T23:39:52.887Z,1750203592.887 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T23:34:52.7Z 2025-06-17T23:39:52.887Z,1750203592.887 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T23:39:52.887Z,1750203592.887 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T23:40:00.527Z,1750203600.527 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20250617T223629/Courier0019.lzma 2025-06-17T23:40:01.348Z,1750203601.348 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2025-06-17T23:40:01.348Z,1750203601.348 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:40:01.359Z,1750203601.359 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:40:01.530Z,1750203601.530 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0019.lzma.bak 2025-06-17T23:40:01.530Z,1750203601.530 [DataOverHttps](INFO): SBD MOMSN=25224052 2025-06-17T23:40:01.774Z,1750203601.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:40:01.774Z,1750203601.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2025-06-17T23:40:17.528Z,1750203617.528 [DataOverHttps](INFO): Sending 163 bytes from file Logs/20250617T223629/Express0020.lzma 2025-06-17T23:40:18.530Z,1750203618.530 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0020.lzma.bak 2025-06-17T23:40:18.530Z,1750203618.530 [DataOverHttps](INFO): SBD MOMSN=25224055 2025-06-17T23:40:20.337Z,1750203620.337 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T23:40:20.337Z,1750203620.337 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T23:40:20.337Z,1750203620.337 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T23:42:31.210Z,1750203751.210 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T23:42:31.210Z,1750203751.210 [NAL9602] Data Fault, FailCount= 1 2025-06-17T23:42:31.210Z,1750203751.210 [NAL9602](ERROR): Data Fault 2025-06-17T23:42:31.245Z,1750203751.245 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T23:42:31.614Z,1750203751.614 [NAL9602](INFO): Powering down 2025-06-17T23:42:32.436Z,1750203752.436 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T23:42:32.436Z,1750203752.436 [NAL9602] No Fault, FailCount= 1 2025-06-17T23:43:01.121Z,1750203781.121 [DVL_micro](ERROR): Failed to parse: :SA,-01.69,+04.94,229.9 2025-06-17T23:43:01.915Z,1750203781.915 [NAL9602](INFO): Powering up NAL9602 2025-06-17T23:43:02.324Z,1750203782.324 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2025-06-17T23:43:02.324Z,1750203782.324 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:43:02.335Z,1750203782.335 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:43:02.748Z,1750203782.748 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:43:02.748Z,1750203782.748 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2025-06-17T23:43:12.823Z,1750203792.823 [NAL9602](INFO): NAL9602 initialized 2025-06-17T23:45:20.930Z,1750203920.930 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T23:45:20.930Z,1750203920.930 [Default:CheckIn:C.Wait] Stopped 2025-06-17T23:45:20.930Z,1750203920.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T23:45:20.930Z,1750203920.930 [Default:CheckIn:D] Running Loop=1 2025-06-17T23:45:21.320Z,1750203921.320 [Default:CheckIn:D] Stopped 2025-06-17T23:45:21.320Z,1750203921.320 [Default:CheckIn:E] Running Loop=1 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.221545 min 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn:E] Stopped 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn] Stopped 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn](INFO): Running loop #7 2025-06-17T23:45:21.713Z,1750203921.713 [Default:CheckIn] Running Loop=7 2025-06-17T23:45:21.714Z,1750203921.714 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T23:45:21.714Z,1750203921.714 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T23:46:03.379Z,1750203963.379 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2025-06-17T23:46:03.379Z,1750203963.379 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:46:03.463Z,1750203963.463 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:46:03.781Z,1750203963.781 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:46:03.781Z,1750203963.781 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2025-06-17T23:49:04.340Z,1750204144.340 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2025-06-17T23:49:04.340Z,1750204144.340 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:49:04.374Z,1750204144.374 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:49:04.786Z,1750204144.786 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:49:04.786Z,1750204144.786 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2025-06-17T23:50:21.954Z,1750204221.954 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T23:45:21.7Z 2025-06-17T23:50:21.954Z,1750204221.954 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T23:50:21.954Z,1750204221.954 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T23:50:28.843Z,1750204228.843 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250617T223629/Courier0022.lzma 2025-06-17T23:50:29.846Z,1750204229.846 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0022.lzma.bak 2025-06-17T23:50:29.846Z,1750204229.846 [DataOverHttps](INFO): SBD MOMSN=25224071 2025-06-17T23:50:49.300Z,1750204249.300 [DataOverHttps](INFO): Sending 164 bytes from file Logs/20250617T223629/Express0023.lzma 2025-06-17T23:50:50.302Z,1750204250.302 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0023.lzma.bak 2025-06-17T23:50:50.302Z,1750204250.302 [DataOverHttps](INFO): SBD MOMSN=25224073 2025-06-17T23:50:52.467Z,1750204252.467 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T23:50:52.467Z,1750204252.467 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T23:50:52.467Z,1750204252.467 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T23:52:05.364Z,1750204325.364 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2025-06-17T23:52:05.364Z,1750204325.364 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:52:05.379Z,1750204325.379 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:52:05.783Z,1750204325.783 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:52:05.783Z,1750204325.783 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2025-06-17T23:52:49.376Z,1750204369.376 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-06-17T23:52:49.377Z,1750204369.377 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-06-17T23:52:49.378Z,1750204369.378 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2025-06-17T23:52:49.381Z,1750204369.381 [BPC1](INFO): Received data from all battery sticks. 2025-06-17T23:53:16.046Z,1750204396.046 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T23:53:16.047Z,1750204396.047 [NAL9602] Data Fault, FailCount= 2 2025-06-17T23:53:16.047Z,1750204396.047 [NAL9602](ERROR): Data Fault 2025-06-17T23:53:16.064Z,1750204396.064 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T23:53:16.446Z,1750204396.446 [NAL9602](INFO): Powering down 2025-06-17T23:53:17.263Z,1750204397.263 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T23:53:17.264Z,1750204397.264 [NAL9602] No Fault, FailCount= 2 2025-06-17T23:53:46.738Z,1750204426.738 [NAL9602](INFO): Powering up NAL9602 2025-06-17T23:53:57.663Z,1750204437.663 [NAL9602](INFO): NAL9602 initialized 2025-06-17T23:55:06.367Z,1750204506.367 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2025-06-17T23:55:06.367Z,1750204506.367 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:55:06.379Z,1750204506.379 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:55:06.801Z,1750204506.801 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:55:06.801Z,1750204506.801 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2025-06-17T23:55:52.825Z,1750204552.825 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T23:55:52.825Z,1750204552.825 [Default:CheckIn:C.Wait] Stopped 2025-06-17T23:55:52.825Z,1750204552.825 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T23:55:52.825Z,1750204552.825 [Default:CheckIn:D] Running Loop=1 2025-06-17T23:55:53.198Z,1750204553.198 [Default:CheckIn:D] Stopped 2025-06-17T23:55:53.198Z,1750204553.198 [Default:CheckIn:E] Running Loop=1 2025-06-17T23:55:53.656Z,1750204553.656 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.752848 min 2025-06-17T23:55:53.656Z,1750204553.656 [Default:CheckIn:E] Stopped 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn] Stopped 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn](INFO): Running loop #8 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn] Running Loop=8 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T23:55:53.657Z,1750204553.657 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T23:58:07.413Z,1750204687.413 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2025-06-17T23:58:07.413Z,1750204687.413 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T23:58:07.424Z,1750204687.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T23:58:07.832Z,1750204687.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T23:58:07.832Z,1750204687.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2025-06-18T00:00:53.886Z,1750204853.886 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T23:55:53.7Z 2025-06-18T00:00:53.886Z,1750204853.886 [Default:CheckIn:Read_GPS] Stopped 2025-06-18T00:00:53.886Z,1750204853.886 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-18T00:01:00.771Z,1750204860.771 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20250617T223629/Courier0025.lzma 2025-06-18T00:01:01.774Z,1750204861.774 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0025.lzma.bak 2025-06-18T00:01:01.774Z,1750204861.774 [DataOverHttps](INFO): SBD MOMSN=25224089 2025-06-18T00:01:08.348Z,1750204868.348 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2025-06-18T00:01:08.348Z,1750204868.348 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:01:08.359Z,1750204868.359 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:01:08.769Z,1750204868.769 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:01:08.769Z,1750204868.769 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2025-06-18T00:01:17.608Z,1750204877.608 [DataOverHttps](INFO): Sending 163 bytes from file Logs/20250617T223629/Express0026.lzma 2025-06-18T00:01:18.610Z,1750204878.610 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0026.lzma.bak 2025-06-18T00:01:18.610Z,1750204878.610 [DataOverHttps](INFO): SBD MOMSN=25224091 2025-06-18T00:01:20.493Z,1750204880.493 [Default:CheckIn:Read_Iridium] Stopped 2025-06-18T00:01:20.493Z,1750204880.493 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-18T00:01:20.493Z,1750204880.493 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-18T00:04:00.042Z,1750205040.042 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-18T00:04:00.042Z,1750205040.042 [NAL9602] Data Fault, FailCount= 3 2025-06-18T00:04:00.042Z,1750205040.042 [NAL9602](ERROR): Data Fault 2025-06-18T00:04:00.084Z,1750205040.084 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-18T00:04:00.462Z,1750205040.462 [NAL9602](INFO): Powering down 2025-06-18T00:04:01.276Z,1750205041.276 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-18T00:04:01.276Z,1750205041.276 [NAL9602] No Fault, FailCount= 3 2025-06-18T00:04:09.351Z,1750205049.351 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2025-06-18T00:04:09.352Z,1750205049.352 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:04:09.362Z,1750205049.362 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:04:09.768Z,1750205049.768 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:04:09.768Z,1750205049.768 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2025-06-18T00:04:30.759Z,1750205070.759 [NAL9602](INFO): Powering up NAL9602 2025-06-18T00:04:41.655Z,1750205081.655 [NAL9602](INFO): NAL9602 initialized 2025-06-18T00:06:21.059Z,1750205181.059 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-18T00:06:21.059Z,1750205181.059 [Default:CheckIn:C.Wait] Stopped 2025-06-18T00:06:21.059Z,1750205181.059 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-18T00:06:21.060Z,1750205181.060 [Default:CheckIn:D] Running Loop=1 2025-06-18T00:06:21.485Z,1750205181.485 [Default:CheckIn:D] Stopped 2025-06-18T00:06:21.485Z,1750205181.485 [Default:CheckIn:E] Running Loop=1 2025-06-18T00:06:21.861Z,1750205181.861 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.224300 min 2025-06-18T00:06:21.861Z,1750205181.861 [Default:CheckIn:E] Stopped 2025-06-18T00:06:21.861Z,1750205181.861 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-18T00:06:21.861Z,1750205181.861 [Default:CheckIn] Stopped 2025-06-18T00:06:21.861Z,1750205181.861 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-18T00:06:21.861Z,1750205181.861 [Default:CheckIn](INFO): Running loop #9 2025-06-18T00:06:21.862Z,1750205181.862 [Default:CheckIn] Running Loop=9 2025-06-18T00:06:21.862Z,1750205181.862 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-18T00:06:21.862Z,1750205181.862 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-18T00:06:45.682Z,1750205205.682 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-06-18T00:06:45.682Z,1750205205.682 [DropWeight] Hardware Fault, FailCount= 1 2025-06-18T00:06:45.682Z,1750205205.682 [DropWeight](ERROR): Hardware Fault 2025-06-18T00:06:45.768Z,1750205205.768 [CBIT](INFO): Critical error at 20250618T000645 2025-06-18T00:06:45.770Z,1750205205.770 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-06-18T00:06:45.771Z,1750205205.771 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-06-18T00:06:46.098Z,1750205206.098 [CBIT](INFO): Critical error at 20250618T000645 2025-06-18T00:07:10.369Z,1750205230.369 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2025-06-18T00:07:10.369Z,1750205230.369 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:07:10.379Z,1750205230.379 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:07:10.767Z,1750205230.767 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:07:10.767Z,1750205230.767 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2025-06-18T00:10:11.350Z,1750205411.350 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2025-06-18T00:10:11.350Z,1750205411.350 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:10:11.361Z,1750205411.361 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:10:11.773Z,1750205411.773 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:10:11.774Z,1750205411.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2025-06-18T00:11:22.034Z,1750205482.034 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-18T00:06:21.9Z 2025-06-18T00:11:22.034Z,1750205482.034 [Default:CheckIn:Read_GPS] Stopped 2025-06-18T00:11:22.035Z,1750205482.035 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-18T00:11:29.653Z,1750205489.653 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20250617T223629/Courier0028.lzma 2025-06-18T00:11:30.654Z,1750205490.654 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0028.lzma.bak 2025-06-18T00:11:30.654Z,1750205490.654 [DataOverHttps](INFO): SBD MOMSN=25224107 2025-06-18T00:11:48.724Z,1750205508.724 [DataOverHttps](INFO): Sending 164 bytes from file Logs/20250617T223629/Express0029.lzma 2025-06-18T00:11:49.726Z,1750205509.726 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0029.lzma.bak 2025-06-18T00:11:49.726Z,1750205509.726 [DataOverHttps](INFO): SBD MOMSN=25224111 2025-06-18T00:11:51.553Z,1750205511.553 [Default:CheckIn:Read_Iridium] Stopped 2025-06-18T00:11:51.553Z,1750205511.553 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-18T00:11:51.553Z,1750205511.553 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-18T00:12:40.828Z,1750205560.828 [DVL_micro](ERROR): Failed to parse: :SA,-01.70,+05.09,229.4 2025-06-18T00:13:12.375Z,1750205592.375 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2025-06-18T00:13:12.376Z,1750205592.376 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:13:12.419Z,1750205592.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:13:12.794Z,1750205592.794 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:13:12.794Z,1750205592.794 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2025-06-18T00:14:43.242Z,1750205683.242 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-18T00:14:43.242Z,1750205683.242 [NAL9602] Data Fault, FailCount= 4 2025-06-18T00:14:43.242Z,1750205683.242 [NAL9602](ERROR): Data Fault 2025-06-18T00:14:43.300Z,1750205683.300 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-18T00:14:43.662Z,1750205683.662 [NAL9602](INFO): Powering down 2025-06-18T00:14:44.510Z,1750205684.510 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-18T00:14:44.510Z,1750205684.510 [NAL9602] No Fault, FailCount= 4 2025-06-18T00:15:13.944Z,1750205713.944 [NAL9602](INFO): Powering up NAL9602 2025-06-18T00:15:24.886Z,1750205724.886 [NAL9602](INFO): NAL9602 initialized 2025-06-18T00:16:13.353Z,1750205773.353 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2025-06-18T00:16:13.353Z,1750205773.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:16:13.364Z,1750205773.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:16:13.772Z,1750205773.772 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:16:13.772Z,1750205773.772 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2025-06-18T00:16:52.176Z,1750205812.176 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-18T00:16:52.177Z,1750205812.177 [Default:CheckIn:C.Wait] Stopped 2025-06-18T00:16:52.177Z,1750205812.177 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-18T00:16:52.177Z,1750205812.177 [Default:CheckIn:D] Running Loop=1 2025-06-18T00:16:52.585Z,1750205812.585 [Default:CheckIn:D] Stopped 2025-06-18T00:16:52.585Z,1750205812.585 [Default:CheckIn:E] Running Loop=1 2025-06-18T00:16:52.979Z,1750205812.979 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.742627 min 2025-06-18T00:16:52.979Z,1750205812.979 [Default:CheckIn:E] Stopped 2025-06-18T00:16:52.979Z,1750205812.979 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-18T00:16:52.979Z,1750205812.979 [Default:CheckIn] Stopped 2025-06-18T00:16:52.979Z,1750205812.979 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-18T00:16:52.980Z,1750205812.980 [Default:CheckIn](INFO): Running loop #10 2025-06-18T00:16:52.980Z,1750205812.980 [Default:CheckIn] Running Loop=10 2025-06-18T00:16:52.980Z,1750205812.980 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-18T00:16:52.980Z,1750205812.980 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-18T00:19:14.389Z,1750205954.389 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34 2025-06-18T00:19:14.389Z,1750205954.389 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:19:14.399Z,1750205954.399 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:19:14.786Z,1750205954.786 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:19:14.786Z,1750205954.786 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34 2025-06-18T00:19:26.067Z,1750205966.067 [DVL_micro](ERROR): Failed to parse:,+00000000.00,+00000000.00,9999.99,000.00 2025-06-18T00:21:45.894Z,1750206105.894 [CBIT](INFO): Clearing failed state for component DropWeight 2025-06-18T00:21:45.894Z,1750206105.894 [DropWeight] No Fault, FailCount= 1 2025-06-18T00:21:53.165Z,1750206113.165 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-18T00:16:52.0Z 2025-06-18T00:21:53.165Z,1750206113.165 [Default:CheckIn:Read_GPS] Stopped 2025-06-18T00:21:53.165Z,1750206113.165 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-18T00:22:00.943Z,1750206120.943 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250617T223629/Courier0031.lzma 2025-06-18T00:22:01.947Z,1750206121.947 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Courier0031.lzma.bak 2025-06-18T00:22:01.947Z,1750206121.947 [DataOverHttps](INFO): SBD MOMSN=25224127 2025-06-18T00:22:15.429Z,1750206135.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35 2025-06-18T00:22:15.429Z,1750206135.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-18T00:22:15.448Z,1750206135.448 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-18T00:22:15.853Z,1750206135.853 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-18T00:22:15.853Z,1750206135.853 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35 2025-06-18T00:22:18.728Z,1750206138.728 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20250617T223629/Express0032.lzma 2025-06-18T00:22:19.730Z,1750206139.730 [DataOverHttps](INFO): Moved sent file to Logs/20250617T223629/Express0032.lzma.bak 2025-06-18T00:22:19.730Z,1750206139.730 [DataOverHttps](INFO): SBD MOMSN=25224129 2025-06-18T00:22:21.468Z,1750206141.468 [Default:CheckIn:Read_Iridium] Stopped 2025-06-18T00:22:21.468Z,1750206141.468 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-18T00:22:21.468Z,1750206141.468 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-18T00:24:32.274Z,1750206272.274 [CommandExec](IMPORTANT): got command failComponent none DropWeight 2025-06-18T00:24:32.274Z,1750206272.274 [CommandExec](IMPORTANT): DropWeight failureMode is No Fault 2025-06-18T00:24:34.552Z,1750206274.552 [CommandExec](IMPORTANT): got command failComponent 2025-06-18T00:24:34.553Z,1750206274.553 [CommandExec](IMPORTANT): Failed components: 2025-06-18T00:24:34.553Z,1750206274.553 [CommandExec](IMPORTANT): No failed Components. 2025-06-18T00:24:36.014Z,1750206276.014 [CommandExec](IMPORTANT): got command failComponent 2025-06-18T00:24:36.014Z,1750206276.014 [CommandExec](IMPORTANT): Failed components: 2025-06-18T00:24:36.014Z,1750206276.014 [CommandExec](IMPORTANT): No failed Components. 2025-06-18T00:24:37.989Z,1750206277.989 [CommandExec](IMPORTANT): got command failComponent 2025-06-18T00:24:37.989Z,1750206277.989 [CommandExec](IMPORTANT): Failed components: 2025-06-18T00:24:37.989Z,1750206277.989 [CommandExec](IMPORTANT): No failed Components. 2025-06-18T00:24:42.369Z,1750206282.369 [CommandExec](IMPORTANT): got command failComponent 2025-06-18T00:24:42.369Z,1750206282.369 [CommandExec](IMPORTANT): Failed components: 2025-06-18T00:24:42.369Z,1750206282.369 [CommandExec](IMPORTANT): No failed Components. 2025-06-18T00:24:44.564Z,1750206284.564 [CommandExec](IMPORTANT): got command 2025-06-18T00:24:44.565Z,1750206284.565 [CommandExec](FAULT): Incomplete syntax. Try: help 2025-06-18T00:24:46.857Z,1750206286.857 [CommandExec](IMPORTANT): got command failComponent 2025-06-18T00:24:46.857Z,1750206286.857 [CommandExec](IMPORTANT): Failed components: 2025-06-18T00:24:46.857Z,1750206286.857 [CommandExec](IMPORTANT): No failed Components. 2025-06-18T00:24:54.253Z,1750206294.253 [CommandExec](IMPORTANT): got command burn off 2025-06-18T00:24:54.253Z,1750206294.253 [CommandExec](IMPORTANT): Deactivating dropweight wire 2025-06-18T00:24:56.749Z,1750206296.749 [CommandExec](IMPORTANT): got command failComponent 2025-06-18T00:24:56.749Z,1750206296.749 [CommandExec](IMPORTANT): Failed components: 2025-06-18T00:24:56.749Z,1750206296.749 [CommandExec](IMPORTANT): No failed Components. 2025-06-18T00:25:00.596Z,1750206300.596 [CommandExec](IMPORTANT): got command quit 2025-06-18T00:25:01.600Z,1750206301.600 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:01.600Z,1750206301.600 [CommandExec](INFO): Uninitializing the command executive. 2025-06-18T00:25:01.600Z,1750206301.600 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-18T00:25:01.600Z,1750206301.600 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:01.736Z,1750206301.736 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-18T00:25:01.736Z,1750206301.736 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-18T00:25:01.736Z,1750206301.736 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:01.737Z,1750206301.737 [NavChartDb](INFO): Join timeout helper Thread ID is 2551 2025-06-18T00:25:02.020Z,1750206302.020 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:02.021Z,1750206302.021 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:02.024Z,1750206302.024 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-18T00:25:02.024Z,1750206302.024 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:02.025Z,1750206302.025 [Radio_Surface](INFO): Join timeout helper Thread ID is 2552 2025-06-18T00:25:02.356Z,1750206302.356 [Radio_Surface](INFO): Powering down 2025-06-18T00:25:02.357Z,1750206302.357 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:02.357Z,1750206302.357 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:02.373Z,1750206302.373 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-06-18T00:25:02.373Z,1750206302.373 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:02.373Z,1750206302.373 [Onboard](INFO): Join timeout helper Thread ID is 2553 2025-06-18T00:25:03.536Z,1750206303.536 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-06-18T00:25:06.472Z,1750206306.472 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:06.472Z,1750206306.472 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.493Z,1750206306.493 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-06-18T00:25:06.493Z,1750206306.493 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.494Z,1750206306.494 [DataOverHttps](INFO): Join timeout helper Thread ID is 2554 2025-06-18T00:25:06.548Z,1750206306.548 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:06.548Z,1750206306.548 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.552Z,1750206306.552 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-06-18T00:25:06.552Z,1750206306.552 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.552Z,1750206306.552 [DAT](INFO): Join timeout helper Thread ID is 2555 2025-06-18T00:25:06.744Z,1750206306.744 [DAT](INFO): Powering down 2025-06-18T00:25:06.821Z,1750206306.821 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:06.821Z,1750206306.821 [DAT](INFO): Powering down 2025-06-18T00:25:06.822Z,1750206306.822 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.841Z,1750206306.841 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-06-18T00:25:06.841Z,1750206306.841 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.841Z,1750206306.841 [BackseatComponent](INFO): Join timeout helper Thread ID is 2556 2025-06-18T00:25:06.976Z,1750206306.976 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:06.976Z,1750206306.976 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.985Z,1750206306.985 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-06-18T00:25:06.985Z,1750206306.985 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:06.985Z,1750206306.985 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2557 2025-06-18T00:25:07.468Z,1750206307.468 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:07.468Z,1750206307.468 [WetLabsBB2FL](INFO): Powering down 2025-06-18T00:25:07.469Z,1750206307.469 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:07.485Z,1750206307.485 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-06-18T00:25:07.485Z,1750206307.485 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:07.485Z,1750206307.485 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2558 2025-06-18T00:25:07.968Z,1750206307.968 [CTD_Seabird](INFO): Powering down 2025-06-18T00:25:07.980Z,1750206307.980 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:07.980Z,1750206307.980 [CTD_Seabird](INFO): Powering down 2025-06-18T00:25:07.000Z,1750206308.000 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.001Z,1750206308.001 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-06-18T00:25:08.001Z,1750206308.001 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.002Z,1750206308.002 [logger](INFO): Join timeout helper Thread ID is 2559 2025-06-18T00:25:08.033Z,1750206308.033 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:08.033Z,1750206308.033 [logger ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.048Z,1750206308.048 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-06-18T00:25:08.049Z,1750206308.049 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.049Z,1750206308.049 [CommandLine](INFO): Join timeout helper Thread ID is 2560 2025-06-18T00:25:08.060Z,1750206308.060 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:08.060Z,1750206308.060 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.068Z,1750206308.068 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-06-18T00:25:08.069Z,1750206308.069 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.069Z,1750206308.069 [CommandExec](INFO): Join timeout helper Thread ID is 2561 2025-06-18T00:25:08.070Z,1750206308.070 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-06-18T00:25:08.070Z,1750206308.070 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.071Z,1750206308.071 [controlThread](INFO): Join timeout helper Thread ID is 2562 2025-06-18T00:25:08.260Z,1750206308.260 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-18T00:25:08.260Z,1750206308.260 [controlThread](DEBUG): Uninitializing ControlThread 2025-06-18T00:25:08.261Z,1750206308.261 [AHRS_M2](INFO): Powering down 2025-06-18T00:25:08.444Z,1750206308.444 [DVL_micro](INFO): Powering down 2025-06-18T00:25:08.445Z,1750206308.445 [NAL9602](INFO): Powering down 2025-06-18T00:25:08.446Z,1750206308.446 [Sonardyne_Nano](INFO): Powering down 2025-06-18T00:25:08.648Z,1750206308.648 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-06-18T00:25:08.649Z,1750206308.649 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-06-18T00:25:08.649Z,1750206308.649 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-06-18T00:25:08.650Z,1750206308.650 [MissionManager](INFO): Uninitializing Mission Default 2025-06-18T00:25:08.650Z,1750206308.650 [Default] Stopped 2025-06-18T00:25:08.650Z,1750206308.650 [Default](DEBUG): Aggregate::uninitialize Default 2025-06-18T00:25:08.650Z,1750206308.650 [Default:B.GoToSurface] Stopped 2025-06-18T00:25:08.650Z,1750206308.650 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-18T00:25:08.650Z,1750206308.650 [Default:CheckIn] Stopped 2025-06-18T00:25:08.650Z,1750206308.650 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-18T00:25:08.650Z,1750206308.650 [Default:CheckIn:C.Wait] Stopped 2025-06-18T00:25:08.651Z,1750206308.651 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-18T00:25:08.654Z,1750206308.654 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-06-18T00:25:08.654Z,1750206308.654 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-06-18T00:25:08.654Z,1750206308.654 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-06-18T00:25:08.654Z,1750206308.654 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-06-18T00:25:08.655Z,1750206308.655 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-06-18T00:25:08.655Z,1750206308.655 [BuoyancyServo](INFO): Powering down 2025-06-18T00:25:08.668Z,1750206308.668 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-06-18T00:25:08.668Z,1750206308.668 [ElevatorServo](INFO): Powering down 2025-06-18T00:25:08.669Z,1750206308.669 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-06-18T00:25:08.669Z,1750206308.669 [MassServo](INFO): Powering down 2025-06-18T00:25:08.670Z,1750206308.670 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-06-18T00:25:08.670Z,1750206308.670 [RudderServo](INFO): Powering down 2025-06-18T00:25:08.671Z,1750206308.671 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-06-18T00:25:08.671Z,1750206308.671 [ThrusterHE](INFO): Powering down 2025-06-18T00:25:08.672Z,1750206308.672 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-06-18T00:25:08.672Z,1750206308.672 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-06-18T00:25:08.672Z,1750206308.672 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-06-18T00:25:08.673Z,1750206308.673 [CBIT](DEBUG): Powering off loads. 2025-06-18T00:25:08.684Z,1750206308.684 [CBIT](DEBUG): Disabling WDT. 2025-06-18T00:25:08.696Z,1750206308.696 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-06-18T00:25:08.696Z,1750206308.696 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-06-18T00:25:08.697Z,1750206308.697 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.754Z,1750206308.754 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-06-18T00:25:08.754Z,1750206308.754 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-06-18T00:25:08.769Z,1750206308.769 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.776Z,1750206308.776 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.838Z,1750206308.838 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.845Z,1750206308.845 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.869Z,1750206308.869 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:08.904Z,1750206308.904 [DAT ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:09.071Z,1750206309.071 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:09.156Z,1750206309.156 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-18T00:25:09.227Z,1750206309.227 [logger ThreadHandler](INFO): Thread cancelled.