2025-05-12T17:30:09.040Z,1747071009.040 [Supervisor](DEBUG): Initializing supervisor. 2025-05-12T17:30:09.045Z,1747071009.045 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-05-12T17:30:09.045Z,1747071009.045 [SyncHandler](INFO): Protected caller Thread ID is 831 2025-05-12T17:30:09.046Z,1747071009.046 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-05-12T17:30:09.047Z,1747071009.047 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-05-12T17:30:09.047Z,1747071009.047 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 832 2025-05-12T17:30:09.051Z,1747071009.051 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-05-12T17:30:09.072Z,1747071009.072 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-05-12T17:30:09.073Z,1747071009.073 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-05-12T17:30:09.073Z,1747071009.073 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 833 2025-05-12T17:30:09.077Z,1747071009.077 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-05-12T17:30:09.078Z,1747071009.078 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-05-12T17:30:09.079Z,1747071009.079 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 834 2025-05-12T17:30:09.081Z,1747071009.081 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-05-12T17:30:09.082Z,1747071009.082 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-05-12T17:30:09.082Z,1747071009.082 [logger ThreadHandler](INFO): Protected caller Thread ID is 835 2025-05-12T17:30:09.086Z,1747071009.086 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-05-12T17:30:09.087Z,1747071009.087 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-05-12T17:30:09.092Z,1747071009.092 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-05-12T17:30:09.202Z,1747071009.202 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-05-12T17:30:09.204Z,1747071009.204 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-05-12T17:30:09.448Z,1747071009.448 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-05-12T17:30:09.449Z,1747071009.449 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-05-12T17:30:09.734Z,1747071009.734 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-05-12T17:30:09.735Z,1747071009.735 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-05-12T17:30:09.854Z,1747071009.854 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-05-12T17:30:09.856Z,1747071009.856 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-05-12T17:30:10.661Z,1747071010.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-05-12T17:30:10.661Z,1747071010.661 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-05-12T17:30:11.208Z,1747071011.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-05-12T17:30:11.209Z,1747071011.209 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-05-12T17:30:11.795Z,1747071011.795 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-05-12T17:30:11.796Z,1747071011.796 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-05-12T17:30:12.435Z,1747071012.435 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-05-12T17:30:12.451Z,1747071012.451 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-05-12T17:30:12.892Z,1747071012.892 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-05-12T17:30:12.894Z,1747071012.894 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-05-12T17:30:13.299Z,1747071013.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-05-12T17:30:13.300Z,1747071013.300 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-05-12T17:30:13.544Z,1747071013.544 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-05-12T17:30:13.546Z,1747071013.546 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-05-12T17:30:13.701Z,1747071013.701 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-05-12T17:30:13.702Z,1747071013.702 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-05-12T17:30:13.795Z,1747071013.795 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-05-12T17:30:13.887Z,1747071013.887 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-05-12T17:30:14.098Z,1747071014.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-05-12T17:30:14.099Z,1747071014.099 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-05-12T17:30:14.367Z,1747071014.367 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-05-12T17:30:14.369Z,1747071014.369 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-05-12T17:30:14.373Z,1747071014.373 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-05-12T17:30:14.469Z,1747071014.469 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-05-12T17:30:14.749Z,1747071014.749 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-05-12T17:30:14.749Z,1747071014.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-05-12T17:30:14.845Z,1747071014.845 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-05-12T17:30:15.031Z,1747071015.031 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-05-12T17:30:15.143Z,1747071015.143 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-05-12T17:30:15.267Z,1747071015.267 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-05-12T17:30:15.392Z,1747071015.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-05-12T17:30:15.498Z,1747071015.498 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-05-12T17:30:15.674Z,1747071015.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-05-12T17:30:15.783Z,1747071015.783 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-05-12T17:30:15.880Z,1747071015.880 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-05-12T17:30:15.989Z,1747071015.989 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-05-12T17:30:16.088Z,1747071016.088 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-05-12T17:30:16.102Z,1747071016.102 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-05-12T17:30:16.328Z,1747071016.328 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-05-12T17:30:16.328Z,1747071016.328 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-05-12T17:30:16.522Z,1747071016.522 [BuoyancyServo] Loaded 2025-05-12T17:30:16.523Z,1747071016.523 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-05-12T17:30:16.546Z,1747071016.546 [ElevatorServo] Loaded 2025-05-12T17:30:16.547Z,1747071016.547 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-05-12T17:30:16.569Z,1747071016.569 [MassServo] Loaded 2025-05-12T17:30:16.569Z,1747071016.569 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-05-12T17:30:16.592Z,1747071016.592 [RudderServo] Loaded 2025-05-12T17:30:16.592Z,1747071016.592 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-05-12T17:30:16.610Z,1747071016.610 [ThrusterHE] Loaded 2025-05-12T17:30:16.610Z,1747071016.610 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-05-12T17:30:16.611Z,1747071016.611 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-05-12T17:30:16.613Z,1747071016.613 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-05-12T17:30:16.814Z,1747071016.814 [SBIT](DEBUG): Construct Startup Built In Test. 2025-05-12T17:30:16.829Z,1747071016.829 [SBIT] Loaded 2025-05-12T17:30:16.830Z,1747071016.830 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-05-12T17:30:16.833Z,1747071016.833 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-05-12T17:30:16.854Z,1747071016.854 [IBIT] Loaded 2025-05-12T17:30:16.854Z,1747071016.854 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-05-12T17:30:16.859Z,1747071016.859 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-05-12T17:30:17.099Z,1747071017.099 [CBIT] Loaded 2025-05-12T17:30:17.100Z,1747071017.100 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-05-12T17:30:17.131Z,1747071017.131 [GFScanner] Loaded 2025-05-12T17:30:17.131Z,1747071017.131 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-05-12T17:30:17.131Z,1747071017.131 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-05-12T17:30:17.132Z,1747071017.132 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-05-12T17:30:17.348Z,1747071017.348 [CTD_Seabird] Loaded 2025-05-12T17:30:17.348Z,1747071017.348 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-05-12T17:30:17.349Z,1747071017.349 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406834E0 2025-05-12T17:30:17.350Z,1747071017.350 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 924 2025-05-12T17:30:17.385Z,1747071017.385 [ESPComponent] Loaded 2025-05-12T17:30:17.385Z,1747071017.385 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-05-12T17:30:17.407Z,1747071017.407 [PAR_Licor] Loaded 2025-05-12T17:30:17.407Z,1747071017.407 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-05-12T17:30:17.453Z,1747071017.453 [WetLabsBB2FL] Loaded 2025-05-12T17:30:17.453Z,1747071017.453 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-05-12T17:30:17.454Z,1747071017.454 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B34E0 2025-05-12T17:30:17.455Z,1747071017.455 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 925 2025-05-12T17:30:17.455Z,1747071017.455 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-05-12T17:30:17.456Z,1747071017.456 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-05-12T17:30:17.663Z,1747071017.663 [DepthRateCalculator] Loaded 2025-05-12T17:30:17.663Z,1747071017.663 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-05-12T17:30:17.705Z,1747071017.705 [PitchRateCalculator] Loaded 2025-05-12T17:30:17.706Z,1747071017.706 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-05-12T17:30:17.743Z,1747071017.743 [SpeedCalculator] Loaded 2025-05-12T17:30:17.744Z,1747071017.744 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-05-12T17:30:17.759Z,1747071017.759 [YawRateCalculator] Loaded 2025-05-12T17:30:17.759Z,1747071017.759 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-05-12T17:30:17.803Z,1747071017.803 [ElevatorOffsetCalculator] Loaded 2025-05-12T17:30:17.803Z,1747071017.803 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-05-12T17:30:17.803Z,1747071017.803 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-05-12T17:30:17.804Z,1747071017.804 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-05-12T17:30:18.444Z,1747071018.444 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-05-12T17:30:18.445Z,1747071018.445 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-05-12T17:30:18.493Z,1747071018.493 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-05-12T17:30:18.494Z,1747071018.494 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-05-12T17:30:18.634Z,1747071018.634 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-05-12T17:30:18.634Z,1747071018.634 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-05-12T17:30:18.648Z,1747071018.648 [NavChart] Loaded 2025-05-12T17:30:18.649Z,1747071018.649 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-05-12T17:30:18.654Z,1747071018.654 [UniversalFixResidualReporter] Loaded 2025-05-12T17:30:18.655Z,1747071018.655 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-05-12T17:30:18.655Z,1747071018.655 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-05-12T17:30:18.656Z,1747071018.656 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-05-12T17:30:19.541Z,1747071019.541 [AHRS_M2] Loaded 2025-05-12T17:30:19.541Z,1747071019.541 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-05-12T17:30:19.794Z,1747071019.794 [BackseatComponent] Loaded 2025-05-12T17:30:19.795Z,1747071019.795 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-05-12T17:30:19.796Z,1747071019.796 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A7F4E0 2025-05-12T17:30:19.796Z,1747071019.796 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 926 2025-05-12T17:30:19.799Z,1747071019.799 [LcmUniversalReporter] Loaded 2025-05-12T17:30:19.799Z,1747071019.799 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-05-12T17:30:20.535Z,1747071020.535 [BPC1] Loaded 2025-05-12T17:30:20.535Z,1747071020.535 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-05-12T17:30:20.635Z,1747071020.635 [DAT] Loaded 2025-05-12T17:30:20.635Z,1747071020.635 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-05-12T17:30:20.636Z,1747071020.636 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AAF4E0 2025-05-12T17:30:20.637Z,1747071020.637 [DAT ThreadHandler](INFO): Protected caller Thread ID is 927 2025-05-12T17:30:20.779Z,1747071020.779 [DataOverHttps] Loaded 2025-05-12T17:30:20.779Z,1747071020.779 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-05-12T17:30:20.780Z,1747071020.780 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40ADF4E0 2025-05-12T17:30:20.781Z,1747071020.781 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 928 2025-05-12T17:30:20.804Z,1747071020.804 [Depth_Keller] Loaded 2025-05-12T17:30:20.804Z,1747071020.804 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-05-12T17:30:20.809Z,1747071020.809 [DropWeight] Loaded 2025-05-12T17:30:20.810Z,1747071020.810 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-05-12T17:30:20.851Z,1747071020.851 [DVL_micro] Loaded 2025-05-12T17:30:20.851Z,1747071020.851 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-05-12T17:30:20.914Z,1747071020.914 [NAL9602] Loaded 2025-05-12T17:30:20.914Z,1747071020.914 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-05-12T17:30:20.941Z,1747071020.941 [Onboard] Loaded 2025-05-12T17:30:20.941Z,1747071020.941 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-05-12T17:30:20.942Z,1747071020.942 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B0F4E0 2025-05-12T17:30:20.942Z,1747071020.942 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 929 2025-05-12T17:30:20.948Z,1747071020.948 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1 2025-05-12T17:30:20.962Z,1747071020.962 [PowerOnly] Loaded 2025-05-12T17:30:20.963Z,1747071020.963 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2025-05-12T17:30:20.977Z,1747071020.977 [Power24vConverter] Loaded 2025-05-12T17:30:20.977Z,1747071020.977 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-05-12T17:30:20.993Z,1747071020.993 [Radio_Surface] Loaded 2025-05-12T17:30:20.994Z,1747071020.994 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-05-12T17:30:20.995Z,1747071020.995 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B3F4E0 2025-05-12T17:30:20.995Z,1747071020.995 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 930 2025-05-12T17:30:21.011Z,1747071021.011 [Sonardyne_Nano] Loaded 2025-05-12T17:30:21.011Z,1747071021.011 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-05-12T17:30:21.012Z,1747071021.012 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-05-12T17:30:21.013Z,1747071021.013 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-05-12T17:30:21.101Z,1747071021.101 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-05-12T17:30:21.101Z,1747071021.101 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-05-12T17:30:21.176Z,1747071021.176 [VerticalControl](DEBUG): Construct VerticalControl. 2025-05-12T17:30:21.229Z,1747071021.229 [VerticalControl] Loaded 2025-05-12T17:30:21.230Z,1747071021.230 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-05-12T17:30:21.233Z,1747071021.233 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-05-12T17:30:21.278Z,1747071021.278 [HorizontalControl] Loaded 2025-05-12T17:30:21.278Z,1747071021.278 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-05-12T17:30:21.280Z,1747071021.280 [SpeedControl](DEBUG): Construct SpeedControl. 2025-05-12T17:30:21.282Z,1747071021.282 [SpeedControl] Loaded 2025-05-12T17:30:21.282Z,1747071021.282 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-05-12T17:30:21.285Z,1747071021.285 [LoopControl](DEBUG): Construct LoopControl. 2025-05-12T17:30:21.286Z,1747071021.286 [LoopControl] Loaded 2025-05-12T17:30:21.286Z,1747071021.286 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-05-12T17:30:21.286Z,1747071021.286 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-05-12T17:30:21.287Z,1747071021.287 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-05-12T17:30:21.303Z,1747071021.303 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-05-12T17:30:21.303Z,1747071021.303 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-05-12T17:30:21.720Z,1747071021.720 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-05-12T17:30:21.727Z,1747071021.727 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-05-12T17:30:21.730Z,1747071021.730 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-05-12T17:30:21.741Z,1747071021.741 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-05-12T17:30:21.742Z,1747071021.742 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0 2025-05-12T17:30:21.743Z,1747071021.743 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 931 2025-05-12T17:30:21.747Z,1747071021.747 [Supervisor](INFO): Main Thread ID is 824 2025-05-12T17:30:21.747Z,1747071021.747 [Supervisor](DEBUG): Running supervisor. 2025-05-12T17:30:21.748Z,1747071021.748 [CommandExec ThreadHandler](INFO): Handler Thread ID is 932 2025-05-12T17:30:21.748Z,1747071021.748 [CommandExec](INFO): Initializing the command executive. 2025-05-12T17:30:21.750Z,1747071021.750 [CommandLine ThreadHandler](INFO): Handler Thread ID is 933 2025-05-12T17:30:21.752Z,1747071021.752 [controlThread ThreadHandler](INFO): Handler Thread ID is 934 2025-05-12T17:30:21.753Z,1747071021.753 [controlThread](DEBUG): Initializing ControlThread 2025-05-12T17:30:21.754Z,1747071021.754 [SBIT](INFO): Initialize SBIT Component. 2025-05-12T17:30:21.755Z,1747071021.755 [SBIT](IMPORTANT): git: 2025-05-12_B 2025-05-12T17:30:21.755Z,1747071021.755 [SBIT](INFO): git hash: 7c5b1c07405cfe7ca09821eb029d166d25d65d57 2025-05-12T17:30:21.755Z,1747071021.755 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-05-12T17:30:21.757Z,1747071021.757 [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-12T17:30:21.758Z,1747071021.758 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2025-05-12T17:30:21.758Z,1747071021.758 [IBIT](INFO): Initialize IBIT Component. 2025-05-12T17:30:21.759Z,1747071021.759 [CBIT](DEBUG): Initialize CBIT Component. 2025-05-12T17:30:21.760Z,1747071021.760 [logger ThreadHandler](INFO): Handler Thread ID is 935 2025-05-12T17:30:21.772Z,1747071021.772 [CBIT](DEBUG): Initialized mux pins. 2025-05-12T17:30:21.773Z,1747071021.773 [CBIT](DEBUG): Initializing the watchdog timer. 2025-05-12T17:30:21.781Z,1747071021.781 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 936 2025-05-12T17:30:21.782Z,1747071021.782 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-05-12T17:30:21.786Z,1747071021.786 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 938 2025-05-12T17:30:21.789Z,1747071021.789 [WetLabsBB2FL](INFO): Powering up 2025-05-12T17:30:21.790Z,1747071021.790 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 940 2025-05-12T17:30:21.796Z,1747071021.796 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-05-12T17:30:21.797Z,1747071021.797 [CBIT](DEBUG): Initializing heartbeat. 2025-05-12T17:30:21.798Z,1747071021.798 [DAT ThreadHandler](INFO): Handler Thread ID is 941 2025-05-12T17:30:21.799Z,1747071021.799 [DAT](INFO): Powering up 2025-05-12T17:30:21.799Z,1747071021.799 [DAT](DEBUG): Initializing DAT. 2025-05-12T17:30:21.802Z,1747071021.802 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 943 2025-05-12T17:30:21.803Z,1747071021.803 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-05-12T17:30:21.825Z,1747071021.825 [Onboard ThreadHandler](INFO): Handler Thread ID is 944 2025-05-12T17:30:21.842Z,1747071021.842 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 945 2025-05-12T17:30:21.868Z,1747071021.868 [CBIT](DEBUG): Deactivating emergency mode. 2025-05-12T17:30:21.869Z,1747071021.869 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 946 2025-05-12T17:30:21.877Z,1747071021.877 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-05-12T17:30:21.877Z,1747071021.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-05-12T17:30:21.878Z,1747071021.878 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-05-12T17:30:21.878Z,1747071021.878 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-05-12T17:30:21.878Z,1747071021.878 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-05-12T17:30:21.878Z,1747071021.878 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-05-12T17:30:21.878Z,1747071021.878 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-05-12T17:30:21.878Z,1747071021.878 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-05-12T17:30:21.908Z,1747071021.908 [CBIT](DEBUG): Backplane powered. 2025-05-12T17:30:21.909Z,1747071021.909 [GFScanner](DEBUG): Initializing GFScanner 2025-05-12T17:30:21.909Z,1747071021.909 [GFScanner](DEBUG): Deactivating GF circuits. 2025-05-12T17:30:21.917Z,1747071021.917 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-05-12T17:30:21.917Z,1747071021.917 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-05-12T17:30:21.918Z,1747071021.918 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-05-12T17:30:21.918Z,1747071021.918 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-05-12T17:30:21.918Z,1747071021.918 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-05-12T17:30:21.919Z,1747071021.919 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-05-12T17:30:21.920Z,1747071021.920 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-05-12T17:30:21.927Z,1747071021.927 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-05-12T17:30:21.937Z,1747071021.937 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-05-12T17:30:21.938Z,1747071021.938 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-05-12T17:30:21.939Z,1747071021.939 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-05-12T17:30:21.940Z,1747071021.940 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-05-12T17:30:21.949Z,1747071021.949 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-05-12T17:30:21.949Z,1747071021.949 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-05-12T17:30:21.962Z,1747071021.962 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-05-12T17:30:22.050Z,1747071022.050 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-05-12T17:30:22.071Z,1747071022.071 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-05-12T17:30:22.092Z,1747071022.092 [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-12T17:30:22.109Z,1747071022.109 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-05-12T17:30:22.109Z,1747071022.109 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-05-12T17:30:22.118Z,1747071022.118 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-05-12T17:30:22.249Z,1747071022.249 [Radio_Surface](INFO): Powering up 2025-05-12T17:30:22.406Z,1747071022.406 [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-12T17:30:22.428Z,1747071022.428 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-05-12T17:30:22.429Z,1747071022.429 [Default:A.Wait](DEBUG): Construct Wait. 2025-05-12T17:30:22.431Z,1747071022.431 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-05-12T17:30:22.473Z,1747071022.473 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-05-12T17:30:22.475Z,1747071022.475 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-05-12T17:30:22.497Z,1747071022.497 [Default:E.Execute](DEBUG): Construct Execute. 2025-05-12T17:30:22.519Z,1747071022.519 [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-12T17:30:22.524Z,1747071022.524 [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-12T17:30:22.558Z,1747071022.558 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-05-12T17:30:22.689Z,1747071022.689 [Depth_Keller](INFO): Initializing. 2025-05-12T17:30:22.698Z,1747071022.698 [PowerOnly](INFO): Powering up loadControl 2025-05-12T17:30:22.717Z,1747071022.717 [Power24vConverter](INFO): Powering up. 2025-05-12T17:30:22.718Z,1747071022.718 [Sonardyne_Nano](INFO): Initializing. 2025-05-12T17:30:22.745Z,1747071022.745 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-05-12T17:30:22.773Z,1747071022.773 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-05-12T17:30:22.781Z,1747071022.781 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-05-12T17:30:22.782Z,1747071022.782 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-05-12T17:30:22.789Z,1747071022.789 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-05-12T17:30:22.790Z,1747071022.790 [MassServo](DEBUG): Initializing EZServoServo. 2025-05-12T17:30:22.797Z,1747071022.797 [MassServo](DEBUG): Initializing MassServo. 2025-05-12T17:30:22.798Z,1747071022.798 [RudderServo](DEBUG): Initializing EZServoServo. 2025-05-12T17:30:22.806Z,1747071022.806 [RudderServo](DEBUG): Initializing RudderServo. 2025-05-12T17:30:22.806Z,1747071022.806 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-05-12T17:30:22.813Z,1747071022.813 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-05-12T17:30:24.401Z,1747071024.401 [WetLabsBB2FL](INFO): Powering down 2025-05-12T17:30:24.964Z,1747071024.964 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-05-12T17:30:26.218Z,1747071026.218 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-05-12T17:30:28.549Z,1747071028.549 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-05-12T17:30:33.897Z,1747071033.897 [DAT](INFO): DAT read: 2025-05-12T17:30:33.899Z,1747071033.899 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-05-12T17:30:35.662Z,1747071035.662 [DAT](INFO): DAT read: MF Frequency Band 2025-05-12T17:30:35.663Z,1747071035.663 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-05-12T17:30:35.663Z,1747071035.663 [DAT](INFO): DAT read: May 12 2025 17:30:27 2025-05-12T17:30:36.922Z,1747071036.922 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-05-12T17:30:36.923Z,1747071036.923 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-05-12T17:30:36.923Z,1747071036.923 [DAT](INFO): commRate: 1200 2025-05-12T17:30:38.993Z,1747071038.993 [DAT](INFO): entering command mode 2025-05-12T17:30:39.193Z,1747071039.193 [DAT](INFO): DAT read: 2025-05-12T17:30:39.194Z,1747071039.194 [DAT](INFO): DAT read: user:1> 2025-05-12T17:30:39.194Z,1747071039.194 [DAT](INFO): setting verbose to 3 2025-05-12T17:30:39.445Z,1747071039.445 [DAT](INFO): DAT read: user:1> 2025-05-12T17:30:39.446Z,1747071039.446 [DAT](INFO): DAT read: Verbose | 3 2025-05-12T17:30:39.447Z,1747071039.447 [DAT](INFO): set verbose to 3 2025-05-12T17:30:39.447Z,1747071039.447 [DAT](INFO): setting DatVerbose to 27440 2025-05-12T17:30:39.697Z,1747071039.697 [DAT](INFO): DAT read: user:2> 2025-05-12T17:30:39.698Z,1747071039.698 [DAT](INFO): DAT read: DatVerbose | 27440 2025-05-12T17:30:39.699Z,1747071039.699 [DAT](INFO): set DatVerbose to 27440 2025-05-12T17:30:39.699Z,1747071039.699 [DAT](INFO): setting transmit power to 8 2025-05-12T17:30:39.949Z,1747071039.949 [DAT](INFO): DAT read: user:3> 2025-05-12T17:30:39.950Z,1747071039.950 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-05-12T17:30:39.950Z,1747071039.950 [DAT](INFO): set transmit power to 8 2025-05-12T17:30:39.951Z,1747071039.951 [DAT](INFO): setting local address to 5 2025-05-12T17:30:40.201Z,1747071040.201 [DAT](INFO): DAT read: user:4> 2025-05-12T17:30:40.202Z,1747071040.202 [DAT](INFO): DAT read: LocalAddr | 5 2025-05-12T17:30:40.203Z,1747071040.203 [DAT](INFO): set local address to 5 2025-05-12T17:30:40.204Z,1747071040.204 [DAT](INFO): Setting time to: 17:30:40 And date to:5/12/2025 2025-05-12T17:30:40.454Z,1747071040.454 [DAT](INFO): DAT read: user:5> 2025-05-12T17:30:40.456Z,1747071040.456 [DAT](INFO): DAT read: Mon May 12, 2025 17:30:40 2025-05-12T17:30:40.456Z,1747071040.456 [DAT](INFO): Local DAT time set to Mon May 12, 2025 17:30:40 2025-05-12T17:30:51.264Z,1747071051.264 [NAL9602](INFO): Powering up NAL9602 2025-05-12T17:31:02.186Z,1747071062.186 [NAL9602](INFO): NAL9602 initialized 2025-05-12T17:31:21.183Z,1747071081.183 [SBIT](IMPORTANT): Beginning Startup BIT 2025-05-12T17:31:21.208Z,1747071081.208 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-05-12T17:31:25.681Z,1747071085.681 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.001941 CHAN A1 (24V): 0.004297 CHAN A2 (12V): -0.005741 CHAN A3 (5V): -0.004325 CHAN B0 (3.3V): -0.002014 CHAN B1 (3.15aV): -0.001749 CHAN B2 (3.15bV): -0.001659 CHAN B3 (GND): -0.001327 OPEN: 0.007084 Full Scale: +/- 1 mA 2025-05-12T17:31:36.159Z,1747071096.159 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-05-12T17:32:12.721Z,1747071132.721 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005320 2025-05-12T17:32:14.627Z,1747071134.627 [SBIT](IMPORTANT): SBIT PASSED 2025-05-12T17:32:14.627Z,1747071134.627 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-05-12T17:32:14.628Z,1747071134.628 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2025-05-12T17:32:14.628Z,1747071134.628 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool; 2025-05-12T17:32:14.628Z,1747071134.628 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=5 minute; 2025-05-12T17:32:14.629Z,1747071134.629 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-05-12T17:32:14.629Z,1747071134.629 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-05-12T17:32:14.629Z,1747071134.629 [SBIT](IMPORTANT): ThrusterHE.bestEffortMode=0 bool; 2025-05-12T17:32:14.629Z,1747071134.629 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=210 cubic_centimeter; 2025-05-12T17:32:14.629Z,1747071134.629 [SBIT](IMPORTANT): VerticalControl.massDefault=10 millimeter; 2025-05-12T17:32:15.021Z,1747071135.021 [MissionManager](IMPORTANT): Started mission Startup 2025-05-12T17:32:15.021Z,1747071135.021 [Startup] Running Loop=1 2025-05-12T17:32:15.022Z,1747071135.022 [Startup](DEBUG): Aggregate::initialize Startup 2025-05-12T17:32:15.022Z,1747071135.022 [Startup:A.GoToSurface] Running Loop=1 2025-05-12T17:32:15.022Z,1747071135.022 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-05-12T17:32:15.022Z,1747071135.022 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-05-12T17:32:15.023Z,1747071135.023 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-05-12T17:32:15.023Z,1747071135.023 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-05-12T17:32:15.023Z,1747071135.023 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-05-12T17:32:15.024Z,1747071135.024 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-05-12T17:32:15.024Z,1747071135.024 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-05-12T17:32:15.026Z,1747071135.026 [Startup:StartupSatComms] Running Loop=1 2025-05-12T17:32:15.026Z,1747071135.026 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-05-12T17:32:15.026Z,1747071135.026 [Startup:StartupSatComms:A] Running Loop=1 2025-05-12T17:32:15.479Z,1747071135.479 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-05-12T17:32:32.033Z,1747071152.033 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-05-12T17:33:12.080Z,1747071192.080 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-05-12T17:33:15.208Z,1747071195.208 [Startup:StartupSatComms:A](INFO): Timed out from 2025-05-12T17:32:15.0Z 2025-05-12T17:33:15.208Z,1747071195.208 [Startup:StartupSatComms:A] Stopped 2025-05-12T17:33:15.208Z,1747071195.208 [Startup:StartupSatComms:B] Running Loop=1 2025-05-12T17:33:15.610Z,1747071195.610 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-05-12T17:33:22.105Z,1747071202.105 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-05-12T17:33:22.105Z,1747071202.105 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:33:22.131Z,1747071202.131 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:33:22.226Z,1747071202.226 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250512T170450/Courier0010.lzma 2025-05-12T17:33:22.523Z,1747071202.523 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:33:22.523Z,1747071202.523 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-05-12T17:33:23.226Z,1747071203.226 [DataOverHttps](INFO): Moved sent file to Logs/20250512T170450/Courier0010.lzma.bak 2025-05-12T17:33:23.227Z,1747071203.227 [DataOverHttps](INFO): SBD MOMSN=24854390 2025-05-12T17:33:33.431Z,1747071213.431 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-05-12T17:33:39.932Z,1747071219.932 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250512T173009/Courier0000.lzma 2025-05-12T17:33:40.934Z,1747071220.934 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Courier0000.lzma.bak 2025-05-12T17:33:40.935Z,1747071220.935 [DataOverHttps](INFO): SBD MOMSN=24854392 2025-05-12T17:33:52.430Z,1747071232.430 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-05-12T17:33:57.918Z,1747071237.918 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250512T170450/Express0011.lzma 2025-05-12T17:33:58.918Z,1747071238.918 [DataOverHttps](INFO): Moved sent file to Logs/20250512T170450/Express0011.lzma.bak 2025-05-12T17:33:58.919Z,1747071238.919 [DataOverHttps](INFO): SBD MOMSN=24854398 2025-05-12T17:34:15.423Z,1747071255.423 [Startup:StartupSatComms:B](INFO): Timed out from 2025-05-12T17:33:15.2Z 2025-05-12T17:34:15.423Z,1747071255.423 [Startup:StartupSatComms:B] Stopped 2025-05-12T17:34:15.423Z,1747071255.423 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-05-12T17:34:15.423Z,1747071255.423 [Startup:StartupSatComms] Stopped 2025-05-12T17:34:15.423Z,1747071255.423 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-05-12T17:34:15.424Z,1747071255.424 [Startup](INFO): Completed Startup 2025-05-12T17:34:15.463Z,1747071255.463 [MissionManager](INFO): Startup is completed. 2025-05-12T17:34:15.463Z,1747071255.463 [MissionManager](INFO): Uninitializing Mission Startup 2025-05-12T17:34:15.463Z,1747071255.463 [Startup] Stopped 2025-05-12T17:34:15.463Z,1747071255.463 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-05-12T17:34:15.463Z,1747071255.463 [Startup:A.GoToSurface] Stopped 2025-05-12T17:34:15.463Z,1747071255.463 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-05-12T17:34:15.813Z,1747071255.813 [MissionManager](IMPORTANT): Started mission Default 2025-05-12T17:34:15.813Z,1747071255.813 [Default] Running Loop=1 2025-05-12T17:34:15.814Z,1747071255.814 [Default](DEBUG): Aggregate::initialize Default 2025-05-12T17:34:15.814Z,1747071255.814 [Default:B.GoToSurface] Running Loop=1 2025-05-12T17:34:15.814Z,1747071255.814 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-05-12T17:34:15.814Z,1747071255.814 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-05-12T17:34:15.814Z,1747071255.814 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-05-12T17:34:15.815Z,1747071255.815 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-05-12T17:34:15.815Z,1747071255.815 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-05-12T17:34:15.815Z,1747071255.815 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-05-12T17:34:15.815Z,1747071255.815 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-05-12T17:34:15.816Z,1747071255.816 [Default:A.Wait] Running Loop=1 2025-05-12T17:34:15.816Z,1747071255.816 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-05-12T17:34:16.719Z,1747071256.719 [DataOverHttps](INFO): Sending 870 bytes from file Logs/20250512T173009/Express0001.lzma 2025-05-12T17:34:17.718Z,1747071257.718 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Express0001.lzma.bak 2025-05-12T17:34:17.719Z,1747071257.719 [DataOverHttps](INFO): SBD MOMSN=24854405 2025-05-12T17:34:29.155Z,1747071269.155 [Default:A.Wait](INFO): Done Waiting. 2025-05-12T17:34:29.155Z,1747071269.155 [Default:A.Wait] Stopped 2025-05-12T17:34:29.155Z,1747071269.155 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-05-12T17:34:29.563Z,1747071269.563 [Default:CheckIn] Running Loop=1 2025-05-12T17:34:29.563Z,1747071269.563 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-12T17:34:29.563Z,1747071269.563 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-12T17:34:29.974Z,1747071269.974 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-05-12T17:35:32.212Z,1747071332.212 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-05-12T17:36:05.695Z,1747071365.695 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-12T17:36:23.097Z,1747071383.097 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-05-12T17:36:23.097Z,1747071383.097 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:36:23.120Z,1747071383.120 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:36:23.554Z,1747071383.554 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:36:23.555Z,1747071383.555 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-05-12T17:37:03.521Z,1747071423.521 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-05-12T17:37:47.152Z,1747071467.152 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-05-12T17:39:08.705Z,1747071548.705 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-05-12T17:39:08.706Z,1747071548.706 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-05-12T17:39:08.707Z,1747071548.707 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2025-05-12T17:39:08.710Z,1747071548.710 [BPC1](INFO): Received data from all battery sticks. 2025-05-12T17:39:24.066Z,1747071564.066 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-05-12T17:39:24.066Z,1747071564.066 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:39:24.092Z,1747071564.092 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:39:24.510Z,1747071564.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:39:24.510Z,1747071564.510 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-05-12T17:39:29.759Z,1747071569.759 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-12T17:34:29.6Z 2025-05-12T17:39:29.759Z,1747071569.759 [Default:CheckIn:Read_GPS] Stopped 2025-05-12T17:39:29.759Z,1747071569.759 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-12T17:39:30.138Z,1747071570.138 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-05-12T17:39:31.177Z,1747071571.177 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250512T173009/Courier0004.lzma 2025-05-12T17:39:31.666Z,1747071571.666 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Courier0004.lzma.bak 2025-05-12T17:39:31.667Z,1747071571.667 [DataOverHttps](INFO): SBD MOMSN=24854440 2025-05-12T17:39:48.581Z,1747071588.581 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20250512T173009/Express0005.lzma 2025-05-12T17:39:49.582Z,1747071589.582 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Express0005.lzma.bak 2025-05-12T17:39:49.583Z,1747071589.583 [DataOverHttps](INFO): SBD MOMSN=24854442 2025-05-12T17:39:51.958Z,1747071591.958 [Default:CheckIn:Read_Iridium] Stopped 2025-05-12T17:39:51.959Z,1747071591.959 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-12T17:39:51.959Z,1747071591.959 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-12T17:41:03.487Z,1747071663.487 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-05-12T17:41:03.487Z,1747071663.487 [NAL9602] Data Fault, FailCount= 1 2025-05-12T17:41:03.488Z,1747071663.488 [NAL9602](ERROR): Data Fault 2025-05-12T17:41:03.572Z,1747071663.572 [CBIT](ERROR): Data Fault in component: NAL9602 2025-05-12T17:41:03.894Z,1747071663.894 [NAL9602](INFO): Powering down 2025-05-12T17:41:04.740Z,1747071664.740 [CBIT](INFO): Clearing failed state for component NAL9602 2025-05-12T17:41:04.740Z,1747071664.740 [NAL9602] No Fault, FailCount= 1 2025-05-12T17:41:34.191Z,1747071694.191 [NAL9602](INFO): Powering up NAL9602 2025-05-12T17:41:45.102Z,1747071705.102 [NAL9602](INFO): NAL9602 initialized 2025-05-12T17:42:25.111Z,1747071745.111 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-05-12T17:42:25.111Z,1747071745.111 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:42:25.138Z,1747071745.138 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:42:25.519Z,1747071745.519 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:42:25.519Z,1747071745.519 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-05-12T17:44:52.585Z,1747071892.585 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-12T17:44:52.585Z,1747071892.585 [Default:CheckIn:C.Wait] Stopped 2025-05-12T17:44:52.585Z,1747071892.585 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-12T17:44:52.585Z,1747071892.585 [Default:CheckIn:D] Running Loop=1 2025-05-12T17:44:52.971Z,1747071892.971 [Default:CheckIn:D] Stopped 2025-05-12T17:44:52.971Z,1747071892.971 [Default:CheckIn:E] Running Loop=1 2025-05-12T17:44:53.394Z,1747071893.394 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.619293 min 2025-05-12T17:44:53.394Z,1747071893.394 [Default:CheckIn:E] Stopped 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn] Stopped 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn](INFO): Running loop #2 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn] Running Loop=2 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-12T17:44:53.395Z,1747071893.395 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-12T17:45:26.095Z,1747071926.095 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-05-12T17:45:26.095Z,1747071926.095 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:45:26.107Z,1747071926.107 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:45:26.539Z,1747071926.539 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:45:26.539Z,1747071926.539 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-05-12T17:48:27.094Z,1747072107.094 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2025-05-12T17:48:27.094Z,1747072107.094 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:48:27.105Z,1747072107.105 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:48:27.529Z,1747072107.529 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:48:27.529Z,1747072107.529 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2025-05-12T17:49:53.566Z,1747072193.566 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-12T17:44:53.4Z 2025-05-12T17:49:53.566Z,1747072193.566 [Default:CheckIn:Read_GPS] Stopped 2025-05-12T17:49:53.567Z,1747072193.567 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-12T17:50:00.532Z,1747072200.532 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250512T173009/Courier0007.lzma 2025-05-12T17:50:01.534Z,1747072201.534 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Courier0007.lzma.bak 2025-05-12T17:50:01.534Z,1747072201.534 [DataOverHttps](INFO): SBD MOMSN=24854580 2025-05-12T17:50:22.707Z,1747072222.707 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20250512T173009/Express0008.lzma 2025-05-12T17:50:23.706Z,1747072223.706 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Express0008.lzma.bak 2025-05-12T17:50:23.707Z,1747072223.707 [DataOverHttps](INFO): SBD MOMSN=24854582 2025-05-12T17:50:25.897Z,1747072225.897 [Default:CheckIn:Read_Iridium] Stopped 2025-05-12T17:50:25.897Z,1747072225.897 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-12T17:50:25.897Z,1747072225.897 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-12T17:51:28.162Z,1747072288.162 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2025-05-12T17:51:28.162Z,1747072288.162 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:51:28.173Z,1747072288.173 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:51:28.566Z,1747072288.566 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:51:28.566Z,1747072288.566 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2025-05-12T17:51:46.327Z,1747072306.327 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-05-12T17:51:46.327Z,1747072306.327 [NAL9602] Data Fault, FailCount= 2 2025-05-12T17:51:46.328Z,1747072306.328 [NAL9602](ERROR): Data Fault 2025-05-12T17:51:46.345Z,1747072306.345 [CBIT](ERROR): Data Fault in component: NAL9602 2025-05-12T17:51:46.726Z,1747072306.726 [NAL9602](INFO): Powering down 2025-05-12T17:51:47.547Z,1747072307.547 [CBIT](INFO): Clearing failed state for component NAL9602 2025-05-12T17:51:47.547Z,1747072307.547 [NAL9602] No Fault, FailCount= 2 2025-05-12T17:52:17.019Z,1747072337.019 [NAL9602](INFO): Powering up NAL9602 2025-05-12T17:52:27.941Z,1747072347.941 [NAL9602](INFO): NAL9602 initialized 2025-05-12T17:54:29.152Z,1747072469.152 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2025-05-12T17:54:29.152Z,1747072469.152 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:54:29.167Z,1747072469.167 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:54:29.572Z,1747072469.572 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:54:29.572Z,1747072469.572 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2025-05-12T17:55:26.504Z,1747072526.504 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-12T17:55:26.505Z,1747072526.505 [Default:CheckIn:C.Wait] Stopped 2025-05-12T17:55:26.505Z,1747072526.505 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-12T17:55:26.505Z,1747072526.505 [Default:CheckIn:D] Running Loop=1 2025-05-12T17:55:26.907Z,1747072526.907 [Default:CheckIn:D] Stopped 2025-05-12T17:55:26.907Z,1747072526.907 [Default:CheckIn:E] Running Loop=1 2025-05-12T17:55:27.338Z,1747072527.338 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.184896 min 2025-05-12T17:55:27.338Z,1747072527.338 [Default:CheckIn:E] Stopped 2025-05-12T17:55:27.338Z,1747072527.338 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-12T17:55:27.338Z,1747072527.338 [Default:CheckIn] Stopped 2025-05-12T17:55:27.338Z,1747072527.338 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-12T17:55:27.338Z,1747072527.338 [Default:CheckIn](INFO): Running loop #3 2025-05-12T17:55:27.339Z,1747072527.339 [Default:CheckIn] Running Loop=3 2025-05-12T17:55:27.339Z,1747072527.339 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-12T17:55:27.339Z,1747072527.339 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-12T17:57:30.145Z,1747072650.145 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2025-05-12T17:57:30.145Z,1747072650.145 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T17:57:30.156Z,1747072650.156 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T17:57:30.563Z,1747072650.563 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T17:57:30.563Z,1747072650.563 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2025-05-12T17:58:43.382Z,1747072723.382 [CommandExec](IMPORTANT): got command failComponent 2025-05-12T17:58:43.382Z,1747072723.382 [CommandExec](IMPORTANT): Failed components: 2025-05-12T17:58:43.382Z,1747072723.382 [CommandExec](IMPORTANT): No failed Components. 2025-05-12T17:59:11.788Z,1747072751.788 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent 2025-05-12T17:59:11.788Z,1747072751.788 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 61.000000 % 2025-05-12T18:00:27.506Z,1747072827.506 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-05-12T17:55:27.3Z 2025-05-12T18:00:27.506Z,1747072827.506 [Default:CheckIn:Read_GPS] Stopped 2025-05-12T18:00:27.507Z,1747072827.507 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-12T18:00:31.149Z,1747072831.149 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2025-05-12T18:00:31.149Z,1747072831.149 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-05-12T18:00:31.163Z,1747072831.163 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-05-12T18:00:31.566Z,1747072831.566 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-05-12T18:00:31.566Z,1747072831.566 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2025-05-12T18:00:37.108Z,1747072837.108 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250512T173009/Courier0010.lzma 2025-05-12T18:00:38.111Z,1747072838.111 [DataOverHttps](INFO): Moved sent file to Logs/20250512T173009/Courier0010.lzma.bak 2025-05-12T18:00:38.111Z,1747072838.111 [DataOverHttps](INFO): SBD MOMSN=24854609 2025-05-12T18:00:59.033Z,174707