2026-02-17T22:04:34.756Z,1771365874.756 [Supervisor](DEBUG): Initializing supervisor.
2026-02-17T22:04:34.760Z,1771365874.760 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2026-02-17T22:04:34.760Z,1771365874.760 [SyncHandler](INFO): Protected caller Thread ID is 834
2026-02-17T22:04:34.761Z,1771365874.761 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2026-02-17T22:04:34.762Z,1771365874.762 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2026-02-17T22:04:34.762Z,1771365874.762 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 835
2026-02-17T22:04:34.766Z,1771365874.766 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2026-02-17T22:04:34.786Z,1771365874.786 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2026-02-17T22:04:34.787Z,1771365874.787 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2026-02-17T22:04:34.787Z,1771365874.787 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 836
2026-02-17T22:04:34.791Z,1771365874.791 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2026-02-17T22:04:34.792Z,1771365874.792 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2026-02-17T22:04:34.792Z,1771365874.792 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 837
2026-02-17T22:04:34.794Z,1771365874.794 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2026-02-17T22:04:34.795Z,1771365874.795 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2026-02-17T22:04:34.796Z,1771365874.796 [logger ThreadHandler](INFO): Protected caller Thread ID is 838
2026-02-17T22:04:34.799Z,1771365874.799 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2026-02-17T22:04:34.800Z,1771365874.800 [Supervisor](INFO): Looking for Config files in directory: Config/
2026-02-17T22:04:34.804Z,1771365874.804 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2026-02-17T22:04:35.141Z,1771365875.141 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2026-02-17T22:04:35.143Z,1771365875.143 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2026-02-17T22:04:35.406Z,1771365875.406 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2026-02-17T22:04:35.408Z,1771365875.408 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2026-02-17T22:04:35.901Z,1771365875.901 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2026-02-17T22:04:35.903Z,1771365875.903 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2026-02-17T22:04:36.143Z,1771365876.143 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2026-02-17T22:04:36.144Z,1771365876.144 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2026-02-17T22:04:36.370Z,1771365876.370 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2026-02-17T22:04:36.372Z,1771365876.372 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2026-02-17T22:04:37.148Z,1771365877.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2026-02-17T22:04:37.149Z,1771365877.149 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2026-02-17T22:04:37.489Z,1771365877.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2026-02-17T22:04:37.489Z,1771365877.489 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2026-02-17T22:04:37.607Z,1771365877.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2026-02-17T22:04:37.608Z,1771365877.608 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2026-02-17T22:04:37.695Z,1771365877.695 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2026-02-17T22:04:37.880Z,1771365877.880 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2026-02-17T22:04:37.882Z,1771365877.882 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2026-02-17T22:04:37.989Z,1771365877.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2026-02-17T22:04:37.990Z,1771365877.990 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2026-02-17T22:04:38.753Z,1771365878.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2026-02-17T22:04:38.754Z,1771365878.754 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2026-02-17T22:04:38.900Z,1771365878.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2026-02-17T22:04:38.901Z,1771365878.901 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2026-02-17T22:04:39.001Z,1771365879.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2026-02-17T22:04:39.001Z,1771365879.001 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2026-02-17T22:04:39.422Z,1771365879.422 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2026-02-17T22:04:39.423Z,1771365879.423 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2026-02-17T22:04:39.969Z,1771365879.969 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2026-02-17T22:04:39.971Z,1771365879.971 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2026-02-17T22:04:39.973Z,1771365879.973 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2026-02-17T22:04:40.098Z,1771365880.098 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2026-02-17T22:04:40.369Z,1771365880.369 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2026-02-17T22:04:40.370Z,1771365880.370 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2026-02-17T22:04:40.482Z,1771365880.482 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2026-02-17T22:04:40.586Z,1771365880.586 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2026-02-17T22:04:40.703Z,1771365880.703 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2026-02-17T22:04:40.859Z,1771365880.859 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2026-02-17T22:04:40.965Z,1771365880.965 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2026-02-17T22:04:41.080Z,1771365881.080 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2026-02-17T22:04:41.173Z,1771365881.173 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2026-02-17T22:04:41.294Z,1771365881.294 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2026-02-17T22:04:41.387Z,1771365881.387 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2026-02-17T22:04:41.390Z,1771365881.390 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2026-02-17T22:04:41.407Z,1771365881.407 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2026-02-17T22:04:41.408Z,1771365881.408 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2026-02-17T22:04:41.554Z,1771365881.554 [DeadReckonUsingMultipleVelocitySources] Loaded
2026-02-17T22:04:41.554Z,1771365881.554 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2026-02-17T22:04:41.593Z,1771365881.593 [DeadReckonWithRespectToSeafloor] Loaded
2026-02-17T22:04:41.594Z,1771365881.594 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2026-02-17T22:04:41.607Z,1771365881.607 [NavChart] Loaded
2026-02-17T22:04:41.607Z,1771365881.607 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2026-02-17T22:04:41.613Z,1771365881.613 [UniversalFixResidualReporter] Loaded
2026-02-17T22:04:41.613Z,1771365881.613 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2026-02-17T22:04:41.613Z,1771365881.613 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2026-02-17T22:04:41.615Z,1771365881.615 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2026-02-17T22:04:42.531Z,1771365882.531 [AHRS_M2] Loaded
2026-02-17T22:04:42.531Z,1771365882.531 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2026-02-17T22:04:42.783Z,1771365882.783 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC3
2026-02-17T22:04:42.784Z,1771365882.784 [BackseatComponent] Loaded
2026-02-17T22:04:42.784Z,1771365882.784 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2026-02-17T22:04:42.785Z,1771365882.785 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408774E0
2026-02-17T22:04:42.786Z,1771365882.786 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921
2026-02-17T22:04:42.789Z,1771365882.789 [LcmPublisher] Loaded
2026-02-17T22:04:42.789Z,1771365882.789 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread.
2026-02-17T22:04:43.581Z,1771365883.581 [BPC1] Loaded
2026-02-17T22:04:43.581Z,1771365883.581 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2026-02-17T22:04:43.751Z,1771365883.751 [DATMMP] Loaded
2026-02-17T22:04:43.751Z,1771365883.751 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2026-02-17T22:04:43.752Z,1771365883.752 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 408A84E0
2026-02-17T22:04:43.753Z,1771365883.753 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 922
2026-02-17T22:04:44.092Z,1771365884.092 [DataOverHttps] Loaded
2026-02-17T22:04:44.093Z,1771365884.093 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2026-02-17T22:04:44.130Z,1771365884.130 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D84E0
2026-02-17T22:04:44.130Z,1771365884.130 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 923
2026-02-17T22:04:44.185Z,1771365884.185 [DepthKeller33X] Loaded
2026-02-17T22:04:44.185Z,1771365884.185 [ComponentRegistry](DEBUG): SyncComponent "DepthKeller33X" handled in the control thread.
2026-02-17T22:04:44.217Z,1771365884.217 [DropWeight] Loaded
2026-02-17T22:04:44.217Z,1771365884.217 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2026-02-17T22:04:44.473Z,1771365884.473 [NAL9602] Loaded
2026-02-17T22:04:44.474Z,1771365884.474 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2026-02-17T22:04:44.503Z,1771365884.503 [Onboard] Loaded
2026-02-17T22:04:44.503Z,1771365884.503 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2026-02-17T22:04:44.504Z,1771365884.504 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409084E0
2026-02-17T22:04:44.504Z,1771365884.504 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 924
2026-02-17T22:04:44.518Z,1771365884.518 [Power24vConverter] Loaded
2026-02-17T22:04:44.518Z,1771365884.518 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2026-02-17T22:04:44.535Z,1771365884.535 [Radio_Surface] Loaded
2026-02-17T22:04:44.535Z,1771365884.535 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2026-02-17T22:04:44.536Z,1771365884.536 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409384E0
2026-02-17T22:04:44.537Z,1771365884.537 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 925
2026-02-17T22:04:44.586Z,1771365884.586 [RDI_Pathfinder] Loaded
2026-02-17T22:04:44.586Z,1771365884.586 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2026-02-17T22:04:44.601Z,1771365884.601 [Sonardyne_Nano] Loaded
2026-02-17T22:04:44.601Z,1771365884.601 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2026-02-17T22:04:44.602Z,1771365884.602 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2026-02-17T22:04:44.602Z,1771365884.602 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2026-02-17T22:04:44.673Z,1771365884.673 [DepthRateCalculator] Loaded
2026-02-17T22:04:44.673Z,1771365884.673 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2026-02-17T22:04:44.679Z,1771365884.679 [PitchRateCalculator] Loaded
2026-02-17T22:04:44.679Z,1771365884.679 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2026-02-17T22:04:44.688Z,1771365884.688 [SpeedCalculator] Loaded
2026-02-17T22:04:44.688Z,1771365884.688 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2026-02-17T22:04:44.693Z,1771365884.693 [YawRateCalculator] Loaded
2026-02-17T22:04:44.693Z,1771365884.693 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2026-02-17T22:04:44.715Z,1771365884.715 [ElevatorOffsetCalculator] Loaded
2026-02-17T22:04:44.715Z,1771365884.715 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2026-02-17T22:04:44.716Z,1771365884.716 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2026-02-17T22:04:44.716Z,1771365884.716 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2026-02-17T22:04:44.825Z,1771365884.825 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2026-02-17T22:04:44.826Z,1771365884.826 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2026-02-17T22:04:44.997Z,1771365884.997 [BuoyancyServo] Loaded
2026-02-17T22:04:44.998Z,1771365884.998 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2026-02-17T22:04:45.021Z,1771365885.021 [ElevatorServo] Loaded
2026-02-17T22:04:45.021Z,1771365885.021 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2026-02-17T22:04:45.044Z,1771365885.044 [MassServo] Loaded
2026-02-17T22:04:45.044Z,1771365885.044 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2026-02-17T22:04:45.066Z,1771365885.066 [RudderServo] Loaded
2026-02-17T22:04:45.067Z,1771365885.067 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2026-02-17T22:04:45.084Z,1771365885.084 [ThrusterHE] Loaded
2026-02-17T22:04:45.084Z,1771365885.084 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2026-02-17T22:04:45.085Z,1771365885.085 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2026-02-17T22:04:45.087Z,1771365885.087 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2026-02-17T22:04:45.309Z,1771365885.309 [CTD_Seabird] Loaded
2026-02-17T22:04:45.309Z,1771365885.309 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2026-02-17T22:04:45.310Z,1771365885.310 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A704E0
2026-02-17T22:04:45.310Z,1771365885.310 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 926
2026-02-17T22:04:45.331Z,1771365885.331 [RBRTridente] Loaded
2026-02-17T22:04:45.331Z,1771365885.331 [ComponentRegistry](DEBUG): Component "RBRTridente" handled in its own thread.
2026-02-17T22:04:45.332Z,1771365885.332 [RBRTridente ThreadHandler](DEBUG): Created PCaller Thread at 40AA04E0
2026-02-17T22:04:45.332Z,1771365885.332 [RBRTridente ThreadHandler](INFO): Protected caller Thread ID is 927
2026-02-17T22:04:45.333Z,1771365885.333 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2026-02-17T22:04:45.334Z,1771365885.334 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2026-02-17T22:04:45.502Z,1771365885.502 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2026-02-17T22:04:45.503Z,1771365885.503 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2026-02-17T22:04:45.721Z,1771365885.721 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2026-02-17T22:04:45.721Z,1771365885.721 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2026-02-17T22:04:46.132Z,1771365886.132 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2026-02-17T22:04:46.133Z,1771365886.133 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2026-02-17T22:04:46.205Z,1771365886.205 [VerticalControl](DEBUG): Construct VerticalControl.
2026-02-17T22:04:46.258Z,1771365886.258 [VerticalControl] Loaded
2026-02-17T22:04:46.258Z,1771365886.258 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2026-02-17T22:04:46.261Z,1771365886.261 [HorizontalControl](DEBUG): Construct HorizontalControl.
2026-02-17T22:04:46.307Z,1771365886.307 [HorizontalControl] Loaded
2026-02-17T22:04:46.307Z,1771365886.307 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2026-02-17T22:04:46.310Z,1771365886.310 [SpeedControl](DEBUG): Construct SpeedControl.
2026-02-17T22:04:46.312Z,1771365886.312 [SpeedControl] Loaded
2026-02-17T22:04:46.312Z,1771365886.312 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2026-02-17T22:04:46.315Z,1771365886.315 [LoopControl](DEBUG): Construct LoopControl.
2026-02-17T22:04:46.315Z,1771365886.315 [LoopControl] Loaded
2026-02-17T22:04:46.315Z,1771365886.315 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2026-02-17T22:04:46.316Z,1771365886.316 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2026-02-17T22:04:46.318Z,1771365886.318 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2026-02-17T22:04:46.513Z,1771365886.513 [SBIT](DEBUG): Construct Startup Built In Test.
2026-02-17T22:04:46.522Z,1771365886.522 [SBIT] Loaded
2026-02-17T22:04:46.522Z,1771365886.522 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2026-02-17T22:04:46.525Z,1771365886.525 [IBIT](DEBUG): Construct Initiated Built In Test.
2026-02-17T22:04:46.538Z,1771365886.538 [IBIT] Loaded
2026-02-17T22:04:46.538Z,1771365886.538 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2026-02-17T22:04:46.543Z,1771365886.543 [CBIT](DEBUG): Construct Continuous Built In Test.
2026-02-17T22:04:46.624Z,1771365886.624 [CBIT] Loaded
2026-02-17T22:04:46.624Z,1771365886.624 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2026-02-17T22:04:46.655Z,1771365886.655 [GFScanner] Loaded
2026-02-17T22:04:46.656Z,1771365886.656 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2026-02-17T22:04:46.656Z,1771365886.656 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2026-02-17T22:04:46.657Z,1771365886.657 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2026-02-17T22:04:46.705Z,1771365886.705 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2026-02-17T22:04:46.712Z,1771365886.712 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2026-02-17T22:04:46.714Z,1771365886.714 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2026-02-17T22:04:46.725Z,1771365886.725 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2026-02-17T22:04:46.726Z,1771365886.726 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C8B4E0
2026-02-17T22:04:46.727Z,1771365886.727 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928
2026-02-17T22:04:46.731Z,1771365886.731 [Supervisor](INFO): Main Thread ID is 825
2026-02-17T22:04:46.731Z,1771365886.731 [Supervisor](DEBUG): Running supervisor.
2026-02-17T22:04:46.732Z,1771365886.732 [CommandExec ThreadHandler](INFO): Handler Thread ID is 929
2026-02-17T22:04:46.732Z,1771365886.732 [CommandExec](INFO): Initializing the command executive.
2026-02-17T22:04:46.734Z,1771365886.734 [CommandLine ThreadHandler](INFO): Handler Thread ID is 930
2026-02-17T22:04:46.736Z,1771365886.736 [controlThread ThreadHandler](INFO): Handler Thread ID is 931
2026-02-17T22:04:46.736Z,1771365886.736 [controlThread](DEBUG): Initializing ControlThread
2026-02-17T22:04:46.738Z,1771365886.738 [NavChart](DEBUG): Initialize NavChart Navigation.
2026-02-17T22:04:46.739Z,1771365886.739 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2026-02-17T22:04:46.742Z,1771365886.742 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2026-02-17T22:04:46.742Z,1771365886.742 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2026-02-17T22:04:46.742Z,1771365886.742 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2026-02-17T22:04:46.743Z,1771365886.743 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2026-02-17T22:04:46.743Z,1771365886.743 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2026-02-17T22:04:46.744Z,1771365886.744 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2026-02-17T22:04:46.746Z,1771365886.746 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2026-02-17T22:04:46.746Z,1771365886.746 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2026-02-17T22:04:46.747Z,1771365886.747 [LoopControl](DEBUG): Initialize LoopControlComponent.
2026-02-17T22:04:46.747Z,1771365886.747 [SBIT](INFO): Initialize SBIT Component.
2026-02-17T22:04:46.748Z,1771365886.748 [SBIT](IMPORTANT): git: 2025-12-17_B-140-g2da5f0ee2
2026-02-17T22:04:46.748Z,1771365886.748 [SBIT](INFO): git hash: 2da5f0ee2d5b6be0b72b0d58b05d4f57e3a852cb
2026-02-17T22:04:46.748Z,1771365886.748 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2026-02-17T22:04:46.749Z,1771365886.749 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Mon Nov 27 01:04:18 PST 2023
2026-02-17T22:04:46.750Z,1771365886.750 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2026-02-17T22:04:46.751Z,1771365886.751 [IBIT](INFO): Initialize IBIT Component.
2026-02-17T22:04:46.752Z,1771365886.752 [CBIT](DEBUG): Initialize CBIT Component.
2026-02-17T22:04:46.753Z,1771365886.753 [logger ThreadHandler](INFO): Handler Thread ID is 932
2026-02-17T22:04:46.765Z,1771365886.765 [CBIT](DEBUG): Initialized mux pins.
2026-02-17T22:04:46.765Z,1771365886.765 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2026-02-17T22:04:46.765Z,1771365886.765 [CBIT](DEBUG): Initializing the watchdog timer.
2026-02-17T22:04:46.777Z,1771365886.777 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 933
2026-02-17T22:04:46.789Z,1771365886.789 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2026-02-17T22:04:46.789Z,1771365886.789 [CBIT](DEBUG): Initializing heartbeat.
2026-02-17T22:04:46.790Z,1771365886.790 [DATMMP ThreadHandler](INFO): Handler Thread ID is 934
2026-02-17T22:04:46.791Z,1771365886.791 [DATMMP](INFO): Start
2026-02-17T22:04:46.791Z,1771365886.791 [DATMMP](INFO): Powering up
2026-02-17T22:04:46.791Z,1771365886.791 [DATMMP](DEBUG): Initializing DATMMP.
2026-02-17T22:04:46.794Z,1771365886.794 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 936
2026-02-17T22:04:46.796Z,1771365886.796 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2026-02-17T22:04:46.817Z,1771365886.817 [Onboard ThreadHandler](INFO): Handler Thread ID is 937
2026-02-17T22:04:46.835Z,1771365886.835 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 938
2026-02-17T22:04:46.849Z,1771365886.849 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 939
2026-02-17T22:04:46.850Z,1771365886.850 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2026-02-17T22:04:46.854Z,1771365886.854 [RBRTridente ThreadHandler](INFO): Handler Thread ID is 941
2026-02-17T22:04:46.855Z,1771365886.855 [RBRTridente](INFO): Start
2026-02-17T22:04:46.857Z,1771365886.857 [RBRTridente](INFO): Powering up
2026-02-17T22:04:46.859Z,1771365886.859 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 943
2026-02-17T22:04:46.861Z,1771365886.861 [CBIT](DEBUG): Deactivating emergency mode.
2026-02-17T22:04:46.867Z,1771365886.867 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2026-02-17T22:04:46.867Z,1771365886.867 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2026-02-17T22:04:46.867Z,1771365886.867 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2026-02-17T22:04:46.868Z,1771365886.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2026-02-17T22:04:46.868Z,1771365886.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2026-02-17T22:04:46.868Z,1771365886.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2026-02-17T22:04:46.868Z,1771365886.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2026-02-17T22:04:46.868Z,1771365886.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2026-02-17T22:04:46.901Z,1771365886.901 [CBIT](DEBUG): Backplane powered.
2026-02-17T22:04:46.901Z,1771365886.901 [GFScanner](DEBUG): Initializing GFScanner
2026-02-17T22:04:46.901Z,1771365886.901 [GFScanner](DEBUG): Deactivating GF circuits.
2026-02-17T22:04:46.906Z,1771365886.906 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2026-02-17T22:04:46.907Z,1771365886.907 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2026-02-17T22:04:46.907Z,1771365886.907 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2026-02-17T22:04:46.912Z,1771365886.912 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2026-02-17T22:04:46.965Z,1771365886.965 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2026-02-17T22:04:46.989Z,1771365886.989 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2026-02-17T22:04:47.041Z,1771365887.041 [DATMMP](INFO): Starting
2026-02-17T22:04:47.046Z,1771365887.046 [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
    }
  }
}


2026-02-17T22:04:47.047Z,1771365887.047 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2026-02-17T22:04:47.047Z,1771365887.047 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2026-02-17T22:04:47.057Z,1771365887.057 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2026-02-17T22:04:47.241Z,1771365887.241 [Radio_Surface](INFO): Powering up
2026-02-17T22:04:47.257Z,1771365887.257 [RBRTridente](INFO): Starting
2026-02-17T22:04:47.293Z,1771365887.293 [DATMMP](INFO): Starting
2026-02-17T22:04:47.340Z,1771365887.340 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2026-02-17T22:04:47.359Z,1771365887.359 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2026-02-17T22:04:47.360Z,1771365887.360 [Default:A.Wait](DEBUG): Construct Wait.
2026-02-17T22:04:47.378Z,1771365887.378 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2026-02-17T22:04:47.404Z,1771365887.404 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2026-02-17T22:04:47.424Z,1771365887.424 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2026-02-17T22:04:47.449Z,1771365887.449 [Default:E.Execute](DEBUG): Construct Execute.
2026-02-17T22:04:47.452Z,1771365887.452 [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"
  }
}


2026-02-17T22:04:47.458Z,1771365887.458 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DepthKeller33X,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmPublisher,Reporter,LogSplitter,
2026-02-17T22:04:47.469Z,1771365887.469 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2026-02-17T22:04:47.545Z,1771365887.545 [DATMMP](INFO): Starting
2026-02-17T22:04:47.634Z,1771365887.634 [DepthKeller33X](INFO): Initializing.
2026-02-17T22:04:47.654Z,1771365887.654 [Power24vConverter](INFO): Powering up.
2026-02-17T22:04:47.655Z,1771365887.655 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2026-02-17T22:04:47.661Z,1771365887.661 [RBRTridente](INFO): Stop
2026-02-17T22:04:47.662Z,1771365887.662 [Sonardyne_Nano](INFO): Initializing.
2026-02-17T22:04:47.681Z,1771365887.681 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-17T22:04:47.693Z,1771365887.693 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2026-02-17T22:04:47.701Z,1771365887.701 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2026-02-17T22:04:47.702Z,1771365887.702 [ElevatorServo](DEBUG): Initializing EZServoServo.
2026-02-17T22:04:47.709Z,1771365887.709 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2026-02-17T22:04:47.710Z,1771365887.710 [MassServo](DEBUG): Initializing EZServoServo.
2026-02-17T22:04:47.717Z,1771365887.717 [MassServo](DEBUG): Initializing MassServo.
2026-02-17T22:04:47.718Z,1771365887.718 [RudderServo](DEBUG): Initializing EZServoServo.
2026-02-17T22:04:47.725Z,1771365887.725 [RudderServo](DEBUG): Initializing RudderServo.
2026-02-17T22:04:47.726Z,1771365887.726 [ThrusterHE](DEBUG): Initializing EZServoServo.
2026-02-17T22:04:47.733Z,1771365887.733 [RBRTridente](INFO): Powering down
2026-02-17T22:04:47.735Z,1771365887.735 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2026-02-17T22:04:47.797Z,1771365887.797 [DATMMP](INFO): Starting
2026-02-17T22:04:47.922Z,1771365887.922 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2026-02-17T22:04:47.922Z,1771365887.922 [DropWeight] Hardware Fault, FailCount= 1
2026-02-17T22:04:47.922Z,1771365887.922 [DropWeight](ERROR): Hardware Fault
2026-02-17T22:04:47.923Z,1771365887.923 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-17T22:04:47.940Z,1771365887.940 [CommandExec](FAULT): Scheduling is paused
2026-02-17T22:04:47.949Z,1771365887.949 [CBIT](INFO): Critical error at 20260217T220447
2026-02-17T22:04:47.949Z,1771365887.949 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2026-02-17T22:04:47.952Z,1771365887.952 [CBIT](ERROR): Hardware Fault in component: DropWeight
2026-02-17T22:04:47.952Z,1771365887.952 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2026-02-17T22:04:48.049Z,1771365888.049 [DATMMP](INFO): Starting
2026-02-17T22:04:48.065Z,1771365888.065 [RBRTridente](INFO): Stopping
2026-02-17T22:04:48.272Z,1771365888.272 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-17T22:04:48.284Z,1771365888.284 [CBIT](INFO): Critical error at 20260217T220447
2026-02-17T22:04:48.301Z,1771365888.301 [DATMMP](INFO): Starting
2026-02-17T22:04:48.553Z,1771365888.553 [DATMMP](INFO): Starting
2026-02-17T22:04:48.676Z,1771365888.676 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-17T22:04:48.805Z,1771365888.805 [DATMMP](INFO): Starting
2026-02-17T22:04:49.057Z,1771365889.057 [DATMMP](INFO): Starting
2026-02-17T22:04:49.079Z,1771365889.079 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-17T22:04:49.309Z,1771365889.309 [DATMMP](INFO): Starting
2026-02-17T22:04:49.506Z,1771365889.506 [DepthRateCalculator](ERROR): Depth measurement is not active
2026-02-17T22:04:49.561Z,1771365889.561 [DATMMP](INFO): Starting
2026-02-17T22:04:49.813Z,1771365889.813 [DATMMP](INFO): Starting
2026-02-17T22:04:50.066Z,1771365890.066 [DATMMP](INFO): Starting
2026-02-17T22:04:50.317Z,1771365890.317 [DATMMP](INFO): Starting
2026-02-17T22:04:50.569Z,1771365890.569 [DATMMP](INFO): Starting
2026-02-17T22:04:50.821Z,1771365890.821 [DATMMP](INFO): Starting
2026-02-17T22:04:51.073Z,1771365891.073 [DATMMP](INFO): Starting
2026-02-17T22:04:51.325Z,1771365891.325 [DATMMP](INFO): Starting
2026-02-17T22:04:51.577Z,1771365891.577 [DATMMP](INFO): Starting
2026-02-17T22:04:51.832Z,1771365891.832 [DATMMP](INFO): Starting
2026-02-17T22:04:52.082Z,1771365892.082 [DATMMP](INFO): Starting
2026-02-17T22:04:52.334Z,1771365892.334 [DATMMP](INFO): Starting
2026-02-17T22:04:52.585Z,1771365892.585 [DATMMP](INFO): Starting
2026-02-17T22:04:52.838Z,1771365892.838 [DATMMP](INFO): Starting
2026-02-17T22:04:53.089Z,1771365893.089 [DATMMP](INFO): Starting
2026-02-17T22:04:53.341Z,1771365893.341 [DATMMP](INFO): Starting
2026-02-17T22:04:53.594Z,1771365893.594 [DATMMP](INFO): Starting
2026-02-17T22:04:53.845Z,1771365893.845 [DATMMP](INFO): Starting
2026-02-17T22:04:53.883Z,1771365893.883 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2026-02-17T22:04:54.097Z,1771365894.097 [DATMMP](INFO): Starting
2026-02-17T22:04:54.350Z,1771365894.350 [DATMMP](INFO): Starting
2026-02-17T22:04:54.601Z,1771365894.601 [DATMMP](INFO): Starting
2026-02-17T22:04:54.854Z,1771365894.854 [DATMMP](INFO): Starting
2026-02-17T22:04:55.105Z,1771365895.105 [DATMMP](INFO): Starting
2026-02-17T22:04:55.357Z,1771365895.357 [DATMMP](INFO): Starting
2026-02-17T22:04:55.609Z,1771365895.609 [DATMMP](INFO): Starting
2026-02-17T22:04:55.861Z,1771365895.861 [DATMMP](INFO): Starting
2026-02-17T22:04:56.113Z,1771365896.113 [DATMMP](INFO): Starting
2026-02-17T22:04:56.365Z,1771365896.365 [DATMMP](INFO): Starting
2026-02-17T22:04:56.618Z,1771365896.618 [DATMMP](INFO): Starting
2026-02-17T22:04:56.870Z,1771365896.870 [DATMMP](INFO): Starting
2026-02-17T22:04:57.121Z,1771365897.121 [DATMMP](INFO): Starting
2026-02-17T22:04:57.373Z,1771365897.373 [DATMMP](INFO): Starting
2026-02-17T22:04:57.626Z,1771365897.626 [DATMMP](INFO): Starting
2026-02-17T22:04:57.877Z,1771365897.877 [DATMMP](INFO): Starting
2026-02-17T22:04:58.130Z,1771365898.130 [DATMMP](INFO): Starting
2026-02-17T22:04:58.382Z,1771365898.382 [DATMMP](INFO): Starting
2026-02-17T22:04:58.384Z,1771365898.384 [DATMMP](INFO): DAT read: 

2026-02-17T22:04:58.386Z,1771365898.386 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series

2026-02-17T22:04:58.633Z,1771365898.633 [DATMMP](INFO): Starting
2026-02-17T22:04:58.885Z,1771365898.885 [DATMMP](INFO): Starting
2026-02-17T22:04:59.137Z,1771365899.137 [DATMMP](INFO): Starting
2026-02-17T22:04:59.389Z,1771365899.389 [DATMMP](INFO): Starting
2026-02-17T22:04:59.641Z,1771365899.641 [DATMMP](INFO): Starting
2026-02-17T22:04:59.893Z,1771365899.893 [DATMMP](INFO): Starting
2026-02-17T22:05:00.146Z,1771365900.146 [DATMMP](INFO): Starting
2026-02-17T22:05:00.147Z,1771365900.147 [DATMMP](INFO): DAT read: MF Frequency Band 5120 bandwidth

2026-02-17T22:05:00.148Z,1771365900.148 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.19.1

2026-02-17T22:05:00.148Z,1771365900.148 [DATMMP](INFO): DAT read: Jan 17 2000 22:04:54 

2026-02-17T22:05:00.398Z,1771365900.398 [DATMMP](INFO): Starting
2026-02-17T22:05:00.649Z,1771365900.649 [DATMMP](INFO): Starting
2026-02-17T22:05:00.650Z,1771365900.650 [DATMMP](INFO): DAT read: Features enabled [Bearing]

2026-02-17T22:05:00.652Z,1771365900.652 [DATMMP](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP

2026-02-17T22:05:00.653Z,1771365900.653 [DATMMP](INFO): commRate: 600
2026-02-17T22:05:00.901Z,1771365900.901 [DATMMP](INFO): Starting
2026-02-17T22:05:01.153Z,1771365901.153 [DATMMP](INFO): Starting
2026-02-17T22:05:01.405Z,1771365901.405 [DATMMP](INFO): Starting
2026-02-17T22:05:01.657Z,1771365901.657 [DATMMP](INFO): Starting
2026-02-17T22:05:01.909Z,1771365901.909 [DATMMP](INFO): Starting
2026-02-17T22:05:02.162Z,1771365902.162 [DATMMP](INFO): Starting
2026-02-17T22:05:02.413Z,1771365902.413 [DATMMP](INFO): Starting
2026-02-17T22:05:02.665Z,1771365902.665 [DATMMP](INFO): Starting
2026-02-17T22:05:02.717Z,1771365902.717 [DATMMP](INFO): entering command mode
2026-02-17T22:05:02.917Z,1771365902.917 [DATMMP](INFO): Starting
2026-02-17T22:05:02.918Z,1771365902.918 [DATMMP](INFO): DAT read: 

2026-02-17T22:05:02.918Z,1771365902.918 [DATMMP](INFO): DAT read: user:1>

2026-02-17T22:05:02.918Z,1771365902.918 [DATMMP](DEBUG): read user prompt 1: user:1>

2026-02-17T22:05:02.919Z,1771365902.919 [DATMMP](INFO): entering MMP mode
2026-02-17T22:05:03.169Z,1771365903.169 [DATMMP](INFO): Starting
2026-02-17T22:05:03.170Z,1771365903.170 [DATMMP](INFO): GSXN notify for xid: 0
2026-02-17T22:05:03.171Z,1771365903.171 [DATMMP](INFO): status rx: 	 x1
2026-02-17T22:05:03.172Z,1771365903.172 [DATMMP](INFO): MMP status: 1: started
2026-02-17T22:05:03.172Z,1771365903.172 [DATMMP](INFO): Received message type: status
2026-02-17T22:05:03.172Z,1771365903.172 [DATMMP](INFO): Handled
2026-02-17T22:05:03.421Z,1771365903.421 [DATMMP](INFO): Starting
2026-02-17T22:05:03.422Z,1771365903.422 [DATMMP](INFO): Sent Tx Power Config 8
2026-02-17T22:05:03.423Z,1771365903.423 [DATMMP](INFO): Setting local address: 3
2026-02-17T22:05:03.424Z,1771365903.424 [DATMMP](INFO): Setting time to: 22:5:3 And date to:2/17/2026
2026-02-17T22:05:03.673Z,1771365903.673 [DATMMP](INFO): Starting
2026-02-17T22:05:03.674Z,1771365903.674 [DATMMP](INFO): GSXN notify for xid: 0
2026-02-17T22:05:03.675Z,1771365903.675 [DATMMP](INFO): mdmpower rx: 	 x8	 x0	 x5	 x0
2026-02-17T22:05:03.675Z,1771365903.675 [DATMMP](INFO): Received message type: mdmpower
2026-02-17T22:05:03.675Z,1771365903.675 [DATMMP](INFO): Handled
2026-02-17T22:05:03.926Z,1771365903.926 [DATMMP](INFO): Starting
2026-02-17T22:05:03.926Z,1771365903.926 [DATMMP](INFO): GSXN notify for xid: 10
2026-02-17T22:05:03.928Z,1771365903.928 [DATMMP](INFO): sreg_txpower rx: 	 x8
2026-02-17T22:05:03.928Z,1771365903.928 [DATMMP](INFO): Received message type: sreg_txpower
2026-02-17T22:05:03.928Z,1771365903.928 [DATMMP](INFO): Match for : sreg_txpower
2026-02-17T22:05:03.929Z,1771365903.929 [DATMMP](INFO): ACK
2026-02-17T22:05:04.178Z,1771365904.178 [DATMMP](INFO): Starting
2026-02-17T22:05:04.179Z,1771365904.179 [DATMMP](INFO): GSXN notify for xid: 0
2026-02-17T22:05:04.180Z,1771365904.180 [DATMMP](INFO): mdmlocal rx: 	 x3	 x0	 x0	 x0
2026-02-17T22:05:04.180Z,1771365904.180 [DATMMP](INFO): Received message type: mdmlocal
2026-02-17T22:05:04.180Z,1771365904.180 [DATMMP](INFO): Handled
2026-02-17T22:05:04.429Z,1771365904.429 [DATMMP](INFO): Starting
2026-02-17T22:05:04.430Z,1771365904.430 [DATMMP](INFO): GSXN notify for xid: 11
2026-02-17T22:05:04.430Z,1771365904.430 [DATMMP](INFO): sreg_locaddr rx: 	 x3
2026-02-17T22:05:04.430Z,1771365904.430 [DATMMP](INFO): Received message type: sreg_locaddr
2026-02-17T22:05:04.430Z,1771365904.430 [DATMMP](INFO): Match for : sreg_locaddr
2026-02-17T22:05:04.431Z,1771365904.431 [DATMMP](INFO): ACK
2026-02-17T22:05:04.681Z,1771365904.681 [DATMMP](INFO): Starting
2026-02-17T22:05:04.682Z,1771365904.682 [DATMMP](INFO): GSXN notify for xid: 12
2026-02-17T22:05:04.683Z,1771365904.683 [DATMMP](INFO): timedate rx: 	 x0	 x16	 x5	 x3	 x1	 x11	 x7E	 x0
2026-02-17T22:05:04.683Z,1771365904.683 [DATMMP](INFO): Received message type: timedate
2026-02-17T22:05:04.683Z,1771365904.683 [DATMMP](INFO): Match for : timedate
2026-02-17T22:05:04.683Z,1771365904.683 [DATMMP](INFO): ACK
2026-02-17T22:05:04.933Z,1771365904.933 [DATMMP](INFO): Starting
2026-02-17T22:05:04.934Z,1771365904.934 [DATMMP](INFO): GSXN notify for xid: 0
2026-02-17T22:05:04.935Z,1771365904.935 [DATMMP](INFO): sys_verb rx: 	 x0	 x0	 x0	 x0
2026-02-17T22:05:04.935Z,1771365904.935 [DATMMP](INFO): Received message type: sys_verb
2026-02-17T22:05:04.935Z,1771365904.935 [DATMMP](INFO): Handled
2026-02-17T22:05:05.185Z,1771365905.185 [DATMMP](INFO): Starting
2026-02-17T22:05:05.186Z,1771365905.186 [DATMMP](INFO): GSXN notify for xid: 13
2026-02-17T22:05:05.187Z,1771365905.187 [DATMMP](INFO): sreg_verbosity rx: 	 x0
2026-02-17T22:05:05.187Z,1771365905.187 [DATMMP](INFO): Received message type: sreg_verbosity
2026-02-17T22:05:05.188Z,1771365905.188 [DATMMP](INFO): Match for : sreg_verbosity
2026-02-17T22:05:05.188Z,1771365905.188 [DATMMP](INFO): ACK
2026-02-17T22:05:05.437Z,1771365905.437 [DATMMP](INFO): Starting
2026-02-17T22:05:05.437Z,1771365905.437 [DATMMP](INFO): GSXN notify for xid: 14
2026-02-17T22:05:05.438Z,1771365905.438 [DATMMP](INFO): version rx: 	 x2	 x5
2026-02-17T22:05:05.438Z,1771365905.438 [DATMMP](INFO): DatMMPVersion: 2.5
2026-02-17T22:05:05.439Z,1771365905.439 [DATMMP](INFO): Received message type: version
2026-02-17T22:05:05.439Z,1771365905.439 [DATMMP](INFO): Match for : version
2026-02-17T22:05:05.439Z,1771365905.439 [DATMMP](INFO): ACK
2026-02-17T22:05:05.439Z,1771365905.439 [DATMMP](INFO): in MMP mode: config complete going to runnable
2026-02-17T22:05:14.563Z,1771365914.563 [NAL9602](INFO): Powering up NAL9602
2026-02-17T22:05:19.802Z,1771365919.802 [DATMMP](INFO): GSXN notify for xid: 0
2026-02-17T22:05:19.803Z,1771365919.803 [DATMMP](INFO): timesync rx: 	 x0	 x1	 x1	 x0
2026-02-17T22:05:19.803Z,1771365919.803 [DATMMP](INFO): Received message type: timesync
2026-02-17T22:05:19.803Z,1771365919.803 [DATMMP](INFO): Handled
2026-02-17T22:05:25.470Z,1771365925.470 [NAL9602](INFO): NAL9602 initialized
2026-02-17T22:05:26.346Z,1771365926.346 [SBIT](IMPORTANT): Beginning Startup BIT
2026-02-17T22:05:26.351Z,1771365926.351 [GFScanner](IMPORTANT): Beginning ground fault scan
2026-02-17T22:05:29.882Z,1771365929.882 [DATMMP](INFO): GSXN notify for xid: 0
2026-02-17T22:05:29.883Z,1771365929.883 [DATMMP](INFO): timesync rx: 	 x1	 x0	 x1	 x0
2026-02-17T22:05:29.883Z,1771365929.883 [DATMMP](INFO): Received message type: timesync
2026-02-17T22:05:29.883Z,1771365929.883 [DATMMP](INFO): Handled
2026-02-17T22:05:30.798Z,1771365930.798 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.019679
CHAN A1 (24V): 0.001314
CHAN A2 (12V): -0.000601
CHAN A3 (5V): -0.011261
CHAN B0 (3.3V): -0.000384
CHAN B1 (3.15aV): -0.000173
CHAN B2 (3.15bV): -0.000679
CHAN B3 (GND): -0.000830
OPEN: 0.008125
Full Scale: +/- 1 mA
2026-02-17T22:06:20.483Z,1771365980.483 [SBIT](IMPORTANT): SBIT PASSED
2026-02-17T22:06:20.483Z,1771365980.483 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2026-02-17T22:06:20.870Z,1771365980.870 [MissionManager](IMPORTANT): Started mission Startup
2026-02-17T22:06:20.871Z,1771365980.871 [Startup] Running Loop=1
2026-02-17T22:06:20.871Z,1771365980.871 [Startup](DEBUG): Aggregate::initialize Startup
2026-02-17T22:06:20.871Z,1771365980.871 [Startup:A.GoToSurface] Running Loop=1
2026-02-17T22:06:20.871Z,1771365980.871 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-02-17T22:06:20.871Z,1771365980.871 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-02-17T22:06:20.872Z,1771365980.872 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-02-17T22:06:20.872Z,1771365980.872 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-02-17T22:06:20.872Z,1771365980.872 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-02-17T22:06:20.873Z,1771365980.873 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-02-17T22:06:20.874Z,1771365980.874 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-02-17T22:06:20.875Z,1771365980.875 [Startup:StartupSatComms] Running Loop=1
2026-02-17T22:06:20.875Z,1771365980.875 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2026-02-17T22:06:20.875Z,1771365980.875 [Startup:StartupSatComms:A] Running Loop=1
2026-02-17T22:06:21.266Z,1771365981.266 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2026-02-17T22:07:07.136Z,1771366027.136 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:07:20.898Z,1771366040.898 [Startup:StartupSatComms:A](INFO): Timed out from 2026-02-17T22:06:20.9Z
2026-02-17T22:07:20.898Z,1771366040.898 [Startup:StartupSatComms:A] Stopped
2026-02-17T22:07:20.898Z,1771366040.898 [Startup:StartupSatComms:B] Running Loop=1
2026-02-17T22:07:21.307Z,1771366041.307 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2026-02-17T22:07:38.915Z,1771366058.915 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:07:46.749Z,1771366066.749 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2026-02-17T22:07:46.749Z,1771366066.749 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-17T22:07:46.751Z,1771366066.751 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2026-02-17T22:07:46.751Z,1771366066.751 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:07:46.785Z,1771366066.785 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-17T22:07:46.785Z,1771366066.785 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:07:47.164Z,1771366067.164 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-17T22:07:47.164Z,1771366067.164 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2026-02-17T22:07:47.164Z,1771366067.164 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:07:47.164Z,1771366067.164 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2026-02-17T22:08:10.639Z,1771366090.639 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:08:21.170Z,1771366101.170 [Startup:StartupSatComms:B](INFO): Timed out from 2026-02-17T22:07:20.9Z
2026-02-17T22:08:21.170Z,1771366101.170 [Startup:StartupSatComms:B] Stopped
2026-02-17T22:08:21.170Z,1771366101.170 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2026-02-17T22:08:21.170Z,1771366101.170 [Startup:StartupSatComms] Stopped
2026-02-17T22:08:21.170Z,1771366101.170 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2026-02-17T22:08:21.171Z,1771366101.171 [Startup](INFO): Completed Startup
2026-02-17T22:08:21.171Z,1771366101.171 [MissionManager](INFO): Startup is completed.
2026-02-17T22:08:21.171Z,1771366101.171 [MissionManager](INFO): Uninitializing Mission Startup
2026-02-17T22:08:21.171Z,1771366101.171 [Startup] Stopped
2026-02-17T22:08:21.171Z,1771366101.171 [Startup](DEBUG): Aggregate::uninitialize Startup
2026-02-17T22:08:21.171Z,1771366101.171 [Startup:A.GoToSurface] Stopped
2026-02-17T22:08:21.171Z,1771366101.171 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-02-17T22:08:21.519Z,1771366101.519 [MissionManager](IMPORTANT): Started mission Default
2026-02-17T22:08:21.519Z,1771366101.519 [Default] Running Loop=1
2026-02-17T22:08:21.519Z,1771366101.519 [Default](DEBUG): Aggregate::initialize Default
2026-02-17T22:08:21.519Z,1771366101.519 [Default:B.GoToSurface] Running Loop=1
2026-02-17T22:08:21.519Z,1771366101.519 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-02-17T22:08:21.520Z,1771366101.520 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-02-17T22:08:21.520Z,1771366101.520 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-02-17T22:08:21.520Z,1771366101.520 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-02-17T22:08:21.520Z,1771366101.520 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-02-17T22:08:21.521Z,1771366101.521 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-02-17T22:08:21.521Z,1771366101.521 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-02-17T22:08:21.521Z,1771366101.521 [Default:A.Wait] Running Loop=1
2026-02-17T22:08:21.521Z,1771366101.521 [Default:A.Wait](DEBUG): Initialize Wait Component.
2026-02-17T22:08:34.909Z,1771366114.909 [Default:A.Wait](INFO): Done Waiting.
2026-02-17T22:08:34.909Z,1771366114.909 [Default:A.Wait] Stopped
2026-02-17T22:08:34.909Z,1771366114.909 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2026-02-17T22:08:35.274Z,1771366115.274 [Default:CheckIn] Running Loop=1
2026-02-17T22:08:35.274Z,1771366115.274 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2026-02-17T22:08:35.274Z,1771366115.274 [Default:CheckIn:Read_GPS] Running Loop=1
2026-02-17T22:08:35.667Z,1771366115.667 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2026-02-17T22:08:42.495Z,1771366122.495 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:09:14.392Z,1771366154.392 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:09:41.857Z,1771366181.857 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:09:46.115Z,1771366186.115 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:09:57.208Z,1771366197.208 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:10:12.559Z,1771366212.559 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:10:17.991Z,1771366217.991 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:10:27.508Z,1771366227.508 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:10:28.335Z,1771366228.335 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2026-02-17T22:10:42.457Z,1771366242.457 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:10:42.499Z,1771366242.499 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00111423340438,35.0, +24.2,  2.4,  0
2026-02-17T22:10:47.758Z,1771366247.758 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2026-02-17T22:10:47.758Z,1771366247.758 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-17T22:10:47.759Z,1771366247.759 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2026-02-17T22:10:47.759Z,1771366247.759 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:10:47.772Z,1771366247.772 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-17T22:10:47.772Z,1771366247.772 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:10:48.166Z,1771366248.166 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-17T22:10:48.166Z,1771366248.166 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2026-02-17T22:10:48.167Z,1771366248.167 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:10:48.167Z,1771366248.167 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2026-02-17T22:10:49.683Z,1771366249.683 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:10:57.876Z,1771366257.876 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:11:02.754Z,1771366262.754 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for bottom velocity. Device response is::BS,-32768,-32768,-3

2026-02-17T22:11:13.184Z,1771366273.184 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:11:20.695Z,1771366280.695 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:11:28.541Z,1771366288.541 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:11:32.640Z,1771366292.640 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-2768,-32768,V
2026-02-17T22:11:43.888Z,1771366303.888 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:11:51.783Z,1771366311.783 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:11:59.240Z,1771366319.240 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-02-17T22:12:18.727Z,1771366338.727 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2026-02-17T22:12:18.731Z,1771366338.731 [BPC1](INFO): Received data from all battery sticks.
2026-02-17T22:12:23.695Z,1771366343.695 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:12:55.359Z,1771366375.359 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:13:27.023Z,1771366407.023 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:13:35.519Z,1771366415.519 [Default:CheckIn:Read_GPS](INFO): Timed out from 2026-02-17T22:08:35.3Z
2026-02-17T22:13:35.520Z,1771366415.520 [Default:CheckIn:Read_GPS] Stopped
2026-02-17T22:13:35.520Z,1771366415.520 [Default:CheckIn:Read_Iridium] Running Loop=1
2026-02-17T22:13:35.932Z,1771366415.932 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2026-02-17T22:13:48.834Z,1771366428.834 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2026-02-17T22:13:48.834Z,1771366428.834 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-17T22:13:48.835Z,1771366428.835 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2026-02-17T22:13:48.835Z,1771366428.835 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:13:48.847Z,1771366428.847 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-17T22:13:48.847Z,1771366428.847 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:13:49.247Z,1771366429.247 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-17T22:13:49.248Z,1771366429.248 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2026-02-17T22:13:49.248Z,1771366429.248 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:13:49.249Z,1771366429.249 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2026-02-17T22:13:58.796Z,1771366438.796 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:14:05.400Z,1771366445.400 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 
2026-02-17T22:14:05.483Z,1771366445.483 [NAL9602](ERROR): received: 
+CSQ:0

OK
2026-02-17T22:14:30.679Z,1771366470.679 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:15:02.203Z,1771366502.203 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:15:27.645Z,1771366527.645 [NAL9602](FAULT): GPS failed to acquire within timeout.
2026-02-17T22:15:27.645Z,1771366527.645 [NAL9602] Data Fault, FailCount= 1
2026-02-17T22:15:27.645Z,1771366527.645 [NAL9602](ERROR): Data Fault
2026-02-17T22:15:27.695Z,1771366527.695 [CBIT](ERROR): Data Fault in component: NAL9602
2026-02-17T22:15:28.044Z,1771366528.044 [NAL9602](INFO): Powering down
2026-02-17T22:15:28.877Z,1771366528.877 [CBIT](INFO): Clearing failed state for component NAL9602
2026-02-17T22:15:28.877Z,1771366528.877 [NAL9602] No Fault, FailCount= 1
2026-02-17T22:15:33.651Z,1771366533.651 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:15:58.367Z,1771366558.367 [NAL9602](INFO): Powering up NAL9602
2026-02-17T22:16:05.355Z,1771366565.355 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:16:09.264Z,1771366569.264 [NAL9602](INFO): NAL9602 initialized
2026-02-17T22:16:37.067Z,1771366597.067 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:16:53.317Z,1771366613.317 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2026-02-17T22:16:53.318Z,1771366613.318 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-17T22:16:53.319Z,1771366613.319 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2026-02-17T22:16:53.319Z,1771366613.319 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:16:53.329Z,1771366613.329 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-17T22:16:53.330Z,1771366613.330 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:16:53.405Z,1771366613.405 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-17T22:16:53.405Z,1771366613.405 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2026-02-17T22:16:53.405Z,1771366613.405 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:16:53.405Z,1771366613.405 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2026-02-17T22:17:08.779Z,1771366628.779 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:17:39.871Z,1771366659.871 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:18:11.375Z,1771366691.375 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:18:43.267Z,1771366723.267 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:19:14.667Z,1771366754.667 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:19:46.503Z,1771366786.503 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:19:48.117Z,1771366788.117 [CBIT](INFO): Clearing failed state for component DropWeight
2026-02-17T22:19:48.117Z,1771366788.117 [DropWeight] No Fault, FailCount= 1
2026-02-17T22:19:55.106Z,1771366795.106 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2026-02-17T22:19:55.106Z,1771366795.106 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-17T22:19:55.128Z,1771366795.128 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2026-02-17T22:19:55.128Z,1771366795.128 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:19:55.173Z,1771366795.173 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-17T22:19:55.173Z,1771366795.173 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:19:55.283Z,1771366795.283 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-17T22:19:55.283Z,1771366795.283 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2026-02-17T22:19:55.284Z,1771366795.284 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:19:55.284Z,1771366795.284 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2026-02-17T22:20:18.507Z,1771366818.507 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:20:49.835Z,1771366849.835 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:21:05.192Z,1771366865.192 [RDI_Pathfinder](ERROR): No DVL communication! Re-initializing
2026-02-17T22:21:05.192Z,1771366865.192 [RDI_Pathfinder] Communications Fault, FailCount= 1
2026-02-17T22:21:05.192Z,1771366865.192 [RDI_Pathfinder](ERROR): Communications Fault
2026-02-17T22:21:05.234Z,1771366865.234 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2026-02-17T22:21:05.395Z,1771366865.395 [RDI_Pathfinder](INFO): Powering down
2026-02-17T22:21:06.169Z,1771366866.169 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2026-02-17T22:21:06.169Z,1771366866.169 [RDI_Pathfinder] No Fault, FailCount= 1
2026-02-17T22:21:06.511Z,1771366866.511 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2026-02-17T22:21:21.023Z,1771366881.023 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:21:52.351Z,1771366912.351 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:22:24.347Z,1771366944.347 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:22:55.455Z,1771366975.455 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:22:55.906Z,1771366975.906 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2026-02-17T22:22:55.906Z,1771366975.906 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2026-02-17T22:22:55.908Z,1771366975.908 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2026-02-17T22:22:55.908Z,1771366975.908 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:22:55.919Z,1771366975.919 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2026-02-17T22:22:55.920Z,1771366975.920 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:22:56.322Z,1771366976.322 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2026-02-17T22:22:56.322Z,1771366976.322 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2026-02-17T22:22:56.331Z,1771366976.331 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:22:56.331Z,1771366976.331 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2026-02-17T22:23:27.419Z,1771367007.419 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:23:52.824Z,1771367032.824 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD,      -18.12,        +0.59,      -14.0
2026-02-17T22:23:58.591Z,1771367038.591 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:24:29.651Z,1771367069.651 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:25:00.760Z,1771367100.760 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:25:00.926Z,1771367100.926 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222500.00,A,3648.16160,N,12147.26970,W,3.654,35.79,170226,,,A*45
2026-02-17T22:25:00.929Z,1771367100.929 [NAL9602](INFO): GPS fix at 20260217T222500: (36.802693, -121.787828)
2026-02-17T22:25:32.331Z,1771367132.331 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:25:57.485Z,1771367157.485 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2026-02-17T22:25:57.485Z,1771367157.485 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:25:57.535Z,1771367157.535 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:25:57.607Z,1771367157.607 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2026-02-17T22:25:57.607Z,1771367157.607 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2026-02-17T22:26:03.804Z,1771367163.804 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:26:35.564Z,1771367195.564 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:27:07.540Z,1771367227.540 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:27:38.703Z,1771367258.703 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:28:10.223Z,1771367290.223 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:28:41.407Z,1771367321.407 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-02-17T22:28:58.565Z,1771367338.565 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2026-02-17T22:28:58.565Z,1771367338.565 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2026-02-17T22:28:58.577Z,1771367338.577 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2026-02-17T22:28:58.674Z,177136733