2025-06-23T21:01:45.065Z,1750712505.065 [Supervisor](DEBUG): Initializing supervisor.
2025-06-23T21:01:45.069Z,1750712505.069 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-06-23T21:01:45.069Z,1750712505.069 [SyncHandler](INFO): Protected caller Thread ID is 1284
2025-06-23T21:01:45.070Z,1750712505.070 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-06-23T21:01:45.071Z,1750712505.071 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-06-23T21:01:45.071Z,1750712505.071 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1285
2025-06-23T21:01:45.075Z,1750712505.075 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-06-23T21:01:45.096Z,1750712505.096 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-06-23T21:01:45.097Z,1750712505.097 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-06-23T21:01:45.097Z,1750712505.097 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1286
2025-06-23T21:01:45.101Z,1750712505.101 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-06-23T21:01:45.102Z,1750712505.102 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-06-23T21:01:45.103Z,1750712505.103 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1287
2025-06-23T21:01:45.105Z,1750712505.105 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-06-23T21:01:45.106Z,1750712505.106 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-06-23T21:01:45.106Z,1750712505.106 [logger ThreadHandler](INFO): Protected caller Thread ID is 1288
2025-06-23T21:01:45.110Z,1750712505.110 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-06-23T21:01:45.111Z,1750712505.111 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-06-23T21:01:45.112Z,1750712505.112 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-06-23T21:01:45.217Z,1750712505.217 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-06-23T21:01:45.217Z,1750712505.217 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-06-23T21:01:45.960Z,1750712505.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-06-23T21:01:45.961Z,1750712505.961 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-06-23T21:01:46.204Z,1750712506.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-06-23T21:01:46.204Z,1750712506.204 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-06-23T21:01:46.292Z,1750712506.292 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-06-23T21:01:46.433Z,1750712506.433 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-06-23T21:01:46.434Z,1750712506.434 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-06-23T21:01:46.534Z,1750712506.534 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-06-23T21:01:46.535Z,1750712506.535 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-06-23T21:01:46.653Z,1750712506.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-06-23T21:01:46.654Z,1750712506.654 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-06-23T21:01:47.069Z,1750712507.069 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-06-23T21:01:47.069Z,1750712507.069 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-06-23T21:01:47.609Z,1750712507.609 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-06-23T21:01:47.609Z,1750712507.609 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-06-23T21:01:47.836Z,1750712507.836 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-06-23T21:01:47.837Z,1750712507.837 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-06-23T21:01:48.030Z,1750712508.030 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-06-23T21:01:48.031Z,1750712508.031 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-06-23T21:01:48.592Z,1750712508.592 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-06-23T21:01:48.593Z,1750712508.593 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-06-23T21:01:48.891Z,1750712508.891 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-06-23T21:01:48.891Z,1750712508.891 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-06-23T21:01:49.146Z,1750712509.146 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-06-23T21:01:49.146Z,1750712509.146 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-06-23T21:01:50.407Z,1750712510.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-06-23T21:01:50.407Z,1750712510.408 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-06-23T21:01:50.767Z,1750712510.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-06-23T21:01:50.769Z,1750712510.769 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2025-06-23T21:01:50.770Z,1750712510.770 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2025-06-23T21:01:50.862Z,1750712510.862 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2025-06-23T21:01:51.038Z,1750712511.038 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg
2025-06-23T21:01:51.152Z,1750712511.152 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg
2025-06-23T21:01:51.254Z,1750712511.254 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2025-06-23T21:01:51.372Z,1750712511.372 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2025-06-23T21:01:51.467Z,1750712511.467 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2025-06-23T21:01:51.572Z,1750712511.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2025-06-23T21:01:51.694Z,1750712511.694 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2025-06-23T21:01:51.974Z,1750712511.974 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-06-23T21:01:51.974Z,1750712511.974 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2025-06-23T21:01:52.067Z,1750712512.067 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2025-06-23T21:01:52.168Z,1750712512.168 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2025-06-23T21:01:52.317Z,1750712512.317 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2025-06-23T21:01:52.422Z,1750712512.422 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-06-23T21:01:52.438Z,1750712512.438 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-06-23T21:01:52.581Z,1750712512.581 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-06-23T21:01:52.582Z,1750712512.582 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-06-23T21:01:52.637Z,1750712512.637 [VerticalControl](DEBUG): Construct VerticalControl.
2025-06-23T21:01:52.700Z,1750712512.700 [VerticalControl] Loaded
2025-06-23T21:01:52.700Z,1750712512.700 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-06-23T21:01:52.703Z,1750712512.703 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-06-23T21:01:52.752Z,1750712512.752 [HorizontalControl] Loaded
2025-06-23T21:01:52.752Z,1750712512.752 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-06-23T21:01:52.755Z,1750712512.755 [SpeedControl](DEBUG): Construct SpeedControl.
2025-06-23T21:01:52.758Z,1750712512.758 [SpeedControl] Loaded
2025-06-23T21:01:52.758Z,1750712512.758 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-06-23T21:01:52.761Z,1750712512.761 [LoopControl](DEBUG): Construct LoopControl.
2025-06-23T21:01:52.761Z,1750712512.761 [LoopControl] Loaded
2025-06-23T21:01:52.762Z,1750712512.762 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-06-23T21:01:52.762Z,1750712512.762 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-06-23T21:01:52.763Z,1750712512.763 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-06-23T21:01:52.815Z,1750712512.815 [DepthRateCalculator] Loaded
2025-06-23T21:01:52.815Z,1750712512.815 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-06-23T21:01:52.820Z,1750712512.820 [PitchRateCalculator] Loaded
2025-06-23T21:01:52.821Z,1750712512.821 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-06-23T21:01:52.831Z,1750712512.831 [SpeedCalculator] Loaded
2025-06-23T21:01:52.831Z,1750712512.831 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-06-23T21:01:52.836Z,1750712512.836 [YawRateCalculator] Loaded
2025-06-23T21:01:52.836Z,1750712512.836 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-06-23T21:01:52.855Z,1750712512.855 [ElevatorOffsetCalculator] Loaded
2025-06-23T21:01:52.855Z,1750712512.855 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-06-23T21:01:52.856Z,1750712512.856 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-06-23T21:01:52.856Z,1750712512.856 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-06-23T21:01:52.887Z,1750712512.887 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-06-23T21:01:52.887Z,1750712512.887 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-06-23T21:01:52.950Z,1750712512.950 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-06-23T21:01:52.951Z,1750712512.951 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-06-23T21:01:53.311Z,1750712513.311 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-06-23T21:01:53.312Z,1750712513.312 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-06-23T21:01:53.493Z,1750712513.493 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-06-23T21:01:53.493Z,1750712513.493 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-06-23T21:01:54.011Z,1750712514.011 [AHRS_M2] Loaded
2025-06-23T21:01:54.011Z,1750712514.011 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-06-23T21:01:54.051Z,1750712514.051 [BackseatComponent] Loaded
2025-06-23T21:01:54.051Z,1750712514.051 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-06-23T21:01:54.052Z,1750712514.052 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409E94E0
2025-06-23T21:01:54.053Z,1750712514.053 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1376
2025-06-23T21:01:54.056Z,1750712514.056 [LcmUniversalReporter] Loaded
2025-06-23T21:01:54.056Z,1750712514.056 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-06-23T21:01:55.178Z,1750712515.178 [BPC1] Loaded
2025-06-23T21:01:55.179Z,1750712515.179 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-06-23T21:01:55.379Z,1750712515.379 [DAT] Loaded
2025-06-23T21:01:55.379Z,1750712515.379 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-06-23T21:01:55.380Z,1750712515.380 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A194E0
2025-06-23T21:01:55.381Z,1750712515.381 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1377
2025-06-23T21:01:55.460Z,1750712515.460 [DataOverHttps] Loaded
2025-06-23T21:01:55.460Z,1750712515.460 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-06-23T21:01:55.461Z,1750712515.461 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A494E0
2025-06-23T21:01:55.462Z,1750712515.462 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1378
2025-06-23T21:01:55.485Z,1750712515.485 [Depth_Keller] Loaded
2025-06-23T21:01:55.485Z,1750712515.485 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-06-23T21:01:55.552Z,1750712515.552 [NAL9602] Loaded
2025-06-23T21:01:55.553Z,1750712515.553 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-06-23T21:01:55.583Z,1750712515.583 [Onboard] Loaded
2025-06-23T21:01:55.583Z,1750712515.583 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-06-23T21:01:55.585Z,1750712515.585 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A794E0
2025-06-23T21:01:55.585Z,1750712515.585 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1379
2025-06-23T21:01:55.599Z,1750712515.599 [Power24vConverter] Loaded
2025-06-23T21:01:55.600Z,1750712515.600 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-06-23T21:01:55.616Z,1750712515.616 [Radio_Surface] Loaded
2025-06-23T21:01:55.616Z,1750712515.616 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-06-23T21:01:55.617Z,1750712515.617 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AA94E0
2025-06-23T21:01:55.618Z,1750712515.618 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1380
2025-06-23T21:01:55.666Z,1750712515.666 [RDI_Pathfinder] Loaded
2025-06-23T21:01:55.666Z,1750712515.666 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-06-23T21:01:55.682Z,1750712515.682 [Sonardyne_Nano] Loaded
2025-06-23T21:01:55.682Z,1750712515.682 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-06-23T21:01:55.682Z,1750712515.682 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-06-23T21:01:55.683Z,1750712515.683 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-06-23T21:01:55.800Z,1750712515.800 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-06-23T21:01:55.800Z,1750712515.800 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-06-23T21:01:55.814Z,1750712515.814 [NavChart] Loaded
2025-06-23T21:01:55.815Z,1750712515.815 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-06-23T21:01:55.820Z,1750712515.820 [UniversalFixResidualReporter] Loaded
2025-06-23T21:01:55.821Z,1750712515.821 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-06-23T21:01:55.821Z,1750712515.821 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-06-23T21:01:55.822Z,1750712515.822 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-06-23T21:01:55.993Z,1750712515.993 [SBIT](DEBUG): Construct Startup Built In Test.
2025-06-23T21:01:56.002Z,1750712516.002 [SBIT] Loaded
2025-06-23T21:01:56.002Z,1750712516.002 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-06-23T21:01:56.005Z,1750712516.005 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-06-23T21:01:56.018Z,1750712516.018 [IBIT] Loaded
2025-06-23T21:01:56.019Z,1750712516.019 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-06-23T21:01:56.024Z,1750712516.024 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-06-23T21:01:56.108Z,1750712516.108 [CBIT] Loaded
2025-06-23T21:01:56.108Z,1750712516.108 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-06-23T21:01:56.142Z,1750712516.142 [GFScanner] Loaded
2025-06-23T21:01:56.142Z,1750712516.142 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-06-23T21:01:56.143Z,1750712516.143 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-06-23T21:01:56.143Z,1750712516.143 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-06-23T21:01:56.283Z,1750712516.283 [BuoyancyServo] Loaded
2025-06-23T21:01:56.284Z,1750712516.284 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-06-23T21:01:56.308Z,1750712516.308 [ElevatorServo] Loaded
2025-06-23T21:01:56.308Z,1750712516.308 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-06-23T21:01:56.338Z,1750712516.338 [DockingStepper] Loaded
2025-06-23T21:01:56.339Z,1750712516.339 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread.
2025-06-23T21:01:56.361Z,1750712516.361 [MassServo] Loaded
2025-06-23T21:01:56.361Z,1750712516.361 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-06-23T21:01:56.383Z,1750712516.383 [RudderServo] Loaded
2025-06-23T21:01:56.383Z,1750712516.383 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-06-23T21:01:56.402Z,1750712516.402 [ThrusterServo] Loaded
2025-06-23T21:01:56.403Z,1750712516.403 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2025-06-23T21:01:56.403Z,1750712516.403 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-06-23T21:01:56.404Z,1750712516.404 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-06-23T21:01:56.414Z,1750712516.414 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-06-23T21:01:56.415Z,1750712516.415 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-06-23T21:01:56.593Z,1750712516.593 [CTD_Seabird] Loaded
2025-06-23T21:01:56.593Z,1750712516.593 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-06-23T21:01:56.595Z,1750712516.595 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C0C4E0
2025-06-23T21:01:56.595Z,1750712516.595 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1381
2025-06-23T21:01:56.618Z,1750712516.618 [PAR_Licor] Loaded
2025-06-23T21:01:56.618Z,1750712516.618 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-06-23T21:01:56.665Z,1750712516.665 [WetLabsBB2FL] Loaded
2025-06-23T21:01:56.665Z,1750712516.665 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-06-23T21:01:56.666Z,1750712516.666 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C3C4E0
2025-06-23T21:01:56.666Z,1750712516.666 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1382
2025-06-23T21:01:56.688Z,1750712516.688 [WetLabsUBAT] Loaded
2025-06-23T21:01:56.688Z,1750712516.688 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2025-06-23T21:01:56.689Z,1750712516.689 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C6C4E0
2025-06-23T21:01:56.690Z,1750712516.690 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 1383
2025-06-23T21:01:56.690Z,1750712516.690 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-06-23T21:01:56.697Z,1750712516.697 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-06-23T21:01:56.700Z,1750712516.700 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-06-23T21:01:56.712Z,1750712516.712 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-06-23T21:01:56.713Z,1750712516.713 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C9C4E0
2025-06-23T21:01:56.713Z,1750712516.713 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1384
2025-06-23T21:01:56.717Z,1750712516.717 [Supervisor](INFO): Main Thread ID is 831
2025-06-23T21:01:56.717Z,1750712516.717 [Supervisor](DEBUG): Running supervisor.
2025-06-23T21:01:56.718Z,1750712516.718 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1385
2025-06-23T21:01:56.719Z,1750712516.719 [CommandExec](INFO): Initializing the command executive.
2025-06-23T21:01:56.720Z,1750712516.720 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1386
2025-06-23T21:01:56.722Z,1750712516.722 [controlThread ThreadHandler](INFO): Handler Thread ID is 1387
2025-06-23T21:01:56.723Z,1750712516.723 [controlThread](DEBUG): Initializing ControlThread
2025-06-23T21:01:56.724Z,1750712516.724 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-06-23T21:01:56.725Z,1750712516.725 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-06-23T21:01:56.726Z,1750712516.726 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-06-23T21:01:56.726Z,1750712516.726 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-06-23T21:01:56.727Z,1750712516.727 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-06-23T21:01:56.727Z,1750712516.727 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-06-23T21:01:56.727Z,1750712516.727 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-06-23T21:01:56.728Z,1750712516.728 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-06-23T21:01:56.728Z,1750712516.728 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-06-23T21:01:56.730Z,1750712516.730 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-06-23T21:01:56.731Z,1750712516.731 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-06-23T21:01:56.731Z,1750712516.731 [SBIT](INFO): Initialize SBIT Component.
2025-06-23T21:01:56.732Z,1750712516.732 [SBIT](IMPORTANT): git: 2025-06-05-2-g07de84f03
2025-06-23T21:01:56.732Z,1750712516.732 [SBIT](INFO): git hash: 07de84f036b9b391a47d8c2a08834ee5eaa918cc
2025-06-23T21:01:56.732Z,1750712516.732 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-06-23T21:01:56.733Z,1750712516.733 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-06-23T21:01:56.734Z,1750712516.734 [SBIT](INFO): Beginning SBIT in 93.000000 seconds.
2025-06-23T21:01:56.735Z,1750712516.735 [IBIT](INFO): Initialize IBIT Component.
2025-06-23T21:01:56.736Z,1750712516.736 [CBIT](DEBUG): Initialize CBIT Component.
2025-06-23T21:01:56.737Z,1750712516.737 [logger ThreadHandler](INFO): Handler Thread ID is 1388
2025-06-23T21:01:56.748Z,1750712516.748 [CBIT](DEBUG): Initialized mux pins.
2025-06-23T21:01:56.748Z,1750712516.748 [CBIT](DEBUG): Initializing the watchdog timer.
2025-06-23T21:01:56.756Z,1750712516.756 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1389
2025-06-23T21:01:56.772Z,1750712516.772 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-06-23T21:01:56.772Z,1750712516.772 [CBIT](DEBUG): Initializing heartbeat.
2025-06-23T21:01:56.773Z,1750712516.773 [DAT ThreadHandler](INFO): Handler Thread ID is 1390
2025-06-23T21:01:56.774Z,1750712516.774 [DAT](INFO): Powering up
2025-06-23T21:01:56.774Z,1750712516.774 [DAT](DEBUG): Initializing DAT.
2025-06-23T21:01:56.777Z,1750712516.777 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1392
2025-06-23T21:01:56.779Z,1750712516.779 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-06-23T21:01:56.800Z,1750712516.800 [Onboard ThreadHandler](INFO): Handler Thread ID is 1393
2025-06-23T21:01:56.818Z,1750712516.818 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1394
2025-06-23T21:01:56.839Z,1750712516.839 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1395
2025-06-23T21:01:56.839Z,1750712516.839 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-06-23T21:01:56.844Z,1750712516.844 [CBIT](DEBUG): Deactivating emergency mode.
2025-06-23T21:01:56.846Z,1750712516.846 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1397
2025-06-23T21:01:56.848Z,1750712516.848 [WetLabsBB2FL](INFO): Powering up
2025-06-23T21:01:56.850Z,1750712516.850 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 1399
2025-06-23T21:01:56.852Z,1750712516.852 [WetLabsUBAT](INFO): Powering up
2025-06-23T21:01:56.854Z,1750712516.854 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1401
2025-06-23T21:01:56.857Z,1750712516.857 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-06-23T21:01:56.857Z,1750712516.857 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-06-23T21:01:56.857Z,1750712516.857 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-06-23T21:01:56.858Z,1750712516.858 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-06-23T21:01:56.858Z,1750712516.858 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-06-23T21:01:56.858Z,1750712516.858 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-06-23T21:01:56.858Z,1750712516.858 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-06-23T21:01:56.858Z,1750712516.858 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-06-23T21:01:56.884Z,1750712516.884 [CBIT](DEBUG): Backplane powered.
2025-06-23T21:01:56.884Z,1750712516.884 [GFScanner](DEBUG): Initializing GFScanner
2025-06-23T21:01:56.884Z,1750712516.884 [GFScanner](DEBUG): Deactivating GF circuits.
2025-06-23T21:01:56.893Z,1750712516.893 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-06-23T21:01:56.893Z,1750712516.893 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl
2025-06-23T21:01:56.894Z,1750712516.894 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl
2025-06-23T21:01:56.895Z,1750712516.895 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl
2025-06-23T21:01:56.908Z,1750712516.908 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into:
2025-06-23T21:01:56.909Z,1750712516.909 [MissionManager](ERROR): Top node has no child nodes: Mission
2025-06-23T21:01:56.909Z,1750712516.909 [MissionManager](ERROR): Could not load startup mission.
2025-06-23T21:01:56.909Z,1750712516.909 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl
2025-06-23T21:01:56.909Z,1750712516.909 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl
2025-06-23T21:01:56.911Z,1750712516.911 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl
2025-06-23T21:01:57.224Z,1750712517.224 [Radio_Surface](INFO): Powering up
2025-06-23T21:01:57.486Z,1750712517.486 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/DefaultWithUndock.tl translated into:
0
6
10
1
3
30
Timed out while trying to detach from dock at current depth of
.
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2025-06-23T21:01:57.505Z,1750712517.505 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2025-06-23T21:01:57.509Z,1750712517.509 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h
2025-06-23T21:01:57.530Z,1750712517.530 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count
2025-06-23T21:01:57.534Z,1750712517.534 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s
2025-06-23T21:01:57.557Z,1750712517.557 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count
2025-06-23T21:01:57.561Z,1750712517.561 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min
2025-06-23T21:01:57.563Z,1750712517.563 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2025-06-23T21:01:57.726Z,1750712517.726 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct.
2025-06-23T21:01:57.726Z,1750712517.726 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-06-23T21:01:57.797Z,1750712517.797 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-06-23T21:01:57.838Z,1750712517.838 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-06-23T21:01:57.853Z,1750712517.853 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-06-23T21:01:57.859Z,1750712517.859 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute.
2025-06-23T21:01:57.880Z,1750712517.880 [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 DefaultWithUndock {
arguments {
ElapsedSinceDefaultStarted = 0 minute
DetachTimeout = 6 hour
"""
Maximum time duration for the vehicle to detach form the dock.
"""
TransponderCode = Dock:Dock.transponderCode
"""
Dock transponder address.
"""
TrackingUpdatePeriod = 10 second
"""
Time duration between acoustic range queries while the mission is
detaching from the dock.
"""
NumberOfPings = 1 count
"""
Number of pings requested each time.
"""
DriftTimeout = 3 minute
"""
How long to allow vehicle to drift away from dock before retrying reverse
"""
}
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 = 30 second
}
aggregate LeaveDock {
run in sequence
timeout duration=DetachTimeout {
syslog important "Timed out while trying to detach from dock at current depth of "
+ Universal:depth~meter + "."
}
# Acoustic tracking directives
behavior Estimation:TrackAcousticContact {
run while (
Universal:depth > Control:VerticalControl.surfaceThreshold
)
set contactLabelSetting = TransponderCode
set numberOfSamplesSetting = NumberOfPings
set updatePeriodSetting = TrackingUpdatePeriod
}
# Leave the dock
behavior Dock:Undock {
run in sequence
set driftTimeout = DriftTimeout
}
}
aggregate SurfaceDefault {
run in sequence
# This mission assumes open water so from here on it's the same old default that's always used
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=P2H {
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"
}
}
2025-06-23T21:01:57.892Z,1750712517.892 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-06-23T21:01:57.900Z,1750712517.900 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-06-23T21:01:57.973Z,1750712517.973 [Depth_Keller](INFO): Initializing.
2025-06-23T21:01:57.974Z,1750712517.974 [Power24vConverter](INFO): Powering up.
2025-06-23T21:01:57.974Z,1750712517.974 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-06-23T21:01:57.981Z,1750712517.981 [Sonardyne_Nano](INFO): Initializing.
2025-06-23T21:01:58.024Z,1750712518.024 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-06-23T21:01:58.051Z,1750712518.051 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-06-23T21:01:58.056Z,1750712518.056 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-06-23T21:01:58.057Z,1750712518.057 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-06-23T21:01:58.064Z,1750712518.064 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-06-23T21:01:58.065Z,1750712518.065 [DockingStepper](INFO): Start
2025-06-23T21:01:58.065Z,1750712518.065 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-06-23T21:01:58.072Z,1750712518.072 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-06-23T21:01:58.073Z,1750712518.073 [MassServo](DEBUG): Initializing EZServoServo.
2025-06-23T21:01:58.080Z,1750712518.080 [MassServo](DEBUG): Initializing MassServo.
2025-06-23T21:01:58.081Z,1750712518.081 [RudderServo](DEBUG): Initializing EZServoServo.
2025-06-23T21:01:58.088Z,1750712518.088 [RudderServo](DEBUG): Initializing RudderServo.
2025-06-23T21:01:58.089Z,1750712518.089 [ThrusterServo](DEBUG): Initializing EZServoServo.
2025-06-23T21:01:58.096Z,1750712518.096 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2025-06-23T21:01:58.351Z,1750712518.351 [DockingStepper](INFO): Starting
2025-06-23T21:01:58.727Z,1750712518.727 [DockingStepper](INFO): Starting
2025-06-23T21:01:59.256Z,1750712519.256 [DockingStepper](INFO): Starting
2025-06-23T21:01:59.305Z,1750712519.305 [DockingStepper](INFO): Init string: /1z16351aE13561N3m50
2025-06-23T21:01:59.461Z,1750712519.461 [WetLabsBB2FL](INFO): Powering down
2025-06-23T21:01:59.548Z,1750712519.548 [DockingStepper](INFO): Starting
2025-06-23T21:01:59.918Z,1750712519.918 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-06-23T21:01:59.971Z,1750712519.971 [DockingStepper](INFO): Starting
2025-06-23T21:02:00.339Z,1750712520.339 [DockingStepper](INFO): Starting
2025-06-23T21:02:00.837Z,1750712520.837 [DockingStepper](INFO): Starting
2025-06-23T21:02:01.304Z,1750712521.304 [DockingStepper](INFO): Starting
2025-06-23T21:02:01.329Z,1750712521.329 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-06-23T21:02:01.577Z,1750712521.577 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103
2025-06-23T21:02:01.670Z,1750712521.670 [DockingStepper](INFO): Starting
2025-06-23T21:02:01.980Z,1750712521.980 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2025-06-23T21:02:02.476Z,1750712522.476 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10
2025-06-23T21:02:02.477Z,1750712522.477 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0
2025-06-23T21:02:02.557Z,1750712522.557 [DockingStepper](INFO): Pause
2025-06-23T21:02:06.096Z,1750712526.096 [WetLabsUBAT](INFO): Powering down
2025-06-23T21:02:08.869Z,1750712528.869 [DAT](INFO): DAT read:
2025-06-23T21:02:08.870Z,1750712528.870 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-06-23T21:02:14.413Z,1750712534.413 [DAT](INFO): DAT read: MF Frequency Band
2025-06-23T21:02:14.414Z,1750712534.414 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2
2025-06-23T21:02:14.415Z,1750712534.415 [DAT](INFO): DAT read: Jun 23 2025 21:02:05
2025-06-23T21:02:15.673Z,1750712535.673 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-06-23T21:02:15.674Z,1750712535.674 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP
2025-06-23T21:02:15.675Z,1750712535.675 [DAT](INFO): commRate: 600
2025-06-23T21:02:17.741Z,1750712537.741 [DAT](INFO): entering command mode
2025-06-23T21:02:17.941Z,1750712537.941 [DAT](INFO): DAT read:
2025-06-23T21:02:17.941Z,1750712537.941 [DAT](INFO): DAT read: user:1
2025-06-23T21:02:17.942Z,1750712537.942 [DAT](INFO): setting verbose to 3
2025-06-23T21:02:18.193Z,1750712538.193 [DAT](INFO): DAT read: user:1>
2025-06-23T21:02:18.194Z,1750712538.194 [DAT](INFO): DAT read: Verbose | 3
2025-06-23T21:02:18.194Z,1750712538.194 [DAT](INFO): set verbose to 3
2025-06-23T21:02:18.194Z,1750712538.194 [DAT](INFO): setting DatVerbose to 27440
2025-06-23T21:02:18.445Z,1750712538.445 [DAT](INFO): DAT read: user:2>
2025-06-23T21:02:18.446Z,1750712538.446 [DAT](INFO): DAT read: DatVerbose | 27440
2025-06-23T21:02:18.446Z,1750712538.446 [DAT](INFO): set DatVerbose to 27440
2025-06-23T21:02:18.446Z,1750712538.446 [DAT](INFO): setting transmit power to 8
2025-06-23T21:02:18.697Z,1750712538.697 [DAT](INFO): DAT read: user:3>
2025-06-23T21:02:18.698Z,1750712538.698 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-06-23T21:02:18.698Z,1750712538.698 [DAT](INFO): set transmit power to 8
2025-06-23T21:02:18.698Z,1750712538.698 [DAT](INFO): setting local address to 10
2025-06-23T21:02:18.949Z,1750712538.949 [DAT](INFO): DAT read: user:4>
2025-06-23T21:02:18.950Z,1750712538.950 [DAT](INFO): DAT read: LocalAddr | 10
2025-06-23T21:02:18.950Z,1750712538.950 [DAT](INFO): set local address to 10
2025-06-23T21:02:18.951Z,1750712538.951 [DAT](INFO): Setting time to: 21:2:18 And date to:6/23/2025
2025-06-23T21:02:19.201Z,1750712539.201 [DAT](INFO): DAT read: user:5>
2025-06-23T21:02:19.202Z,1750712539.202 [DAT](INFO): DAT read: Mon Jun 23, 2025 21:02:18
2025-06-23T21:02:19.202Z,1750712539.202 [DAT](INFO): Local DAT time set to Mon Jun 23, 2025 21:02:18
2025-06-23T21:02:25.901Z,1750712545.901 [NAL9602](INFO): Powering up NAL9602
2025-06-23T21:02:27.932Z,1750712547.932 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:02:36.801Z,1750712556.801 [NAL9602](INFO): NAL9602 initialized
2025-06-23T21:02:59.064Z,1750712579.064 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:03:24.883Z,1750712604.883 [NAL9602](INFO): SBD MO Status=2, MOMSN=48799, MT Status=2, MTMSN=0
2025-06-23T21:03:24.883Z,1750712604.883 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-23T21:03:30.147Z,1750712610.147 [SBIT](IMPORTANT): Beginning Startup BIT
2025-06-23T21:03:30.152Z,1750712610.152 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-06-23T21:03:30.188Z,1750712610.188 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:03:34.713Z,1750712614.713 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012394
CHAN A1 (24V): 0.005708
CHAN A2 (12V): 0.005462
CHAN A3 (5V): -0.000445
CHAN B0 (3.3V): -0.000528
CHAN B1 (3.15aV): -0.000105
CHAN B2 (3.15bV): 0.001616
CHAN B3 (GND): -0.000071
OPEN: 0.005559
Full Scale: +/- 1 mA
2025-06-23T21:03:42.728Z,1750712622.728 [NAL9602](INFO): SBD MO Status=2, MOMSN=48799, MT Status=2, MTMSN=0
2025-06-23T21:03:42.728Z,1750712622.728 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-23T21:04:00.130Z,1750712640.130 [NAL9602](INFO): SBD MO Status=0, MOMSN=48799, MT Status=0, MTMSN=0
2025-06-23T21:04:00.130Z,1750712640.130 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:04:01.328Z,1750712641.328 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:04:01.351Z,1750712641.351 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210359.00,A,3648.15379,N,12147.22158,W,0.058,0.00,230625,,,A*70
2025-06-23T21:04:01.354Z,1750712641.354 [NAL9602](INFO): GPS fix at 20250623T210359: (36.802563, -121.787026)
2025-06-23T21:04:23.699Z,1750712663.699 [SBIT](IMPORTANT): SBIT PASSED
2025-06-23T21:04:23.699Z,1750712663.699 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-06-23T21:04:23.704Z,1750712663.704 [SBIT](IMPORTANT): CBIT.gf24Offset=173 microampere;
2025-06-23T21:04:23.704Z,1750712663.704 [SBIT](IMPORTANT): Docked.verbose=0 bool;
2025-06-23T21:04:23.704Z,1750712663.704 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count;
2025-06-23T21:04:23.704Z,1750712663.704 [SBIT](IMPORTANT): DockingStepper.slideValue=10700 count;
2025-06-23T21:04:23.704Z,1750712663.704 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): Express mostRecent WetLabsUBAT.average_bioluminescence;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): HorizontalControl.rudLimit=8 degree;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): Normal linearApproximation _.dinoflagellates 10000000000.000000 none;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): RudderServo.offsetAngle=1 degree;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): SpeedControl.rollOptimum=1.025000 m/s;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): ThrusterServo.currLimit=60 percent;
2025-06-23T21:04:23.705Z,1750712663.705 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=415.338195 cubic_centimeter;
2025-06-23T21:04:23.706Z,1750712663.706 [SBIT](IMPORTANT): VerticalControl.massDefault=18.468839 millimeter;
2025-06-23T21:04:24.054Z,1750712664.054 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2025-06-23T21:04:24.054Z,1750712664.054 [DefaultWithUndock] Running Loop=1
2025-06-23T21:04:24.054Z,1750712664.054 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2025-06-23T21:04:24.055Z,1750712664.055 [DefaultWithUndock:A.Wait] Running Loop=1
2025-06-23T21:04:24.055Z,1750712664.055 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:04:32.473Z,1750712672.473 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:04:33.313Z,1750712673.313 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:04:54.336Z,1750712694.336 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2025-06-23T21:04:54.336Z,1750712694.336 [DefaultWithUndock:A.Wait] Stopped
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:LeaveDock] Running Loop=1
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2025-06-23T21:04:54.337Z,1750712694.337 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-06-23T21:04:54.338Z,1750712694.338 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-06-23T21:04:54.752Z,1750712694.752 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-06-23T21:04:54.752Z,1750712694.752 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-06-23T21:04:54.753Z,1750712694.753 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth -0.346638 m.
2025-06-23T21:04:54.754Z,1750712694.754 [DefaultWithUndock:LeaveDock:A.] Stopped
2025-06-23T21:04:54.754Z,1750712694.754 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact.
2025-06-23T21:04:54.758Z,1750712694.758 [DockingStepper](INFO): Resume
2025-06-23T21:04:55.140Z,1750712695.140 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2025-06-23T21:04:55.146Z,1750712695.146 [DockingStepper](INFO): Resuming
2025-06-23T21:04:55.569Z,1750712695.569 [DockingStepper](INFO): Start
2025-06-23T21:04:55.570Z,1750712695.570 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-06-23T21:04:55.686Z,1750712695.686 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-06-23T21:04:55.962Z,1750712695.962 [DockingStepper](INFO): Starting
2025-06-23T21:04:56.518Z,1750712696.518 [DockingStepper](INFO): Starting
2025-06-23T21:04:56.782Z,1750712696.782 [DockingStepper](INFO): Starting
2025-06-23T21:04:56.833Z,1750712696.833 [DockingStepper](INFO): Init string: /1z16367aE13561N3m50
2025-06-23T21:04:57.198Z,1750712697.198 [DockingStepper](INFO): Starting
2025-06-23T21:04:57.618Z,1750712697.618 [DockingStepper](INFO): Starting
2025-06-23T21:04:58.021Z,1750712698.021 [DockingStepper](INFO): Starting
2025-06-23T21:04:58.397Z,1750712698.397 [DockingStepper](INFO): Starting
2025-06-23T21:04:58.420Z,1750712698.420 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-06-23T21:04:58.817Z,1750712698.817 [DockingStepper](INFO): Starting
2025-06-23T21:05:03.596Z,1750712703.596 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:05:15.344Z,1750712715.344 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby.
2025-06-23T21:05:15.766Z,1750712715.766 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby.
2025-06-23T21:05:16.145Z,1750712716.145 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2025-06-23T21:05:16.145Z,1750712716.145 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2025-06-23T21:05:16.145Z,1750712716.145 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2025-06-23T21:05:16.146Z,1750712716.146 [DefaultWithUndock:LeaveDock] Stopped
2025-06-23T21:05:16.146Z,1750712716.146 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2025-06-23T21:05:16.146Z,1750712716.146 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2025-06-23T21:05:16.146Z,1750712716.146 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2025-06-23T21:05:16.146Z,1750712716.146 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1
2025-06-23T21:05:16.146Z,1750712716.146 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-06-23T21:05:16.147Z,1750712716.147 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-06-23T21:05:16.147Z,1750712716.147 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-06-23T21:05:16.147Z,1750712716.147 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-06-23T21:05:16.148Z,1750712716.148 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-06-23T21:05:16.148Z,1750712716.148 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-06-23T21:05:16.148Z,1750712716.148 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-06-23T21:05:16.552Z,1750712716.552 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2025-06-23T21:05:16.552Z,1750712716.552 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:05:16.553Z,1750712716.553 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:05:16.697Z,1750712716.697 [DockingStepper](INFO): Pause
2025-06-23T21:05:16.961Z,1750712716.961 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-06-23T21:05:18.572Z,1750712718.572 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210516.00,A,3648.15378,N,12147.22029,W,0.019,0.00,230625,,,A*7E
2025-06-23T21:05:18.575Z,1750712718.575 [NAL9602](INFO): GPS fix at 20250623T210516: (36.802563, -121.787005)
2025-06-23T21:05:18.586Z,1750712718.586 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:05:18.586Z,1750712718.586 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:05:19.001Z,1750712719.001 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-06-23T21:05:34.732Z,1750712734.732 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:05:36.414Z,1750712736.414 [NAL9602](INFO): SBD MO Status=1, MOMSN=48800, MT Status=0, MTMSN=0
2025-06-23T21:05:36.464Z,1750712736.464 [NAL9602](INFO): Sent 74 bytes from file Logs/20250623T203734/Courier0013.lzma
2025-06-23T21:05:36.464Z,1750712736.464 [NAL9602](INFO): Packets left to send: 0
2025-06-23T21:05:44.954Z,1750712744.954 [NAL9602](INFO): SBD MO Status=1, MOMSN=48801, MT Status=0, MTMSN=0
2025-06-23T21:05:45.012Z,1750712745.012 [NAL9602](INFO): Sent 267 bytes from file Logs/20250623T210145/Courier0000.lzma
2025-06-23T21:05:45.012Z,1750712745.012 [NAL9602](INFO): Packets left to send: 0
2025-06-23T21:05:58.631Z,1750712758.631 [NAL9602](INFO): SBD MO Status=2, MOMSN=48802, MT Status=2, MTMSN=0
2025-06-23T21:05:58.631Z,1750712758.631 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-23T21:06:05.872Z,1750712765.872 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:06:26.281Z,1750712786.281 [NAL9602](INFO): SBD MO Status=2, MOMSN=48802, MT Status=2, MTMSN=0
2025-06-23T21:06:26.281Z,1750712786.281 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-23T21:06:26.570Z,1750712786.570 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004451
2025-06-23T21:06:35.313Z,1750712795.313 [DataOverHttps](INFO): Sending 660 bytes from file Logs/20250623T203734/Express0014.lzma
2025-06-23T21:06:46.354Z,1750712806.354 [DataOverHttps](INFO): Moved sent file to Logs/20250623T203734/Express0014.lzma.bak
2025-06-23T21:06:46.354Z,1750712806.354 [DataOverHttps](INFO): SBD MOMSN=25240573
2025-06-23T21:06:56.985Z,1750712816.985 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:07:13.958Z,1750712833.958 [DataOverHttps](INFO): Sending 1345 bytes from file Logs/20250623T210145/Express0001.lzma
2025-06-23T21:07:24.998Z,1750712844.998 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0001.lzma.bak
2025-06-23T21:07:24.998Z,1750712844.998 [DataOverHttps](INFO): SBD MOMSN=25240599
2025-06-23T21:07:27.316Z,1750712847.316 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:07:27.316Z,1750712847.316 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:07:27.316Z,1750712847.316 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:08:04.008Z,1750712884.008 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:08:26.349Z,1750712906.349 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:08:45.116Z,1750712925.116 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:09:02.961Z,1750712942.961 [DataOverHttps](IMPORTANT): SBD MTMSN=20250623T210902
2025-06-23T21:09:10.828Z,1750712950.828 [DataOverHttps](INFO): Received command: failc
2025-06-23T21:09:10.889Z,1750712950.889 [CommandExec](IMPORTANT): got command failComponent
2025-06-23T21:09:10.889Z,1750712950.889 [CommandExec](IMPORTANT): Failed components:
2025-06-23T21:09:10.889Z,1750712950.889 [CommandExec](IMPORTANT): No failed Components.
2025-06-23T21:09:21.881Z,1750712961.881 [DataOverHttps](IMPORTANT): SBD MTMSN=20250623T210920
2025-06-23T21:09:29.784Z,1750712969.784 [DataOverHttps](INFO): Received command: ibit
2025-06-23T21:09:29.865Z,1750712969.865 [CommandExec](IMPORTANT): got command ibit
2025-06-23T21:09:30.150Z,1750712970.150 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-06-23T21:09:30.150Z,1750712970.150 [IBIT](IMPORTANT): Beginning control surface checks.
2025-06-23T21:09:30.155Z,1750712970.155 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-06-23T21:09:31.763Z,1750712971.763 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210931.00,A,3648.15220,N,12147.21813,W,0.039,0.00,230625,,,D*7E
2025-06-23T21:09:31.765Z,1750712971.765 [NAL9602](INFO): GPS fix at 20250623T210931: (36.802537, -121.786969)
2025-06-23T21:09:34.815Z,1750712974.815 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.005980
CHAN A1 (24V): -0.000911
CHAN A2 (12V): 0.003655
CHAN A3 (5V): -0.000238
CHAN B0 (3.3V): 0.000588
CHAN B1 (3.15aV): -0.000385
CHAN B2 (3.15bV): 0.000202
CHAN B3 (GND): -0.003870
OPEN: 0.005821
Full Scale: +/- 1 mA
2025-06-23T21:09:41.828Z,1750712981.828 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:10:00.716Z,1750713000.716 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:10:16.006Z,1750713016.006 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 1
Latitude: 36.802536 Longitude: -121.786972
2025-06-23T21:10:16.397Z,1750713016.397 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2025-06-23T21:10:16.797Z,1750713016.797 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-06-23T21:10:16.797Z,1750713016.797 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-06-23T21:10:16.798Z,1750713016.798 [IBIT](IMPORTANT): Pressure:10.382949 PSI
2025-06-23T21:10:16.798Z,1750713016.798 [IBIT](IMPORTANT): Humidity:15.254548 %
2025-06-23T21:10:17.255Z,1750713017.255 [IBIT](IMPORTANT): Vehicle Pitch:0.663021 degrees
2025-06-23T21:10:17.256Z,1750713017.256 [IBIT](IMPORTANT): Vehicle Roll:9.092010 degrees
2025-06-23T21:10:17.256Z,1750713017.256 [IBIT](IMPORTANT): Vehicle Heading:208.395416 degrees
2025-06-23T21:10:17.643Z,1750713017.643 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-06-23T21:10:17.643Z,1750713017.643 [IBIT](IMPORTANT): buoyancyNeutral: 415.338196 cc
2025-06-23T21:10:17.644Z,1750713017.644 [IBIT](IMPORTANT): massDefault: 1.846884 cm
2025-06-23T21:10:17.644Z,1750713017.644 [IBIT](IMPORTANT): stopDepth: 215.000000 m
2025-06-23T21:10:17.644Z,1750713017.644 [IBIT](IMPORTANT): abortDepth: 255.000000 m
2025-06-23T21:10:17.645Z,1750713017.645 [IBIT](IMPORTANT): IBIT PASSED
2025-06-23T21:10:23.092Z,1750713023.092 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:10:42.052Z,1750713042.052 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:10:46.280Z,1750713046.280 [NAL9602](INFO): SBD MO Status=2, MOMSN=48802, MT Status=2, MTMSN=0
2025-06-23T21:10:46.280Z,1750713046.280 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-23T21:11:00.892Z,1750713060.892 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:11:03.674Z,1750713063.674 [NAL9602](INFO): SBD MO Status=2, MOMSN=48802, MT Status=2, MTMSN=0
2025-06-23T21:11:03.675Z,1750713063.675 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-06-23T21:11:14.582Z,1750713074.582 [NAL9602](INFO): SBD MO Status=1, MOMSN=48802, MT Status=0, MTMSN=0
2025-06-23T21:11:14.582Z,1750713074.582 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:11:19.612Z,1750713079.612 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:11:38.288Z,1750713098.288 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:11:45.289Z,1750713105.289 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:11:57.032Z,1750713117.032 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:12:19.080Z,1750713139.080 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:12:27.802Z,1750713147.802 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:12:27.802Z,1750713147.802 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:12:27.802Z,1750713147.802 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:12:27.802Z,1750713147.802 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:12:28.177Z,1750713148.177 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:12:28.177Z,1750713148.177 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:12:28.584Z,1750713148.584 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 8.068709 min
2025-06-23T21:12:28.584Z,1750713148.584 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:12:28.584Z,1750713148.584 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:12:28.584Z,1750713148.584 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:12:28.584Z,1750713148.584 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:12:28.584Z,1750713148.584 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2025-06-23T21:12:28.585Z,1750713148.585 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2025-06-23T21:12:28.585Z,1750713148.585 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:12:28.585Z,1750713148.585 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:12:30.589Z,1750713150.589 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211229.00,A,3648.15228,N,12147.22049,W,0.058,0.00,230625,,,D*76
2025-06-23T21:12:30.591Z,1750713150.591 [NAL9602](INFO): GPS fix at 20250623T211229: (36.802538, -121.787008)
2025-06-23T21:12:30.603Z,1750713150.603 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:12:30.603Z,1750713150.603 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:12:44.489Z,1750713164.489 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250623T210145/Courier0004.lzma
2025-06-23T21:12:45.949Z,1750713165.949 [NAL9602](INFO): SBD MO Status=1, MOMSN=48803, MT Status=0, MTMSN=0
2025-06-23T21:12:45.949Z,1750713165.949 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:12:55.530Z,1750713175.530 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0004.lzma.bak
2025-06-23T21:12:55.530Z,1750713175.530 [DataOverHttps](INFO): SBD MOMSN=25240640
2025-06-23T21:13:16.666Z,1750713196.666 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:13:23.430Z,1750713203.430 [DataOverHttps](INFO): Sending 933 bytes from file Logs/20250623T210145/Express0005.lzma
2025-06-23T21:13:34.545Z,1750713214.545 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0005.lzma.bak
2025-06-23T21:13:34.545Z,1750713214.545 [DataOverHttps](INFO): SBD MOMSN=25240644
2025-06-23T21:14:03.912Z,1750713243.912 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250623T210145/Express0008.lzma
2025-06-23T21:14:14.954Z,1750713254.954 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0008.lzma.bak
2025-06-23T21:14:14.954Z,1750713254.954 [DataOverHttps](INFO): SBD MOMSN=25240674
2025-06-23T21:14:17.335Z,1750713257.335 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:14:17.335Z,1750713257.335 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:14:17.335Z,1750713257.335 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:14:54.968Z,1750713294.968 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:15:13.932Z,1750713313.932 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:15:32.708Z,1750713332.708 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:15:51.568Z,1750713351.568 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:16:10.184Z,1750713370.184 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:16:28.952Z,1750713388.952 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:16:47.729Z,1750713407.729 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:17:07.724Z,1750713427.724 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:17:26.632Z,1750713446.632 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:17:45.451Z,1750713465.451 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:18:04.244Z,1750713484.244 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:18:25.980Z,1750713505.980 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:18:45.458Z,1750713525.458 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:19:04.468Z,1750713544.468 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:19:17.915Z,1750713557.915 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:19:17.915Z,1750713557.915 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:19:17.915Z,1750713557.915 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:19:17.915Z,1750713557.915 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:19:18.316Z,1750713558.316 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:19:18.316Z,1750713558.316 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 14.904367 min
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:19:18.726Z,1750713558.726 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:19:20.734Z,1750713560.734 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211920.00,A,3648.15308,N,12147.22178,W,0.000,0.00,230625,,,D*79
2025-06-23T21:19:20.737Z,1750713560.737 [NAL9602](INFO): GPS fix at 20250623T211920: (36.802551, -121.787030)
2025-06-23T21:19:20.768Z,1750713560.768 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:19:20.768Z,1750713560.768 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:19:29.324Z,1750713569.324 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250623T210145/Courier0010.lzma
2025-06-23T21:19:40.366Z,1750713580.366 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0010.lzma.bak
2025-06-23T21:19:40.366Z,1750713580.366 [DataOverHttps](INFO): SBD MOMSN=25240682
2025-06-23T21:20:11.108Z,1750713611.108 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250623T210145/Express0011.lzma
2025-06-23T21:20:11.774Z,1750713611.774 [NAL9602](INFO): SBD MO Status=1, MOMSN=48804, MT Status=0, MTMSN=0
2025-06-23T21:20:11.774Z,1750713611.774 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:20:22.150Z,1750713622.150 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0011.lzma.bak
2025-06-23T21:20:22.150Z,1750713622.150 [DataOverHttps](INFO): SBD MOMSN=25240691
2025-06-23T21:20:24.325Z,1750713624.325 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:20:24.325Z,1750713624.325 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:20:24.326Z,1750713624.326 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:20:42.474Z,1750713642.474 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:21:04.132Z,1750713664.132 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:21:22.876Z,1750713682.876 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:21:39.656Z,1750713699.656 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:21:58.297Z,1750713718.297 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:22:20.200Z,1750713740.200 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:22:40.464Z,1750713760.464 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:22:59.392Z,1750713779.392 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:23:18.345Z,1750713798.345 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:23:37.084Z,1750713817.084 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:23:55.784Z,1750713835.784 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:24:16.428Z,1750713856.428 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:24:36.688Z,1750713876.688 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:24:55.680Z,1750713895.680 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:25:14.340Z,1750713914.340 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:25:24.944Z,1750713924.944 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:25:24.944Z,1750713924.944 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:25:24.944Z,1750713924.944 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:25:24.944Z,1750713924.944 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:25:25.350Z,1750713925.350 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:25:25.350Z,1750713925.350 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 21.021602 min
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #4
2025-06-23T21:25:25.785Z,1750713925.785 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=4
2025-06-23T21:25:25.786Z,1750713925.786 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:25:25.786Z,1750713925.786 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:25:27.767Z,1750713927.767 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212527.00,A,3648.36469,N,12147.11850,W,5.404,2.73,230625,,,D*70
2025-06-23T21:25:27.769Z,1750713927.769 [NAL9602](INFO): GPS fix at 20250623T212527: (36.806078, -121.785308)
2025-06-23T21:25:27.825Z,1750713927.825 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:25:27.825Z,1750713927.825 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:25:35.861Z,1750713935.861 [RDI_Pathfinder](ERROR): only read 1 of 4 data items for beam range. Device response is::RA, 0.00, 0.8,V
2025-06-23T21:25:39.855Z,1750713939.855 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250623T210145/Courier0013.lzma
2025-06-23T21:25:44.329Z,1750713944.329 [NAL9602](INFO): SBD MO Status=1, MOMSN=48805, MT Status=0, MTMSN=0
2025-06-23T21:25:44.329Z,1750713944.329 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:25:50.898Z,1750713950.898 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0013.lzma.bak
2025-06-23T21:25:50.898Z,1750713950.898 [DataOverHttps](INFO): SBD MOMSN=25240701
2025-06-23T21:26:14.750Z,1750713974.750 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:26:18.444Z,1750713978.444 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250623T210145/Express0014.lzma
2025-06-23T21:26:29.482Z,1750713989.482 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0014.lzma.bak
2025-06-23T21:26:29.483Z,1750713989.483 [DataOverHttps](INFO): SBD MOMSN=25240705
2025-06-23T21:26:31.710Z,1750713991.710 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:26:31.710Z,1750713991.710 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:26:31.710Z,1750713991.710 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:27:09.536Z,1750714029.536 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:27:28.580Z,1750714048.580 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:27:47.372Z,1750714067.372 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:28:06.068Z,1750714086.068 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:28:29.916Z,1750714109.916 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:28:48.716Z,1750714128.716 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:29:07.552Z,1750714147.552 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:29:26.188Z,1750714166.188 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:29:44.897Z,1750714184.897 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:30:03.676Z,1750714203.676 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:30:26.056Z,1750714226.056 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:30:45.436Z,1750714245.436 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:31:04.160Z,1750714264.160 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:31:22.804Z,1750714282.804 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:31:32.380Z,1750714292.380 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:31:32.380Z,1750714292.380 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:31:32.380Z,1750714292.380 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:31:32.380Z,1750714292.380 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:31:32.771Z,1750714292.771 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:31:32.771Z,1750714292.771 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:31:33.170Z,1750714293.170 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 27.145288 min
2025-06-23T21:31:33.170Z,1750714293.170 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:31:33.170Z,1750714293.170 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:31:33.170Z,1750714293.170 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:31:33.171Z,1750714293.171 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:31:33.171Z,1750714293.171 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #5
2025-06-23T21:31:33.171Z,1750714293.171 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=5
2025-06-23T21:31:33.171Z,1750714293.171 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:31:33.171Z,1750714293.171 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:31:35.187Z,1750714295.187 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213134.00,A,3648.35047,N,12147.71520,W,13.315,287.06,230625,,,A*48
2025-06-23T21:31:35.189Z,1750714295.189 [NAL9602](INFO): GPS fix at 20250623T213134: (36.805841, -121.795253)
2025-06-23T21:31:35.221Z,1750714295.221 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:31:35.221Z,1750714295.221 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:31:44.483Z,1750714304.483 [NAL9602](INFO): SBD MO Status=1, MOMSN=48806, MT Status=0, MTMSN=0
2025-06-23T21:31:44.483Z,1750714304.483 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:31:49.667Z,1750714309.667 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250623T210145/Courier0016.lzma
2025-06-23T21:32:00.710Z,1750714320.710 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0016.lzma.bak
2025-06-23T21:32:00.710Z,1750714320.710 [DataOverHttps](INFO): SBD MOMSN=25240714
2025-06-23T21:32:15.244Z,1750714335.244 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:32:34.282Z,1750714354.282 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20250623T210145/Express0017.lzma
2025-06-23T21:32:44.918Z,1750714364.918 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0017.lzma.bak
2025-06-23T21:32:44.918Z,1750714364.918 [DataOverHttps](INFO): SBD MOMSN=25240718
2025-06-23T21:32:47.193Z,1750714367.193 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:32:47.193Z,1750714367.193 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:32:47.193Z,1750714367.193 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:33:25.916Z,1750714405.916 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:33:43.308Z,1750714423.308 [BPC1](INFO): Calculating totals. Valid battery stick count: 21. Valid reserve battery stick count: 3.
2025-06-23T21:33:43.316Z,1750714423.316 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2025-06-23T21:33:45.876Z,1750714425.876 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:34:08.457Z,1750714448.457 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:34:27.212Z,1750714467.212 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:34:46.892Z,1750714486.892 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:35:05.744Z,1750714505.744 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:35:24.728Z,1750714524.728 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:35:46.628Z,1750714546.628 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:36:05.224Z,1750714565.224 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:36:27.388Z,1750714587.388 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:36:46.300Z,1750714606.300 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:37:05.204Z,1750714625.204 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:37:24.004Z,1750714644.004 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:37:41.628Z,1750714661.628 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:37:47.824Z,1750714667.824 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:37:47.824Z,1750714667.824 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:37:47.824Z,1750714667.824 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:37:47.824Z,1750714667.824 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:37:48.168Z,1750714668.168 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:37:48.168Z,1750714668.168 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:37:48.585Z,1750714668.585 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 33.401898 min
2025-06-23T21:37:48.585Z,1750714668.585 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:37:48.585Z,1750714668.585 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:37:48.585Z,1750714668.585 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:37:48.586Z,1750714668.586 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:37:48.586Z,1750714668.586 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #6
2025-06-23T21:37:48.586Z,1750714668.586 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=6
2025-06-23T21:37:48.586Z,1750714668.586 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:37:48.586Z,1750714668.586 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:37:50.579Z,1750714670.579 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213749.00,A,3648.58633,N,12149.79180,W,17.203,277.11,230625,,,A*49
2025-06-23T21:37:50.581Z,1750714670.581 [NAL9602](INFO): GPS fix at 20250623T213749: (36.809772, -121.829863)
2025-06-23T21:37:50.605Z,1750714670.605 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:37:50.605Z,1750714670.605 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:37:56.892Z,1750714676.892 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20250623T210145/Courier0019.lzma
2025-06-23T21:38:08.458Z,1750714688.458 [NAL9602](INFO): SBD MO Status=1, MOMSN=48807, MT Status=0, MTMSN=0
2025-06-23T21:38:08.458Z,1750714688.458 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:38:09.487Z,1750714689.487 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0019.lzma.bak
2025-06-23T21:38:09.487Z,1750714689.487 [DataOverHttps](INFO): SBD MOMSN=25240727
2025-06-23T21:38:36.756Z,1750714716.756 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20250623T210145/Express0020.lzma
2025-06-23T21:38:39.151Z,1750714719.151 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:38:47.798Z,1750714727.798 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0020.lzma.bak
2025-06-23T21:38:47.798Z,1750714727.798 [DataOverHttps](INFO): SBD MOMSN=25240731
2025-06-23T21:38:50.490Z,1750714730.490 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:38:50.490Z,1750714730.490 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:38:50.490Z,1750714730.490 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:39:28.169Z,1750714768.169 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:39:47.836Z,1750714787.836 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:40:05.748Z,1750714805.748 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:40:30.106Z,1750714830.106 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:40:48.808Z,1750714848.808 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:41:18.941Z,1750714878.941 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:41:19.944Z,1750714879.944 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:41:47.772Z,1750714907.772 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:42:06.412Z,1750714926.412 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:42:27.700Z,1750714947.700 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:42:46.628Z,1750714966.628 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:43:15.372Z,1750714995.372 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:43:34.353Z,1750715014.353 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:43:51.058Z,1750715031.058 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:43:51.058Z,1750715031.058 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:43:51.058Z,1750715031.058 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:43:51.058Z,1750715031.058 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:43:51.523Z,1750715031.523 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:43:51.523Z,1750715031.523 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 39.457808 min
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #7
2025-06-23T21:43:51.891Z,1750715031.891 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=7
2025-06-23T21:43:51.892Z,1750715031.892 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:43:51.892Z,1750715031.892 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:43:53.883Z,1750715033.883 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214353.00,A,3649.08895,N,12151.94879,W,20.469,279.64,230625,,,D*45
2025-06-23T21:43:53.885Z,1750715033.885 [NAL9602](INFO): GPS fix at 20250623T214353: (36.818149, -121.865813)
2025-06-23T21:43:53.896Z,1750715033.896 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:43:53.896Z,1750715033.896 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:44:12.878Z,1750715052.878 [NAL9602](INFO): SBD MO Status=1, MOMSN=48808, MT Status=0, MTMSN=0
2025-06-23T21:44:12.878Z,1750715052.878 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:44:15.623Z,1750715055.623 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250623T210145/Courier0022.lzma
2025-06-23T21:44:26.664Z,1750715066.664 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-06-23T21:44:36.407Z,1750715076.407 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250623T210145/Courier0022.lzma
2025-06-23T21:44:43.579Z,1750715083.579 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:44:47.454Z,1750715087.454 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0022.lzma.bak
2025-06-23T21:44:47.454Z,1750715087.454 [DataOverHttps](INFO): SBD MOMSN=25240775
2025-06-23T21:45:12.332Z,1750715112.332 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20250623T210145/Express0023.lzma
2025-06-23T21:45:25.382Z,1750715125.382 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0023.lzma.bak
2025-06-23T21:45:25.383Z,1750715125.383 [DataOverHttps](INFO): SBD MOMSN=25240780
2025-06-23T21:45:28.064Z,1750715128.064 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:45:28.064Z,1750715128.064 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:45:28.064Z,1750715128.064 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:46:20.364Z,1750715180.364 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-06-23T21:46:21.368Z,1750715181.368 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:46:49.494Z,1750715209.494 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.956738
2025-06-23T21:46:50.496Z,1750715210.496 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:47:20.626Z,1750715240.626 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:47:21.628Z,1750715241.628 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:47:51.748Z,1750715271.748 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:47:52.752Z,1750715272.752 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:48:22.872Z,1750715302.872 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:48:23.877Z,1750715303.877 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:48:54.004Z,1750715334.004 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:48:55.010Z,1750715335.010 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:49:25.140Z,1750715365.140 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:49:26.144Z,1750715366.144 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:49:56.268Z,1750715396.268 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:49:57.272Z,1750715397.272 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:50:27.420Z,1750715427.420 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:50:28.424Z,1750715428.424 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:50:28.646Z,1750715428.646 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:50:28.647Z,1750715428.647 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:50:28.647Z,1750715428.647 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:50:28.647Z,1750715428.647 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:50:29.041Z,1750715429.041 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:50:29.041Z,1750715429.041 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:50:29.458Z,1750715429.458 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 46.083110 min
2025-06-23T21:50:29.459Z,1750715429.459 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:50:29.459Z,1750715429.459 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:50:29.476Z,1750715429.476 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:50:29.476Z,1750715429.476 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:50:29.477Z,1750715429.477 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #8
2025-06-23T21:50:29.477Z,1750715429.477 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=8
2025-06-23T21:50:29.478Z,1750715429.478 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:50:29.478Z,1750715429.478 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:50:31.492Z,1750715431.492 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215030.00,A,3649.56631,N,12154.28802,W,19.963,289.17,230625,,,A*44
2025-06-23T21:50:31.517Z,1750715431.517 [NAL9602](INFO): GPS fix at 20250623T215030: (36.826105, -121.904800)
2025-06-23T21:50:31.547Z,1750715431.547 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:50:31.548Z,1750715431.548 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:50:48.790Z,1750715448.790 [NAL9602](INFO): SBD MO Status=1, MOMSN=48809, MT Status=0, MTMSN=0
2025-06-23T21:50:48.844Z,1750715448.844 [NAL9602](INFO): Sent 73 bytes from file Logs/20250623T210145/Courier0025.lzma
2025-06-23T21:50:48.844Z,1750715448.844 [NAL9602](INFO): Packets left to send: 0
2025-06-23T21:50:57.679Z,1750715457.679 [NAL9602](INFO): SBD MO Status=1, MOMSN=48810, MT Status=0, MTMSN=0
2025-06-23T21:50:57.732Z,1750715457.732 [NAL9602](INFO): Sent 169 bytes from file Logs/20250623T210145/Express0026.lzma
2025-06-23T21:50:57.732Z,1750715457.732 [NAL9602](INFO): Packets left to send: 0
2025-06-23T21:50:58.553Z,1750715458.553 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:50:59.556Z,1750715459.556 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:51:05.601Z,1750715465.601 [NAL9602](INFO): SBD MO Status=0, MOMSN=48811, MT Status=0, MTMSN=0
2025-06-23T21:51:05.815Z,1750715465.815 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:51:05.815Z,1750715465.815 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:51:05.854Z,1750715465.854 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:51:29.684Z,1750715489.684 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:51:30.688Z,1750715490.688 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:51:36.285Z,1750715496.285 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:52:00.824Z,1750715520.824 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-06-23T21:52:01.828Z,1750715521.828 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:52:22.629Z,1750715542.629 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003327
2025-06-23T21:52:23.628Z,1750715543.628 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:52:42.240Z,1750715562.240 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:53:01.068Z,1750715581.068 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:53:20.040Z,1750715600.040 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:53:38.824Z,1750715618.824 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:53:57.624Z,1750715637.624 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:54:19.548Z,1750715659.548 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:54:38.836Z,1750715678.836 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:54:57.800Z,1750715697.800 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:55:16.468Z,1750715716.468 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:55:35.368Z,1750715735.368 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:55:58.168Z,1750715758.168 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:56:06.338Z,1750715766.338 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T21:56:06.338Z,1750715766.338 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T21:56:06.338Z,1750715766.338 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T21:56:06.338Z,1750715766.338 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T21:56:06.744Z,1750715766.744 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T21:56:06.744Z,1750715766.744 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 51.711499 min
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #9
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=9
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T21:56:07.130Z,1750715767.130 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-06-23T21:56:09.135Z,1750715769.135 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215608.00,A,3650.18678,N,12156.04881,W,13.296,328.72,230625,,,A*43
2025-06-23T21:56:09.137Z,1750715769.137 [NAL9602](INFO): GPS fix at 20250623T215608: (36.836446, -121.934147)
2025-06-23T21:56:09.219Z,1750715769.219 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-06-23T21:56:09.219Z,1750715769.219 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-06-23T21:56:15.984Z,1750715775.984 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250623T210145/Courier0028.lzma
2025-06-23T21:56:25.359Z,1750715785.359 [NAL9602](INFO): SBD MO Status=0, MOMSN=48812, MT Status=0, MTMSN=0
2025-06-23T21:56:25.359Z,1750715785.359 [NAL9602](INFO): No messages in MT queue
2025-06-23T21:56:29.034Z,1750715789.034 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Courier0028.lzma.bak
2025-06-23T21:56:29.034Z,1750715789.034 [DataOverHttps](INFO): SBD MOMSN=25240802
2025-06-23T21:56:56.065Z,1750715816.065 [NAL9602](INFO): Not Powering down - fast GPS
2025-06-23T21:56:56.852Z,1750715816.852 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20250623T210145/Express0029.lzma
2025-06-23T21:57:07.907Z,1750715827.907 [DataOverHttps](INFO): Moved sent file to Logs/20250623T210145/Express0029.lzma.bak
2025-06-23T21:57:07.907Z,1750715827.907 [DataOverHttps](INFO): SBD MOMSN=25240808
2025-06-23T21:57:11.052Z,1750715831.052 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-06-23T21:57:11.052Z,1750715831.052 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-06-23T21:57:11.052Z,1750715831.052 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-06-23T21:57:49.380Z,1750715869.380 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:58:08.969Z,1750715888.969 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:58:27.828Z,1750715907.828 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:58:46.644Z,1750715926.644 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:59:05.352Z,1750715945.352 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:59:24.116Z,1750715964.116 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T21:59:43.844Z,1750715983.844 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:00:04.645Z,1750716004.645 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:00:26.636Z,1750716026.636 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:00:45.320Z,1750716045.320 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:01:04.064Z,1750716064.064 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:01:20.813Z,1750716080.813 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:01:40.644Z,1750716100.644 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:02:02.488Z,1750716122.488 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-06-23T22:02:11.849Z,1750716131.849 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-06-23T22:02:11.850Z,1750716131.850 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-06-23T22:02:11.850Z,1750716131.850 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-06-23T22:02:11.850Z,1750716131.850 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-06-23T22:02:12.185Z,1750716132.185 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-06-23T22:02:12.185Z,1750716132.185 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-06-23T22:02:12.572Z,1750716132.572 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 57.802185 min
2025-06-23T22:02:12.572Z,1750716132.572 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-06-23T22:02:12.572Z,1750716132.572 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T22:02:12.572Z,1750716132.572 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-06-23T22:02:12.573Z,1750716132.573 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T22:02:12.573Z,1750716132.573 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #10
2025-06-23T22:02:12.573Z,1750716132.573 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=10
2025-06-23T22:02:12.573Z,1750716132.573 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-06-23T22:02:12.573Z,1750716132.573 [DefaultWithUndock:Surface