2024-05-06T14:55:06.422Z,1715007306.422 [Supervisor](DEBUG): Initializing supervisor. 2024-05-06T14:55:06.426Z,1715007306.426 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-06T14:55:06.427Z,1715007306.427 [SyncHandler](INFO): Protected caller Thread ID is 1040 2024-05-06T14:55:06.427Z,1715007306.427 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-06T14:55:06.428Z,1715007306.428 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-06T14:55:06.429Z,1715007306.429 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1041 2024-05-06T14:55:06.432Z,1715007306.432 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-06T14:55:06.450Z,1715007306.450 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-06T14:55:06.451Z,1715007306.451 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-06T14:55:06.451Z,1715007306.451 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1042 2024-05-06T14:55:06.456Z,1715007306.456 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-06T14:55:06.457Z,1715007306.457 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-06T14:55:06.457Z,1715007306.457 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1043 2024-05-06T14:55:06.459Z,1715007306.459 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-06T14:55:06.460Z,1715007306.460 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-06T14:55:06.460Z,1715007306.460 [logger ThreadHandler](INFO): Protected caller Thread ID is 1044 2024-05-06T14:55:06.464Z,1715007306.464 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-06T14:55:06.464Z,1715007306.464 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-06T14:55:06.466Z,1715007306.466 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-06T14:55:06.812Z,1715007306.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-06T14:55:06.812Z,1715007306.812 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-06T14:55:06.902Z,1715007306.902 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-06T14:55:07.019Z,1715007307.019 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-06T14:55:07.020Z,1715007307.020 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-06T14:55:07.159Z,1715007307.159 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-06T14:55:07.160Z,1715007307.160 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-06T14:55:07.518Z,1715007307.518 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-06T14:55:07.518Z,1715007307.518 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-06T14:55:07.625Z,1715007307.625 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-06T14:55:07.625Z,1715007307.625 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-06T14:55:08.039Z,1715007308.039 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-06T14:55:08.040Z,1715007308.040 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-06T14:55:08.264Z,1715007308.264 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-06T14:55:08.265Z,1715007308.265 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-06T14:55:08.353Z,1715007308.353 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-06T14:55:08.602Z,1715007308.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-06T14:55:08.602Z,1715007308.602 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-06T14:55:08.834Z,1715007308.834 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-06T14:55:08.835Z,1715007308.835 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-06T14:55:09.375Z,1715007309.375 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-06T14:55:09.375Z,1715007309.375 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-06T14:55:09.581Z,1715007309.581 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-06T14:55:09.581Z,1715007309.581 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-06T14:55:09.895Z,1715007309.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-06T14:55:09.896Z,1715007309.896 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-06T14:55:10.770Z,1715007310.770 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-06T14:55:10.771Z,1715007310.771 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-06T14:55:11.358Z,1715007311.358 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-06T14:55:11.360Z,1715007311.360 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2024-05-06T14:55:11.361Z,1715007311.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2024-05-06T14:55:11.470Z,1715007311.470 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2024-05-06T14:55:11.597Z,1715007311.597 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2024-05-06T14:55:11.690Z,1715007311.690 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2024-05-06T14:55:11.807Z,1715007311.807 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2024-05-06T14:55:11.904Z,1715007311.904 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2024-05-06T14:55:12.172Z,1715007312.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-06T14:55:12.173Z,1715007312.173 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2024-05-06T14:55:12.293Z,1715007312.293 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2024-05-06T14:55:12.401Z,1715007312.401 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2024-05-06T14:55:12.514Z,1715007312.514 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2024-05-06T14:55:12.666Z,1715007312.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2024-05-06T14:55:12.761Z,1715007312.761 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-06T14:55:12.766Z,1715007312.766 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-06T14:55:12.883Z,1715007312.883 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-06T14:55:12.884Z,1715007312.884 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-06T14:55:12.937Z,1715007312.937 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-06T14:55:12.998Z,1715007312.998 [VerticalControl] Loaded 2024-05-06T14:55:12.998Z,1715007312.998 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-06T14:55:13.001Z,1715007313.001 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-06T14:55:13.049Z,1715007313.049 [HorizontalControl] Loaded 2024-05-06T14:55:13.049Z,1715007313.049 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-06T14:55:13.051Z,1715007313.051 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-06T14:55:13.054Z,1715007313.054 [SpeedControl] Loaded 2024-05-06T14:55:13.055Z,1715007313.055 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-06T14:55:13.057Z,1715007313.057 [LoopControl](DEBUG): Construct LoopControl. 2024-05-06T14:55:13.058Z,1715007313.058 [LoopControl] Loaded 2024-05-06T14:55:13.058Z,1715007313.058 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-06T14:55:13.058Z,1715007313.058 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-06T14:55:13.059Z,1715007313.059 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-06T14:55:13.116Z,1715007313.116 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-06T14:55:13.117Z,1715007313.117 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-06T14:55:13.573Z,1715007313.573 [AHRS_M2] Loaded 2024-05-06T14:55:13.573Z,1715007313.573 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-06T14:55:13.609Z,1715007313.609 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC4 2024-05-06T14:55:13.609Z,1715007313.609 [BackseatComponent] Loaded 2024-05-06T14:55:13.610Z,1715007313.610 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-05-06T14:55:13.611Z,1715007313.611 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0 2024-05-06T14:55:13.611Z,1715007313.611 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1126 2024-05-06T14:55:13.614Z,1715007313.614 [LcmUniversalReporter] Loaded 2024-05-06T14:55:13.614Z,1715007313.614 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-05-06T14:55:14.416Z,1715007314.416 [BPC1] Loaded 2024-05-06T14:55:14.416Z,1715007314.416 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-06T14:55:14.489Z,1715007314.489 [DataOverHttps] Loaded 2024-05-06T14:55:14.489Z,1715007314.489 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-06T14:55:14.490Z,1715007314.490 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CD4E0 2024-05-06T14:55:14.491Z,1715007314.491 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1127 2024-05-06T14:55:14.512Z,1715007314.512 [Depth_Keller] Loaded 2024-05-06T14:55:14.512Z,1715007314.512 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-06T14:55:14.517Z,1715007314.517 [DropWeight] Loaded 2024-05-06T14:55:14.517Z,1715007314.517 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-05-06T14:55:14.579Z,1715007314.579 [NAL9602] Loaded 2024-05-06T14:55:14.579Z,1715007314.579 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-06T14:55:14.609Z,1715007314.609 [Onboard] Loaded 2024-05-06T14:55:14.609Z,1715007314.609 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-06T14:55:14.610Z,1715007314.610 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0 2024-05-06T14:55:14.611Z,1715007314.611 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1128 2024-05-06T14:55:14.623Z,1715007314.623 [Power24vConverter] Loaded 2024-05-06T14:55:14.623Z,1715007314.623 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-06T14:55:14.636Z,1715007314.636 [Radio_Surface] Loaded 2024-05-06T14:55:14.637Z,1715007314.637 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-06T14:55:14.638Z,1715007314.638 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0 2024-05-06T14:55:14.638Z,1715007314.638 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1129 2024-05-06T14:55:14.652Z,1715007314.652 [Sonardyne_Nano] Loaded 2024-05-06T14:55:14.652Z,1715007314.652 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-05-06T14:55:14.744Z,1715007314.744 [DAT] Loaded 2024-05-06T14:55:14.744Z,1715007314.744 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-05-06T14:55:14.745Z,1715007314.745 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0 2024-05-06T14:55:14.746Z,1715007314.746 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1130 2024-05-06T14:55:14.768Z,1715007314.768 [Waterlinked] Loaded 2024-05-06T14:55:14.769Z,1715007314.769 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-05-06T14:55:14.769Z,1715007314.769 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-06T14:55:14.770Z,1715007314.770 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-06T14:55:14.791Z,1715007314.791 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-06T14:55:14.793Z,1715007314.793 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-06T14:55:14.827Z,1715007314.827 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-06T14:55:14.827Z,1715007314.827 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-06T14:55:14.969Z,1715007314.969 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-06T14:55:14.978Z,1715007314.978 [SBIT] Loaded 2024-05-06T14:55:14.979Z,1715007314.979 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-06T14:55:14.982Z,1715007314.982 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-06T14:55:14.994Z,1715007314.994 [IBIT] Loaded 2024-05-06T14:55:14.995Z,1715007314.995 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-06T14:55:15.000Z,1715007315.000 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-06T14:55:15.105Z,1715007315.105 [CBIT] Loaded 2024-05-06T14:55:15.105Z,1715007315.105 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-06T14:55:15.106Z,1715007315.106 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-06T14:55:15.106Z,1715007315.106 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-06T14:55:15.450Z,1715007315.450 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-06T14:55:15.451Z,1715007315.451 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-06T14:55:15.501Z,1715007315.501 [DepthRateCalculator] Loaded 2024-05-06T14:55:15.501Z,1715007315.501 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-06T14:55:15.506Z,1715007315.506 [PitchRateCalculator] Loaded 2024-05-06T14:55:15.506Z,1715007315.506 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-06T14:55:15.516Z,1715007315.516 [SpeedCalculator] Loaded 2024-05-06T14:55:15.517Z,1715007315.517 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-06T14:55:15.521Z,1715007315.521 [YawRateCalculator] Loaded 2024-05-06T14:55:15.521Z,1715007315.521 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-06T14:55:15.541Z,1715007315.541 [ElevatorOffsetCalculator] Loaded 2024-05-06T14:55:15.542Z,1715007315.542 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-06T14:55:15.542Z,1715007315.542 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-06T14:55:15.543Z,1715007315.543 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-06T14:55:15.717Z,1715007315.717 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-06T14:55:15.717Z,1715007315.717 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-06T14:55:15.829Z,1715007315.829 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-06T14:55:15.830Z,1715007315.830 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-06T14:55:15.872Z,1715007315.872 [DeadReckonUsingSpeedCalculator] Loaded 2024-05-06T14:55:15.872Z,1715007315.872 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-05-06T14:55:15.914Z,1715007315.914 [DeadReckonWithRespectToSeafloor] Loaded 2024-05-06T14:55:15.915Z,1715007315.915 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2024-05-06T14:55:15.928Z,1715007315.928 [NavChart] Loaded 2024-05-06T14:55:15.928Z,1715007315.928 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-06T14:55:15.934Z,1715007315.934 [UniversalFixResidualReporter] Loaded 2024-05-06T14:55:15.934Z,1715007315.934 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-06T14:55:15.935Z,1715007315.935 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-06T14:55:15.936Z,1715007315.936 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-06T14:55:16.070Z,1715007316.070 [BuoyancyServo] Loaded 2024-05-06T14:55:16.070Z,1715007316.070 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-06T14:55:16.091Z,1715007316.091 [ElevatorServo] Loaded 2024-05-06T14:55:16.091Z,1715007316.091 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-06T14:55:16.111Z,1715007316.111 [MassServo] Loaded 2024-05-06T14:55:16.111Z,1715007316.111 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-06T14:55:16.130Z,1715007316.130 [RudderServo] Loaded 2024-05-06T14:55:16.130Z,1715007316.130 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-06T14:55:16.145Z,1715007316.145 [ThrusterHE] Loaded 2024-05-06T14:55:16.145Z,1715007316.145 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-05-06T14:55:16.146Z,1715007316.146 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-06T14:55:16.146Z,1715007316.146 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-06T14:55:16.331Z,1715007316.331 [CTD_Seabird] Loaded 2024-05-06T14:55:16.331Z,1715007316.331 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-06T14:55:16.333Z,1715007316.333 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2024-05-06T14:55:16.333Z,1715007316.333 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1131 2024-05-06T14:55:16.367Z,1715007316.367 [ESPComponent] Loaded 2024-05-06T14:55:16.367Z,1715007316.367 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-05-06T14:55:16.387Z,1715007316.387 [PAR_Licor] Loaded 2024-05-06T14:55:16.387Z,1715007316.387 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-06T14:55:16.431Z,1715007316.431 [WetLabsBB2FL] Loaded 2024-05-06T14:55:16.431Z,1715007316.431 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-06T14:55:16.432Z,1715007316.432 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-05-06T14:55:16.432Z,1715007316.432 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1132 2024-05-06T14:55:16.433Z,1715007316.433 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-06T14:55:16.439Z,1715007316.439 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-06T14:55:16.442Z,1715007316.442 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-06T14:55:16.454Z,1715007316.454 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-06T14:55:16.455Z,1715007316.455 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-05-06T14:55:16.455Z,1715007316.455 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1133 2024-05-06T14:55:16.459Z,1715007316.459 [Supervisor](INFO): Main Thread ID is 827 2024-05-06T14:55:16.460Z,1715007316.460 [Supervisor](DEBUG): Running supervisor. 2024-05-06T14:55:16.460Z,1715007316.460 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1134 2024-05-06T14:55:16.461Z,1715007316.461 [CommandExec](INFO): Initializing the command executive. 2024-05-06T14:55:16.462Z,1715007316.462 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1135 2024-05-06T14:55:16.464Z,1715007316.464 [controlThread ThreadHandler](INFO): Handler Thread ID is 1136 2024-05-06T14:55:16.465Z,1715007316.465 [controlThread](DEBUG): Initializing ControlThread 2024-05-06T14:55:16.466Z,1715007316.466 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-06T14:55:16.467Z,1715007316.467 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-06T14:55:16.468Z,1715007316.468 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-06T14:55:16.468Z,1715007316.468 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-06T14:55:16.474Z,1715007316.474 [SBIT](INFO): Initialize SBIT Component. 2024-05-06T14:55:16.475Z,1715007316.475 [SBIT](IMPORTANT): git: 2024-04-30_A 2024-05-06T14:55:16.475Z,1715007316.475 [SBIT](INFO): git hash: 6f063747ddc9dbe18e4f40e399cbc8a06a65c541 2024-05-06T14:55:16.475Z,1715007316.475 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-06T14:55:16.476Z,1715007316.476 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023 2024-05-06T14:55:16.477Z,1715007316.477 [SBIT](INFO): Beginning SBIT in 83.000000 seconds. 2024-05-06T14:55:16.478Z,1715007316.478 [IBIT](INFO): Initialize IBIT Component. 2024-05-06T14:55:16.479Z,1715007316.479 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-06T14:55:16.480Z,1715007316.480 [logger ThreadHandler](INFO): Handler Thread ID is 1137 2024-05-06T14:55:16.492Z,1715007316.492 [CBIT](DEBUG): Initialized mux pins. 2024-05-06T14:55:16.492Z,1715007316.492 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-06T14:55:16.500Z,1715007316.500 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1138 2024-05-06T14:55:16.512Z,1715007316.512 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1139 2024-05-06T14:55:16.514Z,1715007316.514 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-06T14:55:16.516Z,1715007316.516 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-06T14:55:16.516Z,1715007316.516 [CBIT](DEBUG): Initializing heartbeat. 2024-05-06T14:55:16.524Z,1715007316.524 [Onboard ThreadHandler](INFO): Handler Thread ID is 1140 2024-05-06T14:55:16.554Z,1715007316.554 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1141 2024-05-06T14:55:16.565Z,1715007316.565 [DAT ThreadHandler](INFO): Handler Thread ID is 1142 2024-05-06T14:55:16.565Z,1715007316.565 [DAT](INFO): Powering up 2024-05-06T14:55:16.566Z,1715007316.566 [DAT](DEBUG): Initializing DAT. 2024-05-06T14:55:16.569Z,1715007316.569 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1144 2024-05-06T14:55:16.570Z,1715007316.570 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-06T14:55:16.573Z,1715007316.573 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1146 2024-05-06T14:55:16.576Z,1715007316.576 [WetLabsBB2FL](INFO): Powering up 2024-05-06T14:55:16.578Z,1715007316.578 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1148 2024-05-06T14:55:16.581Z,1715007316.581 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 2024-05-06T14:55:16.581Z,1715007316.581 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 2024-05-06T14:55:16.581Z,1715007316.581 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 2024-05-06T14:55:16.581Z,1715007316.581 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 2024-05-06T14:55:16.581Z,1715007316.581 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 2024-05-06T14:55:16.582Z,1715007316.582 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 2024-05-06T14:55:16.588Z,1715007316.588 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-06T14:55:16.589Z,1715007316.589 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-06T14:55:16.628Z,1715007316.628 [CBIT](DEBUG): Backplane powered. 2024-05-06T14:55:16.628Z,1715007316.628 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-06T14:55:16.629Z,1715007316.629 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-06T14:55:16.629Z,1715007316.629 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-06T14:55:16.629Z,1715007316.629 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-06T14:55:16.630Z,1715007316.630 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-06T14:55:16.631Z,1715007316.631 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-05-06T14:55:16.632Z,1715007316.632 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-06T14:55:16.632Z,1715007316.632 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-06T14:55:16.637Z,1715007316.637 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-06T14:55:16.637Z,1715007316.637 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-05-06T14:55:16.638Z,1715007316.638 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-05-06T14:55:16.639Z,1715007316.639 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-05-06T14:55:16.698Z,1715007316.698 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-05-06T14:55:16.722Z,1715007316.722 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-06T14:55:16.751Z,1715007316.751 [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-05-06T14:55:16.752Z,1715007316.752 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-05-06T14:55:16.752Z,1715007316.752 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-05-06T14:55:16.753Z,1715007316.753 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-05-06T14:55:16.956Z,1715007316.956 [Radio_Surface](INFO): Powering up 2024-05-06T14:55:17.058Z,1715007317.058 [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-05-06T14:55:17.080Z,1715007317.080 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-06T14:55:17.081Z,1715007317.081 [Default:A.Wait](DEBUG): Construct Wait. 2024-05-06T14:55:17.083Z,1715007317.083 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-06T14:55:17.145Z,1715007317.145 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-06T14:55:17.147Z,1715007317.147 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-06T14:55:17.169Z,1715007317.169 [Default:E.Execute](DEBUG): Construct Execute. 2024-05-06T14:55:17.173Z,1715007317.173 [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-05-06T14:55:17.184Z,1715007317.184 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-05-06T14:55:17.200Z,1715007317.200 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-06T14:55:17.274Z,1715007317.274 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m 2024-05-06T14:55:17.275Z,1715007317.275 [Power24vConverter](INFO): Powering up. 2024-05-06T14:55:17.275Z,1715007317.275 [Sonardyne_Nano](INFO): Initializing. 2024-05-06T14:55:17.302Z,1715007317.302 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-05-06T14:55:17.347Z,1715007317.347 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-06T14:55:17.352Z,1715007317.352 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-06T14:55:17.353Z,1715007317.353 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-06T14:55:17.361Z,1715007317.361 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-06T14:55:17.362Z,1715007317.362 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-06T14:55:17.369Z,1715007317.369 [MassServo](DEBUG): Initializing MassServo. 2024-05-06T14:55:17.369Z,1715007317.369 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-06T14:55:17.376Z,1715007317.376 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-06T14:55:17.377Z,1715007317.377 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-05-06T14:55:17.384Z,1715007317.384 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-05-06T14:55:18.684Z,1715007318.684 [WetLabsBB2FL](INFO): Powering down 2024-05-06T14:55:19.214Z,1715007319.214 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-05-06T14:55:20.500Z,1715007320.500 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311 2024-05-06T14:55:20.872Z,1715007320.872 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-05-06T14:55:23.089Z,1715007323.089 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-05-06T14:55:28.661Z,1715007328.661 [DAT](INFO): DAT read: 2024-05-06T14:55:28.662Z,1715007328.662 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-05-06T14:55:30.173Z,1715007330.173 [DAT](INFO): DAT read: MF Frequency Band 2024-05-06T14:55:30.174Z,1715007330.174 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-05-06T14:55:30.175Z,1715007330.175 [DAT](INFO): DAT read: May 6 2024 14:55:24 2024-05-06T14:55:31.433Z,1715007331.433 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-05-06T14:55:31.434Z,1715007331.434 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-05-06T14:55:31.435Z,1715007331.435 [DAT](INFO): commRate: 800 2024-05-06T14:55:33.500Z,1715007333.500 [DAT](INFO): entering command mode 2024-05-06T14:55:33.701Z,1715007333.701 [DAT](INFO): DAT read: 2024-05-06T14:55:33.701Z,1715007333.701 [DAT](INFO): DAT read: user:1> 2024-05-06T14:55:33.701Z,1715007333.701 [DAT](INFO): setting verbose to 3 2024-05-06T14:55:33.953Z,1715007333.953 [DAT](INFO): DAT read: user:1> 2024-05-06T14:55:33.954Z,1715007333.954 [DAT](INFO): DAT read: Verbose | 3 2024-05-06T14:55:33.954Z,1715007333.954 [DAT](INFO): set verbose to 3 2024-05-06T14:55:33.954Z,1715007333.954 [DAT](INFO): setting DatVerbose to 27440 2024-05-06T14:55:34.205Z,1715007334.205 [DAT](INFO): DAT read: user:2> 2024-05-06T14:55:34.206Z,1715007334.206 [DAT](INFO): DAT read: DatVerbose | 27440 2024-05-06T14:55:34.206Z,1715007334.206 [DAT](INFO): set DatVerbose to 27440 2024-05-06T14:55:34.206Z,1715007334.206 [DAT](INFO): setting transmit power to 8 2024-05-06T14:55:34.457Z,1715007334.457 [DAT](INFO): DAT read: user:3> 2024-05-06T14:55:34.457Z,1715007334.457 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-05-06T14:55:34.458Z,1715007334.458 [DAT](INFO): set transmit power to 8 2024-05-06T14:55:34.458Z,1715007334.458 [DAT](INFO): setting local address to 1 2024-05-06T14:55:34.709Z,1715007334.709 [DAT](INFO): DAT read: user:4> 2024-05-06T14:55:34.710Z,1715007334.710 [DAT](INFO): DAT read: LocalAddr | 1 2024-05-06T14:55:34.710Z,1715007334.710 [DAT](INFO): set local address to 1 2024-05-06T14:55:34.711Z,1715007334.711 [DAT](INFO): Setting time to: 14:55:34 And date to:5/6/2024 2024-05-06T14:55:34.961Z,1715007334.961 [DAT](INFO): DAT read: user:5> 2024-05-06T14:55:34.961Z,1715007334.961 [DAT](INFO): DAT read: Mon May 6, 2024 14:55:34 2024-05-06T14:55:34.962Z,1715007334.962 [DAT](INFO): Local DAT time set to Mon May 6, 2024 14:55:34 2024-05-06T14:55:44.670Z,1715007344.670 [NAL9602](INFO): Powering up NAL9602 2024-05-06T14:55:51.608Z,1715007351.608 [Waterlinked](INFO): Powering down 2024-05-06T14:55:55.582Z,1715007355.582 [NAL9602](INFO): NAL9602 initialized 2024-05-06T14:56:24.258Z,1715007384.258 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:56:37.994Z,1715007397.994 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:56:39.232Z,1715007399.232 [NAL9602](INFO): SBD MO Status=2, MOMSN=13537, MT Status=2, MTMSN=0 2024-05-06T14:56:39.232Z,1715007399.232 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-05-06T14:56:40.034Z,1715007400.034 [SBIT](IMPORTANT): Beginning Startup BIT 2024-05-06T14:56:40.038Z,1715007400.038 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-06T14:56:51.136Z,1715007411.136 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.000907 CHAN A1 (24V): 0.002111 CHAN A2 (12V): 0.000722 CHAN A3 (5V): -0.000910 CHAN B0 (3.3V): 0.000959 CHAN B1 (3.15aV): -0.000295 CHAN B2 (3.15bV): 0.000399 CHAN B3 (GND): -0.000495 OPEN: 0.007974 Full Scale: +/- 1 mA 2024-05-06T14:56:51.736Z,1715007411.736 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:56:56.583Z,1715007416.583 [NAL9602](INFO): SBD MO Status=2, MOMSN=13537, MT Status=2, MTMSN=0 2024-05-06T14:56:56.583Z,1715007416.583 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-05-06T14:57:05.466Z,1715007425.466 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:57:07.091Z,1715007427.091 [NAL9602](INFO): SBD MO Status=0, MOMSN=13537, MT Status=0, MTMSN=0 2024-05-06T14:57:07.091Z,1715007427.091 [NAL9602](INFO): No messages in MT queue 2024-05-06T14:57:08.299Z,1715007428.299 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,145706.00,A,3648.13942,N,12147.23583,W,2.780,73.48,060524,,,A*47 2024-05-06T14:57:08.310Z,1715007428.310 [NAL9602](INFO): GPS fix at 20240506T145706: (36.802324, -121.787264) 2024-05-06T14:57:19.614Z,1715007439.614 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:57:33.755Z,1715007453.755 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:57:34.195Z,1715007454.195 [SBIT](IMPORTANT): SBIT PASSED 2024-05-06T14:57:34.195Z,1715007454.195 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-05-06T14:57:34.197Z,1715007454.197 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count; 2024-05-06T14:57:34.197Z,1715007454.197 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=175.634497 cubic_centimeter; 2024-05-06T14:57:34.197Z,1715007454.197 [SBIT](IMPORTANT): VerticalControl.massDefault=15.996625 millimeter; 2024-05-06T14:57:34.598Z,1715007454.598 [MissionManager](IMPORTANT): Started mission Startup 2024-05-06T14:57:34.599Z,1715007454.599 [Startup] Running Loop=1 2024-05-06T14:57:34.599Z,1715007454.599 [Startup](DEBUG): Aggregate::initialize Startup 2024-05-06T14:57:34.599Z,1715007454.599 [Startup:A.GoToSurface] Running Loop=1 2024-05-06T14:57:34.599Z,1715007454.599 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-06T14:57:34.599Z,1715007454.599 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-06T14:57:34.600Z,1715007454.600 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-06T14:57:34.600Z,1715007454.600 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-06T14:57:34.601Z,1715007454.601 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-06T14:57:34.601Z,1715007454.601 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-06T14:57:34.603Z,1715007454.603 [Startup:StartupSatComms] Running Loop=1 2024-05-06T14:57:34.603Z,1715007454.603 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-05-06T14:57:34.603Z,1715007454.603 [Startup:StartupSatComms:A] Running Loop=1 2024-05-06T14:57:34.987Z,1715007454.987 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-05-06T14:57:36.591Z,1715007456.591 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,145734.00,A,3648.13910,N,12147.22946,W,0.078,78.04,060524,,,A*44 2024-05-06T14:57:36.593Z,1715007456.593 [NAL9602](INFO): GPS fix at 20240506T145734: (36.802318, -121.787158) 2024-05-06T14:57:36.609Z,1715007456.609 [Startup:StartupSatComms:A] Stopped 2024-05-06T14:57:36.609Z,1715007456.609 [Startup:StartupSatComms:B] Running Loop=1 2024-05-06T14:57:37.029Z,1715007457.029 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-06T14:57:47.532Z,1715007467.532 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T14:57:49.563Z,1715007469.563 [NAL9602](INFO): SBD MO Status=1, MOMSN=13538, MT Status=0, MTMSN=0 2024-05-06T14:57:49.612Z,1715007469.612 [NAL9602](INFO): Sent 38 bytes from file Logs/20240506T142116/Courier0019.lzma 2024-05-06T14:57:49.612Z,1715007469.612 [NAL9602](INFO): Packets left to send: 0 2024-05-06T14:58:00.523Z,1715007480.523 [NAL9602](INFO): SBD MO Status=1, MOMSN=13539, MT Status=0, MTMSN=0 2024-05-06T14:58:00.584Z,1715007480.584 [NAL9602](INFO): Sent 267 bytes from file Logs/20240506T145506/Courier0000.lzma 2024-05-06T14:58:00.585Z,1715007480.585 [NAL9602](INFO): Packets left to send: 0 2024-05-06T14:58:08.251Z,1715007488.251 [NAL9602](INFO): SBD MO Status=1, MOMSN=13540, MT Status=0, MTMSN=0 2024-05-06T14:58:08.308Z,1715007488.308 [NAL9602](INFO): Sent 145 bytes from file Logs/20240506T142116/Express0020.lzma 2024-05-06T14:58:08.308Z,1715007488.308 [NAL9602](INFO): Packets left to send: 0 2024-05-06T14:58:16.801Z,1715007496.801 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T14:58:16.801Z,1715007496.801 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T14:58:16.833Z,1715007496.833 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T14:58:17.210Z,1715007497.210 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T14:58:17.210Z,1715007497.210 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T14:58:17.599Z,1715007497.599 [NAL9602](INFO): SBD MO Status=1, MOMSN=13541, MT Status=0, MTMSN=0 2024-05-06T14:58:17.650Z,1715007497.650 [NAL9602](INFO): Sent 332 bytes from file Logs/20240506T145506/Express0001.lzma 2024-05-06T14:58:17.650Z,1715007497.650 [NAL9602](INFO): Packets left to send: 2 2024-05-06T14:58:27.338Z,1715007507.338 [NAL9602](INFO): SBD MO Status=1, MOMSN=13542, MT Status=0, MTMSN=0 2024-05-06T14:58:27.392Z,1715007507.392 [NAL9602](INFO): Sent 332 bytes from file Logs/20240506T145506/Express0001.lzma 2024-05-06T14:58:27.392Z,1715007507.392 [NAL9602](INFO): Packets left to send: 1 2024-05-06T14:58:36.688Z,1715007516.688 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-06T14:57:36.6Z 2024-05-06T14:58:36.688Z,1715007516.688 [Startup:StartupSatComms:B] Stopped 2024-05-06T14:58:36.689Z,1715007516.689 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-05-06T14:58:36.689Z,1715007516.689 [Startup:StartupSatComms] Stopped 2024-05-06T14:58:36.689Z,1715007516.689 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-05-06T14:58:36.690Z,1715007516.690 [Startup](INFO): Completed Startup 2024-05-06T14:58:36.690Z,1715007516.690 [MissionManager](INFO): Startup is completed. 2024-05-06T14:58:36.690Z,1715007516.690 [MissionManager](INFO): Uninitializing Mission Startup 2024-05-06T14:58:36.690Z,1715007516.690 [Startup] Stopped 2024-05-06T14:58:36.690Z,1715007516.690 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-05-06T14:58:36.690Z,1715007516.690 [Startup:A.GoToSurface] Stopped 2024-05-06T14:58:36.690Z,1715007516.690 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-06T14:58:37.102Z,1715007517.102 [MissionManager](IMPORTANT): Started mission Default 2024-05-06T14:58:37.102Z,1715007517.102 [Default] Running Loop=1 2024-05-06T14:58:37.103Z,1715007517.103 [Default](DEBUG): Aggregate::initialize Default 2024-05-06T14:58:37.103Z,1715007517.103 [Default:B.GoToSurface] Running Loop=1 2024-05-06T14:58:37.103Z,1715007517.103 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-06T14:58:37.103Z,1715007517.103 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-06T14:58:37.103Z,1715007517.103 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-06T14:58:37.104Z,1715007517.104 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-06T14:58:37.104Z,1715007517.104 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-06T14:58:37.105Z,1715007517.105 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-06T14:58:37.105Z,1715007517.105 [Default:A.Wait] Running Loop=1 2024-05-06T14:58:37.105Z,1715007517.105 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-05-06T14:58:41.117Z,1715007521.117 [NAL9602](INFO): SBD MO Status=1, MOMSN=13543, MT Status=0, MTMSN=0 2024-05-06T14:58:41.172Z,1715007521.172 [NAL9602](INFO): Sent 197 bytes from file Logs/20240506T145506/Express0001.lzma 2024-05-06T14:58:41.172Z,1715007521.172 [NAL9602](INFO): Packets left to send: 0 2024-05-06T14:58:50.423Z,1715007530.423 [Default:A.Wait](INFO): Done Waiting. 2024-05-06T14:58:50.423Z,1715007530.423 [Default:A.Wait] Stopped 2024-05-06T14:58:50.423Z,1715007530.423 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T14:58:50.825Z,1715007530.825 [Default:CheckIn] Running Loop=1 2024-05-06T14:58:50.825Z,1715007530.825 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T14:58:50.825Z,1715007530.825 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T14:58:51.238Z,1715007531.238 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-05-06T14:58:52.832Z,1715007532.832 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,145851.00,A,3648.13916,N,12147.22930,W,0.019,78.04,060524,,,A*48 2024-05-06T14:58:52.842Z,1715007532.842 [NAL9602](INFO): GPS fix at 20240506T145851: (36.802319, -121.787155) 2024-05-06T14:58:52.858Z,1715007532.858 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T14:58:52.858Z,1715007532.858 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T14:58:53.272Z,1715007533.272 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-06T14:59:01.890Z,1715007541.890 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004535 2024-05-06T14:59:09.416Z,1715007549.416 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0004.lzma 2024-05-06T14:59:10.418Z,1715007550.418 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0004.lzma.bak 2024-05-06T14:59:10.418Z,1715007550.418 [DataOverHttps](INFO): SBD MOMSN=19983684 2024-05-06T14:59:15.547Z,1715007555.547 [NAL9602](INFO): SBD MO Status=1, MOMSN=13544, MT Status=0, MTMSN=0 2024-05-06T14:59:15.604Z,1715007555.604 [NAL9602](INFO): Sent 72 bytes from file Logs/20240506T145506/Courier0004.lzma 2024-05-06T14:59:15.605Z,1715007555.605 [NAL9602](INFO): Packets left to send: 0 2024-05-06T14:59:15.646Z,1715007555.646 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T14:59:15.646Z,1715007555.646 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T14:59:15.646Z,1715007555.646 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T14:59:26.400Z,1715007566.400 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20240506T145506/Express0005.lzma 2024-05-06T14:59:27.402Z,1715007567.402 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0005.lzma.bak 2024-05-06T14:59:27.402Z,1715007567.402 [DataOverHttps](INFO): SBD MOMSN=19983703 2024-05-06T14:59:46.241Z,1715007586.241 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:00:22.997Z,1715007622.997 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:00:35.519Z,1715007635.519 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:00:48.448Z,1715007648.448 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:01:01.377Z,1715007661.377 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:01:14.303Z,1715007674.303 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:01:17.961Z,1715007677.961 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:01:17.961Z,1715007677.961 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:01:17.972Z,1715007677.972 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:01:18.383Z,1715007678.383 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:01:18.383Z,1715007678.383 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:01:27.232Z,1715007687.232 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:01:40.161Z,1715007700.161 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:01:53.089Z,1715007713.089 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:02:06.017Z,1715007726.017 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:02:18.541Z,1715007738.541 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:02:31.469Z,1715007751.469 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:04:02.261Z,1715007842.261 [DataOverHttps](IMPORTANT): SBD MTMSN=20240506T150401 2024-05-06T15:04:09.668Z,1715007849.668 [DataOverHttps](INFO): Received command: ibit 2024-05-06T15:04:09.693Z,1715007849.693 [CommandExec](IMPORTANT): got command ibit 2024-05-06T15:04:10.068Z,1715007850.068 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-05-06T15:04:10.068Z,1715007850.068 [IBIT](IMPORTANT): Beginning control surface checks. 2024-05-06T15:04:10.071Z,1715007850.071 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-06T15:04:10.669Z,1715007850.669 [DataOverHttps](IMPORTANT): SBD MTMSN=20240506T150409 2024-05-06T15:04:11.665Z,1715007851.665 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150409.00,A,3648.13857,N,12147.23058,W,0.000,78.04,060524,,,D*42 2024-05-06T15:04:11.667Z,1715007851.667 [NAL9602](INFO): GPS fix at 20240506T150409: (36.802309, -121.787176) 2024-05-06T15:04:18.552Z,1715007858.552 [DataOverHttps](INFO): Received command: failc 2024-05-06T15:04:18.553Z,1715007858.553 [CommandExec](IMPORTANT): got command failComponent 2024-05-06T15:04:18.553Z,1715007858.553 [CommandExec](IMPORTANT): Failed components: 2024-05-06T15:04:18.554Z,1715007858.554 [CommandExec](IMPORTANT): No failed Components. 2024-05-06T15:04:18.978Z,1715007858.978 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:04:18.978Z,1715007858.978 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:04:19.049Z,1715007859.049 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:04:19.460Z,1715007859.460 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:04:19.460Z,1715007859.460 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:04:21.074Z,1715007861.074 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.000286 CHAN A1 (24V): 0.001924 CHAN A2 (12V): 0.000381 CHAN A3 (5V): -0.000863 CHAN B0 (3.3V): -0.000187 CHAN B1 (3.15aV): 0.000184 CHAN B2 (3.15bV): 0.000249 CHAN B3 (GND): -0.000427 OPEN: 0.007771 Full Scale: +/- 1 mA 2024-05-06T15:04:26.638Z,1715007866.638 [NAL9602](INFO): SBD MO Status=0, MOMSN=13545, MT Status=0, MTMSN=0 2024-05-06T15:04:26.638Z,1715007866.638 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:04:27.855Z,1715007867.855 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150426.00,A,3648.13863,N,12147.22922,W,0.039,78.04,060524,,,D*47 2024-05-06T15:04:27.857Z,1715007867.857 [NAL9602](INFO): GPS fix at 20240506T150426: (36.802310, -121.787154) 2024-05-06T15:04:31.079Z,1715007871.079 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150429.00,A,3648.13865,N,12147.22917,W,0.019,78.04,060524,,,D*4A 2024-05-06T15:04:31.082Z,1715007871.082 [NAL9602](INFO): GPS fix at 20240506T150429: (36.802311, -121.787153) 2024-05-06T15:04:33.907Z,1715007873.907 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150432.00,A,3648.13873,N,12147.22905,W,0.000,78.04,060524,,,D*4C 2024-05-06T15:04:33.910Z,1715007873.910 [NAL9602](INFO): GPS fix at 20240506T150432: (36.802312, -121.787151) 2024-05-06T15:04:37.139Z,1715007877.139 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150435.00,A,3648.13870,N,12147.22893,W,0.019,78.04,060524,,,D*4E 2024-05-06T15:04:37.142Z,1715007877.142 [NAL9602](INFO): GPS fix at 20240506T150435: (36.802312, -121.787149) 2024-05-06T15:04:39.975Z,1715007879.975 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150438.00,A,3648.13869,N,12147.22886,W,0.039,78.04,060524,,,D*4D 2024-05-06T15:04:39.978Z,1715007879.978 [NAL9602](INFO): GPS fix at 20240506T150438: (36.802312, -121.787148) 2024-05-06T15:04:43.200Z,1715007883.200 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150441.00,A,3648.13879,N,12147.22875,W,0.000,78.04,060524,,,D*44 2024-05-06T15:04:43.202Z,1715007883.202 [NAL9602](INFO): GPS fix at 20240506T150441: (36.802313, -121.787146) 2024-05-06T15:04:46.043Z,1715007886.043 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150444.00,A,3648.13895,N,12147.22853,W,0.019,78.04,060524,,,D*4F 2024-05-06T15:04:46.045Z,1715007886.045 [NAL9602](INFO): GPS fix at 20240506T150444: (36.802316, -121.787142) 2024-05-06T15:04:48.915Z,1715007888.915 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150447.00,A,3648.13903,N,12147.22842,W,0.019,78.04,060524,,,D*42 2024-05-06T15:04:48.918Z,1715007888.918 [NAL9602](INFO): GPS fix at 20240506T150447: (36.802317, -121.787140) 2024-05-06T15:04:52.150Z,1715007892.150 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150450.00,A,3648.13910,N,12147.22844,W,0.019,78.04,060524,,,D*40 2024-05-06T15:04:52.152Z,1715007892.152 [NAL9602](INFO): GPS fix at 20240506T150450: (36.802318, -121.787141) 2024-05-06T15:04:54.964Z,1715007894.964 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150453.00,A,3648.13917,N,12147.22852,W,0.019,78.04,060524,,,D*43 2024-05-06T15:04:54.966Z,1715007894.966 [NAL9602](INFO): GPS fix at 20240506T150453: (36.802320, -121.787142) 2024-05-06T15:04:56.202Z,1715007896.202 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 4 Latitude: 36.802319 Longitude: -121.787140 2024-05-06T15:04:56.613Z,1715007896.613 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active. 2024-05-06T15:04:57.037Z,1715007897.037 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-05-06T15:04:57.038Z,1715007897.038 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-05-06T15:04:57.038Z,1715007897.038 [IBIT](IMPORTANT): Pressure:9.880905 PSI 2024-05-06T15:04:57.038Z,1715007897.038 [IBIT](IMPORTANT): Humidity:20.943718 % 2024-05-06T15:04:57.412Z,1715007897.412 [IBIT](IMPORTANT): Vehicle Pitch:-0.946438 degrees 2024-05-06T15:04:57.412Z,1715007897.412 [IBIT](IMPORTANT): Vehicle Roll:-2.959834 degrees 2024-05-06T15:04:57.413Z,1715007897.413 [IBIT](IMPORTANT): Vehicle Heading:23.796352 degrees 2024-05-06T15:04:57.821Z,1715007897.821 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-05-06T15:04:57.821Z,1715007897.821 [IBIT](IMPORTANT): buoyancyNeutral: 175.634491 cc 2024-05-06T15:04:57.821Z,1715007897.821 [IBIT](IMPORTANT): massDefault: 1.599663 cm 2024-05-06T15:04:57.822Z,1715007897.822 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2024-05-06T15:04:57.822Z,1715007897.822 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2024-05-06T15:04:57.822Z,1715007897.822 [IBIT](IMPORTANT): IBIT PASSED 2024-05-06T15:04:58.206Z,1715007898.206 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:04:58.206Z,1715007898.206 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:04:58.207Z,1715007898.207 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:04:58.207Z,1715007898.207 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:04:58.619Z,1715007898.619 [Default:CheckIn:D] Stopped 2024-05-06T15:04:58.619Z,1715007898.619 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.358604 min 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn:E] Stopped 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn] Stopped 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn](INFO): Running loop #2 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn] Running Loop=2 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:04:59.018Z,1715007899.018 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:05:01.029Z,1715007901.029 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,150459.00,A,3648.13918,N,12147.22872,W,0.019,78.04,060524,,,D*44 2024-05-06T15:05:01.032Z,1715007901.032 [NAL9602](INFO): GPS fix at 20240506T150459: (36.802320, -121.787145) 2024-05-06T15:05:01.047Z,1715007901.047 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:05:01.047Z,1715007901.047 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:05:07.080Z,1715007907.080 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:05:08.412Z,1715007908.412 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240506T145506/Courier0007.lzma 2024-05-06T15:05:09.414Z,1715007909.414 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0007.lzma.bak 2024-05-06T15:05:09.414Z,1715007909.414 [DataOverHttps](INFO): SBD MOMSN=19983726 2024-05-06T15:05:20.842Z,1715007920.842 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:05:25.311Z,1715007925.311 [DataOverHttps](INFO): Sending 879 bytes from file Logs/20240506T145506/Express0008.lzma 2024-05-06T15:05:26.310Z,1715007926.310 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0008.lzma.bak 2024-05-06T15:05:26.310Z,1715007926.310 [DataOverHttps](INFO): SBD MOMSN=19983729 2024-05-06T15:05:33.345Z,1715007933.345 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:05:35.365Z,1715007935.365 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:05:42.180Z,1715007942.180 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20240506T145506/Express0011.lzma 2024-05-06T15:05:43.182Z,1715007943.182 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0011.lzma.bak 2024-05-06T15:05:43.182Z,1715007943.182 [DataOverHttps](INFO): SBD MOMSN=19983757 2024-05-06T15:05:44.278Z,1715007944.278 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:05:44.278Z,1715007944.278 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:05:44.278Z,1715007944.278 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:05:49.907Z,1715007949.907 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:06:03.645Z,1715007963.645 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:06:16.975Z,1715007976.975 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:06:30.310Z,1715007990.310 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:06:44.043Z,1715008004.043 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:06:58.237Z,1715008018.237 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:07:12.376Z,1715008032.376 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:07:20.083Z,1715008040.083 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:07:20.083Z,1715008040.083 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:07:20.106Z,1715008040.106 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:07:20.519Z,1715008040.519 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:07:20.519Z,1715008040.519 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:09:43.926Z,1715008183.926 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:09:50.791Z,1715008190.791 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:10:06.951Z,1715008206.951 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:10:21.126Z,1715008221.126 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:10:21.126Z,1715008221.126 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:10:21.181Z,1715008221.181 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:10:21.563Z,1715008221.563 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:10:21.563Z,1715008221.563 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:10:22.304Z,1715008222.304 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:10:37.657Z,1715008237.657 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:10:44.966Z,1715008244.966 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:10:44.966Z,1715008244.966 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:10:44.966Z,1715008244.966 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:10:44.966Z,1715008244.966 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:10:45.350Z,1715008245.350 [Default:CheckIn:D] Stopped 2024-05-06T15:10:45.350Z,1715008245.350 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:10:45.753Z,1715008245.753 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.137464 min 2024-05-06T15:10:45.753Z,1715008245.753 [Default:CheckIn:E] Stopped 2024-05-06T15:10:45.753Z,1715008245.753 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:10:45.753Z,1715008245.753 [Default:CheckIn] Stopped 2024-05-06T15:10:45.754Z,1715008245.754 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:10:45.754Z,1715008245.754 [Default:CheckIn](INFO): Running loop #3 2024-05-06T15:10:45.754Z,1715008245.754 [Default:CheckIn] Running Loop=3 2024-05-06T15:10:45.754Z,1715008245.754 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:10:45.754Z,1715008245.754 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:10:47.763Z,1715008247.763 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,151047.00,A,3648.13871,N,12147.23190,W,0.039,78.04,060524,,,D*46 2024-05-06T15:10:47.773Z,1715008247.773 [NAL9602](INFO): GPS fix at 20240506T151047: (36.802312, -121.787198) 2024-05-06T15:10:47.809Z,1715008247.809 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:10:47.809Z,1715008247.809 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:10:52.617Z,1715008252.617 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:10:58.424Z,1715008258.424 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0013.lzma 2024-05-06T15:10:59.426Z,1715008259.426 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0013.lzma.bak 2024-05-06T15:10:59.426Z,1715008259.426 [DataOverHttps](INFO): SBD MOMSN=19983768 2024-05-06T15:11:00.736Z,1715008260.736 [NAL9602](INFO): SBD MO Status=0, MOMSN=13546, MT Status=0, MTMSN=0 2024-05-06T15:11:00.737Z,1715008260.737 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:11:07.600Z,1715008267.600 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:11:15.292Z,1715008275.292 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20240506T145506/Express0014.lzma 2024-05-06T15:11:16.294Z,1715008276.294 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0014.lzma.bak 2024-05-06T15:11:16.294Z,1715008276.294 [DataOverHttps](INFO): SBD MOMSN=19983771 2024-05-06T15:11:17.355Z,1715008277.355 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:11:17.355Z,1715008277.355 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:11:17.355Z,1715008277.355 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:11:21.740Z,1715008281.740 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:11:31.438Z,1715008291.438 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:11:37.091Z,1715008297.091 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:11:52.039Z,1715008312.039 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:13:22.213Z,1715008402.213 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:13:22.213Z,1715008402.213 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:13:22.232Z,1715008402.232 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:13:22.639Z,1715008402.639 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:13:22.639Z,1715008402.639 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:14:34.492Z,1715008474.492 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:14:47.016Z,1715008487.016 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:14:59.579Z,1715008499.579 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:15:12.546Z,1715008512.546 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:15:21.400Z,1715008521.400 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging 2024-05-06T15:15:24.628Z,1715008524.628 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:15:36.747Z,1715008536.747 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:15:48.868Z,1715008548.868 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:16:01.391Z,1715008561.391 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:16:13.916Z,1715008573.916 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:16:17.971Z,1715008577.971 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:16:17.971Z,1715008577.971 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:16:17.971Z,1715008577.971 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:16:17.971Z,1715008577.971 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:16:18.376Z,1715008578.376 [Default:CheckIn:D] Stopped 2024-05-06T15:16:18.376Z,1715008578.376 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:16:18.791Z,1715008578.791 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 17.687897 min 2024-05-06T15:16:18.791Z,1715008578.791 [Default:CheckIn:E] Stopped 2024-05-06T15:16:18.791Z,1715008578.791 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:16:18.792Z,1715008578.792 [Default:CheckIn] Stopped 2024-05-06T15:16:18.792Z,1715008578.792 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:16:18.796Z,1715008578.796 [Default:CheckIn](INFO): Running loop #4 2024-05-06T15:16:18.796Z,1715008578.796 [Default:CheckIn] Running Loop=4 2024-05-06T15:16:18.796Z,1715008578.796 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:16:18.796Z,1715008578.796 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:16:20.787Z,1715008580.787 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,151620.00,A,3648.13755,N,12147.23138,W,0.039,78.04,060524,,,D*4A 2024-05-06T15:16:20.789Z,1715008580.789 [NAL9602](INFO): GPS fix at 20240506T151620: (36.802293, -121.787190) 2024-05-06T15:16:20.825Z,1715008580.825 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:16:20.825Z,1715008580.825 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:16:23.242Z,1715008583.242 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:16:23.242Z,1715008583.242 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:16:23.254Z,1715008583.254 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:16:23.664Z,1715008583.664 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:16:23.664Z,1715008583.664 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:16:26.037Z,1715008586.037 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:16:27.771Z,1715008587.771 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20240506T145506/Courier0016.lzma 2024-05-06T15:16:28.774Z,1715008588.774 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0016.lzma.bak 2024-05-06T15:16:28.774Z,1715008588.774 [DataOverHttps](INFO): SBD MOMSN=19983786 2024-05-06T15:16:32.511Z,1715008592.511 [NAL9602](INFO): SBD MO Status=0, MOMSN=13547, MT Status=0, MTMSN=0 2024-05-06T15:16:32.511Z,1715008592.511 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:16:38.560Z,1715008598.560 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:16:44.608Z,1715008604.608 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240506T145506/Express0017.lzma 2024-05-06T15:16:45.606Z,1715008605.606 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0017.lzma.bak 2024-05-06T15:16:45.606Z,1715008605.606 [DataOverHttps](INFO): SBD MOMSN=19983789 2024-05-06T15:16:46.654Z,1715008606.654 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:16:46.654Z,1715008606.654 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:16:46.654Z,1715008606.654 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:17:03.274Z,1715008623.274 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:19:16.652Z,1715008756.652 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:19:24.371Z,1715008764.371 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:19:24.371Z,1715008764.371 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:19:24.386Z,1715008764.386 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:19:24.764Z,1715008764.764 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:19:24.764Z,1715008764.764 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:19:31.601Z,1715008771.601 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:19:47.356Z,1715008787.356 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:20:03.112Z,1715008803.112 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:20:18.464Z,1715008818.464 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:20:33.414Z,1715008833.414 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:20:48.766Z,1715008848.766 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:21:04.548Z,1715008864.548 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:21:19.899Z,1715008879.899 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:21:47.421Z,1715008907.421 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:21:47.421Z,1715008907.421 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:21:47.421Z,1715008907.421 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:21:47.422Z,1715008907.422 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:21:47.811Z,1715008907.811 [Default:CheckIn:D] Stopped 2024-05-06T15:21:47.811Z,1715008907.811 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:21:48.223Z,1715008908.223 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.178473 min 2024-05-06T15:21:48.223Z,1715008908.223 [Default:CheckIn:E] Stopped 2024-05-06T15:21:48.223Z,1715008908.223 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:21:48.223Z,1715008908.223 [Default:CheckIn] Stopped 2024-05-06T15:21:48.223Z,1715008908.223 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:21:48.224Z,1715008908.224 [Default:CheckIn](INFO): Running loop #5 2024-05-06T15:21:48.224Z,1715008908.224 [Default:CheckIn] Running Loop=5 2024-05-06T15:21:48.224Z,1715008908.224 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:21:48.224Z,1715008908.224 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:21:50.206Z,1715008910.206 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152149.00,A,3648.13887,N,12147.22962,W,0.019,78.04,060524,,,D*45 2024-05-06T15:21:50.208Z,1715008910.208 [NAL9602](INFO): GPS fix at 20240506T152149: (36.802315, -121.787160) 2024-05-06T15:21:50.223Z,1715008910.223 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:21:50.223Z,1715008910.223 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:21:51.023Z,1715008911.023 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:21:51.023Z,1715008911.023 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:21:51.023Z,1715008911.023 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:22:06.371Z,1715008926.371 [NAL9602](INFO): SBD MO Status=0, MOMSN=13548, MT Status=0, MTMSN=0 2024-05-06T15:22:06.371Z,1715008926.371 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:22:25.382Z,1715008945.382 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:22:25.382Z,1715008945.382 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:22:25.407Z,1715008945.407 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:22:25.820Z,1715008945.820 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:22:25.820Z,1715008945.820 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:22:37.089Z,1715008957.089 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:24:04.339Z,1715009044.339 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:24:18.075Z,1715009058.075 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:24:31.408Z,1715009071.408 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:24:44.739Z,1715009084.739 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:24:58.074Z,1715009098.074 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:25:11.404Z,1715009111.404 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:25:25.139Z,1715009125.139 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:25:26.377Z,1715009126.377 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:25:26.377Z,1715009126.377 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:25:26.388Z,1715009126.388 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:25:26.815Z,1715009126.815 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:25:26.815Z,1715009126.815 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:25:38.471Z,1715009138.471 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:25:51.805Z,1715009151.805 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:26:05.136Z,1715009165.136 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T15:26:17.660Z,1715009177.660 [BPC1](INFO): Calculating totals. Valid battery stick count: 24. Valid reserve battery stick count: 3. 2024-05-06T15:26:17.664Z,1715009177.664 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-05-06T15:26:51.623Z,1715009211.623 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:26:51.623Z,1715009211.623 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:26:51.623Z,1715009211.623 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:26:51.623Z,1715009211.623 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:26:52.038Z,1715009212.038 [Default:CheckIn:D] Stopped 2024-05-06T15:26:52.039Z,1715009212.039 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:26:52.426Z,1715009212.426 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 28.248932 min 2024-05-06T15:26:52.426Z,1715009212.426 [Default:CheckIn:E] Stopped 2024-05-06T15:26:52.426Z,1715009212.426 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:26:52.427Z,1715009212.427 [Default:CheckIn] Stopped 2024-05-06T15:26:52.427Z,1715009212.427 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:26:52.427Z,1715009212.427 [Default:CheckIn](INFO): Running loop #6 2024-05-06T15:26:52.427Z,1715009212.427 [Default:CheckIn] Running Loop=6 2024-05-06T15:26:52.427Z,1715009212.427 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:26:52.427Z,1715009212.427 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:26:54.431Z,1715009214.431 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152653.00,A,3648.15058,N,12147.22333,W,0.019,22.25,060524,,,D*47 2024-05-06T15:26:54.434Z,1715009214.434 [NAL9602](INFO): GPS fix at 20240506T152653: (36.802510, -121.787055) 2024-05-06T15:26:54.462Z,1715009214.462 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:26:54.462Z,1715009214.462 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:27:01.724Z,1715009221.724 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0019.lzma 2024-05-06T15:27:02.726Z,1715009222.726 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0019.lzma.bak 2024-05-06T15:27:02.726Z,1715009222.726 [DataOverHttps](INFO): SBD MOMSN=19983812 2024-05-06T15:27:18.644Z,1715009238.644 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240506T145506/Courier0022.lzma 2024-05-06T15:27:19.646Z,1715009239.646 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0022.lzma.bak 2024-05-06T15:27:19.646Z,1715009239.646 [DataOverHttps](INFO): SBD MOMSN=19983815 2024-05-06T15:27:26.751Z,1715009246.751 [NAL9602](INFO): SBD MO Status=2, MOMSN=13549, MT Status=2, MTMSN=0 2024-05-06T15:27:26.751Z,1715009246.751 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-05-06T15:27:35.596Z,1715009255.596 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240506T145506/Express0020.lzma 2024-05-06T15:27:36.598Z,1715009256.598 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0020.lzma.bak 2024-05-06T15:27:36.598Z,1715009256.598 [DataOverHttps](INFO): SBD MOMSN=19983818 2024-05-06T15:27:52.512Z,1715009272.512 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20240506T145506/Express0023.lzma 2024-05-06T15:27:53.514Z,1715009273.514 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0023.lzma.bak 2024-05-06T15:27:53.514Z,1715009273.514 [DataOverHttps](INFO): SBD MOMSN=19983821 2024-05-06T15:27:54.635Z,1715009274.635 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:27:54.635Z,1715009274.635 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:27:54.635Z,1715009274.635 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:27:55.838Z,1715009275.838 [NAL9602](INFO): SBD MO Status=0, MOMSN=13549, MT Status=0, MTMSN=0 2024-05-06T15:27:55.839Z,1715009275.839 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:28:26.542Z,1715009306.542 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:28:27.381Z,1715009307.381 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:28:27.381Z,1715009307.381 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:28:27.396Z,1715009307.396 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:28:27.800Z,1715009307.800 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:28:27.800Z,1715009307.800 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:31:28.402Z,1715009488.402 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:31:28.402Z,1715009488.402 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:31:28.423Z,1715009488.423 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:31:28.788Z,1715009488.788 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:31:28.788Z,1715009488.788 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:32:55.259Z,1715009575.259 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:32:55.259Z,1715009575.259 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:32:55.259Z,1715009575.259 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:32:55.259Z,1715009575.259 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:32:55.678Z,1715009575.678 [Default:CheckIn:D] Stopped 2024-05-06T15:32:55.678Z,1715009575.678 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:32:56.048Z,1715009576.048 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.309591 min 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn:E] Stopped 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn] Stopped 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn](INFO): Running loop #7 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn] Running Loop=7 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:32:56.049Z,1715009576.049 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:32:58.068Z,1715009578.068 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,153257.00,A,3648.15015,N,12147.21965,W,0.058,22.25,060524,,,D*40 2024-05-06T15:32:58.070Z,1715009578.070 [NAL9602](INFO): GPS fix at 20240506T153257: (36.802503, -121.786994) 2024-05-06T15:32:58.086Z,1715009578.086 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:32:58.086Z,1715009578.086 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:33:04.960Z,1715009584.960 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0025.lzma 2024-05-06T15:33:05.963Z,1715009585.963 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0025.lzma.bak 2024-05-06T15:33:05.963Z,1715009585.963 [DataOverHttps](INFO): SBD MOMSN=19983838 2024-05-06T15:33:21.864Z,1715009601.864 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240506T145506/Express0026.lzma 2024-05-06T15:33:22.862Z,1715009602.862 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0026.lzma.bak 2024-05-06T15:33:22.862Z,1715009602.862 [DataOverHttps](INFO): SBD MOMSN=19983841 2024-05-06T15:33:23.927Z,1715009603.927 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:33:23.927Z,1715009603.927 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:33:23.927Z,1715009603.927 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:33:31.584Z,1715009611.584 [NAL9602](INFO): SBD MO Status=0, MOMSN=13550, MT Status=0, MTMSN=0 2024-05-06T15:33:31.584Z,1715009611.584 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:34:02.290Z,1715009642.290 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:34:29.382Z,1715009669.382 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:34:29.382Z,1715009669.382 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:34:29.429Z,1715009669.429 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:34:29.831Z,1715009669.831 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:34:29.831Z,1715009669.831 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:37:30.398Z,1715009850.398 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:37:30.398Z,1715009850.398 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:37:30.440Z,1715009850.440 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:37:30.795Z,1715009850.795 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:37:30.795Z,1715009850.795 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:38:24.500Z,1715009904.500 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:38:24.500Z,1715009904.500 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:38:24.500Z,1715009904.500 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:38:24.500Z,1715009904.500 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:38:24.910Z,1715009904.910 [Default:CheckIn:D] Stopped 2024-05-06T15:38:24.910Z,1715009904.910 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:38:25.325Z,1715009905.325 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.796794 min 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn:E] Stopped 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn] Stopped 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn](INFO): Running loop #8 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn] Running Loop=8 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:38:25.326Z,1715009905.326 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:38:27.323Z,1715009907.323 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,153826.00,A,3648.15032,N,12147.21995,W,0.019,22.25,060524,,,D*43 2024-05-06T15:38:27.325Z,1715009907.325 [NAL9602](INFO): GPS fix at 20240506T153826: (36.802505, -121.786999) 2024-05-06T15:38:27.361Z,1715009907.361 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:38:27.361Z,1715009907.361 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:38:34.396Z,1715009914.396 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0028.lzma 2024-05-06T15:38:35.398Z,1715009915.398 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0028.lzma.bak 2024-05-06T15:38:35.398Z,1715009915.398 [DataOverHttps](INFO): SBD MOMSN=19983851 2024-05-06T15:38:46.304Z,1715009926.304 [NAL9602](INFO): SBD MO Status=0, MOMSN=13551, MT Status=0, MTMSN=0 2024-05-06T15:38:46.304Z,1715009926.304 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:38:53.952Z,1715009933.952 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240506T145506/Express0029.lzma 2024-05-06T15:38:54.954Z,1715009934.954 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0029.lzma.bak 2024-05-06T15:38:54.955Z,1715009934.955 [DataOverHttps](INFO): SBD MOMSN=19983854 2024-05-06T15:38:56.071Z,1715009936.071 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:38:56.071Z,1715009936.071 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:38:56.071Z,1715009936.071 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:39:17.061Z,1715009957.061 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:39:26.077Z,1715009966.077 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-05-06T15:40:27.746Z,1715010027.746 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-05-06T15:40:31.426Z,1715010031.426 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:40:31.426Z,1715010031.426 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:40:31.469Z,1715010031.469 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:40:31.850Z,1715010031.850 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:40:31.850Z,1715010031.850 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:43:32.402Z,1715010212.402 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:43:32.402Z,1715010212.402 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:43:32.413Z,1715010212.413 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:43:32.843Z,1715010212.843 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:43:32.843Z,1715010212.843 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:43:56.644Z,1715010236.644 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:43:56.644Z,1715010236.644 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:43:56.644Z,1715010236.644 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:43:56.644Z,1715010236.644 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:43:57.038Z,1715010237.038 [Default:CheckIn:D] Stopped 2024-05-06T15:43:57.038Z,1715010237.038 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:43:57.446Z,1715010237.446 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 45.332259 min 2024-05-06T15:43:57.446Z,1715010237.446 [Default:CheckIn:E] Stopped 2024-05-06T15:43:57.446Z,1715010237.446 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:43:57.446Z,1715010237.446 [Default:CheckIn] Stopped 2024-05-06T15:43:57.447Z,1715010237.447 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:43:57.447Z,1715010237.447 [Default:CheckIn](INFO): Running loop #9 2024-05-06T15:43:57.447Z,1715010237.447 [Default:CheckIn] Running Loop=9 2024-05-06T15:43:57.447Z,1715010237.447 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:43:57.447Z,1715010237.447 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:43:59.452Z,1715010239.452 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,154358.00,A,3648.14975,N,12147.22082,W,0.117,22.25,060524,,,D*4E 2024-05-06T15:43:59.454Z,1715010239.454 [NAL9602](INFO): GPS fix at 20240506T154358: (36.802496, -121.787014) 2024-05-06T15:43:59.470Z,1715010239.470 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:43:59.470Z,1715010239.470 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:44:06.724Z,1715010246.724 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0031.lzma 2024-05-06T15:44:07.726Z,1715010247.726 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0031.lzma.bak 2024-05-06T15:44:07.726Z,1715010247.726 [DataOverHttps](INFO): SBD MOMSN=19983870 2024-05-06T15:44:23.640Z,1715010263.640 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20240506T145506/Express0032.lzma 2024-05-06T15:44:24.642Z,1715010264.642 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0032.lzma.bak 2024-05-06T15:44:24.642Z,1715010264.642 [DataOverHttps](INFO): SBD MOMSN=19983873 2024-05-06T15:44:25.731Z,1715010265.731 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:44:25.731Z,1715010265.731 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:44:25.731Z,1715010265.731 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:44:46.719Z,1715010286.719 [NAL9602](INFO): SBD MO Status=0, MOMSN=13552, MT Status=0, MTMSN=0 2024-05-06T15:44:46.719Z,1715010286.719 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:45:17.425Z,1715010317.425 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:46:33.394Z,1715010393.394 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:46:33.394Z,1715010393.394 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:46:33.405Z,1715010393.405 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:46:33.814Z,1715010393.814 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:46:33.814Z,1715010393.814 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:49:26.318Z,1715010566.318 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:49:26.318Z,1715010566.318 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:49:26.318Z,1715010566.318 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:49:26.318Z,1715010566.318 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:49:26.707Z,1715010566.707 [Default:CheckIn:D] Stopped 2024-05-06T15:49:26.707Z,1715010566.707 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:49:27.108Z,1715010567.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.826733 min 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn:E] Stopped 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn] Stopped 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn](INFO): Running loop #10 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn] Running Loop=10 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:49:27.109Z,1715010567.109 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:49:29.119Z,1715010569.119 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,154928.00,A,3648.14916,N,12147.22058,W,0.039,22.25,060524,,,D*4C 2024-05-06T15:49:29.129Z,1715010569.129 [NAL9602](INFO): GPS fix at 20240506T154928: (36.802486, -121.787010) 2024-05-06T15:49:29.144Z,1715010569.144 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:49:29.144Z,1715010569.144 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:49:34.401Z,1715010574.401 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:49:34.401Z,1715010574.401 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:49:34.420Z,1715010574.420 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:49:34.831Z,1715010574.831 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:49:34.831Z,1715010574.831 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:49:36.147Z,1715010576.147 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20240506T145506/Courier0034.lzma 2024-05-06T15:49:37.150Z,1715010577.150 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0034.lzma.bak 2024-05-06T15:49:37.150Z,1715010577.150 [DataOverHttps](INFO): SBD MOMSN=19983883 2024-05-06T15:49:40.427Z,1715010580.427 [NAL9602](INFO): SBD MO Status=0, MOMSN=13553, MT Status=0, MTMSN=0 2024-05-06T15:49:40.427Z,1715010580.427 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:49:54.560Z,1715010594.560 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240506T145506/Express0035.lzma 2024-05-06T15:49:55.562Z,1715010595.562 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0035.lzma.bak 2024-05-06T15:49:55.562Z,1715010595.562 [DataOverHttps](INFO): SBD MOMSN=19983889 2024-05-06T15:49:56.635Z,1715010596.635 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:49:56.635Z,1715010596.635 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:49:56.635Z,1715010596.635 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:50:11.157Z,1715010611.157 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:52:35.397Z,1715010755.397 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:52:35.397Z,1715010755.397 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:52:35.436Z,1715010755.436 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:52:35.807Z,1715010755.807 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:52:35.807Z,1715010755.807 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T15:54:57.218Z,1715010897.218 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T15:54:57.218Z,1715010897.218 [Default:CheckIn:C.Wait] Stopped 2024-05-06T15:54:57.218Z,1715010897.218 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T15:54:57.219Z,1715010897.219 [Default:CheckIn:D] Running Loop=1 2024-05-06T15:54:57.610Z,1715010897.610 [Default:CheckIn:D] Stopped 2024-05-06T15:54:57.610Z,1715010897.610 [Default:CheckIn:E] Running Loop=1 2024-05-06T15:54:58.014Z,1715010898.014 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.341793 min 2024-05-06T15:54:58.014Z,1715010898.014 [Default:CheckIn:E] Stopped 2024-05-06T15:54:58.014Z,1715010898.014 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T15:54:58.014Z,1715010898.014 [Default:CheckIn] Stopped 2024-05-06T15:54:58.015Z,1715010898.015 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T15:54:58.015Z,1715010898.015 [Default:CheckIn](INFO): Running loop #11 2024-05-06T15:54:58.015Z,1715010898.015 [Default:CheckIn] Running Loop=11 2024-05-06T15:54:58.015Z,1715010898.015 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T15:54:58.015Z,1715010898.015 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T15:55:00.015Z,1715010900.015 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155459.00,A,3648.15025,N,12147.22049,W,0.078,22.25,060524,,,D*4B 2024-05-06T15:55:00.025Z,1715010900.025 [NAL9602](INFO): GPS fix at 20240506T155459: (36.802504, -121.787008) 2024-05-06T15:55:00.041Z,1715010900.041 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T15:55:00.041Z,1715010900.041 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T15:55:06.960Z,1715010906.960 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0037.lzma 2024-05-06T15:55:07.962Z,1715010907.962 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0037.lzma.bak 2024-05-06T15:55:07.962Z,1715010907.962 [DataOverHttps](INFO): SBD MOMSN=19983903 2024-05-06T15:55:23.838Z,1715010923.838 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240506T145506/Express0038.lzma 2024-05-06T15:55:24.658Z,1715010924.658 [NAL9602](INFO): SBD MO Status=2, MOMSN=13554, MT Status=2, MTMSN=0 2024-05-06T15:55:24.659Z,1715010924.659 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-05-06T15:55:24.834Z,1715010924.834 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0038.lzma.bak 2024-05-06T15:55:24.834Z,1715010924.834 [DataOverHttps](INFO): SBD MOMSN=19983912 2024-05-06T15:55:25.882Z,1715010925.882 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T15:55:25.882Z,1715010925.882 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T15:55:25.882Z,1715010925.882 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T15:55:33.551Z,1715010933.551 [NAL9602](INFO): SBD MO Status=0, MOMSN=13554, MT Status=0, MTMSN=0 2024-05-06T15:55:33.551Z,1715010933.551 [NAL9602](INFO): No messages in MT queue 2024-05-06T15:55:36.386Z,1715010936.386 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T15:55:36.387Z,1715010936.387 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:55:36.398Z,1715010936.398 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:55:36.811Z,1715010936.811 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:55:36.811Z,1715010936.811 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T15:56:04.253Z,1715010964.253 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T15:58:37.386Z,1715011117.386 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T15:58:37.386Z,1715011117.386 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T15:58:37.397Z,1715011117.397 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T15:58:37.803Z,1715011117.803 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T15:58:37.803Z,1715011117.803 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T16:00:26.460Z,1715011226.460 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:00:26.460Z,1715011226.460 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:00:26.460Z,1715011226.460 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:00:26.461Z,1715011226.461 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:00:26.874Z,1715011226.874 [Default:CheckIn:D] Stopped 2024-05-06T16:00:26.874Z,1715011226.874 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:00:27.267Z,1715011227.267 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.829529 min 2024-05-06T16:00:27.267Z,1715011227.267 [Default:CheckIn:E] Stopped 2024-05-06T16:00:27.267Z,1715011227.267 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:00:27.267Z,1715011227.267 [Default:CheckIn] Stopped 2024-05-06T16:00:27.268Z,1715011227.268 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:00:27.280Z,1715011227.280 [Default:CheckIn](INFO): Running loop #12 2024-05-06T16:00:27.280Z,1715011227.280 [Default:CheckIn] Running Loop=12 2024-05-06T16:00:27.281Z,1715011227.281 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:00:27.281Z,1715011227.281 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:00:29.283Z,1715011229.283 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160028.00,A,3648.15062,N,12147.22003,W,0.058,22.25,060524,,,D*40 2024-05-06T16:00:29.285Z,1715011229.285 [NAL9602](INFO): GPS fix at 20240506T160028: (36.802510, -121.787001) 2024-05-06T16:00:29.329Z,1715011229.329 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:00:29.329Z,1715011229.329 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:00:36.268Z,1715011236.268 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0040.lzma 2024-05-06T16:00:37.270Z,1715011237.270 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0040.lzma.bak 2024-05-06T16:00:37.270Z,1715011237.270 [DataOverHttps](INFO): SBD MOMSN=19983919 2024-05-06T16:00:55.750Z,1715011255.750 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20240506T145506/Express0041.lzma 2024-05-06T16:00:56.751Z,1715011256.751 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0041.lzma.bak 2024-05-06T16:00:56.751Z,1715011256.751 [DataOverHttps](INFO): SBD MOMSN=19983925 2024-05-06T16:00:57.216Z,1715011257.216 [NAL9602](INFO): SBD MO Status=2, MOMSN=13555, MT Status=2, MTMSN=0 2024-05-06T16:00:57.216Z,1715011257.216 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-05-06T16:00:58.062Z,1715011258.062 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:00:58.062Z,1715011258.062 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:00:58.062Z,1715011258.062 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:01:24.290Z,1715011284.290 [NAL9602](INFO): SBD MO Status=0, MOMSN=13555, MT Status=0, MTMSN=0 2024-05-06T16:01:24.291Z,1715011284.291 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:01:38.452Z,1715011298.452 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T16:01:38.453Z,1715011298.453 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:01:38.468Z,1715011298.468 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:01:38.847Z,1715011298.847 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:01:38.847Z,1715011298.847 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T16:01:54.989Z,1715011314.989 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:04:39.425Z,1715011479.425 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T16:04:39.425Z,1715011479.425 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:04:39.436Z,1715011479.436 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:04:39.847Z,1715011479.847 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:04:39.847Z,1715011479.847 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T16:05:58.610Z,1715011558.610 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:05:58.610Z,1715011558.610 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:05:58.610Z,1715011558.610 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:05:58.610Z,1715011558.610 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:05:59.015Z,1715011559.015 [Default:CheckIn:D] Stopped 2024-05-06T16:05:59.015Z,1715011559.015 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.365214 min 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn:E] Stopped 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn] Stopped 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn](INFO): Running loop #13 2024-05-06T16:05:59.421Z,1715011559.421 [Default:CheckIn] Running Loop=13 2024-05-06T16:05:59.422Z,1715011559.422 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:05:59.422Z,1715011559.422 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:06:01.427Z,1715011561.427 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160600.00,A,3648.36176,N,12147.12011,W,3.538,0.50,060524,,,D*7B 2024-05-06T16:06:01.429Z,1715011561.429 [NAL9602](INFO): GPS fix at 20240506T160600: (36.806029, -121.785335) 2024-05-06T16:06:01.459Z,1715011561.459 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:06:01.459Z,1715011561.459 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:06:09.192Z,1715011569.192 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20240506T145506/Courier0043.lzma 2024-05-06T16:06:10.194Z,1715011570.194 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0043.lzma.bak 2024-05-06T16:06:10.194Z,1715011570.194 [DataOverHttps](INFO): SBD MOMSN=19983941 2024-05-06T16:06:13.151Z,1715011573.151 [NAL9602](INFO): SBD MO Status=0, MOMSN=13556, MT Status=0, MTMSN=0 2024-05-06T16:06:13.151Z,1715011573.151 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:06:26.037Z,1715011586.037 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240506T145506/Express0044.lzma 2024-05-06T16:06:27.038Z,1715011587.038 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0044.lzma.bak 2024-05-06T16:06:27.038Z,1715011587.038 [DataOverHttps](INFO): SBD MOMSN=19983944 2024-05-06T16:06:28.122Z,1715011588.122 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:06:28.123Z,1715011588.123 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:06:28.123Z,1715011588.123 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:06:43.854Z,1715011603.854 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:07:40.419Z,1715011660.419 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T16:07:40.419Z,1715011660.419 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:07:40.430Z,1715011660.430 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:07:40.838Z,1715011660.838 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:07:40.838Z,1715011660.838 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T16:10:41.410Z,1715011841.410 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T16:10:41.410Z,1715011841.410 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:10:41.421Z,1715011841.421 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:10:41.831Z,1715011841.831 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:10:41.831Z,1715011841.831 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T16:11:28.690Z,1715011888.690 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:11:28.690Z,1715011888.690 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:11:28.690Z,1715011888.690 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:11:28.691Z,1715011888.691 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:11:29.110Z,1715011889.110 [Default:CheckIn:D] Stopped 2024-05-06T16:11:29.110Z,1715011889.110 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:11:29.490Z,1715011889.490 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.866797 min 2024-05-06T16:11:29.490Z,1715011889.490 [Default:CheckIn:E] Stopped 2024-05-06T16:11:29.490Z,1715011889.490 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:11:29.490Z,1715011889.490 [Default:CheckIn] Stopped 2024-05-06T16:11:29.491Z,1715011889.491 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:11:29.491Z,1715011889.491 [Default:CheckIn](INFO): Running loop #14 2024-05-06T16:11:29.491Z,1715011889.491 [Default:CheckIn] Running Loop=14 2024-05-06T16:11:29.491Z,1715011889.491 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:11:29.491Z,1715011889.491 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:11:31.497Z,1715011891.497 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161130.00,A,3648.33328,N,12147.64230,W,15.298,270.51,060524,,,D*4C 2024-05-06T16:11:31.499Z,1715011891.499 [NAL9602](INFO): GPS fix at 20240506T161130: (36.805555, -121.794038) 2024-05-06T16:11:31.514Z,1715011891.514 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:11:31.514Z,1715011891.514 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:11:38.472Z,1715011898.472 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0046.lzma 2024-05-06T16:11:39.474Z,1715011899.474 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0046.lzma.bak 2024-05-06T16:11:39.474Z,1715011899.474 [DataOverHttps](INFO): SBD MOMSN=19983980 2024-05-06T16:11:46.846Z,1715011906.846 [NAL9602](INFO): SBD MO Status=0, MOMSN=13557, MT Status=0, MTMSN=0 2024-05-06T16:11:46.846Z,1715011906.846 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:11:55.284Z,1715011915.284 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20240506T145506/Express0047.lzma 2024-05-06T16:11:56.286Z,1715011916.286 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0047.lzma.bak 2024-05-06T16:11:56.286Z,1715011916.286 [DataOverHttps](INFO): SBD MOMSN=19983985 2024-05-06T16:11:57.370Z,1715011917.370 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:11:57.370Z,1715011917.370 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:11:57.370Z,1715011917.370 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:12:17.553Z,1715011937.553 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:13:42.405Z,1715012022.405 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T16:13:42.405Z,1715012022.405 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:13:42.432Z,1715012022.432 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:13:42.822Z,1715012022.822 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:13:42.823Z,1715012022.823 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T16:16:43.409Z,1715012203.409 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T16:16:43.409Z,1715012203.409 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:16:43.420Z,1715012203.420 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:16:43.831Z,1715012203.831 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:16:43.831Z,1715012203.831 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T16:16:57.949Z,1715012217.949 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:16:57.949Z,1715012217.949 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:16:57.949Z,1715012217.949 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:16:57.949Z,1715012217.949 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:16:58.366Z,1715012218.366 [Default:CheckIn:D] Stopped 2024-05-06T16:16:58.366Z,1715012218.366 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:16:58.751Z,1715012218.751 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 78.354386 min 2024-05-06T16:16:58.751Z,1715012218.751 [Default:CheckIn:E] Stopped 2024-05-06T16:16:58.751Z,1715012218.751 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:16:58.751Z,1715012218.751 [Default:CheckIn] Stopped 2024-05-06T16:16:58.752Z,1715012218.752 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:16:58.752Z,1715012218.752 [Default:CheckIn](INFO): Running loop #15 2024-05-06T16:16:58.752Z,1715012218.752 [Default:CheckIn] Running Loop=15 2024-05-06T16:16:58.752Z,1715012218.752 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:16:58.752Z,1715012218.752 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:17:00.766Z,1715012220.766 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,161700.00,A,3648.22229,N,12149.38668,W,17.475,254.43,060524,,,D*45 2024-05-06T16:17:00.768Z,1715012220.768 [NAL9602](INFO): GPS fix at 20240506T161700: (36.803705, -121.823111) 2024-05-06T16:17:00.783Z,1715012220.783 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:17:00.783Z,1715012220.783 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:17:07.796Z,1715012227.796 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20240506T145506/Courier0049.lzma 2024-05-06T16:17:08.798Z,1715012228.798 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0049.lzma.bak 2024-05-06T16:17:08.798Z,1715012228.798 [DataOverHttps](INFO): SBD MOMSN=19984043 2024-05-06T16:17:18.131Z,1715012238.131 [NAL9602](INFO): SBD MO Status=0, MOMSN=13558, MT Status=0, MTMSN=0 2024-05-06T16:17:18.131Z,1715012238.131 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:17:24.572Z,1715012244.572 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240506T145506/Express0050.lzma 2024-05-06T16:17:25.574Z,1715012245.574 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0050.lzma.bak 2024-05-06T16:17:25.574Z,1715012245.574 [DataOverHttps](INFO): SBD MOMSN=19984049 2024-05-06T16:17:26.626Z,1715012246.626 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:17:26.626Z,1715012246.626 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:17:26.626Z,1715012246.626 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:17:48.833Z,1715012268.833 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:19:44.393Z,1715012384.393 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T16:19:44.393Z,1715012384.393 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:19:44.404Z,1715012384.404 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:19:44.813Z,1715012384.813 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:19:44.813Z,1715012384.813 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T16:22:27.214Z,1715012547.214 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:22:27.214Z,1715012547.214 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:22:27.214Z,1715012547.214 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:22:27.214Z,1715012547.214 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:22:27.622Z,1715012547.622 [Default:CheckIn:D] Stopped 2024-05-06T16:22:27.622Z,1715012547.622 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:22:28.034Z,1715012548.034 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.842000 min 2024-05-06T16:22:28.034Z,1715012548.034 [Default:CheckIn:E] Stopped 2024-05-06T16:22:28.034Z,1715012548.034 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:22:28.035Z,1715012548.035 [Default:CheckIn] Stopped 2024-05-06T16:22:28.035Z,1715012548.035 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:22:28.035Z,1715012548.035 [Default:CheckIn](INFO): Running loop #16 2024-05-06T16:22:28.035Z,1715012548.035 [Default:CheckIn] Running Loop=16 2024-05-06T16:22:28.035Z,1715012548.035 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:22:28.035Z,1715012548.035 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:22:30.031Z,1715012550.031 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162229.00,A,3647.76587,N,12150.75702,W,0.739,47.28,060524,,,D*49 2024-05-06T16:22:30.033Z,1715012550.033 [NAL9602](INFO): GPS fix at 20240506T162229: (36.796098, -121.845950) 2024-05-06T16:22:30.072Z,1715012550.072 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:22:30.072Z,1715012550.072 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:22:36.981Z,1715012556.981 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0052.lzma 2024-05-06T16:22:37.982Z,1715012557.982 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0052.lzma.bak 2024-05-06T16:22:37.982Z,1715012557.982 [DataOverHttps](INFO): SBD MOMSN=19984161 2024-05-06T16:22:43.359Z,1715012563.359 [NAL9602](INFO): SBD MO Status=0, MOMSN=13559, MT Status=0, MTMSN=0 2024-05-06T16:22:43.359Z,1715012563.359 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:22:45.391Z,1715012565.391 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T16:22:45.391Z,1715012565.391 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:22:45.405Z,1715012565.405 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:22:45.812Z,1715012565.812 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:22:45.813Z,1715012565.813 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T16:22:56.496Z,1715012576.496 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240506T145506/Express0053.lzma 2024-05-06T16:22:57.498Z,1715012577.498 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0053.lzma.bak 2024-05-06T16:22:57.498Z,1715012577.498 [DataOverHttps](INFO): SBD MOMSN=19984164 2024-05-06T16:22:58.793Z,1715012578.793 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:22:58.793Z,1715012578.793 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:22:58.793Z,1715012578.793 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:23:14.104Z,1715012594.104 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:25:46.425Z,1715012746.425 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T16:25:46.425Z,1715012746.425 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:25:46.436Z,1715012746.436 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:25:46.835Z,1715012746.835 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:25:46.835Z,1715012746.835 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T16:27:25.798Z,1715012845.798 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:27:41.554Z,1715012861.554 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:27:56.499Z,1715012876.499 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2024-05-06T16:27:59.349Z,1715012879.349 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:27:59.349Z,1715012879.349 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:27:59.349Z,1715012879.349 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:27:59.349Z,1715012879.349 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:27:59.763Z,1715012879.763 [Default:CheckIn:D] Stopped 2024-05-06T16:27:59.763Z,1715012879.763 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:28:00.171Z,1715012880.171 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 89.377669 min 2024-05-06T16:28:00.171Z,1715012880.171 [Default:CheckIn:E] Stopped 2024-05-06T16:28:00.171Z,1715012880.171 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:28:00.172Z,1715012880.172 [Default:CheckIn] Stopped 2024-05-06T16:28:00.172Z,1715012880.172 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:28:00.180Z,1715012880.180 [Default:CheckIn](INFO): Running loop #17 2024-05-06T16:28:00.180Z,1715012880.180 [Default:CheckIn] Running Loop=17 2024-05-06T16:28:00.180Z,1715012880.180 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:28:00.180Z,1715012880.180 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:28:02.167Z,1715012882.167 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162801.00,A,3647.78764,N,12150.72276,W,0.661,77.17,060524,,,D*4A 2024-05-06T16:28:02.169Z,1715012882.169 [NAL9602](INFO): GPS fix at 20240506T162801: (36.796461, -121.845379) 2024-05-06T16:28:02.184Z,1715012882.184 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:28:02.184Z,1715012882.184 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:28:03.004Z,1715012883.004 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:28:03.004Z,1715012883.004 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:28:03.004Z,1715012883.004 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:28:15.504Z,1715012895.504 [NAL9602](INFO): SBD MO Status=0, MOMSN=13560, MT Status=0, MTMSN=0 2024-05-06T16:28:15.504Z,1715012895.504 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:28:46.197Z,1715012926.197 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:28:47.433Z,1715012927.433 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-05-06T16:28:47.433Z,1715012927.433 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:28:47.476Z,1715012927.476 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:28:47.855Z,1715012927.855 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:28:47.855Z,1715012927.855 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-05-06T16:30:23.559Z,1715013023.559 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:30:37.706Z,1715013037.706 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:30:51.461Z,1715013051.461 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:31:05.192Z,1715013065.192 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:31:19.319Z,1715013079.319 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:31:33.461Z,1715013093.461 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:31:46.791Z,1715013106.791 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:31:48.430Z,1715013108.430 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-05-06T16:31:48.430Z,1715013108.430 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-05-06T16:31:48.441Z,1715013108.441 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-05-06T16:31:48.852Z,1715013108.852 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-05-06T16:31:48.856Z,1715013108.856 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-05-06T16:32:00.123Z,1715013120.123 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:32:13.861Z,1715013133.861 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:32:27.191Z,1715013147.191 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:32:40.523Z,1715013160.523 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-06T16:33:03.567Z,1715013183.567 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-05-06T16:33:03.567Z,1715013183.567 [Default:CheckIn:C.Wait] Stopped 2024-05-06T16:33:03.567Z,1715013183.567 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-05-06T16:33:03.567Z,1715013183.567 [Default:CheckIn:D] Running Loop=1 2024-05-06T16:33:03.971Z,1715013183.971 [Default:CheckIn:D] Stopped 2024-05-06T16:33:03.971Z,1715013183.971 [Default:CheckIn:E] Running Loop=1 2024-05-06T16:33:04.384Z,1715013184.384 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.447811 min 2024-05-06T16:33:04.384Z,1715013184.384 [Default:CheckIn:E] Stopped 2024-05-06T16:33:04.384Z,1715013184.384 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-05-06T16:33:04.384Z,1715013184.384 [Default:CheckIn] Stopped 2024-05-06T16:33:04.384Z,1715013184.384 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-05-06T16:33:04.385Z,1715013184.385 [Default:CheckIn](INFO): Running loop #18 2024-05-06T16:33:04.385Z,1715013184.385 [Default:CheckIn] Running Loop=18 2024-05-06T16:33:04.385Z,1715013184.385 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-06T16:33:04.385Z,1715013184.385 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-06T16:33:06.391Z,1715013186.391 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,163305.00,A,3647.81247,N,12150.67746,W,0.972,66.43,060524,,,D*48 2024-05-06T16:33:06.393Z,1715013186.393 [NAL9602](INFO): GPS fix at 20240506T163305: (36.796875, -121.844624) 2024-05-06T16:33:06.422Z,1715013186.422 [Default:CheckIn:Read_GPS] Stopped 2024-05-06T16:33:06.422Z,1715013186.422 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-06T16:33:13.528Z,1715013193.528 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0055.lzma 2024-05-06T16:33:14.530Z,1715013194.530 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0055.lzma.bak 2024-05-06T16:33:14.530Z,1715013194.530 [DataOverHttps](INFO): SBD MOMSN=19984244 2024-05-06T16:33:17.293Z,1715013197.293 [NAL9602](INFO): SBD MO Status=0, MOMSN=13561, MT Status=0, MTMSN=0 2024-05-06T16:33:17.293Z,1715013197.293 [NAL9602](INFO): No messages in MT queue 2024-05-06T16:33:30.384Z,1715013210.384 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240506T145506/Courier0058.lzma 2024-05-06T16:33:31.386Z,1715013211.386 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Courier0058.lzma.bak 2024-05-06T16:33:31.386Z,1715013211.386 [DataOverHttps](INFO): SBD MOMSN=19984247 2024-05-06T16:33:47.176Z,1715013227.176 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20240506T145506/Express0056.lzma 2024-05-06T16:33:47.993Z,1715013227.993 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-06T16:33:48.178Z,1715013228.178 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0056.lzma.bak 2024-05-06T16:33:48.178Z,1715013228.178 [DataOverHttps](INFO): SBD MOMSN=19984250 2024-05-06T16:33:56.889Z,1715013236.889 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5. 2024-05-06T16:33:56.891Z,1715013236.891 [BPC1](INFO): Received data from all battery sticks. 2024-05-06T16:34:04.132Z,1715013244.132 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240506T145506/Express0059.lzma 2024-05-06T16:34:05.134Z,1715013245.134 [DataOverHttps](INFO): Moved sent file to Logs/20240506T145506/Express0059.lzma.bak 2024-05-06T16:34:05.134Z,1715013245.134 [DataOverHttps](IMPORTANT): SBD MOMSN=19984256, MTMSN=20240506T163404 2024-05-06T16:34:06.187Z,1715013246.187 [Default:CheckIn:Read_Iridium] Stopped 2024-05-06T16:34:06.187Z,1715013246.187 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-06T16:34:06.187Z,1715013246.187 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-06T16:34:12.600Z,1715013252.600 [DataOverHttps](INFO): Received command: restart logs