2024-08-22T14:59:36.678Z,1724338776.678 [Supervisor](DEBUG): Initializing supervisor.
2024-08-22T14:59:36.682Z,1724338776.682 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-08-22T14:59:36.683Z,1724338776.683 [SyncHandler](INFO): Protected caller Thread ID is 837
2024-08-22T14:59:36.683Z,1724338776.683 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-08-22T14:59:36.684Z,1724338776.684 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-08-22T14:59:36.685Z,1724338776.685 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838
2024-08-22T14:59:36.688Z,1724338776.688 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-08-22T14:59:36.706Z,1724338776.706 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-08-22T14:59:36.707Z,1724338776.707 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-08-22T14:59:36.707Z,1724338776.707 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839
2024-08-22T14:59:36.711Z,1724338776.711 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-08-22T14:59:36.712Z,1724338776.712 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-08-22T14:59:36.713Z,1724338776.713 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840
2024-08-22T14:59:36.715Z,1724338776.715 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-08-22T14:59:36.716Z,1724338776.716 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-08-22T14:59:36.716Z,1724338776.716 [logger ThreadHandler](INFO): Protected caller Thread ID is 841
2024-08-22T14:59:36.719Z,1724338776.719 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-08-22T14:59:36.720Z,1724338776.720 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-08-22T14:59:36.724Z,1724338776.724 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-08-22T14:59:37.023Z,1724338777.023 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-08-22T14:59:37.025Z,1724338777.025 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-08-22T14:59:37.122Z,1724338777.122 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-08-22T14:59:37.764Z,1724338777.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-08-22T14:59:37.766Z,1724338777.766 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-08-22T14:59:38.156Z,1724338778.156 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-08-22T14:59:38.158Z,1724338778.158 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-08-22T14:59:38.269Z,1724338778.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-08-22T14:59:38.271Z,1724338778.271 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-08-22T14:59:38.726Z,1724338778.726 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-08-22T14:59:38.728Z,1724338778.728 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-08-22T14:59:38.974Z,1724338778.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-08-22T14:59:38.976Z,1724338778.976 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-08-22T14:59:40.024Z,1724338780.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-08-22T14:59:40.027Z,1724338780.027 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-08-22T14:59:40.183Z,1724338780.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-08-22T14:59:40.185Z,1724338780.185 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-08-22T14:59:40.278Z,1724338780.278 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-08-22T14:59:41.204Z,1724338781.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-08-22T14:59:41.204Z,1724338781.204 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-08-22T14:59:41.632Z,1724338781.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-08-22T14:59:41.634Z,1724338781.634 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-08-22T14:59:41.856Z,1724338781.856 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-08-22T14:59:41.857Z,1724338781.857 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-08-22T14:59:41.986Z,1724338781.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-08-22T14:59:41.987Z,1724338781.987 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-08-22T14:59:42.242Z,1724338782.242 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-08-22T14:59:42.243Z,1724338782.243 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-08-22T14:59:42.527Z,1724338782.527 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-08-22T14:59:42.529Z,1724338782.529 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2024-08-22T14:59:42.531Z,1724338782.531 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2024-08-22T14:59:42.638Z,1724338782.638 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2024-08-22T14:59:42.738Z,1724338782.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2024-08-22T14:59:42.858Z,1724338782.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2024-08-22T14:59:42.957Z,1724338782.957 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2024-08-22T14:59:43.077Z,1724338783.077 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2024-08-22T14:59:43.186Z,1724338783.186 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2024-08-22T14:59:43.322Z,1724338783.322 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2024-08-22T14:59:43.499Z,1724338783.499 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2024-08-22T14:59:43.671Z,1724338783.671 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2024-08-22T14:59:44.021Z,1724338784.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2024-08-22T14:59:44.312Z,1724338784.312 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-08-22T14:59:44.313Z,1724338784.313 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-08-22T14:59:44.324Z,1724338784.324 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-08-22T14:59:44.401Z,1724338784.401 [VerticalControl](DEBUG): Construct VerticalControl.
2024-08-22T14:59:44.463Z,1724338784.463 [VerticalControl] Loaded
2024-08-22T14:59:44.463Z,1724338784.463 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-08-22T14:59:44.466Z,1724338784.466 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-08-22T14:59:44.515Z,1724338784.515 [HorizontalControl] Loaded
2024-08-22T14:59:44.515Z,1724338784.515 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-08-22T14:59:44.517Z,1724338784.517 [SpeedControl](DEBUG): Construct SpeedControl.
2024-08-22T14:59:44.521Z,1724338784.521 [SpeedControl] Loaded
2024-08-22T14:59:44.521Z,1724338784.521 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-08-22T14:59:44.524Z,1724338784.524 [LoopControl](DEBUG): Construct LoopControl.
2024-08-22T14:59:44.524Z,1724338784.524 [LoopControl] Loaded
2024-08-22T14:59:44.524Z,1724338784.524 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-08-22T14:59:44.525Z,1724338784.525 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-08-22T14:59:44.527Z,1724338784.527 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-08-22T14:59:44.542Z,1724338784.542 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-08-22T14:59:44.543Z,1724338784.543 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-08-22T14:59:44.772Z,1724338784.772 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-08-22T14:59:44.773Z,1724338784.773 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-08-22T14:59:45.848Z,1724338785.848 [BuoyancyServo] Loaded
2024-08-22T14:59:45.848Z,1724338785.848 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-08-22T14:59:45.871Z,1724338785.871 [ElevatorServo] Loaded
2024-08-22T14:59:45.871Z,1724338785.871 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-08-22T14:59:45.893Z,1724338785.893 [MassServo] Loaded
2024-08-22T14:59:45.893Z,1724338785.893 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-08-22T14:59:45.914Z,1724338785.914 [RudderServo] Loaded
2024-08-22T14:59:45.914Z,1724338785.914 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-08-22T14:59:45.931Z,1724338785.931 [ThrusterHE] Loaded
2024-08-22T14:59:45.932Z,1724338785.932 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-08-22T14:59:45.932Z,1724338785.932 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-08-22T14:59:45.933Z,1724338785.933 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-08-22T14:59:46.081Z,1724338786.081 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-08-22T14:59:46.082Z,1724338786.082 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-08-22T14:59:46.095Z,1724338786.095 [NavChart] Loaded
2024-08-22T14:59:46.096Z,1724338786.096 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-08-22T14:59:46.101Z,1724338786.101 [UniversalFixResidualReporter] Loaded
2024-08-22T14:59:46.102Z,1724338786.102 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-08-22T14:59:46.102Z,1724338786.102 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-08-22T14:59:46.103Z,1724338786.103 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-08-22T14:59:46.190Z,1724338786.190 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-08-22T14:59:46.191Z,1724338786.191 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-08-22T14:59:46.984Z,1724338786.984 [AHRS_M2] Loaded
2024-08-22T14:59:46.984Z,1724338786.984 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-08-22T14:59:47.855Z,1724338787.855 [BPC1] Loaded
2024-08-22T14:59:47.855Z,1724338787.855 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-08-22T14:59:47.996Z,1724338787.996 [DataOverHttps] Loaded
2024-08-22T14:59:47.996Z,1724338787.996 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-08-22T14:59:47.997Z,1724338787.997 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409314E0
2024-08-22T14:59:47.998Z,1724338787.998 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924
2024-08-22T14:59:48.022Z,1724338788.022 [Depth_Keller] Loaded
2024-08-22T14:59:48.022Z,1724338788.022 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-08-22T14:59:48.027Z,1724338788.027 [DropWeight] Loaded
2024-08-22T14:59:48.028Z,1724338788.028 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-08-22T14:59:48.094Z,1724338788.094 [NAL9602] Loaded
2024-08-22T14:59:48.094Z,1724338788.094 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-08-22T14:59:48.126Z,1724338788.126 [Onboard] Loaded
2024-08-22T14:59:48.126Z,1724338788.126 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-08-22T14:59:48.127Z,1724338788.127 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409614E0
2024-08-22T14:59:48.127Z,1724338788.127 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925
2024-08-22T14:59:48.143Z,1724338788.143 [Power24vConverter] Loaded
2024-08-22T14:59:48.143Z,1724338788.143 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-08-22T14:59:48.159Z,1724338788.159 [Radio_Surface] Loaded
2024-08-22T14:59:48.159Z,1724338788.159 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-08-22T14:59:48.160Z,1724338788.160 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409914E0
2024-08-22T14:59:48.161Z,1724338788.161 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926
2024-08-22T14:59:48.260Z,1724338788.260 [DAT] Loaded
2024-08-22T14:59:48.260Z,1724338788.260 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-08-22T14:59:48.261Z,1724338788.261 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409C14E0
2024-08-22T14:59:48.262Z,1724338788.262 [DAT ThreadHandler](INFO): Protected caller Thread ID is 927
2024-08-22T14:59:48.262Z,1724338788.262 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-08-22T14:59:48.263Z,1724338788.263 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-08-22T14:59:48.337Z,1724338788.337 [DepthRateCalculator] Loaded
2024-08-22T14:59:48.337Z,1724338788.337 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-08-22T14:59:48.342Z,1724338788.342 [PitchRateCalculator] Loaded
2024-08-22T14:59:48.342Z,1724338788.342 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-08-22T14:59:48.352Z,1724338788.352 [SpeedCalculator] Loaded
2024-08-22T14:59:48.352Z,1724338788.352 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-08-22T14:59:48.356Z,1724338788.356 [YawRateCalculator] Loaded
2024-08-22T14:59:48.357Z,1724338788.357 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-08-22T14:59:48.376Z,1724338788.376 [ElevatorOffsetCalculator] Loaded
2024-08-22T14:59:48.377Z,1724338788.377 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-08-22T14:59:48.377Z,1724338788.377 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-08-22T14:59:48.378Z,1724338788.378 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-08-22T14:59:48.569Z,1724338788.569 [CANONSampler] Loaded
2024-08-22T14:59:48.570Z,1724338788.570 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2024-08-22T14:59:48.636Z,1724338788.636 [CTD_Seabird] Loaded
2024-08-22T14:59:48.636Z,1724338788.636 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-08-22T14:59:48.637Z,1724338788.637 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A7D4E0
2024-08-22T14:59:48.637Z,1724338788.637 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 928
2024-08-22T14:59:48.662Z,1724338788.662 [PAR_Licor] Loaded
2024-08-22T14:59:48.662Z,1724338788.662 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-08-22T14:59:48.707Z,1724338788.707 [WetLabsBB2FL] Loaded
2024-08-22T14:59:48.707Z,1724338788.707 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-08-22T14:59:48.708Z,1724338788.708 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AAD4E0
2024-08-22T14:59:48.708Z,1724338788.708 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 929
2024-08-22T14:59:48.709Z,1724338788.709 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-08-22T14:59:48.710Z,1724338788.710 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-08-22T14:59:48.755Z,1724338788.755 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-08-22T14:59:48.756Z,1724338788.756 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-08-22T14:59:49.186Z,1724338789.186 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-08-22T14:59:49.188Z,1724338789.188 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-08-22T14:59:49.404Z,1724338789.404 [SBIT](DEBUG): Construct Startup Built In Test.
2024-08-22T14:59:49.413Z,1724338789.413 [SBIT] Loaded
2024-08-22T14:59:49.413Z,1724338789.413 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-08-22T14:59:49.416Z,1724338789.416 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-08-22T14:59:49.429Z,1724338789.429 [IBIT] Loaded
2024-08-22T14:59:49.430Z,1724338789.430 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-08-22T14:59:49.435Z,1724338789.435 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-08-22T14:59:49.546Z,1724338789.546 [CBIT] Loaded
2024-08-22T14:59:49.546Z,1724338789.546 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-08-22T14:59:49.546Z,1724338789.546 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-08-22T14:59:49.547Z,1724338789.547 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-08-22T14:59:49.698Z,1724338789.698 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-08-22T14:59:49.705Z,1724338789.705 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-08-22T14:59:49.708Z,1724338789.708 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-08-22T14:59:49.719Z,1724338789.719 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-08-22T14:59:49.720Z,1724338789.720 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-08-22T14:59:49.720Z,1724338789.720 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 930
2024-08-22T14:59:49.725Z,1724338789.725 [Supervisor](INFO): Main Thread ID is 830
2024-08-22T14:59:49.725Z,1724338789.725 [Supervisor](DEBUG): Running supervisor.
2024-08-22T14:59:49.725Z,1724338789.725 [CommandExec ThreadHandler](INFO): Handler Thread ID is 931
2024-08-22T14:59:49.726Z,1724338789.726 [CommandExec](INFO): Initializing the command executive.
2024-08-22T14:59:49.727Z,1724338789.727 [CommandLine ThreadHandler](INFO): Handler Thread ID is 932
2024-08-22T14:59:49.729Z,1724338789.729 [controlThread ThreadHandler](INFO): Handler Thread ID is 933
2024-08-22T14:59:49.730Z,1724338789.730 [controlThread](DEBUG): Initializing ControlThread
2024-08-22T14:59:49.731Z,1724338789.731 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-08-22T14:59:49.732Z,1724338789.732 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-08-22T14:59:49.733Z,1724338789.733 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-08-22T14:59:49.733Z,1724338789.733 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-08-22T14:59:49.735Z,1724338789.735 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-08-22T14:59:49.736Z,1724338789.736 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-08-22T14:59:49.742Z,1724338789.742 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-08-22T14:59:49.742Z,1724338789.742 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-08-22T14:59:49.742Z,1724338789.742 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-08-22T14:59:49.742Z,1724338789.742 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-08-22T14:59:49.743Z,1724338789.743 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-08-22T14:59:49.748Z,1724338789.748 [SBIT](INFO): Initialize SBIT Component.
2024-08-22T14:59:49.749Z,1724338789.749 [SBIT](IMPORTANT): git: 2024-08-12
2024-08-22T14:59:49.749Z,1724338789.749 [SBIT](INFO): git hash: 514a2155e4c471e50d5c939abb69db7fb725fa43
2024-08-22T14:59:49.749Z,1724338789.749 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-08-22T14:59:49.750Z,1724338789.750 [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
2024-08-22T14:59:49.751Z,1724338789.751 [SBIT](INFO): Beginning SBIT in 69.000000 seconds.
2024-08-22T14:59:49.752Z,1724338789.752 [IBIT](INFO): Initialize IBIT Component.
2024-08-22T14:59:49.753Z,1724338789.753 [CBIT](DEBUG): Initialize CBIT Component.
2024-08-22T14:59:49.754Z,1724338789.754 [logger ThreadHandler](INFO): Handler Thread ID is 934
2024-08-22T14:59:49.764Z,1724338789.764 [CBIT](DEBUG): Initialized mux pins.
2024-08-22T14:59:49.764Z,1724338789.764 [CBIT](DEBUG): Initializing the watchdog timer.
2024-08-22T14:59:49.773Z,1724338789.773 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935
2024-08-22T14:59:49.775Z,1724338789.775 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-08-22T14:59:49.788Z,1724338789.788 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-08-22T14:59:49.788Z,1724338789.788 [CBIT](DEBUG): Initializing heartbeat.
2024-08-22T14:59:49.800Z,1724338789.800 [Onboard ThreadHandler](INFO): Handler Thread ID is 937
2024-08-22T14:59:49.832Z,1724338789.832 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 938
2024-08-22T14:59:49.844Z,1724338789.844 [DAT ThreadHandler](INFO): Handler Thread ID is 939
2024-08-22T14:59:49.845Z,1724338789.845 [DAT](INFO): Powering up
2024-08-22T14:59:49.845Z,1724338789.845 [DAT](DEBUG): Initializing DAT.
2024-08-22T14:59:49.852Z,1724338789.852 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 941
2024-08-22T14:59:49.853Z,1724338789.853 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-08-22T14:59:49.860Z,1724338789.860 [CBIT](DEBUG): Deactivating GF circuits.
2024-08-22T14:59:49.860Z,1724338789.860 [CBIT](DEBUG): Deactivating emergency mode.
2024-08-22T14:59:49.861Z,1724338789.861 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 943
2024-08-22T14:59:49.869Z,1724338789.869 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 945
2024-08-22T14:59:49.870Z,1724338789.870 [WetLabsBB2FL](INFO): Powering up
2024-08-22T14:59:49.876Z,1724338789.876 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-08-22T14:59:49.877Z,1724338789.877 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-08-22T14:59:49.900Z,1724338789.900 [CBIT](DEBUG): Backplane powered.
2024-08-22T14:59:49.901Z,1724338789.901 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-08-22T14:59:49.901Z,1724338789.901 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-08-22T14:59:49.902Z,1724338789.902 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-08-22T14:59:49.906Z,1724338789.906 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-08-22T14:59:49.995Z,1724338789.995 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-08-22T14:59:50.023Z,1724338790.023 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-22T14:59:50.072Z,1724338790.072 [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
}
}
}
2024-08-22T14:59:50.073Z,1724338790.073 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-08-22T14:59:50.073Z,1724338790.073 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-08-22T14:59:50.077Z,1724338790.077 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-08-22T14:59:50.236Z,1724338790.236 [Radio_Surface](INFO): Powering up
2024-08-22T14:59:50.342Z,1724338790.342 [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
2024-08-22T14:59:50.368Z,1724338790.368 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-08-22T14:59:50.370Z,1724338790.370 [Default:A.Wait](DEBUG): Construct Wait.
2024-08-22T14:59:50.388Z,1724338790.388 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-08-22T14:59:50.442Z,1724338790.442 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-08-22T14:59:50.453Z,1724338790.453 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-08-22T14:59:50.458Z,1724338790.458 [Default:E.Execute](DEBUG): Construct Execute.
2024-08-22T14:59:50.477Z,1724338790.477 [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"
}
}
2024-08-22T14:59:50.482Z,1724338790.482 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,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,
2024-08-22T14:59:50.504Z,1724338790.504 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-08-22T14:59:50.670Z,1724338790.670 [Power24vConverter](INFO): Powering up.
2024-08-22T14:59:50.671Z,1724338790.671 [CANONSampler](INFO): Powering down
2024-08-22T14:59:50.708Z,1724338790.708 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-08-22T14:59:50.716Z,1724338790.716 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-08-22T14:59:50.717Z,1724338790.717 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-08-22T14:59:50.724Z,1724338790.724 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-08-22T14:59:50.725Z,1724338790.725 [MassServo](DEBUG): Initializing EZServoServo.
2024-08-22T14:59:50.732Z,1724338790.732 [MassServo](DEBUG): Initializing MassServo.
2024-08-22T14:59:50.733Z,1724338790.733 [RudderServo](DEBUG): Initializing EZServoServo.
2024-08-22T14:59:50.740Z,1724338790.740 [RudderServo](DEBUG): Initializing RudderServo.
2024-08-22T14:59:50.741Z,1724338790.741 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-08-22T14:59:50.748Z,1724338790.748 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-08-22T14:59:50.929Z,1724338790.929 [Depth_Keller](ERROR): Pressure or depth reading out of range: 915.409546 decibar, 0.000000 m
2024-08-22T14:59:52.476Z,1724338792.476 [WetLabsBB2FL](INFO): Powering down
2024-08-22T14:59:56.429Z,1724338796.429 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-08-22T14:59:56.884Z,1724338796.884 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2024-08-22T15:00:02.444Z,1724338802.444 [DAT](INFO): DAT read:
2024-08-22T15:00:02.446Z,1724338802.446 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-08-22T15:00:03.707Z,1724338803.707 [DAT](INFO): DAT read: MF Frequency Band
2024-08-22T15:00:03.957Z,1724338803.957 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-08-22T15:00:03.958Z,1724338803.958 [DAT](INFO): DAT read: Aug 20 2024 23:29:39
2024-08-22T15:00:04.965Z,1724338804.965 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-08-22T15:00:04.966Z,1724338804.966 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2024-08-22T15:00:04.966Z,1724338804.966 [DAT](INFO): commRate: 1200
2024-08-22T15:00:07.032Z,1724338807.032 [DAT](INFO): entering command mode
2024-08-22T15:00:07.232Z,1724338807.232 [DAT](INFO): DAT read:
2024-08-22T15:00:07.233Z,1724338807.233 [DAT](INFO): DAT read: usr:1>
2024-08-22T15:00:07.233Z,1724338807.233 [DAT](INFO): unknown deviceResponse_: usr:1>
2024-08-22T15:00:07.234Z,1724338807.234 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:07.484Z,1724338807.484 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:07.736Z,1724338807.736 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:07.988Z,1724338807.988 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:08.240Z,1724338808.240 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:08.492Z,1724338808.492 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:08.744Z,1724338808.744 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:08.996Z,1724338808.996 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:09.248Z,1724338809.248 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:09.500Z,1724338809.500 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:09.752Z,1724338809.752 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:10.004Z,1724338810.004 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:10.256Z,1724338810.256 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:10.508Z,1724338810.508 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:10.761Z,1724338810.761 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:11.012Z,1724338811.012 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:11.266Z,1724338811.266 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:11.517Z,1724338811.517 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:11.768Z,1724338811.768 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:12.021Z,1724338812.021 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:12.272Z,1724338812.272 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:12.525Z,1724338812.525 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:12.776Z,1724338812.776 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:13.028Z,1724338813.028 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:13.280Z,1724338813.280 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:13.532Z,1724338813.532 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:13.784Z,1724338813.784 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:14.038Z,1724338814.038 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:14.288Z,1724338814.288 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:14.540Z,1724338814.540 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:14.792Z,1724338814.792 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:15.044Z,1724338815.044 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:15.296Z,1724338815.296 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:15.548Z,1724338815.548 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:15.800Z,1724338815.800 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:16.052Z,1724338816.052 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:16.304Z,1724338816.304 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:16.556Z,1724338816.556 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:16.808Z,1724338816.808 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:17.060Z,1724338817.060 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:17.312Z,1724338817.312 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:17.564Z,1724338817.564 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:17.816Z,1724338817.816 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:18.068Z,1724338818.068 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:18.320Z,1724338818.320 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:18.370Z,1724338818.370 [NAL9602](INFO): Powering up NAL9602
2024-08-22T15:00:18.572Z,1724338818.572 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:18.829Z,1724338818.829 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:19.080Z,1724338819.080 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:19.332Z,1724338819.332 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:19.584Z,1724338819.584 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:19.836Z,1724338819.836 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:20.088Z,1724338820.088 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:20.340Z,1724338820.340 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:20.593Z,1724338820.593 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:20.844Z,1724338820.844 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:21.096Z,1724338821.096 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:21.348Z,1724338821.348 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:21.600Z,1724338821.600 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:21.852Z,1724338821.852 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:22.106Z,1724338822.106 [DAT](DEBUG): checking for command mode acknowledgment
2024-08-22T15:00:22.106Z,1724338822.106 [DAT](FAULT): failed to enter command mode
2024-08-22T15:00:22.408Z,1724338822.408 [DAT](INFO): entering command mode
2024-08-22T15:00:22.609Z,1724338822.609 [DAT](INFO): DAT read: user:1>
2024-08-22T15:00:22.610Z,1724338822.610 [DAT](INFO): DAT read: Command '+++' not found
2024-08-22T15:00:22.610Z,1724338822.610 [DAT](INFO): DAT read: Error
2024-08-22T15:00:22.610Z,1724338822.610 [DAT](INFO): setting verbose to 3
2024-08-22T15:00:22.861Z,1724338822.861 [DAT](INFO): DAT read: user:2>
2024-08-22T15:00:22.862Z,1724338822.862 [DAT](INFO): DAT read: Verbose | 3
2024-08-22T15:00:22.862Z,1724338822.862 [DAT](INFO): set verbose to 3
2024-08-22T15:00:22.862Z,1724338822.862 [DAT](INFO): setting DatVerbose to 27440
2024-08-22T15:00:23.112Z,1724338823.112 [DAT](INFO): DAT read: user:3>
2024-08-22T15:00:23.113Z,1724338823.113 [DAT](INFO): DAT read: DatVerbose | 27440
2024-08-22T15:00:23.114Z,1724338823.114 [DAT](INFO): set DatVerbose to 27440
2024-08-22T15:00:23.114Z,1724338823.114 [DAT](INFO): setting transmit power to 8
2024-08-22T15:00:23.365Z,1724338823.365 [DAT](INFO): DAT read: user:4>
2024-08-22T15:00:23.366Z,1724338823.366 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-08-22T15:00:23.366Z,1724338823.366 [DAT](INFO): set transmit power to 8
2024-08-22T15:00:23.366Z,1724338823.366 [DAT](INFO): setting local address to 8
2024-08-22T15:00:23.617Z,1724338823.617 [DAT](INFO): DAT read: user:5>
2024-08-22T15:00:23.618Z,1724338823.618 [DAT](INFO): DAT read: LocalAddr | 8
2024-08-22T15:00:23.618Z,1724338823.618 [DAT](INFO): set local address to 8
2024-08-22T15:00:23.619Z,1724338823.619 [DAT](INFO): Setting time to: 15:0:23 And date to:8/22/2024
2024-08-22T15:00:23.869Z,1724338823.869 [DAT](INFO): DAT read: user:6>
2024-08-22T15:00:23.870Z,1724338823.870 [DAT](INFO): DAT read: Thu Aug 22, 2024 15:00:23
2024-08-22T15:00:23.870Z,1724338823.870 [DAT](INFO): Local DAT time set to Thu Aug 22, 2024 15:00:23
2024-08-22T15:00:29.277Z,1724338829.277 [NAL9602](INFO): NAL9602 initialized
2024-08-22T15:00:59.215Z,1724338859.215 [SBIT](IMPORTANT): Beginning Startup BIT
2024-08-22T15:00:59.219Z,1724338859.219 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-22T15:01:10.137Z,1724338870.137 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-22T15:01:10.657Z,1724338870.657 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-22T15:01:21.449Z,1724338881.449 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-22T15:01:21.849Z,1724338881.849 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-22T15:01:32.726Z,1724338892.726 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-22T15:01:32.727Z,1724338892.727 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2024-08-22T15:01:53.327Z,1724338913.327 [SBIT](IMPORTANT): SBIT PASSED
2024-08-22T15:01:53.327Z,1724338913.327 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-08-22T15:01:53.328Z,1724338913.328 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count;
2024-08-22T15:01:53.328Z,1724338913.328 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=202.807188 cubic_centimeter;
2024-08-22T15:01:53.329Z,1724338913.329 [SBIT](IMPORTANT): VerticalControl.massDefault=12.366144 millimeter;
2024-08-22T15:01:53.733Z,1724338913.733 [MissionManager](IMPORTANT): Started mission Startup
2024-08-22T15:01:53.733Z,1724338913.733 [Startup] Running Loop=1
2024-08-22T15:01:53.733Z,1724338913.733 [Startup](DEBUG): Aggregate::initialize Startup
2024-08-22T15:01:53.733Z,1724338913.733 [Startup:A.GoToSurface] Running Loop=1
2024-08-22T15:01:53.733Z,1724338913.733 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-08-22T15:01:53.734Z,1724338913.734 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-08-22T15:01:53.734Z,1724338913.734 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-08-22T15:01:53.735Z,1724338913.735 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-08-22T15:01:53.735Z,1724338913.735 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-08-22T15:01:53.735Z,1724338913.735 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-08-22T15:01:53.736Z,1724338913.736 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-08-22T15:01:53.737Z,1724338913.737 [Startup:StartupSatComms] Running Loop=1
2024-08-22T15:01:53.738Z,1724338913.738 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-08-22T15:01:53.738Z,1724338913.738 [Startup:StartupSatComms:A] Running Loop=1
2024-08-22T15:01:54.130Z,1724338914.130 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-08-22T15:02:30.659Z,1724338950.659 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005095
2024-08-22T15:02:49.948Z,1724338969.948 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-08-22T15:02:49.948Z,1724338969.948 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:02:49.982Z,1724338969.982 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:02:50.365Z,1724338970.365 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:02:50.365Z,1724338970.365 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-08-22T15:02:53.976Z,1724338973.976 [Startup:StartupSatComms:A](INFO): Timed out from 2024-08-22T15:01:53.7Z
2024-08-22T15:02:53.976Z,1724338973.976 [Startup:StartupSatComms:A] Stopped
2024-08-22T15:02:53.976Z,1724338973.976 [Startup:StartupSatComms:B] Running Loop=1
2024-08-22T15:02:54.383Z,1724338974.383 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-08-22T15:03:00.019Z,1724338980.019 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240822T145936/Courier0000.lzma
2024-08-22T15:03:01.021Z,1724338981.021 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0000.lzma.bak
2024-08-22T15:03:01.021Z,1724338981.021 [DataOverHttps](INFO): SBD MOMSN=23042066
2024-08-22T15:03:05.052Z,1724338985.052 [CommandExec](IMPORTANT): got command gfscan
2024-08-22T15:03:05.330Z,1724338985.330 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-22T15:03:16.241Z,1724338996.241 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.000862
CHAN A1 (24V): 0.000445
CHAN A2 (12V): -0.002692
CHAN A3 (5V): -0.001672
CHAN B0 (3.3V): -0.000045
CHAN B1 (3.15aV): 0.000340
CHAN B2 (3.15bV): -0.000192
CHAN B3 (GND): -0.000447
OPEN: -0.000382
Full Scale: +/- 1 mA
2024-08-22T15:03:16.665Z,1724338996.665 [DataOverHttps](INFO): Sending 706 bytes from file Logs/20240822T145936/Express0001.lzma
2024-08-22T15:03:17.665Z,1724338997.665 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0001.lzma.bak
2024-08-22T15:03:17.665Z,1724338997.665 [DataOverHttps](INFO): SBD MOMSN=23042072
2024-08-22T15:03:19.016Z,1724338999.016 [Startup:StartupSatComms:B] Stopped
2024-08-22T15:03:19.016Z,1724338999.016 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-08-22T15:03:19.017Z,1724338999.017 [Startup:StartupSatComms] Stopped
2024-08-22T15:03:19.017Z,1724338999.017 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-08-22T15:03:19.018Z,1724338999.018 [Startup](INFO): Completed Startup
2024-08-22T15:03:19.018Z,1724338999.018 [MissionManager](INFO): Startup is completed.
2024-08-22T15:03:19.018Z,1724338999.018 [MissionManager](INFO): Uninitializing Mission Startup
2024-08-22T15:03:19.018Z,1724338999.018 [Startup] Stopped
2024-08-22T15:03:19.018Z,1724338999.018 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-08-22T15:03:19.018Z,1724338999.018 [Startup:A.GoToSurface] Stopped
2024-08-22T15:03:19.018Z,1724338999.018 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-08-22T15:03:19.428Z,1724338999.428 [MissionManager](IMPORTANT): Started mission Default
2024-08-22T15:03:19.429Z,1724338999.429 [Default] Running Loop=1
2024-08-22T15:03:19.429Z,1724338999.429 [Default](DEBUG): Aggregate::initialize Default
2024-08-22T15:03:19.429Z,1724338999.429 [Default:B.GoToSurface] Running Loop=1
2024-08-22T15:03:19.429Z,1724338999.429 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-08-22T15:03:19.429Z,1724338999.429 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-08-22T15:03:19.429Z,1724338999.429 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-08-22T15:03:19.430Z,1724338999.430 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-08-22T15:03:19.430Z,1724338999.430 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-08-22T15:03:19.430Z,1724338999.430 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-08-22T15:03:19.431Z,1724338999.431 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-08-22T15:03:19.431Z,1724338999.431 [Default:A.Wait] Running Loop=1
2024-08-22T15:03:19.431Z,1724338999.431 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:03:23.448Z,1724339003.448 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:03:32.784Z,1724339012.784 [Default:A.Wait](INFO): Done Waiting.
2024-08-22T15:03:32.784Z,1724339012.784 [Default:A.Wait] Stopped
2024-08-22T15:03:32.784Z,1724339012.784 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T15:03:33.161Z,1724339013.161 [Default:CheckIn] Running Loop=1
2024-08-22T15:03:33.161Z,1724339013.161 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T15:03:33.161Z,1724339013.161 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T15:03:33.573Z,1724339013.573 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-08-22T15:03:36.781Z,1724339016.781 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:03:50.112Z,1724339030.112 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:04:03.849Z,1724339043.849 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:04:17.181Z,1724339057.181 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:04:30.513Z,1724339070.513 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:04:43.843Z,1724339083.843 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:04:57.176Z,1724339097.176 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:05:10.509Z,1724339110.509 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:05:24.245Z,1724339124.245 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:05:33.142Z,1724339133.142 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-08-22T15:05:37.576Z,1724339137.576 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T15:05:50.948Z,1724339150.948 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-08-22T15:05:50.948Z,1724339150.948 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:05:50.982Z,1724339150.982 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:05:51.413Z,1724339151.413 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:05:51.413Z,1724339151.413 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-08-22T15:05:51.725Z,1724339151.725 [BPC1](INFO): Calculating totals. Valid battery stick count: 39. Valid reserve battery stick count: 3.
2024-08-22T15:05:51.728Z,1724339151.728 [BPC1](INFO): Received data from all battery sticks.
2024-08-22T15:07:47.273Z,1724339267.273 [CommandExec](IMPORTANT): got command burn on
2024-08-22T15:07:47.273Z,1724339267.273 [CommandExec](IMPORTANT): Activating dropweight wire
2024-08-22T15:08:33.338Z,1724339313.338 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-22T15:03:33.2Z
2024-08-22T15:08:33.338Z,1724339313.338 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T15:08:33.338Z,1724339313.338 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T15:08:33.738Z,1724339313.738 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-08-22T15:08:40.327Z,1724339320.327 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240822T145936/Courier0004.lzma
2024-08-22T15:08:41.329Z,1724339321.329 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0004.lzma.bak
2024-08-22T15:08:41.329Z,1724339321.329 [DataOverHttps](INFO): SBD MOMSN=23042092
2024-08-22T15:08:51.936Z,1724339331.936 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-08-22T15:08:51.936Z,1724339331.936 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:08:51.948Z,1724339331.948 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:08:52.343Z,1724339332.343 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:08:52.343Z,1724339332.343 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-08-22T15:08:56.960Z,1724339336.960 [DataOverHttps](INFO): Sending 426 bytes from file Logs/20240822T145936/Express0005.lzma
2024-08-22T15:08:57.961Z,1724339337.961 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0005.lzma.bak
2024-08-22T15:08:57.961Z,1724339337.961 [DataOverHttps](INFO): SBD MOMSN=23042098
2024-08-22T15:08:59.184Z,1724339339.184 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T15:08:59.184Z,1724339339.184 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T15:08:59.184Z,1724339339.184 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:10:22.804Z,1724339422.804 [CommandExec](IMPORTANT): got command burn off
2024-08-22T15:10:22.804Z,1724339422.804 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-08-22T15:10:30.484Z,1724339430.484 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-22T15:10:30.484Z,1724339430.484 [NAL9602] Data Fault, FailCount= 1
2024-08-22T15:10:30.484Z,1724339430.484 [NAL9602](ERROR): Data Fault
2024-08-22T15:10:30.529Z,1724339430.529 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-22T15:10:30.888Z,1724339430.888 [NAL9602](INFO): Powering down
2024-08-22T15:10:31.723Z,1724339431.723 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-22T15:10:31.724Z,1724339431.724 [NAL9602] No Fault, FailCount= 1
2024-08-22T15:11:01.188Z,1724339461.188 [NAL9602](INFO): Powering up NAL9602
2024-08-22T15:11:12.096Z,1724339472.096 [NAL9602](INFO): NAL9602 initialized
2024-08-22T15:11:52.917Z,1724339512.917 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-08-22T15:11:52.917Z,1724339512.917 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:11:52.927Z,1724339512.927 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:11:53.321Z,1724339513.321 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:11:53.321Z,1724339513.321 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-08-22T15:13:59.809Z,1724339639.809 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T15:13:59.809Z,1724339639.809 [Default:CheckIn:C.Wait] Stopped
2024-08-22T15:13:59.809Z,1724339639.809 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T15:13:59.809Z,1724339639.809 [Default:CheckIn:D] Running Loop=1
2024-08-22T15:14:00.224Z,1724339640.224 [Default:CheckIn:D] Stopped
2024-08-22T15:14:00.224Z,1724339640.224 [Default:CheckIn:E] Running Loop=1
2024-08-22T15:14:00.621Z,1724339640.621 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.679925 min
2024-08-22T15:14:00.621Z,1724339640.621 [Default:CheckIn:E] Stopped
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn] Stopped
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn](INFO): Running loop #2
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn] Running Loop=2
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T15:14:00.622Z,1724339640.622 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T15:14:53.948Z,1724339693.948 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-08-22T15:14:53.948Z,1724339693.948 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:14:53.959Z,1724339693.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:14:54.340Z,1724339694.340 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:14:54.340Z,1724339694.340 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-08-22T15:17:54.943Z,1724339874.943 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-08-22T15:17:54.943Z,1724339874.943 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:17:54.954Z,1724339874.954 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:17:55.332Z,1724339875.332 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:17:55.332Z,1724339875.332 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-08-22T15:19:00.797Z,1724339940.797 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-22T15:14:00.6Z
2024-08-22T15:19:00.797Z,1724339940.797 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T15:19:00.797Z,1724339940.797 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T15:19:08.418Z,1724339948.418 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240822T145936/Courier0007.lzma
2024-08-22T15:19:09.421Z,1724339949.421 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0007.lzma.bak
2024-08-22T15:19:09.421Z,1724339949.421 [DataOverHttps](INFO): SBD MOMSN=23042116
2024-08-22T15:19:23.854Z,1724339963.854 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20240822T145936/Express0008.lzma
2024-08-22T15:19:24.861Z,1724339964.861 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0008.lzma.bak
2024-08-22T15:19:24.861Z,1724339964.861 [DataOverHttps](INFO): SBD MOMSN=23042122
2024-08-22T15:19:26.243Z,1724339966.243 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T15:19:26.243Z,1724339966.243 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T15:19:26.243Z,1724339966.243 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:20:55.934Z,1724340055.934 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-08-22T15:20:55.934Z,1724340055.934 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:20:55.945Z,1724340055.945 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:20:56.325Z,1724340056.325 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:20:56.325Z,1724340056.325 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-08-22T15:21:13.277Z,1724340073.277 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-22T15:21:13.277Z,1724340073.277 [NAL9602] Data Fault, FailCount= 2
2024-08-22T15:21:13.277Z,1724340073.277 [NAL9602](ERROR): Data Fault
2024-08-22T15:21:13.294Z,1724340073.294 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-22T15:21:13.680Z,1724340073.680 [NAL9602](INFO): Powering down
2024-08-22T15:21:14.504Z,1724340074.504 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-22T15:21:14.504Z,1724340074.504 [NAL9602] No Fault, FailCount= 2
2024-08-22T15:21:43.980Z,1724340103.980 [NAL9602](INFO): Powering up NAL9602
2024-08-22T15:21:54.888Z,1724340114.888 [NAL9602](INFO): NAL9602 initialized
2024-08-22T15:23:56.928Z,1724340236.928 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-08-22T15:23:56.928Z,1724340236.928 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:23:56.939Z,1724340236.939 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:23:57.344Z,1724340237.344 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:23:57.344Z,1724340237.344 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-08-22T15:24:26.794Z,1724340266.794 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T15:24:26.794Z,1724340266.794 [Default:CheckIn:C.Wait] Stopped
2024-08-22T15:24:26.794Z,1724340266.794 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T15:24:26.794Z,1724340266.794 [Default:CheckIn:D] Running Loop=1
2024-08-22T15:24:27.205Z,1724340267.205 [Default:CheckIn:D] Stopped
2024-08-22T15:24:27.205Z,1724340267.205 [Default:CheckIn:E] Running Loop=1
2024-08-22T15:24:27.625Z,1724340267.625 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.129608 min
2024-08-22T15:24:27.625Z,1724340267.625 [Default:CheckIn:E] Stopped
2024-08-22T15:24:27.625Z,1724340267.625 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T15:24:27.626Z,1724340267.625 [Default:CheckIn] Stopped
2024-08-22T15:24:27.626Z,1724340267.626 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T15:24:27.626Z,1724340267.626 [Default:CheckIn](INFO): Running loop #3
2024-08-22T15:24:27.626Z,1724340267.626 [Default:CheckIn] Running Loop=3
2024-08-22T15:24:27.626Z,1724340267.626 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T15:24:27.626Z,1724340267.626 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T15:26:57.912Z,1724340417.912 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-08-22T15:26:57.912Z,1724340417.912 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:26:57.923Z,1724340417.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:26:58.332Z,1724340418.332 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:26:58.332Z,1724340418.332 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-08-22T15:29:27.786Z,1724340567.786 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-22T15:24:27.6Z
2024-08-22T15:29:27.786Z,1724340567.786 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T15:29:27.786Z,1724340567.786 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T15:29:35.190Z,1724340575.190 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240822T145936/Courier0010.lzma
2024-08-22T15:29:36.193Z,1724340576.193 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0010.lzma.bak
2024-08-22T15:29:36.193Z,1724340576.193 [DataOverHttps](INFO): SBD MOMSN=23042190
2024-08-22T15:29:51.647Z,1724340591.647 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240822T145936/Express0011.lzma
2024-08-22T15:29:52.649Z,1724340592.649 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0011.lzma.bak
2024-08-22T15:29:52.650Z,1724340592.650 [DataOverHttps](INFO): SBD MOMSN=23042197
2024-08-22T15:29:54.041Z,1724340594.041 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T15:29:54.041Z,1724340594.041 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T15:29:54.041Z,1724340594.041 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:29:58.890Z,1724340598.890 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-08-22T15:29:58.890Z,1724340598.890 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:29:58.901Z,1724340598.901 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:29:59.315Z,1724340599.315 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:29:59.315Z,1724340599.315 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-08-22T15:31:56.849Z,1724340716.849 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-22T15:31:56.849Z,1724340716.849 [NAL9602] Data Fault, FailCount= 3
2024-08-22T15:31:56.849Z,1724340716.849 [NAL9602](ERROR): Data Fault
2024-08-22T15:31:56.945Z,1724340716.945 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-22T15:31:57.248Z,1724340717.248 [NAL9602](INFO): Powering down
2024-08-22T15:31:58.098Z,1724340718.098 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-22T15:31:58.098Z,1724340718.098 [NAL9602] No Fault, FailCount= 3
2024-08-22T15:32:27.548Z,1724340747.548 [NAL9602](INFO): Powering up NAL9602
2024-08-22T15:32:38.460Z,1724340758.460 [NAL9602](INFO): NAL9602 initialized
2024-08-22T15:32:43.084Z,1724340763.084 [CommandExec](IMPORTANT): got command burn on
2024-08-22T15:32:43.084Z,1724340763.084 [CommandExec](IMPORTANT): Activating dropweight wire
2024-08-22T15:32:48.700Z,1724340768.700 [CommandExec](IMPORTANT): got command burn off
2024-08-22T15:32:48.700Z,1724340768.700 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-08-22T15:32:59.904Z,1724340779.904 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2024-08-22T15:32:59.904Z,1724340779.904 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:32:59.927Z,1724340779.927 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:33:00.323Z,1724340780.323 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:33:00.323Z,1724340780.323 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2024-08-22T15:34:54.617Z,1724340894.617 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T15:34:54.617Z,1724340894.617 [Default:CheckIn:C.Wait] Stopped
2024-08-22T15:34:54.617Z,1724340894.617 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T15:34:54.617Z,1724340894.617 [Default:CheckIn:D] Running Loop=1
2024-08-22T15:34:55.023Z,1724340895.023 [Default:CheckIn:D] Stopped
2024-08-22T15:34:55.023Z,1724340895.023 [Default:CheckIn:E] Running Loop=1
2024-08-22T15:34:55.441Z,1724340895.441 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.593243 min
2024-08-22T15:34:55.441Z,1724340895.441 [Default:CheckIn:E] Stopped
2024-08-22T15:34:55.441Z,1724340895.441 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T15:34:55.442Z,1724340895.442 [Default:CheckIn] Stopped
2024-08-22T15:34:55.442Z,1724340895.442 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T15:34:55.442Z,1724340895.442 [Default:CheckIn](INFO): Running loop #4
2024-08-22T15:34:55.442Z,1724340895.442 [Default:CheckIn] Running Loop=4
2024-08-22T15:34:55.442Z,1724340895.442 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T15:34:55.442Z,1724340895.442 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T15:35:26.831Z,1724340926.831 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:35:57.971Z,1724340957.971 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:36:00.892Z,1724340960.892 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2024-08-22T15:36:00.892Z,1724340960.892 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:36:00.923Z,1724340960.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:36:01.314Z,1724340961.314 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:36:01.314Z,1724340961.314 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2024-08-22T15:36:29.095Z,1724340989.095 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:37:00.219Z,1724341020.219 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:37:31.343Z,1724341051.343 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:37:34.355Z,1724341054.355 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.755569
2024-08-22T15:38:32.615Z,1724341112.615 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:39:01.863Z,1724341141.863 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2024-08-22T15:39:01.863Z,1724341141.863 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:39:01.874Z,1724341141.874 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:39:02.283Z,1724341142.283 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:39:02.283Z,1724341142.283 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2024-08-22T15:39:03.743Z,1724341143.743 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:39:34.867Z,1724341174.867 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:39:55.617Z,1724341195.617 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-22T15:34:55.4Z
2024-08-22T15:39:55.617Z,1724341195.617 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T15:39:55.617Z,1724341195.617 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T15:40:05.999Z,1724341205.999 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:40:37.127Z,1724341237.127 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:41:08.255Z,1724341268.255 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:41:39.379Z,1724341299.379 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:42:02.872Z,1724341322.872 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2024-08-22T15:42:02.872Z,1724341322.872 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:42:02.903Z,1724341322.903 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:42:03.290Z,1724341323.290 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:42:03.290Z,1724341323.290 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2024-08-22T15:42:10.503Z,1724341330.503 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:42:18.764Z,1724341338.764 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002958
2024-08-22T15:42:30.486Z,1724341350.486 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240822T145936/Courier0013.lzma
2024-08-22T15:42:31.489Z,1724341351.489 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0013.lzma.bak
2024-08-22T15:42:31.489Z,1724341351.489 [DataOverHttps](INFO): SBD MOMSN=23042264
2024-08-22T15:42:37.371Z,1724341357.371 [CommandExec](IMPORTANT): got command failComponent
2024-08-22T15:42:37.372Z,1724341357.372 [CommandExec](IMPORTANT): Failed components:
2024-08-22T15:42:37.372Z,1724341357.372 [CommandExec](IMPORTANT): No failed Components.
2024-08-22T15:42:41.292Z,1724341361.292 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-22T15:42:41.292Z,1724341361.292 [NAL9602] Data Fault, FailCount= 4
2024-08-22T15:42:41.292Z,1724341361.292 [NAL9602](ERROR): Data Fault
2024-08-22T15:42:41.310Z,1724341361.310 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-22T15:42:41.697Z,1724341361.697 [NAL9602](INFO): Powering down
2024-08-22T15:42:42.520Z,1724341362.520 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-22T15:42:42.520Z,1724341362.520 [NAL9602] No Fault, FailCount= 4
2024-08-22T15:42:47.083Z,1724341367.083 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20240822T145936/Express0014.lzma
2024-08-22T15:42:48.085Z,1724341368.085 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0014.lzma.bak
2024-08-22T15:42:48.085Z,1724341368.085 [DataOverHttps](INFO): SBD MOMSN=23042266
2024-08-22T15:42:49.379Z,1724341369.379 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T15:42:49.379Z,1724341369.379 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T15:42:49.379Z,1724341369.379 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:43:12.044Z,1724341392.044 [NAL9602](INFO): Powering up NAL9602
2024-08-22T15:43:22.944Z,1724341402.944 [NAL9602](INFO): NAL9602 initialized
2024-08-22T15:45:03.000Z,1724341504.000 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2024-08-22T15:45:04.000Z,1724341504.000 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:45:04.011Z,1724341504.011 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:45:04.412Z,1724341504.412 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:45:04.412Z,1724341504.412 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2024-08-22T15:45:21.171Z,1724341521.171 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:45:52.295Z,1724341552.295 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:46:23.435Z,1724341583.435 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:46:54.567Z,1724341614.567 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:47:25.691Z,1724341645.691 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:47:30.711Z,1724341650.711 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.743454
2024-08-22T15:47:50.020Z,1724341670.020 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T15:47:50.020Z,1724341670.020 [Default:CheckIn:C.Wait] Stopped
2024-08-22T15:47:50.020Z,1724341670.020 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T15:47:50.020Z,1724341670.020 [Default:CheckIn:D] Running Loop=1
2024-08-22T15:47:50.420Z,1724341670.420 [Default:CheckIn:D] Stopped
2024-08-22T15:47:50.421Z,1724341670.421 [Default:CheckIn:E] Running Loop=1
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.516528 min
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn:E] Stopped
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn] Stopped
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn](INFO): Running loop #5
2024-08-22T15:47:50.831Z,1724341670.831 [Default:CheckIn] Running Loop=5
2024-08-22T15:47:50.832Z,1724341670.832 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T15:47:50.832Z,1724341670.832 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T15:48:04.987Z,1724341684.987 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2024-08-22T15:48:04.987Z,1724341684.987 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:48:04.998Z,1724341684.998 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:48:05.403Z,1724341685.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:48:05.403Z,1724341685.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2024-08-22T15:48:26.939Z,1724341706.939 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:48:58.063Z,1724341738.063 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:49:29.187Z,1724341769.187 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:50:00.311Z,1724341800.311 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:50:31.439Z,1724341831.439 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T15:50:52.211Z,1724341852.211 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002985
2024-08-22T15:51:05.999Z,1724341865.999 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2024-08-22T15:51:05.999Z,1724341865.999 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:51:06.030Z,1724341866.030 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:51:06.414Z,1724341866.414 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:51:06.414Z,1724341866.414 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2024-08-22T15:52:51.025Z,1724341971.025 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-22T15:47:50.8Z
2024-08-22T15:52:51.025Z,1724341971.025 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T15:52:51.025Z,1724341971.025 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T15:52:59.126Z,1724341979.126 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240822T145936/Courier0016.lzma
2024-08-22T15:53:00.129Z,1724341980.129 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0016.lzma.bak
2024-08-22T15:53:00.129Z,1724341980.129 [DataOverHttps](INFO): SBD MOMSN=23042287
2024-08-22T15:53:15.611Z,1724341995.611 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20240822T145936/Express0017.lzma
2024-08-22T15:53:16.613Z,1724341996.613 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0017.lzma.bak
2024-08-22T15:53:16.613Z,1724341996.613 [DataOverHttps](INFO): SBD MOMSN=23042289
2024-08-22T15:53:17.764Z,1724341997.764 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T15:53:17.764Z,1724341997.764 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T15:53:17.764Z,1724341997.764 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:53:25.437Z,1724342005.437 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-08-22T15:53:25.437Z,1724342005.437 [NAL9602] Data Fault, FailCount= 5
2024-08-22T15:53:25.437Z,1724342005.437 [NAL9602](ERROR): Data Fault
2024-08-22T15:53:25.454Z,1724342005.454 [CBIT](ERROR): Data Fault in component: NAL9602
2024-08-22T15:53:25.454Z,1724342005.454 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-08-22T15:53:25.832Z,1724342005.832 [NAL9602](INFO): Powering down
2024-08-22T15:53:25.863Z,1724342005.863 [CommandExec](FAULT): Scheduling is paused
2024-08-22T15:53:25.864Z,1724342005.864 [CBIT](INFO): Critical error at 20240822T155325
2024-08-22T15:53:25.864Z,1724342005.864 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-08-22T15:54:07.050Z,1724342047.050 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2024-08-22T15:54:07.050Z,1724342047.050 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-08-22T15:54:07.061Z,1724342047.061 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-08-22T15:54:07.472Z,1724342047.472 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-08-22T15:54:07.472Z,1724342047.472 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2024-08-22T15:55:25.544Z,1724342125.544 [CBIT](INFO): Clearing failed state for component NAL9602
2024-08-22T15:55:25.544Z,1724342125.544 [NAL9602] No Fault, FailCount= 5
2024-08-22T15:55:25.933Z,1724342125.933 [NAL9602](INFO): Powering up NAL9602
2024-08-22T15:55:36.840Z,1724342136.840 [NAL9602](INFO): NAL9602 initialized
2024-08-22T15:57:04.972Z,1724342224.972 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155703.00,A,3648.15661,N,12147.25299,W,1.283,202.31,220824,,,A*75
2024-08-22T15:57:04.975Z,1724342224.975 [NAL9602](INFO): GPS fix at 20240822T155703: (36.802610, -121.787550)
2024-08-22T15:57:37.300Z,1724342257.300 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T15:58:18.526Z,1724342298.526 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T15:58:18.526Z,1724342298.526 [Default:CheckIn:C.Wait] Stopped
2024-08-22T15:58:18.526Z,1724342298.526 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T15:58:18.526Z,1724342298.526 [Default:CheckIn:D] Running Loop=1
2024-08-22T15:58:18.952Z,1724342298.952 [Default:CheckIn:D] Stopped
2024-08-22T15:58:18.952Z,1724342298.952 [Default:CheckIn:E] Running Loop=1
2024-08-22T15:58:19.331Z,1724342299.331 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.992049 min
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn:E] Stopped
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn] Stopped
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn](INFO): Running loop #6
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn] Running Loop=6
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T15:58:19.332Z,1724342299.332 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T15:58:21.334Z,1724342301.334 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155819.00,A,3648.14109,N,12147.24239,W,0.078,97.95,220824,,,A*45
2024-08-22T15:58:21.336Z,1724342301.336 [NAL9602](INFO): GPS fix at 20240822T155819: (36.802352, -121.787373)
2024-08-22T15:58:21.379Z,1724342301.379 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T15:58:21.379Z,1724342301.379 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T15:58:30.239Z,1724342310.239 [DataOverHttps](INFO): Sending 280 bytes from file Logs/20240822T145936/Courier0019.lzma
2024-08-22T15:58:31.241Z,1724342311.241 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0019.lzma.bak
2024-08-22T15:58:31.241Z,1724342311.241 [DataOverHttps](INFO): SBD MOMSN=23042304
2024-08-22T15:58:37.518Z,1724342317.518 [NAL9602](INFO): SBD MO Status=0, MOMSN=55025, MT Status=0, MTMSN=0
2024-08-22T15:58:37.518Z,1724342317.518 [NAL9602](INFO): No messages in MT queue
2024-08-22T15:58:37.518Z,1724342317.518 [NAL9602](INFO): Failure count cleared after critical for NAL9602
2024-08-22T15:58:47.084Z,1724342327.084 [DataOverHttps](INFO): Sending 331 bytes from file Logs/20240822T145936/Express0020.lzma
2024-08-22T15:58:48.085Z,1724342328.085 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0020.lzma.bak
2024-08-22T15:58:48.085Z,1724342328.085 [DataOverHttps](INFO): SBD MOMSN=23042308
2024-08-22T15:58:49.262Z,1724342329.262 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T15:58:49.262Z,1724342329.262 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T15:58:49.262Z,1724342329.262 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T15:59:08.274Z,1724342348.274 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T15:59:57.320Z,1724342397.320 [DataOverHttps](IMPORTANT): SBD MTMSN=20240822T155956
2024-08-22T16:00:04.880Z,1724342404.880 [DataOverHttps](INFO): Received command: ibit
2024-08-22T16:00:04.971Z,1724342404.971 [CommandExec](IMPORTANT): got command ibit
2024-08-22T16:00:05.256Z,1724342405.256 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-08-22T16:00:05.256Z,1724342405.256 [IBIT](IMPORTANT): Beginning control surface checks.
2024-08-22T16:00:05.259Z,1724342405.259 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-22T16:00:06.862Z,1724342406.862 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160005.00,A,3648.14129,N,12147.23031,W,0.019,18.26,220824,,,A*41
2024-08-22T16:00:06.864Z,1724342406.864 [NAL9602](INFO): GPS fix at 20240822T160005: (36.802355, -121.787172)
2024-08-22T16:00:16.166Z,1724342416.166 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2024-08-22T16:00:16.608Z,1724342416.608 [CBIT](IMPORTANT): Beginning ground fault scan
2024-08-22T16:00:21.403Z,1724342421.403 [NAL9602](INFO): SBD MO Status=0, MOMSN=55026, MT Status=0, MTMSN=0
2024-08-22T16:00:21.403Z,1724342421.403 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:00:22.614Z,1724342422.614 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160020.00,A,3648.14111,N,12147.22991,W,0.272,18.26,220824,,,A*40
2024-08-22T16:00:22.616Z,1724342422.616 [NAL9602](INFO): GPS fix at 20240822T160020: (36.802352, -121.787165)
2024-08-22T16:00:25.854Z,1724342425.854 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160024.00,A,3648.14111,N,12147.22970,W,0.078,18.26,220824,,,A*43
2024-08-22T16:00:25.856Z,1724342425.856 [NAL9602](INFO): GPS fix at 20240822T160024: (36.802352, -121.787162)
2024-08-22T16:00:27.543Z,1724342427.543 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002828
CHAN A1 (24V): 0.000625
CHAN A2 (12V): -0.001918
CHAN A3 (5V): -0.001281
CHAN B0 (3.3V): 0.000243
CHAN B1 (3.15aV): 0.000216
CHAN B2 (3.15bV): -0.000711
CHAN B3 (GND): -0.000315
OPEN: -0.000603
Full Scale: +/- 1 mA
2024-08-22T16:00:29.085Z,1724342429.085 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160027.00,A,3648.14122,N,12147.22956,W,0.039,18.26,220824,,,A*41
2024-08-22T16:00:29.087Z,1724342429.087 [NAL9602](INFO): GPS fix at 20240822T160027: (36.802354, -121.787159)
2024-08-22T16:00:31.914Z,1724342431.914 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160030.00,A,3648.14143,N,12147.22947,W,0.039,18.26,220824,,,A*40
2024-08-22T16:00:31.916Z,1724342431.916 [NAL9602](INFO): GPS fix at 20240822T160030: (36.802357, -121.787158)
2024-08-22T16:00:35.146Z,1724342435.146 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160033.00,A,3648.14167,N,12147.22935,W,0.019,18.26,220824,,,A*42
2024-08-22T16:00:35.148Z,1724342435.148 [NAL9602](INFO): GPS fix at 20240822T160033: (36.802361, -121.787156)
2024-08-22T16:00:36.596Z,1724342436.596 [DataOverHttps](IMPORTANT): SBD MTMSN=20240822T160035
2024-08-22T16:00:37.978Z,1724342437.978 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160036.00,A,3648.14192,N,12147.22926,W,0.058,18.26,220824,,,A*4A
2024-08-22T16:00:37.980Z,1724342437.980 [NAL9602](INFO): GPS fix at 20240822T160036: (36.802365, -121.787154)
2024-08-22T16:00:40.802Z,1724342440.802 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160039.00,A,3648.14207,N,12147.22920,W,0.019,18.26,220824,,,A*49
2024-08-22T16:00:40.804Z,1724342440.804 [NAL9602](INFO): GPS fix at 20240822T160039: (36.802368, -121.787153)
2024-08-22T16:00:44.038Z,1724342444.038 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160042.00,A,3648.14220,N,12147.22916,W,0.000,18.26,220824,,,A*4D
2024-08-22T16:00:44.040Z,1724342444.040 [NAL9602](INFO): GPS fix at 20240822T160042: (36.802370, -121.787153)
2024-08-22T16:00:44.295Z,1724342444.295 [DataOverHttps](INFO): Received command: failc
2024-08-22T16:00:44.383Z,1724342444.383 [CommandExec](IMPORTANT): got command failComponent
2024-08-22T16:00:44.383Z,1724342444.383 [CommandExec](IMPORTANT): Failed components:
2024-08-22T16:00:44.384Z,1724342444.384 [CommandExec](IMPORTANT): No failed Components.
2024-08-22T16:00:46.866Z,1724342446.866 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160045.00,A,3648.14236,N,12147.22916,W,0.039,18.26,220824,,,A*47
2024-08-22T16:00:46.868Z,1724342446.868 [NAL9602](INFO): GPS fix at 20240822T160045: (36.802373, -121.787153)
2024-08-22T16:00:50.106Z,1724342450.106 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160048.00,A,3648.14244,N,12147.22918,W,0.039,18.26,220824,,,A*41
2024-08-22T16:00:50.108Z,1724342450.108 [NAL9602](INFO): GPS fix at 20240822T160048: (36.802374, -121.787153)
2024-08-22T16:00:51.765Z,1724342451.765 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 3
Latitude: 36.802376 Longitude: -121.787155
2024-08-22T16:00:52.140Z,1724342452.140 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.690001
2024-08-22T16:00:52.141Z,1724342452.141 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-08-22T16:00:52.141Z,1724342452.141 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-08-22T16:00:52.556Z,1724342452.556 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-08-22T16:00:52.557Z,1724342452.557 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-08-22T16:00:52.557Z,1724342452.557 [IBIT](IMPORTANT): Pressure:10.327916 PSI
2024-08-22T16:00:52.557Z,1724342452.557 [IBIT](IMPORTANT): Humidity:15.138567 %
2024-08-22T16:00:52.968Z,1724342452.968 [IBIT](IMPORTANT): Vehicle Pitch:-0.525584 degrees
2024-08-22T16:00:52.969Z,1724342452.969 [IBIT](IMPORTANT): Vehicle Roll:6.913460 degrees
2024-08-22T16:00:52.969Z,1724342452.969 [IBIT](IMPORTANT): Vehicle Heading:198.670212 degrees
2024-08-22T16:00:53.347Z,1724342453.347 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-08-22T16:00:53.347Z,1724342453.347 [IBIT](IMPORTANT): buoyancyNeutral: 202.807190 cc
2024-08-22T16:00:53.347Z,1724342453.347 [IBIT](IMPORTANT): massDefault: 1.236614 cm
2024-08-22T16:00:53.348Z,1724342453.348 [IBIT](IMPORTANT): stopDepth: 250.000000 m
2024-08-22T16:00:53.348Z,1724342453.348 [IBIT](IMPORTANT): abortDepth: 270.000000 m
2024-08-22T16:00:53.348Z,1724342453.348 [IBIT](IMPORTANT): IBIT PASSED
2024-08-22T16:01:22.412Z,1724342482.412 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:03:49.889Z,1724342629.889 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:03:49.890Z,1724342629.890 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:03:49.890Z,1724342629.890 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:03:49.890Z,1724342629.890 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:03:50.294Z,1724342630.294 [Default:CheckIn:D] Stopped
2024-08-22T16:03:50.294Z,1724342630.294 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:03:50.689Z,1724342630.689 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.514421 min
2024-08-22T16:03:50.689Z,1724342630.689 [Default:CheckIn:E] Stopped
2024-08-22T16:03:50.689Z,1724342630.689 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:03:50.690Z,1724342630.690 [Default:CheckIn] Stopped
2024-08-22T16:03:50.690Z,1724342630.690 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:03:50.690Z,1724342630.690 [Default:CheckIn](INFO): Running loop #7
2024-08-22T16:03:50.690Z,1724342630.690 [Default:CheckIn] Running Loop=7
2024-08-22T16:03:50.690Z,1724342630.690 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:03:50.690Z,1724342630.690 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:03:52.701Z,1724342632.701 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160351.00,A,3648.14291,N,12147.22896,W,0.039,18.26,220824,,,A*45
2024-08-22T16:03:52.703Z,1724342632.703 [NAL9602](INFO): GPS fix at 20240822T160351: (36.802382, -121.787149)
2024-08-22T16:03:52.713Z,1724342632.713 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:03:52.713Z,1724342632.713 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:04:00.530Z,1724342640.530 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0022.lzma
2024-08-22T16:04:01.533Z,1724342641.533 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0022.lzma.bak
2024-08-22T16:04:01.533Z,1724342641.533 [DataOverHttps](INFO): SBD MOMSN=23042332
2024-08-22T16:04:17.676Z,1724342657.676 [DataOverHttps](INFO): Sending 877 bytes from file Logs/20240822T145936/Express0023.lzma
2024-08-22T16:04:18.677Z,1724342658.677 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0023.lzma.bak
2024-08-22T16:04:18.677Z,1724342658.677 [DataOverHttps](INFO): SBD MOMSN=23042335
2024-08-22T16:04:29.525Z,1724342669.525 [NAL9602](INFO): SBD MO Status=2, MOMSN=55027, MT Status=2, MTMSN=0
2024-08-22T16:04:29.525Z,1724342669.525 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-22T16:04:37.758Z,1724342677.758 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20240822T145936/Express0026.lzma
2024-08-22T16:04:38.761Z,1724342678.761 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0026.lzma.bak
2024-08-22T16:04:38.761Z,1724342678.761 [DataOverHttps](INFO): SBD MOMSN=23042367
2024-08-22T16:04:40.038Z,1724342680.038 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:04:40.038Z,1724342680.038 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:04:40.038Z,1724342680.038 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:04:48.106Z,1724342688.106 [NAL9602](INFO): SBD MO Status=0, MOMSN=55027, MT Status=0, MTMSN=0
2024-08-22T16:04:48.106Z,1724342688.106 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:05:18.806Z,1724342718.806 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:06:57.809Z,1724342817.809 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:07:10.337Z,1724342830.337 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:07:22.049Z,1724342842.049 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:07:33.765Z,1724342853.765 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:07:45.885Z,1724342865.885 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:07:58.005Z,1724342878.005 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:08:09.723Z,1724342889.723 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:08:21.874Z,1724342901.874 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:09:40.782Z,1724342980.782 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:09:40.782Z,1724342980.782 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:09:40.782Z,1724342980.782 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:09:40.782Z,1724342980.782 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:09:41.166Z,1724342981.166 [Default:CheckIn:D] Stopped
2024-08-22T16:09:41.166Z,1724342981.166 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:09:41.568Z,1724342981.568 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.362288 min
2024-08-22T16:09:41.568Z,1724342981.568 [Default:CheckIn:E] Stopped
2024-08-22T16:09:41.568Z,1724342981.568 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:09:41.569Z,1724342981.569 [Default:CheckIn] Stopped
2024-08-22T16:09:41.569Z,1724342981.569 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:09:41.569Z,1724342981.569 [Default:CheckIn](INFO): Running loop #8
2024-08-22T16:09:41.569Z,1724342981.569 [Default:CheckIn] Running Loop=8
2024-08-22T16:09:41.569Z,1724342981.569 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:09:41.569Z,1724342981.569 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:09:43.578Z,1724342983.578 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160942.00,A,3648.14275,N,12147.22831,W,0.097,18.26,220824,,,A*4E
2024-08-22T16:09:43.588Z,1724342983.588 [NAL9602](INFO): GPS fix at 20240822T160942: (36.802379, -121.787138)
2024-08-22T16:09:43.598Z,1724342983.598 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:09:43.598Z,1724342983.598 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:09:51.699Z,1724342991.699 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240822T145936/Courier0028.lzma
2024-08-22T16:09:52.701Z,1724342992.701 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0028.lzma.bak
2024-08-22T16:09:52.701Z,1724342992.701 [DataOverHttps](INFO): SBD MOMSN=23042402
2024-08-22T16:10:08.975Z,1724343008.975 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240822T145936/Express0029.lzma
2024-08-22T16:10:09.977Z,1724343009.977 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0029.lzma.bak
2024-08-22T16:10:09.977Z,1724343009.977 [DataOverHttps](INFO): SBD MOMSN=23042405
2024-08-22T16:10:11.062Z,1724343011.062 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:10:11.063Z,1724343011.063 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:10:11.063Z,1724343011.063 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:10:19.643Z,1724343019.643 [NAL9602](INFO): SBD MO Status=0, MOMSN=55028, MT Status=0, MTMSN=0
2024-08-22T16:10:19.643Z,1724343019.643 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:10:50.244Z,1724343050.244 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:10:55.902Z,1724343055.902 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:11:09.256Z,1724343069.256 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:11:22.969Z,1724343082.969 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:11:36.706Z,1724343096.706 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:11:51.250Z,1724343111.250 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:12:04.581Z,1724343124.581 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:12:18.733Z,1724343138.733 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:12:32.486Z,1724343152.486 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:12:46.224Z,1724343166.224 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:12:59.595Z,1724343179.595 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:13:12.927Z,1724343192.927 [BPC1](ERROR): BPC1B got IPBS message with 4 sticks (min is 7).
2024-08-22T16:13:12.932Z,1724343192.932 [BPC1](INFO): Calculating totals. Valid battery stick count: 38. Valid reserve battery stick count: 5.
2024-08-22T16:13:12.934Z,1724343192.934 [BPC1](INFO): Received data from all battery sticks.
2024-08-22T16:15:11.824Z,1724343311.824 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:15:11.824Z,1724343311.824 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:15:11.824Z,1724343311.824 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:15:11.824Z,1724343311.824 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:15:12.235Z,1724343312.235 [Default:CheckIn:D] Stopped
2024-08-22T16:15:12.235Z,1724343312.235 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:15:12.635Z,1724343312.635 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.880111 min
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn:E] Stopped
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn] Stopped
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn](INFO): Running loop #9
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn] Running Loop=9
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:15:12.636Z,1724343312.636 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:15:14.649Z,1724343314.649 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161513.00,A,3648.14367,N,12147.22928,W,0.000,18.26,220824,,,A*42
2024-08-22T16:15:14.652Z,1724343314.652 [NAL9602](INFO): GPS fix at 20240822T161513: (36.802394, -121.787155)
2024-08-22T16:15:14.663Z,1724343314.663 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:15:14.663Z,1724343314.663 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:15:22.154Z,1724343322.154 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20240822T145936/Courier0031.lzma
2024-08-22T16:15:23.157Z,1724343323.157 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0031.lzma.bak
2024-08-22T16:15:23.157Z,1724343323.157 [DataOverHttps](INFO): SBD MOMSN=23042460
2024-08-22T16:15:31.617Z,1724343331.617 [NAL9602](INFO): SBD MO Status=0, MOMSN=55029, MT Status=0, MTMSN=0
2024-08-22T16:15:31.617Z,1724343331.617 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:15:39.363Z,1724343339.363 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20240822T145936/Express0032.lzma
2024-08-22T16:15:40.365Z,1724343340.365 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0032.lzma.bak
2024-08-22T16:15:40.365Z,1724343340.365 [DataOverHttps](INFO): SBD MOMSN=23042463
2024-08-22T16:15:41.737Z,1724343341.737 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:15:41.737Z,1724343341.737 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:15:41.737Z,1724343341.737 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:16:02.316Z,1724343362.316 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:20:42.486Z,1724343642.486 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:20:42.486Z,1724343642.486 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:20:42.486Z,1724343642.486 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:20:42.491Z,1724343642.491 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:20:42.879Z,1724343642.879 [Default:CheckIn:D] Stopped
2024-08-22T16:20:42.879Z,1724343642.879 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:20:43.277Z,1724343643.277 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.390837 min
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn:E] Stopped
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn] Stopped
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn](INFO): Running loop #10
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn] Running Loop=10
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:20:43.278Z,1724343643.278 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:20:45.294Z,1724343645.294 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162044.00,A,3648.14381,N,12147.22796,W,0.039,18.26,220824,,,A*4F
2024-08-22T16:20:45.296Z,1724343645.296 [NAL9602](INFO): GPS fix at 20240822T162044: (36.802397, -121.787133)
2024-08-22T16:20:45.307Z,1724343645.307 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:20:45.307Z,1724343645.307 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:20:55.951Z,1724343655.951 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240822T145936/Courier0034.lzma
2024-08-22T16:20:56.953Z,1724343656.953 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0034.lzma.bak
2024-08-22T16:20:56.953Z,1724343656.953 [DataOverHttps](INFO): SBD MOMSN=23042476
2024-08-22T16:21:06.761Z,1724343666.761 [NAL9602](INFO): SBD MO Status=0, MOMSN=55030, MT Status=0, MTMSN=0
2024-08-22T16:21:06.762Z,1724343666.762 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:21:13.279Z,1724343673.279 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240822T145936/Express0035.lzma
2024-08-22T16:21:14.281Z,1724343674.281 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0035.lzma.bak
2024-08-22T16:21:14.281Z,1724343674.281 [DataOverHttps](INFO): SBD MOMSN=23042479
2024-08-22T16:21:15.672Z,1724343675.672 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:21:15.672Z,1724343675.672 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:21:15.672Z,1724343675.672 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:21:37.462Z,1724343697.462 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:26:16.073Z,1724343976.073 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:26:16.073Z,1724343976.073 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:26:16.073Z,1724343976.073 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:26:16.073Z,1724343976.073 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:26:16.483Z,1724343976.483 [Default:CheckIn:D] Stopped
2024-08-22T16:26:16.483Z,1724343976.483 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:26:16.907Z,1724343976.907 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.950911 min
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn:E] Stopped
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn] Stopped
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn](INFO): Running loop #11
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn] Running Loop=11
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:26:16.908Z,1724343976.908 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:26:18.893Z,1724343978.893 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162618.00,A,3648.14339,N,12147.22903,W,0.039,18.26,220824,,,A*41
2024-08-22T16:26:18.905Z,1724343978.905 [NAL9602](INFO): GPS fix at 20240822T162618: (36.802390, -121.787150)
2024-08-22T16:26:18.924Z,1724343978.924 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:26:18.924Z,1724343978.924 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:26:29.199Z,1724343989.199 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0037.lzma
2024-08-22T16:26:30.201Z,1724343990.201 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0037.lzma.bak
2024-08-22T16:26:30.201Z,1724343990.201 [DataOverHttps](INFO): SBD MOMSN=23042541
2024-08-22T16:26:38.778Z,1724343998.778 [NAL9602](INFO): SBD MO Status=2, MOMSN=55031, MT Status=2, MTMSN=0
2024-08-22T16:26:38.778Z,1724343998.778 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-22T16:26:46.518Z,1724344006.518 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240822T145936/Express0038.lzma
2024-08-22T16:26:47.521Z,1724344007.521 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0038.lzma.bak
2024-08-22T16:26:47.521Z,1724344007.521 [DataOverHttps](INFO): SBD MOMSN=23042544
2024-08-22T16:26:48.886Z,1724344008.886 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:26:48.887Z,1724344008.887 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:26:48.887Z,1724344008.887 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:26:50.591Z,1724344010.591 [RudderServo](ERROR): getPosition uart error serial timeout
2024-08-22T16:26:50.591Z,1724344010.591 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout
2024-08-22T16:26:50.591Z,1724344010.591 [RudderServo] Communications Fault, FailCount= 1
2024-08-22T16:26:50.591Z,1724344010.591 [RudderServo](ERROR): Communications Fault
2024-08-22T16:26:50.595Z,1724344010.595 [CBIT](ERROR): Communications Fault in component: RudderServo
2024-08-22T16:26:50.993Z,1724344010.993 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-08-22T16:26:50.993Z,1724344010.993 [RudderServo](INFO): Powering down
2024-08-22T16:26:51.813Z,1724344011.813 [RudderServo](DEBUG): Initializing EZServoServo.
2024-08-22T16:26:51.928Z,1724344011.928 [RudderServo](DEBUG): Initializing RudderServo.
2024-08-22T16:26:51.932Z,1724344011.932 [CBIT](INFO): Clearing failed state for component RudderServo
2024-08-22T16:26:51.932Z,1724344011.932 [RudderServo] No Fault, FailCount= 1
2024-08-22T16:26:57.022Z,1724344017.022 [NAL9602](INFO): SBD MO Status=0, MOMSN=55031, MT Status=0, MTMSN=0
2024-08-22T16:26:57.022Z,1724344017.022 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:27:27.717Z,1724344047.717 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:31:49.641Z,1724344309.641 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:31:49.641Z,1724344309.641 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:31:49.641Z,1724344309.641 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:31:49.641Z,1724344309.641 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:31:50.049Z,1724344310.049 [Default:CheckIn:D] Stopped
2024-08-22T16:31:50.049Z,1724344310.049 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 88.510335 min
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn:E] Stopped
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn] Stopped
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn](INFO): Running loop #12
2024-08-22T16:31:50.463Z,1724344310.463 [Default:CheckIn] Running Loop=12
2024-08-22T16:31:50.464Z,1724344310.464 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:31:50.464Z,1724344310.464 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:31:52.453Z,1724344312.453 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163151.00,A,3648.15059,N,12147.22233,W,0.019,97.75,220824,,,A*45
2024-08-22T16:31:52.456Z,1724344312.456 [NAL9602](INFO): GPS fix at 20240822T163151: (36.802510, -121.787039)
2024-08-22T16:31:52.466Z,1724344312.466 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:31:52.466Z,1724344312.466 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:32:00.146Z,1724344320.146 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0040.lzma
2024-08-22T16:32:01.149Z,1724344321.149 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0040.lzma.bak
2024-08-22T16:32:01.149Z,1724344321.149 [DataOverHttps](INFO): SBD MOMSN=23042556
2024-08-22T16:32:13.058Z,1724344333.058 [NAL9602](INFO): SBD MO Status=2, MOMSN=55032, MT Status=2, MTMSN=0
2024-08-22T16:32:13.058Z,1724344333.058 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-22T16:32:17.052Z,1724344337.052 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20240822T145936/Express0041.lzma
2024-08-22T16:32:18.053Z,1724344338.053 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0041.lzma.bak
2024-08-22T16:32:18.053Z,1724344338.053 [DataOverHttps](INFO): SBD MOMSN=23042560
2024-08-22T16:32:19.124Z,1724344339.124 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:32:19.125Z,1724344339.125 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:32:19.125Z,1724344339.125 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:32:55.989Z,1724344375.989 [NAL9602](INFO): SBD MO Status=2, MOMSN=55032, MT Status=2, MTMSN=0
2024-08-22T16:32:55.989Z,1724344375.989 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-22T16:34:11.131Z,1724344451.131 [NAL9602](INFO): SBD MO Status=0, MOMSN=55032, MT Status=0, MTMSN=0
2024-08-22T16:34:11.131Z,1724344451.131 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:34:41.880Z,1724344481.880 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:37:19.913Z,1724344639.913 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:37:19.913Z,1724344639.913 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:37:19.913Z,1724344639.913 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:37:19.913Z,1724344639.913 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:37:20.322Z,1724344640.322 [Default:CheckIn:D] Stopped
2024-08-22T16:37:20.322Z,1724344640.322 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:37:20.722Z,1724344640.722 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.014884 min
2024-08-22T16:37:20.722Z,1724344640.722 [Default:CheckIn:E] Stopped
2024-08-22T16:37:20.722Z,1724344640.722 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:37:20.739Z,1724344640.739 [Default:CheckIn] Stopped
2024-08-22T16:37:20.739Z,1724344640.739 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:37:20.739Z,1724344640.739 [Default:CheckIn](INFO): Running loop #13
2024-08-22T16:37:20.739Z,1724344640.739 [Default:CheckIn] Running Loop=13
2024-08-22T16:37:20.739Z,1724344640.739 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:37:20.739Z,1724344640.739 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:37:22.738Z,1724344642.738 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163722.00,A,3648.14987,N,12147.22128,W,0.272,97.75,220824,,,D*4F
2024-08-22T16:37:22.740Z,1724344642.740 [NAL9602](INFO): GPS fix at 20240822T163722: (36.802498, -121.787021)
2024-08-22T16:37:22.750Z,1724344642.750 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:37:22.750Z,1724344642.750 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:37:28.766Z,1724344648.766 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0043.lzma
2024-08-22T16:37:29.769Z,1724344649.769 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0043.lzma.bak
2024-08-22T16:37:29.769Z,1724344649.769 [DataOverHttps](INFO): SBD MOMSN=23042572
2024-08-22T16:37:45.566Z,1724344665.566 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20240822T145936/Express0044.lzma
2024-08-22T16:37:46.569Z,1724344666.569 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0044.lzma.bak
2024-08-22T16:37:46.569Z,1724344666.569 [DataOverHttps](INFO): SBD MOMSN=23042577
2024-08-22T16:37:47.788Z,1724344667.788 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:37:47.789Z,1724344667.789 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:37:47.789Z,1724344667.789 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:37:57.476Z,1724344677.476 [NAL9602](INFO): SBD MO Status=0, MOMSN=55033, MT Status=0, MTMSN=0
2024-08-22T16:37:57.477Z,1724344677.477 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:38:28.232Z,1724344708.232 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:42:48.216Z,1724344968.216 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:42:48.217Z,1724344968.217 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:42:48.217Z,1724344968.217 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:42:48.217Z,1724344968.217 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:42:48.614Z,1724344968.614 [Default:CheckIn:D] Stopped
2024-08-22T16:42:48.614Z,1724344968.614 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:42:49.030Z,1724344969.030 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 99.486418 min
2024-08-22T16:42:49.030Z,1724344969.030 [Default:CheckIn:E] Stopped
2024-08-22T16:42:49.030Z,1724344969.030 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:42:49.030Z,1724344969.030 [Default:CheckIn] Stopped
2024-08-22T16:42:49.031Z,1724344969.031 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:42:49.031Z,1724344969.031 [Default:CheckIn](INFO): Running loop #14
2024-08-22T16:42:49.031Z,1724344969.031 [Default:CheckIn] Running Loop=14
2024-08-22T16:42:49.031Z,1724344969.031 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:42:49.031Z,1724344969.031 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:42:51.038Z,1724344971.038 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164250.00,A,3648.35042,N,12147.11452,W,3.149,2.11,220824,,,D*75
2024-08-22T16:42:51.040Z,1724344971.040 [NAL9602](INFO): GPS fix at 20240822T164250: (36.805840, -121.785242)
2024-08-22T16:42:51.083Z,1724344971.083 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:42:51.083Z,1724344971.083 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:42:59.846Z,1724344979.846 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0046.lzma
2024-08-22T16:43:00.849Z,1724344980.849 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0046.lzma.bak
2024-08-22T16:43:00.849Z,1724344980.849 [DataOverHttps](INFO): SBD MOMSN=23042587
2024-08-22T16:43:16.595Z,1724344996.595 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20240822T145936/Express0047.lzma
2024-08-22T16:43:17.597Z,1724344997.597 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0047.lzma.bak
2024-08-22T16:43:17.597Z,1724344997.597 [DataOverHttps](INFO): SBD MOMSN=23042593
2024-08-22T16:43:18.957Z,1724344998.957 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:43:18.957Z,1724344998.957 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:43:18.957Z,1724344998.957 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:44:31.301Z,1724345071.301 [NAL9602](INFO): SBD MO Status=0, MOMSN=55034, MT Status=0, MTMSN=0
2024-08-22T16:44:31.301Z,1724345071.301 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:45:02.050Z,1724345102.050 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:48:19.656Z,1724345299.656 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:48:19.656Z,1724345299.656 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:48:19.656Z,1724345299.656 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:48:19.657Z,1724345299.657 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:48:20.070Z,1724345300.070 [Default:CheckIn:D] Stopped
2024-08-22T16:48:20.070Z,1724345300.070 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:48:20.482Z,1724345300.482 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.010685 min
2024-08-22T16:48:20.482Z,1724345300.482 [Default:CheckIn:E] Stopped
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn] Stopped
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn](INFO): Running loop #15
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn] Running Loop=15
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:48:20.483Z,1724345300.483 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:48:22.485Z,1724345302.485 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164821.00,A,3648.41649,N,12147.38691,W,5.287,237.08,220824,,,D*7A
2024-08-22T16:48:22.487Z,1724345302.487 [NAL9602](INFO): GPS fix at 20240822T164821: (36.806942, -121.789782)
2024-08-22T16:48:22.534Z,1724345302.534 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:48:22.534Z,1724345302.534 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:48:29.650Z,1724345309.650 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0049.lzma
2024-08-22T16:48:30.653Z,1724345310.653 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0049.lzma.bak
2024-08-22T16:48:30.653Z,1724345310.653 [DataOverHttps](INFO): SBD MOMSN=23042604
2024-08-22T16:48:46.331Z,1724345326.331 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20240822T145936/Express0050.lzma
2024-08-22T16:48:47.333Z,1724345327.333 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0050.lzma.bak
2024-08-22T16:48:47.333Z,1724345327.333 [DataOverHttps](INFO): SBD MOMSN=23042607
2024-08-22T16:48:48.367Z,1724345328.367 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:48:48.367Z,1724345328.367 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:48:48.367Z,1724345328.367 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:49:16.318Z,1724345356.318 [NAL9602](INFO): SBD MO Status=2, MOMSN=55035, MT Status=2, MTMSN=0
2024-08-22T16:49:16.318Z,1724345356.318 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-08-22T16:49:40.557Z,1724345380.557 [NAL9602](INFO): SBD MO Status=0, MOMSN=55035, MT Status=0, MTMSN=0
2024-08-22T16:49:40.557Z,1724345380.557 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:50:11.254Z,1724345411.254 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:53:48.787Z,1724345628.787 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:53:48.787Z,1724345628.787 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:53:48.788Z,1724345628.788 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:53:48.788Z,1724345628.788 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:53:49.191Z,1724345629.191 [Default:CheckIn:D] Stopped
2024-08-22T16:53:49.191Z,1724345629.191 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 110.496029 min
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn:E] Stopped
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn] Stopped
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn](INFO): Running loop #16
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn] Running Loop=16
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:53:49.581Z,1724345629.581 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:53:51.598Z,1724345631.598 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165350.00,A,3648.29642,N,12148.38911,W,14.734,208.42,220824,,,A*41
2024-08-22T16:53:51.600Z,1724345631.600 [NAL9602](INFO): GPS fix at 20240822T165350: (36.804940, -121.806485)
2024-08-22T16:53:51.611Z,1724345631.611 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:53:51.611Z,1724345631.611 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:53:59.582Z,1724345639.582 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0052.lzma
2024-08-22T16:54:00.585Z,1724345640.585 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0052.lzma.bak
2024-08-22T16:54:00.585Z,1724345640.585 [DataOverHttps](INFO): SBD MOMSN=23042620
2024-08-22T16:54:16.523Z,1724345656.523 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240822T145936/Express0053.lzma
2024-08-22T16:54:17.526Z,1724345657.526 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0053.lzma.bak
2024-08-22T16:54:17.526Z,1724345657.526 [DataOverHttps](INFO): SBD MOMSN=23042623
2024-08-22T16:54:18.690Z,1724345658.690 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:54:18.690Z,1724345658.690 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:54:18.690Z,1724345658.690 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T16:54:27.218Z,1724345667.218 [NAL9602](INFO): SBD MO Status=0, MOMSN=55036, MT Status=0, MTMSN=0
2024-08-22T16:54:27.218Z,1724345667.218 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:54:57.967Z,1724345697.967 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T16:59:19.137Z,1724345959.137 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T16:59:19.137Z,1724345959.137 [Default:CheckIn:C.Wait] Stopped
2024-08-22T16:59:19.137Z,1724345959.137 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T16:59:19.138Z,1724345959.138 [Default:CheckIn:D] Running Loop=1
2024-08-22T16:59:19.528Z,1724345959.528 [Default:CheckIn:D] Stopped
2024-08-22T16:59:19.528Z,1724345959.528 [Default:CheckIn:E] Running Loop=1
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 116.001660 min
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn:E] Stopped
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn] Stopped
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn](INFO): Running loop #17
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn] Running Loop=17
2024-08-22T16:59:19.940Z,1724345959.940 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T16:59:19.941Z,1724345959.941 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T16:59:21.946Z,1724345961.946 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165921.00,A,3648.01771,N,12149.63609,W,17.631,265.99,220824,,,D*40
2024-08-22T16:59:21.949Z,1724345961.949 [NAL9602](INFO): GPS fix at 20240822T165921: (36.800295, -121.827268)
2024-08-22T16:59:21.959Z,1724345961.959 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T16:59:21.959Z,1724345961.959 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T16:59:29.322Z,1724345969.322 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0055.lzma
2024-08-22T16:59:30.325Z,1724345970.325 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0055.lzma.bak
2024-08-22T16:59:30.325Z,1724345970.325 [DataOverHttps](INFO): SBD MOMSN=23042633
2024-08-22T16:59:41.341Z,1724345981.341 [NAL9602](INFO): SBD MO Status=0, MOMSN=55037, MT Status=0, MTMSN=0
2024-08-22T16:59:41.341Z,1724345981.341 [NAL9602](INFO): No messages in MT queue
2024-08-22T16:59:46.119Z,1724345986.119 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240822T145936/Express0056.lzma
2024-08-22T16:59:47.121Z,1724345987.121 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0056.lzma.bak
2024-08-22T16:59:47.121Z,1724345987.121 [DataOverHttps](INFO): SBD MOMSN=23042637
2024-08-22T16:59:48.222Z,1724345988.222 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T16:59:48.222Z,1724345988.222 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T16:59:48.222Z,1724345988.222 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T17:00:12.044Z,1724346012.044 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T17:04:48.939Z,1724346288.939 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T17:04:48.939Z,1724346288.939 [Default:CheckIn:C.Wait] Stopped
2024-08-22T17:04:48.940Z,1724346288.940 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T17:04:48.940Z,1724346288.940 [Default:CheckIn:D] Running Loop=1
2024-08-22T17:04:49.333Z,1724346289.333 [Default:CheckIn:D] Stopped
2024-08-22T17:04:49.333Z,1724346289.333 [Default:CheckIn:E] Running Loop=1
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 121.498413 min
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn:E] Stopped
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn] Stopped
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn](INFO): Running loop #18
2024-08-22T17:04:49.730Z,1724346289.730 [Default:CheckIn] Running Loop=18
2024-08-22T17:04:49.731Z,1724346289.731 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T17:04:49.731Z,1724346289.731 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T17:04:51.734Z,1724346291.734 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170451.00,A,3647.83294,N,12150.89979,W,2.099,345.33,220824,,,D*72
2024-08-22T17:04:51.736Z,1724346291.736 [NAL9602](INFO): GPS fix at 20240822T170451: (36.797216, -121.848330)
2024-08-22T17:04:51.755Z,1724346291.755 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T17:04:51.755Z,1724346291.755 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T17:05:00.638Z,1724346300.638 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0058.lzma
2024-08-22T17:05:01.653Z,1724346301.653 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0058.lzma.bak
2024-08-22T17:05:01.653Z,1724346301.653 [DataOverHttps](INFO): SBD MOMSN=23042698
2024-08-22T17:05:22.165Z,1724346322.165 [NAL9602](INFO): SBD MO Status=0, MOMSN=55038, MT Status=0, MTMSN=0
2024-08-22T17:05:22.165Z,1724346322.165 [NAL9602](INFO): No messages in MT queue
2024-08-22T17:05:48.094Z,1724346348.094 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20240822T145936/Express0059.lzma
2024-08-22T17:05:49.097Z,1724346349.097 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0059.lzma.bak
2024-08-22T17:05:49.097Z,1724346349.097 [DataOverHttps](INFO): SBD MOMSN=23042706
2024-08-22T17:05:50.453Z,1724346350.453 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T17:05:50.453Z,1724346350.453 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T17:05:50.454Z,1724346350.454 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T17:05:52.872Z,1724346352.872 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T17:10:51.065Z,1724346651.065 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-08-22T17:10:51.065Z,1724346651.065 [Default:CheckIn:C.Wait] Stopped
2024-08-22T17:10:51.065Z,1724346651.065 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-08-22T17:10:51.065Z,1724346651.065 [Default:CheckIn:D] Running Loop=1
2024-08-22T17:10:51.476Z,1724346651.476 [Default:CheckIn:D] Stopped
2024-08-22T17:10:51.476Z,1724346651.476 [Default:CheckIn:E] Running Loop=1
2024-08-22T17:10:51.890Z,1724346651.890 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 127.534123 min
2024-08-22T17:10:51.890Z,1724346651.890 [Default:CheckIn:E] Stopped
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn] Stopped
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn](INFO): Running loop #19
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn] Running Loop=19
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-08-22T17:10:51.891Z,1724346651.891 [Default:CheckIn:Read_GPS] Running Loop=1
2024-08-22T17:10:53.890Z,1724346653.890 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171053.00,A,3647.84532,N,12150.72356,W,0.428,76.71,220824,,,D*43
2024-08-22T17:10:53.892Z,1724346653.892 [NAL9602](INFO): GPS fix at 20240822T171053: (36.797422, -121.845393)
2024-08-22T17:10:53.923Z,1724346653.923 [Default:CheckIn:Read_GPS] Stopped
2024-08-22T17:10:53.923Z,1724346653.923 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-08-22T17:10:56.832Z,1724346656.832 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T17:11:10.046Z,1724346670.046 [NAL9602](INFO): SBD MO Status=0, MOMSN=55039, MT Status=0, MTMSN=0
2024-08-22T17:11:10.046Z,1724346670.046 [NAL9602](INFO): No messages in MT queue
2024-08-22T17:11:27.956Z,1724346687.956 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-08-22T17:11:35.414Z,1724346695.414 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240822T145936/Courier0061.lzma
2024-08-22T17:11:36.417Z,1724346696.417 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Courier0061.lzma.bak
2024-08-22T17:11:36.417Z,1724346696.417 [DataOverHttps](INFO): SBD MOMSN=23042795
2024-08-22T17:11:40.752Z,1724346700.752 [NAL9602](INFO): Not Powering down - fast GPS
2024-08-22T17:11:52.111Z,1724346712.111 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240822T145936/Express0062.lzma
2024-08-22T17:11:53.113Z,1724346713.113 [DataOverHttps](INFO): Moved sent file to Logs/20240822T145936/Express0062.lzma.bak
2024-08-22T17:11:53.113Z,1724346713.113 [DataOverHttps](IMPORTANT): SBD MOMSN=23042800, MTMSN=20240822T171152
2024-08-22T17:11:54.497Z,1724346714.497 [Default:CheckIn:Read_Iridium] Stopped
2024-08-22T17:11:54.497Z,1724346714.497 [Default:CheckIn:C.Wait] Running Loop=1
2024-08-22T17:11:54.497Z,1724346714.497 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-08-22T17:12:00.451Z,1724346720.451 [DataOverHttps](INFO): Received command: restart logs