2025-12-17T03:40:23.938Z,1765942823.938 [Supervisor](DEBUG): Initializing supervisor.
2025-12-17T03:40:23.942Z,1765942823.942 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-12-17T03:40:23.942Z,1765942823.942 [SyncHandler](INFO): Protected caller Thread ID is 6381
2025-12-17T03:40:23.943Z,1765942823.943 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-12-17T03:40:23.944Z,1765942823.944 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-12-17T03:40:23.944Z,1765942823.944 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6382
2025-12-17T03:40:23.948Z,1765942823.948 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-12-17T03:40:23.967Z,1765942823.967 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-12-17T03:40:23.968Z,1765942823.968 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-12-17T03:40:23.968Z,1765942823.968 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6383
2025-12-17T03:40:23.972Z,1765942823.972 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-12-17T03:40:23.974Z,1765942823.974 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-12-17T03:40:23.974Z,1765942823.974 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6384
2025-12-17T03:40:23.976Z,1765942823.976 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-12-17T03:40:23.977Z,1765942823.977 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-12-17T03:40:23.977Z,1765942823.977 [logger ThreadHandler](INFO): Protected caller Thread ID is 6385
2025-12-17T03:40:23.981Z,1765942823.981 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-12-17T03:40:23.981Z,1765942823.981 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-12-17T03:40:23.987Z,1765942823.987 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-12-17T03:40:24.374Z,1765942824.374 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-12-17T03:40:24.375Z,1765942824.375 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-12-17T03:40:25.106Z,1765942825.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-12-17T03:40:25.106Z,1765942825.106 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-12-17T03:40:25.224Z,1765942825.224 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-12-17T03:40:25.226Z,1765942825.226 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-12-17T03:40:25.742Z,1765942825.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-12-17T03:40:25.744Z,1765942825.744 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-12-17T03:40:25.849Z,1765942825.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-12-17T03:40:25.849Z,1765942825.849 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-12-17T03:40:25.949Z,1765942825.949 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance
2025-12-17T03:40:25.950Z,1765942825.950 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-12-17T03:40:26.355Z,1765942826.355 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-12-17T03:40:26.357Z,1765942826.357 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-12-17T03:40:26.579Z,1765942826.579 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-12-17T03:40:26.580Z,1765942826.580 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-12-17T03:40:26.724Z,1765942826.724 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-12-17T03:40:26.725Z,1765942826.725 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-12-17T03:40:26.975Z,1765942826.975 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-12-17T03:40:26.976Z,1765942826.976 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-12-17T03:40:27.523Z,1765942827.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-12-17T03:40:27.525Z,1765942827.525 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-12-17T03:40:27.970Z,1765942827.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-12-17T03:40:28.235Z,1765942828.235 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-12-17T03:40:28.969Z,1765942828.969 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-12-17T03:40:29.163Z,1765942829.163 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-12-17T03:40:29.164Z,1765942829.164 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-12-17T03:40:29.410Z,1765942829.410 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-12-17T03:40:29.412Z,1765942829.412 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-12-17T03:40:29.708Z,1765942829.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-12-17T03:40:29.710Z,1765942829.710 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2025-12-17T03:40:29.714Z,1765942829.714 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2025-12-17T03:40:29.820Z,1765942829.820 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2025-12-17T03:40:29.976Z,1765942829.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2025-12-17T03:40:30.071Z,1765942830.071 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2025-12-17T03:40:30.164Z,1765942830.164 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2025-12-17T03:40:30.282Z,1765942830.282 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/workSite.cfg
2025-12-17T03:40:30.383Z,1765942830.383 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Dock.cfg
2025-12-17T03:40:30.501Z,1765942830.501 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2025-12-17T03:40:30.613Z,1765942830.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2025-12-17T03:40:30.883Z,1765942830.883 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-12-17T03:40:30.883Z,1765942830.883 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2025-12-17T03:40:31.022Z,1765942831.022 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2025-12-17T03:40:31.124Z,1765942831.124 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2025-12-17T03:40:31.236Z,1765942831.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2025-12-17T03:40:31.329Z,1765942831.329 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-12-17T03:40:31.342Z,1765942831.342 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-12-17T03:40:31.503Z,1765942831.503 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-12-17T03:40:31.503Z,1765942831.503 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-12-17T03:40:31.517Z,1765942831.517 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-12-17T03:40:31.518Z,1765942831.518 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-12-17T03:40:31.578Z,1765942831.578 [DepthRateCalculator] Loaded
2025-12-17T03:40:31.579Z,1765942831.579 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-12-17T03:40:31.584Z,1765942831.584 [PitchRateCalculator] Loaded
2025-12-17T03:40:31.584Z,1765942831.584 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-12-17T03:40:31.595Z,1765942831.595 [SpeedCalculator] Loaded
2025-12-17T03:40:31.595Z,1765942831.595 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-12-17T03:40:31.599Z,1765942831.599 [YawRateCalculator] Loaded
2025-12-17T03:40:31.600Z,1765942831.600 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-12-17T03:40:31.621Z,1765942831.621 [ElevatorOffsetCalculator] Loaded
2025-12-17T03:40:31.621Z,1765942831.621 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-12-17T03:40:31.622Z,1765942831.622 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-12-17T03:40:31.622Z,1765942831.622 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-12-17T03:40:31.685Z,1765942831.685 [VerticalControl](DEBUG): Construct VerticalControl.
2025-12-17T03:40:31.740Z,1765942831.740 [VerticalControl] Loaded
2025-12-17T03:40:31.740Z,1765942831.740 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-12-17T03:40:31.743Z,1765942831.743 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-12-17T03:40:31.789Z,1765942831.789 [HorizontalControl] Loaded
2025-12-17T03:40:31.790Z,1765942831.790 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-12-17T03:40:31.792Z,1765942831.792 [SpeedControl](DEBUG): Construct SpeedControl.
2025-12-17T03:40:31.795Z,1765942831.795 [SpeedControl] Loaded
2025-12-17T03:40:31.795Z,1765942831.795 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-12-17T03:40:31.798Z,1765942831.798 [LoopControl](DEBUG): Construct LoopControl.
2025-12-17T03:40:31.798Z,1765942831.798 [LoopControl] Loaded
2025-12-17T03:40:31.798Z,1765942831.798 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-12-17T03:40:31.799Z,1765942831.799 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-12-17T03:40:31.799Z,1765942831.799 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-12-17T03:40:31.929Z,1765942831.929 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-12-17T03:40:31.929Z,1765942831.929 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-12-17T03:40:31.943Z,1765942831.943 [NavChart] Loaded
2025-12-17T03:40:31.943Z,1765942831.943 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-12-17T03:40:31.948Z,1765942831.948 [UniversalFixResidualReporter] Loaded
2025-12-17T03:40:31.949Z,1765942831.949 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-12-17T03:40:31.949Z,1765942831.949 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-12-17T03:40:31.950Z,1765942831.950 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-12-17T03:40:32.149Z,1765942832.149 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-12-17T03:40:32.149Z,1765942832.149 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-12-17T03:40:33.582Z,1765942833.582 [AHRS_M2] Loaded
2025-12-17T03:40:33.583Z,1765942833.583 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-12-17T03:40:33.622Z,1765942833.622 [BackseatComponent] Loaded
2025-12-17T03:40:33.622Z,1765942833.622 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-12-17T03:40:33.623Z,1765942833.623 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409404E0
2025-12-17T03:40:33.624Z,1765942833.624 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6473
2025-12-17T03:40:33.627Z,1765942833.627 [LcmPublisher](INFO): Full slate access is ENABLED. All requested slate values (including non-universals) will be published on LCM.
2025-12-17T03:40:33.627Z,1765942833.627 [LcmPublisher] Loaded
2025-12-17T03:40:33.627Z,1765942833.627 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread.
2025-12-17T03:40:34.448Z,1765942834.448 [BPC1] Loaded
2025-12-17T03:40:34.448Z,1765942834.448 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-12-17T03:40:34.546Z,1765942834.546 [DAT] Loaded
2025-12-17T03:40:34.546Z,1765942834.546 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-12-17T03:40:34.547Z,1765942834.547 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409704E0
2025-12-17T03:40:34.547Z,1765942834.547 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6474
2025-12-17T03:40:34.618Z,1765942834.618 [DataOverHttps] Loaded
2025-12-17T03:40:34.618Z,1765942834.618 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-12-17T03:40:34.619Z,1765942834.619 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409A04E0
2025-12-17T03:40:34.620Z,1765942834.620 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6475
2025-12-17T03:40:34.643Z,1765942834.643 [Depth_Keller] Loaded
2025-12-17T03:40:34.643Z,1765942834.643 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-12-17T03:40:34.648Z,1765942834.648 [DropWeight] Loaded
2025-12-17T03:40:34.648Z,1765942834.648 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-12-17T03:40:34.711Z,1765942834.711 [NAL9602] Loaded
2025-12-17T03:40:34.712Z,1765942834.712 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-12-17T03:40:34.741Z,1765942834.741 [Onboard] Loaded
2025-12-17T03:40:34.741Z,1765942834.741 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-12-17T03:40:34.742Z,1765942834.742 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409D04E0
2025-12-17T03:40:34.742Z,1765942834.742 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6476
2025-12-17T03:40:34.756Z,1765942834.756 [Power24vConverter] Loaded
2025-12-17T03:40:34.756Z,1765942834.756 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-12-17T03:40:34.772Z,1765942834.772 [Radio_Surface] Loaded
2025-12-17T03:40:34.772Z,1765942834.772 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-12-17T03:40:34.773Z,1765942834.773 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A004E0
2025-12-17T03:40:34.774Z,1765942834.774 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6477
2025-12-17T03:40:34.819Z,1765942834.819 [RDI_Pathfinder] Loaded
2025-12-17T03:40:34.820Z,1765942834.820 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2025-12-17T03:40:34.834Z,1765942834.834 [Sonardyne_Nano] Loaded
2025-12-17T03:40:34.835Z,1765942834.835 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-12-17T03:40:34.835Z,1765942834.835 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-12-17T03:40:34.836Z,1765942834.836 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-12-17T03:40:35.738Z,1765942835.738 [BuoyancyServo] Loaded
2025-12-17T03:40:35.738Z,1765942835.738 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-12-17T03:40:35.761Z,1765942835.761 [ElevatorServo] Loaded
2025-12-17T03:40:35.762Z,1765942835.762 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-12-17T03:40:35.791Z,1765942835.791 [DockingStepper] Loaded
2025-12-17T03:40:35.791Z,1765942835.791 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread.
2025-12-17T03:40:35.810Z,1765942835.810 [MassServo] Loaded
2025-12-17T03:40:35.811Z,1765942835.811 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-12-17T03:40:35.831Z,1765942835.831 [RudderServo] Loaded
2025-12-17T03:40:35.831Z,1765942835.831 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-12-17T03:40:35.847Z,1765942835.847 [ThrusterHE] Loaded
2025-12-17T03:40:35.848Z,1765942835.848 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-12-17T03:40:35.848Z,1765942835.848 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-12-17T03:40:35.849Z,1765942835.849 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-12-17T03:40:35.929Z,1765942835.929 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-12-17T03:40:35.930Z,1765942835.930 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-12-17T03:40:35.971Z,1765942835.971 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-12-17T03:40:35.971Z,1765942835.971 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-12-17T03:40:36.352Z,1765942836.352 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-12-17T03:40:36.352Z,1765942836.352 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-12-17T03:40:36.560Z,1765942836.560 [CTD_Seabird] Loaded
2025-12-17T03:40:36.561Z,1765942836.561 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-12-17T03:40:36.562Z,1765942836.562 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BC24E0
2025-12-17T03:40:36.562Z,1765942836.562 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6478
2025-12-17T03:40:36.598Z,1765942836.598 [ESPComponent] Loaded
2025-12-17T03:40:36.598Z,1765942836.598 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2025-12-17T03:40:36.620Z,1765942836.620 [PAR_Licor] Loaded
2025-12-17T03:40:36.620Z,1765942836.620 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-12-17T03:40:36.665Z,1765942836.665 [WetLabsBB2FL] Loaded
2025-12-17T03:40:36.665Z,1765942836.665 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-12-17T03:40:36.666Z,1765942836.666 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BF24E0
2025-12-17T03:40:36.666Z,1765942836.666 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6479
2025-12-17T03:40:36.667Z,1765942836.667 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-12-17T03:40:36.668Z,1765942836.668 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-12-17T03:40:36.857Z,1765942836.857 [SBIT](DEBUG): Construct Startup Built In Test.
2025-12-17T03:40:36.866Z,1765942836.866 [SBIT] Loaded
2025-12-17T03:40:36.866Z,1765942836.866 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-12-17T03:40:36.869Z,1765942836.869 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-12-17T03:40:36.882Z,1765942836.882 [IBIT] Loaded
2025-12-17T03:40:36.882Z,1765942836.882 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-12-17T03:40:36.887Z,1765942836.887 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-12-17T03:40:36.967Z,1765942836.967 [CBIT] Loaded
2025-12-17T03:40:36.967Z,1765942836.967 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-12-17T03:40:36.000Z,1765942837.000 [GFScanner] Loaded
2025-12-17T03:40:37.000Z,1765942837.000 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-12-17T03:40:37.000Z,1765942837.000 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-12-17T03:40:37.007Z,1765942837.007 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-12-17T03:40:37.010Z,1765942837.010 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-12-17T03:40:37.021Z,1765942837.021 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-12-17T03:40:37.022Z,1765942837.022 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C6D4E0
2025-12-17T03:40:37.022Z,1765942837.022 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6480
2025-12-17T03:40:37.026Z,1765942837.026 [Supervisor](INFO): Main Thread ID is 825
2025-12-17T03:40:37.026Z,1765942837.026 [Supervisor](DEBUG): Running supervisor.
2025-12-17T03:40:37.027Z,1765942837.027 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6481
2025-12-17T03:40:37.027Z,1765942837.027 [CommandExec](INFO): Initializing the command executive.
2025-12-17T03:40:37.029Z,1765942837.029 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6482
2025-12-17T03:40:37.031Z,1765942837.031 [controlThread ThreadHandler](INFO): Handler Thread ID is 6483
2025-12-17T03:40:37.032Z,1765942837.032 [controlThread](DEBUG): Initializing ControlThread
2025-12-17T03:40:37.032Z,1765942837.032 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-12-17T03:40:37.033Z,1765942837.033 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-12-17T03:40:37.033Z,1765942837.033 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-12-17T03:40:37.034Z,1765942837.034 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-12-17T03:40:37.034Z,1765942837.034 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-12-17T03:40:37.035Z,1765942837.035 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-12-17T03:40:37.036Z,1765942837.036 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-12-17T03:40:37.037Z,1765942837.037 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-12-17T03:40:37.037Z,1765942837.037 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-12-17T03:40:37.038Z,1765942837.038 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-12-17T03:40:37.038Z,1765942837.038 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-12-17T03:40:37.045Z,1765942837.045 [SBIT](INFO): Initialize SBIT Component.
2025-12-17T03:40:37.045Z,1765942837.045 [SBIT](IMPORTANT): git: 2025-12-11-2-g5b5070323
2025-12-17T03:40:37.046Z,1765942837.046 [SBIT](INFO): git hash: 5b50703234a74cb9c609bca727303ff504a0b330
2025-12-17T03:40:37.046Z,1765942837.046 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-12-17T03:40:37.047Z,1765942837.047 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-12-17T03:40:37.048Z,1765942837.048 [SBIT](INFO): Beginning SBIT in 76.000000 seconds.
2025-12-17T03:40:37.049Z,1765942837.049 [IBIT](INFO): Initialize IBIT Component.
2025-12-17T03:40:37.050Z,1765942837.050 [CBIT](DEBUG): Initialize CBIT Component.
2025-12-17T03:40:37.051Z,1765942837.051 [logger ThreadHandler](INFO): Handler Thread ID is 6484
2025-12-17T03:40:37.061Z,1765942837.061 [CBIT](DEBUG): Initialized mux pins.
2025-12-17T03:40:37.061Z,1765942837.061 [CBIT](DEBUG): Initializing the watchdog timer.
2025-12-17T03:40:37.069Z,1765942837.069 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6485
2025-12-17T03:40:37.081Z,1765942837.081 [DAT ThreadHandler](INFO): Handler Thread ID is 6486
2025-12-17T03:40:37.082Z,1765942837.082 [DAT](INFO): Powering up
2025-12-17T03:40:37.082Z,1765942837.082 [DAT](DEBUG): Initializing DAT.
2025-12-17T03:40:37.085Z,1765942837.085 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-12-17T03:40:37.085Z,1765942837.085 [CBIT](DEBUG): Initializing heartbeat.
2025-12-17T03:40:37.087Z,1765942837.087 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6488
2025-12-17T03:40:37.089Z,1765942837.089 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-12-17T03:40:37.097Z,1765942837.097 [Onboard ThreadHandler](INFO): Handler Thread ID is 6489
2025-12-17T03:40:37.115Z,1765942837.115 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6490
2025-12-17T03:40:37.134Z,1765942837.134 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6491
2025-12-17T03:40:37.134Z,1765942837.134 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-12-17T03:40:37.138Z,1765942837.138 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6493
2025-12-17T03:40:37.141Z,1765942837.141 [WetLabsBB2FL](INFO): Powering up
2025-12-17T03:40:37.142Z,1765942837.142 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6495
2025-12-17T03:40:37.146Z,1765942837.146 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-12-17T03:40:37.147Z,1765942837.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-12-17T03:40:37.147Z,1765942837.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-12-17T03:40:37.147Z,1765942837.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-12-17T03:40:37.147Z,1765942837.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-12-17T03:40:37.147Z,1765942837.147 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-12-17T03:40:37.147Z,1765942837.147 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-12-17T03:40:37.148Z,1765942837.148 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-12-17T03:40:37.157Z,1765942837.157 [CBIT](DEBUG): Deactivating emergency mode.
2025-12-17T03:40:37.197Z,1765942837.197 [CBIT](DEBUG): Backplane powered.
2025-12-17T03:40:37.197Z,1765942837.197 [GFScanner](DEBUG): Initializing GFScanner
2025-12-17T03:40:37.197Z,1765942837.197 [GFScanner](DEBUG): Deactivating GF circuits.
2025-12-17T03:40:37.202Z,1765942837.202 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-12-17T03:40:37.203Z,1765942837.203 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl
2025-12-17T03:40:37.203Z,1765942837.203 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl
2025-12-17T03:40:37.209Z,1765942837.209 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl
2025-12-17T03:40:37.214Z,1765942837.214 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into:
2025-12-17T03:40:37.214Z,1765942837.214 [MissionManager](ERROR): Top node has no child nodes: Mission
2025-12-17T03:40:37.214Z,1765942837.214 [MissionManager](ERROR): Could not load startup mission.
2025-12-17T03:40:37.215Z,1765942837.215 [MissionManager](INFO): Loading Mission from file: Missions/underIce/DefaultWithUndock.tl
2025-12-17T03:40:37.215Z,1765942837.215 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/DefaultWithUndock.tl
2025-12-17T03:40:37.221Z,1765942837.221 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/DefaultWithUndock.tl
2025-12-17T03:40:37.521Z,1765942837.521 [Radio_Surface](INFO): Powering up
2025-12-17T03:40:37.773Z,1765942837.773 [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-12-17T03:40:37.800Z,1765942837.800 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2025-12-17T03:40:37.804Z,1765942837.804 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 6.000000 h
2025-12-17T03:40:37.817Z,1765942837.817 [MissionManager](INFO): DefineArg DefaultWithUndock.TransponderCode = 50 count
2025-12-17T03:40:37.845Z,1765942837.845 [MissionManager](INFO): DefineArg DefaultWithUndock.TrackingUpdatePeriod = 10.000000 s
2025-12-17T03:40:37.849Z,1765942837.849 [MissionManager](INFO): DefineArg DefaultWithUndock.NumberOfPings = 1.000000 count
2025-12-17T03:40:37.864Z,1765942837.864 [MissionManager](INFO): DefineArg DefaultWithUndock.DriftTimeout = 3.000000 min
2025-12-17T03:40:37.866Z,1765942837.866 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2025-12-17T03:40:38.023Z,1765942838.023 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Construct.
2025-12-17T03:40:38.023Z,1765942838.023 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-12-17T03:40:38.076Z,1765942838.076 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-12-17T03:40:38.122Z,1765942838.122 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-12-17T03:40:38.125Z,1765942838.125 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-12-17T03:40:38.144Z,1765942838.144 [DefaultWithUndock:E.Execute](DEBUG): Construct Execute.
2025-12-17T03:40:38.160Z,1765942838.160 [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-12-17T03:40:38.174Z,1765942838.174 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmPublisher,Reporter,LogSplitter,
2025-12-17T03:40:38.193Z,1765942838.193 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-12-17T03:40:38.265Z,1765942838.265 [Depth_Keller](INFO): Initializing.
2025-12-17T03:40:38.267Z,1765942838.267 [Power24vConverter](INFO): Powering up.
2025-12-17T03:40:38.267Z,1765942838.267 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2025-12-17T03:40:38.274Z,1765942838.274 [Sonardyne_Nano](INFO): Initializing.
2025-12-17T03:40:38.317Z,1765942838.317 [DepthRateCalculator](ERROR): Depth measurement is not active
2025-12-17T03:40:38.353Z,1765942838.353 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-12-17T03:40:38.361Z,1765942838.361 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-12-17T03:40:38.362Z,1765942838.362 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-12-17T03:40:38.369Z,1765942838.369 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-12-17T03:40:38.370Z,1765942838.370 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-12-17T03:40:38.378Z,1765942838.378 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-12-17T03:40:38.378Z,1765942838.378 [MassServo](DEBUG): Initializing EZServoServo.
2025-12-17T03:40:38.385Z,1765942838.385 [MassServo](DEBUG): Initializing MassServo.
2025-12-17T03:40:38.386Z,1765942838.386 [RudderServo](DEBUG): Initializing EZServoServo.
2025-12-17T03:40:38.393Z,1765942838.393 [RudderServo](DEBUG): Initializing RudderServo.
2025-12-17T03:40:38.394Z,1765942838.394 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-12-17T03:40:38.401Z,1765942838.401 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-12-17T03:40:39.249Z,1765942839.249 [WetLabsBB2FL](INFO): Powering down
2025-12-17T03:40:40.203Z,1765942840.203 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-12-17T03:40:41.861Z,1765942841.861 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2207
2025-12-17T03:40:42.773Z,1765942842.773 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.11
2025-12-17T03:40:42.774Z,1765942842.774 [Radio_Surface](INFO): Found local IP address 10.89.11.2 for eth0
2025-12-17T03:40:43.926Z,1765942843.926 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-12-17T03:40:44.165Z,1765942844.165 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-12-17T03:40:48.925Z,1765942848.925 [DAT](INFO): DAT read:
2025-12-17T03:40:48.927Z,1765942848.927 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-12-17T03:40:50.690Z,1765942850.690 [DAT](INFO): DAT read: MF Frequency Band
2025-12-17T03:40:50.691Z,1765942850.691 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2025-12-17T03:40:50.691Z,1765942850.691 [DAT](INFO): DAT read: Dec 17 2025 03:40:44
2025-12-17T03:40:51.950Z,1765942851.950 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-12-17T03:40:51.951Z,1765942851.951 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP
2025-12-17T03:40:51.951Z,1765942851.951 [DAT](INFO): commRate: 600
2025-12-17T03:40:54.021Z,1765942854.021 [DAT](INFO): entering command mode
2025-12-17T03:40:54.221Z,1765942854.221 [DAT](INFO): DAT read:
2025-12-17T03:40:54.222Z,1765942854.222 [DAT](INFO): DAT read: user:1>
2025-12-17T03:40:54.222Z,1765942854.222 [DAT](INFO): setting verbose to 3
2025-12-17T03:40:54.473Z,1765942854.473 [DAT](INFO): DAT read: user:1>
2025-12-17T03:40:54.474Z,1765942854.474 [DAT](INFO): DAT read: Verbose | 3
2025-12-17T03:40:54.475Z,1765942854.475 [DAT](INFO): set verbose to 3
2025-12-17T03:40:54.475Z,1765942854.475 [DAT](INFO): setting DatVerbose to 27440
2025-12-17T03:40:54.726Z,1765942854.726 [DAT](INFO): DAT read: user:2>
2025-12-17T03:40:54.726Z,1765942854.726 [DAT](INFO): DAT read: DatVerbose | 27440
2025-12-17T03:40:54.727Z,1765942854.727 [DAT](INFO): set DatVerbose to 27440
2025-12-17T03:40:54.727Z,1765942854.727 [DAT](INFO): setting transmit power to 8
2025-12-17T03:40:54.978Z,1765942854.978 [DAT](INFO): DAT read: user:3>
2025-12-17T03:40:54.979Z,1765942854.979 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-12-17T03:40:54.979Z,1765942854.979 [DAT](INFO): set transmit power to 8
2025-12-17T03:40:54.979Z,1765942854.979 [DAT](INFO): setting local address to 11
2025-12-17T03:40:55.230Z,1765942855.230 [DAT](INFO): DAT read: user:4>
2025-12-17T03:40:55.230Z,1765942855.230 [DAT](INFO): DAT read: LocalAddr | 11
2025-12-17T03:40:55.231Z,1765942855.231 [DAT](INFO): set local address to 11
2025-12-17T03:40:55.232Z,1765942855.232 [DAT](INFO): Setting time to: 3:40:55 And date to:12/17/2025
2025-12-17T03:40:55.481Z,1765942855.481 [DAT](INFO): DAT read: user:5>
2025-12-17T03:40:55.482Z,1765942855.482 [DAT](INFO): DAT read: Wed Dec 17, 2025 03:40:55
2025-12-17T03:40:55.483Z,1765942855.483 [DAT](INFO): Local DAT time set to Wed Dec 17, 2025 03:40:55
2025-12-17T03:41:04.850Z,1765942864.850 [NAL9602](INFO): Powering up NAL9602
2025-12-17T03:41:08.209Z,1765942868.209 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:41:15.762Z,1765942875.762 [NAL9602](INFO): NAL9602 initialized
2025-12-17T03:41:36.772Z,1765942896.772 [NAL9602](INFO): SBD MO Status=0, MOMSN=5887, MT Status=0, MTMSN=0
2025-12-17T03:41:36.772Z,1765942896.772 [NAL9602](INFO): No messages in MT queue
2025-12-17T03:41:39.333Z,1765942899.333 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:41:53.752Z,1765942913.752 [SBIT](IMPORTANT): Beginning Startup BIT
2025-12-17T03:41:53.757Z,1765942913.757 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-12-17T03:41:58.301Z,1765942918.301 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001379
CHAN A1 (24V): 0.000883
CHAN A2 (12V): -0.000678
CHAN A3 (5V): -0.004104
CHAN B0 (3.3V): 0.000549
CHAN B1 (3.15aV): 0.000315
CHAN B2 (3.15bV): -0.000085
CHAN B3 (GND): -0.002458
OPEN: 0.005591
Full Scale: +/- 1 mA
2025-12-17T03:42:10.473Z,1765942930.473 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:42:41.060Z,1765942961.060 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,034240.00,A,3647.11920,N,12153.84003,W,0.719,179.63,171225,,,A*7C
2025-12-17T03:42:41.070Z,1765942961.070 [NAL9602](INFO): GPS fix at 20251217T034240: (36.785320, -121.897334)
2025-12-17T03:42:41.607Z,1765942961.607 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:42:47.946Z,1765942967.946 [SBIT](IMPORTANT): SBIT PASSED
2025-12-17T03:42:47.947Z,1765942967.947 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-12-17T03:42:47.947Z,1765942967.947 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=29 count;
2025-12-17T03:42:47.947Z,1765942967.947 [SBIT](IMPORTANT): BackseatComponent.fullSlateAccess=1 bool;
2025-12-17T03:42:47.947Z,1765942967.947 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): DAT.transponderAddress=8 enum;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): Express linearApproximation DAT.acoustic_contact_range 15.000000 meter;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=-0.1 ampere_hour;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): NAL9602.fastGPSFix=0 bool;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.800000 m/s;
2025-12-17T03:42:47.948Z,1765942967.948 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=463.623538 cubic_centimeter;
2025-12-17T03:42:47.949Z,1765942967.949 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=0.001 reciprocal_second;
2025-12-17T03:42:47.949Z,1765942967.949 [SBIT](IMPORTANT): VerticalControl.massDefault=14.138867 millimeter;
2025-12-17T03:42:48.364Z,1765942968.364 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2025-12-17T03:42:48.365Z,1765942968.365 [DefaultWithUndock] Running Loop=1
2025-12-17T03:42:48.365Z,1765942968.365 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2025-12-17T03:42:48.365Z,1765942968.365 [DefaultWithUndock:A.Wait] Running Loop=1
2025-12-17T03:42:48.365Z,1765942968.365 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-12-17T03:43:12.737Z,1765942992.737 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:43:13.377Z,1765942993.377 [NAL9602](INFO): Powering down
2025-12-17T03:43:18.649Z,1765942998.649 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2025-12-17T03:43:18.649Z,1765942998.649 [DefaultWithUndock:A.Wait] Stopped
2025-12-17T03:43:18.649Z,1765942998.649 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-12-17T03:43:18.649Z,1765942998.649 [DefaultWithUndock:LeaveDock] Running Loop=1
2025-12-17T03:43:18.650Z,1765942998.650 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2025-12-17T03:43:18.650Z,1765942998.650 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2025-12-17T03:43:18.650Z,1765942998.650 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2025-12-17T03:43:18.650Z,1765942998.650 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2025-12-17T03:43:18.650Z,1765942998.650 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-12-17T03:43:18.650Z,1765942998.650 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-12-17T03:43:19.070Z,1765942999.070 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-12-17T03:43:19.070Z,1765942999.070 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-12-17T03:43:19.071Z,1765942999.071 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth 0.256400 m.
2025-12-17T03:43:19.072Z,1765942999.072 [DefaultWithUndock:LeaveDock:A.] Stopped
2025-12-17T03:43:19.072Z,1765942999.072 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact.
2025-12-17T03:43:19.454Z,1765942999.454 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2025-12-17T03:43:19.866Z,1765942999.866 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-12-17T03:43:19.986Z,1765942999.986 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-12-17T03:43:20.390Z,1765943000.390 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004129
2025-12-17T03:43:21.389Z,1765943001.389 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:43:30.397Z,1765943010.397 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:43:39.667Z,1765943019.667 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby.
2025-12-17T03:43:40.052Z,1765943020.052 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby.
2025-12-17T03:43:40.377Z,1765943020.377 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:LeaveDock] Stopped
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1
2025-12-17T03:43:40.503Z,1765943020.503 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-12-17T03:43:40.504Z,1765943020.504 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-12-17T03:43:40.504Z,1765943020.504 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-12-17T03:43:40.509Z,1765943020.509 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-12-17T03:43:40.509Z,1765943020.509 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-12-17T03:43:40.510Z,1765943020.510 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-12-17T03:43:40.510Z,1765943020.510 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-12-17T03:43:40.860Z,1765943020.860 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2025-12-17T03:43:40.877Z,1765943020.877 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-12-17T03:43:40.877Z,1765943020.877 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-12-17T03:43:41.264Z,1765943021.264 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-12-17T03:43:41.666Z,1765943021.666 [NAL9602](INFO): Powering up
2025-12-17T03:43:48.961Z,1765943028.961 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:43:52.566Z,1765943032.566 [NAL9602](INFO): NAL9602 initialized
2025-12-17T03:43:57.721Z,1765943037.721 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:07.905Z,1765943047.905 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:08.335Z,1765943048.335 [NAL9602](INFO): SBD MO Status=0, MOMSN=5888, MT Status=0, MTMSN=0
2025-12-17T03:44:08.335Z,1765943048.335 [NAL9602](INFO): No messages in MT queue
2025-12-17T03:44:16.481Z,1765943056.481 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:17.665Z,1765943057.665 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, , -42.12, +1.62, 20.00, 0.00
2025-12-17T03:44:25.209Z,1765943065.209 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:34.081Z,1765943074.081 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:42.685Z,1765943082.685 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:51.293Z,1765943091.293 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:44:56.820Z,1765943096.820 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,034456.00,A,3647.09293,N,12153.82800,W,0.661,175.39,171225,,,A*77
2025-12-17T03:44:56.822Z,1765943096.822 [NAL9602](INFO): GPS fix at 20251217T034456: (36.784882, -121.897133)
2025-12-17T03:44:56.838Z,1765943096.838 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-12-17T03:44:56.838Z,1765943096.838 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-12-17T03:44:57.249Z,1765943097.249 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-12-17T03:44:58.105Z,1765943098.105 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20251217T004129/Courier0060.lzma
2025-12-17T03:44:58.835Z,1765943098.835 [DataOverHttps](INFO): Moved sent file to Logs/20251217T004129/Courier0060.lzma.bak
2025-12-17T03:44:58.835Z,1765943098.835 [DataOverHttps](INFO): SBD MOMSN=26510832
2025-12-17T03:45:15.269Z,1765943115.269 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20251217T034023/Courier0000.lzma
2025-12-17T03:45:16.271Z,1765943116.271 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Courier0000.lzma.bak
2025-12-17T03:45:16.271Z,1765943116.271 [DataOverHttps](INFO): SBD MOMSN=26510834
2025-12-17T03:45:29.574Z,1765943129.574 [NAL9602](INFO): Powering down
2025-12-17T03:45:32.528Z,1765943132.528 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20251217T004129/Express0061.lzma
2025-12-17T03:45:33.523Z,1765943133.523 [DataOverHttps](INFO): Moved sent file to Logs/20251217T004129/Express0061.lzma.bak
2025-12-17T03:45:33.523Z,1765943133.523 [DataOverHttps](INFO): SBD MOMSN=26510838
2025-12-17T03:45:50.746Z,1765943150.746 [DataOverHttps](INFO): Sending 1319 bytes from file Logs/20251217T034023/Express0001.lzma
2025-12-17T03:45:51.747Z,1765943151.747 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Express0001.lzma.bak
2025-12-17T03:45:51.747Z,1765943151.747 [DataOverHttps](INFO): SBD MOMSN=26510842
2025-12-17T03:45:53.430Z,1765943153.430 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-12-17T03:45:53.430Z,1765943153.430 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-12-17T03:45:53.430Z,1765943153.430 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-12-17T03:46:01.541Z,1765943161.541 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:46:11.149Z,1765943171.149 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:46:19.685Z,1765943179.685 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:46:28.565Z,1765943188.565 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:46:38.293Z,1765943198.293 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:46:46.841Z,1765943206.841 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:46:55.337Z,1765943215.337 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:03.957Z,1765943223.957 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:13.817Z,1765943233.817 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:22.489Z,1765943242.489 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:31.113Z,1765943251.113 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:33.603Z,1765943253.603 [BPC1](ERROR): Battery stick #17 (s/n: 00C9) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4A50.
2025-12-17T03:47:33.604Z,1765943253.604 [BPC1](ERROR): Battery stick #24 (s/n: 011E) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-12-17T03:47:33.604Z,1765943253.604 [BPC1](ERROR): Battery stick #26 (s/n: 0112) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-12-17T03:47:33.605Z,1765943253.605 [BPC1](ERROR): Battery stick #27 (s/n: 00AF) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-12-17T03:47:33.606Z,1765943253.606 [BPC1](ERROR): Battery stick #28 (s/n: 0151) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-12-17T03:47:33.607Z,1765943253.607 [BPC1](ERROR): Battery stick #44 (s/n: 00E4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-12-17T03:47:33.607Z,1765943253.607 [BPC1](ERROR): Battery stick #47 (s/n: 00EC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-12-17T03:47:33.608Z,1765943253.608 [BPC1](ERROR): Battery stick #54 (s/n: 009C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-12-17T03:47:33.613Z,1765943253.613 [BPC1](ERROR): Battery stick #58 (s/n: 00F3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-12-17T03:47:33.613Z,1765943253.613 [BPC1](ERROR): Battery stick #62 (s/n: 0126) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-12-17T03:47:33.614Z,1765943253.614 [BPC1](INFO): Calculating totals. Valid battery stick count: 26. Valid reserve battery stick count: 1.
2025-12-17T03:47:33.637Z,1765943253.637 [BPC1](INFO): Received data from all battery sticks.
2025-12-17T03:47:40.017Z,1765943260.017 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:48.653Z,1765943268.653 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:47:57.177Z,1765943277.177 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:48:08.929Z,1765943288.929 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:48:17.665Z,1765943297.665 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:48:26.233Z,1765943306.233 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:48:34.793Z,1765943314.793 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:48:43.449Z,1765943323.449 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:48:51.941Z,1765943331.941 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:01.601Z,1765943341.601 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:10.245Z,1765943350.245 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:18.769Z,1765943358.769 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:27.485Z,1765943367.485 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:36.077Z,1765943376.077 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:44.597Z,1765943384.597 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:49:53.279Z,1765943393.279 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:01.929Z,1765943401.929 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:10.801Z,1765943410.801 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:19.417Z,1765943419.417 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:27.916Z,1765943427.916 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:36.649Z,1765943436.649 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:45.349Z,1765943445.349 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:53.913Z,1765943453.913 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:50:54.033Z,1765943454.033 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2025-12-17T03:50:54.033Z,1765943454.033 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-12-17T03:50:54.033Z,1765943454.033 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-12-17T03:50:54.033Z,1765943454.033 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2025-12-17T03:50:54.441Z,1765943454.441 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2025-12-17T03:50:54.441Z,1765943454.441 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 8.101266 min
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-12-17T03:50:54.857Z,1765943454.857 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-12-17T03:50:55.638Z,1765943455.638 [NAL9602](INFO): Powering up
2025-12-17T03:51:02.657Z,1765943462.657 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:51:06.542Z,1765943466.542 [NAL9602](INFO): NAL9602 initialized
2025-12-17T03:51:11.393Z,1765943471.393 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:51:42.153Z,1765943502.153 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-12-17T03:51:43.157Z,1765943503.157 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:51:51.737Z,1765943511.737 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:51:55.438Z,1765943515.438 [NAL9602](INFO): SBD MO Status=2, MOMSN=5891, MT Status=2, MTMSN=0
2025-12-17T03:51:55.438Z,1765943515.438 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-12-17T03:52:01.385Z,1765943521.385 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:52:10.442Z,1765943530.442 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:52:18.056Z,1765943538.056 [NAL9602](INFO): SBD MO Status=1, MOMSN=5891, MT Status=0, MTMSN=0
2025-12-17T03:52:18.056Z,1765943538.056 [NAL9602](INFO): No messages in MT queue
2025-12-17T03:52:18.949Z,1765943538.949 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:52:19.263Z,1765943539.263 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,035218.00,A,3646.99731,N,12153.79903,W,1.147,161.23,171225,,,A*75
2025-12-17T03:52:19.266Z,1765943539.266 [NAL9602](INFO): GPS fix at 20251217T035218: (36.783288, -121.896651)
2025-12-17T03:52:19.278Z,1765943539.278 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-12-17T03:52:19.278Z,1765943539.278 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-12-17T03:52:25.620Z,1765943545.620 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20251217T034023/Courier0004.lzma
2025-12-17T03:52:26.622Z,1765943546.622 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Courier0004.lzma.bak
2025-12-17T03:52:26.623Z,1765943546.623 [DataOverHttps](INFO): SBD MOMSN=26510879
2025-12-17T03:52:44.273Z,1765943564.273 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20251217T034023/Express0005.lzma
2025-12-17T03:52:46.279Z,1765943566.279 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Express0005.lzma.bak
2025-12-17T03:52:46.279Z,1765943566.279 [DataOverHttps](INFO): SBD MOMSN=26510888
2025-12-17T03:52:47.981Z,1765943567.981 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-12-17T03:52:47.981Z,1765943567.981 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-12-17T03:52:47.981Z,1765943567.981 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-12-17T03:52:51.582Z,1765943571.582 [NAL9602](INFO): Powering down
2025-12-17T03:52:56.017Z,1765943576.017 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:53:03.499Z,1765943583.499 [DataOverHttps](IMPORTANT): SBD MTMSN=20251217T035302
2025-12-17T03:53:12.313Z,1765943592.313 [DataOverHttps](INFO): Received command: load Transport/keepstation.tl;set keepstation.NeedCommsTime 10 min;set keepstation.Latitude 36.79114 degree;set keepstation.Longitude -121.89915 degree;run
2025-12-17T03:53:12.419Z,1765943592.419 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl
2025-12-17T03:53:12.419Z,1765943592.419 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl
2025-12-17T03:53:12.419Z,1765943592.419 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl
2025-12-17T03:53:12.422Z,1765943592.422 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl
2025-12-17T03:53:13.682Z,1765943593.682 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into:
4
45
NaN
NaN
30
15
4
0.75
200
10
10
45
2
0
0
1
2
3
NaN
0
Sinking to
Timed out while trying to reach target sink depth at current depth of
2025-12-17T03:53:13.692Z,1765943593.692 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h
2025-12-17T03:53:13.695Z,1765943593.695 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min
2025-12-17T03:53:13.698Z,1765943593.698 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg
2025-12-17T03:53:13.701Z,1765943593.701 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg
2025-12-17T03:53:13.704Z,1765943593.704 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m
2025-12-17T03:53:13.727Z,1765943593.727 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m
2025-12-17T03:53:13.745Z,1765943593.745 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m
2025-12-17T03:53:13.748Z,1765943593.748 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s
2025-12-17T03:53:13.759Z,1765943593.759 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m
2025-12-17T03:53:13.763Z,1765943593.763 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool
2025-12-17T03:53:13.779Z,1765943593.779 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m
2025-12-17T03:53:13.783Z,1765943593.783 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min
2025-12-17T03:53:13.822Z,1765943593.822 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m
2025-12-17T03:53:13.841Z,1765943593.841 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km
2025-12-17T03:53:13.853Z,1765943593.853 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count
2025-12-17T03:53:13.856Z,1765943593.856 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count
2025-12-17T03:53:13.871Z,1765943593.871 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count
2025-12-17T03:53:13.882Z,1765943593.882 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count
2025-12-17T03:53:13.894Z,1765943593.894 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count
2025-12-17T03:53:13.903Z,1765943593.903 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool
2025-12-17T03:53:13.903Z,1765943593.903 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-12-17T03:53:13.903Z,1765943593.903 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-12-17T03:53:13.909Z,1765943593.909 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-12-17T03:53:14.317Z,1765943594.317 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:53:14.333Z,1765943594.333 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into:
1
10
20
NaN
1
1500
7
30
0
0
0
0
last time_fix was:
first GPS update timeout
Comms timed out after
minutes
second GPS update timeout
2025-12-17T03:53:14.341Z,1765943594.341 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h
2025-12-17T03:53:14.344Z,1765943594.344 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min
2025-12-17T03:53:14.347Z,1765943594.347 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-12-17T03:53:14.350Z,1765943594.350 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s
2025-12-17T03:53:14.354Z,1765943594.354 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-12-17T03:53:14.396Z,1765943594.396 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1500.000000 s
2025-12-17T03:53:14.403Z,1765943594.403 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min
2025-12-17T03:53:14.410Z,1765943594.410 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min
2025-12-17T03:53:14.424Z,1765943594.424 [MissionManager](INFO): DefineArg keepstation:NeedComms.DoingCommsMode = 0.000000 count
2025-12-17T03:53:14.427Z,1765943594.427 [MissionManager](INFO): DefineArg keepstation:NeedComms.RestoreMode = 0.000000 count
2025-12-17T03:53:14.430Z,1765943594.430 [MissionManager](INFO): DefineOutput keepstation:NeedComms.IsActive = 0 bool
2025-12-17T03:53:14.450Z,1765943594.450 [MissionManager](INFO): DefineOutput keepstation:NeedComms.RequiredDiveMode = 0.000000 count
2025-12-17T03:53:14.462Z,1765943594.462 [keepstation:NeedComms:C.GoToSurface](DEBUG): Construct GoToSurface.
2025-12-17T03:53:14.535Z,1765943594.535 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-12-17T03:53:14.536Z,1765943594.536 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-12-17T03:53:14.537Z,1765943594.537 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-12-17T03:53:14.733Z,1765943594.733 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
1.5
200
2000
2025-12-17T03:53:14.760Z,1765943594.760 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m
2025-12-17T03:53:14.775Z,1765943594.775 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2025-12-17T03:53:14.786Z,1765943594.786 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m
2025-12-17T03:53:14.793Z,1765943594.793 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-12-17T03:53:14.794Z,1765943594.794 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-12-17T03:53:14.815Z,1765943594.815 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-12-17T03:53:14.836Z,1765943594.836 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-12-17T03:53:14.859Z,1765943594.859 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-12-17T03:53:14.859Z,1765943594.859 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-12-17T03:53:14.860Z,1765943594.860 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-12-17T03:53:14.898Z,1765943594.898 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-12-17T03:53:14.903Z,1765943594.903 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool
2025-12-17T03:53:14.914Z,1765943594.914 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-12-17T03:53:14.921Z,1765943594.921 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-12-17T03:53:14.922Z,1765943594.922 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-12-17T03:53:14.923Z,1765943594.923 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-12-17T03:53:15.183Z,1765943595.183 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-12-17T03:53:15.191Z,1765943595.191 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool
2025-12-17T03:53:15.196Z,1765943595.196 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool
2025-12-17T03:53:15.211Z,1765943595.211 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool
2025-12-17T03:53:15.218Z,1765943595.218 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool
2025-12-17T03:53:15.225Z,1765943595.225 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool
2025-12-17T03:53:15.236Z,1765943595.236 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-12-17T03:53:15.242Z,1765943595.242 [keepstation:H.Pitch](DEBUG): Construct.
2025-12-17T03:53:15.323Z,1765943595.323 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2025-12-17T03:53:15.331Z,1765943595.331 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct.
2025-12-17T03:53:15.339Z,1765943595.339 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct.
2025-12-17T03:53:15.368Z,1765943595.368 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-12-17T03:53:15.385Z,1765943595.385 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct.
2025-12-17T03:53:15.391Z,1765943595.391 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct.
2025-12-17T03:53:15.441Z,1765943595.441 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct.
2025-12-17T03:53:15.451Z,1765943595.451 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation.
2025-12-17T03:53:15.479Z,1765943595.479 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-12-17T03:53:15.527Z,1765943595.527 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait.
2025-12-17T03:53:15.559Z,1765943595.559 [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 keepstation {
"""
Vehicle transits to desired waypoint (or stays put if none is commanded)
and stays within the specified radius.
"""
arguments {
MissionTimeout = 4 hour
"""
Maximum duration of mission
"""
NeedCommsTime = 45 minute
"""
How often to surface for communications
"""
Latitude = NaN degree
"""
Latitude of waypoint to hold. If NaN, hold the latitude at start of
mission.
"""
Longitude = NaN degree
"""
Longitude of waypoint to hold. If NaN, hold the longitude at start of
mission.
"""
Depth = 30 meter
"""
Depth held during drift mode
"""
ApproachDepth = 15 meter
"""
Depth for initial approach to station.
"""
DepthDeadband = 4 meter
"""
How much vertical drift from the specified depth is allowed in drift
mode
"""
Speed = 0.75 meter_per_second
"""
Vehicle transit speed.
"""
Radius = 200 meter
"""
Radius of circle around waypoint to hold.
"""
SinkOffSurface = false
"""
If true, use buoyancy only to decend to SinkDepth before driving to first target depth
"""
SinkDepth = 10 meter
"""
Initial depth to decend using only buoyancy before driving
"""
SinkDepthTimeout = 10 minute
"""
Max wait time for the vehicle to reach the target depth
"""
MaxDepth = 45 meter
"""
Maximum allowable depth during the mission.
"""
MinOffshore = 2 kilometer
"""
Minimum distance from the shoreline to maintain
"""
}
output {
DiveMode = 0 count
"""
Mission variable (don't change). The mission sets this variable to
switch between dive modes. Initialized to DoingComms.
"""
DoingComms = 0 count
"""
Mission variable (don't change). The mission will run in this mode
when doing surface comms.
"""
SurfaceSink = 1 count
"""
Mission variable (don't change). The mission will run in this mode
when sinking from the surface using only buoyancy.
"""
TransitToStation = 2 count
"""
Mission variable (don't change). The mission will run in this mode
when performing the transit to station
"""
StationKeep = 3 count
"""
Mission variable (don't change). The mission will run in this mode
when keeping station
"""
OnStation = false
"""
Mission variable (don't change). Determines last mode (Transit or StationKeep)
to resume after needcomms
"""
}
timeout duration=MissionTimeout
insert id="NeedComms" Insert/NeedComms.tl
assign in sequence NeedComms:DiveInterval = NeedCommsTime
insert Insert/StandardEnvelopes.tl
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
insert Insert/BackseatDriver.tl
insert Insert/PowerOnly.tl
behavior Guidance:Pitch {
run in parallel
set massPosition = Control:VerticalControl.massDefault
}
aggregate SurfaceComms {
run when (
called
or ( elapsed ( Universal:time_fix ) > NeedCommsTime )
)
assign in sequence DiveMode = DoingComms
call priorityHere=false refId="NeedComms"
aggregate HandleNan {
run in sequence
break if (
not isNaN ( Latitude )
and not isNaN ( Longitude )
)
# If both lat and lon are nan, we are implicitly on station and should skip initial transit, so force OnStation to true
aggregate SetOnStation {
run in sequence
break if (
not isNaN ( Latitude )
or not isNaN ( Longitude )
)
assign in sequence OnStation = true
}
# The "assigns" here mean we should only ever run these aggregates once
# An initial NaN lat/lon should be set here during the initial surface NeedComms call
# Use the most recent fix -- if there isn't one, the keepstation behavior will use Universal:lat/lon
aggregate SetLat {
run in sequence
break if ( not isNaN ( Latitude ) )
assign in sequence Latitude = Universal:latitude_fix
}
aggregate SetLon {
run in sequence
break if ( not isNaN ( Longitude ) )
assign in sequence Longitude = Universal:longitude_fix
}
}
aggregate setTransit {
run in sequence
break if (
SinkOffSurface
or OnStation
)
assign in sequence DiveMode = TransitToStation
}
aggregate setStation {
run in sequence
break if (
SinkOffSurface
or not OnStation
)
assign in sequence DiveMode = StationKeep
}
aggregate setSink {
run in sequence
break if ( not SinkOffSurface )
assign in sequence DiveMode = SurfaceSink
}
}
call id="StartingMission" priorityHere=false refId="SurfaceComms"
aggregate DiveCmd {
run when ( called )
aggregate SurfaceSink {
run while ( DiveMode == SurfaceSink )
aggregate sink {
run in sequence
behavior Guidance:Buoyancy id="BuoyancyHold" {
run in parallel
set position = NaN cc
}
behavior Guidance:SetSpeed {
run in parallel
set speed = 0 m/s
}
syslog info "Sinking to " + SinkDepth~meter
behavior Guidance:Pitch {
run in sequence
timeout duration=SinkDepthTimeout {
syslog important "Timed out while trying to reach target sink depth at current depth of "
+ Universal:depth~meter
}
set depth = SinkDepth
}
# Once we've sunk, either resume transit or station keeping depths and speeds
aggregate sinkToTransit {
run in sequence
break if ( OnStation )
assign in sequence DiveMode = TransitToStation
}
aggregate sinkToStation {
run in sequence
break if ( not OnStation )
assign in sequence DiveMode = StationKeep
}
}
}
aggregate TransitToStation {
run while ( DiveMode == TransitToStation )
aggregate dive {
run in sequence
behavior Guidance:Buoyancy {
run in parallel
set position = Control:VerticalControl.buoyancyNeutral
}
behavior Guidance:Pitch {
run in parallel
set depth = ApproachDepth
}
behavior Guidance:SetSpeed {
run in parallel
set speed = Speed
}
}
}
aggregate StationKeep {
run while ( DiveMode == StationKeep )
assign in parallel Control:VerticalControl.depthDeadband = DepthDeadband
behavior Guidance:Pitch {
run in parallel
set depth = Depth
}
behavior Guidance:KeepStation {
run in parallel
set latitude = Latitude
set longitude = Longitude
set radius = Radius
set speed = Speed
}
}
}
aggregate TransitToStation {
"""
Need a separate aggregate for transit if we want to specify a
different depth for the approach.
"""
run in sequence
aggregate Dive {
run while ( not ( DiveMode == DoingComms ) )
call priorityHere=false refId="DiveCmd"
}
behavior Guidance:Waypoint id="Wpt1" {
run in sequence
set latitude = Latitude
set longitude = Longitude
}
assign in sequence DiveMode = StationKeep
assign in sequence OnStation = true
}
call id="OnStation" priorityHere=false refId="NeedComms"
aggregate KeepStation {
run in sequence
aggregate Dive {
run while ( not ( DiveMode == DoingComms ) )
call priorityHere=false refId="DiveCmd"
}
behavior Guidance:Wait {
"""
Due to the way the KeepStation behavior is currently
implemented, we must run it in parallel and use a Wait to keep
from completing the mission before the timeout expires. However,
this new version of the mission uses a top-level timeout so that
the entire mission will not run for longer then MissionTimeout.
"""
run in sequence
set duration = MissionTimeout
}
}
}
2025-12-17T03:53:15.560Z,1765943595.560 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation
2025-12-17T03:53:26.761Z,1765943606.761 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:53:28.431Z,1765943608.431 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 10 minute
2025-12-17T03:53:28.432Z,1765943608.432 [CommandExec](IMPORTANT): got command set keepstation.Latitude 36.79114 degree
2025-12-17T03:53:28.433Z,1765943608.433 [CommandExec](IMPORTANT): got command set keepstation.Longitude -121.89915 degree
2025-12-17T03:53:28.434Z,1765943608.434 [CommandExec](IMPORTANT): got command run
2025-12-17T03:53:28.436Z,1765943608.436 [CommandExec](IMPORTANT): Running
2025-12-17T03:53:28.788Z,1765943608.788 [DefaultWithUndock] Stopped
2025-12-17T03:53:28.789Z,1765943608.789 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2025-12-17T03:53:28.789Z,1765943608.789 [DefaultWithUndock:SurfaceDefault] Stopped
2025-12-17T03:53:28.790Z,1765943608.790 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault
2025-12-17T03:53:28.790Z,1765943608.790 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Stopped
2025-12-17T03:53:28.790Z,1765943608.790 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-12-17T03:53:28.790Z,1765943608.790 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2025-12-17T03:53:28.791Z,1765943608.791 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-12-17T03:53:28.791Z,1765943608.791 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2025-12-17T03:53:28.791Z,1765943608.791 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-12-17T03:53:28.791Z,1765943608.791 [MissionManager](IMPORTANT): Started mission keepstation
2025-12-17T03:53:28.792Z,1765943608.792 [keepstation] Running Loop=1
2025-12-17T03:53:28.793Z,1765943608.793 [keepstation](DEBUG): Aggregate::initialize keepstation
2025-12-17T03:53:28.793Z,1765943608.793 [keepstation:StandardEnvelopes] Running Loop=1
2025-12-17T03:53:28.793Z,1765943608.793 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes
2025-12-17T03:53:28.794Z,1765943608.794 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-12-17T03:53:28.794Z,1765943608.794 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-12-17T03:53:28.795Z,1765943608.795 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-12-17T03:53:28.795Z,1765943608.795 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-12-17T03:53:28.796Z,1765943608.796 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-12-17T03:53:28.796Z,1765943608.796 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-12-17T03:53:28.796Z,1765943608.796 [keepstation:BackseatDriver] Running Loop=1
2025-12-17T03:53:28.798Z,1765943608.798 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver
2025-12-17T03:53:28.817Z,1765943608.817 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-12-17T03:53:28.818Z,1765943608.818 [keepstation:PowerOnly] Running Loop=1
2025-12-17T03:53:28.818Z,1765943608.818 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly
2025-12-17T03:53:28.819Z,1765943608.819 [keepstation:PowerOnly:A] Running Loop=1
2025-12-17T03:53:28.819Z,1765943608.819 [keepstation:PowerOnly:B] Running Loop=1
2025-12-17T03:53:28.819Z,1765943608.819 [keepstation:PowerOnly:C] Running Loop=1
2025-12-17T03:53:28.819Z,1765943608.819 [keepstation:PowerOnly:D] Running Loop=1
2025-12-17T03:53:28.820Z,1765943608.820 [keepstation:PowerOnly:E.Wait] Running Loop=1
2025-12-17T03:53:28.820Z,1765943608.820 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-12-17T03:53:28.820Z,1765943608.820 [keepstation:H.Pitch] Running Loop=1
2025-12-17T03:53:28.820Z,1765943608.820 [keepstation:H.Pitch](DEBUG): Initialize.
2025-12-17T03:53:28.822Z,1765943608.822 [keepstation:B] Running Loop=1
2025-12-17T03:53:28.824Z,1765943608.824 [keepstation:H.Pitch] Running Loop=1
2025-12-17T03:53:28.831Z,1765943608.831 [keepstation:PowerOnly] Running Loop=1
2025-12-17T03:53:28.832Z,1765943608.832 [keepstation:PowerOnly:D] Stopped
2025-12-17T03:53:28.832Z,1765943608.832 [keepstation:PowerOnly:C] Stopped
2025-12-17T03:53:28.832Z,1765943608.832 [keepstation:PowerOnly:B] Stopped
2025-12-17T03:53:28.832Z,1765943608.832 [keepstation:PowerOnly:A] Stopped
2025-12-17T03:53:28.837Z,1765943608.837 [keepstation:BackseatDriver] Running Loop=1
2025-12-17T03:53:28.837Z,1765943608.837 [keepstation:StandardEnvelopes] Running Loop=1
2025-12-17T03:53:28.837Z,1765943608.837 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-12-17T03:53:28.838Z,1765943608.838 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-12-17T03:53:28.838Z,1765943608.838 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-12-17T03:53:28.839Z,1765943608.839 [keepstation:B] Stopped
2025-12-17T03:53:28.839Z,1765943608.839 [keepstation:D] Running Loop=1
2025-12-17T03:53:29.190Z,1765943609.190 [keepstation:D] Stopped
2025-12-17T03:53:29.190Z,1765943609.190 [keepstation:E] Running Loop=1
2025-12-17T03:53:29.574Z,1765943609.574 [keepstation:E] Stopped
2025-12-17T03:53:29.574Z,1765943609.574 [keepstation:StartingMission] Running Loop=1
2025-12-17T03:53:29.574Z,1765943609.574 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission
2025-12-17T03:53:29.973Z,1765943609.973 [keepstation:SurfaceComms] Running Loop=1
2025-12-17T03:53:29.973Z,1765943609.973 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-12-17T03:53:29.974Z,1765943609.974 [keepstation:SurfaceComms:A] Running Loop=1
2025-12-17T03:53:29.974Z,1765943609.974 [keepstation:SurfaceComms:A] Stopped
2025-12-17T03:53:29.974Z,1765943609.974 [keepstation:SurfaceComms:B] Running Loop=1
2025-12-17T03:53:29.974Z,1765943609.974 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-12-17T03:53:30.391Z,1765943610.391 [keepstation:NeedComms] Running Loop=1
2025-12-17T03:53:30.391Z,1765943610.391 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-12-17T03:53:30.391Z,1765943610.391 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2025-12-17T03:53:30.391Z,1765943610.391 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-12-17T03:53:30.391Z,1765943610.391 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-12-17T03:53:30.392Z,1765943610.392 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-12-17T03:53:30.392Z,1765943610.392 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-12-17T03:53:30.393Z,1765943610.393 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2025-12-17T03:53:30.393Z,1765943610.393 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-12-17T03:53:30.393Z,1765943610.393 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-12-17T03:53:30.394Z,1765943610.394 [keepstation:NeedComms:A] Running Loop=1
2025-12-17T03:53:30.395Z,1765943610.395 [keepstation:NeedComms:A](INFO): last time_fix was: 1765943538.000000 second since 1970/01/01T00:00:00Z
2025-12-17T03:53:30.395Z,1765943610.395 [keepstation:NeedComms:A] Stopped
2025-12-17T03:53:30.395Z,1765943610.395 [keepstation:NeedComms:setActive] Running Loop=1
2025-12-17T03:53:30.395Z,1765943610.395 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2025-12-17T03:53:30.395Z,1765943610.395 [keepstation:NeedComms:setActive:A] Running Loop=1
2025-12-17T03:53:30.846Z,1765943610.846 [keepstation:NeedComms:setActive:A] Stopped
2025-12-17T03:53:30.846Z,1765943610.846 [keepstation:NeedComms:setActive:B] Running Loop=1
2025-12-17T03:53:31.223Z,1765943611.223 [keepstation:NeedComms:setActive:B] Stopped
2025-12-17T03:53:31.223Z,1765943611.223 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2025-12-17T03:53:31.223Z,1765943611.223 [keepstation:NeedComms:setActive] Stopped
2025-12-17T03:53:31.223Z,1765943611.223 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2025-12-17T03:53:31.607Z,1765943611.607 [keepstation:NeedComms:D] Running Loop=1
2025-12-17T03:53:32.019Z,1765943612.019 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-12-17T03:53:32.386Z,1765943612.386 [NAL9602](INFO): Powering up
2025-12-17T03:53:38.517Z,1765943618.517 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:53:43.298Z,1765943623.298 [NAL9602](INFO): NAL9602 initialized
2025-12-17T03:53:47.033Z,1765943627.033 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:53:55.617Z,1765943635.617 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:54:12.354Z,1765943652.354 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:54:20.491Z,1765943660.491 [NAL9602](INFO): SBD MO Status=2, MOMSN=5892, MT Status=2, MTMSN=0
2025-12-17T03:54:20.491Z,1765943660.491 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-12-17T03:54:22.121Z,1765943662.121 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:54:34.049Z,1765943674.049 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:54:42.657Z,1765943682.657 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:54:53.965Z,1765943693.965 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:55:03.753Z,1765943703.753 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:55:14.581Z,1765943714.581 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:55:40.201Z,1765943740.201 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:55:54.889Z,1765943754.889 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:56:07.637Z,1765943767.637 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:56:20.317Z,1765943780.317 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:56:29.269Z,1765943789.269 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:56:39.065Z,1765943799.065 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:56:49.725Z,1765943809.725 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:56:59.425Z,1765943819.425 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:57:08.577Z,1765943828.577 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:57:17.851Z,1765943837.851 [NAL9602](INFO): SBD MO Status=0, MOMSN=5892, MT Status=0, MTMSN=0
2025-12-17T03:57:17.852Z,1765943837.852 [NAL9602](INFO): No messages in MT queue
2025-12-17T03:57:19.064Z,1765943839.064 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,035718.00,A,3646.93403,N,12153.77550,W,0.836,166.19,171225,,,A*7C
2025-12-17T03:57:19.067Z,1765943839.067 [NAL9602](INFO): GPS fix at 20251217T035718: (36.782234, -121.896258)
2025-12-17T03:57:19.080Z,1765943839.080 [keepstation:NeedComms:D] Stopped
2025-12-17T03:57:19.080Z,1765943839.080 [keepstation:NeedComms:E] Running Loop=1
2025-12-17T03:57:19.500Z,1765943839.500 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-12-17T03:57:32.912Z,1765943852.912 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20251217T034023/Courier0007.lzma
2025-12-17T03:57:34.922Z,1765943854.922 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Courier0007.lzma.bak
2025-12-17T03:57:34.923Z,1765943854.923 [DataOverHttps](INFO): SBD MOMSN=26510894
2025-12-17T03:57:51.382Z,1765943871.382 [NAL9602](INFO): Powering down
2025-12-17T03:58:02.105Z,1765943882.105 [DataOverHttps](INFO): Sending 367 bytes from file Logs/20251217T034023/Express0008.lzma
2025-12-17T03:58:03.110Z,1765943883.110 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Express0008.lzma.bak
2025-12-17T03:58:03.111Z,1765943883.111 [DataOverHttps](INFO): SBD MOMSN=26510898
2025-12-17T03:58:28.501Z,1765943908.501 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20251217T034023/Express0011.lzma
2025-12-17T03:58:29.506Z,1765943909.506 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Express0011.lzma.bak
2025-12-17T03:58:29.507Z,1765943909.507 [DataOverHttps](INFO): SBD MOMSN=26510909
2025-12-17T03:58:31.056Z,1765943911.056 [keepstation:NeedComms:E] Stopped
2025-12-17T03:58:31.056Z,1765943911.056 [keepstation:NeedComms:F] Running Loop=1
2025-12-17T03:58:31.435Z,1765943911.435 [keepstation:NeedComms:F](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-12-17T03:58:31.827Z,1765943911.827 [NAL9602](INFO): Powering up
2025-12-17T03:58:40.301Z,1765943920.301 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:58:42.729Z,1765943922.729 [NAL9602](INFO): NAL9602 initialized
2025-12-17T03:58:56.081Z,1765943936.081 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:59:01.730Z,1765943941.730 [NAL9602](INFO): SBD MO Status=0, MOMSN=5893, MT Status=0, MTMSN=0
2025-12-17T03:59:01.730Z,1765943941.730 [NAL9602](INFO): No messages in MT queue
2025-12-17T03:59:05.953Z,1765943945.953 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:59:15.173Z,1765943955.173 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:59:24.762Z,1765943964.762 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:59:26.806Z,1765943966.806 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,035926.00,A,3646.90746,N,12153.76622,W,0.894,151.50,171225,,,A*78
2025-12-17T03:59:26.808Z,1765943966.808 [NAL9602](INFO): GPS fix at 20251217T035926: (36.781791, -121.896104)
2025-12-17T03:59:26.848Z,1765943966.848 [keepstation:NeedComms:F] Stopped
2025-12-17T03:59:26.849Z,1765943966.849 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2025-12-17T03:59:26.849Z,1765943966.849 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2025-12-17T03:59:26.849Z,1765943966.849 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2025-12-17T03:59:27.214Z,1765943967.214 [keepstation:NeedComms:setRestoreMode:A] Stopped
2025-12-17T03:59:27.214Z,1765943967.214 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2025-12-17T03:59:27.215Z,1765943967.215 [keepstation:NeedComms:setRestoreMode] Stopped
2025-12-17T03:59:27.215Z,1765943967.215 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2025-12-17T03:59:27.215Z,1765943967.215 [keepstation:NeedComms:setInactive] Running Loop=1
2025-12-17T03:59:27.215Z,1765943967.215 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2025-12-17T03:59:27.215Z,1765943967.215 [keepstation:NeedComms:setInactive:A] Running Loop=1
2025-12-17T03:59:27.608Z,1765943967.608 [keepstation:NeedComms:setInactive:A] Stopped
2025-12-17T03:59:27.608Z,1765943967.608 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2025-12-17T03:59:27.608Z,1765943967.608 [keepstation:NeedComms:setInactive] Stopped
2025-12-17T03:59:27.608Z,1765943967.608 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2025-12-17T03:59:27.609Z,1765943967.609 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-12-17T03:59:27.609Z,1765943967.609 [keepstation:NeedComms] Stopped
2025-12-17T03:59:27.609Z,1765943967.609 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-12-17T03:59:27.609Z,1765943967.609 [keepstation:NeedComms:C.GoToSurface] Stopped
2025-12-17T03:59:27.609Z,1765943967.609 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:B] Stopped
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2025-12-17T03:59:28.050Z,1765943968.050 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2025-12-17T03:59:28.051Z,1765943968.051 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2025-12-17T03:59:28.410Z,1765943968.410 [keepstation:SurfaceComms:HandleNan] Stopped
2025-12-17T03:59:28.410Z,1765943968.410 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2025-12-17T03:59:28.411Z,1765943968.411 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2025-12-17T03:59:28.411Z,1765943968.411 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2025-12-17T03:59:28.411Z,1765943968.411 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2025-12-17T03:59:28.411Z,1765943968.411 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-12-17T03:59:28.411Z,1765943968.411 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-12-17T03:59:28.411Z,1765943968.411 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-12-17T03:59:28.823Z,1765943968.823 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-12-17T03:59:28.823Z,1765943968.823 [keepstation:SurfaceComms:setTransit](INFO): Completed keepstation:SurfaceComms:setTransit
2025-12-17T03:59:28.823Z,1765943968.823 [keepstation:SurfaceComms:setTransit] Stopped
2025-12-17T03:59:28.824Z,1765943968.824 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-12-17T03:59:28.824Z,1765943968.824 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-12-17T03:59:28.824Z,1765943968.824 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-12-17T03:59:28.824Z,1765943968.824 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-12-17T03:59:29.227Z,1765943969.227 [keepstation:SurfaceComms:setStation] Stopped
2025-12-17T03:59:29.227Z,1765943969.227 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-12-17T03:59:29.227Z,1765943969.227 [keepstation:SurfaceComms:setStation:A] Stopped
2025-12-17T03:59:29.227Z,1765943969.227 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-12-17T03:59:29.227Z,1765943969.227 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-12-17T03:59:29.228Z,1765943969.228 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-12-17T03:59:29.618Z,1765943969.618 [keepstation:SurfaceComms:setSink] Stopped
2025-12-17T03:59:29.618Z,1765943969.618 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-12-17T03:59:29.618Z,1765943969.618 [keepstation:SurfaceComms:setSink:A] Stopped
2025-12-17T03:59:29.618Z,1765943969.618 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-12-17T03:59:29.618Z,1765943969.618 [keepstation:SurfaceComms] Stopped
2025-12-17T03:59:29.618Z,1765943969.618 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-12-17T03:59:30.076Z,1765943970.076 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission
2025-12-17T03:59:30.076Z,1765943970.076 [keepstation:StartingMission] Stopped
2025-12-17T03:59:30.076Z,1765943970.076 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation] Running Loop=1
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation:Dive] Running Loop=1
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation:Dive:A] Running Loop=1
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1
2025-12-17T03:59:30.081Z,1765943970.081 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-12-17T03:59:30.083Z,1765943970.083 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.791142,-121.899147
2025-12-17T03:59:30.441Z,1765943970.441 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.791142,-121.899147
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:TransitToStation:Dive] Running Loop=1
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd] Running Loop=1
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-12-17T03:59:30.442Z,1765943970.442 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2025-12-17T03:59:30.443Z,1765943970.443 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-12-17T03:59:30.444Z,1765943970.444 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-12-17T03:59:30.449Z,1765943970.449 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-12-17T03:59:30.449Z,1765943970.449 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:StationKeep] Stopped
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-12-17T03:59:30.450Z,1765943970.450 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-12-17T03:59:30.451Z,1765943970.451 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-12-17T03:59:30.451Z,1765943970.451 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-12-17T03:59:30.451Z,1765943970.451 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink] Stopped
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-12-17T03:59:30.452Z,1765943970.452 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-12-17T03:59:30.468Z,1765943970.468 [HorizontalControl](DEBUG): kpHeading = 0.400000
2025-12-17T03:59:30.489Z,1765943970.489 [HorizontalControl](DEBUG): kiHeading = 0.001000
2025-12-17T03:59:30.489Z,1765943970.489 [HorizontalControl](DEBUG): kdHeading = 0.050000
2025-12-17T03:59:42.917Z,1765943982.917 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:59:52.265Z,1765943992.265 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T03:59:59.206Z,1765943999.206 [NAL9602](INFO): Powering down
2025-12-17T04:00:23.389Z,1765944023.389 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:00:49.793Z,1765944049.793 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:01:00.026Z,1765944060.026 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:01:32.029Z,1765944092.029 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:01:59.145Z,1765944119.145 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.126865
2025-12-17T04:02:00.149Z,1765944120.149 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:02:21.097Z,1765944141.097 [Radio_Surface](INFO): Powering down
2025-12-17T04:02:30.273Z,1765944150.273 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:02:31.277Z,1765944151.277 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-12-17T04:02:31.277Z,1765944151.277 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:03:01.413Z,1765944181.413 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:03:02.426Z,1765944182.426 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:03:32.565Z,1765944212.565 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:03:33.569Z,1765944213.569 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:04:03.689Z,1765944243.689 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:04:04.710Z,1765944244.710 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:04:34.829Z,1765944274.829 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:04:35.836Z,1765944275.836 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:05:05.965Z,1765944305.965 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:05:06.969Z,1765944306.969 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:05:37.097Z,1765944337.097 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:05:38.101Z,1765944338.101 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:06:08.221Z,1765944368.221 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:06:09.225Z,1765944369.225 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:06:39.345Z,1765944399.345 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:06:40.349Z,1765944400.349 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:07:10.469Z,1765944430.469 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:07:11.473Z,1765944431.473 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:07:13.780Z,1765944433.780 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00
2025-12-17T04:07:41.593Z,1765944461.593 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:07:42.597Z,1765944462.597 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:08:12.718Z,1765944492.718 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:08:13.721Z,1765944493.721 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:08:43.841Z,1765944523.841 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:08:44.845Z,1765944524.845 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:09:14.965Z,1765944554.965 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:09:15.969Z,1765944555.969 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:09:27.123Z,1765944567.123 [keepstation:SurfaceComms] Running Loop=1
2025-12-17T04:09:27.123Z,1765944567.123 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-12-17T04:09:27.123Z,1765944567.123 [keepstation:SurfaceComms:A] Running Loop=1
2025-12-17T04:09:27.124Z,1765944567.124 [keepstation:SurfaceComms:A] Stopped
2025-12-17T04:09:27.124Z,1765944567.124 [keepstation:SurfaceComms:B] Running Loop=1
2025-12-17T04:09:27.124Z,1765944567.124 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-12-17T04:09:27.126Z,1765944567.126 [keepstation:NeedComms] Running Loop=1
2025-12-17T04:09:27.126Z,1765944567.126 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-12-17T04:09:27.126Z,1765944567.126 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2025-12-17T04:09:27.126Z,1765944567.126 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-12-17T04:09:27.126Z,1765944567.126 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-12-17T04:09:27.127Z,1765944567.127 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-12-17T04:09:27.127Z,1765944567.127 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-12-17T04:09:27.127Z,1765944567.127 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2025-12-17T04:09:27.128Z,1765944567.128 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-12-17T04:09:27.128Z,1765944567.128 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-12-17T04:09:27.128Z,1765944567.128 [keepstation:NeedComms:A] Running Loop=1
2025-12-17T04:09:27.130Z,1765944567.130 [keepstation:NeedComms:A](INFO): last time_fix was: 1765943966.000000 second since 1970/01/01T00:00:00Z
2025-12-17T04:09:27.130Z,1765944567.130 [keepstation:NeedComms:A] Stopped
2025-12-17T04:09:27.130Z,1765944567.130 [keepstation:NeedComms:setActive] Running Loop=1
2025-12-17T04:09:27.131Z,1765944567.131 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2025-12-17T04:09:27.131Z,1765944567.131 [keepstation:NeedComms:setActive:A] Running Loop=1
2025-12-17T04:09:27.506Z,1765944567.506 [keepstation:TransitToStation:Dive] Stopped
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:TransitToStation:Dive:A] Stopped
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:DiveCmd:TransitToStation] Stopped
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2025-12-17T04:09:27.507Z,1765944567.507 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2025-12-17T04:09:27.508Z,1765944567.508 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2025-12-17T04:09:27.508Z,1765944567.508 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-12-17T04:09:27.508Z,1765944567.508 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2025-12-17T04:09:27.508Z,1765944567.508 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2025-12-17T04:09:27.508Z,1765944567.508 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2025-12-17T04:09:27.527Z,1765944567.527 [keepstation:NeedComms:setActive:A] Stopped
2025-12-17T04:09:27.527Z,1765944567.527 [keepstation:NeedComms:setActive:B] Running Loop=1
2025-12-17T04:09:27.966Z,1765944567.966 [keepstation:NeedComms:setActive:B] Stopped
2025-12-17T04:09:27.967Z,1765944567.967 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2025-12-17T04:09:27.967Z,1765944567.967 [keepstation:NeedComms:setActive] Stopped
2025-12-17T04:09:27.967Z,1765944567.967 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2025-12-17T04:09:46.089Z,1765944586.089 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:09:47.093Z,1765944587.093 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:10:17.214Z,1765944617.214 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:10:18.217Z,1765944618.217 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:10:27.743Z,1765944627.743 [keepstation:NeedComms:D] Running Loop=1
2025-12-17T04:10:28.393Z,1765944628.393 [Radio_Surface](INFO): Powering up
2025-12-17T04:10:28.542Z,1765944628.542 [NAL9602](INFO): Powering up
2025-12-17T04:10:33.646Z,1765944633.646 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.11
2025-12-17T04:10:33.646Z,1765944633.647 [Radio_Surface](INFO): Found local IP address 10.89.11.2 for eth0
2025-12-17T04:10:39.446Z,1765944639.446 [NAL9602](INFO): NAL9602 initialized
2025-12-17T04:10:48.353Z,1765944648.353 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:10:49.357Z,1765944649.357 [DataOverHttps](INFO): Radio surface powered ON.
2025-12-17T04:10:49.357Z,1765944649.357 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:11:19.493Z,1765944679.493 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:11:20.497Z,1765944680.497 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:11:48.127Z,1765944708.127 [NAL9602](INFO): SBD MO Status=0, MOMSN=5894, MT Status=0, MTMSN=0
2025-12-17T04:11:48.127Z,1765944708.127 [NAL9602](INFO): No messages in MT queue
2025-12-17T04:11:49.339Z,1765944709.339 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,041148.00,A,3647.02979,N,12153.85221,W,0.991,184.73,171225,,,A*75
2025-12-17T04:11:49.342Z,1765944709.342 [NAL9602](INFO): GPS fix at 20251217T041148: (36.783830, -121.897537)
2025-12-17T04:11:49.354Z,1765944709.354 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.791142,-121.899147
2025-12-17T04:11:49.357Z,1765944709.357 [keepstation:NeedComms:D] Stopped
2025-12-17T04:11:49.357Z,1765944709.357 [keepstation:NeedComms:E] Running Loop=1
2025-12-17T04:11:50.617Z,1765944710.617 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:11:51.621Z,1765944711.621 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:12:13.502Z,1765944733.502 [NAL9602](INFO): SBD MO Status=2, MOMSN=5895, MT Status=2, MTMSN=0
2025-12-17T04:12:13.503Z,1765944733.503 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-12-17T04:12:21.741Z,1765944741.741 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:12:22.745Z,1765944742.745 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:12:35.632Z,1765944755.632 [NAL9602](INFO): SBD MO Status=1, MOMSN=5895, MT Status=0, MTMSN=0
2025-12-17T04:12:35.682Z,1765944755.682 [NAL9602](INFO): Sent 73 bytes from file Logs/20251217T034023/Courier0013.lzma
2025-12-17T04:12:35.682Z,1765944755.682 [NAL9602](INFO): Packets left to send: 0
2025-12-17T04:12:46.791Z,1765944766.791 [NAL9602](INFO): SBD MO Status=2, MOMSN=5896, MT Status=2, MTMSN=0
2025-12-17T04:12:46.791Z,1765944766.791 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-12-17T04:12:52.865Z,1765944772.865 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:12:53.869Z,1765944773.869 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:13:16.139Z,1765944796.139 [NAL9602](INFO): SBD MO Status=2, MOMSN=5896, MT Status=2, MTMSN=0
2025-12-17T04:13:16.139Z,1765944796.139 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-12-17T04:13:25.001Z,1765944805.001 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:13:32.789Z,1765944812.789 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002588
2025-12-17T04:13:35.843Z,1765944815.843 [NAL9602](INFO): SBD MO Status=1, MOMSN=5896, MT Status=0, MTMSN=0
2025-12-17T04:13:35.893Z,1765944815.893 [NAL9602](INFO): Sent 300 bytes from file Logs/20251217T034023/Express0014.lzma
2025-12-17T04:13:35.893Z,1765944815.893 [NAL9602](INFO): Packets left to send: 0
2025-12-17T04:13:40.307Z,1765944820.307 [keepstation:NeedComms:E] Stopped
2025-12-17T04:13:40.307Z,1765944820.307 [keepstation:NeedComms:F] Running Loop=1
2025-12-17T04:13:42.303Z,1765944822.303 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,041341.00,A,3647.00749,N,12153.84730,W,0.525,199.98,171225,,,A*7F
2025-12-17T04:13:42.306Z,1765944822.306 [NAL9602](INFO): GPS fix at 20251217T041341: (36.783458, -121.897455)
2025-12-17T04:13:42.318Z,1765944822.318 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.791142,-121.899147
2025-12-17T04:13:42.321Z,1765944822.321 [keepstation:NeedComms:F] Stopped
2025-12-17T04:13:42.321Z,1765944822.321 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2025-12-17T04:13:42.321Z,1765944822.321 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2025-12-17T04:13:42.321Z,1765944822.321 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2025-12-17T04:13:42.740Z,1765944822.740 [keepstation:NeedComms:setRestoreMode:A] Stopped
2025-12-17T04:13:42.740Z,1765944822.740 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2025-12-17T04:13:42.757Z,1765944822.757 [keepstation:NeedComms:setRestoreMode] Stopped
2025-12-17T04:13:42.757Z,1765944822.757 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2025-12-17T04:13:42.757Z,1765944822.757 [keepstation:NeedComms:setInactive] Running Loop=1
2025-12-17T04:13:42.757Z,1765944822.757 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2025-12-17T04:13:42.757Z,1765944822.757 [keepstation:NeedComms:setInactive:A] Running Loop=1
2025-12-17T04:13:43.124Z,1765944823.124 [keepstation:NeedComms:setInactive:A] Stopped
2025-12-17T04:13:43.124Z,1765944823.124 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2025-12-17T04:13:43.124Z,1765944823.124 [keepstation:NeedComms:setInactive] Stopped
2025-12-17T04:13:43.124Z,1765944823.124 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2025-12-17T04:13:43.125Z,1765944823.125 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-12-17T04:13:43.125Z,1765944823.125 [keepstation:NeedComms] Stopped
2025-12-17T04:13:43.125Z,1765944823.125 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-12-17T04:13:43.125Z,1765944823.125 [keepstation:NeedComms:C.GoToSurface] Stopped
2025-12-17T04:13:43.125Z,1765944823.125 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-12-17T04:13:43.553Z,1765944823.553 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-12-17T04:13:43.553Z,1765944823.553 [keepstation:SurfaceComms:B] Stopped
2025-12-17T04:13:43.553Z,1765944823.553 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-12-17T04:13:43.554Z,1765944823.554 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2025-12-17T04:13:43.554Z,1765944823.554 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2025-12-17T04:13:43.554Z,1765944823.554 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2025-12-17T04:13:43.554Z,1765944823.554 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2025-12-17T04:13:43.554Z,1765944823.554 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2025-12-17T04:13:43.978Z,1765944823.978 [keepstation:SurfaceComms:HandleNan] Stopped
2025-12-17T04:13:43.978Z,1765944823.978 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2025-12-17T04:13:43.978Z,1765944823.978 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2025-12-17T04:13:43.978Z,1765944823.978 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2025-12-17T04:13:43.978Z,1765944823.978 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2025-12-17T04:13:43.978Z,1765944823.978 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-12-17T04:13:43.979Z,1765944823.979 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-12-17T04:13:43.979Z,1765944823.979 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-12-17T04:13:44.346Z,1765944824.346 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-12-17T04:13:44.346Z,1765944824.346 [keepstation:SurfaceComms:setTransit](INFO): Completed keepstation:SurfaceComms:setTransit
2025-12-17T04:13:44.346Z,1765944824.346 [keepstation:SurfaceComms:setTransit] Stopped
2025-12-17T04:13:44.347Z,1765944824.347 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-12-17T04:13:44.347Z,1765944824.347 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-12-17T04:13:44.347Z,1765944824.347 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-12-17T04:13:44.347Z,1765944824.347 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-12-17T04:13:44.751Z,1765944824.751 [keepstation:TransitToStation:Dive] Running Loop=1
2025-12-17T04:13:44.751Z,1765944824.751 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2025-12-17T04:13:44.751Z,1765944824.751 [keepstation:TransitToStation:Dive:A] Running Loop=1
2025-12-17T04:13:44.751Z,1765944824.751 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2025-12-17T04:13:44.751Z,1765944824.751 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-12-17T04:13:44.752Z,1765944824.752 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2025-12-17T04:13:44.758Z,1765944824.758 [keepstation:SurfaceComms:setStation] Stopped
2025-12-17T04:13:44.758Z,1765944824.758 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-12-17T04:13:44.758Z,1765944824.758 [keepstation:SurfaceComms:setStation:A] Stopped
2025-12-17T04:13:44.758Z,1765944824.758 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-12-17T04:13:44.758Z,1765944824.758 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-12-17T04:13:44.758Z,1765944824.758 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-12-17T04:13:45.170Z,1765944825.170 [keepstation:SurfaceComms:setSink] Stopped
2025-12-17T04:13:45.170Z,1765944825.170 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-12-17T04:13:45.170Z,1765944825.170 [keepstation:SurfaceComms:setSink:A] Stopped
2025-12-17T04:13:45.170Z,1765944825.170 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-12-17T04:13:45.171Z,1765944825.171 [keepstation:SurfaceComms] Stopped
2025-12-17T04:13:45.171Z,1765944825.171 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-12-17T04:13:52.341Z,1765944832.341 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:14:02.553Z,1765944842.553 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:14:13.982Z,1765944853.982 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:14:14.674Z,1765944854.674 [NAL9602](INFO): Powering down
2025-12-17T04:14:24.370Z,1765944864.370 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.75 m/s, pitch 20.00 deg, mass-position 14.14 mm (1 active estimators).
2025-12-17T04:14:45.141Z,1765944885.141 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:15:13.253Z,1765944913.253 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.275349
2025-12-17T04:15:14.257Z,1765944914.257 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:15:24.661Z,1765944924.661 [Radio_Surface](INFO): Powering down
2025-12-17T04:15:44.377Z,1765944944.377 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:15:45.381Z,1765944945.381 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-12-17T04:15:45.381Z,1765944945.381 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:16:15.502Z,1765944975.502 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:16:16.505Z,1765944976.505 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:16:46.625Z,1765945006.625 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:16:47.629Z,1765945007.629 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:17:17.749Z,1765945037.749 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:17:18.753Z,1765945038.753 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:17:48.875Z,1765945068.875 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:17:49.878Z,1765945069.878 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:18:19.997Z,1765945099.997 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:18:21.001Z,1765945101.001 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:18:51.142Z,1765945131.142 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:18:52.145Z,1765945132.145 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:19:22.266Z,1765945162.266 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:19:23.269Z,1765945163.269 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:19:53.413Z,1765945193.413 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:19:54.417Z,1765945194.417 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:20:24.537Z,1765945224.537 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:20:25.541Z,1765945225.541 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:20:55.681Z,1765945255.681 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:20:56.685Z,1765945256.685 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:21:26.821Z,1765945286.821 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:21:27.825Z,1765945287.825 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:21:57.945Z,1765945317.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:21:58.949Z,1765945318.949 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:22:29.069Z,1765945349.069 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:22:30.074Z,1765945350.074 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:23:00.193Z,1765945380.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:23:01.197Z,1765945381.197 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:23:31.321Z,1765945411.321 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:23:32.325Z,1765945412.325 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:23:42.377Z,1765945422.377 [keepstation:SurfaceComms] Running Loop=1
2025-12-17T04:23:42.377Z,1765945422.377 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-12-17T04:23:42.378Z,1765945422.378 [keepstation:SurfaceComms:A] Running Loop=1
2025-12-17T04:23:42.380Z,1765945422.380 [keepstation:SurfaceComms:A] Stopped
2025-12-17T04:23:42.381Z,1765945422.381 [keepstation:SurfaceComms:B] Running Loop=1
2025-12-17T04:23:42.381Z,1765945422.381 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-12-17T04:23:42.385Z,1765945422.385 [keepstation:NeedComms] Running Loop=1
2025-12-17T04:23:42.385Z,1765945422.385 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-12-17T04:23:42.386Z,1765945422.386 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2025-12-17T04:23:42.386Z,1765945422.386 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-12-17T04:23:42.386Z,1765945422.386 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-12-17T04:23:42.386Z,1765945422.386 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-12-17T04:23:42.387Z,1765945422.387 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-12-17T04:23:42.387Z,1765945422.387 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2025-12-17T04:23:42.387Z,1765945422.387 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-12-17T04:23:42.388Z,1765945422.388 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-12-17T04:23:42.388Z,1765945422.388 [keepstation:NeedComms:A] Running Loop=1
2025-12-17T04:23:42.390Z,1765945422.390 [keepstation:NeedComms:A](INFO): last time_fix was: 1765944821.000000 second since 1970/01/01T00:00:00Z
2025-12-17T04:23:42.390Z,1765945422.390 [keepstation:NeedComms:A] Stopped
2025-12-17T04:23:42.390Z,1765945422.390 [keepstation:NeedComms:setActive] Running Loop=1
2025-12-17T04:23:42.390Z,1765945422.390 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2025-12-17T04:23:42.390Z,1765945422.390 [keepstation:NeedComms:setActive:A] Running Loop=1
2025-12-17T04:23:42.789Z,1765945422.789 [keepstation:TransitToStation:Dive] Stopped
2025-12-17T04:23:42.789Z,1765945422.789 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2025-12-17T04:23:42.789Z,1765945422.789 [keepstation:TransitToStation:Dive:A] Stopped
2025-12-17T04:23:42.789Z,1765945422.789 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation] Stopped
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2025-12-17T04:23:42.790Z,1765945422.790 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2025-12-17T04:23:42.791Z,1765945422.791 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2025-12-17T04:23:42.794Z,1765945422.794 [keepstation:NeedComms:setActive:A] Stopped
2025-12-17T04:23:42.794Z,1765945422.794 [keepstation:NeedComms:setActive:B] Running Loop=1
2025-12-17T04:23:43.251Z,1765945423.251 [keepstation:NeedComms:setActive:B] Stopped
2025-12-17T04:23:43.252Z,1765945423.252 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2025-12-17T04:23:43.252Z,1765945423.252 [keepstation:NeedComms:setActive] Stopped
2025-12-17T04:23:43.252Z,1765945423.252 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2025-12-17T04:24:02.445Z,1765945442.445 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:24:03.449Z,1765945443.449 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:24:33.587Z,1765945473.587 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:24:34.589Z,1765945474.589 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:24:37.527Z,1765945477.527 [keepstation:NeedComms:D] Running Loop=1
2025-12-17T04:24:38.241Z,1765945478.241 [Radio_Surface](INFO): Powering up
2025-12-17T04:24:38.346Z,1765945478.346 [NAL9602](INFO): Powering up
2025-12-17T04:24:43.493Z,1765945483.493 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.11
2025-12-17T04:24:43.494Z,1765945483.494 [Radio_Surface](INFO): Found local IP address 10.89.11.2 for eth0
2025-12-17T04:24:49.253Z,1765945489.253 [NAL9602](INFO): NAL9602 initialized
2025-12-17T04:25:03.799Z,1765945503.799 [NAL9602](INFO): SBD MO Status=0, MOMSN=5897, MT Status=0, MTMSN=0
2025-12-17T04:25:03.799Z,1765945503.799 [NAL9602](INFO): No messages in MT queue
2025-12-17T04:25:04.729Z,1765945504.729 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:25:05.733Z,1765945505.733 [DataOverHttps](INFO): Radio surface powered ON.
2025-12-17T04:25:05.733Z,1765945505.733 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:25:35.854Z,1765945535.854 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:25:36.857Z,1765945536.857 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:26:03.994Z,1765945563.994 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,042600.00,A,3647.13331,N,12153.90555,W,2.177,171.80,171225,,,A*7F
2025-12-17T04:26:03.996Z,1765945563.996 [NAL9602](INFO): GPS fix at 20251217T042600: (36.785555, -121.898426)
2025-12-17T04:26:04.009Z,1765945564.009 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.791142,-121.899147
2025-12-17T04:26:04.011Z,1765945564.011 [keepstation:NeedComms:D] Stopped
2025-12-17T04:26:04.012Z,1765945564.012 [keepstation:NeedComms:E] Running Loop=1
2025-12-17T04:26:06.989Z,1765945566.989 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:26:07.994Z,1765945567.994 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:26:13.835Z,1765945573.835 [NAL9602](INFO): SBD MO Status=1, MOMSN=5898, MT Status=0, MTMSN=0
2025-12-17T04:26:13.889Z,1765945573.889 [NAL9602](INFO): Sent 74 bytes from file Logs/20251217T034023/Courier0016.lzma
2025-12-17T04:26:13.889Z,1765945573.889 [NAL9602](INFO): Packets left to send: 0
2025-12-17T04:26:23.379Z,1765945583.379 [NAL9602](INFO): SBD MO Status=1, MOMSN=5899, MT Status=0, MTMSN=0
2025-12-17T04:26:23.441Z,1765945583.441 [NAL9602](INFO): Sent 200 bytes from file Logs/20251217T034023/Express0017.lzma
2025-12-17T04:26:23.441Z,1765945583.441 [NAL9602](INFO): Packets left to send: 0
2025-12-17T04:26:31.939Z,1765945591.939 [NAL9602](INFO): SBD MO Status=0, MOMSN=5900, MT Status=0, MTMSN=0
2025-12-17T04:26:32.020Z,1765945592.020 [keepstation:NeedComms:E] Stopped
2025-12-17T04:26:32.020Z,1765945592.020 [keepstation:NeedComms:F] Running Loop=1
2025-12-17T04:26:34.566Z,1765945594.566 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,042630.00,A,3647.13162,N,12153.90326,W,0.369,147.21,171225,,,A*7B
2025-12-17T04:26:34.568Z,1765945594.568 [NAL9602](INFO): GPS fix at 20251217T042630: (36.785527, -121.898388)
2025-12-17T04:26:34.626Z,1765945594.626 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.791142,-121.899147
2025-12-17T04:26:34.633Z,1765945594.633 [keepstation:NeedComms:F] Stopped
2025-12-17T04:26:34.633Z,1765945594.633 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2025-12-17T04:26:34.634Z,1765945594.634 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2025-12-17T04:26:34.634Z,1765945594.634 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setRestoreMode:A] Stopped
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setRestoreMode] Stopped
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setInactive] Running Loop=1
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2025-12-17T04:26:34.943Z,1765945594.943 [keepstation:NeedComms:setInactive:A] Running Loop=1
2025-12-17T04:26:35.355Z,1765945595.355 [keepstation:NeedComms:setInactive:A] Stopped
2025-12-17T04:26:35.355Z,1765945595.355 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2025-12-17T04:26:35.355Z,1765945595.355 [keepstation:NeedComms:setInactive] Stopped
2025-12-17T04:26:35.356Z,1765945595.356 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2025-12-17T04:26:35.356Z,1765945595.356 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-12-17T04:26:35.356Z,1765945595.356 [keepstation:NeedComms] Stopped
2025-12-17T04:26:35.357Z,1765945595.357 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-12-17T04:26:35.357Z,1765945595.357 [keepstation:NeedComms:C.GoToSurface] Stopped
2025-12-17T04:26:35.357Z,1765945595.357 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-12-17T04:26:35.750Z,1765945595.750 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-12-17T04:26:35.750Z,1765945595.750 [keepstation:SurfaceComms:B] Stopped
2025-12-17T04:26:35.751Z,1765945595.751 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-12-17T04:26:35.751Z,1765945595.751 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2025-12-17T04:26:35.751Z,1765945595.751 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2025-12-17T04:26:35.751Z,1765945595.751 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2025-12-17T04:26:35.751Z,1765945595.751 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2025-12-17T04:26:35.751Z,1765945595.751 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:HandleNan] Stopped
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-12-17T04:26:36.150Z,1765945596.150 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-12-17T04:26:36.571Z,1765945596.571 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-12-17T04:26:36.571Z,1765945596.571 [keepstation:SurfaceComms:setTransit](INFO): Completed keepstation:SurfaceComms:setTransit
2025-12-17T04:26:36.571Z,1765945596.571 [keepstation:SurfaceComms:setTransit] Stopped
2025-12-17T04:26:36.571Z,1765945596.571 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-12-17T04:26:36.571Z,1765945596.571 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-12-17T04:26:36.571Z,1765945596.571 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-12-17T04:26:36.572Z,1765945596.572 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-12-17T04:26:36.946Z,1765945596.946 [keepstation:TransitToStation:Dive] Running Loop=1
2025-12-17T04:26:36.946Z,1765945596.946 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2025-12-17T04:26:36.946Z,1765945596.946 [keepstation:TransitToStation:Dive:A] Running Loop=1
2025-12-17T04:26:36.946Z,1765945596.946 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-12-17T04:26:36.947Z,1765945596.947 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2025-12-17T04:26:36.948Z,1765945596.948 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-12-17T04:26:36.948Z,1765945596.948 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2025-12-17T04:26:36.949Z,1765945596.949 [keepstation:SurfaceComms:setStation] Stopped
2025-12-17T04:26:36.949Z,1765945596.949 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-12-17T04:26:36.949Z,1765945596.949 [keepstation:SurfaceComms:setStation:A] Stopped
2025-12-17T04:26:36.949Z,1765945596.949 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-12-17T04:26:36.949Z,1765945596.949 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-12-17T04:26:36.949Z,1765945596.949 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-12-17T04:26:37.355Z,1765945597.355 [keepstation:SurfaceComms:setSink] Stopped
2025-12-17T04:26:37.355Z,1765945597.355 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-12-17T04:26:37.355Z,1765945597.355 [keepstation:SurfaceComms:setSink:A] Stopped
2025-12-17T04:26:37.356Z,1765945597.356 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-12-17T04:26:37.356Z,1765945597.356 [keepstation:SurfaceComms] Stopped
2025-12-17T04:26:37.356Z,1765945597.356 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-12-17T04:26:38.129Z,1765945598.129 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:26:39.133Z,1765945599.133 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:27:06.452Z,1765945626.452 [NAL9602](INFO): Powering down
2025-12-17T04:27:09.261Z,1765945629.261 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:27:10.265Z,1765945630.265 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:27:18.365Z,1765945638.365 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002580
2025-12-17T04:27:19.365Z,1765945639.365 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:27:50.546Z,1765945670.546 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:28:18.657Z,1765945698.657 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.295399
2025-12-17T04:28:19.661Z,1765945699.661 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:28:27.749Z,1765945707.749 [Radio_Surface](INFO): Powering down
2025-12-17T04:28:49.805Z,1765945729.805 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:28:50.810Z,1765945730.810 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-12-17T04:28:50.810Z,1765945730.810 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:29:20.949Z,1765945760.949 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:29:21.953Z,1765945761.953 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:29:52.073Z,1765945792.073 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:29:53.077Z,1765945793.077 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:30:23.229Z,1765945823.229 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:30:24.233Z,1765945824.233 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:30:54.373Z,1765945854.373 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:30:55.377Z,1765945855.377 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:31:25.501Z,1765945885.501 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:31:26.505Z,1765945886.505 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:31:56.625Z,1765945916.625 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:31:57.629Z,1765945917.629 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:32:27.749Z,1765945947.749 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:32:28.753Z,1765945948.753 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:32:58.873Z,1765945978.873 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:32:59.878Z,1765945979.878 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:33:29.999Z,1765946009.999 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:33:31.001Z,1765946011.001 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:34:01.121Z,1765946041.121 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:34:02.126Z,1765946042.126 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:34:32.281Z,1765946072.281 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:34:33.285Z,1765946073.285 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:35:03.417Z,1765946103.417 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:35:04.421Z,1765946104.421 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:35:34.541Z,1765946134.541 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:35:35.545Z,1765946135.545 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:36:05.665Z,1765946165.665 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:36:06.669Z,1765946166.669 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:36:34.971Z,1765946194.971 [keepstation:SurfaceComms] Running Loop=1
2025-12-17T04:36:34.971Z,1765946194.971 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-12-17T04:36:34.972Z,1765946194.972 [keepstation:SurfaceComms:A] Running Loop=1
2025-12-17T04:36:34.972Z,1765946194.972 [keepstation:SurfaceComms:A] Stopped
2025-12-17T04:36:34.972Z,1765946194.972 [keepstation:SurfaceComms:B] Running Loop=1
2025-12-17T04:36:34.972Z,1765946194.972 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-12-17T04:36:34.978Z,1765946194.978 [keepstation:NeedComms] Running Loop=1
2025-12-17T04:36:34.978Z,1765946194.978 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-12-17T04:36:34.978Z,1765946194.978 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2025-12-17T04:36:34.978Z,1765946194.978 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-12-17T04:36:34.979Z,1765946194.979 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-12-17T04:36:34.979Z,1765946194.979 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-12-17T04:36:34.979Z,1765946194.979 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-12-17T04:36:34.980Z,1765946194.980 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2025-12-17T04:36:34.980Z,1765946194.980 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-12-17T04:36:34.980Z,1765946194.980 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-12-17T04:36:34.985Z,1765946194.985 [keepstation:NeedComms:A] Running Loop=1
2025-12-17T04:36:34.986Z,1765946194.986 [keepstation:NeedComms:A](INFO): last time_fix was: 1765945590.000000 second since 1970/01/01T00:00:00Z
2025-12-17T04:36:34.986Z,1765946194.986 [keepstation:NeedComms:A] Stopped
2025-12-17T04:36:34.986Z,1765946194.986 [keepstation:NeedComms:setActive] Running Loop=1
2025-12-17T04:36:34.986Z,1765946194.986 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2025-12-17T04:36:34.987Z,1765946194.987 [keepstation:NeedComms:setActive:A] Running Loop=1
2025-12-17T04:36:35.334Z,1765946195.334 [keepstation:TransitToStation:Dive] Stopped
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:TransitToStation:Dive:A] Stopped
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:DiveCmd:TransitToStation] Stopped
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2025-12-17T04:36:35.335Z,1765946195.335 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2025-12-17T04:36:35.336Z,1765946195.336 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2025-12-17T04:36:35.336Z,1765946195.336 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-12-17T04:36:35.336Z,1765946195.336 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2025-12-17T04:36:35.336Z,1765946195.336 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2025-12-17T04:36:35.336Z,1765946195.336 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2025-12-17T04:36:35.339Z,1765946195.339 [keepstation:NeedComms:setActive:A] Stopped
2025-12-17T04:36:35.339Z,1765946195.339 [keepstation:NeedComms:setActive:B] Running Loop=1
2025-12-17T04:36:35.745Z,1765946195.745 [keepstation:NeedComms:setActive:B] Stopped
2025-12-17T04:36:35.745Z,1765946195.745 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2025-12-17T04:36:35.746Z,1765946195.746 [keepstation:NeedComms:setActive] Stopped
2025-12-17T04:36:35.746Z,1765946195.746 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2025-12-17T04:36:36.789Z,1765946196.789 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:36:37.794Z,1765946197.794 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:37:07.929Z,1765946227.929 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:37:08.933Z,1765946228.933 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:37:26.586Z,1765946246.586 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00062308263128,35.0, +13.6, 0.0,15
2025-12-17T04:37:32.665Z,1765946252.665 [keepstation:NeedComms:D] Running Loop=1
2025-12-17T04:37:33.290Z,1765946253.290 [Radio_Surface](INFO): Powering up
2025-12-17T04:37:33.458Z,1765946253.458 [NAL9602](INFO): Powering up
2025-12-17T04:37:38.541Z,1765946258.541 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.11
2025-12-17T04:37:38.541Z,1765946258.541 [Radio_Surface](INFO): Found local IP address 10.89.11.2 for eth0
2025-12-17T04:37:39.053Z,1765946259.053 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:37:40.057Z,1765946260.057 [DataOverHttps](INFO): Radio surface powered ON.
2025-12-17T04:37:40.057Z,1765946260.057 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:37:44.367Z,1765946264.367 [NAL9602](INFO): NAL9602 initialized
2025-12-17T04:38:10.177Z,1765946290.177 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:38:11.181Z,1765946291.181 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:38:41.301Z,1765946321.301 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:38:42.305Z,1765946322.305 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:39:12.425Z,1765946352.425 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:39:13.429Z,1765946353.429 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:39:43.549Z,1765946383.549 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-12-17T04:39:44.553Z,1765946384.553 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:40:12.492Z,1765946412.492 [DataOverHttps](IMPORTANT): SBD MTMSN=20251217T044011
2025-12-17T04:40:12.495Z,1765946412.495 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002969
2025-12-17T04:40:20.724Z,1765946420.724 [DataOverHttps](INFO): Received command: stop
2025-12-17T04:40:20.745Z,1765946420.745 [CommandExec](IMPORTANT): got command stop
2025-12-17T04:40:20.746Z,1765946420.746 [CommandExec](IMPORTANT): Scheduling is paused
2025-12-17T04:40:20.746Z,1765946420.746 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-12-17T04:40:20.762Z,1765946420.762 [MissionManager](INFO): MissionManager is completed.
2025-12-17T04:40:20.762Z,1765946420.762 [MissionManager](INFO): Uninitializing Mission keepstation
2025-12-17T04:40:20.762Z,1765946420.762 [keepstation] Stopped
2025-12-17T04:40:20.762Z,1765946420.762 [keepstation](DEBUG): Aggregate::uninitialize keepstation
2025-12-17T04:40:20.762Z,1765946420.762 [keepstation:NeedComms] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:NeedComms:C.GoToSurface] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:NeedComms:D] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-12-17T04:40:20.763Z,1765946420.763 [keepstation:BackseatDriver] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:BackseatDriver:A.BackseatDriver] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:PowerOnly] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:PowerOnly:E.Wait] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:H.Pitch] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:SurfaceComms] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:SurfaceComms:B] Stopped
2025-12-17T04:40:20.764Z,1765946420.764 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-12-17T04:40:20.773Z,1765946420.773 [keepstation:DiveCmd] Stopped
2025-12-17T04:40:20.773Z,1765946420.773 [keepstation:DiveCmd](DEBUG): Aggregate::uninitialize keepstation:DiveCmd
2025-12-17T04:40:20.773Z,1765946420.773 [keepstation:TransitToStation] Stopped
2025-12-17T04:40:20.773Z,1765946420.773 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation
2025-12-17T04:40:20.773Z,1765946420.773 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped
2025-12-17T04:40:20.773Z,1765946420.773 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-12-17T04:40:21.156Z,1765946421.156 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2025-12-17T04:40:21.156Z,1765946421.156 [DefaultWithUndock] Running Loop=1
2025-12-17T04:40:21.156Z,1765946421.156 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2025-12-17T04:40:21.157Z,1765946421.157 [DefaultWithUndock:A.Wait] Running Loop=1
2025-12-17T04:40:21.157Z,1765946421.157 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-12-17T04:40:22.729Z,1765946422.729 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:40:31.589Z,1765946431.589 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:40:40.169Z,1765946440.169 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:40:44.167Z,1765946444.167 [NAL9602](INFO): SBD MO Status=2, MOMSN=5901, MT Status=2, MTMSN=0
2025-12-17T04:40:44.167Z,1765946444.167 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-12-17T04:40:48.905Z,1765946448.905 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:A.Wait] Stopped
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:LeaveDock] Running Loop=1
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2025-12-17T04:40:51.522Z,1765946451.522 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2025-12-17T04:40:51.523Z,1765946451.523 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-12-17T04:40:51.523Z,1765946451.523 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-12-17T04:40:51.889Z,1765946451.889 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-12-17T04:40:51.889Z,1765946451.889 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-12-17T04:40:51.890Z,1765946451.890 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth 0.207130 m.
2025-12-17T04:40:51.891Z,1765946451.891 [DefaultWithUndock:LeaveDock:A.] Stopped
2025-12-17T04:40:51.891Z,1765946451.891 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact.
2025-12-17T04:40:52.278Z,1765946452.278 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2025-12-17T04:40:52.691Z,1765946452.691 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-12-17T04:40:52.810Z,1765946452.810 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-12-17T04:40:55.075Z,1765946455.075 [NAL9602](INFO): SBD MO Status=0, MOMSN=5901, MT Status=0, MTMSN=0
2025-12-17T04:40:55.075Z,1765946455.075 [NAL9602](INFO): No messages in MT queue
2025-12-17T04:40:57.625Z,1765946457.625 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:41:06.441Z,1765946466.441 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:41:12.466Z,1765946472.466 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: nan m. Transitioning docking module to standby.
2025-12-17T04:41:12.876Z,1765946472.876 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Docking module at standby.
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:LeaveDock] Stopped
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2025-12-17T04:41:13.269Z,1765946473.269 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2025-12-17T04:41:13.270Z,1765946473.270 [DefaultWithUndock:SurfaceDefault:A.GoToSurface] Running Loop=1
2025-12-17T04:41:13.270Z,1765946473.270 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-12-17T04:41:13.270Z,1765946473.270 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-12-17T04:41:13.271Z,1765946473.271 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-12-17T04:41:13.272Z,1765946473.272 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-12-17T04:41:13.274Z,1765946473.274 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-12-17T04:41:13.275Z,1765946473.275 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-12-17T04:41:13.276Z,1765946473.276 [DefaultWithUndock:SurfaceDefault:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-12-17T04:41:13.688Z,1765946473.688 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2025-12-17T04:41:13.688Z,1765946473.688 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2025-12-17T04:41:13.688Z,1765946473.688 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2025-12-17T04:41:15.373Z,1765946475.373 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:41:15.684Z,1765946475.684 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,044114.00,A,3647.22562,N,12153.91371,W,1.108,160.14,171225,,,D*7B
2025-12-17T04:41:15.687Z,1765946475.687 [NAL9602](INFO): GPS fix at 20251217T044114: (36.787094, -121.898562)
2025-12-17T04:41:15.717Z,1765946475.717 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2025-12-17T04:41:15.717Z,1765946475.717 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2025-12-17T04:41:22.160Z,1765946482.160 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20251217T034023/Courier0019.lzma
2025-12-17T04:41:23.163Z,1765946483.163 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Courier0019.lzma.bak
2025-12-17T04:41:23.163Z,1765946483.163 [DataOverHttps](INFO): SBD MOMSN=26511154
2025-12-17T04:41:39.997Z,1765946499.997 [DataOverHttps](INFO): Sending 352 bytes from file Logs/20251217T034023/Express0020.lzma
2025-12-17T04:41:40.999Z,1765946500.999 [DataOverHttps](INFO): Moved sent file to Logs/20251217T034023/Express0020.lzma.bak
2025-12-17T04:41:40.999Z,1765946500.999 [DataOverHttps](INFO): SBD MOMSN=26511158
2025-12-17T04:41:42.761Z,1765946502.761 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2025-12-17T04:41:42.761Z,1765946502.761 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2025-12-17T04:41:42.761Z,1765946502.761 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-12-17T04:41:47.598Z,1765946507.598 [NAL9602](INFO): Powering down
2025-12-17T04:41:50.573Z,1765946510.573 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:41:59.145Z,1765946519.145 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:42:10.037Z,1765946530.037 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:42:18.673Z,1765946538.673 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:42:27.313Z,1765946547.313 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:42:36.169Z,1765946556.169 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-12-17T04:42:43.906Z,1765946563.906 [DataOverHttps](IMPORTANT): SBD MTMSN=20251217T044242
2025-12-17T04:42:51.738Z,1765946571.738 [DataOverHttps](INFO): Received command: schedule resume;restart logs