2025-02-03T18:58:58.286Z,1738609138.286 [Supervisor](DEBUG): Initializing supervisor.
2025-02-03T18:58:58.290Z,1738609138.290 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-02-03T18:58:58.291Z,1738609138.291 [SyncHandler](INFO): Protected caller Thread ID is 837
2025-02-03T18:58:58.291Z,1738609138.291 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-02-03T18:58:58.292Z,1738609138.292 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-02-03T18:58:58.292Z,1738609138.292 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838
2025-02-03T18:58:58.296Z,1738609138.296 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-02-03T18:58:58.313Z,1738609138.313 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-02-03T18:58:58.314Z,1738609138.314 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-02-03T18:58:58.315Z,1738609138.315 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839
2025-02-03T18:58:58.319Z,1738609138.319 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-02-03T18:58:58.320Z,1738609138.320 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-02-03T18:58:58.321Z,1738609138.321 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840
2025-02-03T18:58:58.323Z,1738609138.323 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-02-03T18:58:58.323Z,1738609138.323 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-02-03T18:58:58.324Z,1738609138.324 [logger ThreadHandler](INFO): Protected caller Thread ID is 841
2025-02-03T18:58:58.327Z,1738609138.327 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-02-03T18:58:58.328Z,1738609138.328 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-02-03T18:58:58.332Z,1738609138.332 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-02-03T18:58:58.605Z,1738609138.605 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-02-03T18:58:58.607Z,1738609138.607 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-02-03T18:58:58.698Z,1738609138.698 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-02-03T18:58:59.230Z,1738609139.230 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-02-03T18:58:59.231Z,1738609139.231 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-02-03T18:58:59.576Z,1738609139.576 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-02-03T18:58:59.578Z,1738609139.578 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-02-03T18:58:59.684Z,1738609139.684 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-02-03T18:58:59.685Z,1738609139.685 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-02-03T18:59:00.109Z,1738609140.109 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-02-03T18:59:00.111Z,1738609140.111 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-02-03T18:59:00.331Z,1738609140.331 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-02-03T18:59:00.333Z,1738609140.333 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-02-03T18:59:00.858Z,1738609140.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-02-03T18:59:00.860Z,1738609140.860 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-02-03T18:59:01.005Z,1738609141.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-02-03T18:59:01.006Z,1738609141.006 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-02-03T18:59:01.096Z,1738609141.096 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-02-03T18:59:01.934Z,1738609141.934 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-02-03T18:59:01.934Z,1738609141.934 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-02-03T18:59:02.965Z,1738609142.965 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-02-03T18:59:02.967Z,1738609142.967 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-02-03T18:59:03.157Z,1738609143.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-02-03T18:59:03.157Z,1738609143.157 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-02-03T18:59:03.277Z,1738609143.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-02-03T18:59:03.278Z,1738609143.278 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-02-03T18:59:03.512Z,1738609143.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-02-03T18:59:03.514Z,1738609143.514 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-02-03T18:59:03.783Z,1738609143.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-02-03T18:59:03.785Z,1738609143.785 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2025-02-03T18:59:03.788Z,1738609143.788 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2025-02-03T18:59:03.883Z,1738609143.883 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2025-02-03T18:59:03.995Z,1738609143.995 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2025-02-03T18:59:04.090Z,1738609144.090 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2025-02-03T18:59:04.202Z,1738609144.202 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2025-02-03T18:59:04.304Z,1738609144.304 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2025-02-03T18:59:04.430Z,1738609144.430 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2025-02-03T18:59:04.590Z,1738609144.590 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2025-02-03T18:59:04.746Z,1738609144.746 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2025-02-03T18:59:04.864Z,1738609144.864 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2025-02-03T18:59:05.137Z,1738609145.137 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-02-03T18:59:05.138Z,1738609145.138 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-02-03T18:59:05.153Z,1738609145.153 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-02-03T18:59:05.225Z,1738609145.225 [VerticalControl](DEBUG): Construct VerticalControl.
2025-02-03T18:59:05.284Z,1738609145.284 [VerticalControl] Loaded
2025-02-03T18:59:05.285Z,1738609145.285 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-02-03T18:59:05.287Z,1738609145.287 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-02-03T18:59:05.335Z,1738609145.335 [HorizontalControl] Loaded
2025-02-03T18:59:05.335Z,1738609145.335 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-02-03T18:59:05.337Z,1738609145.337 [SpeedControl](DEBUG): Construct SpeedControl.
2025-02-03T18:59:05.340Z,1738609145.340 [SpeedControl] Loaded
2025-02-03T18:59:05.341Z,1738609145.341 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-02-03T18:59:05.343Z,1738609145.343 [LoopControl](DEBUG): Construct LoopControl.
2025-02-03T18:59:05.344Z,1738609145.344 [LoopControl] Loaded
2025-02-03T18:59:05.344Z,1738609145.344 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-02-03T18:59:05.344Z,1738609145.344 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-02-03T18:59:05.346Z,1738609145.346 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-02-03T18:59:05.362Z,1738609145.362 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-02-03T18:59:05.363Z,1738609145.363 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-02-03T18:59:05.575Z,1738609145.575 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-02-03T18:59:05.575Z,1738609145.575 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-02-03T18:59:05.763Z,1738609145.763 [BuoyancyServo] Loaded
2025-02-03T18:59:05.764Z,1738609145.764 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-02-03T18:59:05.785Z,1738609145.785 [ElevatorServo] Loaded
2025-02-03T18:59:05.786Z,1738609145.786 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-02-03T18:59:05.807Z,1738609145.807 [MassServo] Loaded
2025-02-03T18:59:05.807Z,1738609145.807 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-02-03T18:59:05.827Z,1738609145.827 [RudderServo] Loaded
2025-02-03T18:59:05.827Z,1738609145.827 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-02-03T18:59:05.844Z,1738609145.844 [ThrusterHE] Loaded
2025-02-03T18:59:05.844Z,1738609145.844 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-02-03T18:59:05.845Z,1738609145.845 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-02-03T18:59:05.845Z,1738609145.845 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-02-03T18:59:05.984Z,1738609145.984 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-02-03T18:59:05.985Z,1738609145.985 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-02-03T18:59:05.998Z,1738609145.998 [NavChart] Loaded
2025-02-03T18:59:05.998Z,1738609145.998 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-02-03T18:59:06.004Z,1738609146.004 [UniversalFixResidualReporter] Loaded
2025-02-03T18:59:06.004Z,1738609146.004 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-02-03T18:59:06.005Z,1738609146.005 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-02-03T18:59:06.005Z,1738609146.005 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-02-03T18:59:06.089Z,1738609146.089 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-02-03T18:59:06.090Z,1738609146.090 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-02-03T18:59:06.882Z,1738609146.882 [AHRS_M2] Loaded
2025-02-03T18:59:06.882Z,1738609146.882 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-02-03T18:59:08.439Z,1738609148.439 [BPC1] Loaded
2025-02-03T18:59:08.439Z,1738609148.439 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-02-03T18:59:08.587Z,1738609148.587 [DataOverHttps] Loaded
2025-02-03T18:59:08.587Z,1738609148.587 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-02-03T18:59:08.588Z,1738609148.588 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093F4E0
2025-02-03T18:59:08.589Z,1738609148.589 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 920
2025-02-03T18:59:08.611Z,1738609148.611 [Depth_Keller] Loaded
2025-02-03T18:59:08.612Z,1738609148.612 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-02-03T18:59:08.617Z,1738609148.617 [DropWeight] Loaded
2025-02-03T18:59:08.617Z,1738609148.617 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-02-03T18:59:08.681Z,1738609148.681 [NAL9602] Loaded
2025-02-03T18:59:08.681Z,1738609148.681 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-02-03T18:59:08.710Z,1738609148.710 [Onboard] Loaded
2025-02-03T18:59:08.711Z,1738609148.711 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-02-03T18:59:08.712Z,1738609148.712 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096F4E0
2025-02-03T18:59:08.712Z,1738609148.712 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 921
2025-02-03T18:59:08.727Z,1738609148.727 [Power24vConverter] Loaded
2025-02-03T18:59:08.728Z,1738609148.728 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-02-03T18:59:08.743Z,1738609148.743 [Radio_Surface] Loaded
2025-02-03T18:59:08.744Z,1738609148.744 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-02-03T18:59:08.745Z,1738609148.745 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099F4E0
2025-02-03T18:59:08.745Z,1738609148.745 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 922
2025-02-03T18:59:08.760Z,1738609148.760 [Sonardyne_Nano] Loaded
2025-02-03T18:59:08.761Z,1738609148.761 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-02-03T18:59:08.761Z,1738609148.761 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-02-03T18:59:08.762Z,1738609148.762 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-02-03T18:59:08.833Z,1738609148.833 [DepthRateCalculator] Loaded
2025-02-03T18:59:08.833Z,1738609148.833 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-02-03T18:59:08.838Z,1738609148.838 [PitchRateCalculator] Loaded
2025-02-03T18:59:08.838Z,1738609148.838 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-02-03T18:59:08.847Z,1738609148.847 [SpeedCalculator] Loaded
2025-02-03T18:59:08.847Z,1738609148.847 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-02-03T18:59:08.851Z,1738609148.851 [YawRateCalculator] Loaded
2025-02-03T18:59:08.852Z,1738609148.852 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-02-03T18:59:08.871Z,1738609148.871 [ElevatorOffsetCalculator] Loaded
2025-02-03T18:59:08.871Z,1738609148.871 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-02-03T18:59:08.871Z,1738609148.871 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-02-03T18:59:08.872Z,1738609148.872 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-02-03T18:59:09.055Z,1738609149.055 [CANONSampler] Loaded
2025-02-03T18:59:09.056Z,1738609149.056 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2025-02-03T18:59:09.119Z,1738609149.119 [CTD_Seabird] Loaded
2025-02-03T18:59:09.119Z,1738609149.119 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-02-03T18:59:09.120Z,1738609149.120 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A5B4E0
2025-02-03T18:59:09.120Z,1738609149.120 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 923
2025-02-03T18:59:09.142Z,1738609149.142 [PAR_Licor] Loaded
2025-02-03T18:59:09.143Z,1738609149.143 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-02-03T18:59:09.188Z,1738609149.188 [WetLabsBB2FL] Loaded
2025-02-03T18:59:09.188Z,1738609149.188 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-02-03T18:59:09.189Z,1738609149.189 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A8B4E0
2025-02-03T18:59:09.189Z,1738609149.189 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 924
2025-02-03T18:59:09.190Z,1738609149.190 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-02-03T18:59:09.191Z,1738609149.191 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-02-03T18:59:09.233Z,1738609149.233 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-02-03T18:59:09.234Z,1738609149.234 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-02-03T18:59:09.640Z,1738609149.640 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-02-03T18:59:09.642Z,1738609149.642 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-02-03T18:59:09.816Z,1738609149.816 [SBIT](DEBUG): Construct Startup Built In Test.
2025-02-03T18:59:09.825Z,1738609149.825 [SBIT] Loaded
2025-02-03T18:59:09.825Z,1738609149.825 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-02-03T18:59:09.828Z,1738609149.828 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-02-03T18:59:09.840Z,1738609149.840 [IBIT] Loaded
2025-02-03T18:59:09.841Z,1738609149.841 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-02-03T18:59:09.847Z,1738609149.847 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-02-03T18:59:09.951Z,1738609149.951 [CBIT] Loaded
2025-02-03T18:59:09.952Z,1738609149.952 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-02-03T18:59:09.952Z,1738609149.952 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-02-03T18:59:09.953Z,1738609149.953 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-02-03T18:59:10.120Z,1738609150.120 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-02-03T18:59:10.126Z,1738609150.126 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-02-03T18:59:10.129Z,1738609150.129 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-02-03T18:59:10.140Z,1738609150.140 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-02-03T18:59:10.141Z,1738609150.141 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BEF4E0
2025-02-03T18:59:10.142Z,1738609150.142 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 925
2025-02-03T18:59:10.146Z,1738609150.146 [Supervisor](INFO): Main Thread ID is 830
2025-02-03T18:59:10.146Z,1738609150.146 [Supervisor](DEBUG): Running supervisor.
2025-02-03T18:59:10.147Z,1738609150.147 [CommandExec ThreadHandler](INFO): Handler Thread ID is 926
2025-02-03T18:59:10.147Z,1738609150.147 [CommandExec](INFO): Initializing the command executive.
2025-02-03T18:59:10.149Z,1738609150.149 [CommandLine ThreadHandler](INFO): Handler Thread ID is 927
2025-02-03T18:59:10.151Z,1738609150.151 [controlThread ThreadHandler](INFO): Handler Thread ID is 928
2025-02-03T18:59:10.151Z,1738609150.151 [controlThread](DEBUG): Initializing ControlThread
2025-02-03T18:59:10.152Z,1738609150.152 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-02-03T18:59:10.154Z,1738609150.154 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-02-03T18:59:10.154Z,1738609150.154 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-02-03T18:59:10.155Z,1738609150.155 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-02-03T18:59:10.157Z,1738609150.157 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-02-03T18:59:10.157Z,1738609150.157 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-02-03T18:59:10.162Z,1738609150.162 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-02-03T18:59:10.162Z,1738609150.162 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-02-03T18:59:10.162Z,1738609150.162 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-02-03T18:59:10.163Z,1738609150.163 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-02-03T18:59:10.163Z,1738609150.163 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-02-03T18:59:10.168Z,1738609150.168 [SBIT](INFO): Initialize SBIT Component.
2025-02-03T18:59:10.169Z,1738609150.169 [SBIT](IMPORTANT): git: 2025-02-03
2025-02-03T18:59:10.169Z,1738609150.169 [SBIT](INFO): git hash: 53755eb7ef5be6243977895b16b430e94c56a7b6
2025-02-03T18:59:10.169Z,1738609150.169 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-02-03T18:59:10.170Z,1738609150.170 [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-02-03T18:59:10.171Z,1738609150.171 [SBIT](INFO): Beginning SBIT in 74.000000 seconds.
2025-02-03T18:59:10.172Z,1738609150.172 [IBIT](INFO): Initialize IBIT Component.
2025-02-03T18:59:10.173Z,1738609150.173 [CBIT](DEBUG): Initialize CBIT Component.
2025-02-03T18:59:10.174Z,1738609150.174 [logger ThreadHandler](INFO): Handler Thread ID is 929
2025-02-03T18:59:10.184Z,1738609150.184 [CBIT](DEBUG): Initialized mux pins.
2025-02-03T18:59:10.184Z,1738609150.184 [CBIT](DEBUG): Initializing the watchdog timer.
2025-02-03T18:59:10.192Z,1738609150.192 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 930
2025-02-03T18:59:10.194Z,1738609150.194 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-02-03T18:59:10.204Z,1738609150.204 [Onboard ThreadHandler](INFO): Handler Thread ID is 931
2025-02-03T18:59:10.208Z,1738609150.208 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-02-03T18:59:10.209Z,1738609150.209 [CBIT](DEBUG): Initializing heartbeat.
2025-02-03T18:59:10.225Z,1738609150.225 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 932
2025-02-03T18:59:10.240Z,1738609150.240 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 933
2025-02-03T18:59:10.241Z,1738609150.241 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-02-03T18:59:10.245Z,1738609150.245 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 935
2025-02-03T18:59:10.249Z,1738609150.249 [WetLabsBB2FL](INFO): Powering up
2025-02-03T18:59:10.250Z,1738609150.250 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 937
2025-02-03T18:59:10.259Z,1738609150.259 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-02-03T18:59:10.260Z,1738609150.260 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-02-03T18:59:10.260Z,1738609150.260 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-02-03T18:59:10.260Z,1738609150.260 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-02-03T18:59:10.260Z,1738609150.260 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-02-03T18:59:10.260Z,1738609150.260 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-02-03T18:59:10.261Z,1738609150.261 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-02-03T18:59:10.261Z,1738609150.261 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-02-03T18:59:10.280Z,1738609150.280 [CBIT](DEBUG): Deactivating GF circuits.
2025-02-03T18:59:10.280Z,1738609150.280 [CBIT](DEBUG): Deactivating emergency mode.
2025-02-03T18:59:10.320Z,1738609150.320 [CBIT](DEBUG): Backplane powered.
2025-02-03T18:59:10.321Z,1738609150.321 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-02-03T18:59:10.321Z,1738609150.321 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-02-03T18:59:10.322Z,1738609150.322 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-02-03T18:59:10.325Z,1738609150.325 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-02-03T18:59:10.412Z,1738609150.412 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-02-03T18:59:10.417Z,1738609150.417 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-03T18:59:10.461Z,1738609150.461 [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-02-03T18:59:10.462Z,1738609150.462 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-02-03T18:59:10.462Z,1738609150.462 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-02-03T18:59:10.468Z,1738609150.468 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-02-03T18:59:10.628Z,1738609150.628 [Radio_Surface](INFO): Powering up
2025-02-03T18:59:10.761Z,1738609150.761 [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-02-03T18:59:10.767Z,1738609150.767 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-02-03T18:59:10.785Z,1738609150.785 [Default:A.Wait](DEBUG): Construct Wait.
2025-02-03T18:59:10.787Z,1738609150.787 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-03T18:59:10.827Z,1738609150.827 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-02-03T18:59:10.846Z,1738609150.846 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-02-03T18:59:10.868Z,1738609150.868 [Default:E.Execute](DEBUG): Construct Execute.
2025-02-03T18:59:10.871Z,1738609150.871 [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-02-03T18:59:10.876Z,1738609150.876 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2025-02-03T18:59:10.896Z,1738609150.896 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-02-03T18:59:11.055Z,1738609151.055 [Power24vConverter](INFO): Powering up.
2025-02-03T18:59:11.056Z,1738609151.056 [Sonardyne_Nano](INFO): Initializing.
2025-02-03T18:59:11.068Z,1738609151.068 [CANONSampler](INFO): Powering down
2025-02-03T18:59:11.126Z,1738609151.126 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-02-03T18:59:11.132Z,1738609151.132 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-02-03T18:59:11.133Z,1738609151.133 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-03T18:59:11.140Z,1738609151.140 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-03T18:59:11.141Z,1738609151.141 [MassServo](DEBUG): Initializing EZServoServo.
2025-02-03T18:59:11.148Z,1738609151.148 [MassServo](DEBUG): Initializing MassServo.
2025-02-03T18:59:11.149Z,1738609151.149 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-03T18:59:11.156Z,1738609151.156 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-03T18:59:11.157Z,1738609151.157 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-03T18:59:11.164Z,1738609151.164 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-03T18:59:12.356Z,1738609152.356 [WetLabsBB2FL](INFO): Powering down
2025-02-03T18:59:13.310Z,1738609153.310 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-02-03T18:59:14.561Z,1738609154.561 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2109
2025-02-03T18:59:16.789Z,1738609156.789 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-02-03T18:59:38.773Z,1738609178.773 [NAL9602](INFO): Powering up NAL9602
2025-02-03T18:59:49.682Z,1738609189.682 [NAL9602](INFO): NAL9602 initialized
2025-02-03T19:00:19.184Z,1738609219.184 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:00:24.857Z,1738609224.857 [SBIT](IMPORTANT): Beginning Startup BIT
2025-02-03T19:00:24.861Z,1738609224.861 [CBIT](IMPORTANT): Beginning ground fault scan
2025-02-03T19:00:30.938Z,1738609230.938 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:00:35.919Z,1738609235.919 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2025-02-03T19:00:36.361Z,1738609236.361 [CBIT](IMPORTANT): Beginning ground fault scan
2025-02-03T19:00:45.088Z,1738609245.088 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:00:47.241Z,1738609247.241 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2025-02-03T19:00:47.641Z,1738609247.641 [CBIT](IMPORTANT): Beginning ground fault scan
2025-02-03T19:00:58.387Z,1738609258.387 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2025-02-03T19:00:58.387Z,1738609258.387 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2025-02-03T19:01:18.613Z,1738609278.613 [SBIT](IMPORTANT): SBIT PASSED
2025-02-03T19:01:18.613Z,1738609278.613 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-02-03T19:01:18.614Z,1738609278.614 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=11 count;
2025-02-03T19:01:18.614Z,1738609278.614 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2025-02-03T19:01:18.614Z,1738609278.614 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool;
2025-02-03T19:01:18.615Z,1738609278.615 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;
2025-02-03T19:01:18.615Z,1738609278.615 [SBIT](IMPORTANT): DATMMP.surfaceThreshold=2 meter;
2025-02-03T19:01:18.615Z,1738609278.615 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter;
2025-02-03T19:01:18.615Z,1738609278.615 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=114.876991 cubic_centimeter;
2025-02-03T19:01:18.615Z,1738609278.615 [SBIT](IMPORTANT): VerticalControl.massDefault=13.700078 millimeter;
2025-02-03T19:01:19.006Z,1738609279.006 [MissionManager](IMPORTANT): Started mission Startup
2025-02-03T19:01:19.006Z,1738609279.006 [Startup] Running Loop=1
2025-02-03T19:01:19.007Z,1738609279.007 [Startup](DEBUG): Aggregate::initialize Startup
2025-02-03T19:01:19.007Z,1738609279.007 [Startup:A.GoToSurface] Running Loop=1
2025-02-03T19:01:19.007Z,1738609279.007 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-03T19:01:19.007Z,1738609279.007 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-03T19:01:19.008Z,1738609279.008 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-03T19:01:19.008Z,1738609279.008 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-03T19:01:19.009Z,1738609279.009 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-03T19:01:19.009Z,1738609279.009 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-03T19:01:19.009Z,1738609279.009 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-03T19:01:19.011Z,1738609279.011 [Startup:StartupSatComms] Running Loop=1
2025-02-03T19:01:19.011Z,1738609279.011 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-02-03T19:01:19.011Z,1738609279.011 [Startup:StartupSatComms:A] Running Loop=1
2025-02-03T19:01:19.462Z,1738609279.462 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-02-03T19:01:33.939Z,1738609293.939 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-02-03T19:01:38.247Z,1738609298.247 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004734
2025-02-03T19:01:28.570Z,1738609288.570 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:02:10.570Z,1738609330.570 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-02-03T19:02:10.570Z,1738609330.570 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:02:10.700Z,1738609330.700 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:02:11.116Z,1738609331.116 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:02:11.116Z,1738609331.116 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-02-03T19:02:19.034Z,1738609339.034 [Startup:StartupSatComms:A](INFO): Timed out from 2025-02-03T19:01:19.0Z
2025-02-03T19:02:19.034Z,1738609339.034 [Startup:StartupSatComms:A] Stopped
2025-02-03T19:02:19.034Z,1738609339.034 [Startup:StartupSatComms:B] Running Loop=1
2025-02-03T19:02:19.444Z,1738609339.444 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-03T19:02:27.156Z,1738609347.156 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:02:35.089Z,1738609355.089 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250130T204732/Courier0004.lzma
2025-02-03T19:02:36.090Z,1738609356.090 [DataOverHttps](INFO): Moved sent file to Logs/20250130T204732/Courier0004.lzma.bak
2025-02-03T19:02:36.090Z,1738609356.090 [DataOverHttps](INFO): SBD MOMSN=23952606
2025-02-03T19:02:52.064Z,1738609372.064 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Courier0000.lzma
2025-02-03T19:02:53.066Z,1738609373.066 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0000.lzma.bak
2025-02-03T19:02:53.066Z,1738609373.066 [DataOverHttps](INFO): SBD MOMSN=23952608
2025-02-03T19:03:08.885Z,1738609388.885 [DataOverHttps](INFO): Sending 165 bytes from file Logs/20250130T204732/Express0005.lzma
2025-02-03T19:03:09.886Z,1738609389.886 [DataOverHttps](INFO): Moved sent file to Logs/20250130T204732/Express0005.lzma.bak
2025-02-03T19:03:09.886Z,1738609389.886 [DataOverHttps](INFO): SBD MOMSN=23952611
2025-02-03T19:03:19.247Z,1738609399.247 [Startup:StartupSatComms:B](INFO): Timed out from 2025-02-03T19:02:19.0Z
2025-02-03T19:03:19.247Z,1738609399.247 [Startup:StartupSatComms:B] Stopped
2025-02-03T19:03:19.247Z,1738609399.247 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-02-03T19:03:19.247Z,1738609399.247 [Startup:StartupSatComms] Stopped
2025-02-03T19:03:19.247Z,1738609399.247 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-02-03T19:03:19.275Z,1738609399.275 [Startup](INFO): Completed Startup
2025-02-03T19:03:19.276Z,1738609399.276 [MissionManager](INFO): Startup is completed.
2025-02-03T19:03:19.276Z,1738609399.276 [MissionManager](INFO): Uninitializing Mission Startup
2025-02-03T19:03:19.276Z,1738609399.276 [Startup] Stopped
2025-02-03T19:03:19.276Z,1738609399.276 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-02-03T19:03:19.276Z,1738609399.276 [Startup:A.GoToSurface] Stopped
2025-02-03T19:03:19.276Z,1738609399.276 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-03T19:03:19.654Z,1738609399.654 [MissionManager](IMPORTANT): Started mission Default
2025-02-03T19:03:19.654Z,1738609399.654 [Default] Running Loop=1
2025-02-03T19:03:19.655Z,1738609399.655 [Default](DEBUG): Aggregate::initialize Default
2025-02-03T19:03:19.655Z,1738609399.655 [Default:B.GoToSurface] Running Loop=1
2025-02-03T19:03:19.655Z,1738609399.655 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-03T19:03:19.655Z,1738609399.655 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-03T19:03:19.655Z,1738609399.655 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-03T19:03:19.656Z,1738609399.656 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-03T19:03:19.656Z,1738609399.656 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-03T19:03:19.656Z,1738609399.656 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-03T19:03:19.657Z,1738609399.657 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-03T19:03:19.657Z,1738609399.657 [Default:A.Wait] Running Loop=1
2025-02-03T19:03:19.657Z,1738609399.657 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-03T19:03:25.758Z,1738609405.758 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:03:25.821Z,1738609405.821 [DataOverHttps](INFO): Sending 816 bytes from file Logs/20250203T185858/Express0001.lzma
2025-02-03T19:03:26.822Z,1738609406.822 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0001.lzma.bak
2025-02-03T19:03:26.822Z,1738609406.822 [DataOverHttps](INFO): SBD MOMSN=23952617
2025-02-03T19:03:32.966Z,1738609412.966 [Default:A.Wait](INFO): Done Waiting.
2025-02-03T19:03:32.967Z,1738609412.967 [Default:A.Wait] Stopped
2025-02-03T19:03:32.967Z,1738609412.967 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T19:03:33.377Z,1738609413.377 [Default:CheckIn] Running Loop=1
2025-02-03T19:03:33.377Z,1738609413.377 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T19:03:33.377Z,1738609413.377 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T19:03:33.774Z,1738609413.774 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-03T19:04:53.354Z,1738609493.354 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-02-03T19:05:04.710Z,1738609504.710 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-02-03T19:05:11.599Z,1738609511.599 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-02-03T19:05:11.599Z,1738609511.599 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:05:11.765Z,1738609511.765 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:05:12.141Z,1738609512.141 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:05:12.141Z,1738609512.141 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-02-03T19:05:18.454Z,1738609518.454 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-02-03T19:05:27.293Z,1738609527.293 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-02-03T19:05:45.926Z,1738609545.926 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-02-03T19:06:40.864Z,1738609600.864 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:06:43.286Z,1738609603.286 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-02-03T19:07:10.385Z,1738609630.385 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:07:27.332Z,1738609647.332 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-02-03T19:07:47.085Z,1738609667.085 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:08:03.910Z,1738609683.910 [CommandExec](IMPORTANT): got command strobe off
2025-02-03T19:08:03.910Z,1738609683.910 [CommandExec](IMPORTANT): Deactivating strobe
2025-02-03T19:08:07.701Z,1738609687.701 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:08:12.577Z,1738609692.577 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-02-03T19:08:12.577Z,1738609692.577 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:08:12.724Z,1738609692.724 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:08:13.104Z,1738609693.104 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:08:13.104Z,1738609693.104 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-02-03T19:08:27.889Z,1738609707.889 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:08:33.587Z,1738609713.587 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T19:03:33.4Z
2025-02-03T19:08:33.587Z,1738609713.587 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T19:08:33.587Z,1738609713.587 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T19:08:33.963Z,1738609713.963 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-03T19:08:34.807Z,1738609714.807 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-02-03T19:08:40.780Z,1738609720.780 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0004.lzma
2025-02-03T19:08:41.782Z,1738609721.782 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0004.lzma.bak
2025-02-03T19:08:41.782Z,1738609721.782 [DataOverHttps](INFO): SBD MOMSN=23952718
2025-02-03T19:08:46.071Z,1738609726.071 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:08:57.848Z,1738609737.848 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20250203T185858/Express0005.lzma
2025-02-03T19:08:58.850Z,1738609738.850 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0005.lzma.bak
2025-02-03T19:08:58.850Z,1738609738.850 [DataOverHttps](INFO): SBD MOMSN=23952729
2025-02-03T19:09:00.238Z,1738609740.238 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T19:09:00.238Z,1738609740.238 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T19:09:00.238Z,1738609740.238 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T19:09:01.825Z,1738609741.825 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:09:11.943Z,1738609751.943 [Power24vConverter](INFO): Powering down.
2025-02-03T19:09:17.177Z,1738609757.177 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:09:31.721Z,1738609771.721 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T19:09:47.881Z,1738609787.881 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-02-03T19:09:51.122Z,1738609791.122 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T19:09:51.122Z,1738609791.122 [NAL9602] Data Fault, FailCount= 1
2025-02-03T19:09:51.122Z,1738609791.122 [NAL9602](ERROR): Data Fault
2025-02-03T19:09:51.272Z,1738609791.272 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T19:09:51.526Z,1738609791.526 [NAL9602](INFO): Powering down
2025-02-03T19:09:52.489Z,1738609792.489 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T19:09:52.489Z,1738609792.489 [NAL9602] No Fault, FailCount= 1
2025-02-03T19:10:21.830Z,1738609821.830 [NAL9602](INFO): Powering up NAL9602
2025-02-03T19:10:32.734Z,1738609832.734 [NAL9602](INFO): NAL9602 initialized
2025-02-03T19:11:13.565Z,1738609873.565 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-02-03T19:11:13.565Z,1738609873.565 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:11:13.712Z,1738609873.712 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:11:14.092Z,1738609874.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:11:14.092Z,1738609874.092 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-02-03T19:13:17.561Z,1738609997.561 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-02-03T19:14:00.802Z,1738610040.802 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T19:14:00.802Z,1738610040.802 [Default:CheckIn:C.Wait] Stopped
2025-02-03T19:14:00.802Z,1738610040.802 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T19:14:00.802Z,1738610040.802 [Default:CheckIn:D] Running Loop=1
2025-02-03T19:14:01.206Z,1738610041.206 [Default:CheckIn:D] Stopped
2025-02-03T19:14:01.206Z,1738610041.206 [Default:CheckIn:E] Running Loop=1
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.692524 min
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn:E] Stopped
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn] Stopped
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn](INFO): Running loop #2
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn] Running Loop=2
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T19:14:01.631Z,1738610041.631 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T19:14:14.565Z,1738610054.565 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-02-03T19:14:14.565Z,1738610054.565 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:14:14.697Z,1738610054.697 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:14:15.100Z,1738610055.100 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:14:15.100Z,1738610055.100 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-02-03T19:14:30.688Z,1738610070.688 [BPC1](INFO): Calculating totals. Valid battery stick count: 47. Valid reserve battery stick count: 4.
2025-02-03T19:14:30.691Z,1738610070.691 [BPC1](INFO): Received data from all battery sticks.
2025-02-03T19:17:15.557Z,1738610235.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-02-03T19:17:15.557Z,1738610235.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:17:15.692Z,1738610235.692 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:17:16.084Z,1738610236.084 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:17:16.084Z,1738610236.084 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-02-03T19:19:01.805Z,1738610341.805 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T19:14:01.6Z
2025-02-03T19:19:01.805Z,1738610341.805 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T19:19:01.806Z,1738610341.806 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T19:19:08.648Z,1738610348.648 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250203T185858/Courier0007.lzma
2025-02-03T19:19:09.658Z,1738610349.658 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0007.lzma.bak
2025-02-03T19:19:09.658Z,1738610349.658 [DataOverHttps](INFO): SBD MOMSN=23952737
2025-02-03T19:19:25.476Z,1738610365.476 [DataOverHttps](INFO): Sending 193 bytes from file Logs/20250203T185858/Express0008.lzma
2025-02-03T19:19:26.483Z,1738610366.483 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0008.lzma.bak
2025-02-03T19:19:26.483Z,1738610366.483 [DataOverHttps](INFO): SBD MOMSN=23952745
2025-02-03T19:19:27.719Z,1738610367.719 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T19:19:27.719Z,1738610367.719 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T19:19:27.719Z,1738610367.719 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T19:20:16.615Z,1738610416.615 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-02-03T19:20:16.615Z,1738610416.615 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:20:16.764Z,1738610416.764 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:20:17.145Z,1738610417.145 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:20:17.145Z,1738610417.145 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-02-03T19:20:33.558Z,1738610433.558 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T19:20:33.558Z,1738610433.558 [NAL9602] Data Fault, FailCount= 2
2025-02-03T19:20:33.558Z,1738610433.558 [NAL9602](ERROR): Data Fault
2025-02-03T19:20:33.724Z,1738610433.724 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T19:20:33.962Z,1738610433.962 [NAL9602](INFO): Powering down
2025-02-03T19:20:34.933Z,1738610434.933 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T19:20:34.933Z,1738610434.933 [NAL9602] No Fault, FailCount= 2
2025-02-03T19:21:04.271Z,1738610464.271 [NAL9602](INFO): Powering up NAL9602
2025-02-03T19:21:15.188Z,1738610475.188 [NAL9602](INFO): NAL9602 initialized
2025-02-03T19:23:17.588Z,1738610597.588 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-02-03T19:23:17.588Z,1738610597.588 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:23:17.745Z,1738610597.745 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:23:18.160Z,1738610598.160 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:23:18.160Z,1738610598.160 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-02-03T19:24:28.314Z,1738610668.314 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T19:24:28.314Z,1738610668.314 [Default:CheckIn:C.Wait] Stopped
2025-02-03T19:24:28.314Z,1738610668.314 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T19:24:28.315Z,1738610668.315 [Default:CheckIn:D] Running Loop=1
2025-02-03T19:24:28.710Z,1738610668.710 [Default:CheckIn:D] Stopped
2025-02-03T19:24:28.710Z,1738610668.710 [Default:CheckIn:E] Running Loop=1
2025-02-03T19:24:29.126Z,1738610669.126 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.150932 min
2025-02-03T19:24:29.126Z,1738610669.126 [Default:CheckIn:E] Stopped
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn] Stopped
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn](INFO): Running loop #3
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn] Running Loop=3
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T19:24:29.127Z,1738610669.127 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T19:26:18.601Z,1738610778.601 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-02-03T19:26:18.601Z,1738610778.601 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:26:18.768Z,1738610778.768 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:26:19.156Z,1738610779.156 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:26:19.156Z,1738610779.156 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-02-03T19:29:19.601Z,1738610959.601 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-02-03T19:29:19.601Z,1738610959.601 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:29:19.744Z,1738610959.744 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:29:20.148Z,1738610960.148 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:29:20.148Z,1738610960.148 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-02-03T19:29:29.270Z,1738610969.270 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T19:24:29.1Z
2025-02-03T19:29:29.270Z,1738610969.270 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T19:29:29.271Z,1738610969.271 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T19:29:36.693Z,1738610976.693 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0010.lzma
2025-02-03T19:29:37.694Z,1738610977.694 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0010.lzma.bak
2025-02-03T19:29:37.694Z,1738610977.694 [DataOverHttps](INFO): SBD MOMSN=23952749
2025-02-03T19:29:53.488Z,1738610993.488 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250203T185858/Express0011.lzma
2025-02-03T19:29:54.490Z,1738610994.490 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0011.lzma.bak
2025-02-03T19:29:54.490Z,1738610994.490 [DataOverHttps](INFO): SBD MOMSN=23952751
2025-02-03T19:29:55.954Z,1738610995.954 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T19:29:55.955Z,1738610995.955 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T19:29:55.955Z,1738610995.955 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T19:31:16.319Z,1738611076.319 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T19:31:16.319Z,1738611076.319 [NAL9602] Data Fault, FailCount= 3
2025-02-03T19:31:16.320Z,1738611076.320 [NAL9602](ERROR): Data Fault
2025-02-03T19:31:16.492Z,1738611076.492 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T19:31:16.730Z,1738611076.730 [NAL9602](INFO): Powering down
2025-02-03T19:31:17.697Z,1738611077.697 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T19:31:17.697Z,1738611077.697 [NAL9602] No Fault, FailCount= 3
2025-02-03T19:31:47.034Z,1738611107.034 [NAL9602](INFO): Powering up NAL9602
2025-02-03T19:31:57.938Z,1738611117.938 [NAL9602](INFO): NAL9602 initialized
2025-02-03T19:32:20.593Z,1738611140.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-02-03T19:32:20.593Z,1738611140.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:32:20.728Z,1738611140.728 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:32:21.120Z,1738611141.120 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:32:21.120Z,1738611141.120 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-02-03T19:34:56.528Z,1738611296.528 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T19:34:56.528Z,1738611296.528 [Default:CheckIn:C.Wait] Stopped
2025-02-03T19:34:56.528Z,1738611296.528 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T19:34:56.528Z,1738611296.528 [Default:CheckIn:D] Running Loop=1
2025-02-03T19:34:56.929Z,1738611296.929 [Default:CheckIn:D] Stopped
2025-02-03T19:34:56.929Z,1738611296.929 [Default:CheckIn:E] Running Loop=1
2025-02-03T19:34:57.322Z,1738611297.322 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.621242 min
2025-02-03T19:34:57.322Z,1738611297.322 [Default:CheckIn:E] Stopped
2025-02-03T19:34:57.322Z,1738611297.322 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T19:34:57.322Z,1738611297.322 [Default:CheckIn] Stopped
2025-02-03T19:34:57.322Z,1738611297.322 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T19:34:57.323Z,1738611297.323 [Default:CheckIn](INFO): Running loop #4
2025-02-03T19:34:57.323Z,1738611297.323 [Default:CheckIn] Running Loop=4
2025-02-03T19:34:57.323Z,1738611297.323 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T19:34:57.323Z,1738611297.323 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T19:35:21.557Z,1738611321.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-02-03T19:35:21.557Z,1738611321.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:35:21.712Z,1738611321.712 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:35:22.109Z,1738611322.109 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:35:22.109Z,1738611322.109 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-02-03T19:38:22.563Z,1738611502.563 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-02-03T19:38:22.564Z,1738611502.564 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:38:22.700Z,1738611502.700 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:38:23.104Z,1738611503.104 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:38:23.104Z,1738611503.104 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-02-03T19:39:57.487Z,1738611597.487 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T19:34:57.3Z
2025-02-03T19:39:57.487Z,1738611597.487 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T19:39:57.487Z,1738611597.487 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T19:40:04.868Z,1738611604.868 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0013.lzma
2025-02-03T19:40:05.870Z,1738611605.870 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0013.lzma.bak
2025-02-03T19:40:05.870Z,1738611605.870 [DataOverHttps](INFO): SBD MOMSN=23952806
2025-02-03T19:40:22.460Z,1738611622.460 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250203T185858/Express0014.lzma
2025-02-03T19:40:23.462Z,1738611623.462 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0014.lzma.bak
2025-02-03T19:40:23.462Z,1738611623.462 [DataOverHttps](INFO): SBD MOMSN=23952808
2025-02-03T19:40:24.987Z,1738611624.987 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T19:40:24.987Z,1738611624.987 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T19:40:24.988Z,1738611624.988 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T19:41:23.604Z,1738611683.604 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-02-03T19:41:23.604Z,1738611683.604 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:41:23.760Z,1738611683.760 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:41:24.128Z,1738611684.128 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:41:24.128Z,1738611684.128 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-02-03T19:41:59.930Z,1738611719.930 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T19:41:59.930Z,1738611719.930 [NAL9602] Data Fault, FailCount= 4
2025-02-03T19:41:59.930Z,1738611719.930 [NAL9602](ERROR): Data Fault
2025-02-03T19:42:00.116Z,1738611720.116 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T19:42:00.330Z,1738611720.330 [NAL9602](INFO): Powering down
2025-02-03T19:42:01.280Z,1738611721.280 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T19:42:01.280Z,1738611721.280 [NAL9602] No Fault, FailCount= 4
2025-02-03T19:42:30.626Z,1738611750.626 [NAL9602](INFO): Powering up NAL9602
2025-02-03T19:42:41.534Z,1738611761.534 [NAL9602](INFO): NAL9602 initialized
2025-02-03T19:44:24.565Z,1738611864.565 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-02-03T19:44:24.565Z,1738611864.565 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:44:24.716Z,1738611864.716 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:44:25.112Z,1738611865.112 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:44:25.112Z,1738611865.112 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-02-03T19:45:25.575Z,1738611925.575 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T19:45:25.575Z,1738611925.575 [Default:CheckIn:C.Wait] Stopped
2025-02-03T19:45:25.575Z,1738611925.575 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T19:45:25.575Z,1738611925.575 [Default:CheckIn:D] Running Loop=1
2025-02-03T19:45:25.974Z,1738611925.974 [Default:CheckIn:D] Stopped
2025-02-03T19:45:25.974Z,1738611925.974 [Default:CheckIn:E] Running Loop=1
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.105322 min
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn:E] Stopped
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn] Stopped
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn](INFO): Running loop #5
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn] Running Loop=5
2025-02-03T19:45:26.378Z,1738611926.378 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T19:45:26.379Z,1738611926.379 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T19:47:25.557Z,1738612045.557 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-02-03T19:47:25.557Z,1738612045.557 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:47:25.702Z,1738612045.702 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:47:26.116Z,1738612046.116 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:47:26.116Z,1738612046.116 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-02-03T19:50:26.602Z,1738612226.602 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-02-03T19:50:26.602Z,1738612226.602 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:50:26.604Z,1738612226.604 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T19:45:26.4Z
2025-02-03T19:50:26.604Z,1738612226.604 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T19:50:26.604Z,1738612226.604 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T19:50:26.752Z,1738612226.752 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:50:27.152Z,1738612227.152 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:50:27.152Z,1738612227.152 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-02-03T19:50:34.219Z,1738612234.219 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0016.lzma
2025-02-03T19:50:35.223Z,1738612235.223 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0016.lzma.bak
2025-02-03T19:50:35.223Z,1738612235.223 [DataOverHttps](INFO): SBD MOMSN=23952814
2025-02-03T19:50:50.996Z,1738612250.996 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250203T185858/Express0017.lzma
2025-02-03T19:50:51.998Z,1738612251.998 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0017.lzma.bak
2025-02-03T19:50:51.998Z,1738612251.998 [DataOverHttps](INFO): SBD MOMSN=23952819
2025-02-03T19:50:53.266Z,1738612253.266 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T19:50:53.266Z,1738612253.266 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T19:50:53.266Z,1738612253.266 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T19:52:44.346Z,1738612364.346 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T19:52:44.346Z,1738612364.346 [NAL9602] Data Fault, FailCount= 5
2025-02-03T19:52:44.346Z,1738612364.346 [NAL9602](ERROR): Data Fault
2025-02-03T19:52:44.500Z,1738612364.500 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T19:52:44.501Z,1738612364.501 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-02-03T19:52:44.750Z,1738612364.750 [NAL9602](INFO): Powering down
2025-02-03T19:52:44.902Z,1738612364.902 [CommandExec](FAULT): Scheduling is paused
2025-02-03T19:52:44.902Z,1738612364.902 [CBIT](INFO): Critical error at 20250203T195244
2025-02-03T19:52:44.903Z,1738612364.903 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-02-03T19:53:27.605Z,1738612407.605 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-02-03T19:53:27.605Z,1738612407.605 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:53:27.768Z,1738612407.768 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:53:28.140Z,1738612408.140 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:53:28.140Z,1738612408.140 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-02-03T19:54:44.491Z,1738612484.491 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T19:54:44.491Z,1738612484.491 [NAL9602] No Fault, FailCount= 5
2025-02-03T19:54:44.742Z,1738612484.742 [NAL9602](INFO): Powering up NAL9602
2025-02-03T19:54:55.642Z,1738612495.642 [NAL9602](INFO): NAL9602 initialized
2025-02-03T19:55:53.824Z,1738612553.824 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T19:55:53.824Z,1738612553.824 [Default:CheckIn:C.Wait] Stopped
2025-02-03T19:55:53.824Z,1738612553.824 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T19:55:53.824Z,1738612553.824 [Default:CheckIn:D] Running Loop=1
2025-02-03T19:55:54.234Z,1738612554.234 [Default:CheckIn:D] Stopped
2025-02-03T19:55:54.234Z,1738612554.234 [Default:CheckIn:E] Running Loop=1
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.576331 min
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn:E] Stopped
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn] Stopped
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn](INFO): Running loop #6
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn] Running Loop=6
2025-02-03T19:55:54.655Z,1738612554.655 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T19:55:54.656Z,1738612554.656 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T19:56:28.584Z,1738612588.584 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-02-03T19:56:28.584Z,1738612588.584 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:56:28.720Z,1738612588.720 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:56:29.124Z,1738612589.124 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T19:56:29.124Z,1738612589.124 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-02-03T19:59:29.593Z,1738612769.593 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-02-03T19:59:29.593Z,1738612769.593 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T19:59:29.732Z,1738612769.732 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T19:59:29.732Z,1738612769.732 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:00:54.862Z,1738612854.862 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T19:55:54.7Z
2025-02-03T20:00:54.862Z,1738612854.862 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T20:00:54.862Z,1738612854.862 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T20:01:01.960Z,1738612861.960 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20250203T185858/Courier0019.lzma
2025-02-03T20:01:02.962Z,1738612862.962 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0019.lzma.bak
2025-02-03T20:01:02.962Z,1738612862.962 [DataOverHttps](INFO): SBD MOMSN=23952878
2025-02-03T20:01:17.758Z,1738612877.758 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20250203T185858/Express0020.lzma
2025-02-03T20:01:18.750Z,1738612878.750 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0020.lzma.bak
2025-02-03T20:01:18.751Z,1738612878.751 [DataOverHttps](INFO): SBD MOMSN=23952881
2025-02-03T20:01:20.009Z,1738612880.009 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T20:01:20.009Z,1738612880.009 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T20:01:20.010Z,1738612880.010 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T20:04:58.150Z,1738613098.150 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T20:04:58.151Z,1738613098.151 [NAL9602] Data Fault, FailCount= 1
2025-02-03T20:04:58.151Z,1738613098.151 [NAL9602](ERROR): Data Fault
2025-02-03T20:04:58.316Z,1738613098.316 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T20:04:58.553Z,1738613098.553 [NAL9602](INFO): Powering down
2025-02-03T20:04:59.516Z,1738613099.516 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T20:04:59.516Z,1738613099.516 [NAL9602] No Fault, FailCount= 1
2025-02-03T20:05:28.850Z,1738613128.850 [NAL9602](INFO): Powering up NAL9602
2025-02-03T20:05:39.766Z,1738613139.766 [NAL9602](INFO): NAL9602 initialized
2025-02-03T20:06:20.590Z,1738613180.590 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T20:06:20.590Z,1738613180.590 [Default:CheckIn:C.Wait] Stopped
2025-02-03T20:06:20.590Z,1738613180.590 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T20:06:20.590Z,1738613180.590 [Default:CheckIn:D] Running Loop=1
2025-02-03T20:06:21.001Z,1738613181.001 [Default:CheckIn:D] Stopped
2025-02-03T20:06:21.002Z,1738613181.002 [Default:CheckIn:E] Running Loop=1
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.022449 min
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn:E] Stopped
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn] Stopped
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn](INFO): Running loop #7
2025-02-03T20:06:21.402Z,1738613181.402 [Default:CheckIn] Running Loop=7
2025-02-03T20:06:21.403Z,1738613181.403 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T20:06:21.403Z,1738613181.403 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T20:11:21.574Z,1738613481.574 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T20:06:21.4Z
2025-02-03T20:11:21.574Z,1738613481.574 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T20:11:21.574Z,1738613481.574 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T20:11:29.136Z,1738613489.136 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0022.lzma
2025-02-03T20:11:30.139Z,1738613490.139 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0022.lzma.bak
2025-02-03T20:11:30.139Z,1738613490.139 [DataOverHttps](INFO): SBD MOMSN=23952893
2025-02-03T20:11:45.848Z,1738613505.848 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0023.lzma
2025-02-03T20:11:46.850Z,1738613506.850 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0023.lzma.bak
2025-02-03T20:11:46.850Z,1738613506.850 [DataOverHttps](INFO): SBD MOMSN=23952895
2025-02-03T20:11:48.245Z,1738613508.245 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T20:11:48.245Z,1738613508.245 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T20:11:48.245Z,1738613508.245 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T20:14:29.969Z,1738613669.969 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:14:29.969Z,1738613669.969 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2025-02-03T20:15:36.870Z,1738613736.870 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:15:40.918Z,1738613740.918 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T20:15:40.918Z,1738613740.918 [NAL9602] Data Fault, FailCount= 2
2025-02-03T20:15:40.918Z,1738613740.918 [NAL9602](ERROR): Data Fault
2025-02-03T20:15:41.068Z,1738613741.068 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T20:15:41.322Z,1738613741.322 [NAL9602](INFO): Powering down
2025-02-03T20:15:42.288Z,1738613742.288 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T20:15:42.288Z,1738613742.288 [NAL9602] No Fault, FailCount= 2
2025-02-03T20:15:48.989Z,1738613748.989 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:16:00.301Z,1738613760.301 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:16:11.642Z,1738613771.642 [NAL9602](INFO): Powering up NAL9602
2025-02-03T20:16:12.017Z,1738613772.017 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:16:22.534Z,1738613782.534 [NAL9602](INFO): NAL9602 initialized
2025-02-03T20:16:24.137Z,1738613784.137 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:16:36.257Z,1738613796.257 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:16:48.377Z,1738613808.377 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:16:48.818Z,1738613808.818 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T20:16:48.818Z,1738613808.818 [Default:CheckIn:C.Wait] Stopped
2025-02-03T20:16:48.818Z,1738613808.818 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T20:16:48.818Z,1738613808.818 [Default:CheckIn:D] Running Loop=1
2025-02-03T20:16:49.202Z,1738613809.202 [Default:CheckIn:D] Stopped
2025-02-03T20:16:49.202Z,1738613809.202 [Default:CheckIn:E] Running Loop=1
2025-02-03T20:16:49.649Z,1738613809.649 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.492456 min
2025-02-03T20:16:49.649Z,1738613809.649 [Default:CheckIn:E] Stopped
2025-02-03T20:16:49.649Z,1738613809.649 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T20:16:49.650Z,1738613809.650 [Default:CheckIn] Stopped
2025-02-03T20:16:49.650Z,1738613809.650 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T20:16:49.650Z,1738613809.650 [Default:CheckIn](INFO): Running loop #8
2025-02-03T20:16:49.650Z,1738613809.650 [Default:CheckIn] Running Loop=8
2025-02-03T20:16:49.650Z,1738613809.650 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T20:16:49.650Z,1738613809.650 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T20:17:30.447Z,1738613850.447 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-02-03T20:17:30.447Z,1738613850.447 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:17:30.592Z,1738613850.592 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:17:30.976Z,1738613850.976 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:17:30.976Z,1738613850.976 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-02-03T20:19:29.993Z,1738613969.993 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:19:44.134Z,1738613984.134 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:19:57.869Z,1738613997.869 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:20:11.213Z,1738614011.213 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:20:24.146Z,1738614024.146 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:20:31.457Z,1738614031.457 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-02-03T20:20:31.457Z,1738614031.457 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:20:31.616Z,1738614031.616 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:20:32.040Z,1738614032.040 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:20:32.040Z,1738614032.040 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-02-03T20:20:37.474Z,1738614037.474 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:20:50.805Z,1738614050.805 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:21:04.138Z,1738614064.138 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:21:17.470Z,1738614077.470 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:21:30.801Z,1738614090.801 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:21:44.133Z,1738614104.133 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T20:21:49.812Z,1738614109.812 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T20:16:49.7Z
2025-02-03T20:21:49.812Z,1738614109.812 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T20:21:49.812Z,1738614109.812 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T20:21:51.009Z,1738614111.009 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2025-02-03T20:21:51.012Z,1738614111.012 [BPC1](INFO): Received data from all battery sticks.
2025-02-03T20:21:57.164Z,1738614117.164 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0025.lzma
2025-02-03T20:21:58.166Z,1738614118.166 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0025.lzma.bak
2025-02-03T20:21:58.166Z,1738614118.166 [DataOverHttps](INFO): SBD MOMSN=23952905
2025-02-03T20:22:14.008Z,1738614134.008 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0026.lzma
2025-02-03T20:22:15.010Z,1738614135.010 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0026.lzma.bak
2025-02-03T20:22:15.010Z,1738614135.010 [DataOverHttps](INFO): SBD MOMSN=23952907
2025-02-03T20:22:16.467Z,1738614136.467 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T20:22:16.467Z,1738614136.467 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T20:22:16.467Z,1738614136.467 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T20:23:32.417Z,1738614212.417 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-02-03T20:23:32.417Z,1738614212.417 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:23:32.560Z,1738614212.560 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:23:32.972Z,1738614212.972 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:23:32.972Z,1738614212.972 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-02-03T20:26:23.706Z,1738614383.706 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T20:26:23.706Z,1738614383.706 [NAL9602] Data Fault, FailCount= 3
2025-02-03T20:26:23.706Z,1738614383.706 [NAL9602](ERROR): Data Fault
2025-02-03T20:26:23.896Z,1738614383.896 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T20:26:24.122Z,1738614384.122 [NAL9602](INFO): Powering down
2025-02-03T20:26:25.108Z,1738614385.108 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T20:26:25.108Z,1738614385.108 [NAL9602] No Fault, FailCount= 3
2025-02-03T20:26:33.412Z,1738614393.412 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-02-03T20:26:33.412Z,1738614393.412 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:26:33.580Z,1738614393.580 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:26:33.956Z,1738614393.956 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:26:33.956Z,1738614393.956 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-02-03T20:26:54.442Z,1738614414.442 [NAL9602](INFO): Powering up NAL9602
2025-02-03T20:27:05.364Z,1738614425.364 [NAL9602](INFO): NAL9602 initialized
2025-02-03T20:27:17.088Z,1738614437.088 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T20:27:17.088Z,1738614437.088 [Default:CheckIn:C.Wait] Stopped
2025-02-03T20:27:17.088Z,1738614437.088 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T20:27:17.088Z,1738614437.088 [Default:CheckIn:D] Running Loop=1
2025-02-03T20:27:17.506Z,1738614437.506 [Default:CheckIn:D] Stopped
2025-02-03T20:27:17.506Z,1738614437.506 [Default:CheckIn:E] Running Loop=1
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.964185 min
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn:E] Stopped
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn] Stopped
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn](INFO): Running loop #9
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn] Running Loop=9
2025-02-03T20:27:17.899Z,1738614437.899 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T20:27:17.900Z,1738614437.900 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T20:29:34.433Z,1738614574.433 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-02-03T20:29:34.433Z,1738614574.433 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:29:34.588Z,1738614574.588 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:29:34.980Z,1738614574.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:29:34.980Z,1738614574.980 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-02-03T20:32:18.091Z,1738614738.091 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T20:27:17.9Z
2025-02-03T20:32:18.091Z,1738614738.091 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T20:32:18.091Z,1738614738.091 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T20:32:25.696Z,1738614745.696 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20250203T185858/Courier0028.lzma
2025-02-03T20:32:26.700Z,1738614746.700 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0028.lzma.bak
2025-02-03T20:32:26.700Z,1738614746.700 [DataOverHttps](INFO): SBD MOMSN=23952917
2025-02-03T20:32:35.445Z,1738614755.445 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-02-03T20:32:35.445Z,1738614755.445 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:32:35.610Z,1738614755.610 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:32:35.996Z,1738614755.996 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:32:35.996Z,1738614755.996 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-02-03T20:32:42.460Z,1738614762.460 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250203T185858/Express0029.lzma
2025-02-03T20:32:43.462Z,1738614763.462 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0029.lzma.bak
2025-02-03T20:32:43.462Z,1738614763.462 [DataOverHttps](INFO): SBD MOMSN=23952919
2025-02-03T20:32:44.746Z,1738614764.746 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T20:32:44.746Z,1738614764.746 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T20:32:44.746Z,1738614764.746 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T20:35:36.433Z,1738614936.433 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-02-03T20:35:36.433Z,1738614936.433 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:35:36.576Z,1738614936.576 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:35:36.980Z,1738614936.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:35:36.980Z,1738614936.980 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-02-03T20:37:07.326Z,1738615027.326 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T20:37:07.326Z,1738615027.326 [NAL9602] Data Fault, FailCount= 4
2025-02-03T20:37:07.326Z,1738615027.326 [NAL9602](ERROR): Data Fault
2025-02-03T20:37:07.476Z,1738615027.476 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T20:37:07.731Z,1738615027.731 [NAL9602](INFO): Powering down
2025-02-03T20:37:08.692Z,1738615028.692 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T20:37:08.692Z,1738615028.692 [NAL9602] No Fault, FailCount= 4
2025-02-03T20:37:38.030Z,1738615058.030 [NAL9602](INFO): Powering up NAL9602
2025-02-03T20:37:45.309Z,1738615065.309 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T20:37:45.309Z,1738615065.309 [Default:CheckIn:C.Wait] Stopped
2025-02-03T20:37:45.309Z,1738615065.309 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T20:37:45.309Z,1738615065.309 [Default:CheckIn:D] Running Loop=1
2025-02-03T20:37:45.717Z,1738615065.717 [Default:CheckIn:D] Stopped
2025-02-03T20:37:45.717Z,1738615065.717 [Default:CheckIn:E] Running Loop=1
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.434375 min
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn:E] Stopped
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn] Stopped
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn](INFO): Running loop #10
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn] Running Loop=10
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T20:37:46.125Z,1738615066.125 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T20:37:48.938Z,1738615068.938 [NAL9602](INFO): NAL9602 initialized
2025-02-03T20:38:37.424Z,1738615117.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-02-03T20:38:37.425Z,1738615117.425 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:38:37.589Z,1738615117.589 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:38:37.980Z,1738615117.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:38:37.980Z,1738615117.980 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-02-03T20:41:38.416Z,1738615298.416 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-02-03T20:41:38.416Z,1738615298.416 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:41:38.565Z,1738615298.565 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:41:38.972Z,1738615298.972 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:41:38.972Z,1738615298.972 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-02-03T20:42:46.298Z,1738615366.298 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T20:37:46.1Z
2025-02-03T20:42:46.298Z,1738615366.298 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T20:42:46.298Z,1738615366.298 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T20:42:54.100Z,1738615374.100 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0031.lzma
2025-02-03T20:42:55.102Z,1738615375.102 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0031.lzma.bak
2025-02-03T20:42:55.102Z,1738615375.102 [DataOverHttps](INFO): SBD MOMSN=23952929
2025-02-03T20:43:10.802Z,1738615390.802 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250203T185858/Express0032.lzma
2025-02-03T20:43:11.802Z,1738615391.802 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0032.lzma.bak
2025-02-03T20:43:11.803Z,1738615391.803 [DataOverHttps](INFO): SBD MOMSN=23952931
2025-02-03T20:43:12.958Z,1738615392.958 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T20:43:12.958Z,1738615392.958 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T20:43:12.958Z,1738615392.958 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T20:44:39.413Z,1738615479.413 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-02-03T20:44:39.413Z,1738615479.413 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:44:39.581Z,1738615479.581 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:44:39.988Z,1738615479.988 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:44:39.988Z,1738615479.988 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-02-03T20:47:40.421Z,1738615660.421 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-02-03T20:47:40.422Z,1738615660.422 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:47:40.592Z,1738615660.592 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:47:40.977Z,1738615660.977 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:47:40.977Z,1738615660.977 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-02-03T20:47:50.098Z,1738615670.098 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T20:47:50.098Z,1738615670.098 [NAL9602] Data Fault, FailCount= 5
2025-02-03T20:47:50.098Z,1738615670.098 [NAL9602](ERROR): Data Fault
2025-02-03T20:47:50.272Z,1738615670.272 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T20:47:50.273Z,1738615670.273 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-02-03T20:47:50.490Z,1738615670.490 [NAL9602](INFO): Powering down
2025-02-03T20:47:50.659Z,1738615670.659 [CBIT](INFO): Critical error at 20250203T204750
2025-02-03T20:48:13.522Z,1738615693.522 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T20:48:13.522Z,1738615693.522 [Default:CheckIn:C.Wait] Stopped
2025-02-03T20:48:13.522Z,1738615693.522 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T20:48:13.522Z,1738615693.522 [Default:CheckIn:D] Running Loop=1
2025-02-03T20:48:13.934Z,1738615693.934 [Default:CheckIn:D] Stopped
2025-02-03T20:48:13.935Z,1738615693.935 [Default:CheckIn:E] Running Loop=1
2025-02-03T20:48:14.349Z,1738615694.349 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.904663 min
2025-02-03T20:48:14.349Z,1738615694.349 [Default:CheckIn:E] Stopped
2025-02-03T20:48:14.349Z,1738615694.349 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T20:48:14.349Z,1738615694.349 [Default:CheckIn] Stopped
2025-02-03T20:48:14.349Z,1738615694.349 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T20:48:14.349Z,1738615694.349 [Default:CheckIn](INFO): Running loop #11
2025-02-03T20:48:14.350Z,1738615694.350 [Default:CheckIn] Running Loop=11
2025-02-03T20:48:14.350Z,1738615694.350 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T20:48:14.350Z,1738615694.350 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T20:49:18.572Z,1738615758.572 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging
2025-02-03T20:49:50.336Z,1738615790.336 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T20:49:50.336Z,1738615790.336 [NAL9602] No Fault, FailCount= 5
2025-02-03T20:49:50.486Z,1738615790.486 [NAL9602](INFO): Powering up NAL9602
2025-02-03T20:50:01.390Z,1738615801.390 [NAL9602](INFO): NAL9602 initialized
2025-02-03T20:50:41.462Z,1738615841.462 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-02-03T20:50:41.462Z,1738615841.462 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:50:41.624Z,1738615841.624 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:50:42.008Z,1738615842.008 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:50:42.008Z,1738615842.008 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-02-03T20:53:14.576Z,1738615994.576 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T20:48:14.3Z
2025-02-03T20:53:14.576Z,1738615994.576 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T20:53:14.576Z,1738615994.576 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T20:53:21.592Z,1738616001.592 [DataOverHttps](INFO): Sending 83 bytes from file Logs/20250203T185858/Courier0034.lzma
2025-02-03T20:53:22.594Z,1738616002.594 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0034.lzma.bak
2025-02-03T20:53:22.594Z,1738616002.594 [DataOverHttps](INFO): SBD MOMSN=23952944
2025-02-03T20:53:38.328Z,1738616018.328 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0035.lzma
2025-02-03T20:53:39.330Z,1738616019.330 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0035.lzma.bak
2025-02-03T20:53:39.331Z,1738616019.331 [DataOverHttps](INFO): SBD MOMSN=23952947
2025-02-03T20:53:40.830Z,1738616020.830 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T20:53:40.830Z,1738616020.830 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T20:53:40.830Z,1738616020.830 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T20:53:42.472Z,1738616022.472 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-02-03T20:53:42.472Z,1738616022.472 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:53:42.632Z,1738616022.632 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:53:43.036Z,1738616023.036 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:53:43.036Z,1738616023.036 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-02-03T20:56:43.462Z,1738616203.462 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-02-03T20:56:43.462Z,1738616203.462 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:56:43.616Z,1738616203.616 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:56:44.008Z,1738616204.008 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:56:44.009Z,1738616204.009 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-02-03T20:58:41.410Z,1738616321.410 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T20:58:41.410Z,1738616321.410 [Default:CheckIn:C.Wait] Stopped
2025-02-03T20:58:41.410Z,1738616321.410 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T20:58:41.410Z,1738616321.410 [Default:CheckIn:D] Running Loop=1
2025-02-03T20:58:41.820Z,1738616321.820 [Default:CheckIn:D] Stopped
2025-02-03T20:58:41.820Z,1738616321.820 [Default:CheckIn:E] Running Loop=1
2025-02-03T20:58:42.246Z,1738616322.246 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 115.369434 min
2025-02-03T20:58:42.246Z,1738616322.246 [Default:CheckIn:E] Stopped
2025-02-03T20:58:42.246Z,1738616322.246 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T20:58:42.246Z,1738616322.246 [Default:CheckIn] Stopped
2025-02-03T20:58:42.246Z,1738616322.246 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T20:58:42.246Z,1738616322.246 [Default:CheckIn](INFO): Running loop #12
2025-02-03T20:58:42.247Z,1738616322.247 [Default:CheckIn] Running Loop=12
2025-02-03T20:58:42.247Z,1738616322.247 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T20:58:42.247Z,1738616322.247 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T20:59:44.429Z,1738616384.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-02-03T20:59:44.429Z,1738616384.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T20:59:44.576Z,1738616384.576 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T20:59:44.981Z,1738616384.981 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T20:59:44.981Z,1738616384.981 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-02-03T21:00:02.603Z,1738616402.603 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T21:00:02.603Z,1738616402.603 [NAL9602] Data Fault, FailCount= 1
2025-02-03T21:00:02.603Z,1738616402.603 [NAL9602](ERROR): Data Fault
2025-02-03T21:00:02.748Z,1738616402.748 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T21:00:03.006Z,1738616403.006 [NAL9602](INFO): Powering down
2025-02-03T21:00:03.964Z,1738616403.964 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T21:00:03.964Z,1738616403.964 [NAL9602] No Fault, FailCount= 1
2025-02-03T21:00:33.310Z,1738616433.310 [NAL9602](INFO): Powering up NAL9602
2025-02-03T21:00:44.218Z,1738616444.218 [NAL9602](INFO): NAL9602 initialized
2025-02-03T21:02:45.424Z,1738616565.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-02-03T21:02:45.424Z,1738616565.424 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:02:45.592Z,1738616565.592 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:02:45.972Z,1738616565.972 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:02:45.972Z,1738616565.972 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-02-03T21:03:42.414Z,1738616622.414 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T20:58:42.2Z
2025-02-03T21:03:42.414Z,1738616622.414 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T21:03:42.414Z,1738616622.414 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T21:03:49.548Z,1738616629.548 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0037.lzma
2025-02-03T21:03:50.550Z,1738616630.550 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0037.lzma.bak
2025-02-03T21:03:50.550Z,1738616630.550 [DataOverHttps](INFO): SBD MOMSN=23952957
2025-02-03T21:04:06.556Z,1738616646.556 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250203T185858/Express0038.lzma
2025-02-03T21:04:07.558Z,1738616647.558 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0038.lzma.bak
2025-02-03T21:04:07.558Z,1738616647.558 [DataOverHttps](INFO): SBD MOMSN=23952959
2025-02-03T21:04:09.053Z,1738616649.053 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T21:04:09.053Z,1738616649.053 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T21:04:09.054Z,1738616649.054 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T21:05:46.424Z,1738616746.424 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-02-03T21:05:46.424Z,1738616746.424 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:05:46.568Z,1738616746.568 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:05:46.968Z,1738616746.968 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:05:46.968Z,1738616746.968 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-02-03T21:08:47.431Z,1738616927.431 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-02-03T21:08:47.431Z,1738616927.431 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:08:47.580Z,1738616927.580 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:08:47.998Z,1738616927.998 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:08:47.998Z,1738616927.998 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-02-03T21:09:09.629Z,1738616949.629 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T21:09:09.629Z,1738616949.629 [Default:CheckIn:C.Wait] Stopped
2025-02-03T21:09:09.629Z,1738616949.629 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T21:09:09.630Z,1738616949.630 [Default:CheckIn:D] Running Loop=1
2025-02-03T21:09:10.064Z,1738616950.064 [Default:CheckIn:D] Stopped
2025-02-03T21:09:10.064Z,1738616950.064 [Default:CheckIn:E] Running Loop=1
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 125.840153 min
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn:E] Stopped
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn] Stopped
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn](INFO): Running loop #13
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn] Running Loop=13
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T21:09:10.459Z,1738616950.459 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T21:10:45.370Z,1738617045.370 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T21:10:45.370Z,1738617045.370 [NAL9602] Data Fault, FailCount= 2
2025-02-03T21:10:45.370Z,1738617045.370 [NAL9602](ERROR): Data Fault
2025-02-03T21:10:45.544Z,1738617045.544 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T21:10:45.774Z,1738617045.774 [NAL9602](INFO): Powering down
2025-02-03T21:10:46.728Z,1738617046.728 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T21:10:46.728Z,1738617046.728 [NAL9602] No Fault, FailCount= 2
2025-02-03T21:11:16.074Z,1738617076.074 [NAL9602](INFO): Powering up NAL9602
2025-02-03T21:11:26.982Z,1738617086.982 [NAL9602](INFO): NAL9602 initialized
2025-02-03T21:11:48.401Z,1738617108.401 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-02-03T21:11:48.401Z,1738617108.401 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:11:48.560Z,1738617108.560 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:11:48.976Z,1738617108.976 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:11:48.976Z,1738617108.976 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-02-03T21:14:10.643Z,1738617250.643 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T21:09:10.5Z
2025-02-03T21:14:10.643Z,1738617250.643 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T21:14:10.643Z,1738617250.643 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T21:14:17.716Z,1738617257.716 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0040.lzma
2025-02-03T21:14:18.718Z,1738617258.718 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0040.lzma.bak
2025-02-03T21:14:18.718Z,1738617258.718 [DataOverHttps](INFO): SBD MOMSN=23953099
2025-02-03T21:14:34.408Z,1738617274.408 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250203T185858/Express0041.lzma
2025-02-03T21:14:35.410Z,1738617275.410 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0041.lzma.bak
2025-02-03T21:14:35.410Z,1738617275.410 [DataOverHttps](INFO): SBD MOMSN=23953101
2025-02-03T21:14:36.534Z,1738617276.534 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T21:14:36.535Z,1738617276.535 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T21:14:36.535Z,1738617276.535 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T21:14:49.477Z,1738617289.477 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-02-03T21:14:49.477Z,1738617289.477 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:14:49.620Z,1738617289.620 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:14:49.621Z,1738617289.621 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:19:37.138Z,1738617577.138 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T21:19:37.138Z,1738617577.138 [Default:CheckIn:C.Wait] Stopped
2025-02-03T21:19:37.138Z,1738617577.138 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T21:19:37.138Z,1738617577.138 [Default:CheckIn:D] Running Loop=1
2025-02-03T21:19:37.538Z,1738617577.538 [Default:CheckIn:D] Stopped
2025-02-03T21:19:37.538Z,1738617577.538 [Default:CheckIn:E] Running Loop=1
2025-02-03T21:19:37.922Z,1738617577.922 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 136.298055 min
2025-02-03T21:19:37.922Z,1738617577.922 [Default:CheckIn:E] Stopped
2025-02-03T21:19:37.922Z,1738617577.922 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T21:19:37.922Z,1738617577.922 [Default:CheckIn] Stopped
2025-02-03T21:19:37.922Z,1738617577.922 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T21:19:37.923Z,1738617577.923 [Default:CheckIn](INFO): Running loop #14
2025-02-03T21:19:37.923Z,1738617577.923 [Default:CheckIn] Running Loop=14
2025-02-03T21:19:37.923Z,1738617577.923 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T21:19:37.923Z,1738617577.923 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T21:21:27.798Z,1738617687.798 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T21:21:27.798Z,1738617687.798 [NAL9602] Data Fault, FailCount= 3
2025-02-03T21:21:27.798Z,1738617687.798 [NAL9602](ERROR): Data Fault
2025-02-03T21:21:27.968Z,1738617687.968 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T21:21:28.207Z,1738617688.207 [NAL9602](INFO): Powering down
2025-02-03T21:21:29.169Z,1738617689.169 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T21:21:29.169Z,1738617689.169 [NAL9602] No Fault, FailCount= 3
2025-02-03T21:21:58.507Z,1738617718.507 [NAL9602](INFO): Powering up NAL9602
2025-02-03T21:22:09.410Z,1738617729.410 [NAL9602](INFO): NAL9602 initialized
2025-02-03T21:22:56.675Z,1738617776.675 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:23:08.389Z,1738617788.389 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:23:20.216Z,1738617800.216 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:23:32.629Z,1738617812.629 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:23:44.749Z,1738617824.749 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:23:56.869Z,1738617836.869 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:24:08.585Z,1738617848.585 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:24:20.302Z,1738617860.302 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:24:38.107Z,1738617878.107 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T21:19:37.9Z
2025-02-03T21:24:38.107Z,1738617878.107 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T21:24:38.107Z,1738617878.107 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T21:24:38.907Z,1738617878.907 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T21:24:38.907Z,1738617878.907 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T21:24:38.907Z,1738617878.907 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T21:26:46.152Z,1738618006.152 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:26:58.265Z,1738618018.265 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:27:10.789Z,1738618030.789 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:27:22.909Z,1738618042.909 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:27:35.029Z,1738618055.029 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:27:47.149Z,1738618067.149 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:27:58.873Z,1738618078.873 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:28:10.990Z,1738618090.990 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:28:23.105Z,1738618103.105 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:28:34.823Z,1738618114.823 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:28:46.549Z,1738618126.549 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:28:59.076Z,1738618139.076 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T21:29:12.804Z,1738618152.804 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2025-02-03T21:29:12.806Z,1738618152.806 [BPC1](INFO): Received data from all battery sticks.
2025-02-03T21:29:39.482Z,1738618179.482 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T21:29:39.482Z,1738618179.482 [Default:CheckIn:C.Wait] Stopped
2025-02-03T21:29:39.482Z,1738618179.482 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T21:29:39.482Z,1738618179.482 [Default:CheckIn:D] Running Loop=1
2025-02-03T21:29:39.881Z,1738618179.881 [Default:CheckIn:D] Stopped
2025-02-03T21:29:39.881Z,1738618179.881 [Default:CheckIn:E] Running Loop=1
2025-02-03T21:29:40.314Z,1738618180.314 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 146.337109 min
2025-02-03T21:29:40.314Z,1738618180.314 [Default:CheckIn:E] Stopped
2025-02-03T21:29:40.314Z,1738618180.314 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T21:29:40.314Z,1738618180.314 [Default:CheckIn] Stopped
2025-02-03T21:29:40.315Z,1738618180.315 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T21:29:40.315Z,1738618180.315 [Default:CheckIn](INFO): Running loop #15
2025-02-03T21:29:40.315Z,1738618180.315 [Default:CheckIn] Running Loop=15
2025-02-03T21:29:40.315Z,1738618180.315 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T21:29:40.315Z,1738618180.315 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T21:29:49.736Z,1738618189.736 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:29:49.736Z,1738618189.736 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2025-02-03T21:32:11.390Z,1738618331.390 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T21:32:11.390Z,1738618331.390 [NAL9602] Data Fault, FailCount= 4
2025-02-03T21:32:11.390Z,1738618331.390 [NAL9602](ERROR): Data Fault
2025-02-03T21:32:11.561Z,1738618331.561 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T21:32:11.790Z,1738618331.790 [NAL9602](INFO): Powering down
2025-02-03T21:32:12.752Z,1738618332.752 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T21:32:12.752Z,1738618332.752 [NAL9602] No Fault, FailCount= 4
2025-02-03T21:32:42.090Z,1738618362.090 [NAL9602](INFO): Powering up NAL9602
2025-02-03T21:32:50.208Z,1738618370.208 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-02-03T21:32:50.209Z,1738618370.209 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:32:50.364Z,1738618370.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:32:50.756Z,1738618370.756 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:32:50.756Z,1738618370.756 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-02-03T21:32:53.003Z,1738618373.003 [NAL9602](INFO): NAL9602 initialized
2025-02-03T21:34:40.475Z,1738618480.475 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T21:29:40.3Z
2025-02-03T21:34:40.475Z,1738618480.475 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T21:34:40.475Z,1738618480.475 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T21:34:48.139Z,1738618488.139 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0043.lzma
2025-02-03T21:34:49.142Z,1738618489.142 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0043.lzma.bak
2025-02-03T21:34:49.142Z,1738618489.142 [DataOverHttps](INFO): SBD MOMSN=23953105
2025-02-03T21:35:04.940Z,1738618504.940 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20250203T185858/Courier0046.lzma
2025-02-03T21:35:05.942Z,1738618505.942 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0046.lzma.bak
2025-02-03T21:35:05.942Z,1738618505.942 [DataOverHttps](INFO): SBD MOMSN=23953107
2025-02-03T21:35:21.960Z,1738618521.960 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20250203T185858/Express0044.lzma
2025-02-03T21:35:22.963Z,1738618522.963 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0044.lzma.bak
2025-02-03T21:35:22.963Z,1738618522.963 [DataOverHttps](INFO): SBD MOMSN=23953109
2025-02-03T21:35:38.644Z,1738618538.644 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0047.lzma
2025-02-03T21:35:39.646Z,1738618539.646 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0047.lzma.bak
2025-02-03T21:35:39.646Z,1738618539.646 [DataOverHttps](INFO): SBD MOMSN=23953114
2025-02-03T21:35:41.069Z,1738618541.069 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T21:35:41.069Z,1738618541.069 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T21:35:41.070Z,1738618541.070 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T21:35:51.193Z,1738618551.193 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-02-03T21:35:51.193Z,1738618551.193 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:35:51.344Z,1738618551.344 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:35:51.720Z,1738618551.720 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:35:51.720Z,1738618551.720 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-02-03T21:38:52.181Z,1738618732.181 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-02-03T21:38:52.181Z,1738618732.181 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:38:52.325Z,1738618732.325 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:38:52.708Z,1738618732.708 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:38:52.708Z,1738618732.708 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-02-03T21:40:41.657Z,1738618841.657 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T21:40:41.657Z,1738618841.657 [Default:CheckIn:C.Wait] Stopped
2025-02-03T21:40:41.657Z,1738618841.657 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T21:40:41.657Z,1738618841.657 [Default:CheckIn:D] Running Loop=1
2025-02-03T21:40:42.054Z,1738618842.054 [Default:CheckIn:D] Stopped
2025-02-03T21:40:42.054Z,1738618842.054 [Default:CheckIn:E] Running Loop=1
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 157.373324 min
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn:E] Stopped
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn] Stopped
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn](INFO): Running loop #16
2025-02-03T21:40:42.458Z,1738618842.458 [Default:CheckIn] Running Loop=16
2025-02-03T21:40:42.459Z,1738618842.459 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T21:40:42.459Z,1738618842.459 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T21:41:53.154Z,1738618913.154 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-02-03T21:41:53.154Z,1738618913.154 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:41:53.309Z,1738618913.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:41:53.722Z,1738618913.722 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:41:53.722Z,1738618913.722 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-02-03T21:42:55.391Z,1738618975.391 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T21:42:55.391Z,1738618975.391 [NAL9602] Data Fault, FailCount= 5
2025-02-03T21:42:55.391Z,1738618975.391 [NAL9602](ERROR): Data Fault
2025-02-03T21:42:55.552Z,1738618975.552 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T21:42:55.552Z,1738618975.552 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-02-03T21:42:55.799Z,1738618975.799 [NAL9602](INFO): Powering down
2025-02-03T21:42:55.951Z,1738618975.951 [CBIT](INFO): Critical error at 20250203T214255
2025-02-03T21:44:54.188Z,1738619094.188 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-02-03T21:44:54.188Z,1738619094.188 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:44:54.332Z,1738619094.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:44:54.736Z,1738619094.736 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:44:54.736Z,1738619094.736 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-02-03T21:44:55.528Z,1738619095.528 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T21:44:55.528Z,1738619095.528 [NAL9602] No Fault, FailCount= 5
2025-02-03T21:44:55.775Z,1738619095.775 [NAL9602](INFO): Powering up NAL9602
2025-02-03T21:45:06.691Z,1738619106.691 [NAL9602](INFO): NAL9602 initialized
2025-02-03T21:45:42.656Z,1738619142.656 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T21:40:42.5Z
2025-02-03T21:45:42.656Z,1738619142.656 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T21:45:42.656Z,1738619142.656 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T21:45:50.008Z,1738619150.008 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20250203T185858/Courier0049.lzma
2025-02-03T21:45:51.010Z,1738619151.010 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0049.lzma.bak
2025-02-03T21:45:51.010Z,1738619151.010 [DataOverHttps](INFO): SBD MOMSN=23953118
2025-02-03T21:46:05.718Z,1738619165.718 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20250203T185858/Express0050.lzma
2025-02-03T21:46:06.710Z,1738619166.710 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0050.lzma.bak
2025-02-03T21:46:06.710Z,1738619166.710 [DataOverHttps](INFO): SBD MOMSN=23953121
2025-02-03T21:46:08.105Z,1738619168.105 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T21:46:08.105Z,1738619168.105 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T21:46:08.106Z,1738619168.106 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T21:47:55.171Z,1738619275.171 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-02-03T21:47:55.171Z,1738619275.171 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:47:55.304Z,1738619275.304 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:47:55.726Z,1738619275.726 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:47:55.726Z,1738619275.726 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-02-03T21:50:56.160Z,1738619456.160 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-02-03T21:50:56.160Z,1738619456.160 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:50:56.320Z,1738619456.320 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:50:56.732Z,1738619456.732 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:50:56.732Z,1738619456.732 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-02-03T21:51:08.692Z,1738619468.692 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T21:51:08.692Z,1738619468.692 [Default:CheckIn:C.Wait] Stopped
2025-02-03T21:51:08.692Z,1738619468.692 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T21:51:08.692Z,1738619468.692 [Default:CheckIn:D] Running Loop=1
2025-02-03T21:51:09.090Z,1738619469.090 [Default:CheckIn:D] Stopped
2025-02-03T21:51:09.090Z,1738619469.090 [Default:CheckIn:E] Running Loop=1
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 167.823910 min
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn:E] Stopped
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn] Stopped
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn](INFO): Running loop #17
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn] Running Loop=17
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T21:51:09.522Z,1738619469.522 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T21:53:57.157Z,1738619637.157 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-02-03T21:53:57.157Z,1738619637.157 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:53:57.296Z,1738619637.296 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:53:57.712Z,1738619637.712 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:53:57.712Z,1738619637.712 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-02-03T21:55:07.846Z,1738619707.846 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T21:55:07.846Z,1738619707.846 [NAL9602] Data Fault, FailCount= 1
2025-02-03T21:55:07.846Z,1738619707.846 [NAL9602](ERROR): Data Fault
2025-02-03T21:55:07.996Z,1738619707.996 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T21:55:08.246Z,1738619708.246 [NAL9602](INFO): Powering down
2025-02-03T21:55:09.212Z,1738619709.212 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T21:55:09.212Z,1738619709.212 [NAL9602] No Fault, FailCount= 1
2025-02-03T21:55:38.550Z,1738619738.550 [NAL9602](INFO): Powering up NAL9602
2025-02-03T21:55:49.454Z,1738619749.454 [NAL9602](INFO): NAL9602 initialized
2025-02-03T21:56:09.663Z,1738619769.663 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T21:51:09.5Z
2025-02-03T21:56:09.663Z,1738619769.663 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T21:56:09.663Z,1738619769.663 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T21:56:10.475Z,1738619770.475 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T21:56:10.476Z,1738619770.476 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T21:56:10.476Z,1738619770.476 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T21:56:58.161Z,1738619818.161 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-02-03T21:56:58.161Z,1738619818.161 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:56:58.308Z,1738619818.308 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:56:58.688Z,1738619818.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:56:58.688Z,1738619818.688 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-02-03T21:59:59.166Z,1738619999.166 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-02-03T21:59:59.166Z,1738619999.166 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T21:59:59.316Z,1738619999.316 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T21:59:59.696Z,1738619999.696 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T21:59:59.696Z,1738619999.696 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-02-03T22:01:11.119Z,1738620071.119 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T22:01:11.119Z,1738620071.119 [Default:CheckIn:C.Wait] Stopped
2025-02-03T22:01:11.119Z,1738620071.119 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T22:01:11.119Z,1738620071.119 [Default:CheckIn:D] Running Loop=1
2025-02-03T22:01:11.510Z,1738620071.510 [Default:CheckIn:D] Stopped
2025-02-03T22:01:11.510Z,1738620071.510 [Default:CheckIn:E] Running Loop=1
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 177.864258 min
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn:E] Stopped
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn] Stopped
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn](INFO): Running loop #18
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn] Running Loop=18
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T22:01:11.914Z,1738620071.914 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T22:03:00.209Z,1738620180.209 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-02-03T22:03:00.209Z,1738620180.209 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:03:00.352Z,1738620180.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:03:00.760Z,1738620180.760 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:03:00.760Z,1738620180.760 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-02-03T22:05:50.266Z,1738620350.266 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T22:05:50.266Z,1738620350.266 [NAL9602] Data Fault, FailCount= 2
2025-02-03T22:05:50.266Z,1738620350.266 [NAL9602](ERROR): Data Fault
2025-02-03T22:05:50.432Z,1738620350.432 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T22:05:50.662Z,1738620350.662 [NAL9602](INFO): Powering down
2025-02-03T22:05:51.648Z,1738620351.648 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T22:05:51.648Z,1738620351.648 [NAL9602] No Fault, FailCount= 2
2025-02-03T22:06:01.172Z,1738620361.172 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-02-03T22:06:01.172Z,1738620361.172 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:06:01.317Z,1738620361.317 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:06:01.720Z,1738620361.720 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:06:01.720Z,1738620361.720 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-02-03T22:06:12.085Z,1738620372.085 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T22:01:11.9Z
2025-02-03T22:06:12.085Z,1738620372.085 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T22:06:12.085Z,1738620372.085 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T22:06:19.827Z,1738620379.827 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0052.lzma
2025-02-03T22:06:20.830Z,1738620380.830 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0052.lzma.bak
2025-02-03T22:06:20.830Z,1738620380.830 [DataOverHttps](INFO): SBD MOMSN=23953125
2025-02-03T22:06:20.966Z,1738620380.966 [NAL9602](INFO): Powering up NAL9602
2025-02-03T22:06:31.870Z,1738620391.870 [NAL9602](INFO): NAL9602 initialized
2025-02-03T22:06:36.592Z,1738620396.592 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0055.lzma
2025-02-03T22:06:37.594Z,1738620397.594 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0055.lzma.bak
2025-02-03T22:06:37.594Z,1738620397.594 [DataOverHttps](INFO): SBD MOMSN=23953127
2025-02-03T22:06:53.314Z,1738620413.314 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0053.lzma
2025-02-03T22:06:54.314Z,1738620414.314 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0053.lzma.bak
2025-02-03T22:06:54.314Z,1738620414.314 [DataOverHttps](INFO): SBD MOMSN=23953129
2025-02-03T22:07:10.148Z,1738620430.148 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250203T185858/Express0056.lzma
2025-02-03T22:07:11.150Z,1738620431.150 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0056.lzma.bak
2025-02-03T22:07:11.150Z,1738620431.150 [DataOverHttps](INFO): SBD MOMSN=23953133
2025-02-03T22:07:12.306Z,1738620432.306 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T22:07:12.306Z,1738620432.306 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T22:07:12.306Z,1738620432.306 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T22:09:02.183Z,1738620542.183 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-02-03T22:09:02.183Z,1738620542.183 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:09:02.325Z,1738620542.325 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:09:02.748Z,1738620542.748 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:09:02.748Z,1738620542.748 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-02-03T22:12:03.174Z,1738620723.174 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-02-03T22:12:03.174Z,1738620723.174 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:12:03.321Z,1738620723.321 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:12:03.712Z,1738620723.712 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:12:03.712Z,1738620723.712 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-02-03T22:12:12.874Z,1738620732.874 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T22:12:12.874Z,1738620732.874 [Default:CheckIn:C.Wait] Stopped
2025-02-03T22:12:12.875Z,1738620732.875 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T22:12:12.875Z,1738620732.875 [Default:CheckIn:D] Running Loop=1
2025-02-03T22:12:13.274Z,1738620733.274 [Default:CheckIn:D] Stopped
2025-02-03T22:12:13.274Z,1738620733.274 [Default:CheckIn:E] Running Loop=1
2025-02-03T22:12:13.674Z,1738620733.674 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 188.893669 min
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn:E] Stopped
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn] Stopped
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn](INFO): Running loop #19
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn] Running Loop=19
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T22:12:13.675Z,1738620733.675 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T22:15:04.173Z,1738620904.173 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-02-03T22:15:04.173Z,1738620904.173 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:15:04.332Z,1738620904.332 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:15:04.716Z,1738620904.716 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:15:04.716Z,1738620904.716 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-02-03T22:16:33.026Z,1738620993.026 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T22:16:33.026Z,1738620993.026 [NAL9602] Data Fault, FailCount= 3
2025-02-03T22:16:33.026Z,1738620993.026 [NAL9602](ERROR): Data Fault
2025-02-03T22:16:33.188Z,1738620993.188 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T22:16:33.430Z,1738620993.430 [NAL9602](INFO): Powering down
2025-02-03T22:16:34.396Z,1738620994.396 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T22:16:34.396Z,1738620994.396 [NAL9602] No Fault, FailCount= 3
2025-02-03T22:17:03.730Z,1738621023.730 [NAL9602](INFO): Powering up NAL9602
2025-02-03T22:17:13.838Z,1738621033.838 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T22:12:13.7Z
2025-02-03T22:17:13.838Z,1738621033.838 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T22:17:13.838Z,1738621033.838 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T22:17:14.634Z,1738621034.634 [NAL9602](INFO): NAL9602 initialized
2025-02-03T22:17:21.419Z,1738621041.419 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0058.lzma
2025-02-03T22:17:22.422Z,1738621042.422 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0058.lzma.bak
2025-02-03T22:17:22.422Z,1738621042.422 [DataOverHttps](INFO): SBD MOMSN=23953208
2025-02-03T22:17:38.164Z,1738621058.164 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0059.lzma
2025-02-03T22:17:39.162Z,1738621059.162 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0059.lzma.bak
2025-02-03T22:17:39.162Z,1738621059.162 [DataOverHttps](INFO): SBD MOMSN=23953210
2025-02-03T22:17:40.530Z,1738621060.530 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T22:17:40.530Z,1738621060.530 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T22:17:40.530Z,1738621060.530 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T22:18:05.161Z,1738621085.161 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-02-03T22:18:05.161Z,1738621085.161 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:18:05.312Z,1738621085.312 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:18:05.720Z,1738621085.720 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:18:05.720Z,1738621085.720 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-02-03T22:21:06.145Z,1738621266.145 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-02-03T22:21:06.145Z,1738621266.145 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:21:06.293Z,1738621266.293 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:21:06.688Z,1738621266.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:21:06.688Z,1738621266.688 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-02-03T22:22:41.085Z,1738621361.085 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T22:22:41.085Z,1738621361.085 [Default:CheckIn:C.Wait] Stopped
2025-02-03T22:22:41.085Z,1738621361.085 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T22:22:41.086Z,1738621361.086 [Default:CheckIn:D] Running Loop=1
2025-02-03T22:22:41.482Z,1738621361.482 [Default:CheckIn:D] Stopped
2025-02-03T22:22:41.482Z,1738621361.482 [Default:CheckIn:E] Running Loop=1
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 199.363786 min
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn:E] Stopped
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn] Stopped
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn](INFO): Running loop #20
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn] Running Loop=20
2025-02-03T22:22:41.887Z,1738621361.887 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T22:22:41.888Z,1738621361.888 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T22:24:07.139Z,1738621447.139 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-02-03T22:24:07.139Z,1738621447.139 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:24:07.276Z,1738621447.276 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:24:07.680Z,1738621447.680 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:24:07.680Z,1738621447.680 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-02-03T22:27:08.121Z,1738621628.121 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-02-03T22:27:08.121Z,1738621628.121 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:27:08.285Z,1738621628.285 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:27:08.692Z,1738621628.692 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-03T22:27:08.692Z,1738621628.692 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-02-03T22:27:15.790Z,1738621635.790 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T22:27:15.790Z,1738621635.790 [NAL9602] Data Fault, FailCount= 4
2025-02-03T22:27:15.790Z,1738621635.790 [NAL9602](ERROR): Data Fault
2025-02-03T22:27:15.955Z,1738621635.955 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T22:27:16.194Z,1738621636.194 [NAL9602](INFO): Powering down
2025-02-03T22:27:17.156Z,1738621637.156 [CBIT](INFO): Clearing failed state for component NAL9602
2025-02-03T22:27:17.156Z,1738621637.156 [NAL9602] No Fault, FailCount= 4
2025-02-03T22:27:42.061Z,1738621662.061 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T22:22:41.9Z
2025-02-03T22:27:42.061Z,1738621662.061 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T22:27:42.061Z,1738621662.061 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T22:27:46.490Z,1738621666.490 [NAL9602](INFO): Powering up NAL9602
2025-02-03T22:27:49.047Z,1738621669.047 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250203T185858/Courier0061.lzma
2025-02-03T22:27:50.050Z,1738621670.050 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Courier0061.lzma.bak
2025-02-03T22:27:50.050Z,1738621670.050 [DataOverHttps](INFO): SBD MOMSN=23953219
2025-02-03T22:27:57.411Z,1738621677.411 [NAL9602](INFO): NAL9602 initialized
2025-02-03T22:28:05.772Z,1738621685.772 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20250203T185858/Express0062.lzma
2025-02-03T22:28:06.774Z,1738621686.774 [DataOverHttps](INFO): Moved sent file to Logs/20250203T185858/Express0062.lzma.bak
2025-02-03T22:28:06.774Z,1738621686.774 [DataOverHttps](INFO): SBD MOMSN=23953221
2025-02-03T22:28:07.922Z,1738621687.922 [Default:CheckIn:Read_Iridium] Stopped
2025-02-03T22:28:07.922Z,1738621687.922 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-03T22:28:07.922Z,1738621687.922 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-03T22:30:09.113Z,1738621809.113 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-02-03T22:30:09.113Z,1738621809.113 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-03T22:30:09.264Z,1738621809.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:30:09.264Z,1738621809.264 [CBIT](FAULT): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-03T22:30:18.802Z,1738621818.802 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:30:27.933Z,1738621827.933 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent
2025-02-03T22:30:27.934Z,1738621827.934 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 100.000000 %
2025-02-03T22:30:30.950Z,1738621830.950 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:30:42.261Z,1738621842.261 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:30:53.977Z,1738621853.977 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:31:06.097Z,1738621866.097 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:31:18.217Z,1738621878.217 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:31:29.933Z,1738621889.933 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:31:42.072Z,1738621902.072 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:33:08.531Z,1738621988.531 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-03T22:33:08.531Z,1738621988.531 [Default:CheckIn:C.Wait] Stopped
2025-02-03T22:33:08.531Z,1738621988.531 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-03T22:33:08.531Z,1738621988.531 [Default:CheckIn:D] Running Loop=1
2025-02-03T22:33:08.992Z,1738621988.992 [Default:CheckIn:D] Stopped
2025-02-03T22:33:08.992Z,1738621988.992 [Default:CheckIn:E] Running Loop=1
2025-02-03T22:33:09.371Z,1738621989.371 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 209.822298 min
2025-02-03T22:33:09.372Z,1738621989.372 [Default:CheckIn:E] Stopped
2025-02-03T22:33:09.372Z,1738621989.372 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-03T22:33:09.372Z,1738621989.372 [Default:CheckIn] Stopped
2025-02-03T22:33:09.372Z,1738621989.372 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-03T22:33:09.385Z,1738621989.385 [Default:CheckIn](INFO): Running loop #21
2025-02-03T22:33:09.385Z,1738621989.385 [Default:CheckIn] Running Loop=21
2025-02-03T22:33:09.385Z,1738621989.385 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-03T22:33:09.386Z,1738621989.386 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-03T22:34:08.302Z,1738622048.302 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:34:24.461Z,1738622064.461 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:34:39.817Z,1738622079.817 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:34:55.166Z,1738622095.166 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:35:10.517Z,1738622110.517 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:35:25.472Z,1738622125.472 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:35:41.226Z,1738622141.226 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:35:56.977Z,1738622156.977 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:36:12.733Z,1738622172.733 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:36:27.282Z,1738622187.282 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2025-02-03T22:36:34.153Z,1738622194.153 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2025-02-03T22:36:34.156Z,1738622194.156 [BPC1](INFO): Received data from all battery sticks.
2025-02-03T22:38:00.206Z,1738622280.206 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-02-03T22:38:00.207Z,1738622280.207 [NAL9602] Data Fault, FailCount= 5
2025-02-03T22:38:00.207Z,1738622280.207 [NAL9602](ERROR): Data Fault
2025-02-03T22:38:00.348Z,1738622280.348 [CBIT](ERROR): Data Fault in component: NAL9602
2025-02-03T22:38:00.349Z,1738622280.349 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-02-03T22:38:00.610Z,1738622280.610 [NAL9602](INFO): Powering down
2025-02-03T22:38:00.795Z,1738622280.795 [CBIT](INFO): Critical error at 20250203T223800
2025-02-03T22:38:09.521Z,1738622289.521 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-02-03T22:33:09.4Z
2025-02-03T22:38:09.521Z,1738622289.521 [Default:CheckIn:Read_GPS] Stopped
2025-02-03T22:38:09.521Z,1738622289.521 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-03T2