2024-07-30T16:52:55.963Z,1722358375.963 [Supervisor](DEBUG): Initializing supervisor.
2024-07-30T16:52:55.967Z,1722358375.967 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-07-30T16:52:55.967Z,1722358375.967 [SyncHandler](INFO): Protected caller Thread ID is 1557
2024-07-30T16:52:55.968Z,1722358375.968 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-07-30T16:52:55.976Z,1722358375.976 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-07-30T16:52:55.977Z,1722358375.977 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1558
2024-07-30T16:52:55.981Z,1722358375.981 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-07-30T16:52:56.006Z,1722358376.006 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-07-30T16:52:56.007Z,1722358376.007 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-07-30T16:52:56.008Z,1722358376.008 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1559
2024-07-30T16:52:56.012Z,1722358376.012 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-07-30T16:52:56.013Z,1722358376.013 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-07-30T16:52:56.013Z,1722358376.013 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1560
2024-07-30T16:52:56.015Z,1722358376.015 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-07-30T16:52:56.024Z,1722358376.024 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-07-30T16:52:56.025Z,1722358376.025 [logger ThreadHandler](INFO): Protected caller Thread ID is 1561
2024-07-30T16:52:56.028Z,1722358376.028 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-07-30T16:52:56.029Z,1722358376.029 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-07-30T16:52:56.030Z,1722358376.030 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-07-30T16:52:56.555Z,1722358376.555 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-07-30T16:52:56.555Z,1722358376.555 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-07-30T16:52:56.684Z,1722358376.684 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-07-30T16:52:56.867Z,1722358376.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-07-30T16:52:56.867Z,1722358376.867 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-07-30T16:52:57.073Z,1722358377.073 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-07-30T16:52:57.073Z,1722358377.073 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-07-30T16:52:57.620Z,1722358377.620 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-07-30T16:52:57.620Z,1722358377.620 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-07-30T16:52:57.779Z,1722358377.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-07-30T16:52:57.779Z,1722358377.779 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-07-30T16:52:58.403Z,1722358378.403 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-07-30T16:52:58.403Z,1722358378.403 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-07-30T16:52:58.744Z,1722358378.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-07-30T16:52:58.745Z,1722358378.745 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-07-30T16:52:58.881Z,1722358378.881 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-07-30T16:52:59.252Z,1722358379.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-07-30T16:52:59.252Z,1722358379.252 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-07-30T16:52:59.603Z,1722358379.603 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-07-30T16:52:59.603Z,1722358379.603 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-07-30T16:53:00.428Z,1722358380.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-07-30T16:53:00.428Z,1722358380.428 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-07-30T16:53:00.864Z,1722358380.864 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-07-30T16:53:00.864Z,1722358380.864 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-07-30T16:53:01.393Z,1722358381.393 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-07-30T16:53:01.394Z,1722358381.394 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-07-30T16:53:02.272Z,1722358382.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-07-30T16:53:02.273Z,1722358382.273 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-07-30T16:53:02.861Z,1722358382.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-07-30T16:53:02.863Z,1722358382.863 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2024-07-30T16:53:02.864Z,1722358382.864 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2024-07-30T16:53:02.974Z,1722358382.974 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2024-07-30T16:53:03.102Z,1722358383.102 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2024-07-30T16:53:03.197Z,1722358383.197 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2024-07-30T16:53:03.315Z,1722358383.315 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2024-07-30T16:53:03.413Z,1722358383.413 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2024-07-30T16:53:03.680Z,1722358383.680 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-07-30T16:53:03.681Z,1722358383.681 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2024-07-30T16:53:03.802Z,1722358383.802 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2024-07-30T16:53:03.911Z,1722358383.911 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2024-07-30T16:53:04.026Z,1722358384.026 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2024-07-30T16:53:04.178Z,1722358384.178 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2024-07-30T16:53:04.276Z,1722358384.276 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/
2024-07-30T16:53:04.276Z,1722358384.276 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-07-30T16:53:04.286Z,1722358384.286 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-07-30T16:53:04.403Z,1722358384.403 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-07-30T16:53:04.403Z,1722358384.403 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-07-30T16:53:04.456Z,1722358384.456 [VerticalControl](DEBUG): Construct VerticalControl.
2024-07-30T16:53:04.516Z,1722358384.516 [VerticalControl] Loaded
2024-07-30T16:53:04.516Z,1722358384.516 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-07-30T16:53:04.519Z,1722358384.519 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-07-30T16:53:04.566Z,1722358384.566 [HorizontalControl] Loaded
2024-07-30T16:53:04.566Z,1722358384.566 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-07-30T16:53:04.569Z,1722358384.569 [SpeedControl](DEBUG): Construct SpeedControl.
2024-07-30T16:53:04.572Z,1722358384.572 [SpeedControl] Loaded
2024-07-30T16:53:04.572Z,1722358384.572 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-07-30T16:53:04.575Z,1722358384.575 [LoopControl](DEBUG): Construct LoopControl.
2024-07-30T16:53:04.575Z,1722358384.575 [LoopControl] Loaded
2024-07-30T16:53:04.576Z,1722358384.576 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-07-30T16:53:04.576Z,1722358384.576 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-07-30T16:53:04.577Z,1722358384.577 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-07-30T16:53:04.632Z,1722358384.632 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-07-30T16:53:04.633Z,1722358384.633 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-07-30T16:53:05.093Z,1722358385.093 [AHRS_M2] Loaded
2024-07-30T16:53:05.094Z,1722358385.094 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-07-30T16:53:05.129Z,1722358385.129 [BackseatComponent] Loaded
2024-07-30T16:53:05.129Z,1722358385.129 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-07-30T16:53:05.131Z,1722358385.131 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0
2024-07-30T16:53:05.131Z,1722358385.131 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1643
2024-07-30T16:53:05.134Z,1722358385.134 [LcmUniversalReporter] Loaded
2024-07-30T16:53:05.134Z,1722358385.134 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-07-30T16:53:05.924Z,1722358385.924 [BPC1] Loaded
2024-07-30T16:53:05.924Z,1722358385.924 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-07-30T16:53:06.000Z,1722358386.000 [DataOverHttps] Loaded
2024-07-30T16:53:06.000Z,1722358386.000 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-07-30T16:53:06.001Z,1722358386.001 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CD4E0
2024-07-30T16:53:06.002Z,1722358386.002 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1644
2024-07-30T16:53:06.022Z,1722358386.022 [Depth_Keller] Loaded
2024-07-30T16:53:06.022Z,1722358386.022 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-07-30T16:53:06.027Z,1722358386.027 [DropWeight] Loaded
2024-07-30T16:53:06.027Z,1722358386.027 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-07-30T16:53:06.106Z,1722358386.106 [NAL9602] Loaded
2024-07-30T16:53:06.106Z,1722358386.106 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-07-30T16:53:06.135Z,1722358386.135 [Onboard] Loaded
2024-07-30T16:53:06.136Z,1722358386.136 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-07-30T16:53:06.137Z,1722358386.137 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0
2024-07-30T16:53:06.137Z,1722358386.137 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1645
2024-07-30T16:53:06.149Z,1722358386.149 [Power24vConverter] Loaded
2024-07-30T16:53:06.149Z,1722358386.149 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-07-30T16:53:06.162Z,1722358386.162 [Radio_Surface] Loaded
2024-07-30T16:53:06.163Z,1722358386.163 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-07-30T16:53:06.164Z,1722358386.164 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0
2024-07-30T16:53:06.164Z,1722358386.164 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1646
2024-07-30T16:53:06.178Z,1722358386.178 [Sonardyne_Nano] Loaded
2024-07-30T16:53:06.179Z,1722358386.179 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-07-30T16:53:06.269Z,1722358386.269 [DAT] Loaded
2024-07-30T16:53:06.269Z,1722358386.269 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-07-30T16:53:06.270Z,1722358386.270 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0
2024-07-30T16:53:06.270Z,1722358386.270 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1647
2024-07-30T16:53:06.293Z,1722358386.293 [Waterlinked] Loaded
2024-07-30T16:53:06.293Z,1722358386.293 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2024-07-30T16:53:06.293Z,1722358386.293 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-07-30T16:53:06.294Z,1722358386.294 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-07-30T16:53:06.304Z,1722358386.304 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-07-30T16:53:06.305Z,1722358386.305 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-07-30T16:53:06.331Z,1722358386.331 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-07-30T16:53:06.332Z,1722358386.332 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-07-30T16:53:06.474Z,1722358386.474 [SBIT](DEBUG): Construct Startup Built In Test.
2024-07-30T16:53:06.483Z,1722358386.483 [SBIT] Loaded
2024-07-30T16:53:06.484Z,1722358386.484 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-07-30T16:53:06.486Z,1722358386.486 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-07-30T16:53:06.499Z,1722358386.499 [IBIT] Loaded
2024-07-30T16:53:06.499Z,1722358386.499 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-07-30T16:53:06.505Z,1722358386.505 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-07-30T16:53:06.609Z,1722358386.609 [CBIT] Loaded
2024-07-30T16:53:06.610Z,1722358386.610 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-07-30T16:53:06.610Z,1722358386.610 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-07-30T16:53:06.610Z,1722358386.610 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-07-30T16:53:06.955Z,1722358386.955 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-07-30T16:53:06.955Z,1722358386.955 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-07-30T16:53:07.006Z,1722358387.006 [DepthRateCalculator] Loaded
2024-07-30T16:53:07.006Z,1722358387.006 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-07-30T16:53:07.011Z,1722358387.011 [PitchRateCalculator] Loaded
2024-07-30T16:53:07.011Z,1722358387.011 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-07-30T16:53:07.022Z,1722358387.022 [SpeedCalculator] Loaded
2024-07-30T16:53:07.022Z,1722358387.022 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-07-30T16:53:07.026Z,1722358387.026 [YawRateCalculator] Loaded
2024-07-30T16:53:07.026Z,1722358387.026 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-07-30T16:53:07.047Z,1722358387.047 [ElevatorOffsetCalculator] Loaded
2024-07-30T16:53:07.047Z,1722358387.047 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-07-30T16:53:07.048Z,1722358387.048 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-07-30T16:53:07.048Z,1722358387.048 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-07-30T16:53:07.224Z,1722358387.224 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-07-30T16:53:07.225Z,1722358387.225 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-07-30T16:53:07.346Z,1722358387.346 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-07-30T16:53:07.346Z,1722358387.346 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-07-30T16:53:07.388Z,1722358387.388 [DeadReckonUsingSpeedCalculator] Loaded
2024-07-30T16:53:07.389Z,1722358387.389 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2024-07-30T16:53:07.431Z,1722358387.431 [DeadReckonWithRespectToSeafloor] Loaded
2024-07-30T16:53:07.431Z,1722358387.431 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2024-07-30T16:53:07.445Z,1722358387.445 [NavChart] Loaded
2024-07-30T16:53:07.445Z,1722358387.445 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-07-30T16:53:07.451Z,1722358387.451 [UniversalFixResidualReporter] Loaded
2024-07-30T16:53:07.451Z,1722358387.451 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-07-30T16:53:07.452Z,1722358387.452 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-07-30T16:53:07.452Z,1722358387.452 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-07-30T16:53:07.585Z,1722358387.585 [BuoyancyServo] Loaded
2024-07-30T16:53:07.585Z,1722358387.585 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-07-30T16:53:07.606Z,1722358387.606 [ElevatorServo] Loaded
2024-07-30T16:53:07.606Z,1722358387.606 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-07-30T16:53:07.626Z,1722358387.626 [MassServo] Loaded
2024-07-30T16:53:07.626Z,1722358387.626 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-07-30T16:53:07.645Z,1722358387.645 [RudderServo] Loaded
2024-07-30T16:53:07.645Z,1722358387.645 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-07-30T16:53:07.660Z,1722358387.660 [ThrusterHE] Loaded
2024-07-30T16:53:07.660Z,1722358387.660 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-07-30T16:53:07.660Z,1722358387.660 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-07-30T16:53:07.661Z,1722358387.661 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-07-30T16:53:07.836Z,1722358387.836 [CTD_Seabird] Loaded
2024-07-30T16:53:07.837Z,1722358387.837 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-07-30T16:53:07.838Z,1722358387.838 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0
2024-07-30T16:53:07.838Z,1722358387.838 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1648
2024-07-30T16:53:07.872Z,1722358387.872 [ESPComponent] Loaded
2024-07-30T16:53:07.872Z,1722358387.872 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-07-30T16:53:07.892Z,1722358387.892 [PAR_Licor] Loaded
2024-07-30T16:53:07.892Z,1722358387.892 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-07-30T16:53:07.935Z,1722358387.935 [WetLabsBB2FL] Loaded
2024-07-30T16:53:07.936Z,1722358387.936 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-07-30T16:53:07.937Z,1722358387.937 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-07-30T16:53:07.937Z,1722358387.937 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1649
2024-07-30T16:53:07.938Z,1722358387.938 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-07-30T16:53:07.944Z,1722358387.944 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-07-30T16:53:07.947Z,1722358387.947 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-07-30T16:53:07.959Z,1722358387.959 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-07-30T16:53:07.960Z,1722358387.960 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0
2024-07-30T16:53:07.960Z,1722358387.960 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1650
2024-07-30T16:53:07.964Z,1722358387.964 [Supervisor](INFO): Main Thread ID is 827
2024-07-30T16:53:07.964Z,1722358387.964 [Supervisor](DEBUG): Running supervisor.
2024-07-30T16:53:07.965Z,1722358387.965 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1651
2024-07-30T16:53:07.966Z,1722358387.966 [CommandExec](INFO): Initializing the command executive.
2024-07-30T16:53:07.967Z,1722358387.967 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1652
2024-07-30T16:53:07.971Z,1722358387.971 [controlThread ThreadHandler](INFO): Handler Thread ID is 1653
2024-07-30T16:53:07.971Z,1722358387.971 [controlThread](DEBUG): Initializing ControlThread
2024-07-30T16:53:07.972Z,1722358387.972 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-07-30T16:53:07.974Z,1722358387.974 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-07-30T16:53:07.974Z,1722358387.974 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-07-30T16:53:07.975Z,1722358387.975 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-07-30T16:53:07.978Z,1722358387.978 [SBIT](INFO): Initialize SBIT Component.
2024-07-30T16:53:07.979Z,1722358387.979 [SBIT](IMPORTANT): git: 2024-04-30_A
2024-07-30T16:53:07.979Z,1722358387.979 [SBIT](INFO): git hash: 6f063747ddc9dbe18e4f40e399cbc8a06a65c541
2024-07-30T16:53:07.979Z,1722358387.979 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-07-30T16:53:07.981Z,1722358387.981 [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-07-30T16:53:07.982Z,1722358387.982 [SBIT](INFO): Beginning SBIT in 85.000000 seconds.
2024-07-30T16:53:07.982Z,1722358387.982 [IBIT](INFO): Initialize IBIT Component.
2024-07-30T16:53:07.983Z,1722358387.983 [CBIT](DEBUG): Initialize CBIT Component.
2024-07-30T16:53:07.984Z,1722358387.984 [logger ThreadHandler](INFO): Handler Thread ID is 1654
2024-07-30T16:53:07.996Z,1722358387.996 [CBIT](DEBUG): Initialized mux pins.
2024-07-30T16:53:07.996Z,1722358387.996 [CBIT](DEBUG): Initializing the watchdog timer.
2024-07-30T16:53:08.005Z,1722358388.005 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1655
2024-07-30T16:53:08.017Z,1722358388.017 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1656
2024-07-30T16:53:08.018Z,1722358388.018 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-07-30T16:53:08.020Z,1722358388.020 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-07-30T16:53:08.021Z,1722358388.021 [CBIT](DEBUG): Initializing heartbeat.
2024-07-30T16:53:08.029Z,1722358388.029 [Onboard ThreadHandler](INFO): Handler Thread ID is 1657
2024-07-30T16:53:08.046Z,1722358388.046 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1658
2024-07-30T16:53:08.069Z,1722358388.069 [DAT ThreadHandler](INFO): Handler Thread ID is 1659
2024-07-30T16:53:08.070Z,1722358388.070 [DAT](INFO): Powering up
2024-07-30T16:53:08.070Z,1722358388.070 [DAT](DEBUG): Initializing DAT.
2024-07-30T16:53:08.074Z,1722358388.074 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1661
2024-07-30T16:53:08.074Z,1722358388.074 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-07-30T16:53:08.077Z,1722358388.077 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1663
2024-07-30T16:53:08.081Z,1722358388.081 [WetLabsBB2FL](INFO): Powering up
2024-07-30T16:53:08.082Z,1722358388.082 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1665
2024-07-30T16:53:08.085Z,1722358388.085 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2024-07-30T16:53:08.085Z,1722358388.085 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2024-07-30T16:53:08.085Z,1722358388.085 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2024-07-30T16:53:08.086Z,1722358388.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2024-07-30T16:53:08.086Z,1722358388.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-07-30T16:53:08.086Z,1722358388.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-07-30T16:53:08.086Z,1722358388.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-07-30T16:53:08.086Z,1722358388.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-07-30T16:53:08.086Z,1722358388.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2024-07-30T16:53:08.087Z,1722358388.087 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2024-07-30T16:53:08.087Z,1722358388.087 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2024-07-30T16:53:08.087Z,1722358388.087 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2024-07-30T16:53:08.092Z,1722358388.092 [CBIT](DEBUG): Deactivating GF circuits.
2024-07-30T16:53:08.092Z,1722358388.092 [CBIT](DEBUG): Deactivating emergency mode.
2024-07-30T16:53:08.132Z,1722358388.132 [CBIT](DEBUG): Backplane powered.
2024-07-30T16:53:08.133Z,1722358388.133 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-07-30T16:53:08.133Z,1722358388.133 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-07-30T16:53:08.133Z,1722358388.133 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-07-30T16:53:08.134Z,1722358388.134 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-07-30T16:53:08.134Z,1722358388.134 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-07-30T16:53:08.135Z,1722358388.135 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-07-30T16:53:08.136Z,1722358388.136 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-07-30T16:53:08.136Z,1722358388.136 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-07-30T16:53:08.141Z,1722358388.141 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-07-30T16:53:08.142Z,1722358388.142 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-07-30T16:53:08.142Z,1722358388.142 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-07-30T16:53:08.143Z,1722358388.143 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-07-30T16:53:08.204Z,1722358388.204 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-07-30T16:53:08.228Z,1722358388.228 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-30T16:53:08.248Z,1722358388.248 [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-07-30T16:53:08.269Z,1722358388.269 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-07-30T16:53:08.269Z,1722358388.269 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-07-30T16:53:08.270Z,1722358388.270 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-07-30T16:53:08.460Z,1722358388.460 [Radio_Surface](INFO): Powering up
2024-07-30T16:53:08.599Z,1722358388.599 [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-07-30T16:53:08.621Z,1722358388.621 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-07-30T16:53:08.622Z,1722358388.622 [Default:A.Wait](DEBUG): Construct Wait.
2024-07-30T16:53:08.641Z,1722358388.641 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-30T16:53:08.677Z,1722358388.677 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-07-30T16:53:08.679Z,1722358388.679 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-07-30T16:53:08.697Z,1722358388.697 [Default:E.Execute](DEBUG): Construct Execute.
2024-07-30T16:53:08.717Z,1722358388.717 [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-07-30T16:53:08.722Z,1722358388.722 [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-07-30T16:53:08.745Z,1722358388.745 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-07-30T16:53:08.818Z,1722358388.818 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m
2024-07-30T16:53:08.819Z,1722358388.819 [Power24vConverter](INFO): Powering up.
2024-07-30T16:53:08.820Z,1722358388.820 [Sonardyne_Nano](INFO): Initializing.
2024-07-30T16:53:08.850Z,1722358388.850 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-07-30T16:53:08.902Z,1722358388.902 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-07-30T16:53:08.909Z,1722358388.909 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-07-30T16:53:08.910Z,1722358388.910 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-07-30T16:53:08.917Z,1722358388.917 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-07-30T16:53:08.917Z,1722358388.917 [MassServo](DEBUG): Initializing EZServoServo.
2024-07-30T16:53:08.925Z,1722358388.925 [MassServo](DEBUG): Initializing MassServo.
2024-07-30T16:53:08.925Z,1722358388.925 [RudderServo](DEBUG): Initializing EZServoServo.
2024-07-30T16:53:08.933Z,1722358388.933 [RudderServo](DEBUG): Initializing RudderServo.
2024-07-30T16:53:08.933Z,1722358388.933 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-07-30T16:53:08.944Z,1722358388.944 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-07-30T16:53:10.188Z,1722358390.188 [WetLabsBB2FL](INFO): Powering down
2024-07-30T16:53:10.751Z,1722358390.751 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-07-30T16:53:12.045Z,1722358392.045 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311
2024-07-30T16:53:20.165Z,1722358400.165 [DAT](INFO): DAT read:
2024-07-30T16:53:20.166Z,1722358400.166 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-07-30T16:53:21.929Z,1722358401.929 [DAT](INFO): DAT read: MF Frequency Band
2024-07-30T16:53:21.930Z,1722358401.930 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-07-30T16:53:21.931Z,1722358401.931 [DAT](INFO): DAT read: Jul 30 2024 16:53:16
2024-07-30T16:53:22.938Z,1722358402.938 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-07-30T16:53:22.939Z,1722358402.939 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-07-30T16:53:22.940Z,1722358402.940 [DAT](INFO): commRate: 800
2024-07-30T16:53:25.004Z,1722358405.004 [DAT](INFO): entering command mode
2024-07-30T16:53:25.205Z,1722358405.205 [DAT](INFO): DAT read:
2024-07-30T16:53:25.206Z,1722358405.206 [DAT](INFO): DAT read: user:1>
2024-07-30T16:53:25.206Z,1722358405.206 [DAT](INFO): setting verbose to 3
2024-07-30T16:53:25.457Z,1722358405.457 [DAT](INFO): DAT read: user:1>
2024-07-30T16:53:25.458Z,1722358405.458 [DAT](INFO): DAT read: Verbose | 3
2024-07-30T16:53:25.458Z,1722358405.458 [DAT](INFO): set verbose to 3
2024-07-30T16:53:25.459Z,1722358405.459 [DAT](INFO): setting DatVerbose to 27440
2024-07-30T16:53:25.709Z,1722358405.709 [DAT](INFO): DAT read: user:2>
2024-07-30T16:53:25.710Z,1722358405.710 [DAT](INFO): DAT read: DatVerbose | 27440
2024-07-30T16:53:25.710Z,1722358405.710 [DAT](INFO): set DatVerbose to 27440
2024-07-30T16:53:25.711Z,1722358405.711 [DAT](INFO): setting transmit power to 8
2024-07-30T16:53:25.961Z,1722358405.961 [DAT](INFO): DAT read: user:3>
2024-07-30T16:53:25.962Z,1722358405.962 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-07-30T16:53:25.962Z,1722358405.962 [DAT](INFO): set transmit power to 8
2024-07-30T16:53:25.962Z,1722358405.962 [DAT](INFO): setting local address to 1
2024-07-30T16:53:26.213Z,1722358406.213 [DAT](INFO): DAT read: user:4>
2024-07-30T16:53:26.214Z,1722358406.214 [DAT](INFO): DAT read: LocalAddr | 1
2024-07-30T16:53:26.214Z,1722358406.214 [DAT](INFO): set local address to 1
2024-07-30T16:53:26.215Z,1722358406.215 [DAT](INFO): Setting time to: 16:53:26 And date to:7/30/2024
2024-07-30T16:53:26.465Z,1722358406.465 [DAT](INFO): DAT read: user:5>
2024-07-30T16:53:26.466Z,1722358406.466 [DAT](INFO): DAT read: Tue Jul 30, 2024 16:53:26
2024-07-30T16:53:26.466Z,1722358406.466 [DAT](INFO): Local DAT time set to Tue Jul 30, 2024 16:53:26
2024-07-30T16:53:36.206Z,1722358416.206 [NAL9602](INFO): Powering up NAL9602
2024-07-30T16:53:47.170Z,1722358427.170 [NAL9602](INFO): NAL9602 initialized
2024-07-30T16:54:15.795Z,1722358455.795 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:54:29.533Z,1722358469.533 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:54:33.624Z,1722358473.624 [SBIT](IMPORTANT): Beginning Startup BIT
2024-07-30T16:54:33.640Z,1722358473.640 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-30T16:54:43.670Z,1722358483.670 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:54:44.757Z,1722358484.757 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.013377
CHAN A1 (24V): 0.018464
CHAN A2 (12V): 0.008926
CHAN A3 (5V): 0.002714
CHAN B0 (3.3V): 0.002916
CHAN B1 (3.15aV): 0.002895
CHAN B2 (3.15bV): 0.002268
CHAN B3 (GND): -0.000637
OPEN: 0.010244
Full Scale: +/- 1 mA
2024-07-30T16:54:51.379Z,1722358491.379 [Waterlinked](ERROR): only read 0 of 1 data item for altitude. Device response::BD, +0.00, +0.00, , 7.55, 0.00
2024-07-30T16:54:57.002Z,1722358497.002 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:55:10.357Z,1722358510.357 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:55:18.438Z,1722358518.438 [Waterlinked](ERROR): only read 0 of 1 data item for BIT error. Device response::TS,22032019572, +0.0, 0.0,1475.0, 0
2024-07-30T16:55:24.482Z,1722358524.482 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:55:27.808Z,1722358527.808 [SBIT](IMPORTANT): SBIT PASSED
2024-07-30T16:55:27.808Z,1722358527.808 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-07-30T16:55:27.809Z,1722358527.809 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2024-07-30T16:55:27.809Z,1722358527.809 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): DropWeight.loadAtStartup=1 bool;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 0.600000 count_per_second;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 0.600000 count_per_second;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_caseHumidity 10.000000 percent;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=152.061623 cubic_centimeter;
2024-07-30T16:55:27.810Z,1722358527.810 [SBIT](IMPORTANT): VerticalControl.massDefault=16.305999 millimeter;
2024-07-30T16:55:28.209Z,1722358528.209 [MissionManager](IMPORTANT): Started mission Startup
2024-07-30T16:55:28.209Z,1722358528.209 [Startup] Running Loop=1
2024-07-30T16:55:28.209Z,1722358528.209 [Startup](DEBUG): Aggregate::initialize Startup
2024-07-30T16:55:28.209Z,1722358528.209 [Startup:A.GoToSurface] Running Loop=1
2024-07-30T16:55:28.209Z,1722358528.209 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-30T16:55:28.210Z,1722358528.210 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-30T16:55:28.210Z,1722358528.210 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-30T16:55:28.210Z,1722358528.210 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-30T16:55:28.211Z,1722358528.211 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-30T16:55:28.211Z,1722358528.211 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-30T16:55:28.213Z,1722358528.213 [Startup:StartupSatComms] Running Loop=1
2024-07-30T16:55:28.213Z,1722358528.213 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-07-30T16:55:28.213Z,1722358528.213 [Startup:StartupSatComms:A] Running Loop=1
2024-07-30T16:55:28.584Z,1722358528.584 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-07-30T16:55:38.627Z,1722358538.627 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:55:52.358Z,1722358552.358 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:56:00.921Z,1722358560.921 [Waterlinked](INFO): Powering down
2024-07-30T16:56:05.682Z,1722358565.682 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:56:08.532Z,1722358568.532 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-07-30T16:56:08.532Z,1722358568.532 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-30T16:56:08.533Z,1722358568.533 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2024-07-30T16:56:08.533Z,1722358568.533 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-07-30T16:56:08.535Z,1722358568.535 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T16:56:08.535Z,1722358568.535 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T16:56:08.545Z,1722358568.545 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-30T16:56:08.546Z,1722358568.546 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-07-30T16:56:08.546Z,1722358568.546 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T16:56:08.957Z,1722358568.957 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-30T16:56:08.957Z,1722358568.957 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-07-30T16:56:08.958Z,1722358568.958 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-07-30T16:56:08.958Z,1722358568.958 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2024-07-30T16:56:08.958Z,1722358568.958 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T16:56:08.958Z,1722358568.958 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T16:56:09.333Z,1722358569.333 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-07-30T16:56:19.015Z,1722358579.015 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:56:28.345Z,1722358588.345 [Startup:StartupSatComms:A](INFO): Timed out from 2024-07-30T16:55:28.2Z
2024-07-30T16:56:28.345Z,1722358588.345 [Startup:StartupSatComms:A] Stopped
2024-07-30T16:56:28.345Z,1722358588.345 [Startup:StartupSatComms:B] Running Loop=1
2024-07-30T16:56:28.737Z,1722358588.737 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-30T16:56:39.683Z,1722358599.683 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2024-07-30T16:56:55.983Z,1722358615.983 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004854
2024-07-30T16:57:05.168Z,1722358625.168 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240730T160219/Courier0009.lzma
2024-07-30T16:57:06.170Z,1722358626.170 [DataOverHttps](INFO): Moved sent file to Logs/20240730T160219/Courier0009.lzma.bak
2024-07-30T16:57:06.170Z,1722358626.170 [DataOverHttps](INFO): SBD MOMSN=21394791
2024-07-30T16:57:23.240Z,1722358643.240 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240730T165255/Courier0000.lzma
2024-07-30T16:57:24.242Z,1722358644.242 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0000.lzma.bak
2024-07-30T16:57:24.242Z,1722358644.242 [DataOverHttps](INFO): SBD MOMSN=21394793
2024-07-30T16:57:28.625Z,1722358648.625 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-30T16:56:28.3Z
2024-07-30T16:57:28.625Z,1722358648.625 [Startup:StartupSatComms:B] Stopped
2024-07-30T16:57:28.625Z,1722358648.625 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-07-30T16:57:28.625Z,1722358648.625 [Startup:StartupSatComms] Stopped
2024-07-30T16:57:28.625Z,1722358648.625 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-07-30T16:57:28.626Z,1722358648.626 [Startup](INFO): Completed Startup
2024-07-30T16:57:28.626Z,1722358648.626 [MissionManager](INFO): Startup is completed.
2024-07-30T16:57:28.626Z,1722358648.626 [MissionManager](INFO): Uninitializing Mission Startup
2024-07-30T16:57:28.626Z,1722358648.626 [Startup] Stopped
2024-07-30T16:57:28.626Z,1722358648.626 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-07-30T16:57:28.627Z,1722358648.627 [Startup:A.GoToSurface] Stopped
2024-07-30T16:57:28.627Z,1722358648.627 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-30T16:57:29.027Z,1722358649.027 [MissionManager](IMPORTANT): Started mission Default
2024-07-30T16:57:29.027Z,1722358649.027 [Default] Running Loop=1
2024-07-30T16:57:29.027Z,1722358649.027 [Default](DEBUG): Aggregate::initialize Default
2024-07-30T16:57:29.027Z,1722358649.027 [Default:B.GoToSurface] Running Loop=1
2024-07-30T16:57:29.027Z,1722358649.027 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-30T16:57:29.028Z,1722358649.028 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-30T16:57:29.028Z,1722358649.028 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-30T16:57:29.033Z,1722358649.033 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-30T16:57:29.033Z,1722358649.033 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-30T16:57:29.033Z,1722358649.033 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-30T16:57:29.034Z,1722358649.034 [Default:A.Wait] Running Loop=1
2024-07-30T16:57:29.034Z,1722358649.034 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-07-30T16:57:40.101Z,1722358660.101 [DataOverHttps](INFO): Sending 401 bytes from file Logs/20240730T160219/Express0011.lzma
2024-07-30T16:57:41.102Z,1722358661.102 [DataOverHttps](INFO): Moved sent file to Logs/20240730T160219/Express0011.lzma.bak
2024-07-30T16:57:41.102Z,1722358661.102 [DataOverHttps](INFO): SBD MOMSN=21394796
2024-07-30T16:57:42.341Z,1722358662.341 [Default:A.Wait](INFO): Done Waiting.
2024-07-30T16:57:42.341Z,1722358662.341 [Default:A.Wait] Stopped
2024-07-30T16:57:42.341Z,1722358662.341 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T16:57:42.793Z,1722358662.793 [Default:CheckIn] Running Loop=1
2024-07-30T16:57:42.793Z,1722358662.793 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T16:57:42.793Z,1722358662.793 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T16:57:43.168Z,1722358663.168 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-07-30T16:57:45.968Z,1722358665.968 [NAL9602](INFO): SBD MO Status=2, MOMSN=14169, MT Status=2, MTMSN=0
2024-07-30T16:57:45.968Z,1722358665.968 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-07-30T16:58:40.959Z,1722358720.959 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-07-30T16:58:47.767Z,1722358727.767 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:58:50.195Z,1722358730.195 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-07-30T16:58:55.055Z,1722358735.055 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165854.00,A,3648.16855,N,12147.28079,W,0.194,130.37,300724,,,A*7C
2024-07-30T16:58:55.058Z,1722358735.058 [NAL9602](INFO): GPS fix at 20240730T165854: (36.802809, -121.788013)
2024-07-30T16:58:55.088Z,1722358735.088 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T16:58:55.088Z,1722358735.088 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T16:58:55.500Z,1722358735.500 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-30T16:59:02.853Z,1722358742.853 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20240730T165255/Courier0004.lzma
2024-07-30T16:59:03.132Z,1722358743.132 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:59:03.854Z,1722358743.854 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0004.lzma.bak
2024-07-30T16:59:03.854Z,1722358743.854 [DataOverHttps](INFO): SBD MOMSN=21394812
2024-07-30T16:59:09.679Z,1722358749.679 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T16:59:09.679Z,1722358749.679 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T16:59:09.775Z,1722358749.775 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T16:59:10.167Z,1722358750.167 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T16:59:10.167Z,1722358750.167 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T16:59:18.137Z,1722358758.137 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:59:27.105Z,1722358767.105 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T16:59:27.206Z,1722358767.206 [DataOverHttps](INFO): Sending 963 bytes from file Logs/20240730T165255/Express0001.lzma
2024-07-30T16:59:28.206Z,1722358768.206 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0001.lzma.bak
2024-07-30T16:59:28.206Z,1722358768.206 [DataOverHttps](INFO): SBD MOMSN=21394816
2024-07-30T16:59:33.144Z,1722358773.144 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T16:59:44.993Z,1722358784.993 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20240730T165255/Express0005.lzma
2024-07-30T16:59:45.994Z,1722358785.994 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0005.lzma.bak
2024-07-30T16:59:45.994Z,1722358785.994 [DataOverHttps](INFO): SBD MOMSN=21394838
2024-07-30T16:59:47.307Z,1722358787.307 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T16:59:47.307Z,1722358787.307 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T16:59:47.308Z,1722358787.308 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T16:59:48.093Z,1722358788.093 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T17:00:03.043Z,1722358803.043 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T17:00:18.394Z,1722358818.394 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T17:00:33.744Z,1722358833.744 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T17:00:48.300Z,1722358848.300 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-30T17:01:02.924Z,1722358862.924 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2024-07-30T17:01:02.930Z,1722358862.930 [BPC1](INFO): Calculating totals. Valid battery stick count: 43. Valid reserve battery stick count: 5.
2024-07-30T17:01:02.973Z,1722358862.973 [BPC1](INFO): Received data from all battery sticks.
2024-07-30T17:02:10.910Z,1722358930.910 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:02:10.910Z,1722358930.910 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:02:10.955Z,1722358930.955 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:02:11.333Z,1722358931.333 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:02:11.333Z,1722358931.333 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:04:48.188Z,1722359088.188 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:04:48.188Z,1722359088.188 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:04:48.188Z,1722359088.188 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:04:48.196Z,1722359088.196 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:04:48.575Z,1722359088.575 [Default:CheckIn:D] Stopped
2024-07-30T17:04:48.575Z,1722359088.575 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:04:48.988Z,1722359088.988 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.325800 min
2024-07-30T17:04:48.988Z,1722359088.988 [Default:CheckIn:E] Stopped
2024-07-30T17:04:48.988Z,1722359088.988 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:04:48.988Z,1722359088.988 [Default:CheckIn] Stopped
2024-07-30T17:04:48.988Z,1722359088.988 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:04:48.989Z,1722359088.989 [Default:CheckIn](INFO): Running loop #2
2024-07-30T17:04:48.989Z,1722359088.989 [Default:CheckIn] Running Loop=2
2024-07-30T17:04:48.989Z,1722359088.989 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:04:48.989Z,1722359088.989 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:04:50.991Z,1722359090.991 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170450.00,A,3648.16810,N,12147.27908,W,0.097,137.80,300724,,,A*78
2024-07-30T17:04:51.010Z,1722359091.010 [NAL9602](INFO): GPS fix at 20240730T170450: (36.802802, -121.787985)
2024-07-30T17:04:51.034Z,1722359091.034 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:04:51.034Z,1722359091.034 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:04:59.852Z,1722359099.852 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240730T165255/Courier0007.lzma
2024-07-30T17:05:00.854Z,1722359100.854 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0007.lzma.bak
2024-07-30T17:05:00.854Z,1722359100.854 [DataOverHttps](INFO): SBD MOMSN=21394847
2024-07-30T17:05:12.038Z,1722359112.038 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:05:12.038Z,1722359112.038 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:05:12.097Z,1722359112.097 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:05:12.570Z,1722359112.570 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:05:12.570Z,1722359112.570 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:05:18.148Z,1722359118.148 [DataOverHttps](INFO): Sending 165 bytes from file Logs/20240730T165255/Express0008.lzma
2024-07-30T17:05:19.150Z,1722359119.150 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0008.lzma.bak
2024-07-30T17:05:19.150Z,1722359119.150 [DataOverHttps](INFO): SBD MOMSN=21394850
2024-07-30T17:05:20.575Z,1722359120.575 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:05:20.575Z,1722359120.575 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:05:20.575Z,1722359120.575 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:05:21.734Z,1722359121.734 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-07-30T17:05:21.816Z,1722359121.816 [NAL9602](ERROR): received:
+CSQ:0
OK169, 2, 0, 0, 0
OK
2024-07-30T17:08:00.198Z,1722359280.198 [DataOverHttps](IMPORTANT): SBD MTMSN=20240730T170759
2024-07-30T17:08:11.373Z,1722359291.373 [DataOverHttps](INFO): Received command: ibit; failc
2024-07-30T17:08:11.454Z,1722359291.454 [CommandExec](IMPORTANT): got command ibit
2024-07-30T17:08:11.454Z,1722359291.454 [CommandExec](IMPORTANT): got command failComponent
2024-07-30T17:08:11.455Z,1722359291.455 [CommandExec](IMPORTANT): Failed components:
2024-07-30T17:08:11.455Z,1722359291.455 [CommandExec](IMPORTANT): No failed Components.
2024-07-30T17:08:11.743Z,1722359291.743 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-30T17:08:11.743Z,1722359291.743 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-30T17:08:11.748Z,1722359291.748 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-30T17:08:12.974Z,1722359292.974 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:08:12.975Z,1722359292.975 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:08:12.986Z,1722359292.986 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:08:13.449Z,1722359293.449 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:08:13.449Z,1722359293.449 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:08:22.740Z,1722359302.740 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.009540
CHAN A1 (24V): 0.014166
CHAN A2 (12V): 0.007487
CHAN A3 (5V): 0.001360
CHAN B0 (3.3V): 0.002557
CHAN B1 (3.15aV): 0.001673
CHAN B2 (3.15bV): 0.002002
CHAN B3 (GND): -0.000185
OPEN: 0.008252
Full Scale: +/- 1 mA
2024-07-30T17:09:53.546Z,1722359393.546 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-07-30T17:09:54.756Z,1722359394.756 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170954.00,A,3648.17236,N,12147.28527,W,0.175,136.42,300724,,,A*72
2024-07-30T17:09:54.758Z,1722359394.758 [NAL9602](INFO): GPS fix at 20240730T170954: (36.802873, -121.788088)
2024-07-30T17:09:57.992Z,1722359397.992 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170957.00,A,3648.17231,N,12147.28518,W,0.194,136.42,300724,,,A*75
2024-07-30T17:09:57.994Z,1722359397.994 [NAL9602](INFO): GPS fix at 20240730T170957: (36.802872, -121.788086)
2024-07-30T17:10:00.825Z,1722359400.825 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171000.00,A,3648.17254,N,12147.28586,W,0.330,136.42,300724,,,A*77
2024-07-30T17:10:00.827Z,1722359400.827 [NAL9602](INFO): GPS fix at 20240730T171000: (36.802876, -121.788098)
2024-07-30T17:10:02.458Z,1722359402.458 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2024-07-30T17:10:02.875Z,1722359402.875 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.572001
2024-07-30T17:10:02.876Z,1722359402.876 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-07-30T17:10:02.876Z,1722359402.876 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-07-30T17:10:03.258Z,1722359403.258 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-30T17:10:03.258Z,1722359403.258 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-30T17:10:03.259Z,1722359403.259 [IBIT](IMPORTANT): Pressure:9.948595 PSI
2024-07-30T17:10:03.259Z,1722359403.259 [IBIT](IMPORTANT): Humidity:21.853254 %
2024-07-30T17:10:03.714Z,1722359403.714 [IBIT](IMPORTANT): Vehicle Pitch:-0.782733 degrees
2024-07-30T17:10:03.714Z,1722359403.714 [IBIT](IMPORTANT): Vehicle Roll:-0.122514 degrees
2024-07-30T17:10:03.715Z,1722359403.715 [IBIT](IMPORTANT): Vehicle Heading:260.632324 degrees
2024-07-30T17:10:04.048Z,1722359404.048 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171003.00,A,3648.17237,N,12147.28559,W,0.330,136.42,300724,,,A*73
2024-07-30T17:10:04.050Z,1722359404.050 [NAL9602](INFO): GPS fix at 20240730T171003: (36.802873, -121.788093)
2024-07-30T17:10:04.111Z,1722359404.111 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-30T17:10:04.111Z,1722359404.111 [IBIT](IMPORTANT): buoyancyNeutral: 152.061630 cc
2024-07-30T17:10:04.111Z,1722359404.111 [IBIT](IMPORTANT): massDefault: 1.630600 cm
2024-07-30T17:10:04.111Z,1722359404.111 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-30T17:10:04.112Z,1722359404.112 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-30T17:10:04.112Z,1722359404.112 [IBIT](IMPORTANT): IBIT FAILED
2024-07-30T17:10:21.038Z,1722359421.038 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:10:21.038Z,1722359421.038 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:10:21.038Z,1722359421.038 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:10:21.038Z,1722359421.038 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:10:21.432Z,1722359421.432 [Default:CheckIn:D] Stopped
2024-07-30T17:10:21.432Z,1722359421.432 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.873417 min
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn:E] Stopped
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn] Stopped
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn](INFO): Running loop #3
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn] Running Loop=3
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:10:21.836Z,1722359421.836 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:10:23.868Z,1722359423.868 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171023.00,A,3648.17285,N,12147.28442,W,1.497,136.42,300724,,,A*78
2024-07-30T17:10:23.870Z,1722359423.870 [NAL9602](INFO): GPS fix at 20240730T171023: (36.802881, -121.788074)
2024-07-30T17:10:23.886Z,1722359423.886 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:10:23.886Z,1722359423.886 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:10:31.541Z,1722359431.541 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240730T165255/Courier0010.lzma
2024-07-30T17:10:32.543Z,1722359432.543 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0010.lzma.bak
2024-07-30T17:10:32.543Z,1722359432.543 [DataOverHttps](INFO): SBD MOMSN=21394860
2024-07-30T17:10:49.051Z,1722359449.051 [DataOverHttps](INFO): Sending 888 bytes from file Logs/20240730T165255/Express0011.lzma
2024-07-30T17:10:50.051Z,1722359450.051 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0011.lzma.bak
2024-07-30T17:10:50.051Z,1722359450.051 [DataOverHttps](INFO): SBD MOMSN=21394863
2024-07-30T17:10:56.610Z,1722359456.610 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:11:09.988Z,1722359469.988 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20240730T165255/Express0014.lzma
2024-07-30T17:11:10.991Z,1722359470.991 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0014.lzma.bak
2024-07-30T17:11:10.992Z,1722359470.992 [DataOverHttps](INFO): SBD MOMSN=21394893
2024-07-30T17:11:12.389Z,1722359472.389 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:11:12.389Z,1722359472.389 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:11:12.389Z,1722359472.389 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:11:14.059Z,1722359474.059 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:11:14.059Z,1722359474.059 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:11:14.083Z,1722359474.083 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:11:14.444Z,1722359474.444 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:11:14.444Z,1722359474.444 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:14:15.086Z,1722359655.086 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:14:15.086Z,1722359655.086 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:14:15.113Z,1722359655.113 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:14:15.480Z,1722359655.480 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:14:15.480Z,1722359655.480 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:16:13.112Z,1722359773.112 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:16:13.112Z,1722359773.112 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:16:13.112Z,1722359773.112 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:16:13.112Z,1722359773.112 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:16:13.507Z,1722359773.507 [Default:CheckIn:D] Stopped
2024-07-30T17:16:13.507Z,1722359773.507 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:16:13.907Z,1722359773.907 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.741335 min
2024-07-30T17:16:13.907Z,1722359773.907 [Default:CheckIn:E] Stopped
2024-07-30T17:16:13.907Z,1722359773.907 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:16:13.907Z,1722359773.907 [Default:CheckIn] Stopped
2024-07-30T17:16:13.907Z,1722359773.907 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:16:13.908Z,1722359773.908 [Default:CheckIn](INFO): Running loop #4
2024-07-30T17:16:13.908Z,1722359773.908 [Default:CheckIn] Running Loop=4
2024-07-30T17:16:13.908Z,1722359773.908 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:16:13.908Z,1722359773.908 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:16:15.917Z,1722359775.917 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171615.00,A,3648.13922,N,12147.23006,W,0.039,54.21,300724,,,D*42
2024-07-30T17:16:15.920Z,1722359775.920 [NAL9602](INFO): GPS fix at 20240730T171615: (36.802320, -121.787168)
2024-07-30T17:16:15.935Z,1722359775.935 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:16:15.935Z,1722359775.935 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:16:23.104Z,1722359783.104 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240730T165255/Courier0016.lzma
2024-07-30T17:16:24.103Z,1722359784.103 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0016.lzma.bak
2024-07-30T17:16:24.103Z,1722359784.103 [DataOverHttps](INFO): SBD MOMSN=21394895
2024-07-30T17:16:40.133Z,1722359800.133 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240730T165255/Express0017.lzma
2024-07-30T17:16:41.135Z,1722359801.135 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0017.lzma.bak
2024-07-30T17:16:41.135Z,1722359801.135 [DataOverHttps](INFO): SBD MOMSN=21394898
2024-07-30T17:16:42.188Z,1722359802.188 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:16:42.188Z,1722359802.188 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:16:42.188Z,1722359802.188 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:16:46.622Z,1722359806.622 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2024-07-30T17:16:46.705Z,1722359806.705 [NAL9602](ERROR): received:
+CSQ:0
OK169, 2, 0, 0, 0
OK
2024-07-30T17:17:04.403Z,1722359824.403 [NAL9602](INFO): SBD MO Status=0, MOMSN=14169, MT Status=0, MTMSN=0
2024-07-30T17:17:04.403Z,1722359824.403 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:17:16.154Z,1722359836.154 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:17:16.154Z,1722359836.154 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:17:16.177Z,1722359836.177 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:17:16.576Z,1722359836.576 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:17:16.576Z,1722359836.576 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:17:35.102Z,1722359855.102 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:20:17.155Z,1722360017.155 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:20:17.155Z,1722360017.155 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:20:17.166Z,1722360017.166 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:20:17.588Z,1722360017.588 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:20:17.588Z,1722360017.588 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:21:42.866Z,1722360102.866 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:21:42.866Z,1722360102.866 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:21:42.866Z,1722360102.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:21:42.866Z,1722360102.866 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:21:43.280Z,1722360103.280 [Default:CheckIn:D] Stopped
2024-07-30T17:21:43.280Z,1722360103.280 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:21:43.680Z,1722360103.680 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.237545 min
2024-07-30T17:21:43.680Z,1722360103.680 [Default:CheckIn:E] Stopped
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn] Stopped
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn](INFO): Running loop #5
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn] Running Loop=5
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:21:43.681Z,1722360103.681 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:21:45.680Z,1722360105.680 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172144.00,A,3648.14167,N,12147.22874,W,0.097,3.43,300724,,,D*72
2024-07-30T17:21:45.682Z,1722360105.682 [NAL9602](INFO): GPS fix at 20240730T172144: (36.802361, -121.787146)
2024-07-30T17:21:45.718Z,1722360105.718 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:21:45.718Z,1722360105.718 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:21:53.176Z,1722360113.176 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240730T165255/Courier0019.lzma
2024-07-30T17:21:54.179Z,1722360114.179 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0019.lzma.bak
2024-07-30T17:21:54.179Z,1722360114.179 [DataOverHttps](INFO): SBD MOMSN=21394902
2024-07-30T17:21:56.992Z,1722360116.992 [NAL9602](INFO): SBD MO Status=0, MOMSN=14170, MT Status=0, MTMSN=0
2024-07-30T17:21:56.992Z,1722360116.992 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:22:09.965Z,1722360129.965 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20240730T165255/Express0020.lzma
2024-07-30T17:22:10.967Z,1722360130.967 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0020.lzma.bak
2024-07-30T17:22:10.967Z,1722360130.967 [DataOverHttps](INFO): SBD MOMSN=21394905
2024-07-30T17:22:12.367Z,1722360132.367 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:22:12.367Z,1722360132.367 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:22:12.367Z,1722360132.367 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:22:27.694Z,1722360147.694 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:23:18.246Z,1722360198.246 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:23:18.246Z,1722360198.246 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:23:18.281Z,1722360198.281 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:23:18.632Z,1722360198.632 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:23:18.632Z,1722360198.632 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:26:19.289Z,1722360379.289 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:26:19.289Z,1722360379.289 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:26:19.311Z,1722360379.311 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:26:19.721Z,1722360379.721 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:26:19.721Z,1722360379.721 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:27:13.035Z,1722360433.035 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:27:13.035Z,1722360433.035 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:27:13.035Z,1722360433.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:27:13.035Z,1722360433.035 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:27:13.440Z,1722360433.440 [Default:CheckIn:D] Stopped
2024-07-30T17:27:13.440Z,1722360433.440 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:27:13.856Z,1722360433.856 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.740222 min
2024-07-30T17:27:13.856Z,1722360433.856 [Default:CheckIn:E] Stopped
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn] Stopped
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn](INFO): Running loop #6
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn] Running Loop=6
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:27:13.857Z,1722360433.857 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:27:15.860Z,1722360435.860 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172715.00,A,3648.15014,N,12147.22056,W,0.039,3.43,300724,,,D*78
2024-07-30T17:27:15.862Z,1722360435.862 [NAL9602](INFO): GPS fix at 20240730T172715: (36.802502, -121.787009)
2024-07-30T17:27:15.896Z,1722360435.896 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:27:15.896Z,1722360435.896 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:27:23.564Z,1722360443.564 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240730T165255/Courier0022.lzma
2024-07-30T17:27:24.567Z,1722360444.567 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0022.lzma.bak
2024-07-30T17:27:24.567Z,1722360444.567 [DataOverHttps](INFO): SBD MOMSN=21394909
2024-07-30T17:27:40.509Z,1722360460.509 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240730T165255/Express0023.lzma
2024-07-30T17:27:41.511Z,1722360461.511 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0023.lzma.bak
2024-07-30T17:27:41.511Z,1722360461.511 [DataOverHttps](INFO): SBD MOMSN=21394912
2024-07-30T17:27:42.547Z,1722360462.547 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:27:42.547Z,1722360462.547 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:27:42.547Z,1722360462.547 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:27:49.791Z,1722360469.791 [NAL9602](INFO): SBD MO Status=0, MOMSN=14171, MT Status=0, MTMSN=0
2024-07-30T17:27:49.791Z,1722360469.791 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:28:20.491Z,1722360500.491 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:29:20.344Z,1722360560.344 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:29:20.344Z,1722360560.344 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:29:20.364Z,1722360560.364 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:29:20.744Z,1722360560.744 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:29:20.744Z,1722360560.744 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:32:21.394Z,1722360741.394 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:32:21.394Z,1722360741.394 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:32:21.433Z,1722360741.433 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:32:21.828Z,1722360741.828 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:32:21.828Z,1722360741.828 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:32:43.199Z,1722360763.199 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:32:43.199Z,1722360763.199 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:32:43.199Z,1722360763.199 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:32:43.199Z,1722360763.199 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:32:43.598Z,1722360763.598 [Default:CheckIn:D] Stopped
2024-07-30T17:32:43.598Z,1722360763.598 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:32:44.011Z,1722360764.011 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.242855 min
2024-07-30T17:32:44.011Z,1722360764.011 [Default:CheckIn:E] Stopped
2024-07-30T17:32:44.011Z,1722360764.011 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:32:44.011Z,1722360764.011 [Default:CheckIn] Stopped
2024-07-30T17:32:44.011Z,1722360764.011 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:32:44.012Z,1722360764.012 [Default:CheckIn](INFO): Running loop #7
2024-07-30T17:32:44.012Z,1722360764.012 [Default:CheckIn] Running Loop=7
2024-07-30T17:32:44.012Z,1722360764.012 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:32:44.012Z,1722360764.012 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:32:46.016Z,1722360766.016 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173245.00,A,3648.32126,N,12147.12532,W,4.743,3.51,300724,,,D*75
2024-07-30T17:32:46.018Z,1722360766.018 [NAL9602](INFO): GPS fix at 20240730T173245: (36.805354, -121.785422)
2024-07-30T17:32:46.058Z,1722360766.058 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:32:46.058Z,1722360766.058 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:32:55.820Z,1722360775.820 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240730T165255/Courier0025.lzma
2024-07-30T17:32:56.823Z,1722360776.823 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0025.lzma.bak
2024-07-30T17:32:56.823Z,1722360776.823 [DataOverHttps](INFO): SBD MOMSN=21394917
2024-07-30T17:33:12.776Z,1722360792.776 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20240730T165255/Express0026.lzma
2024-07-30T17:33:13.779Z,1722360793.779 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0026.lzma.bak
2024-07-30T17:33:13.779Z,1722360793.779 [DataOverHttps](INFO): SBD MOMSN=21394920
2024-07-30T17:33:14.764Z,1722360794.764 [NAL9602](INFO): SBD MO Status=0, MOMSN=14172, MT Status=0, MTMSN=0
2024-07-30T17:33:14.764Z,1722360794.764 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:33:15.183Z,1722360795.183 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:33:15.183Z,1722360795.183 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:33:15.183Z,1722360795.183 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:33:45.474Z,1722360825.474 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:35:22.538Z,1722360922.538 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:35:22.538Z,1722360922.538 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:35:22.549Z,1722360922.549 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:35:22.956Z,1722360922.956 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:35:22.956Z,1722360922.956 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:38:15.935Z,1722361095.935 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:38:15.935Z,1722361095.935 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:38:15.935Z,1722361095.935 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:38:15.936Z,1722361095.936 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:38:16.323Z,1722361096.323 [Default:CheckIn:D] Stopped
2024-07-30T17:38:16.323Z,1722361096.323 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:38:16.721Z,1722361096.721 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.788269 min
2024-07-30T17:38:16.721Z,1722361096.721 [Default:CheckIn:E] Stopped
2024-07-30T17:38:16.721Z,1722361096.721 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:38:16.721Z,1722361096.721 [Default:CheckIn] Stopped
2024-07-30T17:38:16.721Z,1722361096.721 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:38:16.722Z,1722361096.722 [Default:CheckIn](INFO): Running loop #8
2024-07-30T17:38:16.722Z,1722361096.722 [Default:CheckIn] Running Loop=8
2024-07-30T17:38:16.722Z,1722361096.722 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:38:16.722Z,1722361096.722 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:38:18.728Z,1722361098.728 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173817.00,A,3648.29530,N,12147.76167,W,20.702,255.68,300724,,,D*4F
2024-07-30T17:38:18.739Z,1722361098.739 [NAL9602](INFO): GPS fix at 20240730T173817: (36.804922, -121.796028)
2024-07-30T17:38:18.754Z,1722361098.754 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:38:18.754Z,1722361098.754 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:38:23.614Z,1722361103.614 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:38:23.614Z,1722361103.614 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:38:23.638Z,1722361103.638 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:38:24.039Z,1722361104.039 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:38:24.039Z,1722361104.039 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:38:25.988Z,1722361105.988 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240730T165255/Courier0028.lzma
2024-07-30T17:38:26.991Z,1722361106.991 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0028.lzma.bak
2024-07-30T17:38:26.991Z,1722361106.991 [DataOverHttps](INFO): SBD MOMSN=21394924
2024-07-30T17:38:43.049Z,1722361123.049 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240730T165255/Express0029.lzma
2024-07-30T17:38:44.051Z,1722361124.051 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0029.lzma.bak
2024-07-30T17:38:44.051Z,1722361124.051 [DataOverHttps](INFO): SBD MOMSN=21394927
2024-07-30T17:38:45.407Z,1722361125.407 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:38:45.407Z,1722361125.407 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:38:45.407Z,1722361125.407 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:38:49.059Z,1722361129.059 [NAL9602](INFO): SBD MO Status=0, MOMSN=14173, MT Status=0, MTMSN=0
2024-07-30T17:38:49.060Z,1722361129.060 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:39:19.798Z,1722361159.798 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:41:24.710Z,1722361284.710 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:41:24.710Z,1722361284.710 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:41:24.721Z,1722361284.721 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:41:25.122Z,1722361285.122 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:41:25.122Z,1722361285.122 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:43:46.164Z,1722361426.164 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:43:46.164Z,1722361426.164 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:43:46.164Z,1722361426.164 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:43:46.164Z,1722361426.164 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:43:46.567Z,1722361426.567 [Default:CheckIn:D] Stopped
2024-07-30T17:43:46.567Z,1722361426.567 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:43:46.974Z,1722361426.974 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.292338 min
2024-07-30T17:43:46.974Z,1722361426.974 [Default:CheckIn:E] Stopped
2024-07-30T17:43:46.974Z,1722361426.974 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:43:46.975Z,1722361426.975 [Default:CheckIn] Stopped
2024-07-30T17:43:46.975Z,1722361426.975 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:43:46.975Z,1722361426.975 [Default:CheckIn](INFO): Running loop #9
2024-07-30T17:43:46.975Z,1722361426.975 [Default:CheckIn] Running Loop=9
2024-07-30T17:43:46.975Z,1722361426.975 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:43:46.975Z,1722361426.975 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:43:48.988Z,1722361428.988 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174348.00,A,3647.92934,N,12149.55219,W,15.512,263.09,300724,,,D*4C
2024-07-30T17:43:48.991Z,1722361428.991 [NAL9602](INFO): GPS fix at 20240730T174348: (36.798822, -121.825870)
2024-07-30T17:43:49.006Z,1722361429.006 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:43:49.006Z,1722361429.006 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:43:55.832Z,1722361435.832 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240730T165255/Courier0031.lzma
2024-07-30T17:43:56.835Z,1722361436.835 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0031.lzma.bak
2024-07-30T17:43:56.835Z,1722361436.835 [DataOverHttps](INFO): SBD MOMSN=21394931
2024-07-30T17:44:07.568Z,1722361447.568 [NAL9602](INFO): SBD MO Status=0, MOMSN=14174, MT Status=0, MTMSN=0
2024-07-30T17:44:07.568Z,1722361447.568 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:44:12.841Z,1722361452.841 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20240730T165255/Express0032.lzma
2024-07-30T17:44:13.843Z,1722361453.843 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0032.lzma.bak
2024-07-30T17:44:13.843Z,1722361453.843 [DataOverHttps](INFO): SBD MOMSN=21394934
2024-07-30T17:44:14.897Z,1722361454.897 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:44:14.897Z,1722361454.897 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:44:14.897Z,1722361454.897 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:44:25.798Z,1722361465.798 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:44:25.798Z,1722361465.798 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:44:25.809Z,1722361465.809 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:44:26.213Z,1722361466.213 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:44:26.213Z,1722361466.213 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:44:38.310Z,1722361478.310 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:47:26.866Z,1722361646.866 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:47:26.866Z,1722361646.866 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:47:26.877Z,1722361646.877 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:47:27.276Z,1722361647.276 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:47:27.276Z,1722361647.276 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T17:49:15.603Z,1722361755.603 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:49:15.603Z,1722361755.603 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:49:15.603Z,1722361755.603 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:49:15.603Z,1722361755.603 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:49:16.004Z,1722361756.004 [Default:CheckIn:D] Stopped
2024-07-30T17:49:16.004Z,1722361756.004 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:49:16.409Z,1722361756.409 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.782955 min
2024-07-30T17:49:16.409Z,1722361756.409 [Default:CheckIn:E] Stopped
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn] Stopped
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn](INFO): Running loop #10
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn] Running Loop=10
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:49:16.410Z,1722361756.410 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:49:18.416Z,1722361758.416 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174917.00,A,3647.81696,N,12150.69051,W,0.778,76.78,300724,,,D*4A
2024-07-30T17:49:18.426Z,1722361758.426 [NAL9602](INFO): GPS fix at 20240730T174917: (36.796949, -121.844842)
2024-07-30T17:49:18.441Z,1722361758.441 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:49:18.441Z,1722361758.441 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:49:25.688Z,1722361765.688 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240730T165255/Courier0034.lzma
2024-07-30T17:49:26.691Z,1722361766.691 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0034.lzma.bak
2024-07-30T17:49:26.691Z,1722361766.691 [DataOverHttps](INFO): SBD MOMSN=21394938
2024-07-30T17:49:42.705Z,1722361782.705 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20240730T165255/Express0035.lzma
2024-07-30T17:49:43.707Z,1722361783.707 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0035.lzma.bak
2024-07-30T17:49:43.707Z,1722361783.707 [DataOverHttps](INFO): SBD MOMSN=21394941
2024-07-30T17:49:45.111Z,1722361785.111 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:49:45.111Z,1722361785.111 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:49:45.111Z,1722361785.111 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:49:47.099Z,1722361787.099 [NAL9602](INFO): SBD MO Status=0, MOMSN=14175, MT Status=0, MTMSN=0
2024-07-30T17:49:47.100Z,1722361787.100 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:50:17.802Z,1722361817.802 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:50:27.916Z,1722361827.916 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:50:27.916Z,1722361827.916 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:50:27.927Z,1722361827.927 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:50:28.336Z,1722361828.336 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:50:28.336Z,1722361828.336 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:51:23.590Z,1722361883.590 [DataOverHttps](IMPORTANT): SBD MTMSN=20240730T175122
2024-07-30T17:51:30.981Z,1722361890.981 [DataOverHttps](INFO): Received command: ibit; failc
2024-07-30T17:51:31.074Z,1722361891.074 [CommandExec](IMPORTANT): got command ibit
2024-07-30T17:51:31.074Z,1722361891.074 [CommandExec](IMPORTANT): got command failComponent
2024-07-30T17:51:31.074Z,1722361891.074 [CommandExec](IMPORTANT): Failed components:
2024-07-30T17:51:31.075Z,1722361891.075 [CommandExec](IMPORTANT): No failed Components.
2024-07-30T17:51:31.406Z,1722361891.406 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-30T17:51:31.406Z,1722361891.406 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-30T17:51:31.409Z,1722361891.409 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-30T17:51:32.976Z,1722361892.976 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175132.00,A,3647.82252,N,12150.64950,W,0.778,81.23,300724,,,D*48
2024-07-30T17:51:32.979Z,1722361892.979 [NAL9602](INFO): GPS fix at 20240730T175132: (36.797042, -121.844158)
2024-07-30T17:51:42.352Z,1722361902.352 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.010433
CHAN A1 (24V): 0.015297
CHAN A2 (12V): 0.007434
CHAN A3 (5V): 0.001762
CHAN B0 (3.3V): 0.002359
CHAN B1 (3.15aV): 0.001944
CHAN B2 (3.15bV): 0.002490
CHAN B3 (GND): -0.000289
OPEN: 0.008014
Full Scale: +/- 1 mA
2024-07-30T17:51:46.712Z,1722361906.712 [NAL9602](INFO): SBD MO Status=0, MOMSN=14176, MT Status=0, MTMSN=0
2024-07-30T17:51:46.712Z,1722361906.712 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:51:47.924Z,1722361907.924 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175147.00,A,3647.82305,N,12150.64508,W,0.661,79.84,300724,,,D*4B
2024-07-30T17:51:47.926Z,1722361907.926 [NAL9602](INFO): GPS fix at 20240730T175147: (36.797051, -121.844085)
2024-07-30T17:51:51.160Z,1722361911.160 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175150.00,A,3647.82319,N,12150.64435,W,1.108,78.31,300724,,,D*49
2024-07-30T17:51:51.163Z,1722361911.163 [NAL9602](INFO): GPS fix at 20240730T175150: (36.797053, -121.844072)
2024-07-30T17:51:53.985Z,1722361913.985 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175153.00,A,3647.82334,N,12150.64358,W,0.739,80.26,300724,,,D*4D
2024-07-30T17:51:53.987Z,1722361913.987 [NAL9602](INFO): GPS fix at 20240730T175153: (36.797056, -121.844060)
2024-07-30T17:51:57.220Z,1722361917.220 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175156.00,A,3647.82343,N,12150.64280,W,0.603,75.42,300724,,,D*4C
2024-07-30T17:51:57.223Z,1722361917.223 [NAL9602](INFO): GPS fix at 20240730T175156: (36.797057, -121.844047)
2024-07-30T17:52:00.048Z,1722361920.048 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175159.00,A,3647.82356,N,12150.64199,W,0.486,76.65,300724,,,D*45
2024-07-30T17:52:00.050Z,1722361920.050 [NAL9602](INFO): GPS fix at 20240730T175159: (36.797059, -121.844033)
2024-07-30T17:52:03.279Z,1722361923.279 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175202.00,A,3647.82368,N,12150.64110,W,0.933,77.87,300724,,,D*4A
2024-07-30T17:52:03.281Z,1722361923.281 [NAL9602](INFO): GPS fix at 20240730T175202: (36.797061, -121.844018)
2024-07-30T17:52:06.108Z,1722361926.108 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175205.00,A,3647.82383,N,12150.64025,W,0.875,76.66,300724,,,D*42
2024-07-30T17:52:06.110Z,1722361926.110 [NAL9602](INFO): GPS fix at 20240730T175205: (36.797064, -121.844004)
2024-07-30T17:52:08.932Z,1722361928.932 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175208.00,A,3647.82402,N,12150.63948,W,0.641,75.43,300724,,,D*49
2024-07-30T17:52:08.934Z,1722361928.934 [NAL9602](INFO): GPS fix at 20240730T175208: (36.797067, -121.843991)
2024-07-30T17:52:12.164Z,1722361932.164 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175211.00,A,3647.82409,N,12150.63870,W,0.778,84.24,300724,,,D*44
2024-07-30T17:52:12.166Z,1722361932.166 [NAL9602](INFO): GPS fix at 20240730T175211: (36.797068, -121.843978)
2024-07-30T17:52:14.992Z,1722361934.992 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175214.00,A,3647.82420,N,12150.63779,W,1.050,84.91,300724,,,D*4E
2024-07-30T17:52:15.003Z,1722361935.003 [NAL9602](INFO): GPS fix at 20240730T175214: (36.797070, -121.843963)
2024-07-30T17:52:17.863Z,1722361937.863 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 5
Latitude: 36.797070 Longitude: -121.843964
2024-07-30T17:52:18.224Z,1722361938.224 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175217.00,A,3647.82434,N,12150.63710,W,0.778,80.05,300724,,,D*42
2024-07-30T17:52:18.226Z,1722361938.226 [NAL9602](INFO): GPS fix at 20240730T175217: (36.797072, -121.843952)
2024-07-30T17:52:18.261Z,1722361938.261 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 16.572001
2024-07-30T17:52:18.262Z,1722361938.262 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2024-07-30T17:52:18.262Z,1722361938.262 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2024-07-30T17:52:18.671Z,1722361938.671 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-30T17:52:18.671Z,1722361938.671 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-30T17:52:18.671Z,1722361938.671 [IBIT](IMPORTANT): Pressure:9.938756 PSI
2024-07-30T17:52:18.672Z,1722361938.672 [IBIT](IMPORTANT): Humidity:20.284458 %
2024-07-30T17:52:19.053Z,1722361939.053 [IBIT](IMPORTANT): Vehicle Pitch:1.177287 degrees
2024-07-30T17:52:19.054Z,1722361939.054 [IBIT](IMPORTANT): Vehicle Roll:-1.582732 degrees
2024-07-30T17:52:19.054Z,1722361939.054 [IBIT](IMPORTANT): Vehicle Heading:91.254005 degrees
2024-07-30T17:52:19.455Z,1722361939.455 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-30T17:52:19.455Z,1722361939.455 [IBIT](IMPORTANT): buoyancyNeutral: 152.061630 cc
2024-07-30T17:52:19.455Z,1722361939.455 [IBIT](IMPORTANT): massDefault: 1.630600 cm
2024-07-30T17:52:19.456Z,1722361939.456 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-30T17:52:19.456Z,1722361939.456 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-30T17:52:19.456Z,1722361939.456 [IBIT](IMPORTANT): IBIT PASSED
2024-07-30T17:52:50.542Z,1722361970.542 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:53:28.990Z,1722362008.990 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:53:28.990Z,1722362008.990 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:53:29.025Z,1722362009.025 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:53:29.401Z,1722362009.401 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:53:29.401Z,1722362009.401 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:54:45.701Z,1722362085.701 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T17:54:45.701Z,1722362085.701 [Default:CheckIn:C.Wait] Stopped
2024-07-30T17:54:45.702Z,1722362085.702 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T17:54:45.702Z,1722362085.702 [Default:CheckIn:D] Running Loop=1
2024-07-30T17:54:46.104Z,1722362086.104 [Default:CheckIn:D] Stopped
2024-07-30T17:54:46.104Z,1722362086.104 [Default:CheckIn:E] Running Loop=1
2024-07-30T17:54:46.511Z,1722362086.511 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.284619 min
2024-07-30T17:54:46.511Z,1722362086.511 [Default:CheckIn:E] Stopped
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn] Stopped
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn](INFO): Running loop #11
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn] Running Loop=11
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T17:54:46.512Z,1722362086.512 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T17:54:48.527Z,1722362088.527 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175447.00,A,3647.83244,N,12150.59394,W,0.855,75.25,300724,,,D*48
2024-07-30T17:54:48.529Z,1722362088.529 [NAL9602](INFO): GPS fix at 20240730T175447: (36.797207, -121.843232)
2024-07-30T17:54:48.552Z,1722362088.552 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T17:54:48.552Z,1722362088.552 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T17:54:58.730Z,1722362098.730 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240730T165255/Courier0037.lzma
2024-07-30T17:54:59.731Z,1722362099.731 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0037.lzma.bak
2024-07-30T17:54:59.731Z,1722362099.731 [DataOverHttps](INFO): SBD MOMSN=21394949
2024-07-30T17:55:06.792Z,1722362106.792 [NAL9602](INFO): SBD MO Status=0, MOMSN=14177, MT Status=0, MTMSN=0
2024-07-30T17:55:06.792Z,1722362106.792 [NAL9602](INFO): No messages in MT queue
2024-07-30T17:55:15.673Z,1722362115.673 [DataOverHttps](INFO): Sending 841 bytes from file Logs/20240730T165255/Express0038.lzma
2024-07-30T17:55:16.663Z,1722362116.663 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0038.lzma.bak
2024-07-30T17:55:16.663Z,1722362116.663 [DataOverHttps](INFO): SBD MOMSN=21394953
2024-07-30T17:55:34.608Z,1722362134.608 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20240730T165255/Express0041.lzma
2024-07-30T17:55:35.611Z,1722362135.611 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0041.lzma.bak
2024-07-30T17:55:35.611Z,1722362135.611 [DataOverHttps](INFO): SBD MOMSN=21394982
2024-07-30T17:55:36.706Z,1722362136.706 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T17:55:36.707Z,1722362136.707 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T17:55:36.707Z,1722362136.707 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T17:55:37.494Z,1722362137.494 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T17:56:30.037Z,1722362190.037 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T17:56:30.037Z,1722362190.037 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:56:30.048Z,1722362190.048 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:56:30.460Z,1722362190.460 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:56:30.460Z,1722362190.460 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T17:59:31.038Z,1722362371.038 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-07-30T17:59:31.038Z,1722362371.038 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T17:59:31.049Z,1722362371.049 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T17:59:31.435Z,1722362371.435 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T17:59:31.435Z,1722362371.435 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-07-30T18:00:37.284Z,1722362437.284 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-30T18:00:37.284Z,1722362437.284 [Default:CheckIn:C.Wait] Stopped
2024-07-30T18:00:37.284Z,1722362437.284 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-30T18:00:37.284Z,1722362437.284 [Default:CheckIn:D] Running Loop=1
2024-07-30T18:00:37.698Z,1722362437.698 [Default:CheckIn:D] Stopped
2024-07-30T18:00:37.698Z,1722362437.698 [Default:CheckIn:E] Running Loop=1
2024-07-30T18:00:38.087Z,1722362438.087 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.144515 min
2024-07-30T18:00:38.087Z,1722362438.087 [Default:CheckIn:E] Stopped
2024-07-30T18:00:38.087Z,1722362438.087 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-30T18:00:38.087Z,1722362438.087 [Default:CheckIn] Stopped
2024-07-30T18:00:38.087Z,1722362438.087 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-30T18:00:38.087Z,1722362438.087 [Default:CheckIn](INFO): Running loop #12
2024-07-30T18:00:38.088Z,1722362438.088 [Default:CheckIn] Running Loop=12
2024-07-30T18:00:38.088Z,1722362438.088 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-30T18:00:38.088Z,1722362438.088 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-30T18:00:40.093Z,1722362440.093 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180039.00,A,3647.85329,N,12150.48800,W,0.797,90.42,300724,,,D*4E
2024-07-30T18:00:40.095Z,1722362440.095 [NAL9602](INFO): GPS fix at 20240730T180039: (36.797555, -121.841467)
2024-07-30T18:00:40.111Z,1722362440.111 [Default:CheckIn:Read_GPS] Stopped
2024-07-30T18:00:40.111Z,1722362440.111 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-30T18:00:47.272Z,1722362447.272 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240730T165255/Courier0043.lzma
2024-07-30T18:00:48.275Z,1722362448.275 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Courier0043.lzma.bak
2024-07-30T18:00:48.275Z,1722362448.275 [DataOverHttps](INFO): SBD MOMSN=21394986
2024-07-30T18:00:52.248Z,1722362452.248 [NAL9602](INFO): SBD MO Status=0, MOMSN=14178, MT Status=0, MTMSN=0
2024-07-30T18:00:52.248Z,1722362452.248 [NAL9602](INFO): No messages in MT queue
2024-07-30T18:01:06.961Z,1722362466.961 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20240730T165255/Express0044.lzma
2024-07-30T18:01:07.963Z,1722362467.963 [DataOverHttps](INFO): Moved sent file to Logs/20240730T165255/Express0044.lzma.bak
2024-07-30T18:01:07.963Z,1722362467.963 [DataOverHttps](INFO): SBD MOMSN=21394989
2024-07-30T18:01:09.268Z,1722362469.268 [Default:CheckIn:Read_Iridium] Stopped
2024-07-30T18:01:09.268Z,1722362469.268 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-30T18:01:09.268Z,1722362469.268 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-30T18:01:22.998Z,1722362482.998 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-30T18:02:32.089Z,1722362552.089 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-07-30T18:02:32.089Z,1722362552.089 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-07-30T18:02:32.100Z,1722362552.100 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-07-30T18:02:32.514Z,1722362552.514 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-07-30T18:02:32.514Z,1722362552.514 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-07-30T18:02:47.990Z,1722362567.990 [DataOverHttps](IMPORTANT): SBD MTMSN=20240730T180246
2024-07-30T18:02:58.384Z,1722362578.384 [DataOverHttps](INFO): Received command: restart logs