2024-09-09T18:20:35.140Z,1725906035.140 [Supervisor](DEBUG): Initializing supervisor.
2024-09-09T18:20:35.145Z,1725906035.145 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-09-09T18:20:35.145Z,1725906035.145 [SyncHandler](INFO): Protected caller Thread ID is 1007
2024-09-09T18:20:35.145Z,1725906035.145 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-09-09T18:20:35.147Z,1725906035.147 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-09-09T18:20:35.147Z,1725906035.147 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1008
2024-09-09T18:20:35.151Z,1725906035.151 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-09-09T18:20:35.169Z,1725906035.169 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-09-09T18:20:35.170Z,1725906035.170 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-09-09T18:20:35.170Z,1725906035.170 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1009
2024-09-09T18:20:35.175Z,1725906035.175 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-09-09T18:20:35.176Z,1725906035.176 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-09-09T18:20:35.176Z,1725906035.176 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1010
2024-09-09T18:20:35.178Z,1725906035.178 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-09-09T18:20:35.179Z,1725906035.179 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-09-09T18:20:35.179Z,1725906035.179 [logger ThreadHandler](INFO): Protected caller Thread ID is 1011
2024-09-09T18:20:35.183Z,1725906035.183 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-09-09T18:20:35.183Z,1725906035.183 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-09-09T18:20:35.185Z,1725906035.185 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-09-09T18:20:35.292Z,1725906035.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-09-09T18:20:35.293Z,1725906035.293 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-09-09T18:20:36.103Z,1725906036.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-09-09T18:20:36.104Z,1725906036.104 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-09-09T18:20:36.356Z,1725906036.356 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-09-09T18:20:36.357Z,1725906036.357 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-09-09T18:20:36.447Z,1725906036.447 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-09-09T18:20:36.591Z,1725906036.591 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-09-09T18:20:36.592Z,1725906036.592 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-09-09T18:20:36.684Z,1725906036.684 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-09-09T18:20:36.805Z,1725906036.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-09-09T18:20:36.805Z,1725906036.805 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-09-09T18:20:37.233Z,1725906037.233 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-09-09T18:20:37.233Z,1725906037.233 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-09-09T18:20:37.805Z,1725906037.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-09-09T18:20:37.806Z,1725906037.806 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-09-09T18:20:38.044Z,1725906038.044 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-09-09T18:20:38.045Z,1725906038.045 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-09-09T18:20:38.249Z,1725906038.249 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-09-09T18:20:38.249Z,1725906038.249 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-09-09T18:20:38.821Z,1725906038.821 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-09-09T18:20:38.821Z,1725906038.821 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-09-09T18:20:39.135Z,1725906039.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-09-09T18:20:39.136Z,1725906039.136 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-09-09T18:20:39.400Z,1725906039.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-09-09T18:20:39.400Z,1725906039.400 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-09-09T18:20:40.383Z,1725906040.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-09-09T18:20:40.384Z,1725906040.384 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-09-09T18:20:40.772Z,1725906040.772 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-09-09T18:20:40.773Z,1725906040.773 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2024-09-09T18:20:40.774Z,1725906040.774 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2024-09-09T18:20:40.869Z,1725906040.869 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2024-09-09T18:20:41.056Z,1725906041.056 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg
2024-09-09T18:20:41.205Z,1725906041.205 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg
2024-09-09T18:20:41.312Z,1725906041.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2024-09-09T18:20:41.432Z,1725906041.432 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2024-09-09T18:20:41.530Z,1725906041.530 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2024-09-09T18:20:41.637Z,1725906041.637 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2024-09-09T18:20:41.763Z,1725906041.763 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2024-09-09T18:20:42.042Z,1725906042.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-09-09T18:20:42.043Z,1725906042.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2024-09-09T18:20:42.149Z,1725906042.149 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2024-09-09T18:20:42.254Z,1725906042.254 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2024-09-09T18:20:42.410Z,1725906042.410 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2024-09-09T18:20:42.524Z,1725906042.524 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2024-09-09T18:20:42.525Z,1725906042.525 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-09-09T18:20:42.536Z,1725906042.536 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-09-09T18:20:42.648Z,1725906042.648 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-09-09T18:20:42.649Z,1725906042.649 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-09-09T18:20:42.703Z,1725906042.703 [VerticalControl](DEBUG): Construct VerticalControl.
2024-09-09T18:20:42.764Z,1725906042.764 [VerticalControl] Loaded
2024-09-09T18:20:42.764Z,1725906042.764 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-09-09T18:20:42.767Z,1725906042.767 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-09-09T18:20:42.814Z,1725906042.814 [HorizontalControl] Loaded
2024-09-09T18:20:42.815Z,1725906042.815 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-09-09T18:20:42.817Z,1725906042.817 [SpeedControl](DEBUG): Construct SpeedControl.
2024-09-09T18:20:42.820Z,1725906042.820 [SpeedControl] Loaded
2024-09-09T18:20:42.820Z,1725906042.820 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-09-09T18:20:42.823Z,1725906042.823 [LoopControl](DEBUG): Construct LoopControl.
2024-09-09T18:20:42.823Z,1725906042.823 [LoopControl] Loaded
2024-09-09T18:20:42.824Z,1725906042.824 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-09-09T18:20:42.824Z,1725906042.824 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-09-09T18:20:42.825Z,1725906042.825 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-09-09T18:20:42.874Z,1725906042.874 [DepthRateCalculator] Loaded
2024-09-09T18:20:42.874Z,1725906042.874 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-09-09T18:20:42.879Z,1725906042.879 [PitchRateCalculator] Loaded
2024-09-09T18:20:42.879Z,1725906042.879 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-09-09T18:20:42.889Z,1725906042.889 [SpeedCalculator] Loaded
2024-09-09T18:20:42.889Z,1725906042.889 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-09-09T18:20:42.894Z,1725906042.894 [YawRateCalculator] Loaded
2024-09-09T18:20:42.894Z,1725906042.894 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-09-09T18:20:42.912Z,1725906042.912 [ElevatorOffsetCalculator] Loaded
2024-09-09T18:20:42.912Z,1725906042.912 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-09-09T18:20:42.913Z,1725906042.913 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-09-09T18:20:42.913Z,1725906042.913 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-09-09T18:20:42.940Z,1725906042.940 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-09-09T18:20:42.940Z,1725906042.940 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-09-09T18:20:43.009Z,1725906043.009 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-09-09T18:20:43.009Z,1725906043.009 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-09-09T18:20:43.350Z,1725906043.350 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-09-09T18:20:43.350Z,1725906043.350 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-09-09T18:20:43.526Z,1725906043.526 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-09-09T18:20:43.526Z,1725906043.526 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-09-09T18:20:44.012Z,1725906044.012 [AHRS_M2] Loaded
2024-09-09T18:20:44.012Z,1725906044.012 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-09-09T18:20:44.052Z,1725906044.052 [BackseatComponent] Loaded
2024-09-09T18:20:44.052Z,1725906044.052 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-09-09T18:20:44.053Z,1725906044.053 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409DD4E0
2024-09-09T18:20:44.053Z,1725906044.053 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1099
2024-09-09T18:20:44.056Z,1725906044.056 [LcmUniversalReporter] Loaded
2024-09-09T18:20:44.057Z,1725906044.057 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-09-09T18:20:45.269Z,1725906045.269 [BPC1] Loaded
2024-09-09T18:20:45.269Z,1725906045.269 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-09-09T18:20:45.443Z,1725906045.443 [DATMMP] Loaded
2024-09-09T18:20:45.443Z,1725906045.443 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2024-09-09T18:20:45.444Z,1725906045.444 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 40A0E4E0
2024-09-09T18:20:45.445Z,1725906045.445 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 1100
2024-09-09T18:20:45.520Z,1725906045.520 [DataOverHttps] Loaded
2024-09-09T18:20:45.521Z,1725906045.521 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-09-09T18:20:45.522Z,1725906045.522 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A3E4E0
2024-09-09T18:20:45.522Z,1725906045.522 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1101
2024-09-09T18:20:45.545Z,1725906045.545 [Depth_Keller] Loaded
2024-09-09T18:20:45.546Z,1725906045.546 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-09-09T18:20:45.611Z,1725906045.611 [NAL9602] Loaded
2024-09-09T18:20:45.611Z,1725906045.611 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-09-09T18:20:45.642Z,1725906045.642 [Onboard] Loaded
2024-09-09T18:20:45.642Z,1725906045.642 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-09-09T18:20:45.643Z,1725906045.643 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A6E4E0
2024-09-09T18:20:45.643Z,1725906045.643 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1102
2024-09-09T18:20:45.657Z,1725906045.657 [Power24vConverter] Loaded
2024-09-09T18:20:45.658Z,1725906045.658 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-09-09T18:20:45.673Z,1725906045.673 [Radio_Surface] Loaded
2024-09-09T18:20:45.673Z,1725906045.673 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-09-09T18:20:45.674Z,1725906045.674 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A9E4E0
2024-09-09T18:20:45.675Z,1725906045.675 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1103
2024-09-09T18:20:45.722Z,1725906045.722 [RDI_Pathfinder] Loaded
2024-09-09T18:20:45.723Z,1725906045.723 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2024-09-09T18:20:45.738Z,1725906045.738 [Sonardyne_Nano] Loaded
2024-09-09T18:20:45.738Z,1725906045.738 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-09-09T18:20:45.738Z,1725906045.738 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-09-09T18:20:45.739Z,1725906045.739 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-09-09T18:20:45.851Z,1725906045.851 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-09-09T18:20:45.852Z,1725906045.852 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-09-09T18:20:45.866Z,1725906045.866 [NavChart] Loaded
2024-09-09T18:20:45.866Z,1725906045.866 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-09-09T18:20:45.872Z,1725906045.872 [UniversalFixResidualReporter] Loaded
2024-09-09T18:20:45.872Z,1725906045.872 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-09-09T18:20:45.872Z,1725906045.872 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-09-09T18:20:45.873Z,1725906045.873 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-09-09T18:20:46.015Z,1725906046.015 [SBIT](DEBUG): Construct Startup Built In Test.
2024-09-09T18:20:46.025Z,1725906046.025 [SBIT] Loaded
2024-09-09T18:20:46.025Z,1725906046.025 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-09-09T18:20:46.028Z,1725906046.028 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-09-09T18:20:46.041Z,1725906046.041 [IBIT] Loaded
2024-09-09T18:20:46.041Z,1725906046.041 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-09-09T18:20:46.047Z,1725906046.047 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-09-09T18:20:46.155Z,1725906046.155 [CBIT] Loaded
2024-09-09T18:20:46.155Z,1725906046.155 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-09-09T18:20:46.156Z,1725906046.156 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-09-09T18:20:46.156Z,1725906046.156 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-09-09T18:20:46.293Z,1725906046.293 [BuoyancyServo] Loaded
2024-09-09T18:20:46.294Z,1725906046.294 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-09-09T18:20:46.317Z,1725906046.317 [ElevatorServo] Loaded
2024-09-09T18:20:46.317Z,1725906046.317 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-09-09T18:20:46.340Z,1725906046.340 [MassServo] Loaded
2024-09-09T18:20:46.340Z,1725906046.340 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-09-09T18:20:46.360Z,1725906046.360 [RudderServo] Loaded
2024-09-09T18:20:46.361Z,1725906046.361 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-09-09T18:20:46.379Z,1725906046.379 [ThrusterServo] Loaded
2024-09-09T18:20:46.380Z,1725906046.380 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2024-09-09T18:20:46.380Z,1725906046.380 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-09-09T18:20:46.381Z,1725906046.381 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-09-09T18:20:46.391Z,1725906046.391 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-09-09T18:20:46.392Z,1725906046.392 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-09-09T18:20:46.570Z,1725906046.570 [CTD_Seabird] Loaded
2024-09-09T18:20:46.571Z,1725906046.571 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-09-09T18:20:46.572Z,1725906046.572 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BF24E0
2024-09-09T18:20:46.572Z,1725906046.572 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1104
2024-09-09T18:20:46.595Z,1725906046.595 [PAR_Licor] Loaded
2024-09-09T18:20:46.595Z,1725906046.595 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-09-09T18:20:46.640Z,1725906046.640 [WetLabsBB2FL] Loaded
2024-09-09T18:20:46.640Z,1725906046.640 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-09-09T18:20:46.641Z,1725906046.641 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C224E0
2024-09-09T18:20:46.642Z,1725906046.642 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1105
2024-09-09T18:20:46.663Z,1725906046.663 [WetLabsUBAT] Loaded
2024-09-09T18:20:46.664Z,1725906046.664 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2024-09-09T18:20:46.665Z,1725906046.665 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C524E0
2024-09-09T18:20:46.665Z,1725906046.665 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 1106
2024-09-09T18:20:46.665Z,1725906046.665 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-09-09T18:20:46.673Z,1725906046.673 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-09-09T18:20:46.675Z,1725906046.675 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-09-09T18:20:46.687Z,1725906046.687 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-09-09T18:20:46.688Z,1725906046.688 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C824E0
2024-09-09T18:20:46.688Z,1725906046.688 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1107
2024-09-09T18:20:46.692Z,1725906046.692 [Supervisor](INFO): Main Thread ID is 832
2024-09-09T18:20:46.693Z,1725906046.693 [Supervisor](DEBUG): Running supervisor.
2024-09-09T18:20:46.693Z,1725906046.693 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1108
2024-09-09T18:20:46.694Z,1725906046.694 [CommandExec](INFO): Initializing the command executive.
2024-09-09T18:20:46.695Z,1725906046.695 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1109
2024-09-09T18:20:46.697Z,1725906046.697 [controlThread ThreadHandler](INFO): Handler Thread ID is 1110
2024-09-09T18:20:46.698Z,1725906046.698 [controlThread](DEBUG): Initializing ControlThread
2024-09-09T18:20:46.699Z,1725906046.699 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-09-09T18:20:46.700Z,1725906046.700 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-09-09T18:20:46.701Z,1725906046.701 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-09-09T18:20:46.701Z,1725906046.701 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-09-09T18:20:46.702Z,1725906046.702 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-09-09T18:20:46.702Z,1725906046.702 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-09-09T18:20:46.702Z,1725906046.702 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-09-09T18:20:46.703Z,1725906046.703 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-09-09T18:20:46.703Z,1725906046.703 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-09-09T18:20:46.708Z,1725906046.708 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-09-09T18:20:46.708Z,1725906046.708 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-09-09T18:20:46.708Z,1725906046.708 [SBIT](INFO): Initialize SBIT Component.
2024-09-09T18:20:46.709Z,1725906046.709 [SBIT](IMPORTANT): git: 2024-09-05
2024-09-09T18:20:46.709Z,1725906046.709 [SBIT](INFO): git hash: dce0dc62070cf863068ea7da7140e449252762ed
2024-09-09T18:20:46.709Z,1725906046.709 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-09-09T18:20:46.710Z,1725906046.710 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-09-09T18:20:46.712Z,1725906046.712 [SBIT](INFO): Beginning SBIT in 116.000000 seconds.
2024-09-09T18:20:46.712Z,1725906046.712 [IBIT](INFO): Initialize IBIT Component.
2024-09-09T18:20:46.713Z,1725906046.713 [CBIT](DEBUG): Initialize CBIT Component.
2024-09-09T18:20:46.714Z,1725906046.714 [logger ThreadHandler](INFO): Handler Thread ID is 1111
2024-09-09T18:20:46.726Z,1725906046.726 [CBIT](DEBUG): Initialized mux pins.
2024-09-09T18:20:46.726Z,1725906046.726 [CBIT](DEBUG): Initializing the watchdog timer.
2024-09-09T18:20:46.731Z,1725906046.731 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1112
2024-09-09T18:20:46.739Z,1725906046.739 [DATMMP ThreadHandler](INFO): Handler Thread ID is 1113
2024-09-09T18:20:46.739Z,1725906046.739 [DATMMP](INFO): Start
2024-09-09T18:20:46.740Z,1725906046.740 [DATMMP](INFO): Powering up
2024-09-09T18:20:46.740Z,1725906046.740 [DATMMP](DEBUG): Initializing DATMMP.
2024-09-09T18:20:46.744Z,1725906046.744 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1115
2024-09-09T18:20:46.745Z,1725906046.745 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-09-09T18:20:46.750Z,1725906046.750 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-09-09T18:20:46.751Z,1725906046.751 [CBIT](DEBUG): Initializing heartbeat.
2024-09-09T18:20:46.759Z,1725906046.759 [Onboard ThreadHandler](INFO): Handler Thread ID is 1116
2024-09-09T18:20:46.776Z,1725906046.776 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1117
2024-09-09T18:20:46.795Z,1725906046.795 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1118
2024-09-09T18:20:46.795Z,1725906046.795 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-09-09T18:20:46.800Z,1725906046.800 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1120
2024-09-09T18:20:46.803Z,1725906046.803 [WetLabsBB2FL](INFO): Powering up
2024-09-09T18:20:46.804Z,1725906046.804 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 1122
2024-09-09T18:20:46.807Z,1725906046.807 [WetLabsUBAT](INFO): Powering up
2024-09-09T18:20:46.808Z,1725906046.808 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1124
2024-09-09T18:20:46.811Z,1725906046.811 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-09-09T18:20:46.812Z,1725906046.812 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-09-09T18:20:46.812Z,1725906046.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-09-09T18:20:46.812Z,1725906046.812 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-09-09T18:20:46.812Z,1725906046.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-09-09T18:20:46.812Z,1725906046.812 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-09-09T18:20:46.812Z,1725906046.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-09-09T18:20:46.813Z,1725906046.813 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-09-09T18:20:46.822Z,1725906046.822 [CBIT](DEBUG): Deactivating GF circuits.
2024-09-09T18:20:46.822Z,1725906046.822 [CBIT](DEBUG): Deactivating emergency mode.
2024-09-09T18:20:46.862Z,1725906046.862 [CBIT](DEBUG): Backplane powered.
2024-09-09T18:20:46.867Z,1725906046.867 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-09-09T18:20:46.868Z,1725906046.868 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-09-09T18:20:46.868Z,1725906046.868 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-09-09T18:20:46.869Z,1725906046.869 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-09-09T18:20:46.946Z,1725906046.946 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-09-09T18:20:46.951Z,1725906046.951 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-09-09T18:20:46.990Z,1725906046.990 [DATMMP](INFO): Starting
2024-09-09T18:20:46.992Z,1725906046.992 [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-09-09T18:20:46.992Z,1725906046.992 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-09-09T18:20:46.992Z,1725906046.992 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-09-09T18:20:46.993Z,1725906046.993 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-09-09T18:20:47.182Z,1725906047.182 [Radio_Surface](INFO): Powering up
2024-09-09T18:20:47.242Z,1725906047.242 [DATMMP](INFO): Starting
2024-09-09T18:20:47.354Z,1725906047.354 [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-09-09T18:20:47.377Z,1725906047.377 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-09-09T18:20:47.378Z,1725906047.378 [Default:A.Wait](DEBUG): Construct Wait.
2024-09-09T18:20:47.383Z,1725906047.383 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-09-09T18:20:47.423Z,1725906047.423 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-09-09T18:20:47.425Z,1725906047.425 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-09-09T18:20:47.447Z,1725906047.447 [Default:E.Execute](DEBUG): Construct Execute.
2024-09-09T18:20:47.450Z,1725906047.450 [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-09-09T18:20:47.458Z,1725906047.458 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-09-09T18:20:47.474Z,1725906047.474 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-09-09T18:20:47.494Z,1725906047.494 [DATMMP](INFO): Starting
2024-09-09T18:20:47.540Z,1725906047.540 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m
2024-09-09T18:20:47.541Z,1725906047.541 [Power24vConverter](INFO): Powering up.
2024-09-09T18:20:47.542Z,1725906047.542 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2024-09-09T18:20:47.579Z,1725906047.579 [Sonardyne_Nano](INFO): Initializing.
2024-09-09T18:20:47.626Z,1725906047.626 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-09-09T18:20:47.656Z,1725906047.656 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-09-09T18:20:47.663Z,1725906047.663 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-09-09T18:20:47.664Z,1725906047.664 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-09-09T18:20:47.671Z,1725906047.671 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-09-09T18:20:47.672Z,1725906047.672 [MassServo](DEBUG): Initializing EZServoServo.
2024-09-09T18:20:47.679Z,1725906047.679 [MassServo](DEBUG): Initializing MassServo.
2024-09-09T18:20:47.679Z,1725906047.679 [RudderServo](DEBUG): Initializing EZServoServo.
2024-09-09T18:20:47.687Z,1725906047.687 [RudderServo](DEBUG): Initializing RudderServo.
2024-09-09T18:20:47.687Z,1725906047.687 [ThrusterServo](DEBUG): Initializing EZServoServo.
2024-09-09T18:20:47.695Z,1725906047.695 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2024-09-09T18:20:47.746Z,1725906047.746 [DATMMP](INFO): Starting
2024-09-09T18:20:47.999Z,1725906047.999 [DATMMP](INFO): Starting
2024-09-09T18:20:48.250Z,1725906048.250 [DATMMP](INFO): Starting
2024-09-09T18:20:48.502Z,1725906048.502 [DATMMP](INFO): Starting
2024-09-09T18:20:48.754Z,1725906048.754 [DATMMP](INFO): Starting
2024-09-09T18:20:49.006Z,1725906049.006 [DATMMP](INFO): Starting
2024-09-09T18:20:49.258Z,1725906049.258 [DATMMP](INFO): Starting
2024-09-09T18:20:49.418Z,1725906049.418 [WetLabsBB2FL](INFO): Powering down
2024-09-09T18:20:49.510Z,1725906049.510 [DATMMP](INFO): Starting
2024-09-09T18:20:49.762Z,1725906049.762 [DATMMP](INFO): Starting
2024-09-09T18:20:49.893Z,1725906049.893 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-09-09T18:20:50.015Z,1725906050.015 [DATMMP](INFO): Starting
2024-09-09T18:20:50.266Z,1725906050.266 [DATMMP](INFO): Starting
2024-09-09T18:20:50.518Z,1725906050.518 [DATMMP](INFO): Starting
2024-09-09T18:20:50.770Z,1725906050.770 [DATMMP](INFO): Starting
2024-09-09T18:20:51.022Z,1725906051.022 [DATMMP](INFO): Starting
2024-09-09T18:20:51.154Z,1725906051.154 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103
2024-09-09T18:20:51.277Z,1725906051.277 [DATMMP](INFO): Starting
2024-09-09T18:20:51.527Z,1725906051.527 [DATMMP](INFO): Starting
2024-09-09T18:20:51.781Z,1725906051.781 [DATMMP](INFO): Starting
2024-09-09T18:20:52.030Z,1725906052.030 [DATMMP](INFO): Starting
2024-09-09T18:20:52.282Z,1725906052.282 [DATMMP](INFO): Starting
2024-09-09T18:20:52.534Z,1725906052.534 [DATMMP](INFO): Starting
2024-09-09T18:20:52.786Z,1725906052.786 [DATMMP](INFO): Starting
2024-09-09T18:20:53.038Z,1725906053.038 [DATMMP](INFO): Starting
2024-09-09T18:20:53.290Z,1725906053.290 [DATMMP](INFO): Starting
2024-09-09T18:20:53.544Z,1725906053.544 [DATMMP](INFO): Starting
2024-09-09T18:20:53.794Z,1725906053.794 [DATMMP](INFO): Starting
2024-09-09T18:20:54.047Z,1725906054.047 [DATMMP](INFO): Starting
2024-09-09T18:20:54.298Z,1725906054.298 [DATMMP](INFO): Starting
2024-09-09T18:20:54.550Z,1725906054.550 [DATMMP](INFO): Starting
2024-09-09T18:20:54.802Z,1725906054.802 [DATMMP](INFO): Starting
2024-09-09T18:20:55.054Z,1725906055.054 [DATMMP](INFO): Starting
2024-09-09T18:20:55.306Z,1725906055.306 [DATMMP](INFO): Starting
2024-09-09T18:20:55.558Z,1725906055.558 [DATMMP](INFO): Starting
2024-09-09T18:20:55.810Z,1725906055.810 [DATMMP](INFO): Starting
2024-09-09T18:20:56.063Z,1725906056.063 [DATMMP](INFO): Starting
2024-09-09T18:20:56.075Z,1725906056.075 [WetLabsUBAT](INFO): Powering down
2024-09-09T18:20:56.314Z,1725906056.314 [DATMMP](INFO): Starting
2024-09-09T18:20:56.566Z,1725906056.566 [DATMMP](INFO): Starting
2024-09-09T18:20:56.819Z,1725906056.819 [DATMMP](INFO): Starting
2024-09-09T18:20:57.071Z,1725906057.071 [DATMMP](INFO): Starting
2024-09-09T18:20:57.322Z,1725906057.322 [DATMMP](INFO): Starting
2024-09-09T18:20:57.574Z,1725906057.574 [DATMMP](INFO): Starting
2024-09-09T18:20:57.826Z,1725906057.826 [DATMMP](INFO): Starting
2024-09-09T18:20:58.078Z,1725906058.078 [DATMMP](INFO): Starting
2024-09-09T18:20:58.330Z,1725906058.330 [DATMMP](INFO): Starting
2024-09-09T18:20:58.582Z,1725906058.582 [DATMMP](INFO): Starting
2024-09-09T18:20:58.834Z,1725906058.834 [DATMMP](INFO): Starting
2024-09-09T18:20:59.087Z,1725906059.087 [DATMMP](INFO): Starting
2024-09-09T18:20:59.338Z,1725906059.338 [DATMMP](INFO): Starting
2024-09-09T18:20:59.590Z,1725906059.590 [DATMMP](INFO): Starting
2024-09-09T18:20:59.591Z,1725906059.591 [DATMMP](INFO): DAT read:
2024-09-09T18:20:59.592Z,1725906059.592 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-09-09T18:20:59.842Z,1725906059.842 [DATMMP](INFO): Starting
2024-09-09T18:21:00.094Z,1725906060.094 [DATMMP](INFO): Starting
2024-09-09T18:21:00.346Z,1725906060.346 [DATMMP](INFO): Starting
2024-09-09T18:21:00.598Z,1725906060.598 [DATMMP](INFO): Starting
2024-09-09T18:21:00.851Z,1725906060.851 [DATMMP](INFO): Starting
2024-09-09T18:21:01.104Z,1725906061.104 [DATMMP](INFO): Starting
2024-09-09T18:21:01.354Z,1725906061.354 [DATMMP](INFO): Starting
2024-09-09T18:21:01.355Z,1725906061.355 [DATMMP](INFO): DAT read: MF Frequency Band
2024-09-09T18:21:01.356Z,1725906061.356 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.17.2
2024-09-09T18:21:01.357Z,1725906061.357 [DATMMP](INFO): DAT read: Aug 9 2000 18:20:54
2024-09-09T18:21:01.606Z,1725906061.606 [DATMMP](INFO): Starting
2024-09-09T18:21:01.858Z,1725906061.858 [DATMMP](INFO): Starting
2024-09-09T18:21:02.110Z,1725906062.110 [DATMMP](INFO): Starting
2024-09-09T18:21:02.362Z,1725906062.362 [DATMMP](INFO): Starting
2024-09-09T18:21:02.363Z,1725906062.363 [DATMMP](INFO): DAT read: Features enabled [Bearing]
2024-09-09T18:21:02.364Z,1725906062.364 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-09-09T18:21:02.365Z,1725906062.365 [DATMMP](INFO): commRate: 800
2024-09-09T18:21:02.614Z,1725906062.614 [DATMMP](INFO): Starting
2024-09-09T18:21:02.866Z,1725906062.866 [DATMMP](INFO): Starting
2024-09-09T18:21:03.119Z,1725906063.119 [DATMMP](INFO): Starting
2024-09-09T18:21:03.371Z,1725906063.371 [DATMMP](INFO): Starting
2024-09-09T18:21:03.622Z,1725906063.622 [DATMMP](INFO): Starting
2024-09-09T18:21:03.875Z,1725906063.875 [DATMMP](INFO): Starting
2024-09-09T18:21:04.127Z,1725906064.127 [DATMMP](INFO): Starting
2024-09-09T18:21:04.378Z,1725906064.378 [DATMMP](INFO): Starting
2024-09-09T18:21:04.430Z,1725906064.430 [DATMMP](INFO): entering command mode
2024-09-09T18:21:04.631Z,1725906064.631 [DATMMP](INFO): Starting
2024-09-09T18:21:04.631Z,1725906064.631 [DATMMP](INFO): DAT read:
2024-09-09T18:21:04.631Z,1725906064.631 [DATMMP](INFO): DAT read: user:1>
2024-09-09T18:21:04.632Z,1725906064.632 [DATMMP](DEBUG): read user prompt 1: user:1>
2024-09-09T18:21:04.632Z,1725906064.632 [DATMMP](INFO): entering MMP mode
2024-09-09T18:21:04.882Z,1725906064.882 [DATMMP](INFO): Starting
2024-09-09T18:21:04.883Z,1725906064.883 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-09T18:21:04.885Z,1725906064.885 [DATMMP](INFO): status rx: x1
2024-09-09T18:21:04.885Z,1725906064.885 [DATMMP](INFO): MMP status: 1: started
2024-09-09T18:21:04.885Z,1725906064.885 [DATMMP](INFO): Received message type: status
2024-09-09T18:21:04.886Z,1725906064.886 [DATMMP](INFO): Handled
2024-09-09T18:21:05.135Z,1725906065.135 [DATMMP](INFO): Starting
2024-09-09T18:21:05.136Z,1725906065.136 [DATMMP](INFO): Sent Tx Power Config 8
2024-09-09T18:21:05.136Z,1725906065.136 [DATMMP](INFO): Setting local address: 10
2024-09-09T18:21:05.138Z,1725906065.138 [DATMMP](INFO): Setting time to: 18:21:5 And date to:9/9/2024
2024-09-09T18:21:05.386Z,1725906065.386 [DATMMP](INFO): Starting
2024-09-09T18:21:05.387Z,1725906065.387 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-09T18:21:05.388Z,1725906065.388 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0
2024-09-09T18:21:05.388Z,1725906065.388 [DATMMP](INFO): Received message type: mdmpower
2024-09-09T18:21:05.388Z,1725906065.388 [DATMMP](INFO): Handled
2024-09-09T18:21:05.638Z,1725906065.638 [DATMMP](INFO): Starting
2024-09-09T18:21:05.639Z,1725906065.639 [DATMMP](INFO): GSXN notify for xid: 10
2024-09-09T18:21:05.639Z,1725906065.639 [DATMMP](INFO): sreg_txpower rx: x8
2024-09-09T18:21:05.639Z,1725906065.639 [DATMMP](INFO): Received message type: sreg_txpower
2024-09-09T18:21:05.640Z,1725906065.640 [DATMMP](INFO): Match for : sreg_txpower
2024-09-09T18:21:05.640Z,1725906065.640 [DATMMP](INFO): ACK
2024-09-09T18:21:05.891Z,1725906065.891 [DATMMP](INFO): Starting
2024-09-09T18:21:05.891Z,1725906065.891 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-09T18:21:05.892Z,1725906065.892 [DATMMP](INFO): mdmlocal rx: xA x0 x0 x0
2024-09-09T18:21:05.892Z,1725906065.892 [DATMMP](INFO): Received message type: mdmlocal
2024-09-09T18:21:05.892Z,1725906065.892 [DATMMP](INFO): Handled
2024-09-09T18:21:06.143Z,1725906066.143 [DATMMP](INFO): Starting
2024-09-09T18:21:06.143Z,1725906066.143 [DATMMP](INFO): GSXN notify for xid: 11
2024-09-09T18:21:06.144Z,1725906066.144 [DATMMP](INFO): sreg_locaddr rx: xA
2024-09-09T18:21:06.144Z,1725906066.144 [DATMMP](INFO): Received message type: sreg_locaddr
2024-09-09T18:21:06.144Z,1725906066.144 [DATMMP](INFO): Match for : sreg_locaddr
2024-09-09T18:21:06.145Z,1725906066.145 [DATMMP](INFO): ACK
2024-09-09T18:21:06.395Z,1725906066.395 [DATMMP](INFO): Starting
2024-09-09T18:21:06.395Z,1725906066.395 [DATMMP](INFO): GSXN notify for xid: 12
2024-09-09T18:21:06.396Z,1725906066.396 [DATMMP](INFO): timedate rx: x0 x12 x15 x5 x8 x9 x7C x0
2024-09-09T18:21:06.396Z,1725906066.396 [DATMMP](INFO): Received message type: timedate
2024-09-09T18:21:06.396Z,1725906066.396 [DATMMP](INFO): Match for : timedate
2024-09-09T18:21:06.397Z,1725906066.397 [DATMMP](INFO): ACK
2024-09-09T18:21:06.646Z,1725906066.646 [DATMMP](INFO): Starting
2024-09-09T18:21:06.647Z,1725906066.647 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-09T18:21:06.648Z,1725906066.648 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0
2024-09-09T18:21:06.648Z,1725906066.648 [DATMMP](INFO): Received message type: sys_verb
2024-09-09T18:21:06.648Z,1725906066.648 [DATMMP](INFO): Handled
2024-09-09T18:21:06.899Z,1725906066.899 [DATMMP](INFO): Starting
2024-09-09T18:21:06.899Z,1725906066.899 [DATMMP](INFO): GSXN notify for xid: 13
2024-09-09T18:21:06.900Z,1725906066.900 [DATMMP](INFO): sreg_verbosity rx: x0
2024-09-09T18:21:06.900Z,1725906066.900 [DATMMP](INFO): Received message type: sreg_verbosity
2024-09-09T18:21:06.900Z,1725906066.900 [DATMMP](INFO): Match for : sreg_verbosity
2024-09-09T18:21:06.900Z,1725906066.900 [DATMMP](INFO): ACK
2024-09-09T18:21:07.150Z,1725906067.150 [DATMMP](INFO): Starting
2024-09-09T18:21:07.151Z,1725906067.151 [DATMMP](INFO): GSXN notify for xid: 14
2024-09-09T18:21:07.152Z,1725906067.152 [DATMMP](INFO): version rx: x2 x5
2024-09-09T18:21:07.152Z,1725906067.152 [DATMMP](INFO): DatMMPVersion: 2.5
2024-09-09T18:21:07.152Z,1725906067.152 [DATMMP](INFO): Received message type: version
2024-09-09T18:21:07.152Z,1725906067.152 [DATMMP](INFO): Match for : version
2024-09-09T18:21:07.152Z,1725906067.152 [DATMMP](INFO): ACK
2024-09-09T18:21:07.152Z,1725906067.152 [DATMMP](INFO): in MMP mode: config complete going to runnable
2024-09-09T18:21:15.756Z,1725906075.756 [NAL9602](INFO): Powering up NAL9602
2024-09-09T18:21:21.767Z,1725906081.767 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-09T18:21:21.768Z,1725906081.768 [DATMMP](INFO): timesync rx: x0 x1 x1 x0
2024-09-09T18:21:21.768Z,1725906081.768 [DATMMP](INFO): Received message type: timesync
2024-09-09T18:21:21.768Z,1725906081.768 [DATMMP](INFO): Handled
2024-09-09T18:21:26.664Z,1725906086.664 [NAL9602](INFO): NAL9602 initialized
2024-09-09T18:21:29.127Z,1725906089.127 [CommandExec](IMPORTANT): got command strobe off
2024-09-09T18:21:29.128Z,1725906089.128 [CommandExec](IMPORTANT): Deactivating strobe
2024-09-09T18:21:31.847Z,1725906091.847 [DATMMP](INFO): GSXN notify for xid: 0
2024-09-09T18:21:31.848Z,1725906091.848 [DATMMP](INFO): timesync rx: x1 x0 x1 x0
2024-09-09T18:21:31.848Z,1725906091.848 [DATMMP](INFO): Received message type: timesync
2024-09-09T18:21:31.848Z,1725906091.848 [DATMMP](INFO): Handled
2024-09-09T18:22:43.525Z,1725906163.525 [SBIT](IMPORTANT): Beginning Startup BIT
2024-09-09T18:22:43.529Z,1725906163.529 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-09T18:22:54.402Z,1725906174.402 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.078995
CHAN A1 (24V): 0.081730
CHAN A2 (12V): 0.028164
CHAN A3 (5V): 0.008092
CHAN B0 (3.3V): 0.004907
CHAN B1 (3.15aV): 0.005636
CHAN B2 (3.15bV): 0.005330
CHAN B3 (GND): -0.003161
OPEN: 0.006697
Full Scale: +/- 1 mA
2024-09-09T18:23:33.180Z,1725906213.180 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:23:37.577Z,1725906217.577 [SBIT](IMPORTANT): SBIT PASSED
2024-09-09T18:23:37.577Z,1725906217.577 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-09-09T18:23:37.578Z,1725906217.578 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-09-09T18:23:37.578Z,1725906217.578 [SBIT](IMPORTANT): DATMMP.loadAtStartup=1 bool;
2024-09-09T18:23:37.578Z,1725906217.578 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;
2024-09-09T18:23:37.578Z,1725906217.578 [SBIT](IMPORTANT): DockingStepper.loadAtStartup=0 bool;
2024-09-09T18:23:37.578Z,1725906217.578 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2024-09-09T18:23:37.578Z,1725906217.578 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter;
2024-09-09T18:23:37.579Z,1725906217.579 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 5.000000 meter;
2024-09-09T18:23:37.579Z,1725906217.579 [SBIT](IMPORTANT): Radio_Surface.manageDockNetwork=0 bool;
2024-09-09T18:23:37.579Z,1725906217.579 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree;
2024-09-09T18:23:37.579Z,1725906217.579 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=314.8 cubic_centimeter;
2024-09-09T18:23:37.579Z,1725906217.579 [SBIT](IMPORTANT): VerticalControl.massDefault=24.11 millimeter;
2024-09-09T18:23:37.989Z,1725906217.989 [MissionManager](IMPORTANT): Started mission Startup
2024-09-09T18:23:37.989Z,1725906217.989 [Startup] Running Loop=1
2024-09-09T18:23:37.990Z,1725906217.990 [Startup](DEBUG): Aggregate::initialize Startup
2024-09-09T18:23:37.990Z,1725906217.990 [Startup:A.GoToSurface] Running Loop=1
2024-09-09T18:23:37.990Z,1725906217.990 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-09-09T18:23:37.990Z,1725906217.990 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-09-09T18:23:37.991Z,1725906217.991 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-09-09T18:23:37.991Z,1725906217.991 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-09-09T18:23:37.992Z,1725906217.992 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-09-09T18:23:37.992Z,1725906217.992 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-09-09T18:23:37.992Z,1725906217.992 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-09-09T18:23:37.994Z,1725906217.994 [Startup:StartupSatComms] Running Loop=1
2024-09-09T18:23:37.994Z,1725906217.994 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-09-09T18:23:37.994Z,1725906217.994 [Startup:StartupSatComms:A] Running Loop=1
2024-09-09T18:23:38.381Z,1725906218.381 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-09-09T18:23:46.887Z,1725906226.887 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-09-09T18:23:46.887Z,1725906226.887 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:23:46.957Z,1725906226.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:23:47.339Z,1725906227.339 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:23:47.339Z,1725906227.339 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-09-09T18:23:50.172Z,1725906230.172 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004767
2024-09-09T18:23:50.907Z,1725906230.907 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:01.864Z,1725906241.864 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:12.775Z,1725906252.775 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:22.085Z,1725906262.085 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:23.721Z,1725906263.721 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:32.973Z,1725906272.973 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:34.590Z,1725906274.590 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:38.183Z,1725906278.183 [Startup:StartupSatComms:A](INFO): Timed out from 2024-09-09T18:23:37.0Z
2024-09-09T18:24:38.183Z,1725906278.183 [Startup:StartupSatComms:A] Stopped
2024-09-09T18:24:38.183Z,1725906278.183 [Startup:StartupSatComms:B] Running Loop=1
2024-09-09T18:24:38.597Z,1725906278.597 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-09-09T18:24:43.517Z,1725906283.517 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:45.497Z,1725906285.497 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:45.558Z,1725906285.558 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T180918/Courier0007.lzma
2024-09-09T18:24:46.562Z,1725906286.562 [DataOverHttps](INFO): Moved sent file to Logs/20240909T180918/Courier0007.lzma.bak
2024-09-09T18:24:46.562Z,1725906286.562 [DataOverHttps](INFO): SBD MOMSN=23148431
2024-09-09T18:24:54.387Z,1725906294.387 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:24:56.421Z,1725906296.421 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:02.298Z,1725906302.298 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240909T182035/Courier0000.lzma
2024-09-09T18:25:03.300Z,1725906303.300 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0000.lzma.bak
2024-09-09T18:25:03.301Z,1725906303.301 [DataOverHttps](INFO): SBD MOMSN=23148433
2024-09-09T18:25:05.294Z,1725906305.294 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:07.358Z,1725906307.358 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:16.255Z,1725906316.255 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:18.628Z,1725906318.628 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:19.454Z,1725906319.454 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20240909T180918/Express0008.lzma
2024-09-09T18:25:20.456Z,1725906320.456 [DataOverHttps](INFO): Moved sent file to Logs/20240909T180918/Express0008.lzma.bak
2024-09-09T18:25:20.456Z,1725906320.456 [DataOverHttps](INFO): SBD MOMSN=23148436
2024-09-09T18:25:27.163Z,1725906327.163 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:29.532Z,1725906329.532 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:36.329Z,1725906336.329 [DataOverHttps](INFO): Sending 1015 bytes from file Logs/20240909T182035/Express0001.lzma
2024-09-09T18:25:37.328Z,1725906337.328 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0001.lzma.bak
2024-09-09T18:25:37.328Z,1725906337.328 [DataOverHttps](INFO): SBD MOMSN=23148443
2024-09-09T18:25:38.028Z,1725906338.028 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:38.396Z,1725906338.396 [Startup:StartupSatComms:B](INFO): Timed out from 2024-09-09T18:24:38.2Z
2024-09-09T18:25:38.397Z,1725906338.397 [Startup:StartupSatComms:B] Stopped
2024-09-09T18:25:38.397Z,1725906338.397 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-09-09T18:25:38.397Z,1725906338.397 [Startup:StartupSatComms] Stopped
2024-09-09T18:25:38.397Z,1725906338.397 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-09-09T18:25:38.398Z,1725906338.398 [Startup](INFO): Completed Startup
2024-09-09T18:25:38.398Z,1725906338.398 [MissionManager](INFO): Startup is completed.
2024-09-09T18:25:38.398Z,1725906338.398 [MissionManager](INFO): Uninitializing Mission Startup
2024-09-09T18:25:38.398Z,1725906338.398 [Startup] Stopped
2024-09-09T18:25:38.399Z,1725906338.399 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-09-09T18:25:38.399Z,1725906338.399 [Startup:A.GoToSurface] Stopped
2024-09-09T18:25:38.399Z,1725906338.399 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-09-09T18:25:38.797Z,1725906338.797 [MissionManager](IMPORTANT): Started mission Default
2024-09-09T18:25:38.797Z,1725906338.797 [Default] Running Loop=1
2024-09-09T18:25:38.797Z,1725906338.797 [Default](DEBUG): Aggregate::initialize Default
2024-09-09T18:25:38.797Z,1725906338.797 [Default:B.GoToSurface] Running Loop=1
2024-09-09T18:25:38.797Z,1725906338.797 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-09-09T18:25:38.798Z,1725906338.798 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-09-09T18:25:38.798Z,1725906338.798 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-09-09T18:25:38.798Z,1725906338.798 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-09-09T18:25:38.799Z,1725906338.799 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-09-09T18:25:38.799Z,1725906338.799 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-09-09T18:25:38.799Z,1725906338.799 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-09-09T18:25:38.799Z,1725906338.799 [Default:A.Wait] Running Loop=1
2024-09-09T18:25:38.800Z,1725906338.800 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-09-09T18:25:40.914Z,1725906340.914 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:48.944Z,1725906348.944 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:51.770Z,1725906351.770 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:25:51.801Z,1725906351.801 [Default:A.Wait](INFO): Done Waiting.
2024-09-09T18:25:51.801Z,1725906351.801 [Default:A.Wait] Stopped
2024-09-09T18:25:51.801Z,1725906351.801 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T18:25:52.141Z,1725906352.141 [Default:CheckIn] Running Loop=1
2024-09-09T18:25:52.141Z,1725906352.141 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T18:25:52.141Z,1725906352.141 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T18:25:52.536Z,1725906352.536 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-09-09T18:25:59.846Z,1725906359.846 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:02.682Z,1725906362.682 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:10.754Z,1725906370.754 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:13.194Z,1725906373.194 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:21.662Z,1725906381.662 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:24.095Z,1725906384.095 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:24.739Z,1725906384.739 [CommandExec](IMPORTANT): got command burn on
2024-09-09T18:26:24.740Z,1725906384.740 [CommandExec](IMPORTANT): Activating dropweight wire
2024-09-09T18:26:30.084Z,1725906390.084 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-09-09T18:26:32.164Z,1725906392.164 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:34.989Z,1725906394.989 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:43.869Z,1725906403.869 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:45.906Z,1725906405.906 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:47.871Z,1725906407.871 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-09-09T18:26:47.871Z,1725906407.871 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:26:47.882Z,1725906407.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:26:48.292Z,1725906408.292 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:26:48.292Z,1725906408.292 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-09-09T18:26:56.384Z,1725906416.384 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:26:56.503Z,1725906416.503 [CommandExec](IMPORTANT): got command burn off
2024-09-09T18:26:56.503Z,1725906416.503 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-09-09T18:26:56.821Z,1725906416.821 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:07.319Z,1725906427.319 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:08.501Z,1725906428.501 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:18.235Z,1725906438.235 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:21.025Z,1725906441.025 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:28.786Z,1725906448.786 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:33.552Z,1725906453.552 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:39.632Z,1725906459.632 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:46.075Z,1725906466.075 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:50.545Z,1725906470.545 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:27:58.601Z,1725906478.601 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:01.450Z,1725906481.450 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:11.163Z,1725906491.163 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:11.558Z,1725906491.558 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:22.049Z,1725906502.049 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:23.654Z,1725906503.654 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:32.965Z,1725906512.965 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:36.172Z,1725906516.172 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:43.873Z,1725906523.873 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:48.697Z,1725906528.697 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:28:54.781Z,1725906534.781 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:29:01.629Z,1725906541.629 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:29:05.686Z,1725906545.686 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:29:07.244Z,1725906547.244 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:29:10.867Z,1725906550.867 [BPC1](ERROR): Failed to receive data from all battery packs.
2024-09-09T18:29:10.868Z,1725906550.868 [BPC1] Communications Fault, FailCount= 1
2024-09-09T18:29:10.868Z,1725906550.868 [BPC1](ERROR): Communications Fault
2024-09-09T18:29:10.893Z,1725906550.893 [CBIT](ERROR): Communications Fault in component: BPC1
2024-09-09T18:29:34.287Z,1725906574.287 [CommandExec](IMPORTANT): got command gfscan
2024-09-09T18:29:34.366Z,1725906574.366 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-09T18:29:45.259Z,1725906585.259 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.040350
CHAN A1 (24V): 0.081247
CHAN A2 (12V): 0.028846
CHAN A3 (5V): 0.008060
CHAN B0 (3.3V): 0.005185
CHAN B1 (3.15aV): 0.005318
CHAN B2 (3.15bV): 0.005130
CHAN B3 (GND): -0.002382
OPEN: 0.006821
Full Scale: +/- 1 mA
2024-09-09T18:29:48.880Z,1725906588.880 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-09-09T18:29:48.880Z,1725906588.880 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:29:48.890Z,1725906588.890 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:29:49.372Z,1725906589.372 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:29:49.372Z,1725906589.372 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-09-09T18:30:52.350Z,1725906652.350 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T18:25:52.1Z
2024-09-09T18:30:52.351Z,1725906652.351 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T18:30:52.351Z,1725906652.351 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T18:30:52.728Z,1725906652.728 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-09-09T18:30:53.867Z,1725906653.867 [CommandExec](IMPORTANT): got command gfscan
2024-09-09T18:30:54.070Z,1725906654.070 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-09T18:31:00.906Z,1725906660.906 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T182035/Courier0004.lzma
2024-09-09T18:31:01.268Z,1725906661.268 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2024-09-09T18:31:01.268Z,1725906661.268 [RDI_Pathfinder] Communications Fault, FailCount= 1
2024-09-09T18:31:01.269Z,1725906661.269 [RDI_Pathfinder](ERROR): Communications Fault
2024-09-09T18:31:01.310Z,1725906661.310 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2024-09-09T18:31:01.739Z,1725906661.739 [RDI_Pathfinder](INFO): Powering down
2024-09-09T18:31:01.908Z,1725906661.908 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0004.lzma.bak
2024-09-09T18:31:01.908Z,1725906661.908 [DataOverHttps](INFO): SBD MOMSN=23148470
2024-09-09T18:31:02.514Z,1725906662.514 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2024-09-09T18:31:02.515Z,1725906662.515 [RDI_Pathfinder] No Fault, FailCount= 1
2024-09-09T18:31:02.895Z,1725906662.895 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2024-09-09T18:31:04.984Z,1725906664.984 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.041166
CHAN A1 (24V): -0.136149
CHAN A2 (12V): 0.028929
CHAN A3 (5V): 0.008672
CHAN B0 (3.3V): 0.005246
CHAN B1 (3.15aV): 0.005525
CHAN B2 (3.15bV): 0.005345
CHAN B3 (GND): -0.002361
OPEN: 0.006822
Full Scale: +/- 1 mA
2024-09-09T18:31:17.438Z,1725906677.438 [DataOverHttps](INFO): Sending 433 bytes from file Logs/20240909T182035/Express0005.lzma
2024-09-09T18:31:18.440Z,1725906678.440 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0005.lzma.bak
2024-09-09T18:31:18.440Z,1725906678.440 [DataOverHttps](INFO): SBD MOMSN=23148472
2024-09-09T18:31:19.468Z,1725906679.468 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T18:31:19.468Z,1725906679.468 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T18:31:19.468Z,1725906679.468 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T18:31:25.101Z,1725906685.101 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2024-09-09T18:31:25.101Z,1725906685.101 [RDI_Pathfinder] Communications Fault, FailCount= 2
2024-09-09T18:31:25.101Z,1725906685.101 [RDI_Pathfinder](ERROR): Communications Fault
2024-09-09T18:31:25.118Z,1725906685.118 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2024-09-09T18:31:25.575Z,1725906685.575 [RDI_Pathfinder](INFO): Powering down
2024-09-09T18:31:26.538Z,1725906686.538 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2024-09-09T18:31:26.538Z,1725906686.538 [RDI_Pathfinder] No Fault, FailCount= 2
2024-09-09T18:31:26.727Z,1725906686.727 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2024-09-09T18:31:29.544Z,1725906689.544 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T18:31:29.544Z,1725906689.544 [NAL9602] Data Fault, FailCount= 1
2024-09-09T18:31:29.544Z,1725906689.544 [NAL9602](ERROR): Data Fault
2024-09-09T18:31:29.589Z,1725906689.589 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T18:31:29.947Z,1725906689.947 [NAL9602](INFO): Powering down
2024-09-09T18:31:30.784Z,1725906690.784 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T18:31:30.784Z,1725906690.784 [NAL9602] No Fault, FailCount= 1
2024-09-09T18:32:00.248Z,1725906720.248 [NAL9602](INFO): Powering up NAL9602
2024-09-09T18:32:11.160Z,1725906731.160 [NAL9602](INFO): NAL9602 initialized
2024-09-09T18:32:49.948Z,1725906769.948 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-09-09T18:32:49.948Z,1725906769.948 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:32:49.958Z,1725906769.958 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:32:50.380Z,1725906770.380 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:32:50.381Z,1725906770.381 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-09-09T18:35:50.972Z,1725906950.972 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-09-09T18:35:50.972Z,1725906950.972 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:35:50.982Z,1725906950.982 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:35:51.395Z,1725906951.395 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:35:51.395Z,1725906951.395 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-09-09T18:36:20.050Z,1725906980.050 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T18:36:20.050Z,1725906980.050 [Default:CheckIn:C.Wait] Stopped
2024-09-09T18:36:20.050Z,1725906980.050 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T18:36:20.050Z,1725906980.050 [Default:CheckIn:D] Running Loop=1
2024-09-09T18:36:20.470Z,1725906980.470 [Default:CheckIn:D] Stopped
2024-09-09T18:36:20.470Z,1725906980.470 [Default:CheckIn:E] Running Loop=1
2024-09-09T18:36:20.868Z,1725906980.868 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.694544 min
2024-09-09T18:36:20.868Z,1725906980.868 [Default:CheckIn:E] Stopped
2024-09-09T18:36:20.868Z,1725906980.868 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T18:36:20.868Z,1725906980.868 [Default:CheckIn] Stopped
2024-09-09T18:36:20.868Z,1725906980.868 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T18:36:20.868Z,1725906980.868 [Default:CheckIn](INFO): Running loop #2
2024-09-09T18:36:20.869Z,1725906980.869 [Default:CheckIn] Running Loop=2
2024-09-09T18:36:20.869Z,1725906980.869 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T18:36:20.869Z,1725906980.869 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T18:36:41.359Z,1725907001.359 [CommandExec](IMPORTANT): got command show stack
2024-09-09T18:36:41.360Z,1725907001.360 [CommandExec](IMPORTANT): Behavior Stack:
2024-09-09T18:36:41.360Z,1725907001.360 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface
2024-09-09T18:36:41.360Z,1725907001.360 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS
2024-09-09T18:38:51.959Z,1725907131.959 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-09-09T18:38:51.959Z,1725907131.959 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:38:51.970Z,1725907131.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:38:52.390Z,1725907132.390 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:38:52.390Z,1725907132.390 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-09-09T18:39:11.766Z,1725907151.766 [CBIT](INFO): Clearing failed state for component BPC1
2024-09-09T18:39:11.766Z,1725907151.766 [BPC1] No Fault, FailCount= 1
2024-09-09T18:40:23.296Z,1725907223.296 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:40:23.372Z,1725907223.372 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:40:33.796Z,1725907233.796 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:40:34.221Z,1725907234.221 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:40:44.711Z,1725907244.711 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:40:56.017Z,1725907256.017 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:41:06.929Z,1725907266.929 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:41:17.859Z,1725907277.859 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:41:21.023Z,1725907281.023 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T18:36:20.9Z
2024-09-09T18:41:21.023Z,1725907281.023 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T18:41:21.023Z,1725907281.023 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T18:41:27.990Z,1725907287.990 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T182035/Courier0007.lzma
2024-09-09T18:41:28.992Z,1725907288.992 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0007.lzma.bak
2024-09-09T18:41:28.992Z,1725907288.992 [DataOverHttps](INFO): SBD MOMSN=23148545
2024-09-09T18:41:42.147Z,1725907302.147 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:41:44.875Z,1725907304.875 [DataOverHttps](INFO): Sending 503 bytes from file Logs/20240909T182035/Express0008.lzma
2024-09-09T18:41:45.876Z,1725907305.876 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0008.lzma.bak
2024-09-09T18:41:45.876Z,1725907305.876 [DataOverHttps](INFO): SBD MOMSN=23148547
2024-09-09T18:41:46.897Z,1725907306.897 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T18:41:46.898Z,1725907306.898 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T18:41:46.898Z,1725907306.898 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T18:41:52.948Z,1725907312.948 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-09-09T18:41:52.948Z,1725907312.948 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:41:52.967Z,1725907312.967 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:41:53.366Z,1725907313.366 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:41:53.366Z,1725907313.366 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-09-09T18:42:13.932Z,1725907333.932 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T18:42:13.932Z,1725907333.932 [NAL9602] Data Fault, FailCount= 2
2024-09-09T18:42:13.932Z,1725907333.932 [NAL9602](ERROR): Data Fault
2024-09-09T18:42:13.949Z,1725907333.949 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T18:42:14.383Z,1725907334.383 [NAL9602](INFO): Powering down
2024-09-09T18:42:15.184Z,1725907335.184 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T18:42:15.184Z,1725907335.184 [NAL9602] No Fault, FailCount= 2
2024-09-09T18:42:44.648Z,1725907364.648 [NAL9602](INFO): Powering up NAL9602
2024-09-09T18:42:55.534Z,1725907375.534 [NAL9602](INFO): NAL9602 initialized
2024-09-09T18:42:55.990Z,1725907375.990 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:01.610Z,1725907381.610 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:12.575Z,1725907392.575 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:23.478Z,1725907403.478 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:34.386Z,1725907414.386 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:40.432Z,1725907420.432 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:45.298Z,1725907425.298 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:50.954Z,1725907430.954 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:43:56.204Z,1725907436.204 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:01.861Z,1725907441.861 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:07.514Z,1725907447.514 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:12.823Z,1725907452.823 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:18.416Z,1725907458.416 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:23.673Z,1725907463.673 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:29.328Z,1725907469.328 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:34.583Z,1725907474.583 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:40.640Z,1725907480.640 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:45.487Z,1725907485.487 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:51.551Z,1725907491.551 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:44:53.919Z,1725907493.919 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-09-09T18:44:53.919Z,1725907493.919 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:44:53.930Z,1725907493.930 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:44:54.383Z,1725907494.383 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:44:54.383Z,1725907494.383 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-09-09T18:44:56.404Z,1725907496.404 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:02.068Z,1725907502.068 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:07.303Z,1725907507.303 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:13.366Z,1725907513.366 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:18.620Z,1725907518.620 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:24.313Z,1725907524.313 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:29.933Z,1725907529.933 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:35.181Z,1725907535.181 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:40.841Z,1725907540.841 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:45.683Z,1725907545.683 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:51.746Z,1725907551.746 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:45:56.593Z,1725907556.593 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:04.682Z,1725907564.682 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:07.906Z,1725907567.906 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:09.870Z,1725907569.870 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:19.219Z,1725907579.219 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:22.032Z,1725907582.032 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:30.530Z,1725907590.530 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:34.215Z,1725907594.215 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:41.841Z,1725907601.841 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:46.670Z,1725907606.670 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:47.476Z,1725907607.476 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T18:46:47.477Z,1725907607.477 [Default:CheckIn:C.Wait] Stopped
2024-09-09T18:46:47.477Z,1725907607.477 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T18:46:47.477Z,1725907607.477 [Default:CheckIn:D] Running Loop=1
2024-09-09T18:46:47.868Z,1725907607.868 [Default:CheckIn:D] Stopped
2024-09-09T18:46:47.869Z,1725907607.869 [Default:CheckIn:E] Running Loop=1
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.151188 min
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn:E] Stopped
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn] Stopped
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn](INFO): Running loop #3
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn] Running Loop=3
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T18:46:48.288Z,1725907608.288 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T18:46:52.744Z,1725907612.744 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:46:59.596Z,1725907619.596 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:03.655Z,1725907623.655 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:11.749Z,1725907631.749 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:14.573Z,1725907634.573 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:23.836Z,1725907643.836 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:25.471Z,1725907645.471 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:35.557Z,1725907655.557 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:36.380Z,1725907656.380 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:47.332Z,1725907667.332 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:48.185Z,1725907668.185 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:47:54.911Z,1725907674.911 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-09-09T18:47:54.911Z,1725907674.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:47:54.921Z,1725907674.921 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:47:55.325Z,1725907675.325 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:47:55.325Z,1725907675.325 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-09-09T18:47:58.223Z,1725907678.223 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:48:00.199Z,1725907680.199 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:48:09.104Z,1725907689.104 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:48:12.316Z,1725907692.316 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:48:20.011Z,1725907700.011 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:48:25.657Z,1725907705.657 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:48:29.236Z,1725907709.236 [BPC1](ERROR): Failed to receive data from all battery packs.
2024-09-09T18:48:29.236Z,1725907709.236 [BPC1] Communications Fault, FailCount= 2
2024-09-09T18:48:29.236Z,1725907709.236 [BPC1](ERROR): Communications Fault
2024-09-09T18:48:29.280Z,1725907709.280 [CBIT](ERROR): Communications Fault in component: BPC1
2024-09-09T18:50:55.903Z,1725907855.903 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-09-09T18:50:55.903Z,1725907855.903 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:50:55.914Z,1725907855.914 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:50:56.371Z,1725907856.371 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:50:56.371Z,1725907856.371 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-09-09T18:51:48.457Z,1725907908.457 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T18:46:48.3Z
2024-09-09T18:51:48.457Z,1725907908.457 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T18:51:48.457Z,1725907908.457 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T18:51:55.310Z,1725907915.310 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T182035/Courier0010.lzma
2024-09-09T18:51:56.312Z,1725907916.312 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0010.lzma.bak
2024-09-09T18:51:56.312Z,1725907916.312 [DataOverHttps](INFO): SBD MOMSN=23148702
2024-09-09T18:52:12.174Z,1725907932.174 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240909T182035/Express0011.lzma
2024-09-09T18:52:13.176Z,1725907933.176 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0011.lzma.bak
2024-09-09T18:52:13.176Z,1725907933.176 [DataOverHttps](INFO): SBD MOMSN=23148712
2024-09-09T18:52:14.313Z,1725907934.313 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T18:52:14.313Z,1725907934.313 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T18:52:14.313Z,1725907934.313 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T18:52:58.308Z,1725907978.308 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T18:52:58.308Z,1725907978.308 [NAL9602] Data Fault, FailCount= 3
2024-09-09T18:52:58.308Z,1725907978.308 [NAL9602](ERROR): Data Fault
2024-09-09T18:52:58.401Z,1725907978.401 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T18:52:58.707Z,1725907978.707 [NAL9602](INFO): Powering down
2024-09-09T18:52:59.537Z,1725907979.537 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T18:52:59.537Z,1725907979.537 [NAL9602] No Fault, FailCount= 3
2024-09-09T18:53:29.012Z,1725908009.012 [NAL9602](INFO): Powering up NAL9602
2024-09-09T18:53:39.920Z,1725908019.920 [NAL9602](INFO): NAL9602 initialized
2024-09-09T18:53:56.899Z,1725908036.899 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2024-09-09T18:53:56.899Z,1725908036.899 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:53:56.910Z,1725908036.910 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:53:57.307Z,1725908037.307 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:53:57.308Z,1725908037.308 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2024-09-09T18:56:57.887Z,1725908217.887 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2024-09-09T18:56:57.887Z,1725908217.887 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:56:57.899Z,1725908217.899 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:56:58.324Z,1725908218.324 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:56:58.324Z,1725908218.324 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2024-09-09T18:57:14.857Z,1725908234.857 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T18:57:14.857Z,1725908234.857 [Default:CheckIn:C.Wait] Stopped
2024-09-09T18:57:14.857Z,1725908234.857 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T18:57:14.857Z,1725908234.857 [Default:CheckIn:D] Running Loop=1
2024-09-09T18:57:15.260Z,1725908235.260 [Default:CheckIn:D] Stopped
2024-09-09T18:57:15.260Z,1725908235.260 [Default:CheckIn:E] Running Loop=1
2024-09-09T18:57:15.665Z,1725908235.665 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.607715 min
2024-09-09T18:57:15.665Z,1725908235.665 [Default:CheckIn:E] Stopped
2024-09-09T18:57:15.665Z,1725908235.665 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T18:57:15.665Z,1725908235.665 [Default:CheckIn] Stopped
2024-09-09T18:57:15.666Z,1725908235.666 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T18:57:15.666Z,1725908235.666 [Default:CheckIn](INFO): Running loop #4
2024-09-09T18:57:15.666Z,1725908235.666 [Default:CheckIn] Running Loop=4
2024-09-09T18:57:15.666Z,1725908235.666 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T18:57:15.666Z,1725908235.666 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T18:58:30.436Z,1725908310.436 [CBIT](INFO): Clearing failed state for component BPC1
2024-09-09T18:58:30.436Z,1725908310.436 [BPC1] No Fault, FailCount= 2
2024-09-09T18:59:41.969Z,1725908381.969 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:59:42.048Z,1725908382.048 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T18:59:53.281Z,1725908393.281 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T18:59:58.887Z,1725908398.887 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2024-09-09T18:59:58.887Z,1725908398.887 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T18:59:58.925Z,1725908398.925 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T18:59:59.307Z,1725908399.307 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T18:59:59.307Z,1725908399.307 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2024-09-09T19:00:04.197Z,1725908404.197 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:00:15.502Z,1725908415.502 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:00:19.122Z,1725908419.122 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:00:26.407Z,1725908426.407 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:00:37.457Z,1725908437.457 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:01:07.217Z,1725908467.217 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:09.043Z,1725908529.043 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:14.653Z,1725908534.653 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:15.891Z,1725908535.891 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T18:57:15.7Z
2024-09-09T19:02:15.891Z,1725908535.891 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:02:15.891Z,1725908535.891 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:02:23.462Z,1725908543.462 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T182035/Courier0013.lzma
2024-09-09T19:02:24.464Z,1725908544.464 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0013.lzma.bak
2024-09-09T19:02:24.464Z,1725908544.464 [DataOverHttps](INFO): SBD MOMSN=23148799
2024-09-09T19:02:25.617Z,1725908545.617 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:36.600Z,1725908556.600 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:40.490Z,1725908560.490 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240909T182035/Express0014.lzma
2024-09-09T19:02:41.492Z,1725908561.492 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0014.lzma.bak
2024-09-09T19:02:41.492Z,1725908561.492 [DataOverHttps](INFO): SBD MOMSN=23148801
2024-09-09T19:02:42.536Z,1725908562.536 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:02:42.536Z,1725908562.536 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:02:42.536Z,1725908562.536 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T19:02:47.494Z,1725908567.494 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:58.345Z,1725908578.345 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:02:59.959Z,1725908579.959 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2024-09-09T19:02:59.959Z,1725908579.959 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:02:59.970Z,1725908579.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:03:00.363Z,1725908580.363 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:03:00.364Z,1725908580.364 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2024-09-09T19:03:05.968Z,1725908585.968 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:09.253Z,1725908589.253 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:16.932Z,1725908596.932 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:20.254Z,1725908600.254 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:27.841Z,1725908607.841 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:31.069Z,1725908611.069 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:38.750Z,1725908618.750 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:41.976Z,1725908621.976 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:41.988Z,1725908621.988 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T19:03:41.988Z,1725908621.988 [NAL9602] Data Fault, FailCount= 4
2024-09-09T19:03:41.988Z,1725908621.988 [NAL9602](ERROR): Data Fault
2024-09-09T19:03:42.006Z,1725908622.006 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T19:03:42.331Z,1725908622.331 [NAL9602](INFO): Powering down
2024-09-09T19:03:43.145Z,1725908623.145 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T19:03:43.145Z,1725908623.145 [NAL9602] No Fault, FailCount= 4
2024-09-09T19:03:49.249Z,1725908629.249 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:52.482Z,1725908632.482 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:03:59.755Z,1725908639.755 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:03.797Z,1725908643.797 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:10.662Z,1725908650.662 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:12.620Z,1725908652.620 [NAL9602](INFO): Powering up NAL9602
2024-09-09T19:04:14.299Z,1725908654.299 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:21.980Z,1725908661.980 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:23.528Z,1725908663.528 [NAL9602](INFO): NAL9602 initialized
2024-09-09T19:04:25.207Z,1725908665.207 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:32.930Z,1725908672.930 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:36.167Z,1725908676.167 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:43.793Z,1725908683.793 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:46.617Z,1725908686.617 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:54.299Z,1725908694.299 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:04:57.931Z,1725908697.931 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:05.609Z,1725908705.609 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:09.298Z,1725908709.298 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:16.916Z,1725908716.916 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:20.184Z,1725908720.184 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:30.653Z,1725908730.653 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:31.073Z,1725908731.073 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:35.441Z,1725908735.441 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:41.560Z,1725908741.560 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:47.611Z,1725908747.611 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:52.469Z,1725908752.469 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:05:59.315Z,1725908759.315 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:00.899Z,1725908760.899 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2024-09-09T19:06:00.899Z,1725908760.899 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:06:00.926Z,1725908760.926 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:06:01.343Z,1725908761.343 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:06:01.343Z,1725908761.343 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2024-09-09T19:06:02.973Z,1725908762.973 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:11.439Z,1725908771.439 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:14.295Z,1725908774.295 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:23.965Z,1725908783.965 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:25.195Z,1725908785.195 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:36.151Z,1725908796.151 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:36.892Z,1725908796.892 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:44.153Z,1725908804.153 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,-3276,V
2024-09-09T19:06:47.011Z,1725908807.011 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:49.413Z,1725908809.413 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:06:58.325Z,1725908818.325 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:01.940Z,1725908821.940 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:04.349Z,1725908824.349 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-32768,-3768,V
2024-09-09T19:07:08.824Z,1725908828.824 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:14.870Z,1725908834.870 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:19.734Z,1725908839.734 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:26.989Z,1725908846.989 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:30.702Z,1725908850.702 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:39.104Z,1725908859.104 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:41.552Z,1725908861.552 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:43.133Z,1725908863.133 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T19:07:43.133Z,1725908863.133 [Default:CheckIn:C.Wait] Stopped
2024-09-09T19:07:43.133Z,1725908863.133 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T19:07:43.133Z,1725908863.133 [Default:CheckIn:D] Running Loop=1
2024-09-09T19:07:43.527Z,1725908863.527 [Default:CheckIn:D] Stopped
2024-09-09T19:07:43.527Z,1725908863.527 [Default:CheckIn:E] Running Loop=1
2024-09-09T19:07:43.920Z,1725908863.920 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.078833 min
2024-09-09T19:07:43.920Z,1725908863.920 [Default:CheckIn:E] Stopped
2024-09-09T19:07:43.920Z,1725908863.920 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T19:07:43.920Z,1725908863.920 [Default:CheckIn] Stopped
2024-09-09T19:07:43.921Z,1725908863.921 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T19:07:43.921Z,1725908863.921 [Default:CheckIn](INFO): Running loop #5
2024-09-09T19:07:43.921Z,1725908863.921 [Default:CheckIn] Running Loop=5
2024-09-09T19:07:43.921Z,1725908863.921 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T19:07:43.921Z,1725908863.921 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T19:07:51.635Z,1725908871.635 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:52.861Z,1725908872.861 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:07:57.249Z,1725908877.249 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:08:00.468Z,1725908880.468 [BPC1](ERROR): Failed to receive data from all battery packs.
2024-09-09T19:08:00.468Z,1725908880.468 [BPC1] Communications Fault, FailCount= 3
2024-09-09T19:08:00.468Z,1725908880.468 [BPC1](ERROR): Communications Fault
2024-09-09T19:08:00.530Z,1725908880.530 [CBIT](ERROR): Communications Fault in component: BPC1
2024-09-09T19:09:01.891Z,1725908941.891 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2024-09-09T19:09:01.891Z,1725908941.891 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:09:01.901Z,1725908941.901 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:09:02.363Z,1725908942.363 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:09:02.363Z,1725908942.363 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2024-09-09T19:10:52.998Z,1725909052.998 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging
2024-09-09T19:12:02.927Z,1725909122.927 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2024-09-09T19:12:02.927Z,1725909122.927 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:12:02.958Z,1725909122.958 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:12:03.345Z,1725909123.345 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:12:03.345Z,1725909123.345 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2024-09-09T19:12:44.168Z,1725909164.168 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T19:07:43.9Z
2024-09-09T19:12:44.168Z,1725909164.168 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:12:44.168Z,1725909164.168 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:12:44.975Z,1725909164.975 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:12:44.976Z,1725909164.976 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:12:44.976Z,1725909164.976 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T19:14:25.128Z,1725909265.128 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T19:14:25.128Z,1725909265.128 [NAL9602] Data Fault, FailCount= 5
2024-09-09T19:14:25.128Z,1725909265.128 [NAL9602](ERROR): Data Fault
2024-09-09T19:14:25.179Z,1725909265.179 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T19:14:25.179Z,1725909265.179 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-09-09T19:14:25.531Z,1725909265.531 [NAL9602](INFO): Powering down
2024-09-09T19:14:25.551Z,1725909265.551 [CommandExec](FAULT): Scheduling is paused
2024-09-09T19:14:25.552Z,1725909265.552 [CBIT](INFO): Critical error at 20240909T191425
2024-09-09T19:14:25.552Z,1725909265.552 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-09-09T19:15:03.929Z,1725909303.929 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2024-09-09T19:15:03.929Z,1725909303.929 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:15:03.940Z,1725909303.940 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:15:04.361Z,1725909304.361 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:15:04.361Z,1725909304.361 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2024-09-09T19:16:25.149Z,1725909385.149 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T19:16:25.149Z,1725909385.149 [NAL9602] No Fault, FailCount= 5
2024-09-09T19:16:25.524Z,1725909385.524 [NAL9602](INFO): Powering up NAL9602
2024-09-09T19:16:36.432Z,1725909396.432 [NAL9602](INFO): NAL9602 initialized
2024-09-09T19:17:45.524Z,1725909465.524 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T19:17:45.525Z,1725909465.525 [Default:CheckIn:C.Wait] Stopped
2024-09-09T19:17:45.525Z,1725909465.525 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T19:17:45.525Z,1725909465.525 [Default:CheckIn:D] Running Loop=1
2024-09-09T19:17:45.924Z,1725909465.924 [Default:CheckIn:D] Stopped
2024-09-09T19:17:45.924Z,1725909465.924 [Default:CheckIn:E] Running Loop=1
2024-09-09T19:17:46.438Z,1725909466.438 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.118783 min
2024-09-09T19:17:46.438Z,1725909466.438 [Default:CheckIn:E] Stopped
2024-09-09T19:17:46.438Z,1725909466.438 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T19:17:46.438Z,1725909466.438 [Default:CheckIn] Stopped
2024-09-09T19:17:46.438Z,1725909466.438 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T19:17:46.438Z,1725909466.438 [Default:CheckIn](INFO): Running loop #6
2024-09-09T19:17:46.439Z,1725909466.439 [Default:CheckIn] Running Loop=6
2024-09-09T19:17:46.439Z,1725909466.439 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T19:17:46.439Z,1725909466.439 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T19:18:01.698Z,1725909481.698 [CBIT](INFO): Clearing failed state for component BPC1
2024-09-09T19:18:01.698Z,1725909481.698 [BPC1] No Fault, FailCount= 3
2024-09-09T19:18:04.916Z,1725909484.916 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2024-09-09T19:18:04.916Z,1725909484.916 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:18:04.927Z,1725909484.927 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:18:05.340Z,1725909485.340 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:18:05.340Z,1725909485.340 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2024-09-09T19:19:12.840Z,1725909552.840 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:19:23.346Z,1725909563.346 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:19:34.252Z,1725909574.252 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:19:45.161Z,1725909585.161 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:19:56.174Z,1725909596.174 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:20:02.125Z,1725909602.125 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:20:35.650Z,1725909635.650 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:20:46.549Z,1725909646.549 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:21:05.920Z,1725909665.920 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2024-09-09T19:21:05.920Z,1725909665.920 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:21:05.965Z,1725909665.965 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:21:06.399Z,1725909666.399 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:21:06.399Z,1725909666.399 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2024-09-09T19:21:29.741Z,1725909689.741 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:21:41.065Z,1725909701.065 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:21:51.395Z,1725909711.395 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:02.295Z,1725909722.295 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:13.605Z,1725909733.605 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:24.513Z,1725909744.513 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:30.174Z,1725909750.174 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:35.422Z,1725909755.422 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:41.077Z,1725909761.077 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:46.334Z,1725909766.334 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:46.708Z,1725909766.708 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T19:17:46.4Z
2024-09-09T19:22:46.708Z,1725909766.708 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:22:46.708Z,1725909766.708 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:22:52.039Z,1725909772.039 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:22:54.454Z,1725909774.454 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T182035/Courier0016.lzma
2024-09-09T19:22:55.456Z,1725909775.456 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0016.lzma.bak
2024-09-09T19:22:55.456Z,1725909775.456 [DataOverHttps](INFO): SBD MOMSN=23148877
2024-09-09T19:22:57.234Z,1725909777.234 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:02.899Z,1725909782.899 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:07.799Z,1725909787.799 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:11.338Z,1725909791.338 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20240909T182035/Courier0019.lzma
2024-09-09T19:23:12.345Z,1725909792.345 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0019.lzma.bak
2024-09-09T19:23:12.345Z,1725909792.345 [DataOverHttps](INFO): SBD MOMSN=23148879
2024-09-09T19:23:13.800Z,1725909793.800 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:18.679Z,1725909798.679 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:25.140Z,1725909805.140 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:28.367Z,1725909808.367 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240909T182035/Express0017.lzma
2024-09-09T19:23:29.368Z,1725909809.368 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0017.lzma.bak
2024-09-09T19:23:29.368Z,1725909809.368 [DataOverHttps](INFO): SBD MOMSN=23148882
2024-09-09T19:23:29.560Z,1725909809.560 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:36.019Z,1725909816.019 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:40.461Z,1725909820.461 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:45.166Z,1725909825.166 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20240909T182035/Express0020.lzma
2024-09-09T19:23:46.168Z,1725909826.168 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0020.lzma.bak
2024-09-09T19:23:46.168Z,1725909826.168 [DataOverHttps](INFO): SBD MOMSN=23148886
2024-09-09T19:23:46.926Z,1725909826.926 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:47.303Z,1725909827.303 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:23:47.303Z,1725909827.303 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:23:47.303Z,1725909827.303 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T19:23:51.019Z,1725909831.019 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:23:57.838Z,1725909837.838 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:01.473Z,1725909841.473 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:07.096Z,1725909847.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2024-09-09T19:24:07.096Z,1725909847.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:24:07.106Z,1725909847.106 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:24:07.514Z,1725909847.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:24:07.514Z,1725909847.514 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2024-09-09T19:24:09.150Z,1725909849.150 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:12.385Z,1725909852.385 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:20.092Z,1725909860.092 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:23.289Z,1725909863.289 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:30.969Z,1725909870.969 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:34.599Z,1725909874.599 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:41.873Z,1725909881.873 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:45.508Z,1725909885.508 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:53.169Z,1725909893.169 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:24:56.418Z,1725909896.418 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:05.694Z,1725909905.694 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:07.324Z,1725909907.324 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:18.212Z,1725909918.212 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:18.285Z,1725909918.285 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:29.140Z,1725909929.140 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:30.332Z,1725909930.332 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:40.468Z,1725909940.468 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:42.452Z,1725909942.452 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:51.367Z,1725909951.367 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:25:54.976Z,1725909954.976 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:02.674Z,1725909962.674 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:07.096Z,1725909967.096 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:13.664Z,1725909973.664 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:19.640Z,1725909979.640 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:24.164Z,1725909984.164 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:31.767Z,1725909991.767 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:35.017Z,1725909995.017 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:38.189Z,1725909998.189 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T19:26:38.189Z,1725909998.189 [NAL9602] Data Fault, FailCount= 1
2024-09-09T19:26:38.189Z,1725909998.189 [NAL9602](ERROR): Data Fault
2024-09-09T19:26:38.227Z,1725909998.227 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T19:26:38.587Z,1725909998.587 [NAL9602](INFO): Powering down
2024-09-09T19:26:39.416Z,1725909999.416 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T19:26:39.417Z,1725909999.417 [NAL9602] No Fault, FailCount= 1
2024-09-09T19:26:44.699Z,1725910004.699 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:45.924Z,1725910005.924 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:56.833Z,1725910016.833 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:26:57.215Z,1725910017.215 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:27:07.336Z,1725910027.336 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:27:08.145Z,1725910028.145 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2024-09-09T19:27:08.145Z,1725910028.145 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:27:08.176Z,1725910028.176 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:27:08.503Z,1725910028.503 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:27:08.503Z,1725910028.503 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2024-09-09T19:27:08.892Z,1725910028.892 [NAL9602](INFO): Powering up NAL9602
2024-09-09T19:27:09.741Z,1725910029.741 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-09-09T19:27:18.246Z,1725910038.246 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-09-09T19:27:19.388Z,1725910039.388 [BPC1](ERROR): Failed to receive data from all battery packs.
2024-09-09T19:27:19.388Z,1725910039.388 [BPC1] Communications Fault, FailCount= 4
2024-09-09T19:27:19.388Z,1725910039.388 [BPC1](ERROR): Communications Fault
2024-09-09T19:27:19.450Z,1725910039.450 [CBIT](ERROR): Communications Fault in component: BPC1
2024-09-09T19:27:19.800Z,1725910039.800 [NAL9602](INFO): NAL9602 initialized
2024-09-09T19:27:30.318Z,1725910050.318 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,32768,-32768,V
2024-09-09T19:28:47.881Z,1725910127.881 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T19:28:47.881Z,1725910127.881 [Default:CheckIn:C.Wait] Stopped
2024-09-09T19:28:47.881Z,1725910127.881 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T19:28:47.881Z,1725910127.881 [Default:CheckIn:D] Running Loop=1
2024-09-09T19:28:48.307Z,1725910128.307 [Default:CheckIn:D] Stopped
2024-09-09T19:28:48.308Z,1725910128.308 [Default:CheckIn:E] Running Loop=1
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.158504 min
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn:E] Stopped
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn] Stopped
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn](INFO): Running loop #7
2024-09-09T19:28:48.705Z,1725910128.705 [Default:CheckIn] Running Loop=7
2024-09-09T19:28:48.706Z,1725910128.706 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T19:28:48.706Z,1725910128.706 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T19:30:09.112Z,1725910209.112 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2024-09-09T19:30:09.112Z,1725910209.112 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:30:09.123Z,1725910209.123 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:30:09.528Z,1725910209.528 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:30:09.528Z,1725910209.528 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2024-09-09T19:33:10.123Z,1725910390.123 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2024-09-09T19:33:10.123Z,1725910390.123 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:33:10.158Z,1725910390.158 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:33:10.510Z,1725910390.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:33:10.510Z,1725910390.510 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2024-09-09T19:33:48.885Z,1725910428.885 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T19:28:48.7Z
2024-09-09T19:33:48.885Z,1725910428.885 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:33:48.885Z,1725910428.885 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:33:55.734Z,1725910435.734 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240909T182035/Courier0022.lzma
2024-09-09T19:34:00.753Z,1725910440.753 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0022.lzma.bak
2024-09-09T19:34:00.753Z,1725910440.753 [DataOverHttps](INFO): SBD MOMSN=23148987
2024-09-09T19:34:20.386Z,1725910460.386 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240909T182035/Express0023.lzma
2024-09-09T19:34:21.388Z,1725910461.388 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0023.lzma.bak
2024-09-09T19:34:21.388Z,1725910461.388 [DataOverHttps](INFO): SBD MOMSN=23148991
2024-09-09T19:34:22.477Z,1725910462.477 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:34:22.477Z,1725910462.477 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:34:22.477Z,1725910462.477 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T19:36:11.120Z,1725910571.120 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25
2024-09-09T19:36:11.120Z,1725910571.120 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:36:11.138Z,1725910571.138 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:36:11.581Z,1725910571.581 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:36:11.581Z,1725910571.581 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25
2024-09-09T19:37:20.664Z,1725910640.664 [CBIT](INFO): Clearing failed state for component BPC1
2024-09-09T19:37:20.664Z,1725910640.664 [BPC1] No Fault, FailCount= 4
2024-09-09T19:37:22.616Z,1725910642.616 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-09-09T19:37:22.616Z,1725910642.616 [NAL9602] Data Fault, FailCount= 2
2024-09-09T19:37:22.616Z,1725910642.616 [NAL9602](ERROR): Data Fault
2024-09-09T19:37:22.691Z,1725910642.691 [CBIT](ERROR): Data Fault in component: NAL9602
2024-09-09T19:37:23.019Z,1725910643.019 [NAL9602](INFO): Powering down
2024-09-09T19:37:23.862Z,1725910643.862 [CBIT](INFO): Clearing failed state for component NAL9602
2024-09-09T19:37:23.862Z,1725910643.862 [NAL9602] No Fault, FailCount= 2
2024-09-09T19:37:53.324Z,1725910673.324 [NAL9602](INFO): Powering up NAL9602
2024-09-09T19:38:04.288Z,1725910684.288 [NAL9602](INFO): NAL9602 initialized
2024-09-09T19:39:12.223Z,1725910752.223 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26
2024-09-09T19:39:12.224Z,1725910752.224 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:39:12.242Z,1725910752.242 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:39:12.605Z,1725910752.605 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:39:12.605Z,1725910752.605 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26
2024-09-09T19:39:23.108Z,1725910763.108 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T19:39:23.108Z,1725910763.108 [Default:CheckIn:C.Wait] Stopped
2024-09-09T19:39:23.108Z,1725910763.108 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T19:39:23.109Z,1725910763.109 [Default:CheckIn:D] Running Loop=1
2024-09-09T19:39:23.500Z,1725910763.500 [Default:CheckIn:D] Stopped
2024-09-09T19:39:23.500Z,1725910763.500 [Default:CheckIn:E] Running Loop=1
2024-09-09T19:39:23.912Z,1725910763.912 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.745052 min
2024-09-09T19:39:23.912Z,1725910763.912 [Default:CheckIn:E] Stopped
2024-09-09T19:39:23.912Z,1725910763.912 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T19:39:23.912Z,1725910763.912 [Default:CheckIn] Stopped
2024-09-09T19:39:23.912Z,1725910763.912 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T19:39:23.912Z,1725910763.912 [Default:CheckIn](INFO): Running loop #8
2024-09-09T19:39:23.913Z,1725910763.913 [Default:CheckIn] Running Loop=8
2024-09-09T19:39:23.913Z,1725910763.913 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T19:39:23.913Z,1725910763.913 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T19:39:48.934Z,1725910788.934 [BPC1](INFO): Calculating totals. Valid battery stick count: 31. Valid reserve battery stick count: 3.
2024-09-09T19:39:48.937Z,1725910788.937 [BPC1](INFO): Received data from all battery sticks.
2024-09-09T19:42:13.192Z,1725910933.192 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27
2024-09-09T19:42:13.192Z,1725910933.192 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-09-09T19:42:13.233Z,1725910933.233 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-09-09T19:42:13.608Z,1725910933.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-09-09T19:42:13.608Z,1725910933.608 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27
2024-09-09T19:44:24.069Z,1725911064.069 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-09T19:39:23.9Z
2024-09-09T19:44:24.070Z,1725911064.070 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:44:24.070Z,1725911064.070 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:44:31.826Z,1725911071.826 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20240909T182035/Courier0025.lzma
2024-09-09T19:44:32.828Z,1725911072.828 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0025.lzma.bak
2024-09-09T19:44:32.828Z,1725911072.828 [DataOverHttps](INFO): SBD MOMSN=23149023
2024-09-09T19:44:48.634Z,1725911088.634 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240909T182035/Express0026.lzma
2024-09-09T19:44:49.636Z,1725911089.636 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0026.lzma.bak
2024-09-09T19:44:49.637Z,1725911089.637 [DataOverHttps](INFO): SBD MOMSN=23149028
2024-09-09T19:44:50.732Z,1725911090.732 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:44:50.732Z,1725911090.732 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:44:50.732Z,1725911090.732 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T19:45:00.813Z,1725911100.813 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194500.00,A,3648.17110,N,12147.27416,W,0.194,0.00,090924,,,A*77
2024-09-09T19:45:00.817Z,1725911100.817 [NAL9602](INFO): GPS fix at 20240909T194500: (36.802852, -121.787903)
2024-09-09T19:45:33.139Z,1725911133.139 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T19:45:33.760Z,1725911133.760 [DataOverHttps](IMPORTANT): SBD MTMSN=20240909T194532
2024-09-09T19:45:41.315Z,1725911141.315 [DataOverHttps](INFO): Received command: ibit
2024-09-09T19:45:41.419Z,1725911141.419 [CommandExec](IMPORTANT): got command ibit
2024-09-09T19:45:41.636Z,1725911141.636 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-09-09T19:45:41.637Z,1725911141.637 [IBIT](IMPORTANT): Beginning control surface checks.
2024-09-09T19:45:41.640Z,1725911141.640 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-09T19:45:43.237Z,1725911143.237 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194542.00,A,3648.17131,N,12147.27771,W,0.933,0.00,090924,,,A*75
2024-09-09T19:45:43.240Z,1725911143.240 [NAL9602](INFO): GPS fix at 20240909T194542: (36.802855, -121.787962)
2024-09-09T19:45:52.548Z,1725911152.548 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.037750
CHAN A1 (24V): 0.077018
CHAN A2 (12V): 0.027345
CHAN A3 (5V): 0.008708
CHAN B0 (3.3V): 0.005519
CHAN B1 (3.15aV): 0.005696
CHAN B2 (3.15bV): 0.006451
CHAN B3 (GND): -0.002370
OPEN: 0.006578
Full Scale: +/- 1 mA
2024-09-09T19:46:12.428Z,1725911172.428 [IBIT](FAULT): Rudder: EXPECTED:-15.000000 ACTUAL:-14.680960
2024-09-09T19:46:12.428Z,1725911172.428 [IBIT](FAULT): Control surface position failure.
2024-09-09T19:47:32.743Z,1725911252.743 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2024-09-09T19:47:33.163Z,1725911253.163 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.501000
2024-09-09T19:47:33.164Z,1725911253.164 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-09-09T19:47:33.164Z,1725911253.164 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-09-09T19:47:33.548Z,1725911253.548 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-09-09T19:47:33.548Z,1725911253.548 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-09-09T19:47:33.548Z,1725911253.548 [IBIT](IMPORTANT): Pressure:9.630446 PSI
2024-09-09T19:47:33.549Z,1725911253.549 [IBIT](IMPORTANT): Humidity:6.855085 %
2024-09-09T19:47:33.948Z,1725911253.948 [IBIT](IMPORTANT): Vehicle Pitch:-0.541753 degrees
2024-09-09T19:47:33.949Z,1725911253.949 [IBIT](IMPORTANT): Vehicle Roll:9.294934 degrees
2024-09-09T19:47:33.949Z,1725911253.949 [IBIT](IMPORTANT): Vehicle Heading:162.723801 degrees
2024-09-09T19:47:34.381Z,1725911254.381 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-09-09T19:47:34.381Z,1725911254.381 [IBIT](IMPORTANT): buoyancyNeutral: 314.799988 cc
2024-09-09T19:47:34.382Z,1725911254.382 [IBIT](IMPORTANT): massDefault: 2.411000 cm
2024-09-09T19:47:34.382Z,1725911254.382 [IBIT](IMPORTANT): stopDepth: 215.000000 m
2024-09-09T19:47:34.382Z,1725911254.382 [IBIT](IMPORTANT): abortDepth: 255.000000 m
2024-09-09T19:47:34.382Z,1725911254.382 [IBIT](IMPORTANT): IBIT FAILED
2024-09-09T19:47:51.708Z,1725911271.708 [NAL9602](INFO): SBD MO Status=2, MOMSN=41696, MT Status=2, MTMSN=0
2024-09-09T19:47:51.708Z,1725911271.708 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T19:48:41.805Z,1725911321.805 [NAL9602](INFO): SBD MO Status=0, MOMSN=41696, MT Status=0, MTMSN=0
2024-09-09T19:48:41.806Z,1725911321.806 [NAL9602](INFO): No messages in MT queue
2024-09-09T19:49:12.507Z,1725911352.507 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T19:49:51.301Z,1725911391.301 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T19:49:51.301Z,1725911391.301 [Default:CheckIn:C.Wait] Stopped
2024-09-09T19:49:51.301Z,1725911391.301 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T19:49:51.301Z,1725911391.301 [Default:CheckIn:D] Running Loop=1
2024-09-09T19:49:51.709Z,1725911391.709 [Default:CheckIn:D] Stopped
2024-09-09T19:49:51.709Z,1725911391.709 [Default:CheckIn:E] Running Loop=1
2024-09-09T19:49:52.183Z,1725911392.183 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.215202 min
2024-09-09T19:49:52.183Z,1725911392.183 [Default:CheckIn:E] Stopped
2024-09-09T19:49:52.183Z,1725911392.183 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T19:49:52.183Z,1725911392.183 [Default:CheckIn] Stopped
2024-09-09T19:49:52.183Z,1725911392.183 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T19:49:52.183Z,1725911392.183 [Default:CheckIn](INFO): Running loop #9
2024-09-09T19:49:52.184Z,1725911392.184 [Default:CheckIn] Running Loop=9
2024-09-09T19:49:52.184Z,1725911392.184 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T19:49:52.184Z,1725911392.184 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T19:49:54.136Z,1725911394.136 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194953.00,A,3648.14461,N,12147.22635,W,0.019,37.56,090924,,,A*48
2024-09-09T19:49:54.139Z,1725911394.139 [NAL9602](INFO): GPS fix at 20240909T194953: (36.802410, -121.787106)
2024-09-09T19:49:54.187Z,1725911394.187 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:49:54.187Z,1725911394.187 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:50:04.435Z,1725911404.435 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20240909T182035/Courier0028.lzma
2024-09-09T19:50:05.436Z,1725911405.436 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0028.lzma.bak
2024-09-09T19:50:05.437Z,1725911405.437 [DataOverHttps](INFO): SBD MOMSN=23149060
2024-09-09T19:50:13.580Z,1725911413.580 [NAL9602](INFO): SBD MO Status=0, MOMSN=41697, MT Status=0, MTMSN=0
2024-09-09T19:50:13.580Z,1725911413.580 [NAL9602](INFO): No messages in MT queue
2024-09-09T19:50:13.580Z,1725911413.580 [NAL9602](INFO): Failure count cleared after critical for NAL9602
2024-09-09T19:50:22.003Z,1725911422.003 [DataOverHttps](INFO): Sending 965 bytes from file Logs/20240909T182035/Express0029.lzma
2024-09-09T19:50:23.004Z,1725911423.004 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0029.lzma.bak
2024-09-09T19:50:23.004Z,1725911423.004 [DataOverHttps](INFO): SBD MOMSN=23149071
2024-09-09T19:50:24.173Z,1725911424.173 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:50:24.174Z,1725911424.174 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:50:24.174Z,1725911424.174 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T19:50:44.287Z,1725911444.287 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T19:52:18.972Z,1725911538.972 [DataOverHttps](IMPORTANT): SBD MTMSN=20240909T195218
2024-09-09T19:52:26.730Z,1725911546.730 [DataOverHttps](INFO): Received command: ibit
2024-09-09T19:52:26.751Z,1725911546.751 [CommandExec](IMPORTANT): got command ibit
2024-09-09T19:52:26.925Z,1725911546.925 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-09-09T19:52:26.925Z,1725911546.925 [IBIT](IMPORTANT): Beginning control surface checks.
2024-09-09T19:52:26.928Z,1725911546.928 [CBIT](IMPORTANT): Beginning ground fault scan
2024-09-09T19:52:28.513Z,1725911548.513 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195227.00,A,3648.14483,N,12147.22674,W,0.019,37.56,090924,,,D*4D
2024-09-09T19:52:28.524Z,1725911548.524 [NAL9602](INFO): GPS fix at 20240909T195227: (36.802414, -121.787112)
2024-09-09T19:52:37.825Z,1725911557.825 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.037558
CHAN A1 (24V): 0.078113
CHAN A2 (12V): 0.028536
CHAN A3 (5V): 0.008978
CHAN B0 (3.3V): 0.006061
CHAN B1 (3.15aV): 0.006288
CHAN B2 (3.15bV): 0.005793
CHAN B3 (GND): -0.002532
OPEN: 0.006706
Full Scale: +/- 1 mA
2024-09-09T19:52:48.307Z,1725911568.307 [NAL9602](INFO): SBD MO Status=2, MOMSN=41698, MT Status=2, MTMSN=0
2024-09-09T19:52:48.307Z,1725911568.307 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T19:52:57.680Z,1725911577.680 [IBIT](FAULT): Rudder: EXPECTED:-15.000000 ACTUAL:-14.683159
2024-09-09T19:52:57.681Z,1725911577.681 [IBIT](FAULT): Control surface position failure.
2024-09-09T19:53:13.395Z,1725911593.395 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 3
Latitude: 36.802414 Longitude: -121.787109
2024-09-09T19:53:13.775Z,1725911593.775 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.501000
2024-09-09T19:53:13.775Z,1725911593.775 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-09-09T19:53:13.775Z,1725911593.775 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-09-09T19:53:14.199Z,1725911594.199 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-09-09T19:53:14.199Z,1725911594.199 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-09-09T19:53:14.199Z,1725911594.199 [IBIT](IMPORTANT): Pressure:9.622747 PSI
2024-09-09T19:53:14.199Z,1725911594.199 [IBIT](IMPORTANT): Humidity:6.836772 %
2024-09-09T19:53:14.596Z,1725911594.596 [IBIT](IMPORTANT): Vehicle Pitch:-0.909512 degrees
2024-09-09T19:53:14.596Z,1725911594.596 [IBIT](IMPORTANT): Vehicle Roll:10.118760 degrees
2024-09-09T19:53:14.597Z,1725911594.597 [IBIT](IMPORTANT): Vehicle Heading:207.655884 degrees
2024-09-09T19:53:15.011Z,1725911595.011 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-09-09T19:53:15.011Z,1725911595.011 [IBIT](IMPORTANT): buoyancyNeutral: 314.799988 cc
2024-09-09T19:53:15.012Z,1725911595.012 [IBIT](IMPORTANT): massDefault: 2.411000 cm
2024-09-09T19:53:15.012Z,1725911595.012 [IBIT](IMPORTANT): stopDepth: 215.000000 m
2024-09-09T19:53:15.012Z,1725911595.012 [IBIT](IMPORTANT): abortDepth: 255.000000 m
2024-09-09T19:53:15.012Z,1725911595.012 [IBIT](IMPORTANT): IBIT FAILED
2024-09-09T19:53:19.017Z,1725911599.017 [NAL9602](INFO): SBD MO Status=0, MOMSN=41698, MT Status=0, MTMSN=0
2024-09-09T19:53:19.017Z,1725911599.017 [NAL9602](INFO): No messages in MT queue
2024-09-09T19:53:49.715Z,1725911629.715 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T19:55:24.697Z,1725911724.697 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T19:55:24.698Z,1725911724.698 [Default:CheckIn:C.Wait] Stopped
2024-09-09T19:55:24.698Z,1725911724.698 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T19:55:24.698Z,1725911724.698 [Default:CheckIn:D] Running Loop=1
2024-09-09T19:55:25.071Z,1725911725.071 [Default:CheckIn:D] Stopped
2024-09-09T19:55:25.071Z,1725911725.071 [Default:CheckIn:E] Running Loop=1
2024-09-09T19:55:25.487Z,1725911725.487 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 89.771224 min
2024-09-09T19:55:25.487Z,1725911725.487 [Default:CheckIn:E] Stopped
2024-09-09T19:55:25.487Z,1725911725.487 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T19:55:25.487Z,1725911725.487 [Default:CheckIn] Stopped
2024-09-09T19:55:25.488Z,1725911725.488 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T19:55:25.488Z,1725911725.488 [Default:CheckIn](INFO): Running loop #10
2024-09-09T19:55:25.488Z,1725911725.488 [Default:CheckIn] Running Loop=10
2024-09-09T19:55:25.488Z,1725911725.488 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T19:55:25.488Z,1725911725.488 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T19:55:27.489Z,1725911727.489 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195526.00,A,3648.14434,N,12147.22734,W,0.058,37.56,090924,,,D*47
2024-09-09T19:55:27.500Z,1725911727.500 [NAL9602](INFO): GPS fix at 20240909T195526: (36.802406, -121.787122)
2024-09-09T19:55:27.510Z,1725911727.510 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T19:55:27.511Z,1725911727.511 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T19:55:35.458Z,1725911735.458 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0031.lzma
2024-09-09T19:55:36.460Z,1725911736.460 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0031.lzma.bak
2024-09-09T19:55:36.460Z,1725911736.460 [DataOverHttps](INFO): SBD MOMSN=23149107
2024-09-09T19:55:42.837Z,1725911742.837 [NAL9602](INFO): SBD MO Status=0, MOMSN=41699, MT Status=0, MTMSN=0
2024-09-09T19:55:42.837Z,1725911742.837 [NAL9602](INFO): No messages in MT queue
2024-09-09T19:55:52.863Z,1725911752.863 [DataOverHttps](INFO): Sending 838 bytes from file Logs/20240909T182035/Express0033.lzma
2024-09-09T19:55:53.864Z,1725911753.864 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0033.lzma.bak
2024-09-09T19:55:53.864Z,1725911753.864 [DataOverHttps](INFO): SBD MOMSN=23149113
2024-09-09T19:56:13.583Z,1725911773.583 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T19:56:13.694Z,1725911773.694 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20240909T182035/Express0038.lzma
2024-09-09T19:56:14.697Z,1725911774.697 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0038.lzma.bak
2024-09-09T19:56:14.697Z,1725911774.697 [DataOverHttps](INFO): SBD MOMSN=23149145
2024-09-09T19:56:16.015Z,1725911776.015 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T19:56:16.015Z,1725911776.015 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T19:56:16.015Z,1725911776.015 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:01:16.594Z,1725912076.594 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:01:16.594Z,1725912076.594 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:01:16.594Z,1725912076.594 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:01:16.594Z,1725912076.594 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:01:16.998Z,1725912076.998 [Default:CheckIn:D] Stopped
2024-09-09T20:01:16.998Z,1725912076.998 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:01:17.406Z,1725912077.406 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 95.636678 min
2024-09-09T20:01:17.406Z,1725912077.406 [Default:CheckIn:E] Stopped
2024-09-09T20:01:17.406Z,1725912077.406 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:01:17.406Z,1725912077.406 [Default:CheckIn] Stopped
2024-09-09T20:01:17.406Z,1725912077.406 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:01:17.406Z,1725912077.406 [Default:CheckIn](INFO): Running loop #11
2024-09-09T20:01:17.407Z,1725912077.407 [Default:CheckIn] Running Loop=11
2024-09-09T20:01:17.407Z,1725912077.407 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:01:17.407Z,1725912077.407 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:01:19.418Z,1725912079.418 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200118.00,A,3648.14441,N,12147.22659,W,0.019,37.56,090924,,,D*4C
2024-09-09T20:01:19.420Z,1725912079.420 [NAL9602](INFO): GPS fix at 20240909T200118: (36.802407, -121.787110)
2024-09-09T20:01:19.431Z,1725912079.431 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:01:19.432Z,1725912079.432 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:01:27.506Z,1725912087.506 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0040.lzma
2024-09-09T20:01:28.508Z,1725912088.508 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0040.lzma.bak
2024-09-09T20:01:28.508Z,1725912088.508 [DataOverHttps](INFO): SBD MOMSN=23149175
2024-09-09T20:01:31.565Z,1725912091.565 [NAL9602](INFO): SBD MO Status=0, MOMSN=41700, MT Status=0, MTMSN=0
2024-09-09T20:01:31.565Z,1725912091.565 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:01:44.758Z,1725912104.758 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240909T182035/Express0041.lzma
2024-09-09T20:01:45.760Z,1725912105.760 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0041.lzma.bak
2024-09-09T20:01:45.761Z,1725912105.761 [DataOverHttps](INFO): SBD MOMSN=23149181
2024-09-09T20:01:46.939Z,1725912106.939 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:01:46.939Z,1725912106.939 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:01:46.940Z,1725912106.940 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:02:02.231Z,1725912122.231 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:06:47.494Z,1725912407.494 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:06:47.494Z,1725912407.494 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:06:47.494Z,1725912407.494 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:06:47.494Z,1725912407.494 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:06:47.895Z,1725912407.895 [Default:CheckIn:D] Stopped
2024-09-09T20:06:47.895Z,1725912407.895 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:06:48.318Z,1725912408.318 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 101.151628 min
2024-09-09T20:06:48.318Z,1725912408.318 [Default:CheckIn:E] Stopped
2024-09-09T20:06:48.318Z,1725912408.318 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:06:48.318Z,1725912408.318 [Default:CheckIn] Stopped
2024-09-09T20:06:48.319Z,1725912408.319 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:06:48.319Z,1725912408.319 [Default:CheckIn](INFO): Running loop #12
2024-09-09T20:06:48.319Z,1725912408.319 [Default:CheckIn] Running Loop=12
2024-09-09T20:06:48.319Z,1725912408.319 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:06:48.319Z,1725912408.319 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:06:50.313Z,1725912410.313 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200649.00,A,3648.14364,N,12147.22560,W,0.117,37.56,090924,,,D*49
2024-09-09T20:06:50.315Z,1725912410.315 [NAL9602](INFO): GPS fix at 20240909T200649: (36.802394, -121.787093)
2024-09-09T20:06:50.367Z,1725912410.367 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:06:50.367Z,1725912410.367 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:06:58.058Z,1725912418.058 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0043.lzma
2024-09-09T20:06:59.060Z,1725912419.060 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0043.lzma.bak
2024-09-09T20:06:59.060Z,1725912419.060 [DataOverHttps](INFO): SBD MOMSN=23149195
2024-09-09T20:07:15.310Z,1725912435.310 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240909T182035/Express0044.lzma
2024-09-09T20:07:16.312Z,1725912436.312 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0044.lzma.bak
2024-09-09T20:07:16.312Z,1725912436.312 [DataOverHttps](INFO): SBD MOMSN=23149198
2024-09-09T20:07:17.395Z,1725912437.395 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:07:17.395Z,1725912437.395 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:07:17.395Z,1725912437.395 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:08:16.371Z,1725912496.371 [NAL9602](INFO): SBD MO Status=0, MOMSN=41701, MT Status=0, MTMSN=0
2024-09-09T20:08:16.371Z,1725912496.371 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:08:47.071Z,1725912527.071 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:12:17.970Z,1725912737.970 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:12:17.970Z,1725912737.970 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:12:17.970Z,1725912737.970 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:12:17.970Z,1725912737.970 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:12:18.405Z,1725912738.405 [Default:CheckIn:D] Stopped
2024-09-09T20:12:18.405Z,1725912738.405 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:12:18.770Z,1725912738.770 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 106.660140 min
2024-09-09T20:12:18.794Z,1725912738.794 [Default:CheckIn:E] Stopped
2024-09-09T20:12:18.794Z,1725912738.794 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:12:18.795Z,1725912738.795 [Default:CheckIn] Stopped
2024-09-09T20:12:18.795Z,1725912738.795 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:12:18.795Z,1725912738.795 [Default:CheckIn](INFO): Running loop #13
2024-09-09T20:12:18.795Z,1725912738.795 [Default:CheckIn] Running Loop=13
2024-09-09T20:12:18.795Z,1725912738.795 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:12:18.795Z,1725912738.795 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:12:20.785Z,1725912740.785 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201220.00,A,3648.15033,N,12147.22145,W,0.078,74.90,090924,,,D*45
2024-09-09T20:12:20.797Z,1725912740.797 [NAL9602](INFO): GPS fix at 20240909T201220: (36.802506, -121.787024)
2024-09-09T20:12:20.808Z,1725912740.808 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:12:20.808Z,1725912740.808 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:12:28.834Z,1725912748.834 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240909T182035/Courier0046.lzma
2024-09-09T20:12:29.836Z,1725912749.836 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0046.lzma.bak
2024-09-09T20:12:29.836Z,1725912749.836 [DataOverHttps](INFO): SBD MOMSN=23149358
2024-09-09T20:12:46.210Z,1725912766.210 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240909T182035/Express0047.lzma
2024-09-09T20:12:47.224Z,1725912767.224 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0047.lzma.bak
2024-09-09T20:12:47.224Z,1725912767.224 [DataOverHttps](INFO): SBD MOMSN=23149361
2024-09-09T20:12:48.399Z,1725912768.399 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:12:48.399Z,1725912768.399 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:12:48.399Z,1725912768.399 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:12:52.405Z,1725912772.405 [NAL9602](INFO): SBD MO Status=0, MOMSN=41702, MT Status=0, MTMSN=0
2024-09-09T20:12:52.405Z,1725912772.405 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:13:23.107Z,1725912803.107 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:17:49.023Z,1725913069.023 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:17:49.023Z,1725913069.023 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:17:49.023Z,1725913069.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:17:49.023Z,1725913069.023 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:17:49.422Z,1725913069.422 [Default:CheckIn:D] Stopped
2024-09-09T20:17:49.422Z,1725913069.422 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 112.177083 min
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn:E] Stopped
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn] Stopped
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn](INFO): Running loop #14
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn] Running Loop=14
2024-09-09T20:17:49.835Z,1725913069.835 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:17:49.836Z,1725913069.836 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:17:51.832Z,1725913071.832 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201751.00,A,3648.15096,N,12147.22272,W,0.019,74.90,090924,,,D*49
2024-09-09T20:17:51.834Z,1725913071.834 [NAL9602](INFO): GPS fix at 20240909T201751: (36.802516, -121.787045)
2024-09-09T20:17:51.845Z,1725913071.845 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:17:51.845Z,1725913071.845 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:17:59.030Z,1725913079.030 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0049.lzma
2024-09-09T20:18:00.033Z,1725913080.033 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0049.lzma.bak
2024-09-09T20:18:00.033Z,1725913080.033 [DataOverHttps](INFO): SBD MOMSN=23149366
2024-09-09T20:18:03.953Z,1725913083.953 [NAL9602](INFO): SBD MO Status=0, MOMSN=41703, MT Status=0, MTMSN=0
2024-09-09T20:18:03.953Z,1725913083.953 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:18:18.670Z,1725913098.670 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240909T182035/Express0050.lzma
2024-09-09T20:18:19.673Z,1725913099.673 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0050.lzma.bak
2024-09-09T20:18:19.673Z,1725913099.673 [DataOverHttps](INFO): SBD MOMSN=23149369
2024-09-09T20:18:20.998Z,1725913100.998 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:18:20.998Z,1725913100.998 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:18:20.998Z,1725913100.998 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:18:34.719Z,1725913114.719 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:23:21.579Z,1725913401.579 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:23:21.579Z,1725913401.579 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:23:21.579Z,1725913401.579 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:23:21.579Z,1725913401.579 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:23:21.986Z,1725913401.986 [Default:CheckIn:D] Stopped
2024-09-09T20:23:21.986Z,1725913401.986 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:23:22.421Z,1725913402.421 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 117.719808 min
2024-09-09T20:23:22.421Z,1725913402.421 [Default:CheckIn:E] Stopped
2024-09-09T20:23:22.422Z,1725913402.422 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:23:22.422Z,1725913402.422 [Default:CheckIn] Stopped
2024-09-09T20:23:22.422Z,1725913402.422 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:23:22.422Z,1725913402.422 [Default:CheckIn](INFO): Running loop #15
2024-09-09T20:23:22.422Z,1725913402.422 [Default:CheckIn] Running Loop=15
2024-09-09T20:23:22.426Z,1725913402.426 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:23:22.426Z,1725913402.426 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:23:24.402Z,1725913404.402 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202323.00,A,3648.15145,N,12147.22242,W,0.039,74.90,090924,,,D*45
2024-09-09T20:23:24.404Z,1725913404.404 [NAL9602](INFO): GPS fix at 20240909T202323: (36.802524, -121.787040)
2024-09-09T20:23:24.440Z,1725913404.440 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:23:24.440Z,1725913404.440 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:23:32.582Z,1725913412.582 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0052.lzma
2024-09-09T20:23:33.584Z,1725913413.584 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0052.lzma.bak
2024-09-09T20:23:33.584Z,1725913413.584 [DataOverHttps](INFO): SBD MOMSN=23149396
2024-09-09T20:23:41.764Z,1725913421.764 [NAL9602](INFO): SBD MO Status=0, MOMSN=41704, MT Status=0, MTMSN=0
2024-09-09T20:23:41.764Z,1725913421.764 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:23:49.798Z,1725913429.798 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240909T182035/Express0053.lzma
2024-09-09T20:23:50.800Z,1725913430.800 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0053.lzma.bak
2024-09-09T20:23:50.800Z,1725913430.800 [DataOverHttps](INFO): SBD MOMSN=23149399
2024-09-09T20:23:51.878Z,1725913431.878 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:23:51.878Z,1725913431.878 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:23:51.878Z,1725913431.878 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:24:12.471Z,1725913452.471 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:26:58.181Z,1725913618.181 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-3768,-32768,V
2024-09-09T20:28:52.468Z,1725913732.468 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:28:52.468Z,1725913732.468 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:28:52.468Z,1725913732.468 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:28:52.468Z,1725913732.468 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:28:52.859Z,1725913732.859 [Default:CheckIn:D] Stopped
2024-09-09T20:28:52.859Z,1725913732.859 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:28:53.271Z,1725913733.271 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 123.234367 min
2024-09-09T20:28:53.271Z,1725913733.271 [Default:CheckIn:E] Stopped
2024-09-09T20:28:53.271Z,1725913733.271 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:28:53.271Z,1725913733.271 [Default:CheckIn] Stopped
2024-09-09T20:28:53.271Z,1725913733.271 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:28:53.272Z,1725913733.272 [Default:CheckIn](INFO): Running loop #16
2024-09-09T20:28:53.272Z,1725913733.272 [Default:CheckIn] Running Loop=16
2024-09-09T20:28:53.272Z,1725913733.272 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:28:53.272Z,1725913733.272 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:28:55.273Z,1725913735.273 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202854.00,A,3648.15068,N,12147.22156,W,0.039,74.90,090924,,,D*46
2024-09-09T20:28:55.275Z,1725913735.275 [NAL9602](INFO): GPS fix at 20240909T202854: (36.802511, -121.787026)
2024-09-09T20:28:55.310Z,1725913735.310 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:28:55.310Z,1725913735.310 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:29:02.510Z,1725913742.510 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0055.lzma
2024-09-09T20:29:03.513Z,1725913743.513 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0055.lzma.bak
2024-09-09T20:29:03.513Z,1725913743.513 [DataOverHttps](INFO): SBD MOMSN=23149404
2024-09-09T20:29:08.600Z,1725913748.600 [NAL9602](INFO): SBD MO Status=0, MOMSN=41705, MT Status=0, MTMSN=0
2024-09-09T20:29:08.601Z,1725913748.601 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:29:19.786Z,1725913759.786 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240909T182035/Express0056.lzma
2024-09-09T20:29:20.788Z,1725913760.788 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0056.lzma.bak
2024-09-09T20:29:20.788Z,1725913760.788 [DataOverHttps](INFO): SBD MOMSN=23149410
2024-09-09T20:29:21.943Z,1725913761.943 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:29:21.943Z,1725913761.943 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:29:21.943Z,1725913761.943 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:29:39.301Z,1725913779.301 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:34:22.526Z,1725914062.526 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:34:22.526Z,1725914062.526 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:34:22.527Z,1725914062.527 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:34:22.527Z,1725914062.527 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:34:22.930Z,1725914062.930 [Default:CheckIn:D] Stopped
2024-09-09T20:34:22.930Z,1725914062.930 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 128.735539 min
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn:E] Stopped
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn] Stopped
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn](INFO): Running loop #17
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn] Running Loop=17
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:34:23.333Z,1725914063.333 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:34:25.341Z,1725914065.341 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203424.00,A,3648.15007,N,12147.22130,W,0.019,74.90,090924,,,D*47
2024-09-09T20:34:25.352Z,1725914065.352 [NAL9602](INFO): GPS fix at 20240909T203424: (36.802501, -121.787022)
2024-09-09T20:34:25.364Z,1725914065.364 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:34:25.364Z,1725914065.364 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:34:33.066Z,1725914073.066 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240909T182035/Courier0058.lzma
2024-09-09T20:34:34.068Z,1725914074.068 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0058.lzma.bak
2024-09-09T20:34:34.068Z,1725914074.068 [DataOverHttps](INFO): SBD MOMSN=23149433
2024-09-09T20:34:50.334Z,1725914090.334 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240909T182035/Express0059.lzma
2024-09-09T20:34:51.337Z,1725914091.337 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0059.lzma.bak
2024-09-09T20:34:51.337Z,1725914091.337 [DataOverHttps](INFO): SBD MOMSN=23149436
2024-09-09T20:34:52.440Z,1725914092.440 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:34:52.440Z,1725914092.440 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:34:52.440Z,1725914092.440 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:34:53.625Z,1725914093.625 [NAL9602](INFO): SBD MO Status=0, MOMSN=41706, MT Status=0, MTMSN=0
2024-09-09T20:34:53.625Z,1725914093.625 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:35:24.323Z,1725914124.323 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:39:53.006Z,1725914393.006 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:39:53.006Z,1725914393.006 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:39:53.010Z,1725914393.010 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:39:53.010Z,1725914393.010 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:39:53.420Z,1725914393.420 [Default:CheckIn:D] Stopped
2024-09-09T20:39:53.420Z,1725914393.420 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:39:53.835Z,1725914393.835 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 134.243717 min
2024-09-09T20:39:53.835Z,1725914393.835 [Default:CheckIn:E] Stopped
2024-09-09T20:39:53.835Z,1725914393.835 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:39:53.835Z,1725914393.835 [Default:CheckIn] Stopped
2024-09-09T20:39:53.835Z,1725914393.835 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:39:53.836Z,1725914393.836 [Default:CheckIn](INFO): Running loop #18
2024-09-09T20:39:53.836Z,1725914393.836 [Default:CheckIn] Running Loop=18
2024-09-09T20:39:53.836Z,1725914393.836 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:39:53.836Z,1725914393.836 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:39:55.810Z,1725914395.810 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203955.00,A,3648.18641,N,12147.17500,W,4.860,42.80,090924,,,D*42
2024-09-09T20:39:55.812Z,1725914395.812 [NAL9602](INFO): GPS fix at 20240909T203955: (36.803107, -121.786250)
2024-09-09T20:39:55.823Z,1725914395.823 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:39:55.823Z,1725914395.823 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:40:05.234Z,1725914405.234 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0061.lzma
2024-09-09T20:40:06.236Z,1725914406.236 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0061.lzma.bak
2024-09-09T20:40:06.237Z,1725914406.237 [DataOverHttps](INFO): SBD MOMSN=23149442
2024-09-09T20:40:24.050Z,1725914424.050 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240909T182035/Express0062.lzma
2024-09-09T20:40:25.052Z,1725914425.052 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0062.lzma.bak
2024-09-09T20:40:25.052Z,1725914425.052 [DataOverHttps](INFO): SBD MOMSN=23149449
2024-09-09T20:40:26.187Z,1725914426.187 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:40:26.187Z,1725914426.187 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:40:26.187Z,1725914426.187 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:40:47.160Z,1725914447.160 [NAL9602](INFO): SBD MO Status=0, MOMSN=41707, MT Status=0, MTMSN=0
2024-09-09T20:40:47.161Z,1725914447.161 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:40:58.484Z,1725914458.484 [RDI_Pathfinder](ERROR): only read 0 of 4 data items for water velocity. Device response is::WS:BE,-32768,-32768,-32768,V
2024-09-09T20:41:17.863Z,1725914477.863 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:42:24.977Z,1725914544.977 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:42:39.117Z,1725914559.117 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:42:53.260Z,1725914573.260 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:43:07.397Z,1725914587.397 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:43:21.539Z,1725914601.539 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:43:35.273Z,1725914615.273 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:43:49.413Z,1725914629.413 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:44:03.177Z,1725914643.177 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:44:17.365Z,1725914657.365 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:44:31.096Z,1725914671.096 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:44:44.834Z,1725914684.834 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-09-09T20:44:44.841Z,1725914684.841 [BPC1](INFO): Calculating totals. Valid battery stick count: 28. Valid reserve battery stick count: 5.
2024-09-09T20:44:44.844Z,1725914684.844 [BPC1](INFO): Received data from all battery sticks.
2024-09-09T20:45:26.868Z,1725914726.868 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:45:26.868Z,1725914726.868 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:45:26.869Z,1725914726.869 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:45:26.869Z,1725914726.869 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:45:27.276Z,1725914727.276 [Default:CheckIn:D] Stopped
2024-09-09T20:45:27.277Z,1725914727.277 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:45:27.671Z,1725914727.671 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 139.807992 min
2024-09-09T20:45:27.671Z,1725914727.671 [Default:CheckIn:E] Stopped
2024-09-09T20:45:27.671Z,1725914727.671 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:45:27.671Z,1725914727.671 [Default:CheckIn] Stopped
2024-09-09T20:45:27.671Z,1725914727.671 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:45:27.672Z,1725914727.672 [Default:CheckIn](INFO): Running loop #19
2024-09-09T20:45:27.672Z,1725914727.672 [Default:CheckIn] Running Loop=19
2024-09-09T20:45:27.672Z,1725914727.672 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:45:27.672Z,1725914727.672 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:45:29.685Z,1725914729.685 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204528.00,A,3648.45510,N,12147.31590,W,7.406,234.51,090924,,,D*71
2024-09-09T20:45:29.687Z,1725914729.687 [NAL9602](INFO): GPS fix at 20240909T204528: (36.807585, -121.788598)
2024-09-09T20:45:29.698Z,1725914729.698 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:45:29.698Z,1725914729.698 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:45:37.526Z,1725914737.526 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20240909T182035/Courier0064.lzma
2024-09-09T20:45:38.528Z,1725914738.528 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0064.lzma.bak
2024-09-09T20:45:38.528Z,1725914738.528 [DataOverHttps](INFO): SBD MOMSN=23149467
2024-09-09T20:45:53.129Z,1725914753.129 [NAL9602](INFO): SBD MO Status=0, MOMSN=41708, MT Status=0, MTMSN=0
2024-09-09T20:45:53.129Z,1725914753.129 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:45:54.802Z,1725914754.802 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240909T182035/Express0065.lzma
2024-09-09T20:45:55.806Z,1725914755.806 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0065.lzma.bak
2024-09-09T20:45:55.806Z,1725914755.806 [DataOverHttps](INFO): SBD MOMSN=23149470
2024-09-09T20:45:57.177Z,1725914757.177 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:45:57.177Z,1725914757.177 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:45:57.178Z,1725914757.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:46:23.872Z,1725914783.872 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:50:57.798Z,1725915057.798 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:50:57.798Z,1725915057.798 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:50:57.798Z,1725915057.798 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:50:57.798Z,1725915057.798 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:50:58.235Z,1725915058.235 [Default:CheckIn:D] Stopped
2024-09-09T20:50:58.235Z,1725915058.235 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:50:58.607Z,1725915058.607 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 145.323975 min
2024-09-09T20:50:58.607Z,1725915058.607 [Default:CheckIn:E] Stopped
2024-09-09T20:50:58.607Z,1725915058.607 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:50:58.607Z,1725915058.607 [Default:CheckIn] Stopped
2024-09-09T20:50:58.607Z,1725915058.607 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:50:58.608Z,1725915058.608 [Default:CheckIn](INFO): Running loop #20
2024-09-09T20:50:58.608Z,1725915058.608 [Default:CheckIn] Running Loop=20
2024-09-09T20:50:58.608Z,1725915058.608 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:50:58.608Z,1725915058.608 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:51:00.617Z,1725915060.617 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205059.00,A,3649.31795,N,12149.61794,W,29.585,299.70,090924,,,D*41
2024-09-09T20:51:00.619Z,1725915060.619 [NAL9602](INFO): GPS fix at 20240909T205059: (36.821966, -121.826966)
2024-09-09T20:51:00.631Z,1725915060.631 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:51:00.631Z,1725915060.631 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:51:12.198Z,1725915072.198 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240909T182035/Courier0067.lzma
2024-09-09T20:51:13.200Z,1725915073.200 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0067.lzma.bak
2024-09-09T20:51:13.200Z,1725915073.200 [DataOverHttps](INFO): SBD MOMSN=23149487
2024-09-09T20:51:20.005Z,1725915080.005 [NAL9602](INFO): SBD MO Status=2, MOMSN=41709, MT Status=2, MTMSN=0
2024-09-09T20:51:20.005Z,1725915080.005 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T20:51:29.638Z,1725915089.638 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240909T182035/Express0068.lzma
2024-09-09T20:51:30.640Z,1725915090.640 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0068.lzma.bak
2024-09-09T20:51:30.640Z,1725915090.640 [DataOverHttps](INFO): SBD MOMSN=23149490
2024-09-09T20:51:31.754Z,1725915091.754 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:51:31.754Z,1725915091.754 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:51:31.754Z,1725915091.754 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:51:43.845Z,1725915103.845 [NAL9602](INFO): SBD MO Status=2, MOMSN=41709, MT Status=2, MTMSN=0
2024-09-09T20:51:43.845Z,1725915103.845 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T20:52:01.212Z,1725915121.212 [NAL9602](INFO): SBD MO Status=2, MOMSN=41709, MT Status=2, MTMSN=0
2024-09-09T20:52:01.212Z,1725915121.212 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T20:52:14.153Z,1725915134.153 [NAL9602](INFO): SBD MO Status=0, MOMSN=41709, MT Status=0, MTMSN=0
2024-09-09T20:52:14.153Z,1725915134.153 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:52:44.843Z,1725915164.843 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:56:32.347Z,1725915392.347 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T20:56:32.347Z,1725915392.347 [Default:CheckIn:C.Wait] Stopped
2024-09-09T20:56:32.347Z,1725915392.347 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T20:56:32.347Z,1725915392.347 [Default:CheckIn:D] Running Loop=1
2024-09-09T20:56:32.722Z,1725915392.722 [Default:CheckIn:D] Stopped
2024-09-09T20:56:32.722Z,1725915392.722 [Default:CheckIn:E] Running Loop=1
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 150.898747 min
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn:E] Stopped
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn] Stopped
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn](INFO): Running loop #21
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn] Running Loop=21
2024-09-09T20:56:33.132Z,1725915393.132 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T20:56:33.133Z,1725915393.133 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T20:56:35.137Z,1725915395.137 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205634.00,A,3649.92131,N,12152.80726,W,28.244,277.84,090924,,,D*41
2024-09-09T20:56:35.140Z,1725915395.140 [NAL9602](INFO): GPS fix at 20240909T205634: (36.832022, -121.880121)
2024-09-09T20:56:35.175Z,1725915395.175 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T20:56:35.175Z,1725915395.175 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T20:56:43.214Z,1725915403.214 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0070.lzma
2024-09-09T20:56:44.216Z,1725915404.216 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0070.lzma.bak
2024-09-09T20:56:44.216Z,1725915404.216 [DataOverHttps](INFO): SBD MOMSN=23149509
2024-09-09T20:57:00.946Z,1725915420.946 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20240909T182035/Express0071.lzma
2024-09-09T20:57:01.948Z,1725915421.948 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0071.lzma.bak
2024-09-09T20:57:01.949Z,1725915421.949 [DataOverHttps](INFO): SBD MOMSN=23149512
2024-09-09T20:57:03.025Z,1725915423.025 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T20:57:03.025Z,1725915423.025 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T20:57:03.025Z,1725915423.025 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T20:57:14.325Z,1725915434.325 [NAL9602](INFO): SBD MO Status=2, MOMSN=41710, MT Status=2, MTMSN=0
2024-09-09T20:57:14.325Z,1725915434.325 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T20:57:26.845Z,1725915446.845 [NAL9602](INFO): SBD MO Status=0, MOMSN=41710, MT Status=0, MTMSN=0
2024-09-09T20:57:26.845Z,1725915446.845 [NAL9602](INFO): No messages in MT queue
2024-09-09T20:57:57.546Z,1725915477.546 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T20:59:20.104Z,1725915560.104 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T20:59:22.112Z,1725915562.112 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.240292
2024-09-09T21:00:16.076Z,1725915616.076 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.007414
2024-09-09T21:02:03.605Z,1725915723.605 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T21:02:03.605Z,1725915723.605 [Default:CheckIn:C.Wait] Stopped
2024-09-09T21:02:03.605Z,1725915723.605 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T21:02:03.605Z,1725915723.605 [Default:CheckIn:D] Running Loop=1
2024-09-09T21:02:04.015Z,1725915724.015 [Default:CheckIn:D] Stopped
2024-09-09T21:02:04.015Z,1725915724.015 [Default:CheckIn:E] Running Loop=1
2024-09-09T21:02:04.446Z,1725915724.446 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 156.420296 min
2024-09-09T21:02:04.446Z,1725915724.446 [Default:CheckIn:E] Stopped
2024-09-09T21:02:04.450Z,1725915724.450 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T21:02:04.450Z,1725915724.450 [Default:CheckIn] Stopped
2024-09-09T21:02:04.450Z,1725915724.450 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T21:02:04.451Z,1725915724.451 [Default:CheckIn](INFO): Running loop #22
2024-09-09T21:02:04.451Z,1725915724.451 [Default:CheckIn] Running Loop=22
2024-09-09T21:02:04.451Z,1725915724.451 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T21:02:04.451Z,1725915724.451 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T21:02:06.417Z,1725915726.417 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210205.00,A,3650.67584,N,12155.95566,W,28.788,294.12,090924,,,D*49
2024-09-09T21:02:06.420Z,1725915726.420 [NAL9602](INFO): GPS fix at 20240909T210205: (36.844597, -121.932594)
2024-09-09T21:02:06.451Z,1725915726.451 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T21:02:06.451Z,1725915726.451 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T21:02:14.626Z,1725915734.626 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0073.lzma
2024-09-09T21:02:15.628Z,1725915735.628 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0073.lzma.bak
2024-09-09T21:02:15.628Z,1725915735.628 [DataOverHttps](INFO): SBD MOMSN=23149530
2024-09-09T21:02:21.769Z,1725915741.769 [NAL9602](INFO): SBD MO Status=0, MOMSN=41711, MT Status=0, MTMSN=0
2024-09-09T21:02:21.769Z,1725915741.769 [NAL9602](INFO): No messages in MT queue
2024-09-09T21:02:33.354Z,1725915753.354 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240909T182035/Express0074.lzma
2024-09-09T21:02:34.368Z,1725915754.368 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0074.lzma.bak
2024-09-09T21:02:34.369Z,1725915754.369 [DataOverHttps](INFO): SBD MOMSN=23149536
2024-09-09T21:02:35.522Z,1725915755.522 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T21:02:35.522Z,1725915755.522 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T21:02:35.522Z,1725915755.522 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T21:02:52.475Z,1725915772.475 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T21:04:55.291Z,1725915895.291 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.803234
2024-09-09T21:05:27.882Z,1725915927.882 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002885
2024-09-09T21:07:36.192Z,1725916056.192 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T21:07:36.192Z,1725916056.192 [Default:CheckIn:C.Wait] Stopped
2024-09-09T21:07:36.192Z,1725916056.192 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T21:07:36.192Z,1725916056.192 [Default:CheckIn:D] Running Loop=1
2024-09-09T21:07:36.551Z,1725916056.551 [Default:CheckIn:D] Stopped
2024-09-09T21:07:36.551Z,1725916056.551 [Default:CheckIn:E] Running Loop=1
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 161.962565 min
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn:E] Stopped
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn] Stopped
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn](INFO): Running loop #23
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn] Running Loop=23
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T21:07:36.965Z,1725916056.965 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T21:07:38.965Z,1725916058.965 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210738.00,A,3651.21848,N,12158.11556,W,0.661,39.91,090924,,,D*4C
2024-09-09T21:07:38.967Z,1725916058.967 [NAL9602](INFO): GPS fix at 20240909T210738: (36.853641, -121.968593)
2024-09-09T21:07:39.003Z,1725916059.003 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T21:07:39.003Z,1725916059.003 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T21:07:54.327Z,1725916074.327 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.241760
2024-09-09T21:08:10.877Z,1725916090.877 [NAL9602](INFO): SBD MO Status=2, MOMSN=41712, MT Status=2, MTMSN=0
2024-09-09T21:08:10.877Z,1725916090.877 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-09-09T21:08:14.990Z,1725916094.990 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002781
2024-09-09T21:08:25.502Z,1725916105.502 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0076.lzma
2024-09-09T21:08:26.504Z,1725916106.504 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0076.lzma.bak
2024-09-09T21:08:26.504Z,1725916106.504 [DataOverHttps](INFO): SBD MOMSN=23149665
2024-09-09T21:08:29.459Z,1725916109.459 [NAL9602](INFO): SBD MO Status=0, MOMSN=41712, MT Status=0, MTMSN=0
2024-09-09T21:08:29.459Z,1725916109.459 [NAL9602](INFO): No messages in MT queue
2024-09-09T21:08:44.696Z,1725916124.696 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240909T182035/Express0077.lzma
2024-09-09T21:08:45.696Z,1725916125.696 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Express0077.lzma.bak
2024-09-09T21:08:45.697Z,1725916125.697 [DataOverHttps](INFO): SBD MOMSN=23149669
2024-09-09T21:08:46.849Z,1725916126.849 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T21:08:46.849Z,1725916126.849 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T21:08:46.849Z,1725916126.849 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T21:09:00.167Z,1725916140.167 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T21:09:55.003Z,1725916195.003 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.654896
2024-09-09T21:10:28.144Z,1725916228.144 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:11:03.307Z,1725916263.307 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:11:38.447Z,1725916298.447 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:12:13.587Z,1725916333.587 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:12:48.727Z,1725916368.727 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:13:23.883Z,1725916403.883 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:13:47.429Z,1725916427.429 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T21:13:47.429Z,1725916427.429 [Default:CheckIn:C.Wait] Stopped
2024-09-09T21:13:47.429Z,1725916427.429 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T21:13:47.429Z,1725916427.429 [Default:CheckIn:D] Running Loop=1
2024-09-09T21:13:47.821Z,1725916427.821 [Default:CheckIn:D] Stopped
2024-09-09T21:13:47.821Z,1725916427.821 [Default:CheckIn:E] Running Loop=1
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 168.150391 min
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn:E] Stopped
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn] Stopped
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn](INFO): Running loop #24
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn] Running Loop=24
2024-09-09T21:13:48.245Z,1725916428.245 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T21:13:48.246Z,1725916428.246 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T21:13:50.236Z,1725916430.236 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211349.00,A,3651.20116,N,12158.11251,W,0.330,208.81,090924,,,D*7C
2024-09-09T21:13:50.238Z,1725916430.238 [NAL9602](INFO): GPS fix at 20240909T211349: (36.853353, -121.968542)
2024-09-09T21:13:50.286Z,1725916430.286 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T21:13:50.287Z,1725916430.287 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T21:13:59.023Z,1725916439.023 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:14:04.860Z,1725916444.861 [NAL9602](INFO): SBD MO Status=1, MOMSN=41713, MT Status=0, MTMSN=0
2024-09-09T21:14:04.916Z,1725916444.916 [NAL9602](INFO): Sent 72 bytes from file Logs/20240909T182035/Courier0079.lzma
2024-09-09T21:14:04.917Z,1725916444.917 [NAL9602](INFO): Packets left to send: 0
2024-09-09T21:14:13.809Z,1725916453.809 [NAL9602](INFO): SBD MO Status=1, MOMSN=41714, MT Status=0, MTMSN=0
2024-09-09T21:14:13.863Z,1725916453.863 [NAL9602](INFO): Sent 131 bytes from file Logs/20240909T182035/Express0080.lzma
2024-09-09T21:14:13.863Z,1725916453.863 [NAL9602](INFO): Packets left to send: 0
2024-09-09T21:14:23.110Z,1725916463.110 [NAL9602](INFO): SBD MO Status=0, MOMSN=41715, MT Status=0, MTMSN=0
2024-09-09T21:14:23.195Z,1725916463.195 [Default:CheckIn:Read_Iridium] Stopped
2024-09-09T21:14:23.195Z,1725916463.195 [Default:CheckIn:C.Wait] Running Loop=1
2024-09-09T21:14:23.195Z,1725916463.195 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-09-09T21:14:53.804Z,1725916493.804 [NAL9602](INFO): Not Powering down - fast GPS
2024-09-09T21:15:26.370Z,1725916526.370 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002793
2024-09-09T21:17:33.936Z,1725916653.936 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.252438
2024-09-09T21:18:07.075Z,1725916687.075 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2024-09-09T21:18:37.479Z,1725916717.479 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002869
2024-09-09T21:19:23.737Z,1725916763.737 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-09-09T21:19:23.737Z,1725916763.737 [Default:CheckIn:C.Wait] Stopped
2024-09-09T21:19:23.737Z,1725916763.737 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-09-09T21:19:23.737Z,1725916763.737 [Default:CheckIn:D] Running Loop=1
2024-09-09T21:19:24.178Z,1725916764.178 [Default:CheckIn:D] Stopped
2024-09-09T21:19:24.178Z,1725916764.178 [Default:CheckIn:E] Running Loop=1
2024-09-09T21:19:24.538Z,1725916764.538 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 173.756348 min
2024-09-09T21:19:24.538Z,1725916764.538 [Default:CheckIn:E] Stopped
2024-09-09T21:19:24.538Z,1725916764.538 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-09-09T21:19:24.538Z,1725916764.538 [Default:CheckIn] Stopped
2024-09-09T21:19:24.538Z,1725916764.538 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-09-09T21:19:24.538Z,1725916764.538 [Default:CheckIn](INFO): Running loop #25
2024-09-09T21:19:24.539Z,1725916764.539 [Default:CheckIn] Running Loop=25
2024-09-09T21:19:24.539Z,1725916764.539 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-09-09T21:19:24.539Z,1725916764.539 [Default:CheckIn:Read_GPS] Running Loop=1
2024-09-09T21:19:26.553Z,1725916766.553 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211925.00,A,3651.17593,N,12158.11478,W,0.428,167.93,090924,,,D*7B
2024-09-09T21:19:26.555Z,1725916766.555 [NAL9602](INFO): GPS fix at 20240909T211925: (36.852932, -121.968580)
2024-09-09T21:19:26.566Z,1725916766.566 [Default:CheckIn:Read_GPS] Stopped
2024-09-09T21:19:26.566Z,1725916766.566 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-09-09T21:19:34.722Z,1725916774.722 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240909T182035/Courier0082.lzma
2024-09-09T21:19:36.729Z,1725916776.729 [DataOverHttps](INFO): Moved sent file to Logs/20240909T182035/Courier0082.lzma.bak
2024-09-09T21:19:36.729Z,1725916776.729 [DataOverHttps](IMPORTANT): SBD MOMSN=23149730, MTMSN=20240909T211934
2024-09-09T21:19:43.125Z,1725916783.125 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=41716, MT Status=1, MTMSN=2273
2024-09-09T21:19:43.125Z,1725916783.125 [NAL9602](INFO): Data available in MT queue
2024-09-09T21:19:43.611Z,1725916783.611 [NAL9602](INFO): Received command: restart logs