2025-03-14T01:08:08.565Z,1741914488.565 [Supervisor](DEBUG): Initializing supervisor.
2025-03-14T01:08:08.570Z,1741914488.570 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-03-14T01:08:08.570Z,1741914488.570 [SyncHandler](INFO): Protected caller Thread ID is 1170
2025-03-14T01:08:08.571Z,1741914488.571 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-03-14T01:08:08.572Z,1741914488.572 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-03-14T01:08:08.572Z,1741914488.572 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1171
2025-03-14T01:08:08.576Z,1741914488.576 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-03-14T01:08:08.596Z,1741914488.596 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-03-14T01:08:08.596Z,1741914488.596 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-03-14T01:08:08.597Z,1741914488.597 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1172
2025-03-14T01:08:08.601Z,1741914488.601 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-03-14T01:08:08.602Z,1741914488.602 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-03-14T01:08:08.603Z,1741914488.603 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1173
2025-03-14T01:08:08.605Z,1741914488.605 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-03-14T01:08:08.606Z,1741914488.606 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-03-14T01:08:08.606Z,1741914488.606 [logger ThreadHandler](INFO): Protected caller Thread ID is 1174
2025-03-14T01:08:08.610Z,1741914488.610 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-03-14T01:08:08.610Z,1741914488.610 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-03-14T01:08:08.612Z,1741914488.612 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-03-14T01:08:08.847Z,1741914488.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-03-14T01:08:08.848Z,1741914488.848 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-03-14T01:08:08.969Z,1741914488.969 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-03-14T01:08:08.970Z,1741914488.970 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-03-14T01:08:09.078Z,1741914489.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-03-14T01:08:09.079Z,1741914489.079 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-03-14T01:08:09.614Z,1741914489.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-03-14T01:08:09.614Z,1741914489.614 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-03-14T01:08:09.999Z,1741914489.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-03-14T01:08:09.000Z,1741914490.000 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-03-14T01:08:10.384Z,1741914490.384 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-03-14T01:08:10.385Z,1741914490.385 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-03-14T01:08:10.602Z,1741914490.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-03-14T01:08:10.603Z,1741914490.603 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-03-14T01:08:10.694Z,1741914490.694 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-03-14T01:08:10.787Z,1741914490.787 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-03-14T01:08:11.241Z,1741914491.241 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-03-14T01:08:11.242Z,1741914491.242 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-03-14T01:08:11.562Z,1741914491.562 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-03-14T01:08:11.562Z,1741914491.562 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-03-14T01:08:12.201Z,1741914492.201 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-03-14T01:08:12.202Z,1741914492.202 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-03-14T01:08:12.543Z,1741914492.543 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-03-14T01:08:12.543Z,1741914492.543 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-03-14T01:08:12.825Z,1741914492.825 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-03-14T01:08:12.826Z,1741914492.826 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-03-14T01:08:13.128Z,1741914493.128 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-03-14T01:08:13.128Z,1741914493.128 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-03-14T01:08:14.373Z,1741914494.373 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-03-14T01:08:14.375Z,1741914494.375 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2025-03-14T01:08:14.376Z,1741914494.376 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2025-03-14T01:08:14.472Z,1741914494.472 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2025-03-14T01:08:14.619Z,1741914494.619 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2025-03-14T01:08:14.908Z,1741914494.908 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-03-14T01:08:14.908Z,1741914494.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2025-03-14T01:08:15.053Z,1741914495.053 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2025-03-14T01:08:15.166Z,1741914495.166 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2025-03-14T01:08:15.275Z,1741914495.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2025-03-14T01:08:15.402Z,1741914495.402 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2025-03-14T01:08:15.500Z,1741914495.500 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2025-03-14T01:08:15.600Z,1741914495.600 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2025-03-14T01:08:15.706Z,1741914495.706 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2025-03-14T01:08:15.902Z,1741914495.902 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2025-03-14T01:08:15.903Z,1741914495.903 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-03-14T01:08:15.914Z,1741914495.914 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-03-14T01:08:15.972Z,1741914495.972 [DepthRateCalculator] Loaded
2025-03-14T01:08:15.972Z,1741914495.972 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-03-14T01:08:15.978Z,1741914495.978 [PitchRateCalculator] Loaded
2025-03-14T01:08:15.978Z,1741914495.978 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-03-14T01:08:15.989Z,1741914495.989 [SpeedCalculator] Loaded
2025-03-14T01:08:15.989Z,1741914495.989 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-03-14T01:08:15.995Z,1741914495.995 [YawRateCalculator] Loaded
2025-03-14T01:08:15.995Z,1741914495.995 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-03-14T01:08:16.017Z,1741914496.017 [ElevatorOffsetCalculator] Loaded
2025-03-14T01:08:16.018Z,1741914496.018 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-03-14T01:08:16.018Z,1741914496.018 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-03-14T01:08:16.019Z,1741914496.019 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-03-14T01:08:16.050Z,1741914496.050 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-03-14T01:08:16.051Z,1741914496.051 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-03-14T01:08:16.062Z,1741914496.062 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-03-14T01:08:16.062Z,1741914496.062 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-03-14T01:08:16.620Z,1741914496.620 [AHRS_M2] Loaded
2025-03-14T01:08:16.620Z,1741914496.620 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-03-14T01:08:16.660Z,1741914496.660 [BackseatComponent] Loaded
2025-03-14T01:08:16.660Z,1741914496.660 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-03-14T01:08:16.661Z,1741914496.661 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0
2025-03-14T01:08:16.662Z,1741914496.662 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1256
2025-03-14T01:08:16.664Z,1741914496.664 [LcmUniversalReporter] Loaded
2025-03-14T01:08:16.665Z,1741914496.665 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-03-14T01:08:17.489Z,1741914497.489 [BPC1] Loaded
2025-03-14T01:08:17.489Z,1741914497.489 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-03-14T01:08:17.588Z,1741914497.588 [DAT] Loaded
2025-03-14T01:08:17.588Z,1741914497.588 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-03-14T01:08:17.589Z,1741914497.589 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0
2025-03-14T01:08:17.589Z,1741914497.589 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1257
2025-03-14T01:08:17.664Z,1741914497.664 [DataOverHttps] Loaded
2025-03-14T01:08:17.664Z,1741914497.664 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-03-14T01:08:17.665Z,1741914497.665 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0
2025-03-14T01:08:17.666Z,1741914497.666 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1258
2025-03-14T01:08:17.689Z,1741914497.689 [Depth_Keller] Loaded
2025-03-14T01:08:17.689Z,1741914497.689 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-03-14T01:08:17.694Z,1741914497.694 [DropWeight] Loaded
2025-03-14T01:08:17.695Z,1741914497.695 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-03-14T01:08:17.717Z,1741914497.717 [MultiRay](INFO): Running on single LCB
2025-03-14T01:08:17.717Z,1741914497.717 [MultiRay] Loaded
2025-03-14T01:08:17.717Z,1741914497.717 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2025-03-14T01:08:17.784Z,1741914497.784 [NAL9602] Loaded
2025-03-14T01:08:17.784Z,1741914497.784 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-03-14T01:08:17.814Z,1741914497.814 [Onboard] Loaded
2025-03-14T01:08:17.815Z,1741914497.815 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-03-14T01:08:17.816Z,1741914497.816 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0
2025-03-14T01:08:17.816Z,1741914497.816 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1259
2025-03-14T01:08:17.822Z,1741914497.822 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2025-03-14T01:08:17.836Z,1741914497.836 [PowerOnly] Loaded
2025-03-14T01:08:17.836Z,1741914497.836 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2025-03-14T01:08:17.851Z,1741914497.851 [Power24vConverter] Loaded
2025-03-14T01:08:17.851Z,1741914497.851 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-03-14T01:08:17.869Z,1741914497.869 [Radio_Surface] Loaded
2025-03-14T01:08:17.869Z,1741914497.869 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-03-14T01:08:17.870Z,1741914497.870 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0
2025-03-14T01:08:17.870Z,1741914497.870 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1260
2025-03-14T01:08:17.896Z,1741914497.896 [Waterlinked] Loaded
2025-03-14T01:08:17.897Z,1741914497.897 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2025-03-14T01:08:17.897Z,1741914497.897 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-03-14T01:08:17.897Z,1741914497.897 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-03-14T01:08:18.440Z,1741914498.440 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-03-14T01:08:18.440Z,1741914498.440 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-03-14T01:08:18.494Z,1741914498.494 [NavChart] Loaded
2025-03-14T01:08:18.494Z,1741914498.494 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-03-14T01:08:18.500Z,1741914498.500 [UniversalFixResidualReporter] Loaded
2025-03-14T01:08:18.500Z,1741914498.500 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-03-14T01:08:18.500Z,1741914498.500 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-03-14T01:08:18.517Z,1741914498.517 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-03-14T01:08:18.768Z,1741914498.768 [SBIT](DEBUG): Construct Startup Built In Test.
2025-03-14T01:08:18.782Z,1741914498.782 [SBIT] Loaded
2025-03-14T01:08:18.783Z,1741914498.783 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-03-14T01:08:18.786Z,1741914498.786 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-03-14T01:08:18.799Z,1741914498.799 [IBIT] Loaded
2025-03-14T01:08:18.799Z,1741914498.799 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-03-14T01:08:18.805Z,1741914498.805 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-03-14T01:08:18.887Z,1741914498.887 [CBIT] Loaded
2025-03-14T01:08:18.888Z,1741914498.888 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-03-14T01:08:18.920Z,1741914498.920 [GFScanner] Loaded
2025-03-14T01:08:18.921Z,1741914498.921 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-03-14T01:08:18.921Z,1741914498.921 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-03-14T01:08:18.922Z,1741914498.922 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-03-14T01:08:19.105Z,1741914499.105 [CTD_Seabird] Loaded
2025-03-14T01:08:19.105Z,1741914499.105 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-03-14T01:08:19.106Z,1741914499.106 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0
2025-03-14T01:08:19.107Z,1741914499.107 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1261
2025-03-14T01:08:19.130Z,1741914499.130 [PAR_Licor] Loaded
2025-03-14T01:08:19.130Z,1741914499.130 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-03-14T01:08:19.178Z,1741914499.178 [WetLabsBB2FL] Loaded
2025-03-14T01:08:19.179Z,1741914499.179 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-03-14T01:08:19.180Z,1741914499.180 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0
2025-03-14T01:08:19.180Z,1741914499.180 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1262
2025-03-14T01:08:19.181Z,1741914499.181 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-03-14T01:08:19.181Z,1741914499.181 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-03-14T01:08:19.337Z,1741914499.337 [BuoyancyServo] Loaded
2025-03-14T01:08:19.337Z,1741914499.337 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-03-14T01:08:19.362Z,1741914499.362 [ElevatorServo] Loaded
2025-03-14T01:08:19.362Z,1741914499.362 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-03-14T01:08:19.386Z,1741914499.386 [MassServo] Loaded
2025-03-14T01:08:19.387Z,1741914499.387 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-03-14T01:08:19.410Z,1741914499.410 [RudderServo] Loaded
2025-03-14T01:08:19.410Z,1741914499.410 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-03-14T01:08:19.429Z,1741914499.429 [ThrusterHE] Loaded
2025-03-14T01:08:19.430Z,1741914499.430 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-03-14T01:08:19.430Z,1741914499.430 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-03-14T01:08:19.431Z,1741914499.431 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-03-14T01:08:19.492Z,1741914499.492 [VerticalControl](DEBUG): Construct VerticalControl.
2025-03-14T01:08:19.546Z,1741914499.546 [VerticalControl] Loaded
2025-03-14T01:08:19.547Z,1741914499.547 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-03-14T01:08:19.550Z,1741914499.550 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-03-14T01:08:19.596Z,1741914499.596 [HorizontalControl] Loaded
2025-03-14T01:08:19.596Z,1741914499.596 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-03-14T01:08:19.599Z,1741914499.599 [SpeedControl](DEBUG): Construct SpeedControl.
2025-03-14T01:08:19.600Z,1741914499.600 [SpeedControl] Loaded
2025-03-14T01:08:19.601Z,1741914499.601 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-03-14T01:08:19.604Z,1741914499.604 [LoopControl](DEBUG): Construct LoopControl.
2025-03-14T01:08:19.604Z,1741914499.604 [LoopControl] Loaded
2025-03-14T01:08:19.604Z,1741914499.604 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-03-14T01:08:19.605Z,1741914499.605 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-03-14T01:08:19.605Z,1741914499.605 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-03-14T01:08:19.759Z,1741914499.759 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-03-14T01:08:19.760Z,1741914499.760 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-03-14T01:08:19.966Z,1741914499.966 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-03-14T01:08:19.967Z,1741914499.967 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-03-14T01:08:20.372Z,1741914500.372 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-03-14T01:08:20.372Z,1741914500.372 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-03-14T01:08:20.439Z,1741914500.439 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-03-14T01:08:20.445Z,1741914500.445 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-03-14T01:08:20.448Z,1741914500.448 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-03-14T01:08:20.460Z,1741914500.460 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-03-14T01:08:20.461Z,1741914500.461 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0
2025-03-14T01:08:20.461Z,1741914500.461 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1263
2025-03-14T01:08:20.466Z,1741914500.466 [Supervisor](INFO): Main Thread ID is 829
2025-03-14T01:08:20.466Z,1741914500.466 [Supervisor](DEBUG): Running supervisor.
2025-03-14T01:08:20.466Z,1741914500.466 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1264
2025-03-14T01:08:20.467Z,1741914500.467 [CommandExec](INFO): Initializing the command executive.
2025-03-14T01:08:20.468Z,1741914500.468 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1265
2025-03-14T01:08:20.471Z,1741914500.471 [controlThread ThreadHandler](INFO): Handler Thread ID is 1266
2025-03-14T01:08:20.472Z,1741914500.472 [controlThread](DEBUG): Initializing ControlThread
2025-03-14T01:08:20.473Z,1741914500.473 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-03-14T01:08:20.473Z,1741914500.473 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-03-14T01:08:20.473Z,1741914500.473 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-03-14T01:08:20.474Z,1741914500.474 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-03-14T01:08:20.474Z,1741914500.474 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-03-14T01:08:20.480Z,1741914500.480 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-03-14T01:08:20.480Z,1741914500.480 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-03-14T01:08:20.480Z,1741914500.480 [SBIT](INFO): Initialize SBIT Component.
2025-03-14T01:08:20.481Z,1741914500.481 [SBIT](IMPORTANT): git: 2025-03-12_C
2025-03-14T01:08:20.481Z,1741914500.481 [SBIT](INFO): git hash: c930cdb2e5c1f1ff3673ee566a0d82f2333fbba8
2025-03-14T01:08:20.481Z,1741914500.481 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-03-14T01:08:20.483Z,1741914500.483 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2025-03-14T01:08:20.484Z,1741914500.484 [SBIT](INFO): Beginning SBIT in 47.000000 seconds.
2025-03-14T01:08:20.484Z,1741914500.484 [IBIT](INFO): Initialize IBIT Component.
2025-03-14T01:08:20.485Z,1741914500.485 [CBIT](DEBUG): Initialize CBIT Component.
2025-03-14T01:08:20.486Z,1741914500.486 [logger ThreadHandler](INFO): Handler Thread ID is 1267
2025-03-14T01:08:20.497Z,1741914500.497 [CBIT](DEBUG): Initialized mux pins.
2025-03-14T01:08:20.497Z,1741914500.497 [CBIT](DEBUG): Initializing the watchdog timer.
2025-03-14T01:08:20.505Z,1741914500.505 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1268
2025-03-14T01:08:20.517Z,1741914500.517 [DAT ThreadHandler](INFO): Handler Thread ID is 1269
2025-03-14T01:08:20.518Z,1741914500.518 [DAT](INFO): Powering up
2025-03-14T01:08:20.518Z,1741914500.518 [DAT](DEBUG): Initializing DAT.
2025-03-14T01:08:20.521Z,1741914500.521 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-03-14T01:08:20.521Z,1741914500.521 [CBIT](DEBUG): Initializing heartbeat.
2025-03-14T01:08:20.523Z,1741914500.523 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1271
2025-03-14T01:08:20.525Z,1741914500.525 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-03-14T01:08:20.534Z,1741914500.534 [Onboard ThreadHandler](INFO): Handler Thread ID is 1272
2025-03-14T01:08:20.551Z,1741914500.551 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1273
2025-03-14T01:08:20.570Z,1741914500.570 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1274
2025-03-14T01:08:20.570Z,1741914500.570 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-03-14T01:08:20.574Z,1741914500.574 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1276
2025-03-14T01:08:20.578Z,1741914500.578 [WetLabsBB2FL](INFO): Powering up
2025-03-14T01:08:20.579Z,1741914500.579 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1278
2025-03-14T01:08:20.582Z,1741914500.582 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-03-14T01:08:20.582Z,1741914500.582 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-03-14T01:08:20.582Z,1741914500.582 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-03-14T01:08:20.582Z,1741914500.582 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-03-14T01:08:20.582Z,1741914500.582 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-03-14T01:08:20.583Z,1741914500.583 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-03-14T01:08:20.583Z,1741914500.583 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-03-14T01:08:20.583Z,1741914500.583 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-03-14T01:08:20.593Z,1741914500.593 [CBIT](DEBUG): Deactivating emergency mode.
2025-03-14T01:08:20.633Z,1741914500.633 [CBIT](DEBUG): Backplane powered.
2025-03-14T01:08:20.633Z,1741914500.633 [GFScanner](DEBUG): Initializing GFScanner
2025-03-14T01:08:20.633Z,1741914500.633 [GFScanner](DEBUG): Deactivating GF circuits.
2025-03-14T01:08:20.642Z,1741914500.642 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-03-14T01:08:20.644Z,1741914500.644 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-03-14T01:08:20.645Z,1741914500.645 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-03-14T01:08:20.645Z,1741914500.645 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-03-14T01:08:20.646Z,1741914500.646 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-03-14T01:08:20.647Z,1741914500.647 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-03-14T01:08:20.647Z,1741914500.647 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-03-14T01:08:20.648Z,1741914500.648 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-03-14T01:08:20.707Z,1741914500.707 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Startup">
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="StartupSatComms">
        <Sequence />
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix />
        </ReadDatum>
        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications />
        </ReadDatum>
    </Aggregate>
</Mission>

2025-03-14T01:08:20.727Z,1741914500.727 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-14T01:08:20.751Z,1741914500.751 [MissionManager](DEBUG): 
#   Copyright (c) 2024 MBARI
#   MBARI Proprietary Information. Confidential. All Rights Reserved
#   Unauthorized copying or distribution of this file via any medium is strictly
#   prohibited.
#
#   WARNING - This file contains information whose export is restricted by the
#   Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
#   amended. Violations of these export laws are subject to severe civil and/or
#   criminal penalties.

mission Startup {
  behavior Guidance:GoToSurface {
    run in progression
  }

  aggregate StartupSatComms {
    run in sequence

    readDatum {
      timeout duration=P1M

      Universal:latitude_fix
    }

    readDatum {
      timeout duration=P1M

      Universal:platform_communications
    }
  }
}


2025-03-14T01:08:20.752Z,1741914500.752 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-03-14T01:08:20.752Z,1741914500.752 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-03-14T01:08:20.753Z,1741914500.753 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-03-14T01:08:20.957Z,1741914500.957 [Radio_Surface](INFO): Powering up
2025-03-14T01:08:20.981Z,1741914500.981 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="Default">
    <DefineArg Name="ElapsedSinceDefaultStarted">
        <Units:minute />
        <Value>0</Value>
    </DefineArg>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:second />
            <Value>13</Value>
        </Setting>
    </Guidance:Wait>
    <Guidance:GoToSurface>
        <Progression />
    </Guidance:GoToSurface>
    <Aggregate Id="CheckIn">
        <Sequence Repeat="288" />
        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M" />
            <Universal:time_fix />
        </ReadDatum>
        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence />
                    <Setting>
                        <Guidance:Execute.command />
                        <String>Burn on</String>
                    </Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications />
        </ReadDatum>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Units:minute />
                <Value>5</Value>
            </Setting>
        </Guidance:Wait>
        <Assign>
            <Sequence />
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Elapsed>
                <Universal:mission_started />
            </Elapsed>
        </Assign>
        <Syslog Severity="Important">
            Default mission has been running for 
            <Arg Name="ElapsedSinceDefaultStarted" />
            <Units:minute />
        </Syslog>
    </Aggregate>
    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>
    <Guidance:Execute>
        <Sequence />
        <Setting>
            <Guidance:Execute.command />
            <String>restart logs</String>
        </Setting>
    </Guidance:Execute>
</Mission>

2025-03-14T01:08:20.987Z,1741914500.987 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-03-14T01:08:20.988Z,1741914500.988 [Default:A.Wait](DEBUG): Construct Wait.
2025-03-14T01:08:20.991Z,1741914500.991 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-14T01:08:21.015Z,1741914501.015 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-03-14T01:08:21.018Z,1741914501.018 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-03-14T01:08:21.036Z,1741914501.036 [Default:E.Execute](DEBUG): Construct Execute.
2025-03-14T01:08:21.039Z,1741914501.039 [MissionManager](DEBUG): 
#   Copyright (c) 2024 MBARI
#   MBARI Proprietary Information. Confidential. All Rights Reserved
#   Unauthorized copying or distribution of this file via any medium is strictly
#   prohibited.
#
#   WARNING - This file contains information whose export is restricted by the
#   Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
#   amended. Violations of these export laws are subject to severe civil and/or
#   criminal penalties.

mission Default {
  arguments {
    ElapsedSinceDefaultStarted = 0 minute
  }

  behavior Guidance:Wait {
    """
    Wait a moment to see if the scheduler starts a new mission before
    starting to actually run Default.
    """

    run in sequence

    set duration = 13 second
  }

  behavior Guidance:GoToSurface {
    run in progression
  }

  aggregate CheckIn {
    run in sequence repeat=288

    readDatum id="Read_GPS" {
      timeout duration=P5M

      Universal:time_fix
    }

    readDatum id="Read_Iridium" {
      timeout duration=P4H {
        behavior Guidance:Execute {
          run in sequence

          set command = "Burn on"
        }

        syslog critical "Dropped weight due to communications timeout."
      }

      Universal:platform_communications
    }

    behavior Guidance:Wait {
      run in sequence

      set duration = 5 minute
    }

    assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )

    syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
  }

  syslog important "Restarting logs and Default mission."

  behavior Guidance:Execute {
    run in sequence

    set command = "restart logs"
  }
}


2025-03-14T01:08:21.044Z,1741914501.044 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-03-14T01:08:21.061Z,1741914501.061 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-03-14T01:08:21.116Z,1741914501.116 [MultiRay](INFO): Powering up MultiRay Lights
2025-03-14T01:08:21.130Z,1741914501.130 [Power24vConverter](INFO): Powering up.
2025-03-14T01:08:21.194Z,1741914501.194 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-03-14T01:08:21.201Z,1741914501.201 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-03-14T01:08:21.202Z,1741914501.202 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-03-14T01:08:21.209Z,1741914501.209 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-03-14T01:08:21.210Z,1741914501.210 [MassServo](DEBUG): Initializing EZServoServo.
2025-03-14T01:08:21.229Z,1741914501.229 [MassServo](DEBUG): Initializing MassServo.
2025-03-14T01:08:21.230Z,1741914501.230 [RudderServo](DEBUG): Initializing EZServoServo.
2025-03-14T01:08:21.237Z,1741914501.237 [RudderServo](DEBUG): Initializing RudderServo.
2025-03-14T01:08:21.238Z,1741914501.238 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-03-14T01:08:21.245Z,1741914501.245 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-03-14T01:08:23.193Z,1741914503.193 [WetLabsBB2FL](INFO): Powering down
2025-03-14T01:08:26.914Z,1741914506.914 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-03-14T01:08:27.601Z,1741914507.601 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-03-14T01:08:32.122Z,1741914512.122 [DAT](INFO): DAT read: 

2025-03-14T01:08:32.123Z,1741914512.123 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2025-03-14T01:08:33.634Z,1741914513.634 [DAT](INFO): DAT read: MF Frequency Band

2025-03-14T01:08:33.635Z,1741914513.635 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2025-03-14T01:08:33.636Z,1741914513.636 [DAT](INFO): DAT read: Mar 14 2025 01:08:28 

2025-03-14T01:08:34.642Z,1741914514.642 [DAT](INFO): DAT read: Features enabled [Bearing]

2025-03-14T01:08:34.643Z,1741914514.643 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2025-03-14T01:08:34.644Z,1741914514.644 [DAT](INFO): commRate: 800
2025-03-14T01:08:36.709Z,1741914516.709 [DAT](INFO): entering command mode
2025-03-14T01:08:36.909Z,1741914516.909 [DAT](INFO): DAT read: 

2025-03-14T01:08:36.910Z,1741914516.910 [DAT](INFO): DAT read: user:1>

2025-03-14T01:08:36.910Z,1741914516.910 [DAT](INFO): setting verbose to 3
2025-03-14T01:08:37.162Z,1741914517.162 [DAT](INFO): DAT read: user:1>

2025-03-14T01:08:37.163Z,1741914517.163 [DAT](INFO): DAT read: Verbose         | 3           

2025-03-14T01:08:37.163Z,1741914517.163 [DAT](INFO): set verbose to 3
2025-03-14T01:08:37.163Z,1741914517.163 [DAT](INFO): setting DatVerbose to 27440
2025-03-14T01:08:37.414Z,1741914517.414 [DAT](INFO): DAT read: user:2>

2025-03-14T01:08:37.415Z,1741914517.415 [DAT](INFO): DAT read: DatVerbose      | 27440       

2025-03-14T01:08:37.415Z,1741914517.415 [DAT](INFO): set DatVerbose to 27440
2025-03-14T01:08:37.415Z,1741914517.415 [DAT](INFO): setting transmit power to 8
2025-03-14T01:08:37.666Z,1741914517.666 [DAT](INFO): DAT read: user:3>

2025-03-14T01:08:37.667Z,1741914517.667 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2025-03-14T01:08:37.667Z,1741914517.667 [DAT](INFO): set transmit power to 8
2025-03-14T01:08:37.667Z,1741914517.667 [DAT](INFO): setting local address to 9
2025-03-14T01:08:37.919Z,1741914517.919 [DAT](INFO): DAT read: user:4>

2025-03-14T01:08:37.920Z,1741914517.920 [DAT](INFO): DAT read: LocalAddr       | 9           

2025-03-14T01:08:37.920Z,1741914517.920 [DAT](INFO): set local address to 9
2025-03-14T01:08:37.921Z,1741914517.921 [DAT](INFO): Setting time to: 1:8:37 And date to:3/14/2025
2025-03-14T01:08:38.170Z,1741914518.170 [DAT](INFO): DAT read: user:5>

2025-03-14T01:08:38.171Z,1741914518.171 [DAT](INFO): DAT read: Fri Mar 14, 2025  01:08:37  

2025-03-14T01:08:38.171Z,1741914518.171 [DAT](INFO): Local DAT time set to Fri Mar 14, 2025  01:08:37  

2025-03-14T01:08:48.127Z,1741914528.127 [NAL9602](INFO): Powering up NAL9602
2025-03-14T01:08:58.321Z,1741914538.321 [Waterlinked](INFO): Powering down
2025-03-14T01:08:59.035Z,1741914539.035 [NAL9602](INFO): NAL9602 initialized
2025-03-14T01:09:07.969Z,1741914547.969 [SBIT](IMPORTANT): Beginning Startup BIT
2025-03-14T01:09:07.973Z,1741914547.973 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-03-14T01:09:12.446Z,1741914552.446 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.005773
CHAN A1 (24V): 0.001058
CHAN A2 (12V): -0.005808
CHAN A3 (5V): -0.003172
CHAN B0 (3.3V): -0.000946
CHAN B1 (3.15aV): -0.001108
CHAN B2 (3.15bV): -0.000838
CHAN B3 (GND): -0.000147
OPEN: 0.005974
Full Scale: +/- 1 mA
2025-03-14T01:09:26.524Z,1741914566.524 [NAL9602](INFO): SBD MO Status=0, MOMSN=18670, MT Status=0, MTMSN=0
2025-03-14T01:09:26.524Z,1741914566.524 [NAL9602](INFO): No messages in MT queue
2025-03-14T01:10:02.114Z,1741914602.114 [SBIT](IMPORTANT): SBIT PASSED
2025-03-14T01:10:02.115Z,1741914602.115 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-03-14T01:10:02.115Z,1741914602.115 [SBIT](IMPORTANT): BuoyancyServo.limitLo=490 count;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool;

2025-03-14T01:10:02.116Z,1741914602.116 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool;

2025-03-14T01:10:02.117Z,1741914602.117 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=373.087254 cubic_centimeter;

2025-03-14T01:10:02.117Z,1741914602.117 [SBIT](IMPORTANT): VerticalControl.massDefault=6.846363 millimeter;

2025-03-14T01:10:02.535Z,1741914602.535 [MissionManager](IMPORTANT): Started mission Startup
2025-03-14T01:10:02.535Z,1741914602.535 [Startup] Running Loop=1
2025-03-14T01:10:02.535Z,1741914602.535 [Startup](DEBUG): Aggregate::initialize Startup
2025-03-14T01:10:02.536Z,1741914602.536 [Startup:A.GoToSurface] Running Loop=1
2025-03-14T01:10:02.536Z,1741914602.536 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-14T01:10:02.536Z,1741914602.536 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-14T01:10:02.537Z,1741914602.537 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-14T01:10:02.537Z,1741914602.537 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-14T01:10:02.538Z,1741914602.538 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-14T01:10:02.538Z,1741914602.538 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-14T01:10:02.538Z,1741914602.538 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-14T01:10:02.540Z,1741914602.540 [Startup:StartupSatComms] Running Loop=1
2025-03-14T01:10:02.540Z,1741914602.540 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-03-14T01:10:02.540Z,1741914602.540 [Startup:StartupSatComms:A] Running Loop=1
2025-03-14T01:10:02.942Z,1741914602.942 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-03-14T01:11:02.723Z,1741914662.723 [Startup:StartupSatComms:A](INFO): Timed out from 2025-03-14T01:10:02.5Z
2025-03-14T01:11:02.723Z,1741914662.723 [Startup:StartupSatComms:A] Stopped
2025-03-14T01:11:02.724Z,1741914662.724 [Startup:StartupSatComms:B] Running Loop=1
2025-03-14T01:11:03.128Z,1741914663.128 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-14T01:11:20.523Z,1741914680.523 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-03-14T01:11:20.523Z,1741914680.523 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-14T01:11:20.534Z,1741914680.534 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-14T01:11:20.951Z,1741914680.951 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-14T01:11:20.951Z,1741914680.951 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-03-14T01:11:29.013Z,1741914689.013 [NAL9602](INFO): SBD MO Status=2, MOMSN=18671, MT Status=2, MTMSN=0
2025-03-14T01:11:29.013Z,1741914689.013 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-03-14T01:11:40.364Z,1741914700.364 [NAL9602](INFO): SBD MO Status=1, MOMSN=18671, MT Status=0, MTMSN=0
2025-03-14T01:11:40.413Z,1741914700.413 [NAL9602](INFO): Sent 96 bytes from file Logs/20250314T004312/Courier0007.lzma
2025-03-14T01:11:40.413Z,1741914700.413 [NAL9602](INFO): Packets left to send: 0
2025-03-14T01:11:44.763Z,1741914704.763 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005011
2025-03-14T01:11:48.904Z,1741914708.904 [NAL9602](INFO): SBD MO Status=1, MOMSN=18672, MT Status=0, MTMSN=0
2025-03-14T01:11:48.961Z,1741914708.961 [NAL9602](INFO): Sent 151 bytes from file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:11:48.961Z,1741914708.961 [NAL9602](INFO): Packets left to send: 0
2025-03-14T01:11:49.035Z,1741914709.035 [Startup:StartupSatComms:B] Stopped
2025-03-14T01:11:49.035Z,1741914709.035 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-03-14T01:11:49.035Z,1741914709.035 [Startup:StartupSatComms] Stopped
2025-03-14T01:11:49.035Z,1741914709.035 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-03-14T01:11:49.036Z,1741914709.036 [Startup](INFO): Completed Startup
2025-03-14T01:11:49.036Z,1741914709.036 [MissionManager](INFO): Startup is completed.
2025-03-14T01:11:49.037Z,1741914709.037 [MissionManager](INFO): Uninitializing Mission Startup
2025-03-14T01:11:49.049Z,1741914709.049 [Startup] Stopped
2025-03-14T01:11:49.049Z,1741914709.049 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-03-14T01:11:49.049Z,1741914709.049 [Startup:A.GoToSurface] Stopped
2025-03-14T01:11:49.049Z,1741914709.049 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-14T01:11:49.343Z,1741914709.343 [MissionManager](IMPORTANT): Started mission Default
2025-03-14T01:11:49.343Z,1741914709.343 [Default] Running Loop=1
2025-03-14T01:11:49.343Z,1741914709.343 [Default](DEBUG): Aggregate::initialize Default
2025-03-14T01:11:49.344Z,1741914709.344 [Default:B.GoToSurface] Running Loop=1
2025-03-14T01:11:49.344Z,1741914709.344 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-14T01:11:49.344Z,1741914709.344 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-14T01:11:49.344Z,1741914709.344 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-14T01:11:49.344Z,1741914709.344 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-14T01:11:49.357Z,1741914709.357 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-14T01:11:49.357Z,1741914709.357 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-14T01:11:49.358Z,1741914709.358 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-14T01:11:49.358Z,1741914709.358 [Default:A.Wait] Running Loop=1
2025-03-14T01:11:49.358Z,1741914709.358 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-03-14T01:11:57.075Z,1741914717.075 [DataOverHttps](IMPORTANT): Could not stat file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:11:57.075Z,1741914717.075 [DataOverHttps](FAULT): Could not open file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:12:02.700Z,1741914722.700 [Default:A.Wait](INFO): Done Waiting.
2025-03-14T01:12:02.700Z,1741914722.700 [Default:A.Wait] Stopped
2025-03-14T01:12:02.700Z,1741914722.700 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-03-14T01:12:03.115Z,1741914723.115 [Default:CheckIn] Running Loop=1
2025-03-14T01:12:03.115Z,1741914723.115 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-14T01:12:03.115Z,1741914723.115 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-14T01:12:03.525Z,1741914723.525 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-03-14T01:12:06.627Z,1741914726.627 [DataOverHttps](IMPORTANT): Could not stat file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:12:06.627Z,1741914726.627 [DataOverHttps](FAULT): Could not open file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:12:44.035Z,1741914764.035 [DataOverHttps](IMPORTANT): Could not stat file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:12:44.035Z,1741914764.035 [DataOverHttps](FAULT): Could not open file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:13:16.527Z,1741914796.527 [DataOverHttps](IMPORTANT): Could not stat file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:13:16.527Z,1741914796.527 [DataOverHttps](FAULT): Could not open file Logs/20250314T010808/Courier0000.lzma
2025-03-14T01:13:19.853Z,1741914799.853 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011318.00,A,3647.36758,N,12150.13343,W,1.458,93.67,140325,,,A*4C
2025-03-14T01:13:19.856Z,1741914799.856 [NAL9602](INFO): GPS fix at 20250314T011318: (36.789460, -121.835557)
2025-03-14T01:13:19.867Z,1741914799.867 [Default:CheckIn:Read_GPS] Stopped
2025-03-14T01:13:19.867Z,1741914799.867 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-03-14T01:13:20.297Z,1741914800.297 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-14T01:13:27.098Z,1741914807.098 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20250314T010808/Courier0004.lzma
2025-03-14T01:13:29.103Z,1741914809.103 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Courier0004.lzma.bak
2025-03-14T01:13:29.103Z,1741914809.103 [DataOverHttps](INFO): SBD MOMSN=24226517
2025-03-14T01:13:50.919Z,1741914830.919 [DataOverHttps](INFO): Sending 821 bytes from file Logs/20250313T185332/Express0104.lzma
2025-03-14T01:13:52.506Z,1741914832.506 [NAL9602](INFO): Not Powering down - fast GPS
2025-03-14T01:13:52.924Z,1741914832.924 [DataOverHttps](INFO): Moved sent file to Logs/20250313T185332/Express0104.lzma.bak
2025-03-14T01:13:52.924Z,1741914832.924 [DataOverHttps](INFO): SBD MOMSN=24226520
2025-03-14T01:14:13.999Z,1741914853.999 [DataOverHttps](INFO): Sending 1154 bytes from file Logs/20250314T004312/Express0001.lzma
2025-03-14T01:14:14.999Z,1741914854.999 [DataOverHttps](INFO): Moved sent file to Logs/20250314T004312/Express0001.lzma.bak
2025-03-14T01:14:14.999Z,1741914854.999 [DataOverHttps](INFO): SBD MOMSN=24226682
2025-03-14T01:14:31.026Z,1741914871.026 [DataOverHttps](INFO): Sending 431 bytes from file Logs/20250314T004312/Express0005.lzma
2025-03-14T01:14:33.031Z,1741914873.031 [DataOverHttps](INFO): Moved sent file to Logs/20250314T004312/Express0005.lzma.bak
2025-03-14T01:14:33.031Z,1741914873.031 [DataOverHttps](INFO): SBD MOMSN=24226733
2025-03-14T01:14:49.155Z,1741914889.155 [DataOverHttps](INFO): Sending 1483 bytes from file Logs/20250314T004312/Express0008.lzma
2025-03-14T01:14:50.151Z,1741914890.151 [DataOverHttps](INFO): Moved sent file to Logs/20250314T004312/Express0008.lzma.bak
2025-03-14T01:14:50.151Z,1741914890.151 [DataOverHttps](INFO): SBD MOMSN=24226779
2025-03-14T01:15:09.046Z,1741914909.046 [DataOverHttps](INFO): Sending 888 bytes from file Logs/20250314T010808/Express0001.lzma
2025-03-14T01:15:10.047Z,1741914910.047 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Express0001.lzma.bak
2025-03-14T01:15:10.047Z,1741914910.047 [DataOverHttps](INFO): SBD MOMSN=24226890
2025-03-14T01:15:38.881Z,1741914938.881 [DataOverHttps](INFO): Sending 422 bytes from file Logs/20250314T010808/Express0005.lzma
2025-03-14T01:15:43.903Z,1741914943.903 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Express0005.lzma.bak
2025-03-14T01:15:43.903Z,1741914943.903 [DataOverHttps](INFO): SBD MOMSN=24226913
2025-03-14T01:15:45.389Z,1741914945.389 [Default:CheckIn:Read_Iridium] Stopped
2025-03-14T01:15:45.389Z,1741914945.389 [Default:CheckIn:C.Wait] Running Loop=1
2025-03-14T01:15:45.389Z,1741914945.389 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-03-14T01:16:29.871Z,1741914989.871 [DataOverHttps](IMPORTANT): SBD MTMSN=20250314T011627
2025-03-14T01:16:38.361Z,1741914998.361 [DataOverHttps](INFO): Received command: load Transport/transit.tl;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;run
2025-03-14T01:16:38.416Z,1741914998.416 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2025-03-14T01:16:38.421Z,1741914998.421 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2025-03-14T01:16:38.421Z,1741914998.421 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/transit.tl
2025-03-14T01:16:38.424Z,1741914998.424 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/transit.tl
2025-03-14T01:16:39.098Z,1741914999.098 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/transit.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="transit">
    <DefineArg Name="MissionTimeout">
        <Units:minute />
        <Value>60</Value>
    </DefineArg>
    <DefineArg Name="NeedCommsTime">
        <Units:minute />
        <Value>30</Value>
    </DefineArg>
    <DefineArg Name="Latitude">
        <Units:degree />
        <Value>NaN</Value>
    </DefineArg>
    <DefineArg Name="Longitude">
        <Units:degree />
        <Value>NaN</Value>
    </DefineArg>
    <DefineArg Name="Northings">
        <Units:meter />
        <Value>0</Value>
    </DefineArg>
    <DefineArg Name="Eastings">
        <Units:meter />
        <Value>0</Value>
    </DefineArg>
    <DefineArg Name="Depth">
        <Units:meter />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="Speed">
        <Units:meter_per_second />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="MaxDepth">
        <Units:meter />
        <Value>20</Value>
    </DefineArg>
    <DefineArg Name="MinOffshore">
        <Units:kilometer />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="MinAltitude">
        <Units:meter />
        <Value>7</Value>
    </DefineArg>
    <DefineArg Name="MassHold">
        <True />
    </DefineArg>
    <DefineArg Name="BuoyancyHold">
        <True />
    </DefineArg>
    <Timeout Duration="MissionTimeout" />
    <Insert Id="NeedComms" Filename="Insert/NeedComms.tl" />
    <Assign>
        <Sequence />
        <Arg Name="NeedComms:DiveInterval" />
        <Arg Name="NeedCommsTime" />
    </Assign>
    <Assign>
        <Sequence />
        <Arg Name="NeedComms:WaitForPitchUp" />
        <Units:second />
        <Value>1</Value>
    </Assign>
    <Insert Filename="Insert/StandardEnvelopes.tl" />
    <Assign>
        <Sequence />
        <Arg Name="StandardEnvelopes:MinAltitude" />
        <Arg Name="MinAltitude" />
    </Assign>
    <Assign>
        <Sequence />
        <Arg Name="StandardEnvelopes:MaxDepth" />
        <Arg Name="MaxDepth" />
    </Assign>
    <Assign>
        <Sequence />
        <Arg Name="StandardEnvelopes:MinOffshore" />
        <Arg Name="MinOffshore" />
    </Assign>
    <Insert Filename="Insert/BackseatDriver.tl" />
    <Insert Filename="Insert/PowerOnly.tl" />
    <Guidance:Buoyancy Id="BuoyancyHold">
        <While>
            <Arg Name="BuoyancyHold" />
        </While>
        <Setting>
            <Guidance:Buoyancy.position />
            <Control:VerticalControl.buoyancyNeutral />
        </Setting>
    </Guidance:Buoyancy>
    <Guidance:Pitch Id="MassHold">
        <While>
            <Arg Name="MassHold" />
        </While>
        <Setting>
            <Guidance:Pitch.massPosition />
            <Control:VerticalControl.massDefault />
        </Setting>
    </Guidance:Pitch>
    <Aggregate Id="Transit">
        <Sequence />
        <Guidance:Pitch>
            <Parallel />
            <Setting>
                <Guidance:Pitch.depth />
                <Arg Name="Depth" />
            </Setting>
        </Guidance:Pitch>
        <Guidance:SetSpeed>
            <Parallel />
            <Setting>
                <Guidance:SetSpeed.speed />
                <Arg Name="Speed" />
            </Setting>
        </Guidance:SetSpeed>
        <Guidance:Waypoint Id="Wpt1">
            <Sequence />
            <Setting>
                <Guidance:Waypoint.latitude />
                <Arg Name="Latitude" />
            </Setting>
            <Setting>
                <Guidance:Waypoint.longitude />
                <Arg Name="Longitude" />
            </Setting>
            <Setting>
                <Guidance:Waypoint.northingsDelta />
                <Arg Name="Northings" />
            </Setting>
            <Setting>
                <Guidance:Waypoint.eastingsDelta />
                <Arg Name="Eastings" />
            </Setting>
        </Guidance:Waypoint>
        <Call RefId="NeedComms" Id="PhoneHome" />
    </Aggregate>
</Mission>

2025-03-14T01:16:39.104Z,1741914999.104 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2025-03-14T01:16:39.107Z,1741914999.107 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2025-03-14T01:16:39.110Z,1741914999.110 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2025-03-14T01:16:39.113Z,1741914999.113 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2025-03-14T01:16:39.116Z,1741914999.116 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2025-03-14T01:16:39.119Z,1741914999.119 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2025-03-14T01:16:39.186Z,1741914999.186 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2025-03-14T01:16:39.205Z,1741914999.205 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2025-03-14T01:16:39.208Z,1741914999.208 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2025-03-14T01:16:39.219Z,1741914999.219 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2025-03-14T01:16:39.261Z,1741914999.261 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2025-03-14T01:16:39.264Z,1741914999.264 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2025-03-14T01:16:39.271Z,1741914999.271 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2025-03-14T01:16:39.271Z,1741914999.271 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-03-14T01:16:39.271Z,1741914999.271 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-03-14T01:16:39.273Z,1741914999.273 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-03-14T01:16:39.679Z,1741914999.679 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="NeedComms">
    <DefineArg Name="DiveInterval">
        <Units:hour />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="WaitForPitchUp">
        <Units:minute />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="SurfacePitch">
        <Units:degree />
        <Value>20</Value>
    </DefineArg>
    <DefineArg Name="SurfaceDepthRate">
        <Units:meter_per_second />
        <Value>NaN</Value>
    </DefineArg>
    <DefineArg Name="SurfaceSpeed">
        <Units:meter_per_second />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="SurfacingTimeout">
        <Units:second />
        <Value>1000</Value>
    </DefineArg>
    <DefineArg Name="GPSTimeout">
        <Units:minute />
        <Value>7</Value>
    </DefineArg>
    <DefineArg Name="CommsTimeout">
        <Units:minute />
        <Value>30</Value>
    </DefineArg>
    <When>
        <Called />
        <Or>
            <Elapsed>
                <Universal:time_fix />
            </Elapsed>
            <Gt>
                <Arg Name="DiveInterval" />
                <Add>
                    <Arg Name="WaitForPitchUp" />
                </Add>
            </Gt>
        </Or>
        <Or>
            <Elapsed>
                <Universal:time_fix />
            </Elapsed>
            <Gt>
                <Arg Name="DiveInterval" />
            </Gt>
            <And>
                <Universal:platform_pitch_angle />
                <Gt>
                    <Units:degree />
                    <Value>0</Value>
                </Gt>
            </And>
        </Or>
    </When>
    <Syslog Severity="Info">
        last time_fix was: 
        <Universal:time_fix />
        <Units:epoch_second />
    </Syslog>
    <Guidance:GoToSurface>
        <Progression />
        <Setting>
            <Guidance:GoToSurface.pitch />
            <Arg Name="SurfacePitch" />
        </Setting>
        <Setting>
            <Guidance:GoToSurface.depthRate />
            <Arg Name="SurfaceDepthRate" />
        </Setting>
        <Setting>
            <Guidance:GoToSurface.speed />
            <Arg Name="SurfaceSpeed" />
        </Setting>
        <Setting>
            <Guidance:GoToSurface.surfaceTimeout />
            <Arg Name="SurfacingTimeout" />
        </Setting>
    </Guidance:GoToSurface>
    <ReadDatum>
        <Timeout Duration="GPSTimeout">
            <Syslog Severity="Important">first GPS update timeout</Syslog>
        </Timeout>
        <Universal:time_fix />
    </ReadDatum>
    <ReadDatum>
        <Timeout Duration="CommsTimeout">
            <Syslog Severity="Important">
                Comms timed out after 
                <Arg Name="CommsTimeout" />
                <Units:minute />
                minutes
            </Syslog>
        </Timeout>
        <Universal:platform_communications />
    </ReadDatum>
    <ReadDatum>
        <Timeout Duration="GPSTimeout">
            <Syslog Severity="Important">second GPS update timeout</Syslog>
        </Timeout>
        <Universal:time_fix />
    </ReadDatum>
</Aggregate>

2025-03-14T01:16:39.684Z,1741914999.684 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 1.000000 h
2025-03-14T01:16:39.688Z,1741914999.688 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2025-03-14T01:16:39.691Z,1741914999.691 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-03-14T01:16:39.694Z,1741914999.694 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2025-03-14T01:16:39.697Z,1741914999.697 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-03-14T01:16:39.700Z,1741914999.700 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2025-03-14T01:16:39.703Z,1741914999.703 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2025-03-14T01:16:39.706Z,1741914999.706 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2025-03-14T01:16:39.733Z,1741914999.733 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-14T01:16:39.834Z,1741914999.834 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-03-14T01:16:39.834Z,1741914999.834 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-03-14T01:16:39.835Z,1741914999.835 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-03-14T01:16:40.047Z,1741915000.047 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="StandardEnvelopes">
    <DefineArg Name="MinAltitude">
        <Units:meter />
        <Value>5</Value>
    </DefineArg>
    <DefineArg Name="MaxDepthIgnore">
        <Units:meter />
        <Value>0</Value>
    </DefineArg>
    <DefineArg Name="MaxDepth">
        <Units:meter />
        <Value>200</Value>
    </DefineArg>
    <DefineArg Name="MinOffshore">
        <Units:meter />
        <Value>2000</Value>
    </DefineArg>
    <Parallel />
    <Guidance:AltitudeEnvelope>
        <Parallel />
        <Setting>
            <Guidance:AltitudeEnvelope.minAltitude />
            <Arg Name="MinAltitude" />
        </Setting>
        <Setting>
            <Guidance:AltitudeEnvelope.maxDepthIgnore />
            <Arg Name="MaxDepthIgnore" />
        </Setting>
    </Guidance:AltitudeEnvelope>
    <Guidance:DepthEnvelope>
        <Parallel />
        <Setting>
            <Guidance:DepthEnvelope.maxDepth />
            <Arg Name="MaxDepth" />
        </Setting>
    </Guidance:DepthEnvelope>
    <Guidance:OffshoreEnvelope>
        <Parallel />
        <Setting>
            <Guidance:OffshoreEnvelope.minOffshore />
            <Arg Name="MinOffshore" />
        </Setting>
    </Guidance:OffshoreEnvelope>
</Aggregate>

2025-03-14T01:16:40.061Z,1741915000.061 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2025-03-14T01:16:40.064Z,1741915000.064 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-03-14T01:16:40.072Z,1741915000.072 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2025-03-14T01:16:40.075Z,1741915000.075 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-03-14T01:16:40.076Z,1741915000.076 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-03-14T01:16:40.096Z,1741915000.096 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-03-14T01:16:40.126Z,1741915000.126 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-03-14T01:16:40.158Z,1741915000.158 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-03-14T01:16:40.158Z,1741915000.158 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-03-14T01:16:40.159Z,1741915000.159 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-03-14T01:16:40.238Z,1741915000.238 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="BackseatDriver">
    <DefineArg Name="EnableBackseat">
        <False />
    </DefineArg>
    <Parallel />
    <Guidance:BackseatDriver>
        <Sequence />
        <Setting>
            <Guidance:BackseatDriver.powerBackseat />
            <Arg Name="EnableBackseat" />
        </Setting>
    </Guidance:BackseatDriver>
</Aggregate>

2025-03-14T01:16:40.246Z,1741915000.246 [MissionManager](INFO): DefineArg transit:BackseatDriver.EnableBackseat = 0 bool
2025-03-14T01:16:40.253Z,1741915000.253 [transit:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-03-14T01:16:40.256Z,1741915000.256 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-03-14T01:16:40.256Z,1741915000.256 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-03-14T01:16:40.262Z,1741915000.262 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-03-14T01:16:40.551Z,1741915000.551 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="PowerOnly">
    <DefineArg Name="SampleAll">
        <False />
    </DefineArg>
    <DefineArg Name="SampleLoad1">
        <False />
    </DefineArg>
    <DefineArg Name="SampleLoad2">
        <False />
    </DefineArg>
    <DefineArg Name="SampleLoad3">
        <False />
    </DefineArg>
    <DefineArg Name="EnabledPowerOnly">
        <Sensor:PowerOnly.loadAtStartup />
    </DefineArg>
    <Parallel />
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleAll" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.samplePowerOnly />
    </ReadData>
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleLoad1" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.sampleLoad1 />
    </ReadData>
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleLoad2" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.sampleLoad2 />
    </ReadData>
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleLoad3" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.sampleLoad3 />
    </ReadData>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:hour />
            <Value>99999</Value>
        </Setting>
    </Guidance:Wait>
</Aggregate>

2025-03-14T01:16:40.559Z,1741915000.559 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleAll = 0 bool
2025-03-14T01:16:40.563Z,1741915000.563 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad1 = 0 bool
2025-03-14T01:16:40.573Z,1741915000.573 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad2 = 0 bool
2025-03-14T01:16:40.576Z,1741915000.576 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad3 = 0 bool
2025-03-14T01:16:40.584Z,1741915000.584 [MissionManager](INFO): DefineArg transit:PowerOnly.EnabledPowerOnly = 1 bool
2025-03-14T01:16:40.599Z,1741915000.599 [transit:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-03-14T01:16:40.611Z,1741915000.611 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2025-03-14T01:16:40.621Z,1741915000.621 [transit:MassHold.Pitch](DEBUG): Construct.
2025-03-14T01:16:40.628Z,1741915000.628 [transit:Transit:A.Pitch](DEBUG): Construct.
2025-03-14T01:16:40.654Z,1741915000.654 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2025-03-14T01:16:40.669Z,1741915000.669 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-03-14T01:16:40.706Z,1741915000.706 [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 transit {
  """
  Vehicle transits to desired waypoint and can be commanded to use/hold
  mass or buoyancy.
  """

  arguments {
    MissionTimeout = 60 minute
      """
      Maximum duration of mission
      """

    NeedCommsTime = 30 minute
      """
      How often to surface for commumications
      """

    Latitude = NaN degree
      """
      Latitude of waypoint to seek. If set to NaN, uses latitude at mission
      initialization.
      """

    Longitude = NaN degree
      """
      Longitude of waypoint to seek. If set to NaN, uses longitude at mission
      initialization.
      """

    Northings = 0 meter
      """
      Northward distance of the waypoint to seek. If combined with Latitude
      and/or Longitude, this is an offset from the specified Latitude and/or
      Longitude.
      """

    Eastings = 0 meter
      """
      Eastward distance of the waypoint to seek. If combined with Latitude
      and/or Longitude, this is an offset from the specified Latitude and/or
      Longitude.
      """

    Depth = 10 meter
      """
      Depth of flat and level flight during the mission.
      """

    Speed = 1 meter_per_second
      """
      Speed of vehicle (relative to water) during the mission.
      """

    MaxDepth = 20 meter
      """
      Maximum depth for the entire mission.
      """

    MinOffshore = 1 kilometer
      """
      Minimum distance offshore for the entire mission.
      """

    MinAltitude = 7 meter
      """
      Minimum height above the sea floor for the entire mission.
      """

    MassHold = true
      """
      Set to True in order to hold mass at default position, False to allow
      mass to run on its own.
      """

    BuoyancyHold = true
      """
      Set to True in order to hold buoyancy at neutral position, False to
      allow buoyancy to run on its own.
      """
  }

  timeout duration=MissionTimeout

  insert id="NeedComms" Insert/NeedComms.tl

  assign in sequence NeedComms:DiveInterval = NeedCommsTime

  assign in sequence NeedComms:WaitForPitchUp = 1 second

  insert Insert/StandardEnvelopes.tl

  assign in sequence StandardEnvelopes:MinAltitude = MinAltitude

  assign in sequence StandardEnvelopes:MaxDepth = MaxDepth

  assign in sequence StandardEnvelopes:MinOffshore = MinOffshore

  insert Insert/BackseatDriver.tl

  insert Insert/PowerOnly.tl

  behavior Guidance:Buoyancy id="BuoyancyHold" {
    run while ( BuoyancyHold )

    set position = Control:VerticalControl.buoyancyNeutral
  }

  behavior Guidance:Pitch id="MassHold" {
    run while ( MassHold )

    set massPosition = Control:VerticalControl.massDefault
  }

  aggregate Transit {
    run in sequence

    behavior Guidance:Pitch {
      run in parallel

      set depth = Depth
    }

    behavior Guidance:SetSpeed {
      run in parallel

      set speed = Speed
    }

    behavior Guidance:Waypoint id="Wpt1" {
      run in sequence

      set latitude = Latitude
      set longitude = Longitude
      set northingsDelta = Northings
      set eastingsDelta = Eastings
    }

    call id="PhoneHome" refId="NeedComms"
  }
}


2025-03-14T01:16:40.707Z,1741915000.707 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl id=transit
2025-03-14T01:16:45.174Z,1741915005.174 [CommandExec](IMPORTANT): got command set transit.Latitude 36.797 degree
2025-03-14T01:16:45.175Z,1741915005.175 [CommandExec](IMPORTANT): got command set transit.Longitude -121.847 degree
2025-03-14T01:16:45.175Z,1741915005.175 [CommandExec](IMPORTANT): got command run
2025-03-14T01:16:45.178Z,1741915005.178 [CommandExec](IMPORTANT): Running 
2025-03-14T01:16:45.211Z,1741915005.211 [Default] Stopped
2025-03-14T01:16:45.211Z,1741915005.211 [Default](DEBUG): Aggregate::uninitialize Default
2025-03-14T01:16:45.212Z,1741915005.212 [Default:B.GoToSurface] Stopped
2025-03-14T01:16:45.212Z,1741915005.212 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-14T01:16:45.212Z,1741915005.212 [Default:CheckIn] Stopped
2025-03-14T01:16:45.212Z,1741915005.212 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-03-14T01:16:45.212Z,1741915005.212 [Default:CheckIn:C.Wait] Stopped
2025-03-14T01:16:45.212Z,1741915005.212 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-03-14T01:16:45.212Z,1741915005.212 [MissionManager](IMPORTANT): Started mission transit
2025-03-14T01:16:45.212Z,1741915005.212 [transit] Running Loop=1
2025-03-14T01:16:45.212Z,1741915005.212 [transit](DEBUG): Aggregate::initialize transit
2025-03-14T01:16:45.213Z,1741915005.213 [transit:StandardEnvelopes] Running Loop=1
2025-03-14T01:16:45.257Z,1741915005.257 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2025-03-14T01:16:45.257Z,1741915005.257 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-03-14T01:16:45.257Z,1741915005.257 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-03-14T01:16:45.257Z,1741915005.257 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-03-14T01:16:45.257Z,1741915005.257 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-03-14T01:16:45.258Z,1741915005.258 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-03-14T01:16:45.258Z,1741915005.258 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-03-14T01:16:45.258Z,1741915005.258 [transit:BackseatDriver] Running Loop=1
2025-03-14T01:16:45.258Z,1741915005.258 [transit:BackseatDriver](DEBUG): Aggregate::initialize transit:BackseatDriver
2025-03-14T01:16:45.258Z,1741915005.258 [transit:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-03-14T01:16:45.258Z,1741915005.258 [transit:PowerOnly] Running Loop=1
2025-03-14T01:16:45.258Z,1741915005.258 [transit:PowerOnly](DEBUG): Aggregate::initialize transit:PowerOnly
2025-03-14T01:16:45.258Z,1741915005.258 [transit:PowerOnly:A] Running Loop=1
2025-03-14T01:16:45.258Z,1741915005.258 [transit:PowerOnly:B] Running Loop=1
2025-03-14T01:16:45.258Z,1741915005.258 [transit:PowerOnly:C] Running Loop=1
2025-03-14T01:16:45.259Z,1741915005.259 [transit:PowerOnly:D] Running Loop=1
2025-03-14T01:16:45.259Z,1741915005.259 [transit:PowerOnly:E.Wait] Running Loop=1
2025-03-14T01:16:45.259Z,1741915005.259 [transit:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-03-14T01:16:45.259Z,1741915005.259 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-03-14T01:16:45.259Z,1741915005.259 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-03-14T01:16:45.259Z,1741915005.259 [transit:MassHold.Pitch] Running Loop=1
2025-03-14T01:16:45.259Z,1741915005.259 [transit:MassHold.Pitch](DEBUG): Initialize.
2025-03-14T01:16:45.259Z,1741915005.259 [transit:B] Running Loop=1
2025-03-14T01:16:45.260Z,1741915005.260 [transit:MassHold.Pitch] Running Loop=1
2025-03-14T01:16:45.260Z,1741915005.260 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-03-14T01:16:45.265Z,1741915005.265 [transit:PowerOnly] Running Loop=1
2025-03-14T01:16:45.266Z,1741915005.266 [transit:PowerOnly:D] Stopped
2025-03-14T01:16:45.266Z,1741915005.266 [transit:PowerOnly:C] Stopped
2025-03-14T01:16:45.266Z,1741915005.266 [transit:PowerOnly:B] Stopped
2025-03-14T01:16:45.266Z,1741915005.266 [transit:PowerOnly:A] Stopped
2025-03-14T01:16:45.266Z,1741915005.266 [transit:BackseatDriver] Running Loop=1
2025-03-14T01:16:45.266Z,1741915005.266 [transit:StandardEnvelopes] Running Loop=1
2025-03-14T01:16:45.266Z,1741915005.266 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-03-14T01:16:45.267Z,1741915005.267 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-03-14T01:16:45.267Z,1741915005.267 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-03-14T01:16:45.268Z,1741915005.268 [transit:B] Stopped
2025-03-14T01:16:45.268Z,1741915005.268 [transit:C] Running Loop=1
2025-03-14T01:16:45.619Z,1741915005.619 [transit:C] Stopped
2025-03-14T01:16:45.619Z,1741915005.619 [transit:E] Running Loop=1
2025-03-14T01:16:46.026Z,1741915006.026 [transit:E] Stopped
2025-03-14T01:16:46.027Z,1741915006.027 [transit:F] Running Loop=1
2025-03-14T01:16:46.434Z,1741915006.434 [transit:F] Stopped
2025-03-14T01:16:46.434Z,1741915006.434 [transit:G] Running Loop=1
2025-03-14T01:16:46.830Z,1741915006.830 [transit:G] Stopped
2025-03-14T01:16:46.830Z,1741915006.830 [transit:Transit] Running Loop=1
2025-03-14T01:16:46.830Z,1741915006.830 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2025-03-14T01:16:46.830Z,1741915006.830 [transit:Transit:A.Pitch] Running Loop=1
2025-03-14T01:16:46.830Z,1741915006.830 [transit:Transit:A.Pitch](DEBUG): Initialize.
2025-03-14T01:16:46.830Z,1741915006.830 [transit:Transit:B.SetSpeed] Running Loop=1
2025-03-14T01:16:46.830Z,1741915006.830 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2025-03-14T01:16:46.831Z,1741915006.831 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2025-03-14T01:16:46.831Z,1741915006.831 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-03-14T01:16:46.832Z,1741915006.832 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2025-03-14T01:16:46.850Z,1741915006.850 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2025-03-14T01:16:47.236Z,1741915007.236 [transit:Transit:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000
2025-03-14T01:16:47.237Z,1741915007.237 [transit:Transit:B.SetSpeed] Running Loop=1
2025-03-14T01:16:47.237Z,1741915007.237 [transit:Transit:A.Pitch] Running Loop=1
2025-03-14T01:16:47.246Z,1741915007.246 [HorizontalControl](DEBUG): kpHeading = 0.400000
2025-03-14T01:16:47.246Z,1741915007.246 [HorizontalControl](DEBUG): kiHeading = 0.001000
2025-03-14T01:16:47.246Z,1741915007.246 [HorizontalControl](DEBUG): kdHeading = 0.050000
2025-03-14T01:18:11.738Z,1741915091.738 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:18:14.751Z,1741915094.751 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.240219
2025-03-14T01:18:46.877Z,1741915126.877 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:18:47.785Z,1741915127.785 [Radio_Surface](INFO): Powering down
2025-03-14T01:18:47.881Z,1741915127.881 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-03-14T01:22:09.645Z,1741915329.645 [transit:StandardEnvelopes:A.AltitudeEnvelope](IMPORTANT): Altitude envelope ACTIVE
2025-03-14T01:27:12.367Z,1741915632.367 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-14T01:27:27.783Z,1741915647.783 [Waterlinked](ERROR): only read 4 of 5 data items. Device response::BI,    +0,    +0,    +0,.00
2025-03-14T01:31:44.335Z,1741915904.335 [Waterlinked](ERROR): only read 0 of 1 data item for altitude. Device response::BD,       +0.0 +0.00,       +0.00,   0.00,  0.00
2025-03-14T01:38:17.873Z,1741916297.873 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:38:17.873Z,1741916297.873 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:38:17.873Z,1741916297.873 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:38:18.046Z,1741916298.046 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:38:18.333Z,1741916298.333 [Waterlinked](INFO): Powering down
2025-03-14T01:38:19.217Z,1741916299.217 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:38:19.217Z,1741916299.217 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:38:57.850Z,1741916337.850 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:38:57.850Z,1741916337.850 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:38:57.850Z,1741916337.850 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:38:58.009Z,1741916338.009 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:38:58.329Z,1741916338.329 [Waterlinked](INFO): Powering down
2025-03-14T01:38:59.181Z,1741916339.181 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:38:59.181Z,1741916339.181 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:39:21.646Z,1741916361.646 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5.
2025-03-14T01:39:21.650Z,1741916361.650 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2025-03-14T01:41:20.353Z,1741916480.353 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:41:20.353Z,1741916480.353 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:41:20.353Z,1741916480.353 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:41:20.506Z,1741916480.506 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:41:20.825Z,1741916480.825 [Waterlinked](INFO): Powering down
2025-03-14T01:41:21.702Z,1741916481.702 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:41:21.702Z,1741916481.702 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:41:59.294Z,1741916519.294 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:41:59.295Z,1741916519.295 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:41:59.295Z,1741916519.295 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:41:59.671Z,1741916519.671 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:41:59.849Z,1741916519.849 [Waterlinked](INFO): Powering down
2025-03-14T01:42:00.744Z,1741916520.744 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:42:00.744Z,1741916520.744 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:42:49.844Z,1741916569.844 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:42:49.844Z,1741916569.844 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:42:49.844Z,1741916569.844 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:42:49.965Z,1741916569.965 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:42:50.313Z,1741916570.313 [Waterlinked](INFO): Powering down
2025-03-14T01:42:51.169Z,1741916571.169 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:42:51.169Z,1741916571.169 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:43:20.224Z,1741916600.224 [transit:NeedComms] Running Loop=1
2025-03-14T01:43:20.224Z,1741916600.224 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2025-03-14T01:43:20.225Z,1741916600.225 [transit:NeedComms:B.GoToSurface] Running Loop=1
2025-03-14T01:43:20.225Z,1741916600.225 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-14T01:43:20.226Z,1741916600.226 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-03-14T01:43:20.227Z,1741916600.227 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-03-14T01:43:20.228Z,1741916600.228 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-03-14T01:43:20.253Z,1741916600.253 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-03-14T01:43:20.254Z,1741916600.254 [transit:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-14T01:43:20.255Z,1741916600.255 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-14T01:43:20.256Z,1741916600.256 [transit:NeedComms:A] Running Loop=1
2025-03-14T01:43:20.270Z,1741916600.270 [transit:NeedComms:A](INFO): last time_fix was:  1741914798.000000 second since 1970/01/01T00:00:00Z 
2025-03-14T01:43:20.270Z,1741916600.270 [transit:NeedComms:A] Stopped
2025-03-14T01:43:22.598Z,1741916602.598 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:23.022Z,1741916603.022 [Radio_Surface](INFO): Powering up
2025-03-14T01:43:23.147Z,1741916603.147 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:23.731Z,1741916603.731 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:24.156Z,1741916604.156 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:24.816Z,1741916604.816 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:25.541Z,1741916605.541 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:26.069Z,1741916606.069 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:26.456Z,1741916606.456 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:26.859Z,1741916606.859 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:27.259Z,1741916607.259 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:27.651Z,1741916607.651 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:28.105Z,1741916608.105 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:28.486Z,1741916608.486 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:28.861Z,1741916608.861 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:29.046Z,1741916609.046 [DataOverHttps](INFO): Radio surface powered ON.
2025-03-14T01:43:29.288Z,1741916609.288 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:29.702Z,1741916609.702 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:30.080Z,1741916610.080 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:30.494Z,1741916610.494 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:30.883Z,1741916610.883 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:31.435Z,1741916611.435 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:31.737Z,1741916611.737 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:32.134Z,1741916612.134 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:32.535Z,1741916612.535 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:32.930Z,1741916612.930 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:33.364Z,1741916613.364 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:33.738Z,1741916613.738 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:34.127Z,1741916614.127 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:34.535Z,1741916614.535 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:34.940Z,1741916614.940 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:35.359Z,1741916615.359 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:35.758Z,1741916615.758 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:36.144Z,1741916616.144 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:36.585Z,1741916616.585 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:37.076Z,1741916617.076 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:37.497Z,1741916617.497 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:37.863Z,1741916617.863 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:38.278Z,1741916618.278 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:38.659Z,1741916618.659 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:39.089Z,1741916619.089 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:39.465Z,1741916619.465 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:39.900Z,1741916619.900 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:40.386Z,1741916620.386 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:40.707Z,1741916620.707 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:41.086Z,1741916621.086 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:41.521Z,1741916621.521 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:41.922Z,1741916621.922 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:42.352Z,1741916622.352 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:42.707Z,1741916622.707 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:43.120Z,1741916623.120 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:43.512Z,1741916623.512 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:43.936Z,1741916623.936 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:44.346Z,1741916624.346 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:44.722Z,1741916624.722 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:45.098Z,1741916625.098 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:45.548Z,1741916625.548 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:45.944Z,1741916625.944 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:46.328Z,1741916626.328 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:46.916Z,1741916626.916 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:47.275Z,1741916627.275 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:47.647Z,1741916627.647 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:47.986Z,1741916627.986 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:48.402Z,1741916628.402 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:48.915Z,1741916628.915 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:49.227Z,1741916629.227 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:49.605Z,1741916629.605 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:50.006Z,1741916630.006 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:50.417Z,1741916630.418 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:50.818Z,1741916630.818 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:51.230Z,1741916631.230 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:51.637Z,1741916631.637 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:52.014Z,1741916632.014 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:52.500Z,1741916632.500 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:52.840Z,1741916632.840 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:53.234Z,1741916633.234 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:53.641Z,1741916633.641 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:54.063Z,1741916634.063 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:54.597Z,1741916634.597 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:54.889Z,1741916634.889 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:55.273Z,1741916635.273 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:55.686Z,1741916635.686 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:56.078Z,1741916636.078 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:56.486Z,1741916636.486 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:56.870Z,1741916636.870 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:57.296Z,1741916637.296 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:57.703Z,1741916637.703 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:58.088Z,1741916638.088 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:58.480Z,1741916638.480 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:58.910Z,1741916638.910 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:59.174Z,1741916639.174 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:43:59.338Z,1741916639.338 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:43:59.727Z,1741916639.727 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:00.096Z,1741916640.096 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:00.528Z,1741916640.528 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:00.924Z,1741916640.924 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:01.490Z,1741916641.490 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:01.793Z,1741916641.793 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:02.158Z,1741916642.158 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:02.574Z,1741916642.574 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:02.943Z,1741916642.943 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:03.364Z,1741916643.364 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:03.753Z,1741916643.753 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:04.169Z,1741916644.169 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:04.617Z,1741916644.617 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:04.993Z,1741916644.993 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:05.391Z,1741916645.391 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:05.816Z,1741916645.816 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:06.320Z,1741916646.320 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:06.647Z,1741916646.647 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:07.002Z,1741916647.002 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:07.485Z,1741916647.485 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:07.833Z,1741916647.833 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:08.241Z,1741916648.241 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:08.646Z,1741916648.646 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:09.052Z,1741916649.052 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:09.420Z,1741916649.420 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:09.846Z,1741916649.846 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:10.252Z,1741916650.252 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:10.660Z,1741916650.660 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:11.046Z,1741916651.046 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:11.470Z,1741916651.470 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:11.860Z,1741916651.860 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:12.249Z,1741916652.249 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:12.823Z,1741916652.823 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:13.134Z,1741916653.134 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:13.523Z,1741916653.523 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:13.914Z,1741916653.914 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:14.325Z,1741916654.325 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:14.886Z,1741916654.886 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:15.175Z,1741916655.175 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:15.550Z,1741916655.550 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:15.944Z,1741916655.944 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:16.376Z,1741916656.376 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:16.757Z,1741916656.757 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:17.527Z,1741916657.527 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:17.854Z,1741916657.854 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:18.310Z,1741916658.310 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:18.641Z,1741916658.641 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:19.008Z,1741916659.008 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:19.456Z,1741916659.456 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:19.838Z,1741916659.838 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:20.227Z,1741916660.227 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:20.633Z,1741916660.633 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:21.046Z,1741916661.046 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:21.430Z,1741916661.430 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:21.831Z,1741916661.831 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:22.240Z,1741916662.240 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:22.635Z,1741916662.635 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:23.064Z,1741916663.064 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:23.466Z,1741916663.466 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:23.879Z,1741916663.879 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:24.290Z,1741916664.290 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:24.651Z,1741916664.651 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:25.083Z,1741916665.083 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:25.469Z,1741916665.469 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:25.867Z,1741916665.867 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:26.288Z,1741916666.288 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:26.696Z,1741916666.696 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:27.102Z,1741916667.102 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:27.540Z,1741916667.540 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:27.894Z,1741916667.894 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:28.450Z,1741916668.450 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:28.749Z,1741916668.749 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:29.110Z,1741916669.110 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:29.514Z,1741916669.514 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:29.920Z,1741916669.920 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:30.342Z,1741916670.342 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:30.731Z,1741916670.731 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:31.131Z,1741916671.131 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:31.655Z,1741916671.655 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:32.050Z,1741916672.050 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:32.473Z,1741916672.473 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:32.816Z,1741916672.816 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:33.295Z,1741916673.295 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:33.693Z,1741916673.693 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:34.031Z,1741916674.031 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:34.322Z,1741916674.322 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:44:34.478Z,1741916674.478 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:34.860Z,1741916674.860 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:35.252Z,1741916675.252 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:35.657Z,1741916675.657 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:36.184Z,1741916676.184 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:36.472Z,1741916676.472 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:36.865Z,1741916676.865 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:37.260Z,1741916677.260 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:37.656Z,1741916677.656 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:38.074Z,1741916678.074 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:38.490Z,1741916678.490 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:38.895Z,1741916678.895 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:39.293Z,1741916679.293 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:39.705Z,1741916679.705 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:40.101Z,1741916680.101 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:40.509Z,1741916680.509 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:40.884Z,1741916680.884 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:41.296Z,1741916681.296 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:41.701Z,1741916681.701 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:42.117Z,1741916682.117 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:42.573Z,1741916682.573 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:42.962Z,1741916682.962 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:43.319Z,1741916683.319 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:43.732Z,1741916683.732 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:44.140Z,1741916684.140 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:44.533Z,1741916684.533 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:45.032Z,1741916685.032 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:45.359Z,1741916685.359 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:45.744Z,1741916685.744 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:46.182Z,1741916686.182 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:46.573Z,1741916686.573 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:46.998Z,1741916686.998 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:47.429Z,1741916687.429 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:47.959Z,1741916687.959 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:48.246Z,1741916688.246 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:48.627Z,1741916688.627 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:49.026Z,1741916689.026 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:49.417Z,1741916689.417 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:49.952Z,1741916689.952 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:50.263Z,1741916690.263 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:50.635Z,1741916690.635 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:51.027Z,1741916691.027 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:51.454Z,1741916691.454 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:51.863Z,1741916691.863 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:52.266Z,1741916692.266 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:52.659Z,1741916692.659 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:53.080Z,1741916693.080 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:53.466Z,1741916693.466 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:53.874Z,1741916693.874 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:54.286Z,1741916694.286 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:54.694Z,1741916694.694 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:55.099Z,1741916695.099 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:55.491Z,1741916695.491 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:55.896Z,1741916695.896 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:56.281Z,1741916696.281 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:56.712Z,1741916696.712 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:57.091Z,1741916697.091 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:57.569Z,1741916697.569 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:57.955Z,1741916697.955 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:58.493Z,1741916698.493 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:58.825Z,1741916698.825 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:59.169Z,1741916699.169 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:59.553Z,1741916699.553 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:44:59.964Z,1741916699.964 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:00.378Z,1741916700.378 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:00.776Z,1741916700.776 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:01.326Z,1741916701.326 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:01.605Z,1741916701.605 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:01.973Z,1741916701.973 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:02.431Z,1741916702.431 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:02.796Z,1741916702.796 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:03.176Z,1741916703.176 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:03.590Z,1741916703.590 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:04.113Z,1741916704.113 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:04.424Z,1741916704.424 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:04.800Z,1741916704.800 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:05.207Z,1741916705.207 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:05.625Z,1741916705.625 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:06.020Z,1741916706.020 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:06.435Z,1741916706.435 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:06.842Z,1741916706.842 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:07.339Z,1741916707.339 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:07.658Z,1741916707.658 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:08.049Z,1741916708.049 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:08.438Z,1741916708.438 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:08.878Z,1741916708.878 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:09.249Z,1741916709.249 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:09.462Z,1741916709.462 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:45:09.675Z,1741916709.675 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:10.062Z,1741916710.062 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:10.450Z,1741916710.450 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:10.888Z,1741916710.888 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:11.259Z,1741916711.259 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:11.671Z,1741916711.671 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:12.080Z,1741916712.080 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:12.509Z,1741916712.509 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:12.925Z,1741916712.925 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:13.293Z,1741916713.293 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:13.687Z,1741916713.687 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:14.099Z,1741916714.099 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:14.662Z,1741916714.662 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:14.953Z,1741916714.953 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:15.315Z,1741916715.315 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:15.722Z,1741916715.722 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:16.074Z,1741916716.074 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:45:16.453Z,1741916716.453 [transit:NeedComms:B.GoToSurface](ERROR): No valid altitude, but last altitude 0.09 too low. Waiting for 600.000000 seconds.
2025-03-14T01:45:31.052Z,1741916731.052 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:45:31.052Z,1741916731.052 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:45:31.052Z,1741916731.052 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:45:31.235Z,1741916731.235 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:45:31.509Z,1741916731.509 [Waterlinked](INFO): Powering down
2025-03-14T01:45:32.273Z,1741916732.273 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:45:32.273Z,1741916732.273 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:45:44.602Z,1741916744.602 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:46:00.686Z,1741916760.686 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:01.016Z,1741916761.016 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:01.409Z,1741916761.409 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:01.810Z,1741916761.810 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:02.202Z,1741916762.202 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:02.633Z,1741916762.633 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:03.016Z,1741916763.016 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:03.435Z,1741916763.435 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:03.839Z,1741916763.839 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:04.228Z,1741916764.228 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:04.630Z,1741916764.630 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:05.057Z,1741916765.057 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:05.433Z,1741916765.433 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:05.870Z,1741916765.870 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:06.259Z,1741916766.259 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:06.668Z,1741916766.668 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:07.072Z,1741916767.072 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:07.497Z,1741916767.497 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:07.890Z,1741916767.890 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:08.267Z,1741916768.267 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:08.672Z,1741916768.672 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:09.072Z,1741916769.072 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:09.484Z,1741916769.484 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:09.896Z,1741916769.896 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:10.293Z,1741916770.293 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T01:46:10.623Z,1741916770.623 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-03-14T01:46:10.624Z,1741916770.624 [Waterlinked] Communications Fault, FailCount= 1
2025-03-14T01:46:10.624Z,1741916770.624 [Waterlinked](ERROR): Communications Fault
2025-03-14T01:46:10.701Z,1741916770.701 [transit:NeedComms:B.GoToSurface](ERROR): No valid altitude, but last altitude 0.09 too low. Waiting for 600.000000 seconds.
2025-03-14T01:46:10.811Z,1741916770.811 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-03-14T01:46:11.085Z,1741916771.085 [Waterlinked](INFO): Powering down
2025-03-14T01:46:11.865Z,1741916771.865 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-03-14T01:46:11.865Z,1741916771.865 [Waterlinked] No Fault, FailCount= 1
2025-03-14T01:46:19.745Z,1741916779.745 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:46:54.890Z,1741916814.890 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:46:57.914Z,1741916817.914 [Waterlinked](ERROR): only read 0 of 1 data item for BIT error. Device response::TS,24052713020, +0.0,   0.0,1475.0,  0
2025-03-14T01:47:01.130Z,1741916821.130 [transit:NeedComms:C] Running Loop=1
2025-03-14T01:47:01.597Z,1741916821.597 [Waterlinked](INFO): Powering down
2025-03-14T01:47:01.616Z,1741916821.616 [transit:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-03-14T01:47:30.030Z,1741916850.030 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:48:05.169Z,1741916885.169 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:48:17.726Z,1741916897.726 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003744
2025-03-14T01:48:46.940Z,1741916926.940 [NAL9602](INFO): SBD MO Status=2, MOMSN=18673, MT Status=2, MTMSN=0
2025-03-14T01:48:46.941Z,1741916926.941 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-03-14T01:50:51.379Z,1741917051.379 [NAL9602](INFO): SBD MO Status=0, MOMSN=18673, MT Status=0, MTMSN=0
2025-03-14T01:50:51.379Z,1741917051.379 [NAL9602](INFO): No messages in MT queue
2025-03-14T01:50:52.583Z,1741917052.583 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,015051.00,A,3647.64157,N,12150.61417,W,0.408,148.47,140325,,,A*7A
2025-03-14T01:50:52.585Z,1741917052.585 [NAL9602](INFO): GPS fix at 20250314T015051: (36.794026, -121.843570)
2025-03-14T01:50:52.598Z,1741917052.598 [UniversalFixResidualReporter](INFO): Fix residual: 23.8 %DT, over the last 1144.3 m. Residual distance 272.1 m at bearing -37.5 degrees. Fix at (36.7940, -121.8436) with 875.7 m made good.
2025-03-14T01:50:52.602Z,1741917052.602 [transit:NeedComms:C] Stopped
2025-03-14T01:50:52.602Z,1741917052.602 [transit:NeedComms:D] Running Loop=1
2025-03-14T01:50:53.014Z,1741917053.014 [transit:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-14T01:51:00.497Z,1741917060.497 [DataOverHttps](INFO): Sending 264 bytes from file Logs/20250314T010808/Courier0007.lzma
2025-03-14T01:51:01.499Z,1741917061.499 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Courier0007.lzma.bak
2025-03-14T01:51:01.499Z,1741917061.499 [DataOverHttps](INFO): SBD MOMSN=24226969
2025-03-14T01:51:17.478Z,1741917077.478 [DataOverHttps](INFO): Sending 613 bytes from file Logs/20250314T010808/Express0008.lzma
2025-03-14T01:51:18.479Z,1741917078.479 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Express0008.lzma.bak
2025-03-14T01:51:18.479Z,1741917078.479 [DataOverHttps](INFO): SBD MOMSN=24226973
2025-03-14T01:51:25.298Z,1741917085.298 [NAL9602](INFO): Not Powering down - fast GPS
2025-03-14T01:51:34.564Z,1741917094.564 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250314T010808/Express0011.lzma
2025-03-14T01:51:35.567Z,1741917095.567 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Express0011.lzma.bak
2025-03-14T01:51:35.567Z,1741917095.567 [DataOverHttps](INFO): SBD MOMSN=24226985
2025-03-14T01:51:37.033Z,1741917097.033 [transit:NeedComms:D] Stopped
2025-03-14T01:51:37.034Z,1741917097.034 [transit:NeedComms:E] Running Loop=1
2025-03-14T01:51:37.432Z,1741917097.432 [transit:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-03-14T01:51:39.040Z,1741917099.040 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,015137.00,A,3647.64018,N,12150.61263,W,0.894,87.21,140325,,,A*4F
2025-03-14T01:51:39.042Z,1741917099.042 [NAL9602](INFO): GPS fix at 20250314T015137: (36.794003, -121.843544)
2025-03-14T01:51:39.091Z,1741917099.091 [transit:NeedComms:E] Stopped
2025-03-14T01:51:39.092Z,1741917099.092 [transit:NeedComms](INFO): Completed transit:NeedComms
2025-03-14T01:51:39.092Z,1741917099.092 [transit:NeedComms] Stopped
2025-03-14T01:51:39.097Z,1741917099.097 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2025-03-14T01:51:39.097Z,1741917099.097 [transit:NeedComms:B.GoToSurface] Stopped
2025-03-14T01:51:39.097Z,1741917099.097 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-14T01:52:22.848Z,1741917142.848 [NAL9602](INFO): SBD MO Status=2, MOMSN=18674, MT Status=2, MTMSN=0
2025-03-14T01:52:22.849Z,1741917142.849 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-03-14T01:53:03.526Z,1741917183.526 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 6.85 mm (1 active estimators).
2025-03-14T01:53:04.732Z,1741917184.732 [NAL9602](INFO): SBD MO Status=2, MOMSN=18674, MT Status=2, MTMSN=0
2025-03-14T01:53:04.732Z,1741917184.732 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-03-14T01:53:46.087Z,1741917226.087 [transit:StandardEnvelopes:A.AltitudeEnvelope](IMPORTANT): Altitude envelope ACTIVE
2025-03-14T01:53:52.821Z,1741917232.821 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:53:55.833Z,1741917235.833 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.249992
2025-03-14T01:54:03.867Z,1741917243.867 [Radio_Surface](INFO): Powering down
2025-03-14T01:54:27.962Z,1741917267.962 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T01:54:28.966Z,1741917268.966 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-03-14T01:56:00.047Z,1741917360.047 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-03-14T01:56:00.047Z,1741917360.047 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-14T01:56:00.050Z,1741917360.050 [transit:Transit:Wpt1.Waypoint](ERROR): Location not readable.
2025-03-14T01:56:00.128Z,1741917360.128 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-14T01:56:00.405Z,1741917360.405 [transit:Transit:Wpt1.Waypoint](ERROR): Location not readable.
2025-03-14T01:56:00.448Z,1741917360.448 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-14T01:56:00.448Z,1741917360.448 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-03-14T01:56:41.235Z,1741917401.235 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-03-14T01:57:12.012Z,1741917432.012 [NAL9602](INFO): Not Powering down - fast GPS
2025-03-14T02:01:51.697Z,1741917711.697 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000
2025-03-14T02:01:51.697Z,1741917711.697 [transit:Transit:Wpt1.Waypoint] Stopped
2025-03-14T02:01:51.697Z,1741917711.697 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-03-14T02:01:51.697Z,1741917711.697 [transit:Transit:PhoneHome] Running Loop=1
2025-03-14T02:01:51.697Z,1741917711.697 [transit:Transit:PhoneHome](DEBUG): Aggregate::initialize transit:Transit:PhoneHome
2025-03-14T02:01:52.119Z,1741917712.119 [transit:NeedComms] Running Loop=1
2025-03-14T02:01:52.119Z,1741917712.119 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2025-03-14T02:01:52.119Z,1741917712.119 [transit:NeedComms:B.GoToSurface] Running Loop=1
2025-03-14T02:01:52.119Z,1741917712.119 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-14T02:01:52.120Z,1741917712.120 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-03-14T02:01:52.120Z,1741917712.120 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-03-14T02:01:52.120Z,1741917712.120 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-03-14T02:01:52.121Z,1741917712.121 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-03-14T02:01:52.121Z,1741917712.121 [transit:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-14T02:01:52.121Z,1741917712.121 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-14T02:01:52.122Z,1741917712.122 [transit:NeedComms:A] Running Loop=1
2025-03-14T02:01:52.123Z,1741917712.123 [transit:NeedComms:A](INFO): last time_fix was:  1741917097.000000 second since 1970/01/01T00:00:00Z 
2025-03-14T02:01:52.123Z,1741917712.123 [transit:NeedComms:A] Stopped
2025-03-14T02:02:28.596Z,1741917748.596 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:28.967Z,1741917748.967 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:29.038Z,1741917749.038 [Radio_Surface](INFO): Powering up
2025-03-14T02:02:29.749Z,1741917749.749 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:30.144Z,1741917750.144 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:30.818Z,1741917750.818 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:31.427Z,1741917751.427 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:31.838Z,1741917751.838 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:32.221Z,1741917752.221 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:32.665Z,1741917752.665 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:33.158Z,1741917753.158 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:33.510Z,1741917753.510 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:33.841Z,1741917753.841 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:34.245Z,1741917754.245 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:34.644Z,1741917754.644 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:35.042Z,1741917755.042 [DataOverHttps](INFO): Radio surface powered ON.
2025-03-14T02:02:35.085Z,1741917755.085 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:35.447Z,1741917755.447 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:35.859Z,1741917755.859 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:36.262Z,1741917756.262 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:36.652Z,1741917756.652 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:37.083Z,1741917757.083 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:37.486Z,1741917757.486 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:37.876Z,1741917757.876 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:38.266Z,1741917758.266 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:38.674Z,1741917758.674 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:39.080Z,1741917759.080 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:39.485Z,1741917759.485 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:39.914Z,1741917759.914 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:40.284Z,1741917760.284 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:40.701Z,1741917760.701 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:41.126Z,1741917761.126 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:41.498Z,1741917761.498 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:41.928Z,1741917761.928 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:42.300Z,1741917762.300 [transit:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.09
2025-03-14T02:02:42.872Z,1741917762.872 [transit:NeedComms:B.GoToSurface](ERROR): No valid altitude, but last altitude 0.09 too low. Waiting for 600.000000 seconds.
2025-03-14T02:02:44.665Z,1741917764.665 [transit:NeedComms:C] Running Loop=1
2025-03-14T02:02:45.109Z,1741917765.109 [Waterlinked](INFO): Powering down
2025-03-14T02:03:05.170Z,1741917785.170 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T02:03:17.346Z,1741917797.346 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-03-14T02:03:17.421Z,1741917797.421 [NAL9602](ERROR): received: 
+CSQ:0

OK674, 2, 0, 0, 0

OK
2025-03-14T02:03:40.309Z,1741917820.309 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T02:04:15.457Z,1741917855.457 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T02:04:50.597Z,1741917890.597 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T02:05:25.737Z,1741917925.737 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-03-14T02:05:58.374Z,1741917958.374 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003714
2025-03-14T02:06:32.482Z,1741917992.482 [NAL9602](INFO): SBD MO Status=0, MOMSN=18674, MT Status=0, MTMSN=0
2025-03-14T02:06:32.482Z,1741917992.482 [NAL9602](INFO): No messages in MT queue
2025-03-14T02:06:33.690Z,1741917993.690 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,020632.00,A,3647.76928,N,12150.77395,W,0.233,135.12,140325,,,A*72
2025-03-14T02:06:33.693Z,1741917993.693 [NAL9602](INFO): GPS fix at 20250314T020632: (36.796155, -121.846232)
2025-03-14T02:06:33.704Z,1741917993.704 [UniversalFixResidualReporter](INFO): Fix residual: 29.1 %DT, over the last 513.1 m. Residual distance 149.3 m at bearing -40.0 degrees. Fix at (36.7962, -121.8462) with 338.5 m made good.
2025-03-14T02:06:33.708Z,1741917993.708 [transit:NeedComms:C] Stopped
2025-03-14T02:06:33.708Z,1741917993.708 [transit:NeedComms:D] Running Loop=1
2025-03-14T02:06:41.444Z,1741918001.444 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20250314T010808/Courier0013.lzma
2025-03-14T02:06:42.447Z,1741918002.447 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Courier0013.lzma.bak
2025-03-14T02:06:42.447Z,1741918002.447 [DataOverHttps](INFO): SBD MOMSN=24227005
2025-03-14T02:06:58.330Z,1741918018.330 [DataOverHttps](INFO): Sending 387 bytes from file Logs/20250314T010808/Express0014.lzma
2025-03-14T02:06:59.331Z,1741918019.331 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Express0014.lzma.bak
2025-03-14T02:06:59.331Z,1741918019.331 [DataOverHttps](INFO): SBD MOMSN=24227009
2025-03-14T02:07:00.779Z,1741918020.779 [transit:NeedComms:D] Stopped
2025-03-14T02:07:00.779Z,1741918020.779 [transit:NeedComms:E] Running Loop=1
2025-03-14T02:07:02.772Z,1741918022.772 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,020701.00,A,3647.76770,N,12150.77370,W,0.875,125.08,140325,,,A*79
2025-03-14T02:07:02.774Z,1741918022.774 [NAL9602](INFO): GPS fix at 20250314T020701: (36.796128, -121.846228)
2025-03-14T02:07:02.828Z,1741918022.828 [transit:NeedComms:E] Stopped
2025-03-14T02:07:02.833Z,1741918022.833 [transit:NeedComms](INFO): Completed transit:NeedComms
2025-03-14T02:07:02.833Z,1741918022.833 [transit:NeedComms] Stopped
2025-03-14T02:07:02.833Z,1741918022.833 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2025-03-14T02:07:02.833Z,1741918022.833 [transit:NeedComms:B.GoToSurface] Stopped
2025-03-14T02:07:02.833Z,1741918022.833 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-14T02:07:03.224Z,1741918023.224 [transit:Transit:PhoneHome](INFO): Completed transit:Transit:PhoneHome
2025-03-14T02:07:03.225Z,1741918023.224 [transit:Transit:PhoneHome] Stopped
2025-03-14T02:07:03.229Z,1741918023.229 [transit:Transit:PhoneHome](DEBUG): Aggregate::uninitialize transit:Transit:PhoneHome
2025-03-14T02:07:03.230Z,1741918023.230 [transit:Transit](INFO): Completed transit:Transit
2025-03-14T02:07:03.230Z,1741918023.230 [transit:Transit] Stopped
2025-03-14T02:07:03.230Z,1741918023.230 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2025-03-14T02:07:03.230Z,1741918023.230 [transit:Transit:A.Pitch] Stopped
2025-03-14T02:07:03.230Z,1741918023.230 [transit:Transit:B.SetSpeed] Stopped
2025-03-14T02:07:03.230Z,1741918023.230 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2025-03-14T02:07:03.232Z,1741918023.232 [transit](INFO): Completed transit
2025-03-14T02:07:03.232Z,1741918023.232 [MissionManager](INFO): transit is completed.
2025-03-14T02:07:03.232Z,1741918023.232 [MissionManager](INFO): Uninitializing Mission transit
2025-03-14T02:07:03.232Z,1741918023.232 [transit] Stopped
2025-03-14T02:07:03.232Z,1741918023.232 [transit](DEBUG): Aggregate::uninitialize transit
2025-03-14T02:07:03.232Z,1741918023.232 [transit:StandardEnvelopes] Stopped
2025-03-14T02:07:03.232Z,1741918023.232 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2025-03-14T02:07:03.233Z,1741918023.233 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-03-14T02:07:03.237Z,1741918023.237 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-03-14T02:07:03.237Z,1741918023.237 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-03-14T02:07:03.237Z,1741918023.237 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-03-14T02:07:03.237Z,1741918023.237 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-03-14T02:07:03.238Z,1741918023.238 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-03-14T02:07:03.238Z,1741918023.238 [transit:BackseatDriver] Stopped
2025-03-14T02:07:03.238Z,1741918023.238 [transit:BackseatDriver](DEBUG): Aggregate::uninitialize transit:BackseatDriver
2025-03-14T02:07:03.238Z,1741918023.238 [transit:BackseatDriver:A.BackseatDriver] Stopped
2025-03-14T02:07:03.238Z,1741918023.238 [transit:PowerOnly] Stopped
2025-03-14T02:07:03.238Z,1741918023.238 [transit:PowerOnly](DEBUG): Aggregate::uninitialize transit:PowerOnly
2025-03-14T02:07:03.238Z,1741918023.238 [transit:PowerOnly:E.Wait] Stopped
2025-03-14T02:07:03.238Z,1741918023.238 [transit:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-03-14T02:07:03.238Z,1741918023.238 [transit:BuoyancyHold.Buoyancy] Stopped
2025-03-14T02:07:03.238Z,1741918023.238 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-03-14T02:07:03.238Z,1741918023.238 [transit:MassHold.Pitch] Stopped
2025-03-14T02:07:03.613Z,1741918023.613 [MissionManager](IMPORTANT): Started mission Default
2025-03-14T02:07:03.613Z,1741918023.613 [Default] Running Loop=1
2025-03-14T02:07:03.613Z,1741918023.613 [Default](DEBUG): Aggregate::initialize Default
2025-03-14T02:07:03.614Z,1741918023.614 [Default:B.GoToSurface] Running Loop=1
2025-03-14T02:07:03.614Z,1741918023.614 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-14T02:07:03.614Z,1741918023.614 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-14T02:07:03.614Z,1741918023.614 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-14T02:07:03.615Z,1741918023.615 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-14T02:07:03.615Z,1741918023.615 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-14T02:07:03.615Z,1741918023.615 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-14T02:07:03.615Z,1741918023.615 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-14T02:07:03.616Z,1741918023.616 [Default:A.Wait] Running Loop=1
2025-03-14T02:07:03.616Z,1741918023.616 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-03-14T02:07:16.920Z,1741918036.920 [Default:A.Wait](INFO): Done Waiting.
2025-03-14T02:07:16.920Z,1741918036.920 [Default:A.Wait] Stopped
2025-03-14T02:07:16.920Z,1741918036.920 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-03-14T02:07:17.329Z,1741918037.329 [Default:CheckIn] Running Loop=1
2025-03-14T02:07:17.329Z,1741918037.329 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-14T02:07:17.329Z,1741918037.329 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-14T02:07:19.348Z,1741918039.348 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,020717.00,A,3647.76553,N,12150.77278,W,1.866,129.38,140325,,,A*78
2025-03-14T02:07:19.350Z,1741918039.350 [NAL9602](INFO): GPS fix at 20250314T020717: (36.796092, -121.846213)
2025-03-14T02:07:19.360Z,1741918039.360 [Default:CheckIn:Read_GPS] Stopped
2025-03-14T02:07:19.360Z,1741918039.360 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-03-14T02:07:26.661Z,1741918046.661 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250314T010808/Courier0016.lzma
2025-03-14T02:07:27.663Z,1741918047.663 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Courier0016.lzma.bak
2025-03-14T02:07:27.663Z,1741918047.663 [DataOverHttps](INFO): SBD MOMSN=24227016
2025-03-14T02:07:43.554Z,1741918063.554 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20250314T010808/Express0017.lzma
2025-03-14T02:07:44.555Z,1741918064.555 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Express0017.lzma.bak
2025-03-14T02:07:44.555Z,1741918064.555 [DataOverHttps](INFO): SBD MOMSN=24227019
2025-03-14T02:07:46.020Z,1741918066.020 [Default:CheckIn:Read_Iridium] Stopped
2025-03-14T02:07:46.020Z,1741918066.020 [Default:CheckIn:C.Wait] Running Loop=1
2025-03-14T02:07:46.020Z,1741918066.020 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-03-14T02:07:52.115Z,1741918072.115 [NAL9602](INFO): Not Powering down - fast GPS
2025-03-14T02:12:46.643Z,1741918366.643 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-03-14T02:12:46.643Z,1741918366.643 [Default:CheckIn:C.Wait] Stopped
2025-03-14T02:12:46.644Z,1741918366.644 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-03-14T02:12:46.644Z,1741918366.644 [Default:CheckIn:D] Running Loop=1
2025-03-14T02:12:47.044Z,1741918367.044 [Default:CheckIn:D] Stopped
2025-03-14T02:12:47.044Z,1741918367.044 [Default:CheckIn:E] Running Loop=1
2025-03-14T02:12:47.452Z,1741918367.452 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  5.723841 min 
2025-03-14T02:12:47.452Z,1741918367.452 [Default:CheckIn:E] Stopped
2025-03-14T02:12:47.452Z,1741918367.452 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-03-14T02:12:47.452Z,1741918367.452 [Default:CheckIn] Stopped
2025-03-14T02:12:47.452Z,1741918367.452 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-03-14T02:12:47.453Z,1741918367.453 [Default:CheckIn](INFO): Running loop #2
2025-03-14T02:12:47.453Z,1741918367.453 [Default:CheckIn] Running Loop=2
2025-03-14T02:12:47.453Z,1741918367.453 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-14T02:12:47.453Z,1741918367.453 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-14T02:12:49.470Z,1741918369.470 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,021248.00,A,3647.73560,N,12150.75500,W,0.272,163.91,140325,,,A*7A
2025-03-14T02:12:49.473Z,1741918369.473 [NAL9602](INFO): GPS fix at 20250314T021248: (36.795593, -121.845917)
2025-03-14T02:12:49.483Z,1741918369.483 [Default:CheckIn:Read_GPS] Stopped
2025-03-14T02:12:49.483Z,1741918369.483 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-03-14T02:12:56.624Z,1741918376.624 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20250314T010808/Courier0019.lzma
2025-03-14T02:12:57.627Z,1741918377.627 [DataOverHttps](INFO): Moved sent file to Logs/20250314T010808/Courier0019.lzma.bak
2025-03-14T02:12:57.627Z,1741918377.627 [DataOverHttps](IMPORTANT): SBD MOMSN=24227031, MTMSN=20250314T021255
2025-03-14T02:13:05.173Z,1741918385.173 [DataOverHttps](INFO): Received command: schedule clear;schedule resume;restart logs