2025-05-27T20:46:59.076Z,1748378819.076 [Supervisor](DEBUG): Initializing supervisor.
2025-05-27T20:46:59.081Z,1748378819.081 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-05-27T20:46:59.081Z,1748378819.081 [SyncHandler](INFO): Protected caller Thread ID is 3643
2025-05-27T20:46:59.082Z,1748378819.082 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-05-27T20:46:59.083Z,1748378819.083 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-05-27T20:46:59.083Z,1748378819.083 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3644
2025-05-27T20:46:59.100Z,1748378819.100 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-05-27T20:46:59.120Z,1748378819.120 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-05-27T20:46:59.121Z,1748378819.121 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-05-27T20:46:59.122Z,1748378819.122 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3645
2025-05-27T20:46:59.126Z,1748378819.126 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-05-27T20:46:59.127Z,1748378819.127 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-05-27T20:46:59.127Z,1748378819.127 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3646
2025-05-27T20:46:59.129Z,1748378819.129 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-05-27T20:46:59.130Z,1748378819.130 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-05-27T20:46:59.131Z,1748378819.131 [logger ThreadHandler](INFO): Protected caller Thread ID is 3647
2025-05-27T20:46:59.135Z,1748378819.135 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-05-27T20:46:59.135Z,1748378819.135 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-05-27T20:46:59.141Z,1748378819.141 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-05-27T20:46:59.315Z,1748378819.315 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-05-27T20:46:59.317Z,1748378819.317 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-05-27T20:46:59.563Z,1748378819.563 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-05-27T20:46:59.565Z,1748378819.565 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-05-27T20:46:59.843Z,1748378819.843 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-05-27T20:46:59.845Z,1748378819.845 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-05-27T20:46:59.963Z,1748378819.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-05-27T20:46:59.965Z,1748378819.965 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-05-27T20:47:00.737Z,1748378820.737 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-05-27T20:47:00.737Z,1748378820.737 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-05-27T20:47:01.262Z,1748378821.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-05-27T20:47:01.262Z,1748378821.262 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-05-27T20:47:01.828Z,1748378821.828 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-05-27T20:47:01.829Z,1748378821.829 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-05-27T20:47:02.287Z,1748378822.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-05-27T20:47:02.542Z,1748378822.542 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-05-27T20:47:03.005Z,1748378823.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-05-27T20:47:03.006Z,1748378823.006 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-05-27T20:47:03.399Z,1748378823.399 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-05-27T20:47:03.400Z,1748378823.400 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-05-27T20:47:03.639Z,1748378823.639 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-05-27T20:47:03.641Z,1748378823.641 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-05-27T20:47:03.793Z,1748378823.793 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-05-27T20:47:03.794Z,1748378823.794 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-05-27T20:47:03.889Z,1748378823.889 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-05-27T20:47:03.981Z,1748378823.981 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-05-27T20:47:04.183Z,1748378824.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-05-27T20:47:04.184Z,1748378824.184 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-05-27T20:47:04.447Z,1748378824.447 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-05-27T20:47:04.449Z,1748378824.449 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2025-05-27T20:47:04.452Z,1748378824.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2025-05-27T20:47:04.549Z,1748378824.549 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2025-05-27T20:47:04.826Z,1748378824.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-05-27T20:47:04.827Z,1748378824.827 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2025-05-27T20:47:04.923Z,1748378824.923 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2025-05-27T20:47:05.104Z,1748378825.104 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2025-05-27T20:47:05.216Z,1748378825.216 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2025-05-27T20:47:05.337Z,1748378825.337 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2025-05-27T20:47:05.462Z,1748378825.462 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2025-05-27T20:47:05.568Z,1748378825.568 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2025-05-27T20:47:05.739Z,1748378825.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2025-05-27T20:47:05.848Z,1748378825.848 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg
2025-05-27T20:47:05.945Z,1748378825.945 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2025-05-27T20:47:06.063Z,1748378826.063 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2025-05-27T20:47:06.163Z,1748378826.163 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2025-05-27T20:47:06.163Z,1748378826.163 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-05-27T20:47:06.181Z,1748378826.181 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-05-27T20:47:06.398Z,1748378826.398 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-05-27T20:47:06.398Z,1748378826.398 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-05-27T20:47:06.567Z,1748378826.567 [BuoyancyServo] Loaded
2025-05-27T20:47:06.567Z,1748378826.567 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-05-27T20:47:06.591Z,1748378826.591 [ElevatorServo] Loaded
2025-05-27T20:47:06.591Z,1748378826.591 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-05-27T20:47:06.614Z,1748378826.614 [MassServo] Loaded
2025-05-27T20:47:06.614Z,1748378826.614 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-05-27T20:47:06.636Z,1748378826.636 [RudderServo] Loaded
2025-05-27T20:47:06.636Z,1748378826.636 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-05-27T20:47:06.654Z,1748378826.654 [ThrusterHE] Loaded
2025-05-27T20:47:06.654Z,1748378826.654 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-05-27T20:47:06.655Z,1748378826.655 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-05-27T20:47:06.657Z,1748378826.657 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-05-27T20:47:06.854Z,1748378826.854 [SBIT](DEBUG): Construct Startup Built In Test.
2025-05-27T20:47:06.869Z,1748378826.869 [SBIT] Loaded
2025-05-27T20:47:06.869Z,1748378826.869 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-05-27T20:47:06.872Z,1748378826.872 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-05-27T20:47:06.893Z,1748378826.893 [IBIT] Loaded
2025-05-27T20:47:06.893Z,1748378826.893 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-05-27T20:47:06.898Z,1748378826.898 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-05-27T20:47:07.090Z,1748378827.090 [CBIT] Loaded
2025-05-27T20:47:07.090Z,1748378827.090 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-05-27T20:47:07.120Z,1748378827.120 [GFScanner] Loaded
2025-05-27T20:47:07.121Z,1748378827.121 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-05-27T20:47:07.121Z,1748378827.121 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-05-27T20:47:07.122Z,1748378827.122 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-05-27T20:47:07.337Z,1748378827.337 [CTD_Seabird] Loaded
2025-05-27T20:47:07.338Z,1748378827.338 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-05-27T20:47:07.339Z,1748378827.339 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406834E0
2025-05-27T20:47:07.339Z,1748378827.339 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3735
2025-05-27T20:47:07.375Z,1748378827.375 [ESPComponent] Loaded
2025-05-27T20:47:07.375Z,1748378827.375 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-05-27T20:47:07.397Z,1748378827.397 [PAR_Licor] Loaded
2025-05-27T20:47:07.398Z,1748378827.398 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-05-27T20:47:07.442Z,1748378827.442 [WetLabsBB2FL] Loaded
2025-05-27T20:47:07.443Z,1748378827.443 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-05-27T20:47:07.444Z,1748378827.444 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B34E0
2025-05-27T20:47:07.444Z,1748378827.444 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3736
2025-05-27T20:47:07.445Z,1748378827.445 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-05-27T20:47:07.445Z,1748378827.445 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-05-27T20:47:07.651Z,1748378827.651 [DepthRateCalculator] Loaded
2025-05-27T20:47:07.651Z,1748378827.651 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-05-27T20:47:07.656Z,1748378827.656 [PitchRateCalculator] Loaded
2025-05-27T20:47:07.665Z,1748378827.665 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-05-27T20:47:07.714Z,1748378827.714 [SpeedCalculator] Loaded
2025-05-27T20:47:07.714Z,1748378827.714 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-05-27T20:47:07.719Z,1748378827.719 [YawRateCalculator] Loaded
2025-05-27T20:47:07.719Z,1748378827.719 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-05-27T20:47:07.782Z,1748378827.782 [ElevatorOffsetCalculator] Loaded
2025-05-27T20:47:07.783Z,1748378827.783 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-05-27T20:47:07.783Z,1748378827.783 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-05-27T20:47:07.784Z,1748378827.784 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-05-27T20:47:08.544Z,1748378828.544 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-05-27T20:47:08.545Z,1748378828.545 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-05-27T20:47:08.593Z,1748378828.593 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-05-27T20:47:08.594Z,1748378828.594 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-05-27T20:47:08.734Z,1748378828.734 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-05-27T20:47:08.734Z,1748378828.734 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-05-27T20:47:08.748Z,1748378828.748 [NavChart] Loaded
2025-05-27T20:47:08.748Z,1748378828.748 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-05-27T20:47:08.754Z,1748378828.754 [UniversalFixResidualReporter] Loaded
2025-05-27T20:47:08.754Z,1748378828.754 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-05-27T20:47:08.755Z,1748378828.755 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-05-27T20:47:08.755Z,1748378828.755 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-05-27T20:47:09.643Z,1748378829.643 [AHRS_M2] Loaded
2025-05-27T20:47:09.644Z,1748378829.644 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-05-27T20:47:09.899Z,1748378829.899 [BackseatComponent] Loaded
2025-05-27T20:47:09.899Z,1748378829.899 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-05-27T20:47:09.900Z,1748378829.900 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A7F4E0
2025-05-27T20:47:09.901Z,1748378829.901 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3737
2025-05-27T20:47:09.904Z,1748378829.904 [LcmUniversalReporter] Loaded
2025-05-27T20:47:09.904Z,1748378829.904 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-05-27T20:47:10.635Z,1748378830.635 [BPC1] Loaded
2025-05-27T20:47:10.635Z,1748378830.635 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-05-27T20:47:10.734Z,1748378830.734 [DAT] Loaded
2025-05-27T20:47:10.734Z,1748378830.734 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-05-27T20:47:10.735Z,1748378830.735 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AAF4E0
2025-05-27T20:47:10.736Z,1748378830.736 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3738
2025-05-27T20:47:11.044Z,1748378831.044 [DataOverHttps] Loaded
2025-05-27T20:47:11.044Z,1748378831.044 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-05-27T20:47:11.045Z,1748378831.045 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40ADF4E0
2025-05-27T20:47:11.046Z,1748378831.046 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3739
2025-05-27T20:47:11.069Z,1748378831.069 [Depth_Keller] Loaded
2025-05-27T20:47:11.069Z,1748378831.069 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-05-27T20:47:11.074Z,1748378831.074 [DropWeight] Loaded
2025-05-27T20:47:11.074Z,1748378831.074 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-05-27T20:47:11.115Z,1748378831.115 [DVL_micro] Loaded
2025-05-27T20:47:11.116Z,1748378831.116 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2025-05-27T20:47:11.178Z,1748378831.178 [NAL9602] Loaded
2025-05-27T20:47:11.178Z,1748378831.178 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-05-27T20:47:11.204Z,1748378831.204 [Onboard] Loaded
2025-05-27T20:47:11.205Z,1748378831.205 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-05-27T20:47:11.206Z,1748378831.206 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B0F4E0
2025-05-27T20:47:11.206Z,1748378831.206 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3740
2025-05-27T20:47:11.212Z,1748378831.212 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1
2025-05-27T20:47:11.226Z,1748378831.226 [PowerOnly] Loaded
2025-05-27T20:47:11.226Z,1748378831.226 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2025-05-27T20:47:11.240Z,1748378831.240 [Power24vConverter] Loaded
2025-05-27T20:47:11.240Z,1748378831.240 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-05-27T20:47:11.256Z,1748378831.256 [Radio_Surface] Loaded
2025-05-27T20:47:11.257Z,1748378831.257 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-05-27T20:47:11.258Z,1748378831.258 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B3F4E0
2025-05-27T20:47:11.258Z,1748378831.258 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3741
2025-05-27T20:47:11.274Z,1748378831.274 [Sonardyne_Nano] Loaded
2025-05-27T20:47:11.274Z,1748378831.274 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-05-27T20:47:11.274Z,1748378831.274 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-05-27T20:47:11.275Z,1748378831.275 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-05-27T20:47:11.363Z,1748378831.363 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-05-27T20:47:11.364Z,1748378831.364 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-05-27T20:47:11.437Z,1748378831.437 [VerticalControl](DEBUG): Construct VerticalControl.
2025-05-27T20:47:11.489Z,1748378831.489 [VerticalControl] Loaded
2025-05-27T20:47:11.489Z,1748378831.489 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-05-27T20:47:11.492Z,1748378831.492 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-05-27T20:47:11.537Z,1748378831.537 [HorizontalControl] Loaded
2025-05-27T20:47:11.537Z,1748378831.537 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-05-27T20:47:11.540Z,1748378831.540 [SpeedControl](DEBUG): Construct SpeedControl.
2025-05-27T20:47:11.541Z,1748378831.541 [SpeedControl] Loaded
2025-05-27T20:47:11.542Z,1748378831.542 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-05-27T20:47:11.545Z,1748378831.545 [LoopControl](DEBUG): Construct LoopControl.
2025-05-27T20:47:11.545Z,1748378831.545 [LoopControl] Loaded
2025-05-27T20:47:11.545Z,1748378831.545 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-05-27T20:47:11.546Z,1748378831.546 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-05-27T20:47:11.546Z,1748378831.546 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-05-27T20:47:11.562Z,1748378831.562 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-05-27T20:47:11.563Z,1748378831.563 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-05-27T20:47:11.973Z,1748378831.973 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-05-27T20:47:11.979Z,1748378831.979 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-05-27T20:47:11.982Z,1748378831.982 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-05-27T20:47:11.993Z,1748378831.993 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-05-27T20:47:11.994Z,1748378831.994 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0
2025-05-27T20:47:11.994Z,1748378831.994 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3742
2025-05-27T20:47:11.999Z,1748378831.999 [Supervisor](INFO): Main Thread ID is 3641
2025-05-27T20:47:11.999Z,1748378831.999 [Supervisor](DEBUG): Running supervisor.
2025-05-27T20:47:11.000Z,1748378832.000 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3743
2025-05-27T20:47:11.000Z,1748378832.000 [CommandExec](INFO): Initializing the command executive.
2025-05-27T20:47:12.002Z,1748378832.002 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3744
2025-05-27T20:47:12.004Z,1748378832.004 [controlThread ThreadHandler](INFO): Handler Thread ID is 3745
2025-05-27T20:47:12.004Z,1748378832.004 [controlThread](DEBUG): Initializing ControlThread
2025-05-27T20:47:12.007Z,1748378832.007 [SBIT](INFO): Initialize SBIT Component.
2025-05-27T20:47:12.008Z,1748378832.008 [SBIT](IMPORTANT): git: 2025-05-12_B
2025-05-27T20:47:12.008Z,1748378832.008 [SBIT](INFO): git hash: 7c5b1c07405cfe7ca09821eb029d166d25d65d57
2025-05-27T20:47:12.008Z,1748378832.008 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-05-27T20:47:12.010Z,1748378832.010 [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-05-27T20:47:12.011Z,1748378832.011 [SBIT](INFO): Beginning SBIT in 164.000000 seconds.
2025-05-27T20:47:12.011Z,1748378832.011 [IBIT](INFO): Initialize IBIT Component.
2025-05-27T20:47:12.012Z,1748378832.012 [CBIT](DEBUG): Initialize CBIT Component.
2025-05-27T20:47:12.013Z,1748378832.013 [logger ThreadHandler](INFO): Handler Thread ID is 3746
2025-05-27T20:47:12.024Z,1748378832.024 [CBIT](DEBUG): Initialized mux pins.
2025-05-27T20:47:12.025Z,1748378832.025 [CBIT](DEBUG): Initializing the watchdog timer.
2025-05-27T20:47:12.033Z,1748378832.033 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3747
2025-05-27T20:47:12.034Z,1748378832.034 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-05-27T20:47:12.038Z,1748378832.038 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3749
2025-05-27T20:47:12.041Z,1748378832.041 [WetLabsBB2FL](INFO): Powering up
2025-05-27T20:47:12.042Z,1748378832.042 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3751
2025-05-27T20:47:12.048Z,1748378832.048 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-05-27T20:47:12.049Z,1748378832.049 [CBIT](DEBUG): Initializing heartbeat.
2025-05-27T20:47:12.050Z,1748378832.050 [DAT ThreadHandler](INFO): Handler Thread ID is 3752
2025-05-27T20:47:12.051Z,1748378832.051 [DAT](INFO): Powering up
2025-05-27T20:47:12.051Z,1748378832.051 [DAT](DEBUG): Initializing DAT.
2025-05-27T20:47:12.054Z,1748378832.054 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3754
2025-05-27T20:47:12.055Z,1748378832.055 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-05-27T20:47:12.077Z,1748378832.077 [Onboard ThreadHandler](INFO): Handler Thread ID is 3755
2025-05-27T20:47:12.094Z,1748378832.094 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3756
2025-05-27T20:47:12.115Z,1748378832.115 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3757
2025-05-27T20:47:12.121Z,1748378832.121 [CBIT](DEBUG): Deactivating emergency mode.
2025-05-27T20:47:12.125Z,1748378832.125 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-05-27T20:47:12.126Z,1748378832.126 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-05-27T20:47:12.126Z,1748378832.126 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-05-27T20:47:12.126Z,1748378832.126 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-05-27T20:47:12.126Z,1748378832.126 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-05-27T20:47:12.126Z,1748378832.126 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-05-27T20:47:12.126Z,1748378832.126 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-05-27T20:47:12.127Z,1748378832.127 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-05-27T20:47:12.161Z,1748378832.161 [CBIT](DEBUG): Backplane powered.
2025-05-27T20:47:12.161Z,1748378832.161 [GFScanner](DEBUG): Initializing GFScanner
2025-05-27T20:47:12.161Z,1748378832.161 [GFScanner](DEBUG): Deactivating GF circuits.
2025-05-27T20:47:12.169Z,1748378832.169 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-05-27T20:47:12.170Z,1748378832.170 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-05-27T20:47:12.170Z,1748378832.170 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-05-27T20:47:12.170Z,1748378832.170 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-05-27T20:47:12.171Z,1748378832.171 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-05-27T20:47:12.172Z,1748378832.172 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-05-27T20:47:12.172Z,1748378832.172 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-05-27T20:47:12.184Z,1748378832.184 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-05-27T20:47:12.194Z,1748378832.194 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-05-27T20:47:12.195Z,1748378832.195 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-05-27T20:47:12.195Z,1748378832.195 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-05-27T20:47:12.196Z,1748378832.196 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-05-27T20:47:12.206Z,1748378832.206 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-05-27T20:47:12.207Z,1748378832.207 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-05-27T20:47:12.233Z,1748378832.233 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-05-27T20:47:12.284Z,1748378832.284 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-05-27T20:47:12.327Z,1748378832.327 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-05-27T20:47:12.363Z,1748378832.363 [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-05-27T20:47:12.363Z,1748378832.363 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-05-27T20:47:12.364Z,1748378832.364 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-05-27T20:47:12.369Z,1748378832.369 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-05-27T20:47:12.501Z,1748378832.501 [Radio_Surface](INFO): Powering up
2025-05-27T20:47:12.693Z,1748378832.693 [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-05-27T20:47:12.699Z,1748378832.699 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-05-27T20:47:12.700Z,1748378832.700 [Default:A.Wait](DEBUG): Construct Wait.
2025-05-27T20:47:12.714Z,1748378832.714 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-05-27T20:47:12.739Z,1748378832.739 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-05-27T20:47:12.761Z,1748378832.761 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-05-27T20:47:12.783Z,1748378832.783 [Default:E.Execute](DEBUG): Construct Execute.
2025-05-27T20:47:12.786Z,1748378832.786 [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-05-27T20:47:12.805Z,1748378832.805 [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-05-27T20:47:12.850Z,1748378832.850 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-05-27T20:47:12.995Z,1748378832.995 [Depth_Keller](INFO): Initializing.
2025-05-27T20:47:12.999Z,1748378832.999 [PowerOnly](INFO): Powering up loadControl
2025-05-27T20:47:13.017Z,1748378833.017 [Power24vConverter](INFO): Powering up.
2025-05-27T20:47:13.018Z,1748378833.018 [Sonardyne_Nano](INFO): Initializing.
2025-05-27T20:47:13.045Z,1748378833.045 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-05-27T20:47:13.132Z,1748378833.132 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-05-27T20:47:13.141Z,1748378833.141 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-05-27T20:47:13.142Z,1748378833.142 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-05-27T20:47:13.149Z,1748378833.149 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-05-27T20:47:13.150Z,1748378833.150 [MassServo](DEBUG): Initializing EZServoServo.
2025-05-27T20:47:13.157Z,1748378833.157 [MassServo](DEBUG): Initializing MassServo.
2025-05-27T20:47:13.158Z,1748378833.158 [RudderServo](DEBUG): Initializing EZServoServo.
2025-05-27T20:47:13.165Z,1748378833.165 [RudderServo](DEBUG): Initializing RudderServo.
2025-05-27T20:47:13.166Z,1748378833.166 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-05-27T20:47:13.173Z,1748378833.173 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-05-27T20:47:13.292Z,1748378833.292 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T20:47:13.292Z,1748378833.292 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T20:47:13.292Z,1748378833.292 [DropWeight](ERROR): Hardware Fault
2025-05-27T20:47:13.320Z,1748378833.320 [CommandExec](FAULT): Scheduling is paused
2025-05-27T20:47:13.329Z,1748378833.329 [CBIT](INFO): Critical error at 20250527T204713
2025-05-27T20:47:13.329Z,1748378833.329 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-05-27T20:47:13.331Z,1748378833.331 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T20:47:13.332Z,1748378833.332 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T20:47:13.667Z,1748378833.667 [CBIT](INFO): Critical error at 20250527T204713
2025-05-27T20:47:14.653Z,1748378834.653 [WetLabsBB2FL](INFO): Powering down
2025-05-27T20:47:16.481Z,1748378836.481 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-05-27T20:47:17.366Z,1748378837.366 [Sonardyne_Nano](FAULT): Failed hardware self-test:>CKHW:FAIL;LBK
2025-05-27T20:47:17.366Z,1748378837.366 [Sonardyne_Nano] Hardware Fault, FailCount= 1
2025-05-27T20:47:17.366Z,1748378837.366 [Sonardyne_Nano](ERROR): Hardware Fault
2025-05-27T20:47:17.549Z,1748378837.549 [CBIT](ERROR): Hardware Fault in component: Sonardyne_Nano
2025-05-27T20:47:17.711Z,1748378837.711 [Sonardyne_Nano](INFO): Powering down
2025-05-27T20:47:18.586Z,1748378838.586 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-05-27T20:47:18.652Z,1748378838.652 [CBIT](INFO): Clearing failed state for component Sonardyne_Nano
2025-05-27T20:47:18.652Z,1748378838.652 [Sonardyne_Nano] No Fault, FailCount= 1
2025-05-27T20:47:18.919Z,1748378838.919 [Sonardyne_Nano](INFO): Initializing.
2025-05-27T20:47:20.940Z,1748378840.940 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-05-27T20:47:22.164Z,1748378842.164 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213
2025-05-27T20:47:24.149Z,1748378844.149 [DAT](INFO): DAT read:
2025-05-27T20:47:24.151Z,1748378844.151 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-05-27T20:47:25.914Z,1748378845.914 [DAT](INFO): DAT read: MF Frequency Band
2025-05-27T20:47:25.915Z,1748378845.915 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2025-05-27T20:47:25.915Z,1748378845.915 [DAT](INFO): DAT read: May 14 2025 21:38:16
2025-05-27T20:47:26.922Z,1748378846.922 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-05-27T20:47:26.923Z,1748378846.923 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2025-05-27T20:47:26.924Z,1748378846.924 [DAT](INFO): commRate: 1200
2025-05-27T20:47:27.104Z,1748378847.104 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.006219
2025-05-27T20:47:28.989Z,1748378848.989 [DAT](INFO): entering command mode
2025-05-27T20:47:29.189Z,1748378849.189 [DAT](INFO): DAT read:
2025-05-27T20:47:29.190Z,1748378849.190 [DAT](INFO): DAT read: user:1>
2025-05-27T20:47:29.190Z,1748378849.190 [DAT](INFO): setting verbose to 3
2025-05-27T20:47:29.442Z,1748378849.442 [DAT](INFO): DAT read: user:1>
2025-05-27T20:47:29.443Z,1748378849.443 [DAT](INFO): DAT read: Verbose | 3
2025-05-27T20:47:29.443Z,1748378849.443 [DAT](INFO): set verbose to 3
2025-05-27T20:47:29.443Z,1748378849.443 [DAT](INFO): setting DatVerbose to 27440
2025-05-27T20:47:29.693Z,1748378849.693 [DAT](INFO): DAT read: user:2>
2025-05-27T20:47:29.694Z,1748378849.694 [DAT](INFO): DAT read: DatVerbose | 27440
2025-05-27T20:47:29.695Z,1748378849.695 [DAT](INFO): set DatVerbose to 27440
2025-05-27T20:47:29.695Z,1748378849.695 [DAT](INFO): setting transmit power to 8
2025-05-27T20:47:29.945Z,1748378849.945 [DAT](INFO): DAT read: user:3>
2025-05-27T20:47:29.946Z,1748378849.946 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-05-27T20:47:29.947Z,1748378849.947 [DAT](INFO): set transmit power to 8
2025-05-27T20:47:29.947Z,1748378849.947 [DAT](INFO): setting local address to 5
2025-05-27T20:47:30.197Z,1748378850.197 [DAT](INFO): DAT read: user:4>
2025-05-27T20:47:30.198Z,1748378850.198 [DAT](INFO): DAT read: LocalAddr | 5
2025-05-27T20:47:30.198Z,1748378850.198 [DAT](INFO): set local address to 5
2025-05-27T20:47:30.199Z,1748378850.199 [DAT](INFO): Setting time to: 20:47:30 And date to:5/27/2025
2025-05-27T20:47:30.449Z,1748378850.449 [DAT](INFO): DAT read: user:5>
2025-05-27T20:47:30.450Z,1748378850.450 [DAT](INFO): DAT read: Tue May 27, 2025 20:47:30
2025-05-27T20:47:30.451Z,1748378850.451 [DAT](INFO): Local DAT time set to Tue May 27, 2025 20:47:30
2025-05-27T20:47:41.536Z,1748378861.536 [NAL9602](INFO): Powering up NAL9602
2025-05-27T20:47:52.419Z,1748378872.419 [NAL9602](INFO): NAL9602 initialized
2025-05-27T20:48:37.417Z,1748378917.417 [CommandExec](IMPORTANT): got command failComponent
2025-05-27T20:48:37.417Z,1748378917.417 [CommandExec](IMPORTANT): Failed components:
2025-05-27T20:48:37.418Z,1748378917.418 [CommandExec](IMPORTANT): DropWeight: Hardware Fault
2025-05-27T20:49:11.062Z,1748378951.062 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitFwd
2025-05-27T20:49:11.062Z,1748378951.062 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitFwd 38.500000 mm
2025-05-27T20:49:56.508Z,1748378996.508 [SBIT](IMPORTANT): Beginning Startup BIT
2025-05-27T20:49:56.513Z,1748378996.513 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-05-27T20:50:00.998Z,1748379000.998 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010020
CHAN A1 (24V): 0.000415
CHAN A2 (12V): -0.004838
CHAN A3 (5V): -0.002571
CHAN B0 (3.3V): -0.000893
CHAN B1 (3.15aV): -0.000841
CHAN B2 (3.15bV): -0.001005
CHAN B3 (GND): 0.000156
OPEN: 0.006689
Full Scale: +/- 1 mA
2025-05-27T20:50:12.434Z,1748379012.434 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-05-27T20:50:12.434Z,1748379012.434 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T20:50:12.645Z,1748379012.645 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T20:50:12.870Z,1748379012.870 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T20:50:12.870Z,1748379012.870 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-05-27T20:50:50.684Z,1748379050.684 [SBIT](IMPORTANT): SBIT PASSED
2025-05-27T20:50:50.684Z,1748379050.684 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-05-27T20:50:50.701Z,1748379050.701 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count;
2025-05-27T20:50:50.701Z,1748379050.701 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;
2025-05-27T20:50:50.701Z,1748379050.701 [SBIT](IMPORTANT): DVL_micro.loadAtStartup=1 bool;
2025-05-27T20:50:50.701Z,1748379050.701 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;
2025-05-27T20:50:50.701Z,1748379050.701 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=0 bool;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=245.826411 cubic_centimeter;
2025-05-27T20:50:50.702Z,1748379050.702 [SBIT](IMPORTANT): VerticalControl.massDefault=36.203649 millimeter;
2025-05-27T20:50:51.091Z,1748379051.091 [MissionManager](IMPORTANT): Started mission Startup
2025-05-27T20:50:51.091Z,1748379051.091 [Startup] Running Loop=1
2025-05-27T20:50:51.091Z,1748379051.091 [Startup](DEBUG): Aggregate::initialize Startup
2025-05-27T20:50:51.091Z,1748379051.091 [Startup:A.GoToSurface] Running Loop=1
2025-05-27T20:50:51.092Z,1748379051.092 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-05-27T20:50:51.092Z,1748379051.092 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-05-27T20:50:51.093Z,1748379051.093 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-05-27T20:50:51.093Z,1748379051.093 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-05-27T20:50:51.094Z,1748379051.094 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-05-27T20:50:51.094Z,1748379051.094 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-05-27T20:50:51.094Z,1748379051.094 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-05-27T20:50:51.096Z,1748379051.096 [Startup:StartupSatComms] Running Loop=1
2025-05-27T20:50:51.096Z,1748379051.096 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-05-27T20:50:51.096Z,1748379051.096 [Startup:StartupSatComms:A] Running Loop=1
2025-05-27T20:50:51.490Z,1748379051.490 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-05-27T20:51:06.026Z,1748379066.026 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-05-27T20:51:51.306Z,1748379111.306 [Startup:StartupSatComms:A](INFO): Timed out from 2025-05-27T20:50:51.1Z
2025-05-27T20:51:51.307Z,1748379111.307 [Startup:StartupSatComms:A] Stopped
2025-05-27T20:51:51.307Z,1748379111.307 [Startup:StartupSatComms:B] Running Loop=1
2025-05-27T20:51:51.707Z,1748379111.707 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-05-27T20:51:52.430Z,1748379112.430 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250514T203529/Courier0030.lzma
2025-05-27T20:51:53.387Z,1748379113.387 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0030.lzma.bak
2025-05-27T20:51:53.387Z,1748379113.387 [DataOverHttps](INFO): SBD MOMSN=25010087
2025-05-27T20:52:09.441Z,1748379129.441 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20250527T204659/Courier0000.lzma
2025-05-27T20:52:10.443Z,1748379130.443 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0000.lzma.bak
2025-05-27T20:52:10.444Z,1748379130.444 [DataOverHttps](INFO): SBD MOMSN=25010089
2025-05-27T20:52:26.554Z,1748379146.554 [DataOverHttps](INFO): Sending 100 bytes from file Logs/20250514T203529/Express0031.lzma
2025-05-27T20:52:27.555Z,1748379147.555 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0031.lzma.bak
2025-05-27T20:52:27.555Z,1748379147.555 [DataOverHttps](INFO): SBD MOMSN=25010095
2025-05-27T20:52:43.480Z,1748379163.480 [DataOverHttps](INFO): Sending 1114 bytes from file Logs/20250527T204659/Express0001.lzma
2025-05-27T20:52:44.480Z,1748379164.480 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0001.lzma.bak
2025-05-27T20:52:44.480Z,1748379164.480 [DataOverHttps](INFO): SBD MOMSN=25010106
2025-05-27T20:52:45.823Z,1748379165.823 [Startup:StartupSatComms:B] Stopped
2025-05-27T20:52:45.823Z,1748379165.823 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-05-27T20:52:45.823Z,1748379165.823 [Startup:StartupSatComms] Stopped
2025-05-27T20:52:45.823Z,1748379165.823 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-05-27T20:52:45.825Z,1748379165.825 [Startup](INFO): Completed Startup
2025-05-27T20:52:45.825Z,1748379165.825 [MissionManager](INFO): Startup is completed.
2025-05-27T20:52:45.825Z,1748379165.825 [MissionManager](INFO): Uninitializing Mission Startup
2025-05-27T20:52:45.825Z,1748379165.825 [Startup] Stopped
2025-05-27T20:52:45.825Z,1748379165.825 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-05-27T20:52:45.825Z,1748379165.825 [Startup:A.GoToSurface] Stopped
2025-05-27T20:52:45.825Z,1748379165.825 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-05-27T20:52:46.248Z,1748379166.248 [MissionManager](IMPORTANT): Started mission Default
2025-05-27T20:52:46.249Z,1748379166.249 [Default] Running Loop=1
2025-05-27T20:52:46.249Z,1748379166.249 [Default](DEBUG): Aggregate::initialize Default
2025-05-27T20:52:46.249Z,1748379166.249 [Default:B.GoToSurface] Running Loop=1
2025-05-27T20:52:46.249Z,1748379166.249 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-05-27T20:52:46.250Z,1748379166.250 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-05-27T20:52:46.250Z,1748379166.250 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-05-27T20:52:46.251Z,1748379166.251 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-05-27T20:52:46.251Z,1748379166.251 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-05-27T20:52:46.252Z,1748379166.252 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-05-27T20:52:46.252Z,1748379166.252 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-05-27T20:52:46.253Z,1748379166.253 [Default:A.Wait] Running Loop=1
2025-05-27T20:52:46.253Z,1748379166.253 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-05-27T20:52:55.507Z,1748379175.507 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-05-27T20:52:59.625Z,1748379179.625 [Default:A.Wait](INFO): Done Waiting.
2025-05-27T20:52:59.625Z,1748379179.625 [Default:A.Wait] Stopped
2025-05-27T20:52:59.625Z,1748379179.625 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T20:52:59.996Z,1748379179.996 [Default:CheckIn] Running Loop=1
2025-05-27T20:52:59.996Z,1748379179.996 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T20:52:59.996Z,1748379179.996 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T20:53:00.386Z,1748379180.386 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-05-27T20:53:13.306Z,1748379193.306 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-05-27T20:53:13.306Z,1748379193.306 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T20:53:13.316Z,1748379193.316 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T20:53:13.723Z,1748379193.723 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T20:53:13.723Z,1748379193.723 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-05-27T20:54:47.028Z,1748379287.028 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-05-27T20:54:47.029Z,1748379287.029 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 6.
2025-05-27T20:54:47.033Z,1748379287.033 [BPC1](INFO): Received data from all battery sticks.
2025-05-27T20:56:14.282Z,1748379374.282 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-05-27T20:56:14.282Z,1748379374.282 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T20:56:14.319Z,1748379374.319 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T20:56:14.726Z,1748379374.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T20:56:14.726Z,1748379374.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-05-27T20:57:53.677Z,1748379473.677 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T20:57:53.677Z,1748379473.677 [NAL9602] Data Fault, FailCount= 1
2025-05-27T20:57:53.677Z,1748379473.677 [NAL9602](ERROR): Data Fault
2025-05-27T20:57:53.736Z,1748379473.736 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T20:57:54.083Z,1748379474.083 [NAL9602](INFO): Powering down
2025-05-27T20:57:54.927Z,1748379474.927 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T20:57:54.927Z,1748379474.927 [NAL9602] No Fault, FailCount= 1
2025-05-27T20:58:00.135Z,1748379480.135 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T20:52:59.0Z
2025-05-27T20:58:00.135Z,1748379480.135 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T20:58:00.135Z,1748379480.135 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T20:58:00.544Z,1748379480.544 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-05-27T20:58:07.776Z,1748379487.776 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250527T204659/Courier0004.lzma
2025-05-27T20:58:08.778Z,1748379488.778 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0004.lzma.bak
2025-05-27T20:58:08.779Z,1748379488.779 [DataOverHttps](INFO): SBD MOMSN=25010166
2025-05-27T20:58:24.367Z,1748379504.367 [NAL9602](INFO): Powering up NAL9602
2025-05-27T20:58:24.697Z,1748379504.697 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20250527T204659/Express0005.lzma
2025-05-27T20:58:25.699Z,1748379505.699 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0005.lzma.bak
2025-05-27T20:58:25.700Z,1748379505.700 [DataOverHttps](INFO): SBD MOMSN=25010168
2025-05-27T20:58:27.195Z,1748379507.195 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T20:58:27.195Z,1748379507.195 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T20:58:27.195Z,1748379507.195 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T20:58:35.271Z,1748379515.271 [NAL9602](INFO): NAL9602 initialized
2025-05-27T20:59:15.289Z,1748379555.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-05-27T20:59:15.289Z,1748379555.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T20:59:15.377Z,1748379555.377 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T20:59:15.710Z,1748379555.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T20:59:15.710Z,1748379555.710 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-05-27T21:02:13.528Z,1748379733.528 [CBIT](INFO): Clearing failed state for component DropWeight
2025-05-27T21:02:13.528Z,1748379733.528 [DropWeight] No Fault, FailCount= 1
2025-05-27T21:02:16.341Z,1748379736.341 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-05-27T21:02:16.341Z,1748379736.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:02:16.352Z,1748379736.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:02:16.754Z,1748379736.754 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:02:16.754Z,1748379736.754 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-05-27T21:03:27.858Z,1748379807.858 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T21:03:27.858Z,1748379807.858 [Default:CheckIn:C.Wait] Stopped
2025-05-27T21:03:27.858Z,1748379807.858 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:03:27.858Z,1748379807.858 [Default:CheckIn:D] Running Loop=1
2025-05-27T21:03:28.278Z,1748379808.278 [Default:CheckIn:D] Stopped
2025-05-27T21:03:28.278Z,1748379808.278 [Default:CheckIn:E] Running Loop=1
2025-05-27T21:03:28.658Z,1748379808.658 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.700493 min
2025-05-27T21:03:28.658Z,1748379808.658 [Default:CheckIn:E] Stopped
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn] Stopped
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn](INFO): Running loop #2
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn] Running Loop=2
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:03:28.659Z,1748379808.659 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:05:17.349Z,1748379917.349 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-05-27T21:05:17.349Z,1748379917.349 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:05:17.364Z,1748379917.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:05:17.731Z,1748379917.731 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:05:17.731Z,1748379917.731 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-05-27T21:08:18.329Z,1748380098.329 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-05-27T21:08:18.329Z,1748380098.329 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:08:18.340Z,1748380098.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:08:18.720Z,1748380098.720 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:08:18.720Z,1748380098.720 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-05-27T21:08:28.811Z,1748380108.811 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:03:28.7Z
2025-05-27T21:08:28.811Z,1748380108.811 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T21:08:28.812Z,1748380108.812 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T21:08:30.830Z,1748380110.830 [DVL_micro](ERROR): Failed to parse:
:SA,-02.41,+02.51,206.9
2025-05-27T21:08:36.228Z,1748380116.228 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0007.lzma
2025-05-27T21:08:36.483Z,1748380116.483 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T21:08:36.484Z,1748380116.484 [NAL9602] Data Fault, FailCount= 2
2025-05-27T21:08:36.484Z,1748380116.484 [NAL9602](ERROR): Data Fault
2025-05-27T21:08:36.526Z,1748380116.526 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T21:08:36.883Z,1748380116.883 [NAL9602](INFO): Powering down
2025-05-27T21:08:37.230Z,1748380117.230 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0007.lzma.bak
2025-05-27T21:08:37.231Z,1748380117.231 [DataOverHttps](INFO): SBD MOMSN=25010205
2025-05-27T21:08:37.704Z,1748380117.704 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T21:08:37.704Z,1748380117.704 [NAL9602] No Fault, FailCount= 2
2025-05-27T21:08:52.988Z,1748380132.988 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20250527T204659/Express0008.lzma
2025-05-27T21:08:53.990Z,1748380133.990 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0008.lzma.bak
2025-05-27T21:08:53.991Z,1748380133.991 [DataOverHttps](INFO): SBD MOMSN=25010247
2025-05-27T21:08:55.474Z,1748380135.474 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T21:08:55.475Z,1748380135.475 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T21:08:55.475Z,1748380135.475 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T21:09:07.183Z,1748380147.183 [NAL9602](INFO): Powering up NAL9602
2025-05-27T21:09:18.095Z,1748380158.095 [NAL9602](INFO): NAL9602 initialized
2025-05-27T21:11:19.329Z,1748380279.329 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-05-27T21:11:19.329Z,1748380279.329 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:11:19.340Z,1748380279.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:11:19.737Z,1748380279.737 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:11:19.737Z,1748380279.737 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-05-27T21:13:56.070Z,1748380436.070 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T21:13:56.070Z,1748380436.070 [Default:CheckIn:C.Wait] Stopped
2025-05-27T21:13:56.070Z,1748380436.070 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:13:56.070Z,1748380436.070 [Default:CheckIn:D] Running Loop=1
2025-05-27T21:13:56.486Z,1748380436.486 [Default:CheckIn:D] Stopped
2025-05-27T21:13:56.486Z,1748380436.486 [Default:CheckIn:E] Running Loop=1
2025-05-27T21:13:56.868Z,1748380436.868 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.170628 min
2025-05-27T21:13:56.868Z,1748380436.868 [Default:CheckIn:E] Stopped
2025-05-27T21:13:56.868Z,1748380436.868 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T21:13:56.868Z,1748380436.868 [Default:CheckIn] Stopped
2025-05-27T21:13:56.885Z,1748380436.885 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T21:13:56.885Z,1748380436.885 [Default:CheckIn](INFO): Running loop #3
2025-05-27T21:13:56.885Z,1748380436.885 [Default:CheckIn] Running Loop=3
2025-05-27T21:13:56.885Z,1748380436.885 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:13:56.885Z,1748380436.885 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:14:20.313Z,1748380460.313 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-05-27T21:14:20.313Z,1748380460.313 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:14:20.328Z,1748380460.328 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:14:20.718Z,1748380460.718 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:14:20.718Z,1748380460.718 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-05-27T21:16:55.019Z,1748380615.019 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.99,+9999.99
2025-05-27T21:17:21.338Z,1748380641.338 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-05-27T21:17:21.338Z,1748380641.338 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:17:21.357Z,1748380641.357 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:17:21.715Z,1748380641.715 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:17:21.715Z,1748380641.715 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-05-27T21:18:57.045Z,1748380737.045 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:13:56.9Z
2025-05-27T21:18:57.045Z,1748380737.045 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T21:18:57.045Z,1748380737.045 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T21:19:03.924Z,1748380743.924 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0010.lzma
2025-05-27T21:19:04.927Z,1748380744.927 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0010.lzma.bak
2025-05-27T21:19:04.927Z,1748380744.927 [DataOverHttps](INFO): SBD MOMSN=25010289
2025-05-27T21:19:20.466Z,1748380760.466 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T21:19:20.466Z,1748380760.466 [NAL9602] Data Fault, FailCount= 3
2025-05-27T21:19:20.466Z,1748380760.466 [NAL9602](ERROR): Data Fault
2025-05-27T21:19:20.532Z,1748380760.532 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T21:19:20.784Z,1748380760.784 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250527T204659/Express0011.lzma
2025-05-27T21:19:20.885Z,1748380760.885 [NAL9602](INFO): Powering down
2025-05-27T21:19:21.699Z,1748380761.699 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T21:19:21.699Z,1748380761.699 [NAL9602] No Fault, FailCount= 3
2025-05-27T21:19:21.786Z,1748380761.786 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0011.lzma.bak
2025-05-27T21:19:21.787Z,1748380761.787 [DataOverHttps](INFO): SBD MOMSN=25010338
2025-05-27T21:19:23.311Z,1748380763.311 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T21:19:23.311Z,1748380763.311 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T21:19:23.311Z,1748380763.311 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T21:19:51.163Z,1748380791.163 [NAL9602](INFO): Powering up NAL9602
2025-05-27T21:20:02.071Z,1748380802.071 [NAL9602](INFO): NAL9602 initialized
2025-05-27T21:20:22.293Z,1748380822.293 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-05-27T21:20:22.293Z,1748380822.293 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:20:22.331Z,1748380822.331 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:20:22.746Z,1748380822.746 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:20:22.746Z,1748380822.746 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-05-27T21:23:23.295Z,1748381003.295 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-05-27T21:23:23.295Z,1748381003.295 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:23:23.307Z,1748381003.307 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:23:23.680Z,1748381003.680 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:23:23.680Z,1748381003.680 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-05-27T21:24:23.871Z,1748381063.871 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T21:24:23.871Z,1748381063.871 [Default:CheckIn:C.Wait] Stopped
2025-05-27T21:24:23.871Z,1748381063.871 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:24:23.871Z,1748381063.871 [Default:CheckIn:D] Running Loop=1
2025-05-27T21:24:24.305Z,1748381064.305 [Default:CheckIn:D] Stopped
2025-05-27T21:24:24.305Z,1748381064.305 [Default:CheckIn:E] Running Loop=1
2025-05-27T21:24:24.702Z,1748381064.702 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.634271 min
2025-05-27T21:24:24.702Z,1748381064.702 [Default:CheckIn:E] Stopped
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn] Stopped
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn](INFO): Running loop #4
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn] Running Loop=4
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:24:24.703Z,1748381064.703 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:26:24.285Z,1748381184.285 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-05-27T21:26:24.285Z,1748381184.285 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:26:24.295Z,1748381184.295 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:26:24.694Z,1748381184.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:26:24.694Z,1748381184.694 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-05-27T21:29:24.852Z,1748381364.852 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:24:24.7Z
2025-05-27T21:29:24.852Z,1748381364.852 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T21:29:24.852Z,1748381364.852 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T21:29:25.258Z,1748381365.258 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-05-27T21:29:25.258Z,1748381365.258 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:29:25.271Z,1748381365.271 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:29:25.739Z,1748381365.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:29:25.739Z,1748381365.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-05-27T21:29:31.836Z,1748381371.836 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0013.lzma
2025-05-27T21:29:32.839Z,1748381372.839 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0013.lzma.bak
2025-05-27T21:29:32.839Z,1748381372.839 [DataOverHttps](INFO): SBD MOMSN=25010373
2025-05-27T21:29:48.716Z,1748381388.716 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250527T204659/Express0014.lzma
2025-05-27T21:29:49.718Z,1748381389.718 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0014.lzma.bak
2025-05-27T21:29:49.719Z,1748381389.719 [DataOverHttps](INFO): SBD MOMSN=25010422
2025-05-27T21:29:51.162Z,1748381391.162 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T21:29:51.162Z,1748381391.162 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T21:29:51.162Z,1748381391.162 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T21:30:03.271Z,1748381403.271 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T21:30:03.271Z,1748381403.271 [NAL9602] Data Fault, FailCount= 4
2025-05-27T21:30:03.271Z,1748381403.271 [NAL9602](ERROR): Data Fault
2025-05-27T21:30:03.317Z,1748381403.317 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T21:30:03.675Z,1748381403.675 [NAL9602](INFO): Powering down
2025-05-27T21:30:04.503Z,1748381404.503 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T21:30:04.504Z,1748381404.504 [NAL9602] No Fault, FailCount= 4
2025-05-27T21:30:33.971Z,1748381433.971 [NAL9602](INFO): Powering up NAL9602
2025-05-27T21:30:44.880Z,1748381444.880 [NAL9602](INFO): NAL9602 initialized
2025-05-27T21:32:14.970Z,1748381534.970 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T21:32:14.971Z,1748381534.971 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T21:32:14.971Z,1748381534.971 [DropWeight](ERROR): Hardware Fault
2025-05-27T21:32:14.993Z,1748381534.993 [CBIT](INFO): Critical error at 20250527T213214
2025-05-27T21:32:14.996Z,1748381534.996 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T21:32:15.029Z,1748381535.029 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T21:32:15.443Z,1748381535.443 [CBIT](INFO): Critical error at 20250527T213215
2025-05-27T21:32:26.301Z,1748381546.301 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-05-27T21:32:26.301Z,1748381546.301 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:32:26.339Z,1748381546.339 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:32:26.711Z,1748381546.711 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:32:26.711Z,1748381546.711 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-05-27T21:34:51.768Z,1748381691.768 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T21:34:51.768Z,1748381691.768 [Default:CheckIn:C.Wait] Stopped
2025-05-27T21:34:51.768Z,1748381691.768 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:34:51.789Z,1748381691.789 [Default:CheckIn:D] Running Loop=1
2025-05-27T21:34:52.163Z,1748381692.163 [Default:CheckIn:D] Stopped
2025-05-27T21:34:52.163Z,1748381692.163 [Default:CheckIn:E] Running Loop=1
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.098576 min
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn:E] Stopped
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn] Stopped
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn](INFO): Running loop #5
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn] Running Loop=5
2025-05-27T21:34:52.573Z,1748381692.573 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:34:52.574Z,1748381692.574 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:35:27.332Z,1748381727.332 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-05-27T21:35:27.332Z,1748381727.332 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:35:27.342Z,1748381727.342 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:35:27.750Z,1748381727.750 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:35:27.750Z,1748381727.750 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-05-27T21:38:28.318Z,1748381908.318 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-05-27T21:38:28.318Z,1748381908.318 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:38:28.330Z,1748381908.330 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:38:28.735Z,1748381908.735 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:38:28.736Z,1748381908.736 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-05-27T21:39:52.758Z,1748381992.758 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:34:52.6Z
2025-05-27T21:39:52.758Z,1748381992.758 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T21:39:52.758Z,1748381992.758 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T21:40:00.352Z,1748382000.352 [DataOverHttps](INFO): Sending 116 bytes from file Logs/20250527T204659/Courier0016.lzma
2025-05-27T21:40:01.356Z,1748382001.356 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0016.lzma.bak
2025-05-27T21:40:01.356Z,1748382001.356 [DataOverHttps](INFO): SBD MOMSN=25010454
2025-05-27T21:40:20.009Z,1748382020.009 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250527T204659/Express0017.lzma
2025-05-27T21:40:21.010Z,1748382021.010 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0017.lzma.bak
2025-05-27T21:40:21.011Z,1748382021.011 [DataOverHttps](INFO): SBD MOMSN=25010501
2025-05-27T21:40:22.318Z,1748382022.318 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T21:40:22.318Z,1748382022.318 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T21:40:22.318Z,1748382022.318 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T21:40:46.127Z,1748382046.127 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T21:40:46.127Z,1748382046.127 [NAL9602] Data Fault, FailCount= 5
2025-05-27T21:40:46.127Z,1748382046.127 [NAL9602](ERROR): Data Fault
2025-05-27T21:40:46.145Z,1748382046.145 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T21:40:46.146Z,1748382046.146 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-05-27T21:40:46.538Z,1748382046.538 [NAL9602](INFO): Powering down
2025-05-27T21:40:46.554Z,1748382046.554 [CBIT](INFO): Critical error at 20250527T214046
2025-05-27T21:41:29.380Z,1748382089.380 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-05-27T21:41:29.380Z,1748382089.380 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:41:29.396Z,1748382089.396 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:41:29.802Z,1748382089.802 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:41:29.802Z,1748382089.802 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-05-27T21:42:46.140Z,1748382166.140 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T21:42:46.140Z,1748382166.140 [NAL9602] No Fault, FailCount= 5
2025-05-27T21:42:46.528Z,1748382166.528 [NAL9602](INFO): Powering up NAL9602
2025-05-27T21:42:57.435Z,1748382177.435 [NAL9602](INFO): NAL9602 initialized
2025-05-27T21:44:30.385Z,1748382270.385 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-05-27T21:44:30.385Z,1748382270.385 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:44:30.427Z,1748382270.427 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:44:30.803Z,1748382270.803 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:44:30.803Z,1748382270.803 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-05-27T21:45:06.718Z,1748382306.718 [DVL_micro](ERROR): Failed to parse:
:WI,-01605,-02768,+00665,+00000,A
2025-05-27T21:45:22.906Z,1748382322.906 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T21:45:22.906Z,1748382322.906 [Default:CheckIn:C.Wait] Stopped
2025-05-27T21:45:22.906Z,1748382322.906 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:45:22.906Z,1748382322.906 [Default:CheckIn:D] Running Loop=1
2025-05-27T21:45:23.302Z,1748382323.302 [Default:CheckIn:D] Stopped
2025-05-27T21:45:23.302Z,1748382323.302 [Default:CheckIn:E] Running Loop=1
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.617558 min
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn:E] Stopped
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn] Stopped
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn](INFO): Running loop #6
2025-05-27T21:45:23.706Z,1748382323.706 [Default:CheckIn] Running Loop=6
2025-05-27T21:45:23.707Z,1748382323.707 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:45:23.707Z,1748382323.707 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:47:15.200Z,1748382435.200 [CBIT](INFO): Clearing failed state for component DropWeight
2025-05-27T21:47:15.201Z,1748382435.201 [DropWeight] No Fault, FailCount= 1
2025-05-27T21:47:31.366Z,1748382451.366 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-05-27T21:47:31.366Z,1748382451.366 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:47:31.380Z,1748382451.380 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:47:31.821Z,1748382451.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:47:31.821Z,1748382451.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2025-05-27T21:50:23.860Z,1748382623.860 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:45:23.7Z
2025-05-27T21:50:23.860Z,1748382623.860 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T21:50:23.861Z,1748382623.861 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T21:50:31.680Z,1748382631.680 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20250527T204659/Courier0019.lzma
2025-05-27T21:50:32.335Z,1748382632.335 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2025-05-27T21:50:32.335Z,1748382632.335 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:50:32.346Z,1748382632.346 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:50:32.683Z,1748382632.683 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0019.lzma.bak
2025-05-27T21:50:32.684Z,1748382632.684 [DataOverHttps](INFO): SBD MOMSN=25010529
2025-05-27T21:50:32.820Z,1748382632.820 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:50:32.820Z,1748382632.820 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2025-05-27T21:50:48.456Z,1748382648.456 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250527T204659/Express0020.lzma
2025-05-27T21:50:49.458Z,1748382649.458 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0020.lzma.bak
2025-05-27T21:50:49.459Z,1748382649.459 [DataOverHttps](INFO): SBD MOMSN=25010579
2025-05-27T21:50:50.958Z,1748382650.958 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T21:50:50.958Z,1748382650.958 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T21:50:50.958Z,1748382650.958 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T21:52:58.987Z,1748382778.987 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T21:52:58.987Z,1748382778.987 [NAL9602] Data Fault, FailCount= 1
2025-05-27T21:52:58.987Z,1748382778.987 [NAL9602](ERROR): Data Fault
2025-05-27T21:52:59.004Z,1748382779.004 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T21:52:59.389Z,1748382779.389 [NAL9602](INFO): Powering down
2025-05-27T21:53:00.211Z,1748382780.211 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T21:53:00.211Z,1748382780.211 [NAL9602] No Fault, FailCount= 1
2025-05-27T21:53:19.000Z,1748382800.000 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.99,+9999.99
2025-05-27T21:53:29.687Z,1748382809.687 [NAL9602](INFO): Powering up NAL9602
2025-05-27T21:53:33.330Z,1748382813.330 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2025-05-27T21:53:33.330Z,1748382813.330 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:53:33.341Z,1748382813.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:53:33.753Z,1748382813.753 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:53:33.753Z,1748382813.753 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2025-05-27T21:53:40.595Z,1748382820.595 [NAL9602](INFO): NAL9602 initialized
2025-05-27T21:55:51.518Z,1748382951.518 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T21:55:51.518Z,1748382951.518 [Default:CheckIn:C.Wait] Stopped
2025-05-27T21:55:51.518Z,1748382951.518 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T21:55:51.518Z,1748382951.518 [Default:CheckIn:D] Running Loop=1
2025-05-27T21:55:51.931Z,1748382951.931 [Default:CheckIn:D] Stopped
2025-05-27T21:55:51.931Z,1748382951.931 [Default:CheckIn:E] Running Loop=1
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.094702 min
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn:E] Stopped
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn] Stopped
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn](INFO): Running loop #7
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn] Running Loop=7
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T21:55:52.310Z,1748382952.310 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T21:56:34.409Z,1748382994.409 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2025-05-27T21:56:34.409Z,1748382994.409 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:56:34.442Z,1748382994.442 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:56:34.847Z,1748382994.847 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:56:34.847Z,1748382994.847 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2025-05-27T21:59:35.317Z,1748383175.317 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2025-05-27T21:59:35.317Z,1748383175.317 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T21:59:35.328Z,1748383175.328 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T21:59:35.727Z,1748383175.727 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T21:59:35.727Z,1748383175.727 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2025-05-27T22:00:52.490Z,1748383252.490 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T21:55:52.3Z
2025-05-27T22:00:52.490Z,1748383252.490 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:00:52.490Z,1748383252.490 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:00:59.812Z,1748383259.812 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0022.lzma
2025-05-27T22:01:00.815Z,1748383260.815 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0022.lzma.bak
2025-05-27T22:01:00.816Z,1748383260.816 [DataOverHttps](INFO): SBD MOMSN=25010620
2025-05-27T22:01:17.004Z,1748383277.004 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250527T204659/Express0023.lzma
2025-05-27T22:01:18.006Z,1748383278.006 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0023.lzma.bak
2025-05-27T22:01:18.007Z,1748383278.007 [DataOverHttps](INFO): SBD MOMSN=25010669
2025-05-27T22:01:19.170Z,1748383279.170 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:01:19.170Z,1748383279.170 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:01:19.170Z,1748383279.170 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:02:27.415Z,1748383347.415 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-05-27T22:02:27.416Z,1748383347.416 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6.
2025-05-27T22:02:27.419Z,1748383347.419 [BPC1](INFO): Received data from all battery sticks.
2025-05-27T22:02:36.331Z,1748383356.331 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25
2025-05-27T22:02:36.331Z,1748383356.331 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:02:36.358Z,1748383356.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:02:36.722Z,1748383356.722 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:02:36.722Z,1748383356.722 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25
2025-05-27T22:03:42.160Z,1748383422.160 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:03:42.160Z,1748383422.160 [NAL9602] Data Fault, FailCount= 2
2025-05-27T22:03:42.160Z,1748383422.160 [NAL9602](ERROR): Data Fault
2025-05-27T22:03:42.177Z,1748383422.177 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:03:42.585Z,1748383422.585 [NAL9602](INFO): Powering down
2025-05-27T22:03:43.377Z,1748383423.377 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:03:43.377Z,1748383423.377 [NAL9602] No Fault, FailCount= 2
2025-05-27T22:04:12.855Z,1748383452.855 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:04:23.768Z,1748383463.768 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:05:37.298Z,1748383537.298 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26
2025-05-27T22:05:37.298Z,1748383537.298 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:05:37.309Z,1748383537.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:05:37.711Z,1748383537.711 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:05:37.711Z,1748383537.711 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26
2025-05-27T22:06:19.742Z,1748383579.742 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:06:19.742Z,1748383579.742 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:06:19.742Z,1748383579.742 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:06:19.742Z,1748383579.742 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:06:20.136Z,1748383580.136 [Default:CheckIn:D] Stopped
2025-05-27T22:06:20.136Z,1748383580.136 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:06:20.527Z,1748383580.527 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.564795 min
2025-05-27T22:06:20.527Z,1748383580.527 [Default:CheckIn:E] Stopped
2025-05-27T22:06:20.527Z,1748383580.527 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:06:20.527Z,1748383580.527 [Default:CheckIn] Stopped
2025-05-27T22:06:20.527Z,1748383580.527 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:06:20.528Z,1748383580.528 [Default:CheckIn](INFO): Running loop #8
2025-05-27T22:06:20.528Z,1748383580.528 [Default:CheckIn] Running Loop=8
2025-05-27T22:06:20.528Z,1748383580.528 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:06:20.528Z,1748383580.528 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:08:38.291Z,1748383718.291 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27
2025-05-27T22:08:38.291Z,1748383718.291 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:08:38.330Z,1748383718.330 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:08:38.706Z,1748383718.706 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:08:38.706Z,1748383718.706 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27
2025-05-27T22:11:20.727Z,1748383880.727 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:06:20.5Z
2025-05-27T22:11:20.727Z,1748383880.727 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:11:20.727Z,1748383880.727 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:11:28.344Z,1748383888.344 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20250527T204659/Courier0025.lzma
2025-05-27T22:11:29.347Z,1748383889.347 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0025.lzma.bak
2025-05-27T22:11:29.347Z,1748383889.347 [DataOverHttps](INFO): SBD MOMSN=25010828
2025-05-27T22:11:39.302Z,1748383899.302 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28
2025-05-27T22:11:39.302Z,1748383899.302 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:11:39.312Z,1748383899.312 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:11:39.726Z,1748383899.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:11:39.726Z,1748383899.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28
2025-05-27T22:11:45.668Z,1748383905.668 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250527T204659/Express0026.lzma
2025-05-27T22:11:46.671Z,1748383906.671 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0026.lzma.bak
2025-05-27T22:11:46.671Z,1748383906.671 [DataOverHttps](INFO): SBD MOMSN=25010875
2025-05-27T22:11:47.846Z,1748383907.846 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:11:47.846Z,1748383907.846 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:11:47.846Z,1748383907.846 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:14:26.147Z,1748384066.147 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:14:26.147Z,1748384066.147 [NAL9602] Data Fault, FailCount= 3
2025-05-27T22:14:26.147Z,1748384066.147 [NAL9602](ERROR): Data Fault
2025-05-27T22:14:26.165Z,1748384066.165 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:14:26.574Z,1748384066.574 [NAL9602](INFO): Powering down
2025-05-27T22:14:27.376Z,1748384067.376 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:14:27.393Z,1748384067.393 [NAL9602] No Fault, FailCount= 3
2025-05-27T22:14:40.290Z,1748384080.290 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29
2025-05-27T22:14:40.290Z,1748384080.290 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:14:40.300Z,1748384080.300 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:14:40.704Z,1748384080.704 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:14:40.704Z,1748384080.704 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29
2025-05-27T22:14:56.852Z,1748384096.852 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:15:07.759Z,1748384107.759 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:16:48.387Z,1748384208.387 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:16:48.387Z,1748384208.387 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:16:48.387Z,1748384208.387 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:16:48.387Z,1748384208.387 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:16:48.787Z,1748384208.787 [Default:CheckIn:D] Stopped
2025-05-27T22:16:48.787Z,1748384208.787 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:16:49.172Z,1748384209.172 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.042301 min
2025-05-27T22:16:49.172Z,1748384209.172 [Default:CheckIn:E] Stopped
2025-05-27T22:16:49.172Z,1748384209.172 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:16:49.172Z,1748384209.172 [Default:CheckIn] Stopped
2025-05-27T22:16:49.173Z,1748384209.173 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:16:49.173Z,1748384209.173 [Default:CheckIn](INFO): Running loop #9
2025-05-27T22:16:49.173Z,1748384209.173 [Default:CheckIn] Running Loop=9
2025-05-27T22:16:49.173Z,1748384209.173 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:16:49.173Z,1748384209.173 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:17:16.639Z,1748384236.639 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T22:17:16.639Z,1748384236.639 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T22:17:16.639Z,1748384236.639 [DropWeight](ERROR): Hardware Fault
2025-05-27T22:17:16.727Z,1748384236.727 [CBIT](INFO): Critical error at 20250527T221716
2025-05-27T22:17:16.733Z,1748384236.733 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T22:17:16.734Z,1748384236.734 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T22:17:17.082Z,1748384237.082 [CBIT](INFO): Critical error at 20250527T221716
2025-05-27T22:17:41.282Z,1748384261.282 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30
2025-05-27T22:17:41.282Z,1748384261.282 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:17:41.305Z,1748384261.305 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:17:41.733Z,1748384261.733 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:17:41.733Z,1748384261.733 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30
2025-05-27T22:20:42.278Z,1748384442.278 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31
2025-05-27T22:20:42.278Z,1748384442.278 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:20:42.289Z,1748384442.289 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:20:42.701Z,1748384442.701 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:20:42.701Z,1748384442.701 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31
2025-05-27T22:21:49.362Z,1748384509.362 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:16:49.2Z
2025-05-27T22:21:49.362Z,1748384509.362 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:21:49.362Z,1748384509.362 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:21:55.342Z,1748384515.342 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20250527T204659/Courier0028.lzma
2025-05-27T22:21:56.338Z,1748384516.338 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0028.lzma.bak
2025-05-27T22:21:56.339Z,1748384516.339 [DataOverHttps](INFO): SBD MOMSN=25010906
2025-05-27T22:22:12.264Z,1748384532.264 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250527T204659/Express0029.lzma
2025-05-27T22:22:13.267Z,1748384533.267 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0029.lzma.bak
2025-05-27T22:22:13.267Z,1748384533.267 [DataOverHttps](INFO): SBD MOMSN=25010930
2025-05-27T22:22:14.427Z,1748384534.427 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:22:14.428Z,1748384534.428 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:22:14.428Z,1748384534.428 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:23:43.318Z,1748384623.318 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32
2025-05-27T22:23:43.318Z,1748384623.318 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:23:43.341Z,1748384623.341 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:23:43.704Z,1748384623.704 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:23:43.704Z,1748384623.704 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32
2025-05-27T22:25:10.135Z,1748384710.135 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:25:10.135Z,1748384710.135 [NAL9602] Data Fault, FailCount= 4
2025-05-27T22:25:10.135Z,1748384710.135 [NAL9602](ERROR): Data Fault
2025-05-27T22:25:10.154Z,1748384710.154 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:25:10.549Z,1748384710.549 [NAL9602](INFO): Powering down
2025-05-27T22:25:11.389Z,1748384711.389 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:25:11.389Z,1748384711.389 [NAL9602] No Fault, FailCount= 4
2025-05-27T22:25:40.845Z,1748384740.845 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:25:51.754Z,1748384751.754 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:26:44.289Z,1748384804.289 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33
2025-05-27T22:26:44.289Z,1748384804.289 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:26:44.300Z,1748384804.300 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:26:44.711Z,1748384804.711 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:26:44.711Z,1748384804.711 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33
2025-05-27T22:27:15.002Z,1748384835.002 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:27:15.002Z,1748384835.002 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:27:15.002Z,1748384835.002 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:27:15.002Z,1748384835.002 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:27:15.422Z,1748384835.422 [Default:CheckIn:D] Stopped
2025-05-27T22:27:15.422Z,1748384835.422 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.486222 min
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn:E] Stopped
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn] Stopped
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn](INFO): Running loop #10
2025-05-27T22:27:15.818Z,1748384835.818 [Default:CheckIn] Running Loop=10
2025-05-27T22:27:15.819Z,1748384835.819 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:27:15.819Z,1748384835.819 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:29:45.271Z,1748384985.271 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34
2025-05-27T22:29:45.271Z,1748384985.271 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:29:45.282Z,1748384985.282 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:29:45.691Z,1748384985.691 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:29:45.692Z,1748384985.692 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34
2025-05-27T22:32:16.009Z,1748385136.009 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:27:15.8Z
2025-05-27T22:32:16.009Z,1748385136.009 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:32:16.009Z,1748385136.009 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:32:16.815Z,1748385136.815 [CBIT](INFO): Clearing failed state for component DropWeight
2025-05-27T22:32:16.815Z,1748385136.815 [DropWeight] No Fault, FailCount= 1
2025-05-27T22:32:23.676Z,1748385143.676 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0031.lzma
2025-05-27T22:32:24.678Z,1748385144.678 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0031.lzma.bak
2025-05-27T22:32:24.679Z,1748385144.679 [DataOverHttps](INFO): SBD MOMSN=25011001
2025-05-27T22:32:40.584Z,1748385160.584 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250527T204659/Express0032.lzma
2025-05-27T22:32:41.587Z,1748385161.587 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0032.lzma.bak
2025-05-27T22:32:41.587Z,1748385161.587 [DataOverHttps](INFO): SBD MOMSN=25011010
2025-05-27T22:32:43.062Z,1748385163.062 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:32:43.062Z,1748385163.062 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:32:43.062Z,1748385163.062 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:32:46.297Z,1748385166.297 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35
2025-05-27T22:32:46.297Z,1748385166.297 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:32:46.316Z,1748385166.316 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:32:46.738Z,1748385166.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:32:46.738Z,1748385166.738 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35
2025-05-27T22:35:47.288Z,1748385347.288 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36
2025-05-27T22:35:47.288Z,1748385347.288 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:35:47.299Z,1748385347.299 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:35:47.717Z,1748385347.717 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:35:47.717Z,1748385347.717 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36
2025-05-27T22:35:54.132Z,1748385354.132 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:35:54.132Z,1748385354.132 [NAL9602] Data Fault, FailCount= 5
2025-05-27T22:35:54.132Z,1748385354.132 [NAL9602](ERROR): Data Fault
2025-05-27T22:35:54.177Z,1748385354.177 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:35:54.178Z,1748385354.178 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-05-27T22:35:54.539Z,1748385354.539 [NAL9602](INFO): Powering down
2025-05-27T22:35:54.555Z,1748385354.555 [CBIT](INFO): Critical error at 20250527T223554
2025-05-27T22:37:43.639Z,1748385463.639 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:37:43.640Z,1748385463.640 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:37:43.640Z,1748385463.640 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:37:43.640Z,1748385463.640 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:37:44.030Z,1748385464.030 [Default:CheckIn:D] Stopped
2025-05-27T22:37:44.030Z,1748385464.030 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:37:44.430Z,1748385464.430 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.963029 min
2025-05-27T22:37:44.430Z,1748385464.430 [Default:CheckIn:E] Stopped
2025-05-27T22:37:44.430Z,1748385464.430 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:37:44.430Z,1748385464.430 [Default:CheckIn] Stopped
2025-05-27T22:37:44.430Z,1748385464.430 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:37:44.431Z,1748385464.431 [Default:CheckIn](INFO): Running loop #11
2025-05-27T22:37:44.431Z,1748385464.431 [Default:CheckIn] Running Loop=11
2025-05-27T22:37:44.431Z,1748385464.431 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:37:44.431Z,1748385464.431 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:37:54.152Z,1748385474.152 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:37:54.152Z,1748385474.152 [NAL9602] No Fault, FailCount= 5
2025-05-27T22:37:54.541Z,1748385474.541 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:38:05.431Z,1748385485.431 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:38:48.262Z,1748385528.262 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37
2025-05-27T22:38:48.262Z,1748385528.262 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:38:48.273Z,1748385528.273 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:38:48.694Z,1748385528.694 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:38:48.694Z,1748385528.694 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37
2025-05-27T22:39:00.783Z,1748385540.783 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.99,+9999.99
2025-05-27T22:41:08.046Z,1748385668.046 [DVL_micro](ERROR): Failed to parse:
:RD,+9999.99,+9999.99,+9999.99,+9999.99
2025-05-27T22:41:49.253Z,1748385709.253 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38
2025-05-27T22:41:49.253Z,1748385709.253 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:41:49.263Z,1748385709.263 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:41:49.677Z,1748385709.677 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:41:49.677Z,1748385709.677 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38
2025-05-27T22:42:44.603Z,1748385764.603 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:37:44.4Z
2025-05-27T22:42:44.603Z,1748385764.603 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:42:44.603Z,1748385764.603 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:42:51.708Z,1748385771.708 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20250527T204659/Courier0034.lzma
2025-05-27T22:42:52.710Z,1748385772.710 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0034.lzma.bak
2025-05-27T22:42:52.711Z,1748385772.711 [DataOverHttps](INFO): SBD MOMSN=25011077
2025-05-27T22:43:08.561Z,1748385788.561 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250527T204659/Express0035.lzma
2025-05-27T22:43:09.562Z,1748385789.562 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0035.lzma.bak
2025-05-27T22:43:09.563Z,1748385789.563 [DataOverHttps](INFO): SBD MOMSN=25011085
2025-05-27T22:43:10.874Z,1748385790.874 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:43:10.874Z,1748385790.874 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:43:10.874Z,1748385790.874 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:44:50.273Z,1748385890.273 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 39
2025-05-27T22:44:50.273Z,1748385890.273 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:44:50.284Z,1748385890.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:44:50.695Z,1748385890.695 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:44:50.695Z,1748385890.695 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 39
2025-05-27T22:47:51.274Z,1748386071.274 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 40
2025-05-27T22:47:51.274Z,1748386071.274 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:47:51.285Z,1748386071.285 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:47:51.681Z,1748386071.681 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:47:51.681Z,1748386071.681 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 40
2025-05-27T22:48:09.007Z,1748386089.007 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:48:09.007Z,1748386089.007 [NAL9602] Data Fault, FailCount= 1
2025-05-27T22:48:09.007Z,1748386089.007 [NAL9602](ERROR): Data Fault
2025-05-27T22:48:09.046Z,1748386089.046 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:48:09.424Z,1748386089.424 [NAL9602](INFO): Powering down
2025-05-27T22:48:10.247Z,1748386090.247 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:48:10.247Z,1748386090.247 [NAL9602] No Fault, FailCount= 1
2025-05-27T22:48:11.441Z,1748386091.441 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:48:11.442Z,1748386091.442 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:48:11.442Z,1748386091.442 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:48:11.442Z,1748386091.442 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:48:11.856Z,1748386091.856 [Default:CheckIn:D] Stopped
2025-05-27T22:48:11.856Z,1748386091.856 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:48:12.282Z,1748386092.282 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.426790 min
2025-05-27T22:48:12.282Z,1748386092.282 [Default:CheckIn:E] Stopped
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn] Stopped
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn](INFO): Running loop #12
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn] Running Loop=12
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:48:12.283Z,1748386092.283 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:48:39.720Z,1748386119.720 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:48:50.624Z,1748386130.624 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:50:52.253Z,1748386252.253 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41
2025-05-27T22:50:52.253Z,1748386252.253 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:50:52.272Z,1748386252.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:50:52.679Z,1748386252.679 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:50:52.679Z,1748386252.679 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41
2025-05-27T22:53:12.442Z,1748386392.442 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:48:12.3Z
2025-05-27T22:53:12.442Z,1748386392.442 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T22:53:12.442Z,1748386392.442 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T22:53:19.428Z,1748386399.428 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0037.lzma
2025-05-27T22:53:20.430Z,1748386400.430 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0037.lzma.bak
2025-05-27T22:53:20.431Z,1748386400.431 [DataOverHttps](INFO): SBD MOMSN=25011160
2025-05-27T22:53:36.237Z,1748386416.237 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250527T204659/Express0038.lzma
2025-05-27T22:53:37.239Z,1748386417.239 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0038.lzma.bak
2025-05-27T22:53:37.239Z,1748386417.239 [DataOverHttps](INFO): SBD MOMSN=25011169
2025-05-27T22:53:38.696Z,1748386418.696 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T22:53:38.696Z,1748386418.696 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T22:53:38.696Z,1748386418.696 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T22:53:53.223Z,1748386433.223 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 42
2025-05-27T22:53:53.224Z,1748386433.224 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:53:53.234Z,1748386433.234 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:53:53.645Z,1748386433.645 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:53:53.645Z,1748386433.645 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 42
2025-05-27T22:56:54.211Z,1748386614.211 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 43
2025-05-27T22:56:54.211Z,1748386614.211 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:56:54.221Z,1748386614.221 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:56:54.646Z,1748386614.646 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:56:54.646Z,1748386614.646 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 43
2025-05-27T22:58:39.274Z,1748386719.274 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T22:58:39.274Z,1748386719.274 [Default:CheckIn:C.Wait] Stopped
2025-05-27T22:58:39.274Z,1748386719.274 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T22:58:39.274Z,1748386719.274 [Default:CheckIn:D] Running Loop=1
2025-05-27T22:58:39.686Z,1748386719.686 [Default:CheckIn:D] Stopped
2025-05-27T22:58:39.686Z,1748386719.686 [Default:CheckIn:E] Running Loop=1
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 125.890625 min
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn:E] Stopped
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn] Stopped
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn](INFO): Running loop #13
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn] Running Loop=13
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T22:58:40.061Z,1748386720.061 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T22:58:52.184Z,1748386732.184 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T22:58:52.184Z,1748386732.184 [NAL9602] Data Fault, FailCount= 2
2025-05-27T22:58:52.184Z,1748386732.184 [NAL9602](ERROR): Data Fault
2025-05-27T22:58:52.201Z,1748386732.201 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T22:58:52.586Z,1748386732.586 [NAL9602](INFO): Powering down
2025-05-27T22:58:53.406Z,1748386733.406 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T22:58:53.406Z,1748386733.406 [NAL9602] No Fault, FailCount= 2
2025-05-27T22:59:22.879Z,1748386762.879 [NAL9602](INFO): Powering up NAL9602
2025-05-27T22:59:33.811Z,1748386773.811 [NAL9602](INFO): NAL9602 initialized
2025-05-27T22:59:55.232Z,1748386795.232 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 44
2025-05-27T22:59:55.233Z,1748386795.233 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T22:59:55.255Z,1748386795.255 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T22:59:55.616Z,1748386795.616 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T22:59:55.616Z,1748386795.616 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 44
2025-05-27T23:02:18.215Z,1748386938.215 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2025-05-27T23:02:18.215Z,1748386938.215 [DropWeight] Hardware Fault, FailCount= 1
2025-05-27T23:02:18.215Z,1748386938.215 [DropWeight](ERROR): Hardware Fault
2025-05-27T23:02:18.240Z,1748386938.240 [CBIT](INFO): Critical error at 20250527T230218
2025-05-27T23:02:18.263Z,1748386938.263 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-05-27T23:02:18.264Z,1748386938.264 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-05-27T23:02:18.650Z,1748386938.650 [CBIT](INFO): Critical error at 20250527T230218
2025-05-27T23:02:56.202Z,1748386976.202 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 45
2025-05-27T23:02:56.202Z,1748386976.202 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:02:56.217Z,1748386976.217 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:02:56.638Z,1748386976.638 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:02:56.638Z,1748386976.638 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 45
2025-05-27T23:03:40.240Z,1748387020.240 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T22:58:40.1Z
2025-05-27T23:03:40.240Z,1748387020.240 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:03:40.240Z,1748387020.240 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T23:03:47.672Z,1748387027.672 [DataOverHttps](INFO): Sending 116 bytes from file Logs/20250527T204659/Courier0040.lzma
2025-05-27T23:03:48.675Z,1748387028.675 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0040.lzma.bak
2025-05-27T23:03:48.675Z,1748387028.675 [DataOverHttps](INFO): SBD MOMSN=25011245
2025-05-27T23:04:05.732Z,1748387045.732 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250527T204659/Express0041.lzma
2025-05-27T23:04:06.731Z,1748387046.731 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0041.lzma.bak
2025-05-27T23:04:06.731Z,1748387046.731 [DataOverHttps](INFO): SBD MOMSN=25011255
2025-05-27T23:04:08.135Z,1748387048.135 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T23:04:08.135Z,1748387048.135 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T23:04:08.135Z,1748387048.135 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T23:05:57.193Z,1748387157.193 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 46
2025-05-27T23:05:57.193Z,1748387157.193 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:05:57.203Z,1748387157.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:05:57.608Z,1748387157.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:05:57.608Z,1748387157.608 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 46
2025-05-27T23:08:58.180Z,1748387338.180 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 47
2025-05-27T23:08:58.180Z,1748387338.180 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:08:58.190Z,1748387338.190 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:08:58.819Z,1748387338.819 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:08:58.819Z,1748387338.819 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 47
2025-05-27T23:09:08.696Z,1748387348.696 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:09:08.696Z,1748387348.696 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:09:08.696Z,1748387348.696 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:09:08.696Z,1748387348.696 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:09:09.094Z,1748387349.094 [Default:CheckIn:D] Stopped
2025-05-27T23:09:09.094Z,1748387349.094 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:09:09.507Z,1748387349.507 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 136.380754 min
2025-05-27T23:09:09.507Z,1748387349.507 [Default:CheckIn:E] Stopped
2025-05-27T23:09:09.507Z,1748387349.507 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:09:09.508Z,1748387349.508 [Default:CheckIn] Stopped
2025-05-27T23:09:09.508Z,1748387349.508 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:09:09.508Z,1748387349.508 [Default:CheckIn](INFO): Running loop #14
2025-05-27T23:09:09.508Z,1748387349.508 [Default:CheckIn] Running Loop=14
2025-05-27T23:09:09.508Z,1748387349.508 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:09:09.508Z,1748387349.508 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:09:36.570Z,1748387376.570 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T23:09:36.571Z,1748387376.571 [NAL9602] Data Fault, FailCount= 3
2025-05-27T23:09:36.571Z,1748387376.571 [NAL9602](ERROR): Data Fault
2025-05-27T23:09:36.612Z,1748387376.612 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T23:09:36.971Z,1748387376.971 [NAL9602](INFO): Powering down
2025-05-27T23:09:37.804Z,1748387377.804 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T23:09:37.804Z,1748387377.804 [NAL9602] No Fault, FailCount= 3
2025-05-27T23:10:05.260Z,1748387405.260 [BPC1](FAULT): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-05-27T23:10:05.261Z,1748387405.261 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6.
2025-05-27T23:10:05.264Z,1748387405.264 [BPC1](INFO): Received data from all battery sticks.
2025-05-27T23:10:07.271Z,1748387407.271 [NAL9602](INFO): Powering up NAL9602
2025-05-27T23:10:18.182Z,1748387418.182 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:11:59.195Z,1748387519.195 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 48
2025-05-27T23:11:59.195Z,1748387519.195 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:11:59.241Z,1748387519.241 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:11:59.599Z,1748387519.599 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:11:59.599Z,1748387519.599 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 48
2025-05-27T23:14:09.698Z,1748387649.698 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T23:09:09.5Z
2025-05-27T23:14:09.698Z,1748387649.698 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:14:09.698Z,1748387649.698 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T23:14:17.368Z,1748387657.368 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20250527T204659/Courier0043.lzma
2025-05-27T23:14:18.371Z,1748387658.371 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0043.lzma.bak
2025-05-27T23:14:18.372Z,1748387658.372 [DataOverHttps](INFO): SBD MOMSN=25011337
2025-05-27T23:14:36.585Z,1748387676.585 [DataOverHttps](INFO): Sending 257 bytes from file Logs/20250527T204659/Express0044.lzma
2025-05-27T23:14:37.587Z,1748387677.587 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0044.lzma.bak
2025-05-27T23:14:37.587Z,1748387677.587 [DataOverHttps](INFO): SBD MOMSN=25011345
2025-05-27T23:14:38.826Z,1748387678.826 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T23:14:38.826Z,1748387678.826 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T23:14:38.826Z,1748387678.826 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T23:15:00.237Z,1748387700.237 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 49
2025-05-27T23:15:00.238Z,1748387700.238 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:15:00.248Z,1748387700.248 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:15:00.654Z,1748387700.654 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:15:00.655Z,1748387700.655 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 49
2025-05-27T23:17:18.403Z,1748387838.403 [CBIT](INFO): Clearing failed state for component DropWeight
2025-05-27T23:17:18.403Z,1748387838.403 [DropWeight] No Fault, FailCount= 1
2025-05-27T23:18:01.219Z,1748387881.219 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 50
2025-05-27T23:18:01.219Z,1748387881.219 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:18:01.230Z,1748387881.230 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:18:01.639Z,1748387881.639 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:18:01.639Z,1748387881.639 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 50
2025-05-27T23:19:39.418Z,1748387979.418 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:19:39.418Z,1748387979.418 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:19:39.418Z,1748387979.418 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:19:39.418Z,1748387979.418 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:19:39.832Z,1748387979.832 [Default:CheckIn:D] Stopped
2025-05-27T23:19:39.832Z,1748387979.832 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 146.893050 min
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn:E] Stopped
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn] Stopped
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn](INFO): Running loop #15
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn] Running Loop=15
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:19:40.202Z,1748387980.202 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:20:21.413Z,1748388021.413 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T23:20:21.413Z,1748388021.413 [NAL9602] Data Fault, FailCount= 4
2025-05-27T23:20:21.413Z,1748388021.413 [NAL9602](ERROR): Data Fault
2025-05-27T23:20:21.430Z,1748388021.430 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T23:20:21.814Z,1748388021.814 [NAL9602](INFO): Powering down
2025-05-27T23:20:22.635Z,1748388022.635 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T23:20:22.635Z,1748388022.635 [NAL9602] No Fault, FailCount= 4
2025-05-27T23:20:52.108Z,1748388052.108 [NAL9602](INFO): Powering up NAL9602
2025-05-27T23:21:02.213Z,1748388062.213 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 51
2025-05-27T23:21:02.213Z,1748388062.213 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:21:02.224Z,1748388062.224 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:21:02.677Z,1748388062.677 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:21:02.681Z,1748388062.681 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 51
2025-05-27T23:21:03.031Z,1748388063.031 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:24:03.257Z,1748388243.257 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 52
2025-05-27T23:24:03.257Z,1748388243.257 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:24:03.267Z,1748388243.267 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:24:03.620Z,1748388243.620 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:24:03.621Z,1748388243.621 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 52
2025-05-27T23:24:40.458Z,1748388280.458 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T23:19:40.2Z
2025-05-27T23:24:40.459Z,1748388280.459 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:24:40.459Z,1748388280.459 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T23:24:48.168Z,1748388288.168 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250527T204659/Courier0046.lzma
2025-05-27T23:24:49.171Z,1748388289.171 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0046.lzma.bak
2025-05-27T23:24:49.171Z,1748388289.171 [DataOverHttps](INFO): SBD MOMSN=25011419
2025-05-27T23:25:04.933Z,1748388304.933 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250527T204659/Express0047.lzma
2025-05-27T23:25:05.935Z,1748388305.935 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0047.lzma.bak
2025-05-27T23:25:05.935Z,1748388305.935 [DataOverHttps](INFO): SBD MOMSN=25011422
2025-05-27T23:25:07.448Z,1748388307.448 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T23:25:07.448Z,1748388307.448 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T23:25:07.448Z,1748388307.448 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T23:27:04.209Z,1748388424.209 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 53
2025-05-27T23:27:04.209Z,1748388424.209 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:27:04.220Z,1748388424.220 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:27:04.634Z,1748388424.634 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:27:04.634Z,1748388424.634 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 53
2025-05-27T23:30:05.192Z,1748388605.192 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 54
2025-05-27T23:30:05.192Z,1748388605.192 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:30:05.202Z,1748388605.202 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:30:05.626Z,1748388605.626 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:30:05.626Z,1748388605.626 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 54
2025-05-27T23:30:08.023Z,1748388608.023 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:30:08.023Z,1748388608.023 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:30:08.023Z,1748388608.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:30:08.023Z,1748388608.023 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:30:08.450Z,1748388608.450 [Default:CheckIn:D] Stopped
2025-05-27T23:30:08.450Z,1748388608.450 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:30:08.854Z,1748388608.854 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 157.370020 min
2025-05-27T23:30:08.854Z,1748388608.854 [Default:CheckIn:E] Stopped
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn] Stopped
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn](INFO): Running loop #16
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn] Running Loop=16
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:30:08.855Z,1748388608.855 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:31:04.216Z,1748388664.216 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T23:31:04.216Z,1748388664.216 [NAL9602] Data Fault, FailCount= 5
2025-05-27T23:31:04.216Z,1748388664.216 [NAL9602](ERROR): Data Fault
2025-05-27T23:31:04.260Z,1748388664.260 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T23:31:04.261Z,1748388664.261 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-05-27T23:31:04.620Z,1748388664.620 [NAL9602](INFO): Powering down
2025-05-27T23:31:04.636Z,1748388664.636 [CBIT](INFO): Critical error at 20250527T233104
2025-05-27T23:33:04.235Z,1748388784.235 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T23:33:04.235Z,1748388784.235 [NAL9602] No Fault, FailCount= 5
2025-05-27T23:33:04.614Z,1748388784.614 [NAL9602](INFO): Powering up NAL9602
2025-05-27T23:33:06.229Z,1748388786.229 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 55
2025-05-27T23:33:06.230Z,1748388786.230 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:33:06.262Z,1748388786.262 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:33:06.671Z,1748388786.671 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:33:06.672Z,1748388786.672 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 55
2025-05-27T23:33:15.524Z,1748388795.524 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:35:09.086Z,1748388909.086 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-27T23:30:08.9Z
2025-05-27T23:35:09.086Z,1748388909.086 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:35:09.086Z,1748388909.086 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-05-27T23:35:16.664Z,1748388916.664 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20250527T204659/Courier0049.lzma
2025-05-27T23:35:17.667Z,1748388917.667 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Courier0049.lzma.bak
2025-05-27T23:35:17.667Z,1748388917.667 [DataOverHttps](INFO): SBD MOMSN=25011552
2025-05-27T23:35:32.434Z,1748388932.434 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250527T204659/Express0050.lzma
2025-05-27T23:35:33.435Z,1748388933.435 [DataOverHttps](INFO): Moved sent file to Logs/20250527T204659/Express0050.lzma.bak
2025-05-27T23:35:33.435Z,1748388933.435 [DataOverHttps](INFO): SBD MOMSN=25011556
2025-05-27T23:35:34.562Z,1748388934.562 [Default:CheckIn:Read_Iridium] Stopped
2025-05-27T23:35:34.562Z,1748388934.562 [Default:CheckIn:C.Wait] Running Loop=1
2025-05-27T23:35:34.562Z,1748388934.562 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-05-27T23:36:07.322Z,1748388967.322 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 56
2025-05-27T23:36:07.322Z,1748388967.322 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:36:07.345Z,1748388967.345 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:36:07.735Z,1748388967.735 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:36:07.735Z,1748388967.735 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 56
2025-05-27T23:39:08.293Z,1748389148.293 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 57
2025-05-27T23:39:08.293Z,1748389148.293 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:39:08.304Z,1748389148.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:39:08.710Z,1748389148.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:39:08.710Z,1748389148.710 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 57
2025-05-27T23:40:35.192Z,1748389235.192 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-05-27T23:40:35.192Z,1748389235.192 [Default:CheckIn:C.Wait] Stopped
2025-05-27T23:40:35.192Z,1748389235.192 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-05-27T23:40:35.192Z,1748389235.192 [Default:CheckIn:D] Running Loop=1
2025-05-27T23:40:35.590Z,1748389235.590 [Default:CheckIn:D] Stopped
2025-05-27T23:40:35.590Z,1748389235.590 [Default:CheckIn:E] Running Loop=1
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 167.822363 min
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn:E] Stopped
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn] Stopped
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn](INFO): Running loop #17
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn] Running Loop=17
2025-05-27T23:40:35.989Z,1748389235.989 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-05-27T23:40:35.990Z,1748389235.990 [Default:CheckIn:Read_GPS] Running Loop=1
2025-05-27T23:42:09.329Z,1748389329.329 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 58
2025-05-27T23:42:09.330Z,1748389329.330 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:42:09.340Z,1748389329.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:42:09.726Z,1748389329.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:42:09.726Z,1748389329.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 58
2025-05-27T23:43:18.412Z,1748389398.412 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-05-27T23:43:18.413Z,1748389398.413 [NAL9602] Data Fault, FailCount= 1
2025-05-27T23:43:18.413Z,1748389398.413 [NAL9602](ERROR): Data Fault
2025-05-27T23:43:18.429Z,1748389398.429 [CBIT](ERROR): Data Fault in component: NAL9602
2025-05-27T23:43:18.816Z,1748389398.816 [NAL9602](INFO): Powering down
2025-05-27T23:43:19.666Z,1748389399.666 [CBIT](INFO): Clearing failed state for component NAL9602
2025-05-27T23:43:19.666Z,1748389399.666 [NAL9602] No Fault, FailCount= 1
2025-05-27T23:43:49.118Z,1748389429.118 [NAL9602](INFO): Powering up NAL9602
2025-05-27T23:44:00.023Z,1748389440.023 [NAL9602](INFO): NAL9602 initialized
2025-05-27T23:45:06.982Z,1748389506.982 [CommandExec](IMPORTANT): got command restart application
2025-05-27T23:45:07.985Z,1748389507.985 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:07.985Z,1748389507.985 [CommandExec](INFO): Uninitializing the command executive.
2025-05-27T23:45:07.985Z,1748389507.985 [CommandExec](INFO): Uninitializing the command scheduler.
2025-05-27T23:45:07.986Z,1748389507.986 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:08.097Z,1748389508.097 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-05-27T23:45:08.097Z,1748389508.097 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-05-27T23:45:08.097Z,1748389508.097 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:08.098Z,1748389508.098 [NavChartDb](INFO): Join timeout helper Thread ID is 3963
2025-05-27T23:45:08.449Z,1748389508.449 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:08.449Z,1748389508.449 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:08.453Z,1748389508.453 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-05-27T23:45:08.453Z,1748389508.453 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:08.453Z,1748389508.453 [Radio_Surface](INFO): Join timeout helper Thread ID is 3964
2025-05-27T23:45:08.813Z,1748389508.813 [Radio_Surface](INFO): Powering down
2025-05-27T23:45:08.814Z,1748389508.814 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:08.814Z,1748389508.814 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:08.833Z,1748389508.833 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-05-27T23:45:08.833Z,1748389508.833 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:08.833Z,1748389508.833 [Onboard](INFO): Join timeout helper Thread ID is 3965
2025-05-27T23:45:08.931Z,1748389508.931 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-05-27T23:45:10.357Z,1748389510.357 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 59
2025-05-27T23:45:10.357Z,1748389510.357 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-05-27T23:45:10.392Z,1748389510.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-05-27T23:45:10.763Z,1748389510.763 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-05-27T23:45:10.763Z,1748389510.763 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 59
2025-05-27T23:45:11.053Z,1748389511.053 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:11.053Z,1748389511.053 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:11.065Z,1748389511.065 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-05-27T23:45:11.065Z,1748389511.065 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:11.065Z,1748389511.065 [DataOverHttps](INFO): Join timeout helper Thread ID is 3966
2025-05-27T23:45:11.941Z,1748389511.941 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:11.941Z,1748389511.941 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:11.957Z,1748389511.957 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-05-27T23:45:11.957Z,1748389511.957 [DAT ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:11.957Z,1748389511.957 [DAT](INFO): Join timeout helper Thread ID is 3967
2025-05-27T23:45:11.961Z,1748389511.961 [DAT](INFO): Powering down
2025-05-27T23:45:12.029Z,1748389512.029 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:12.029Z,1748389512.029 [DAT](INFO): Powering down
2025-05-27T23:45:12.030Z,1748389512.030 [DAT ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.038Z,1748389512.038 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-05-27T23:45:12.038Z,1748389512.038 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.038Z,1748389512.038 [BackseatComponent](INFO): Join timeout helper Thread ID is 3968
2025-05-27T23:45:12.149Z,1748389512.149 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:12.149Z,1748389512.149 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.157Z,1748389512.157 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-05-27T23:45:12.157Z,1748389512.157 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.158Z,1748389512.158 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3969
2025-05-27T23:45:12.441Z,1748389512.441 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:12.441Z,1748389512.441 [WetLabsBB2FL](INFO): Powering down
2025-05-27T23:45:12.442Z,1748389512.442 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.449Z,1748389512.449 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-05-27T23:45:12.450Z,1748389512.450 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.450Z,1748389512.450 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3970
2025-05-27T23:45:12.685Z,1748389512.685 [CTD_Seabird](INFO): Powering down
2025-05-27T23:45:12.699Z,1748389512.699 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:12.700Z,1748389512.700 [CTD_Seabird](INFO): Powering down
2025-05-27T23:45:12.713Z,1748389512.713 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.729Z,1748389512.729 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-05-27T23:45:12.729Z,1748389512.729 [logger ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.730Z,1748389512.730 [logger](INFO): Join timeout helper Thread ID is 3971
2025-05-27T23:45:12.745Z,1748389512.745 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:12.745Z,1748389512.745 [logger ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.749Z,1748389512.749 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-05-27T23:45:12.750Z,1748389512.750 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.750Z,1748389512.750 [CommandLine](INFO): Join timeout helper Thread ID is 3972
2025-05-27T23:45:12.849Z,1748389512.849 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:12.849Z,1748389512.849 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.853Z,1748389512.853 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-05-27T23:45:12.853Z,1748389512.853 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.854Z,1748389512.854 [CommandExec](INFO): Join timeout helper Thread ID is 3973
2025-05-27T23:45:12.855Z,1748389512.855 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-05-27T23:45:12.855Z,1748389512.855 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:12.855Z,1748389512.855 [controlThread](INFO): Join timeout helper Thread ID is 3974
2025-05-27T23:45:13.141Z,1748389513.141 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-05-27T23:45:13.141Z,1748389513.141 [controlThread](DEBUG): Uninitializing ControlThread
2025-05-27T23:45:13.142Z,1748389513.142 [AHRS_M2](INFO): Powering down
2025-05-27T23:45:13.317Z,1748389513.317 [DVL_micro](INFO): Powering down
2025-05-27T23:45:13.318Z,1748389513.318 [NAL9602](INFO): Powering down
2025-05-27T23:45:13.319Z,1748389513.319 [Sonardyne_Nano](INFO): Powering down
2025-05-27T23:45:13.525Z,1748389513.525 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-05-27T23:45:13.526Z,1748389513.526 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-05-27T23:45:13.526Z,1748389513.526 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-05-27T23:45:13.527Z,1748389513.527 [MissionManager](INFO): Uninitializing Mission Default
2025-05-27T23:45:13.527Z,1748389513.527 [Default] Stopped
2025-05-27T23:45:13.527Z,1748389513.527 [Default](DEBUG): Aggregate::uninitialize Default
2025-05-27T23:45:13.527Z,1748389513.527 [Default:B.GoToSurface] Stopped
2025-05-27T23:45:13.527Z,1748389513.527 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-05-27T23:45:13.527Z,1748389513.527 [Default:CheckIn] Stopped
2025-05-27T23:45:13.527Z,1748389513.527 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-05-27T23:45:13.527Z,1748389513.527 [Default:CheckIn:Read_GPS] Stopped
2025-05-27T23:45:13.530Z,1748389513.530 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-05-27T23:45:13.530Z,1748389513.530 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-05-27T23:45:13.531Z,1748389513.531 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-05-27T23:45:13.531Z,1748389513.531 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-05-27T23:45:13.531Z,1748389513.531 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-05-27T23:45:13.531Z,1748389513.531 [BuoyancyServo](INFO): Powering down
2025-05-27T23:45:13.545Z,1748389513.545 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-05-27T23:45:13.545Z,1748389513.545 [ElevatorServo](INFO): Powering down
2025-05-27T23:45:13.546Z,1748389513.546 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-05-27T23:45:13.546Z,1748389513.546 [MassServo](INFO): Powering down
2025-05-27T23:45:13.547Z,1748389513.547 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-05-27T23:45:13.547Z,1748389513.547 [RudderServo](INFO): Powering down
2025-05-27T23:45:13.547Z,1748389513.547 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-05-27T23:45:13.548Z,1748389513.548 [ThrusterHE](INFO): Powering down
2025-05-27T23:45:13.548Z,1748389513.548 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-05-27T23:45:13.549Z,1748389513.549 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-05-27T23:45:13.549Z,1748389513.549 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-05-27T23:45:13.549Z,1748389513.549 [CBIT](DEBUG): Powering off loads.
2025-05-27T23:45:13.560Z,1748389513.560 [CBIT](DEBUG): Disabling WDT.
2025-05-27T23:45:13.573Z,1748389513.573 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-05-27T23:45:13.573Z,1748389513.573 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-05-27T23:45:13.574Z,1748389513.574 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.611Z,1748389513.611 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-05-27T23:45:13.611Z,1748389513.611 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-05-27T23:45:13.625Z,1748389513.625 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.632Z,1748389513.632 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.663Z,1748389513.663 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.666Z,1748389513.666 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.673Z,1748389513.673 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.679Z,1748389513.679 [DAT ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.722Z,1748389513.722 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.775Z,1748389513.775 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-05-27T23:45:13.839Z,1748389513.839 [logger ThreadHandler](INFO): Thread cancelled.