2025-03-10T17:15:39.836Z,1741626939.836 [Supervisor](DEBUG): Initializing supervisor. 2025-03-10T17:15:39.840Z,1741626939.840 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-03-10T17:15:39.841Z,1741626939.841 [SyncHandler](INFO): Protected caller Thread ID is 1649 2025-03-10T17:15:39.841Z,1741626939.841 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-03-10T17:15:39.842Z,1741626939.842 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-03-10T17:15:39.842Z,1741626939.842 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1650 2025-03-10T17:15:39.847Z,1741626939.847 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-03-10T17:15:39.866Z,1741626939.866 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-03-10T17:15:39.867Z,1741626939.867 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-03-10T17:15:39.867Z,1741626939.867 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1651 2025-03-10T17:15:39.872Z,1741626939.872 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-03-10T17:15:39.873Z,1741626939.873 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-03-10T17:15:39.873Z,1741626939.873 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1652 2025-03-10T17:15:39.875Z,1741626939.875 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-03-10T17:15:39.876Z,1741626939.876 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-03-10T17:15:39.877Z,1741626939.877 [logger ThreadHandler](INFO): Protected caller Thread ID is 1653 2025-03-10T17:15:39.881Z,1741626939.881 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-03-10T17:15:39.881Z,1741626939.881 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-03-10T17:15:39.883Z,1741626939.883 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-03-10T17:15:39.993Z,1741626939.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-03-10T17:15:39.994Z,1741626939.994 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-03-10T17:15:40.244Z,1741626940.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-03-10T17:15:40.245Z,1741626940.245 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-03-10T17:15:40.537Z,1741626940.537 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-03-10T17:15:40.538Z,1741626940.538 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-03-10T17:15:40.662Z,1741626940.662 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-03-10T17:15:40.663Z,1741626940.663 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-03-10T17:15:41.483Z,1741626941.483 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-03-10T17:15:41.484Z,1741626941.484 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-03-10T17:15:42.155Z,1741626942.155 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-03-10T17:15:42.155Z,1741626942.155 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-03-10T17:15:42.811Z,1741626942.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-03-10T17:15:42.811Z,1741626942.811 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-03-10T17:15:43.567Z,1741626943.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-03-10T17:15:43.568Z,1741626943.568 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-03-10T17:15:43.950Z,1741626943.950 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-03-10T17:15:43.951Z,1741626943.951 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-03-10T17:15:44.361Z,1741626944.361 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-03-10T17:15:44.361Z,1741626944.361 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-03-10T17:15:44.613Z,1741626944.613 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-03-10T17:15:44.613Z,1741626944.613 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-03-10T17:15:44.771Z,1741626944.771 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-03-10T17:15:44.772Z,1741626944.772 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-03-10T17:15:44.868Z,1741626944.868 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-03-10T17:15:44.961Z,1741626944.961 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-03-10T17:15:45.171Z,1741626945.171 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-03-10T17:15:45.172Z,1741626945.172 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-03-10T17:15:45.442Z,1741626945.442 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-03-10T17:15:45.444Z,1741626945.444 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2025-03-10T17:15:45.445Z,1741626945.445 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2025-03-10T17:15:45.542Z,1741626945.542 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2025-03-10T17:15:45.830Z,1741626945.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-03-10T17:15:45.830Z,1741626945.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2025-03-10T17:15:45.930Z,1741626945.930 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2025-03-10T17:15:46.119Z,1741626946.119 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2025-03-10T17:15:46.234Z,1741626946.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2025-03-10T17:15:46.363Z,1741626946.363 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2025-03-10T17:15:46.494Z,1741626946.494 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2025-03-10T17:15:46.615Z,1741626946.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2025-03-10T17:15:46.799Z,1741626946.799 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg 2025-03-10T17:15:46.913Z,1741626946.913 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/workSite.cfg 2025-03-10T17:15:47.012Z,1741626947.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2025-03-10T17:15:47.126Z,1741626947.126 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2025-03-10T17:15:47.231Z,1741626947.231 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2025-03-10T17:15:47.231Z,1741626947.231 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-03-10T17:15:47.238Z,1741626947.238 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-03-10T17:15:47.417Z,1741626947.417 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-03-10T17:15:47.417Z,1741626947.417 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-03-10T17:15:47.582Z,1741626947.582 [BuoyancyServo] Loaded 2025-03-10T17:15:47.582Z,1741626947.582 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-03-10T17:15:47.607Z,1741626947.607 [ElevatorServo] Loaded 2025-03-10T17:15:47.607Z,1741626947.607 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-03-10T17:15:47.630Z,1741626947.630 [MassServo] Loaded 2025-03-10T17:15:47.630Z,1741626947.630 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-03-10T17:15:47.653Z,1741626947.653 [RudderServo] Loaded 2025-03-10T17:15:47.654Z,1741626947.654 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-03-10T17:15:47.673Z,1741626947.673 [ThrusterHE] Loaded 2025-03-10T17:15:47.673Z,1741626947.673 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-03-10T17:15:47.673Z,1741626947.673 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-03-10T17:15:47.674Z,1741626947.674 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-03-10T17:15:47.834Z,1741626947.834 [SBIT](DEBUG): Construct Startup Built In Test. 2025-03-10T17:15:47.849Z,1741626947.849 [SBIT] Loaded 2025-03-10T17:15:47.850Z,1741626947.850 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-03-10T17:15:47.853Z,1741626947.853 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-03-10T17:15:47.874Z,1741626947.874 [IBIT] Loaded 2025-03-10T17:15:47.874Z,1741626947.874 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-03-10T17:15:47.880Z,1741626947.880 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-03-10T17:15:48.083Z,1741626948.083 [CBIT] Loaded 2025-03-10T17:15:48.083Z,1741626948.083 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-03-10T17:15:48.115Z,1741626948.115 [GFScanner] Loaded 2025-03-10T17:15:48.116Z,1741626948.116 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-03-10T17:15:48.116Z,1741626948.116 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-03-10T17:15:48.117Z,1741626948.117 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-03-10T17:15:48.763Z,1741626948.763 [CTD_Seabird] Loaded 2025-03-10T17:15:48.764Z,1741626948.764 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-03-10T17:15:48.773Z,1741626948.773 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406834E0 2025-03-10T17:15:48.773Z,1741626948.773 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1741 2025-03-10T17:15:48.856Z,1741626948.856 [ESPComponent] Loaded 2025-03-10T17:15:48.857Z,1741626948.857 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2025-03-10T17:15:48.915Z,1741626948.915 [PAR_Licor] Loaded 2025-03-10T17:15:48.915Z,1741626948.915 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-03-10T17:15:48.962Z,1741626948.962 [WetLabsBB2FL] Loaded 2025-03-10T17:15:48.962Z,1741626948.962 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-03-10T17:15:48.963Z,1741626948.963 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406B34E0 2025-03-10T17:15:48.964Z,1741626948.964 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1742 2025-03-10T17:15:48.965Z,1741626948.965 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-03-10T17:15:48.965Z,1741626948.965 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-03-10T17:15:49.034Z,1741626949.034 [DepthRateCalculator] Loaded 2025-03-10T17:15:49.034Z,1741626949.034 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-03-10T17:15:49.040Z,1741626949.040 [PitchRateCalculator] Loaded 2025-03-10T17:15:49.040Z,1741626949.040 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-03-10T17:15:49.051Z,1741626949.051 [SpeedCalculator] Loaded 2025-03-10T17:15:49.052Z,1741626949.052 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-03-10T17:15:49.056Z,1741626949.056 [YawRateCalculator] Loaded 2025-03-10T17:15:49.057Z,1741626949.057 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-03-10T17:15:49.077Z,1741626949.077 [ElevatorOffsetCalculator] Loaded 2025-03-10T17:15:49.077Z,1741626949.077 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-03-10T17:15:49.078Z,1741626949.078 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-03-10T17:15:49.078Z,1741626949.078 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-03-10T17:15:49.210Z,1741626949.210 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-03-10T17:15:49.211Z,1741626949.211 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-03-10T17:15:49.240Z,1741626949.240 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-03-10T17:15:49.241Z,1741626949.241 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-03-10T17:15:49.356Z,1741626949.356 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-03-10T17:15:49.356Z,1741626949.356 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-03-10T17:15:49.371Z,1741626949.371 [NavChart] Loaded 2025-03-10T17:15:49.371Z,1741626949.371 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-03-10T17:15:49.377Z,1741626949.377 [UniversalFixResidualReporter] Loaded 2025-03-10T17:15:49.377Z,1741626949.377 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-03-10T17:15:49.377Z,1741626949.377 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-03-10T17:15:49.378Z,1741626949.378 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-03-10T17:15:49.859Z,1741626949.859 [AHRS_M2] Loaded 2025-03-10T17:15:49.860Z,1741626949.860 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-03-10T17:15:49.899Z,1741626949.899 [BackseatComponent] Loaded 2025-03-10T17:15:49.899Z,1741626949.899 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-03-10T17:15:49.900Z,1741626949.900 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A7E4E0 2025-03-10T17:15:49.901Z,1741626949.901 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1743 2025-03-10T17:15:49.904Z,1741626949.904 [LcmUniversalReporter] Loaded 2025-03-10T17:15:49.904Z,1741626949.904 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-03-10T17:15:50.673Z,1741626950.673 [BPC1] Loaded 2025-03-10T17:15:50.673Z,1741626950.673 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-03-10T17:15:50.779Z,1741626950.779 [DAT] Loaded 2025-03-10T17:15:50.780Z,1741626950.780 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-03-10T17:15:50.781Z,1741626950.781 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AAE4E0 2025-03-10T17:15:50.781Z,1741626950.781 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1744 2025-03-10T17:15:50.857Z,1741626950.857 [DataOverHttps] Loaded 2025-03-10T17:15:50.858Z,1741626950.858 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-03-10T17:15:50.859Z,1741626950.859 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40ADE4E0 2025-03-10T17:15:50.859Z,1741626950.859 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1745 2025-03-10T17:15:50.883Z,1741626950.883 [Depth_Keller] Loaded 2025-03-10T17:15:50.883Z,1741626950.883 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-03-10T17:15:50.889Z,1741626950.889 [DropWeight] Loaded 2025-03-10T17:15:50.889Z,1741626950.889 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-03-10T17:15:50.931Z,1741626950.931 [DVL_micro] Loaded 2025-03-10T17:15:50.932Z,1741626950.932 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2025-03-10T17:15:50.996Z,1741626950.996 [NAL9602] Loaded 2025-03-10T17:15:50.996Z,1741626950.996 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-03-10T17:15:51.023Z,1741626951.023 [Onboard] Loaded 2025-03-10T17:15:51.023Z,1741626951.023 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-03-10T17:15:51.025Z,1741626951.025 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40B0E4E0 2025-03-10T17:15:51.025Z,1741626951.025 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1746 2025-03-10T17:15:51.040Z,1741626951.040 [Power24vConverter] Loaded 2025-03-10T17:15:51.040Z,1741626951.040 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-03-10T17:15:51.057Z,1741626951.057 [Radio_Surface] Loaded 2025-03-10T17:15:51.057Z,1741626951.057 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-03-10T17:15:51.058Z,1741626951.058 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B3E4E0 2025-03-10T17:15:51.058Z,1741626951.058 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1747 2025-03-10T17:15:51.074Z,1741626951.074 [Sonardyne_Nano] Loaded 2025-03-10T17:15:51.075Z,1741626951.075 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-03-10T17:15:51.075Z,1741626951.075 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-03-10T17:15:51.076Z,1741626951.076 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-03-10T17:15:51.136Z,1741626951.136 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-03-10T17:15:51.137Z,1741626951.137 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-03-10T17:15:51.190Z,1741626951.190 [VerticalControl](DEBUG): Construct VerticalControl. 2025-03-10T17:15:51.242Z,1741626951.242 [VerticalControl] Loaded 2025-03-10T17:15:51.243Z,1741626951.243 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-03-10T17:15:51.246Z,1741626951.246 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-03-10T17:15:51.291Z,1741626951.291 [HorizontalControl] Loaded 2025-03-10T17:15:51.291Z,1741626951.291 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-03-10T17:15:51.293Z,1741626951.293 [SpeedControl](DEBUG): Construct SpeedControl. 2025-03-10T17:15:51.295Z,1741626951.295 [SpeedControl] Loaded 2025-03-10T17:15:51.295Z,1741626951.295 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-03-10T17:15:51.298Z,1741626951.298 [LoopControl](DEBUG): Construct LoopControl. 2025-03-10T17:15:51.299Z,1741626951.299 [LoopControl] Loaded 2025-03-10T17:15:51.299Z,1741626951.299 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-03-10T17:15:51.300Z,1741626951.300 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-03-10T17:15:51.300Z,1741626951.300 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-03-10T17:15:51.310Z,1741626951.310 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-03-10T17:15:51.311Z,1741626951.311 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-03-10T17:15:51.655Z,1741626951.655 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-03-10T17:15:51.661Z,1741626951.661 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-03-10T17:15:51.664Z,1741626951.664 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-03-10T17:15:51.676Z,1741626951.676 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-03-10T17:15:51.677Z,1741626951.677 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C644E0 2025-03-10T17:15:51.677Z,1741626951.677 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1748 2025-03-10T17:15:51.682Z,1741626951.682 [Supervisor](INFO): Main Thread ID is 1462 2025-03-10T17:15:51.682Z,1741626951.682 [Supervisor](DEBUG): Running supervisor. 2025-03-10T17:15:51.683Z,1741626951.683 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1749 2025-03-10T17:15:51.683Z,1741626951.683 [CommandExec](INFO): Initializing the command executive. 2025-03-10T17:15:51.685Z,1741626951.685 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1750 2025-03-10T17:15:51.688Z,1741626951.688 [controlThread ThreadHandler](INFO): Handler Thread ID is 1751 2025-03-10T17:15:51.689Z,1741626951.689 [controlThread](DEBUG): Initializing ControlThread 2025-03-10T17:15:51.690Z,1741626951.690 [SBIT](INFO): Initialize SBIT Component. 2025-03-10T17:15:51.691Z,1741626951.691 [SBIT](IMPORTANT): git: 2025-03-06_B 2025-03-10T17:15:51.691Z,1741626951.691 [SBIT](INFO): git hash: 24b4ce5baafc07409b46e74dcb267db57334b86b 2025-03-10T17:15:51.691Z,1741626951.691 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-03-10T17:15:51.693Z,1741626951.693 [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-03-10T17:15:51.694Z,1741626951.694 [SBIT](INFO): Beginning SBIT in 68.000000 seconds. 2025-03-10T17:15:51.694Z,1741626951.694 [IBIT](INFO): Initialize IBIT Component. 2025-03-10T17:15:51.695Z,1741626951.695 [CBIT](DEBUG): Initialize CBIT Component. 2025-03-10T17:15:51.696Z,1741626951.696 [logger ThreadHandler](INFO): Handler Thread ID is 1752 2025-03-10T17:15:51.708Z,1741626951.708 [CBIT](DEBUG): Initialized mux pins. 2025-03-10T17:15:51.708Z,1741626951.708 [CBIT](DEBUG): Initializing the watchdog timer. 2025-03-10T17:15:51.717Z,1741626951.717 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1753 2025-03-10T17:15:51.717Z,1741626951.717 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-03-10T17:15:51.722Z,1741626951.722 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1755 2025-03-10T17:15:51.725Z,1741626951.725 [WetLabsBB2FL](INFO): Powering up 2025-03-10T17:15:51.726Z,1741626951.726 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1757 2025-03-10T17:15:51.732Z,1741626951.732 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-03-10T17:15:51.733Z,1741626951.733 [CBIT](DEBUG): Initializing heartbeat. 2025-03-10T17:15:51.734Z,1741626951.734 [DAT ThreadHandler](INFO): Handler Thread ID is 1758 2025-03-10T17:15:51.734Z,1741626951.734 [DAT](INFO): Powering up 2025-03-10T17:15:51.735Z,1741626951.735 [DAT](DEBUG): Initializing DAT. 2025-03-10T17:15:51.737Z,1741626951.737 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1760 2025-03-10T17:15:51.739Z,1741626951.739 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-03-10T17:15:51.760Z,1741626951.760 [Onboard ThreadHandler](INFO): Handler Thread ID is 1761 2025-03-10T17:15:51.778Z,1741626951.778 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1762 2025-03-10T17:15:51.796Z,1741626951.796 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1763 2025-03-10T17:15:51.799Z,1741626951.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-03-10T17:15:51.799Z,1741626951.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-03-10T17:15:51.799Z,1741626951.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-03-10T17:15:51.799Z,1741626951.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-03-10T17:15:51.799Z,1741626951.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-03-10T17:15:51.799Z,1741626951.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-03-10T17:15:51.800Z,1741626951.800 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-03-10T17:15:51.800Z,1741626951.800 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-03-10T17:15:51.804Z,1741626951.804 [CBIT](DEBUG): Deactivating emergency mode. 2025-03-10T17:15:51.844Z,1741626951.844 [CBIT](DEBUG): Backplane powered. 2025-03-10T17:15:51.844Z,1741626951.844 [GFScanner](DEBUG): Initializing GFScanner 2025-03-10T17:15:51.845Z,1741626951.845 [GFScanner](DEBUG): Deactivating GF circuits. 2025-03-10T17:15:51.852Z,1741626951.852 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-03-10T17:15:51.853Z,1741626951.853 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-03-10T17:15:51.853Z,1741626951.853 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-03-10T17:15:51.854Z,1741626951.854 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-03-10T17:15:51.854Z,1741626951.854 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-03-10T17:15:51.855Z,1741626951.855 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-03-10T17:15:51.855Z,1741626951.855 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-03-10T17:15:51.871Z,1741626951.871 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-03-10T17:15:51.880Z,1741626951.880 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-03-10T17:15:51.881Z,1741626951.881 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-03-10T17:15:51.881Z,1741626951.881 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-03-10T17:15:51.882Z,1741626951.882 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-03-10T17:15:51.883Z,1741626951.883 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-03-10T17:15:51.883Z,1741626951.883 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-03-10T17:15:51.892Z,1741626951.892 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-03-10T17:15:51.974Z,1741626951.974 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-03-10T17:15:51.995Z,1741626951.995 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-03-10T17:15:52.023Z,1741626952.023 [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-03-10T17:15:52.044Z,1741626952.044 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-03-10T17:15:52.044Z,1741626952.044 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-03-10T17:15:52.045Z,1741626952.045 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-03-10T17:15:52.184Z,1741626952.184 [Radio_Surface](INFO): Powering up 2025-03-10T17:15:52.371Z,1741626952.371 [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-03-10T17:15:52.397Z,1741626952.397 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-03-10T17:15:52.398Z,1741626952.398 [Default:A.Wait](DEBUG): Construct Wait. 2025-03-10T17:15:52.417Z,1741626952.417 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-03-10T17:15:52.441Z,1741626952.441 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-03-10T17:15:52.464Z,1741626952.464 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-03-10T17:15:52.471Z,1741626952.471 [Default:E.Execute](DEBUG): Construct Execute. 2025-03-10T17:15:52.494Z,1741626952.494 [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-03-10T17:15:52.499Z,1741626952.499 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,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-03-10T17:15:52.542Z,1741626952.542 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-03-10T17:15:52.609Z,1741626952.609 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m 2025-03-10T17:15:52.613Z,1741626952.613 [Power24vConverter](INFO): Powering up. 2025-03-10T17:15:52.614Z,1741626952.614 [Sonardyne_Nano](INFO): Initializing. 2025-03-10T17:15:52.640Z,1741626952.640 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-03-10T17:15:52.669Z,1741626952.669 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-03-10T17:15:52.676Z,1741626952.676 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-03-10T17:15:52.677Z,1741626952.677 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-03-10T17:15:52.685Z,1741626952.685 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-03-10T17:15:52.686Z,1741626952.686 [MassServo](DEBUG): Initializing EZServoServo. 2025-03-10T17:15:52.692Z,1741626952.692 [MassServo](DEBUG): Initializing MassServo. 2025-03-10T17:15:52.693Z,1741626952.693 [RudderServo](DEBUG): Initializing EZServoServo. 2025-03-10T17:15:52.700Z,1741626952.700 [RudderServo](DEBUG): Initializing RudderServo. 2025-03-10T17:15:52.701Z,1741626952.701 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-03-10T17:15:52.708Z,1741626952.708 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-03-10T17:15:54.336Z,1741626954.336 [WetLabsBB2FL](INFO): Powering down 2025-03-10T17:15:54.935Z,1741626954.935 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-03-10T17:15:56.173Z,1741626956.173 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2213 2025-03-10T17:15:58.772Z,1741626958.772 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-03-10T17:16:03.833Z,1741626963.833 [DAT](INFO): DAT read: 2025-03-10T17:16:03.834Z,1741626963.834 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-03-10T17:16:05.597Z,1741626965.597 [DAT](INFO): DAT read: MF Frequency Band 2025-03-10T17:16:05.598Z,1741626965.598 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-03-10T17:16:05.599Z,1741626965.599 [DAT](INFO): DAT read: Mar 10 2025 17:15:59 2025-03-10T17:16:06.605Z,1741626966.605 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-03-10T17:16:06.606Z,1741626966.606 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC 2025-03-10T17:16:06.607Z,1741626966.607 [DAT](INFO): commRate: 1200 2025-03-10T17:16:08.672Z,1741626968.672 [DAT](INFO): entering command mode 2025-03-10T17:16:08.873Z,1741626968.873 [DAT](INFO): DAT read: 2025-03-10T17:16:08.873Z,1741626968.873 [DAT](INFO): DAT read: user:1> 2025-03-10T17:16:08.874Z,1741626968.874 [DAT](INFO): setting verbose to 3 2025-03-10T17:16:09.126Z,1741626969.126 [DAT](INFO): DAT read: user:1> 2025-03-10T17:16:09.127Z,1741626969.127 [DAT](INFO): DAT read: Verbose | 3 2025-03-10T17:16:09.128Z,1741626969.128 [DAT](INFO): set verbose to 3 2025-03-10T17:16:09.128Z,1741626969.128 [DAT](INFO): setting DatVerbose to 27440 2025-03-10T17:16:09.377Z,1741626969.377 [DAT](INFO): DAT read: user:2> 2025-03-10T17:16:09.378Z,1741626969.378 [DAT](INFO): DAT read: DatVerbose | 27440 2025-03-10T17:16:09.378Z,1741626969.378 [DAT](INFO): set DatVerbose to 27440 2025-03-10T17:16:09.378Z,1741626969.378 [DAT](INFO): setting transmit power to 8 2025-03-10T17:16:09.629Z,1741626969.629 [DAT](INFO): DAT read: user:3> 2025-03-10T17:16:09.630Z,1741626969.630 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-03-10T17:16:09.630Z,1741626969.630 [DAT](INFO): set transmit power to 8 2025-03-10T17:16:09.630Z,1741626969.630 [DAT](INFO): setting local address to 5 2025-03-10T17:16:09.881Z,1741626969.881 [DAT](INFO): DAT read: user:4> 2025-03-10T17:16:09.882Z,1741626969.882 [DAT](INFO): DAT read: LocalAddr | 5 2025-03-10T17:16:09.882Z,1741626969.882 [DAT](INFO): set local address to 5 2025-03-10T17:16:09.883Z,1741626969.883 [DAT](INFO): Setting time to: 17:16:9 And date to:3/10/2025 2025-03-10T17:16:10.133Z,1741626970.133 [DAT](INFO): DAT read: user:5> 2025-03-10T17:16:10.134Z,1741626970.134 [DAT](INFO): DAT read: Mon Mar 10, 2025 17:16:09 2025-03-10T17:16:10.134Z,1741626970.134 [DAT](INFO): Local DAT time set to Mon Mar 10, 2025 17:16:09 2025-03-10T17:16:21.229Z,1741626981.229 [NAL9602](INFO): Powering up NAL9602 2025-03-10T17:16:32.123Z,1741626992.123 [NAL9602](INFO): NAL9602 initialized 2025-03-10T17:17:00.467Z,1741627020.467 [SBIT](IMPORTANT): Beginning Startup BIT 2025-03-10T17:17:00.471Z,1741627020.471 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-03-10T17:17:04.931Z,1741627024.931 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.006146 CHAN A1 (24V): 0.041372 CHAN A2 (12V): -0.006623 CHAN A3 (5V): 0.003417 CHAN B0 (3.3V): -0.000692 CHAN B1 (3.15aV): -0.000964 CHAN B2 (3.15bV): -0.001767 CHAN B3 (GND): 0.002583 OPEN: 0.007034 Full Scale: +/- 1 mA 2025-03-10T17:17:54.232Z,1741627074.232 [SBIT](IMPORTANT): SBIT PASSED 2025-03-10T17:17:54.237Z,1741627074.237 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-03-10T17:17:54.237Z,1741627074.237 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2025-03-10T17:17:54.237Z,1741627074.237 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool; 2025-03-10T17:17:54.238Z,1741627074.238 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool; 2025-03-10T17:17:54.238Z,1741627074.238 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=214.355421 cubic_centimeter; 2025-03-10T17:17:54.238Z,1741627074.238 [SBIT](IMPORTANT): VerticalControl.massDefault=12.200269 millimeter; 2025-03-10T17:17:54.585Z,1741627074.585 [MissionManager](IMPORTANT): Started mission Startup 2025-03-10T17:17:54.585Z,1741627074.585 [Startup] Running Loop=1 2025-03-10T17:17:54.585Z,1741627074.585 [Startup](DEBUG): Aggregate::initialize Startup 2025-03-10T17:17:54.585Z,1741627074.585 [Startup:A.GoToSurface] Running Loop=1 2025-03-10T17:17:54.585Z,1741627074.585 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-10T17:17:54.586Z,1741627074.586 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-10T17:17:54.586Z,1741627074.586 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-10T17:17:54.587Z,1741627074.587 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-10T17:17:54.587Z,1741627074.587 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-10T17:17:54.587Z,1741627074.587 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-10T17:17:54.588Z,1741627074.588 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-10T17:17:54.619Z,1741627074.619 [Startup:StartupSatComms] Running Loop=1 2025-03-10T17:17:54.619Z,1741627074.619 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-03-10T17:17:54.619Z,1741627074.619 [Startup:StartupSatComms:A] Running Loop=1 2025-03-10T17:17:54.994Z,1741627074.994 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-03-10T17:18:03.638Z,1741627083.638 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004120 2025-03-10T17:18:51.989Z,1741627131.989 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-03-10T17:18:51.989Z,1741627131.989 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:18:52.000Z,1741627132.000 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:18:52.426Z,1741627132.426 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:18:52.426Z,1741627132.426 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-03-10T17:18:54.778Z,1741627134.778 [Startup:StartupSatComms:A](INFO): Timed out from 2025-03-10T17:17:54.6Z 2025-03-10T17:18:54.778Z,1741627134.778 [Startup:StartupSatComms:A] Stopped 2025-03-10T17:18:54.778Z,1741627134.778 [Startup:StartupSatComms:B] Running Loop=1 2025-03-10T17:18:55.188Z,1741627135.188 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-10T17:19:02.536Z,1741627142.536 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20250310T155613/Courier0025.lzma 2025-03-10T17:19:03.539Z,1741627143.539 [DataOverHttps](INFO): Moved sent file to Logs/20250310T155613/Courier0025.lzma.bak 2025-03-10T17:19:03.539Z,1741627143.539 [DataOverHttps](INFO): SBD MOMSN=24149381 2025-03-10T17:19:19.285Z,1741627159.285 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250310T171539/Courier0000.lzma 2025-03-10T17:19:20.286Z,1741627160.286 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0000.lzma.bak 2025-03-10T17:19:20.286Z,1741627160.286 [DataOverHttps](INFO): SBD MOMSN=24149383 2025-03-10T17:19:36.052Z,1741627176.052 [DataOverHttps](INFO): Sending 330 bytes from file Logs/20250310T155613/Express0026.lzma 2025-03-10T17:19:37.054Z,1741627177.054 [DataOverHttps](INFO): Moved sent file to Logs/20250310T155613/Express0026.lzma.bak 2025-03-10T17:19:37.054Z,1741627177.054 [DataOverHttps](INFO): SBD MOMSN=24149386 2025-03-10T17:19:52.870Z,1741627192.870 [DataOverHttps](INFO): Sending 818 bytes from file Logs/20250310T171539/Express0001.lzma 2025-03-10T17:19:53.870Z,1741627193.870 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0001.lzma.bak 2025-03-10T17:19:53.870Z,1741627193.870 [DataOverHttps](INFO): SBD MOMSN=24149398 2025-03-10T17:19:54.999Z,1741627194.999 [Startup:StartupSatComms:B](INFO): Timed out from 2025-03-10T17:18:54.8Z 2025-03-10T17:19:54.999Z,1741627194.999 [Startup:StartupSatComms:B] Stopped 2025-03-10T17:19:54.999Z,1741627194.999 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-03-10T17:19:54.999Z,1741627194.999 [Startup:StartupSatComms] Stopped 2025-03-10T17:19:54.999Z,1741627194.999 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-03-10T17:19:55.001Z,1741627195.001 [Startup](INFO): Completed Startup 2025-03-10T17:19:55.001Z,1741627195.001 [MissionManager](INFO): Startup is completed. 2025-03-10T17:19:55.001Z,1741627195.001 [MissionManager](INFO): Uninitializing Mission Startup 2025-03-10T17:19:55.001Z,1741627195.001 [Startup] Stopped 2025-03-10T17:19:55.001Z,1741627195.001 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-03-10T17:19:55.001Z,1741627195.001 [Startup:A.GoToSurface] Stopped 2025-03-10T17:19:55.001Z,1741627195.001 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-10T17:19:55.401Z,1741627195.401 [MissionManager](IMPORTANT): Started mission Default 2025-03-10T17:19:55.402Z,1741627195.402 [Default] Running Loop=1 2025-03-10T17:19:55.402Z,1741627195.402 [Default](DEBUG): Aggregate::initialize Default 2025-03-10T17:19:55.402Z,1741627195.402 [Default:B.GoToSurface] Running Loop=1 2025-03-10T17:19:55.402Z,1741627195.402 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-10T17:19:55.402Z,1741627195.402 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-10T17:19:55.402Z,1741627195.402 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-10T17:19:55.403Z,1741627195.403 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-10T17:19:55.403Z,1741627195.403 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-10T17:19:55.403Z,1741627195.403 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-10T17:19:55.404Z,1741627195.404 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-10T17:19:55.404Z,1741627195.404 [Default:A.Wait] Running Loop=1 2025-03-10T17:19:55.404Z,1741627195.404 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-03-10T17:20:06.704Z,1741627206.704 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-03-10T17:20:08.723Z,1741627208.723 [Default:A.Wait](INFO): Done Waiting. 2025-03-10T17:20:08.723Z,1741627208.723 [Default:A.Wait] Stopped 2025-03-10T17:20:08.723Z,1741627208.723 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T17:20:09.134Z,1741627209.134 [Default:CheckIn] Running Loop=1 2025-03-10T17:20:09.135Z,1741627209.135 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T17:20:09.135Z,1741627209.135 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T17:20:09.543Z,1741627209.543 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-03-10T17:21:35.171Z,1741627295.171 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-03-10T17:21:53.020Z,1741627313.020 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-03-10T17:21:53.020Z,1741627313.020 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:21:53.054Z,1741627313.054 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:21:53.391Z,1741627313.391 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:21:53.391Z,1741627313.391 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-03-10T17:23:26.329Z,1741627406.329 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6. 2025-03-10T17:23:26.337Z,1741627406.337 [BPC1](INFO): Received data from all battery sticks. 2025-03-10T17:24:53.963Z,1741627493.963 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-03-10T17:24:53.963Z,1741627493.963 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:24:53.979Z,1741627493.979 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:24:54.403Z,1741627494.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:24:54.403Z,1741627494.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-03-10T17:25:09.332Z,1741627509.332 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T17:20:09.1Z 2025-03-10T17:25:09.332Z,1741627509.332 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T17:25:09.332Z,1741627509.332 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T17:25:09.725Z,1741627509.725 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-10T17:25:16.460Z,1741627516.460 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250310T171539/Courier0004.lzma 2025-03-10T17:25:17.462Z,1741627517.462 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0004.lzma.bak 2025-03-10T17:25:17.462Z,1741627517.462 [DataOverHttps](INFO): SBD MOMSN=24149431 2025-03-10T17:25:33.409Z,1741627533.409 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20250310T171539/Express0005.lzma 2025-03-10T17:25:34.410Z,1741627534.410 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0005.lzma.bak 2025-03-10T17:25:34.410Z,1741627534.410 [DataOverHttps](INFO): SBD MOMSN=24149433 2025-03-10T17:25:35.589Z,1741627535.589 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T17:25:35.590Z,1741627535.590 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T17:25:35.590Z,1741627535.590 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T17:26:33.331Z,1741627593.330 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T17:26:33.331Z,1741627593.331 [NAL9602] Data Fault, FailCount= 1 2025-03-10T17:26:33.331Z,1741627593.331 [NAL9602](ERROR): Data Fault 2025-03-10T17:26:33.347Z,1741627593.347 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T17:26:33.730Z,1741627593.730 [NAL9602](INFO): Powering down 2025-03-10T17:26:34.554Z,1741627594.554 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T17:26:34.554Z,1741627594.554 [NAL9602] No Fault, FailCount= 1 2025-03-10T17:27:04.031Z,1741627624.031 [NAL9602](INFO): Powering up NAL9602 2025-03-10T17:27:14.955Z,1741627634.955 [NAL9602](INFO): NAL9602 initialized 2025-03-10T17:27:54.969Z,1741627674.969 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-03-10T17:27:54.969Z,1741627674.969 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:27:55.015Z,1741627675.015 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:27:55.363Z,1741627675.363 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:27:55.363Z,1741627675.363 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-03-10T17:30:36.161Z,1741627836.161 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T17:30:36.161Z,1741627836.161 [Default:CheckIn:C.Wait] Stopped 2025-03-10T17:30:36.161Z,1741627836.161 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T17:30:36.161Z,1741627836.161 [Default:CheckIn:D] Running Loop=1 2025-03-10T17:30:36.570Z,1741627836.570 [Default:CheckIn:D] Stopped 2025-03-10T17:30:36.570Z,1741627836.570 [Default:CheckIn:E] Running Loop=1 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.686131 min 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn:E] Stopped 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn] Stopped 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn](INFO): Running loop #2 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn] Running Loop=2 2025-03-10T17:30:36.986Z,1741627836.986 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T17:30:36.987Z,1741627836.987 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T17:30:55.945Z,1741627855.945 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2025-03-10T17:30:55.945Z,1741627855.945 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:30:55.999Z,1741627855.999 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:30:56.358Z,1741627856.358 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:30:56.358Z,1741627856.358 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2025-03-10T17:33:56.924Z,1741628036.924 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2025-03-10T17:33:56.925Z,1741628036.925 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:33:56.935Z,1741628036.935 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:33:57.349Z,1741628037.349 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:33:57.349Z,1741628037.349 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2025-03-10T17:35:37.154Z,1741628137.154 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T17:30:36.0Z 2025-03-10T17:35:37.154Z,1741628137.154 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T17:35:37.154Z,1741628137.154 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T17:35:47.689Z,1741628147.689 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250310T171539/Courier0007.lzma 2025-03-10T17:35:48.690Z,1741628148.690 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0007.lzma.bak 2025-03-10T17:35:48.690Z,1741628148.690 [DataOverHttps](INFO): SBD MOMSN=24149456 2025-03-10T17:36:06.364Z,1741628166.364 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20250310T171539/Express0008.lzma 2025-03-10T17:36:07.366Z,1741628167.366 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0008.lzma.bak 2025-03-10T17:36:07.366Z,1741628167.366 [DataOverHttps](INFO): SBD MOMSN=24149458 2025-03-10T17:36:08.633Z,1741628168.633 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T17:36:08.633Z,1741628168.633 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T17:36:08.634Z,1741628168.634 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T17:36:57.914Z,1741628217.914 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2025-03-10T17:36:57.914Z,1741628217.914 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:36:57.926Z,1741628217.926 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:36:58.339Z,1741628218.339 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:36:58.339Z,1741628218.339 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2025-03-10T17:37:16.899Z,1741628236.899 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T17:37:16.899Z,1741628236.899 [NAL9602] Data Fault, FailCount= 2 2025-03-10T17:37:16.899Z,1741628236.899 [NAL9602](ERROR): Data Fault 2025-03-10T17:37:16.916Z,1741628236.916 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T17:37:17.304Z,1741628237.304 [NAL9602](INFO): Powering down 2025-03-10T17:37:18.160Z,1741628238.160 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T17:37:18.161Z,1741628238.161 [NAL9602] No Fault, FailCount= 2 2025-03-10T17:37:47.612Z,1741628267.612 [NAL9602](INFO): Powering up NAL9602 2025-03-10T17:37:58.511Z,1741628278.511 [NAL9602](INFO): NAL9602 initialized 2025-03-10T17:39:58.909Z,1741628398.909 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2025-03-10T17:39:58.909Z,1741628398.909 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:39:58.920Z,1741628398.920 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:39:59.325Z,1741628399.325 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:39:59.325Z,1741628399.325 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2025-03-10T17:41:09.277Z,1741628469.277 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T17:41:09.277Z,1741628469.277 [Default:CheckIn:C.Wait] Stopped 2025-03-10T17:41:09.277Z,1741628469.277 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T17:41:09.277Z,1741628469.277 [Default:CheckIn:D] Running Loop=1 2025-03-10T17:41:09.733Z,1741628469.733 [Default:CheckIn:D] Stopped 2025-03-10T17:41:09.733Z,1741628469.733 [Default:CheckIn:E] Running Loop=1 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.238851 min 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn:E] Stopped 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn] Stopped 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn](INFO): Running loop #3 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn] Running Loop=3 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T17:41:10.115Z,1741628470.115 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T17:43:00.036Z,1741628580.036 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2025-03-10T17:43:00.036Z,1741628580.036 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:43:00.047Z,1741628580.047 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:43:00.434Z,1741628580.434 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:43:00.434Z,1741628580.434 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2025-03-10T17:46:01.037Z,1741628761.037 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2025-03-10T17:46:01.037Z,1741628761.037 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:46:01.048Z,1741628761.048 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:46:01.450Z,1741628761.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:46:01.450Z,1741628761.450 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2025-03-10T17:46:10.357Z,1741628770.357 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T17:41:10.1Z 2025-03-10T17:46:10.357Z,1741628770.357 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T17:46:10.357Z,1741628770.357 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T17:46:17.556Z,1741628777.556 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250310T171539/Courier0010.lzma 2025-03-10T17:46:18.558Z,1741628778.558 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0010.lzma.bak 2025-03-10T17:46:18.558Z,1741628778.558 [DataOverHttps](INFO): SBD MOMSN=24149480 2025-03-10T17:46:36.256Z,1741628796.256 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250310T171539/Express0011.lzma 2025-03-10T17:46:37.258Z,1741628797.258 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0011.lzma.bak 2025-03-10T17:46:37.258Z,1741628797.258 [DataOverHttps](INFO): SBD MOMSN=24149482 2025-03-10T17:46:38.622Z,1741628798.622 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T17:46:38.622Z,1741628798.622 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T17:46:38.622Z,1741628798.622 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T17:47:59.790Z,1741628879.790 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T17:47:59.790Z,1741628879.790 [NAL9602] Data Fault, FailCount= 3 2025-03-10T17:47:59.791Z,1741628879.791 [NAL9602](ERROR): Data Fault 2025-03-10T17:47:59.807Z,1741628879.807 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T17:48:00.200Z,1741628880.200 [NAL9602](INFO): Powering down 2025-03-10T17:48:01.015Z,1741628881.015 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T17:48:01.015Z,1741628881.015 [NAL9602] No Fault, FailCount= 3 2025-03-10T17:48:30.508Z,1741628910.508 [NAL9602](INFO): Powering up NAL9602 2025-03-10T17:48:41.399Z,1741628921.399 [NAL9602](INFO): NAL9602 initialized 2025-03-10T17:49:02.025Z,1741628942.025 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2025-03-10T17:49:02.025Z,1741628942.025 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:49:02.036Z,1741628942.036 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:49:02.441Z,1741628942.441 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:49:02.441Z,1741628942.441 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2025-03-10T17:51:39.213Z,1741629099.213 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T17:51:39.214Z,1741629099.214 [Default:CheckIn:C.Wait] Stopped 2025-03-10T17:51:39.214Z,1741629099.214 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T17:51:39.214Z,1741629099.214 [Default:CheckIn:D] Running Loop=1 2025-03-10T17:51:39.610Z,1741629099.610 [Default:CheckIn:D] Stopped 2025-03-10T17:51:39.610Z,1741629099.610 [Default:CheckIn:E] Running Loop=1 2025-03-10T17:51:40.030Z,1741629100.030 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.736798 min 2025-03-10T17:51:40.030Z,1741629100.030 [Default:CheckIn:E] Stopped 2025-03-10T17:51:40.030Z,1741629100.030 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T17:51:40.030Z,1741629100.030 [Default:CheckIn] Stopped 2025-03-10T17:51:40.030Z,1741629100.030 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T17:51:40.031Z,1741629100.031 [Default:CheckIn](INFO): Running loop #4 2025-03-10T17:51:40.031Z,1741629100.031 [Default:CheckIn] Running Loop=4 2025-03-10T17:51:40.031Z,1741629100.031 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T17:51:40.031Z,1741629100.031 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T17:52:03.037Z,1741629123.037 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2025-03-10T17:52:03.037Z,1741629123.037 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:52:03.072Z,1741629123.072 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:52:03.450Z,1741629123.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:52:03.450Z,1741629123.450 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2025-03-10T17:55:04.040Z,1741629304.040 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2025-03-10T17:55:04.040Z,1741629304.040 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:55:04.051Z,1741629304.051 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:55:04.446Z,1741629304.446 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:55:04.446Z,1741629304.446 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2025-03-10T17:56:40.172Z,1741629400.172 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T17:51:40.0Z 2025-03-10T17:56:40.172Z,1741629400.172 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T17:56:40.172Z,1741629400.172 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T17:56:49.484Z,1741629409.484 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250310T171539/Courier0013.lzma 2025-03-10T17:56:50.486Z,1741629410.486 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0013.lzma.bak 2025-03-10T17:56:50.486Z,1741629410.486 [DataOverHttps](INFO): SBD MOMSN=24149544 2025-03-10T17:57:06.296Z,1741629426.296 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250310T171539/Express0014.lzma 2025-03-10T17:57:07.298Z,1741629427.298 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0014.lzma.bak 2025-03-10T17:57:07.298Z,1741629427.298 [DataOverHttps](INFO): SBD MOMSN=24149546 2025-03-10T17:57:08.447Z,1741629428.447 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T17:57:08.447Z,1741629428.447 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T17:57:08.447Z,1741629428.447 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T17:58:05.001Z,1741629485.001 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2025-03-10T17:58:05.001Z,1741629485.001 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T17:58:05.012Z,1741629485.012 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T17:58:05.418Z,1741629485.418 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T17:58:05.418Z,1741629485.418 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2025-03-10T17:58:43.808Z,1741629523.808 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T17:58:43.828Z,1741629523.828 [NAL9602] Data Fault, FailCount= 4 2025-03-10T17:58:43.828Z,1741629523.828 [NAL9602](ERROR): Data Fault 2025-03-10T17:58:43.895Z,1741629523.895 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T17:58:44.186Z,1741629524.186 [NAL9602](INFO): Powering down 2025-03-10T17:58:45.018Z,1741629525.018 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T17:58:45.018Z,1741629525.018 [NAL9602] No Fault, FailCount= 4 2025-03-10T17:59:14.486Z,1741629554.486 [NAL9602](INFO): Powering up NAL9602 2025-03-10T17:59:25.388Z,1741629565.388 [NAL9602](INFO): NAL9602 initialized 2025-03-10T18:01:06.143Z,1741629666.143 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2025-03-10T18:01:06.143Z,1741629666.143 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:01:06.162Z,1741629666.162 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:01:06.534Z,1741629666.534 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:01:06.534Z,1741629666.534 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2025-03-10T18:02:09.149Z,1741629729.149 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T18:02:09.150Z,1741629729.150 [Default:CheckIn:C.Wait] Stopped 2025-03-10T18:02:09.150Z,1741629729.150 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T18:02:09.150Z,1741629729.150 [Default:CheckIn:D] Running Loop=1 2025-03-10T18:02:09.555Z,1741629729.555 [Default:CheckIn:D] Stopped 2025-03-10T18:02:09.555Z,1741629729.555 [Default:CheckIn:E] Running Loop=1 2025-03-10T18:02:09.935Z,1741629729.935 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.235889 min 2025-03-10T18:02:09.935Z,1741629729.935 [Default:CheckIn:E] Stopped 2025-03-10T18:02:09.935Z,1741629729.935 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T18:02:09.935Z,1741629729.935 [Default:CheckIn] Stopped 2025-03-10T18:02:09.936Z,1741629729.936 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:02:09.936Z,1741629729.936 [Default:CheckIn](INFO): Running loop #5 2025-03-10T18:02:09.936Z,1741629729.936 [Default:CheckIn] Running Loop=5 2025-03-10T18:02:09.936Z,1741629729.936 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T18:02:09.936Z,1741629729.936 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T18:04:07.128Z,1741629847.128 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2025-03-10T18:04:07.129Z,1741629847.129 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:04:07.139Z,1741629847.139 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:04:07.538Z,1741629847.538 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:04:07.538Z,1741629847.538 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2025-03-10T18:07:08.097Z,1741630028.097 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2025-03-10T18:07:08.097Z,1741630028.097 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:07:08.135Z,1741630028.135 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:07:08.520Z,1741630028.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:07:08.520Z,1741630028.520 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2025-03-10T18:07:10.148Z,1741630030.148 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T18:02:09.9Z 2025-03-10T18:07:10.148Z,1741630030.148 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T18:07:10.148Z,1741630030.148 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T18:07:19.321Z,1741630039.321 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250310T171539/Courier0016.lzma 2025-03-10T18:07:20.322Z,1741630040.322 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0016.lzma.bak 2025-03-10T18:07:20.322Z,1741630040.322 [DataOverHttps](INFO): SBD MOMSN=24149570 2025-03-10T18:07:36.136Z,1741630056.136 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250310T171539/Express0017.lzma 2025-03-10T18:07:37.138Z,1741630057.138 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0017.lzma.bak 2025-03-10T18:07:37.138Z,1741630057.138 [DataOverHttps](INFO): SBD MOMSN=24149572 2025-03-10T18:07:38.405Z,1741630058.405 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T18:07:38.405Z,1741630058.405 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T18:07:38.405Z,1741630058.405 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T18:09:27.875Z,1741630167.875 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T18:09:27.875Z,1741630167.875 [NAL9602] Data Fault, FailCount= 5 2025-03-10T18:09:27.875Z,1741630167.875 [NAL9602](ERROR): Data Fault 2025-03-10T18:09:27.926Z,1741630167.926 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T18:09:27.926Z,1741630167.926 [CBIT](CRITICAL): Data Fault in component: NAL9602 2025-03-10T18:09:28.282Z,1741630168.282 [NAL9602](INFO): Powering down 2025-03-10T18:09:28.297Z,1741630168.297 [CommandExec](FAULT): Scheduling is paused 2025-03-10T18:09:28.297Z,1741630168.297 [CBIT](INFO): Critical error at 20250310T180927 2025-03-10T18:09:28.297Z,1741630168.297 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2025-03-10T18:09:28.690Z,1741630168.690 [NAL9602](FAULT): LCB fault: LCB Watchdog Reset. Hardware Overcurrent Shutdown. Current Limiter Activated. 2025-03-10T18:09:28.690Z,1741630168.690 [NAL9602] Hardware Fault, FailCount= 5 2025-03-10T18:09:28.690Z,1741630168.690 [NAL9602](ERROR): Hardware Fault 2025-03-10T18:10:09.092Z,1741630209.092 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2025-03-10T18:10:09.092Z,1741630209.092 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:10:09.149Z,1741630209.149 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:10:09.536Z,1741630209.536 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:10:09.537Z,1741630209.537 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2025-03-10T18:11:27.894Z,1741630287.894 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T18:11:27.894Z,1741630287.894 [NAL9602] No Fault, FailCount= 5 2025-03-10T18:11:28.263Z,1741630288.263 [NAL9602](INFO): Powering up NAL9602 2025-03-10T18:11:39.175Z,1741630299.175 [NAL9602](INFO): NAL9602 initialized 2025-03-10T18:12:38.975Z,1741630358.975 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T18:12:38.975Z,1741630358.975 [Default:CheckIn:C.Wait] Stopped 2025-03-10T18:12:38.975Z,1741630358.975 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T18:12:38.975Z,1741630358.975 [Default:CheckIn:D] Running Loop=1 2025-03-10T18:12:39.387Z,1741630359.387 [Default:CheckIn:D] Stopped 2025-03-10T18:12:39.388Z,1741630359.388 [Default:CheckIn:E] Running Loop=1 2025-03-10T18:12:39.782Z,1741630359.782 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.733093 min 2025-03-10T18:12:39.782Z,1741630359.782 [Default:CheckIn:E] Stopped 2025-03-10T18:12:39.782Z,1741630359.782 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T18:12:39.783Z,1741630359.783 [Default:CheckIn] Stopped 2025-03-10T18:12:39.783Z,1741630359.783 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:12:39.783Z,1741630359.783 [Default:CheckIn](INFO): Running loop #6 2025-03-10T18:12:39.783Z,1741630359.783 [Default:CheckIn] Running Loop=6 2025-03-10T18:12:39.783Z,1741630359.783 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T18:12:39.783Z,1741630359.783 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T18:13:10.089Z,1741630390.089 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2025-03-10T18:13:10.089Z,1741630390.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:13:10.116Z,1741630390.116 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:13:10.518Z,1741630390.518 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:13:10.518Z,1741630390.518 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2025-03-10T18:16:11.081Z,1741630571.081 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2025-03-10T18:16:11.081Z,1741630571.081 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:16:11.091Z,1741630571.091 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:16:11.510Z,1741630571.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:16:11.510Z,1741630571.510 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2025-03-10T18:17:39.971Z,1741630659.971 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T18:12:39.8Z 2025-03-10T18:17:39.971Z,1741630659.971 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T18:17:39.971Z,1741630659.971 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T18:17:47.610Z,1741630667.610 [DataOverHttps](INFO): Sending 106 bytes from file Logs/20250310T171539/Courier0019.lzma 2025-03-10T18:17:48.610Z,1741630668.610 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0019.lzma.bak 2025-03-10T18:17:48.610Z,1741630668.610 [DataOverHttps](INFO): SBD MOMSN=24149597 2025-03-10T18:18:04.444Z,1741630684.444 [DataOverHttps](INFO): Sending 274 bytes from file Logs/20250310T171539/Express0020.lzma 2025-03-10T18:18:05.446Z,1741630685.446 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0020.lzma.bak 2025-03-10T18:18:05.446Z,1741630685.446 [DataOverHttps](INFO): SBD MOMSN=24149600 2025-03-10T18:18:06.633Z,1741630686.633 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T18:18:06.633Z,1741630686.633 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T18:18:06.634Z,1741630686.634 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T18:19:12.100Z,1741630752.100 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2025-03-10T18:19:12.100Z,1741630752.100 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:19:12.119Z,1741630752.119 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:19:12.530Z,1741630752.530 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:19:12.530Z,1741630752.530 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2025-03-10T18:21:41.590Z,1741630901.590 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T18:21:41.590Z,1741630901.590 [NAL9602] Data Fault, FailCount= 1 2025-03-10T18:21:41.590Z,1741630901.590 [NAL9602](ERROR): Data Fault 2025-03-10T18:21:41.670Z,1741630901.670 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T18:21:42.002Z,1741630902.002 [NAL9602](INFO): Powering down 2025-03-10T18:21:42.849Z,1741630902.849 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T18:21:42.849Z,1741630902.849 [NAL9602] No Fault, FailCount= 1 2025-03-10T18:22:12.306Z,1741630932.306 [NAL9602](INFO): Powering up NAL9602 2025-03-10T18:22:13.113Z,1741630933.113 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2025-03-10T18:22:13.113Z,1741630933.113 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:22:13.159Z,1741630933.159 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:22:13.541Z,1741630933.541 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:22:13.541Z,1741630933.541 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2025-03-10T18:22:23.199Z,1741630943.199 [NAL9602](INFO): NAL9602 initialized 2025-03-10T18:23:07.238Z,1741630987.238 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T18:23:07.238Z,1741630987.238 [Default:CheckIn:C.Wait] Stopped 2025-03-10T18:23:07.238Z,1741630987.238 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T18:23:07.238Z,1741630987.238 [Default:CheckIn:D] Running Loop=1 2025-03-10T18:23:07.676Z,1741630987.676 [Default:CheckIn:D] Stopped 2025-03-10T18:23:07.677Z,1741630987.677 [Default:CheckIn:E] Running Loop=1 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.204578 min 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn:E] Stopped 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn] Stopped 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn](INFO): Running loop #7 2025-03-10T18:23:08.087Z,1741630988.087 [Default:CheckIn] Running Loop=7 2025-03-10T18:23:08.088Z,1741630988.088 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T18:23:08.088Z,1741630988.088 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T18:25:14.125Z,1741631114.125 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2025-03-10T18:25:14.125Z,1741631114.125 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:25:14.135Z,1741631114.135 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:25:14.534Z,1741631114.534 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:25:14.534Z,1741631114.534 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2025-03-10T18:28:08.269Z,1741631288.269 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T18:23:08.1Z 2025-03-10T18:28:08.269Z,1741631288.269 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T18:28:08.269Z,1741631288.269 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T18:28:15.108Z,1741631295.108 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2025-03-10T18:28:15.108Z,1741631295.108 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:28:15.119Z,1741631295.119 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:28:15.260Z,1741631295.260 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250310T171539/Courier0022.lzma 2025-03-10T18:28:15.515Z,1741631295.515 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:28:15.515Z,1741631295.515 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2025-03-10T18:28:16.262Z,1741631296.262 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0022.lzma.bak 2025-03-10T18:28:16.262Z,1741631296.262 [DataOverHttps](INFO): SBD MOMSN=24149627 2025-03-10T18:28:34.041Z,1741631314.041 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250310T171539/Express0023.lzma 2025-03-10T18:28:35.042Z,1741631315.042 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0023.lzma.bak 2025-03-10T18:28:35.042Z,1741631315.042 [DataOverHttps](INFO): SBD MOMSN=24149629 2025-03-10T18:28:36.125Z,1741631316.125 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T18:28:36.125Z,1741631316.125 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T18:28:36.126Z,1741631316.126 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T18:31:03.956Z,1741631463.956 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6. 2025-03-10T18:31:03.958Z,1741631463.958 [BPC1](INFO): Received data from all battery sticks. 2025-03-10T18:31:16.105Z,1741631476.105 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2025-03-10T18:31:16.105Z,1741631476.105 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:31:16.165Z,1741631476.165 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:31:16.541Z,1741631476.541 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:31:16.541Z,1741631476.541 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2025-03-10T18:32:24.347Z,1741631544.347 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T18:32:24.347Z,1741631544.347 [NAL9602] Data Fault, FailCount= 2 2025-03-10T18:32:24.347Z,1741631544.347 [NAL9602](ERROR): Data Fault 2025-03-10T18:32:24.363Z,1741631544.363 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T18:32:24.755Z,1741631544.755 [NAL9602](INFO): Powering down 2025-03-10T18:32:25.615Z,1741631545.615 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T18:32:25.615Z,1741631545.615 [NAL9602] No Fault, FailCount= 2 2025-03-10T18:32:55.064Z,1741631575.064 [NAL9602](INFO): Powering up NAL9602 2025-03-10T18:33:05.966Z,1741631585.966 [NAL9602](INFO): NAL9602 initialized 2025-03-10T18:33:36.671Z,1741631616.671 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T18:33:36.671Z,1741631616.671 [Default:CheckIn:C.Wait] Stopped 2025-03-10T18:33:36.671Z,1741631616.671 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T18:33:36.671Z,1741631616.671 [Default:CheckIn:D] Running Loop=1 2025-03-10T18:33:37.089Z,1741631617.089 [Default:CheckIn:D] Stopped 2025-03-10T18:33:37.089Z,1741631617.089 [Default:CheckIn:E] Running Loop=1 2025-03-10T18:33:37.492Z,1741631617.492 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.694784 min 2025-03-10T18:33:37.508Z,1741631617.508 [Default:CheckIn:E] Stopped 2025-03-10T18:33:37.508Z,1741631617.508 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T18:33:37.508Z,1741631617.508 [Default:CheckIn] Stopped 2025-03-10T18:33:37.508Z,1741631617.508 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:33:37.509Z,1741631617.509 [Default:CheckIn](INFO): Running loop #8 2025-03-10T18:33:37.509Z,1741631617.509 [Default:CheckIn] Running Loop=8 2025-03-10T18:33:37.509Z,1741631617.509 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T18:33:37.509Z,1741631617.509 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T18:34:17.091Z,1741631657.091 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2025-03-10T18:34:17.091Z,1741631657.091 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:34:17.172Z,1741631657.172 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:34:17.500Z,1741631657.500 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:34:17.500Z,1741631657.500 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2025-03-10T18:37:18.101Z,1741631838.101 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2025-03-10T18:37:18.101Z,1741631838.101 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:37:18.163Z,1741631838.163 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:37:18.510Z,1741631838.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:37:18.510Z,1741631838.510 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2025-03-10T18:38:37.691Z,1741631917.691 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T18:33:37.5Z 2025-03-10T18:38:37.691Z,1741631917.691 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T18:38:37.691Z,1741631917.691 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T18:38:44.604Z,1741631924.604 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20250310T171539/Courier0025.lzma 2025-03-10T18:38:45.606Z,1741631925.606 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0025.lzma.bak 2025-03-10T18:38:45.606Z,1741631925.606 [DataOverHttps](INFO): SBD MOMSN=24149664 2025-03-10T18:39:01.280Z,1741631941.280 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250310T171539/Express0026.lzma 2025-03-10T18:39:02.282Z,1741631942.282 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0026.lzma.bak 2025-03-10T18:39:02.282Z,1741631942.282 [DataOverHttps](INFO): SBD MOMSN=24149674 2025-03-10T18:39:03.557Z,1741631943.557 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T18:39:03.558Z,1741631943.558 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T18:39:03.558Z,1741631943.558 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T18:40:19.109Z,1741632019.109 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2025-03-10T18:40:19.109Z,1741632019.109 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:40:19.120Z,1741632019.120 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:40:19.494Z,1741632019.494 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:40:19.494Z,1741632019.494 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2025-03-10T18:43:07.143Z,1741632187.143 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T18:43:07.143Z,1741632187.143 [NAL9602] Data Fault, FailCount= 3 2025-03-10T18:43:07.143Z,1741632187.143 [NAL9602](ERROR): Data Fault 2025-03-10T18:43:07.203Z,1741632187.203 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T18:43:07.547Z,1741632187.547 [NAL9602](INFO): Powering down 2025-03-10T18:43:08.372Z,1741632188.372 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T18:43:08.372Z,1741632188.372 [NAL9602] No Fault, FailCount= 3 2025-03-10T18:43:20.082Z,1741632200.082 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2025-03-10T18:43:20.082Z,1741632200.082 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:43:20.092Z,1741632200.092 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:43:20.509Z,1741632200.509 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:43:20.509Z,1741632200.509 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2025-03-10T18:43:37.865Z,1741632217.865 [NAL9602](INFO): Powering up NAL9602 2025-03-10T18:43:48.764Z,1741632228.764 [NAL9602](INFO): NAL9602 initialized 2025-03-10T18:44:04.137Z,1741632244.137 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T18:44:04.138Z,1741632244.138 [Default:CheckIn:C.Wait] Stopped 2025-03-10T18:44:04.138Z,1741632244.138 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T18:44:04.138Z,1741632244.138 [Default:CheckIn:D] Running Loop=1 2025-03-10T18:44:04.558Z,1741632244.558 [Default:CheckIn:D] Stopped 2025-03-10T18:44:04.558Z,1741632244.558 [Default:CheckIn:E] Running Loop=1 2025-03-10T18:44:04.942Z,1741632244.942 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.152596 min 2025-03-10T18:44:04.942Z,1741632244.942 [Default:CheckIn:E] Stopped 2025-03-10T18:44:04.942Z,1741632244.942 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T18:44:04.942Z,1741632244.942 [Default:CheckIn] Stopped 2025-03-10T18:44:04.942Z,1741632244.942 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:44:04.942Z,1741632244.942 [Default:CheckIn](INFO): Running loop #9 2025-03-10T18:44:04.943Z,1741632244.943 [Default:CheckIn] Running Loop=9 2025-03-10T18:44:04.943Z,1741632244.943 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T18:44:04.943Z,1741632244.943 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T18:46:21.101Z,1741632381.101 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2025-03-10T18:46:21.101Z,1741632381.101 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:46:21.111Z,1741632381.111 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:46:21.479Z,1741632381.479 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:46:21.479Z,1741632381.479 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2025-03-10T18:49:05.118Z,1741632545.118 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-10T18:44:04.9Z 2025-03-10T18:49:05.118Z,1741632545.118 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T18:49:05.118Z,1741632545.118 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-03-10T18:49:12.437Z,1741632552.437 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250310T171539/Courier0028.lzma 2025-03-10T18:49:13.438Z,1741632553.438 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Courier0028.lzma.bak 2025-03-10T18:49:13.438Z,1741632553.438 [DataOverHttps](INFO): SBD MOMSN=24149881 2025-03-10T18:49:22.064Z,1741632562.064 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2025-03-10T18:49:22.065Z,1741632562.065 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:49:22.075Z,1741632562.075 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:49:22.474Z,1741632562.474 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:49:22.474Z,1741632562.474 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2025-03-10T18:49:31.110Z,1741632571.110 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250310T171539/Express0029.lzma 2025-03-10T18:49:32.110Z,1741632572.110 [DataOverHttps](INFO): Moved sent file to Logs/20250310T171539/Express0029.lzma.bak 2025-03-10T18:49:32.110Z,1741632572.110 [DataOverHttps](INFO): SBD MOMSN=24149883 2025-03-10T18:49:33.409Z,1741632573.409 [Default:CheckIn:Read_Iridium] Stopped 2025-03-10T18:49:33.409Z,1741632573.409 [Default:CheckIn:C.Wait] Running Loop=1 2025-03-10T18:49:33.409Z,1741632573.409 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-03-10T18:52:23.125Z,1741632743.125 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2025-03-10T18:52:23.125Z,1741632743.125 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:52:23.135Z,1741632743.135 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:52:23.553Z,1741632743.553 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:52:23.553Z,1741632743.553 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2025-03-10T18:53:50.772Z,1741632830.772 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-03-10T18:53:50.773Z,1741632830.773 [NAL9602] Data Fault, FailCount= 4 2025-03-10T18:53:50.773Z,1741632830.773 [NAL9602](ERROR): Data Fault 2025-03-10T18:53:50.789Z,1741632830.789 [CBIT](ERROR): Data Fault in component: NAL9602 2025-03-10T18:53:51.170Z,1741632831.170 [NAL9602](INFO): Powering down 2025-03-10T18:53:51.995Z,1741632831.995 [CBIT](INFO): Clearing failed state for component NAL9602 2025-03-10T18:53:51.995Z,1741632831.995 [NAL9602] No Fault, FailCount= 4 2025-03-10T18:54:21.475Z,1741632861.475 [NAL9602](INFO): Powering up NAL9602 2025-03-10T18:54:32.379Z,1741632872.379 [NAL9602](INFO): NAL9602 initialized 2025-03-10T18:54:34.022Z,1741632874.022 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-03-10T18:54:34.023Z,1741632874.023 [Default:CheckIn:C.Wait] Stopped 2025-03-10T18:54:34.023Z,1741632874.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-03-10T18:54:34.023Z,1741632874.023 [Default:CheckIn:D] Running Loop=1 2025-03-10T18:54:34.419Z,1741632874.419 [Default:CheckIn:D] Stopped 2025-03-10T18:54:34.419Z,1741632874.420 [Default:CheckIn:E] Running Loop=1 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.650293 min 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn:E] Stopped 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn] Stopped 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn](INFO): Running loop #10 2025-03-10T18:54:34.810Z,1741632874.810 [Default:CheckIn] Running Loop=10 2025-03-10T18:54:34.811Z,1741632874.811 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-03-10T18:54:34.811Z,1741632874.811 [Default:CheckIn:Read_GPS] Running Loop=1 2025-03-10T18:55:24.113Z,1741632924.113 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2025-03-10T18:55:24.113Z,1741632924.113 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-03-10T18:55:24.123Z,1741632924.123 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-03-10T18:55:24.580Z,1741632924.580 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-03-10T18:55:24.580Z,1741632924.580 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2025-03-10T18:58:07.186Z,1741633087.186 [CommandExec](IMPORTANT): got command restart application 2025-03-10T18:58:08.188Z,1741633088.188 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:08.188Z,1741633088.188 [CommandExec](INFO): Uninitializing the command executive. 2025-03-10T18:58:08.189Z,1741633088.189 [CommandExec](INFO): Uninitializing the command scheduler. 2025-03-10T18:58:08.189Z,1741633088.189 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:08.376Z,1741633088.376 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-03-10T18:58:08.376Z,1741633088.376 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-03-10T18:58:08.376Z,1741633088.376 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:08.377Z,1741633088.377 [NavChartDb](INFO): Join timeout helper Thread ID is 1876 2025-03-10T18:58:08.380Z,1741633088.380 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:08.381Z,1741633088.381 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:08.396Z,1741633088.396 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-03-10T18:58:08.396Z,1741633088.396 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:08.397Z,1741633088.397 [Radio_Surface](INFO): Join timeout helper Thread ID is 1877 2025-03-10T18:58:08.664Z,1741633088.664 [Radio_Surface](INFO): Powering down 2025-03-10T18:58:08.665Z,1741633088.665 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:08.665Z,1741633088.665 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:08.668Z,1741633088.668 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-03-10T18:58:08.668Z,1741633088.668 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:08.669Z,1741633088.669 [Onboard](INFO): Join timeout helper Thread ID is 1878 2025-03-10T18:58:09.128Z,1741633089.128 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-03-10T18:58:11.848Z,1741633091.848 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:11.849Z,1741633091.849 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:11.860Z,1741633091.860 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-03-10T18:58:11.860Z,1741633091.860 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:11.861Z,1741633091.861 [DataOverHttps](INFO): Join timeout helper Thread ID is 1879 2025-03-10T18:58:12.140Z,1741633092.140 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:12.141Z,1741633092.141 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.148Z,1741633092.148 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-03-10T18:58:12.148Z,1741633092.148 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.149Z,1741633092.149 [DAT](INFO): Join timeout helper Thread ID is 1880 2025-03-10T18:58:12.356Z,1741633092.356 [DAT](INFO): Powering down 2025-03-10T18:58:12.425Z,1741633092.425 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:12.425Z,1741633092.425 [DAT](INFO): Powering down 2025-03-10T18:58:12.426Z,1741633092.426 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.437Z,1741633092.437 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-03-10T18:58:12.437Z,1741633092.437 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.438Z,1741633092.438 [BackseatComponent](INFO): Join timeout helper Thread ID is 1881 2025-03-10T18:58:12.588Z,1741633092.588 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:12.589Z,1741633092.589 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.597Z,1741633092.597 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-03-10T18:58:12.597Z,1741633092.597 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.597Z,1741633092.597 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1882 2025-03-10T18:58:12.748Z,1741633092.748 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:12.748Z,1741633092.748 [WetLabsBB2FL](INFO): Powering down 2025-03-10T18:58:12.749Z,1741633092.749 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.761Z,1741633092.761 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-03-10T18:58:12.761Z,1741633092.761 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:12.761Z,1741633092.761 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1883 2025-03-10T18:58:13.104Z,1741633093.104 [CTD_Seabird](INFO): Powering down 2025-03-10T18:58:13.116Z,1741633093.116 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:13.116Z,1741633093.116 [CTD_Seabird](INFO): Powering down 2025-03-10T18:58:13.138Z,1741633093.138 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.154Z,1741633093.154 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-03-10T18:58:13.154Z,1741633093.154 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.155Z,1741633093.155 [logger](INFO): Join timeout helper Thread ID is 1884 2025-03-10T18:58:13.181Z,1741633093.181 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:13.181Z,1741633093.181 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.193Z,1741633093.193 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-03-10T18:58:13.193Z,1741633093.193 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.193Z,1741633093.193 [CommandLine](INFO): Join timeout helper Thread ID is 1885 2025-03-10T18:58:13.276Z,1741633093.276 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:13.277Z,1741633093.277 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.293Z,1741633093.293 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-03-10T18:58:13.293Z,1741633093.293 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.293Z,1741633093.293 [CommandExec](INFO): Join timeout helper Thread ID is 1886 2025-03-10T18:58:13.294Z,1741633093.294 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-03-10T18:58:13.295Z,1741633093.295 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.295Z,1741633093.295 [controlThread](INFO): Join timeout helper Thread ID is 1887 2025-03-10T18:58:13.344Z,1741633093.344 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-10T18:58:13.345Z,1741633093.345 [controlThread](DEBUG): Uninitializing ControlThread 2025-03-10T18:58:13.346Z,1741633093.346 [AHRS_M2](INFO): Powering down 2025-03-10T18:58:13.512Z,1741633093.512 [DVL_micro](INFO): Powering down 2025-03-10T18:58:13.513Z,1741633093.513 [NAL9602](INFO): Powering down 2025-03-10T18:58:13.514Z,1741633093.514 [Sonardyne_Nano](INFO): Powering down 2025-03-10T18:58:13.633Z,1741633093.633 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-03-10T18:58:13.634Z,1741633093.634 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-03-10T18:58:13.634Z,1741633093.634 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-03-10T18:58:13.635Z,1741633093.635 [MissionManager](INFO): Uninitializing Mission Default 2025-03-10T18:58:13.635Z,1741633093.635 [Default] Stopped 2025-03-10T18:58:13.635Z,1741633093.635 [Default](DEBUG): Aggregate::uninitialize Default 2025-03-10T18:58:13.635Z,1741633093.635 [Default:B.GoToSurface] Stopped 2025-03-10T18:58:13.635Z,1741633093.635 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-10T18:58:13.635Z,1741633093.635 [Default:CheckIn] Stopped 2025-03-10T18:58:13.635Z,1741633093.635 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-03-10T18:58:13.635Z,1741633093.635 [Default:CheckIn:Read_GPS] Stopped 2025-03-10T18:58:13.638Z,1741633093.638 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-03-10T18:58:13.639Z,1741633093.639 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-03-10T18:58:13.639Z,1741633093.639 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-03-10T18:58:13.639Z,1741633093.639 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-03-10T18:58:13.639Z,1741633093.639 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-03-10T18:58:13.640Z,1741633093.640 [BuoyancyServo](INFO): Powering down 2025-03-10T18:58:13.652Z,1741633093.652 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-03-10T18:58:13.652Z,1741633093.652 [ElevatorServo](INFO): Powering down 2025-03-10T18:58:13.653Z,1741633093.653 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-03-10T18:58:13.653Z,1741633093.653 [MassServo](INFO): Powering down 2025-03-10T18:58:13.654Z,1741633093.654 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-03-10T18:58:13.654Z,1741633093.654 [RudderServo](INFO): Powering down 2025-03-10T18:58:13.655Z,1741633093.655 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-03-10T18:58:13.655Z,1741633093.655 [ThrusterHE](INFO): Powering down 2025-03-10T18:58:13.656Z,1741633093.656 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-03-10T18:58:13.656Z,1741633093.656 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-03-10T18:58:13.657Z,1741633093.657 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-03-10T18:58:13.657Z,1741633093.657 [CBIT](DEBUG): Powering off loads. 2025-03-10T18:58:13.668Z,1741633093.668 [CBIT](DEBUG): Disabling WDT. 2025-03-10T18:58:13.680Z,1741633093.680 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-10T18:58:13.680Z,1741633093.680 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-03-10T18:58:13.681Z,1741633093.681 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.715Z,1741633093.715 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-10T18:58:13.715Z,1741633093.715 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-03-10T18:58:13.734Z,1741633093.734 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.741Z,1741633093.741 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.781Z,1741633093.781 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.783Z,1741633093.783 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.791Z,1741633093.791 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.799Z,1741633093.799 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.843Z,1741633093.843 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.910Z,1741633093.910 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-10T18:58:13.965Z,1741633093.965 [logger ThreadHandler](INFO): Thread cancelled.