2025-02-06T01:00:46.365Z,1738803646.365 [Supervisor](DEBUG): Initializing supervisor.
2025-02-06T01:00:46.369Z,1738803646.369 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-02-06T01:00:46.370Z,1738803646.370 [SyncHandler](INFO): Protected caller Thread ID is 1065
2025-02-06T01:00:46.370Z,1738803646.370 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-02-06T01:00:46.371Z,1738803646.371 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-02-06T01:00:46.371Z,1738803646.371 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1066
2025-02-06T01:00:46.375Z,1738803646.375 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-02-06T01:00:46.392Z,1738803646.392 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-02-06T01:00:46.393Z,1738803646.393 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-02-06T01:00:46.394Z,1738803646.394 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1067
2025-02-06T01:00:46.398Z,1738803646.398 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-02-06T01:00:46.399Z,1738803646.399 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-02-06T01:00:46.399Z,1738803646.399 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1068
2025-02-06T01:00:46.401Z,1738803646.401 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-02-06T01:00:46.402Z,1738803646.402 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-02-06T01:00:46.402Z,1738803646.402 [logger ThreadHandler](INFO): Protected caller Thread ID is 1069
2025-02-06T01:00:46.406Z,1738803646.406 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-02-06T01:00:46.406Z,1738803646.406 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-02-06T01:00:46.408Z,1738803646.408 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-02-06T01:00:46.647Z,1738803646.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-02-06T01:00:46.648Z,1738803646.648 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-02-06T01:00:46.870Z,1738803646.870 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-02-06T01:00:46.871Z,1738803646.871 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-02-06T01:00:46.979Z,1738803646.979 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-02-06T01:00:46.979Z,1738803646.979 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-02-06T01:00:47.173Z,1738803647.173 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-02-06T01:00:47.174Z,1738803647.174 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-02-06T01:00:47.676Z,1738803647.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-02-06T01:00:47.676Z,1738803647.676 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-02-06T01:00:47.797Z,1738803647.797 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-02-06T01:00:47.797Z,1738803647.797 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-02-06T01:00:48.079Z,1738803648.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-02-06T01:00:48.079Z,1738803648.079 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-02-06T01:00:48.301Z,1738803648.301 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-02-06T01:00:48.301Z,1738803648.301 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-02-06T01:00:48.886Z,1738803648.886 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-02-06T01:00:48.887Z,1738803648.887 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-02-06T01:00:49.328Z,1738803649.328 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-02-06T01:00:49.329Z,1738803649.329 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-02-06T01:00:49.422Z,1738803649.422 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-02-06T01:00:49.821Z,1738803649.821 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-02-06T01:00:49.822Z,1738803649.822 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-02-06T01:00:49.975Z,1738803649.975 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-02-06T01:00:49.975Z,1738803649.975 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-02-06T01:00:50.898Z,1738803650.898 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-02-06T01:00:50.899Z,1738803650.899 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-02-06T01:00:51.258Z,1738803651.258 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-02-06T01:00:51.259Z,1738803651.259 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-02-06T01:00:51.355Z,1738803651.355 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/
2025-02-06T01:00:51.356Z,1738803651.356 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg
2025-02-06T01:00:51.460Z,1738803651.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg
2025-02-06T01:00:51.579Z,1738803651.579 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg
2025-02-06T01:00:51.695Z,1738803651.695 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg
2025-02-06T01:00:51.797Z,1738803651.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg
2025-02-06T01:00:51.895Z,1738803651.895 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg
2025-02-06T01:00:52.011Z,1738803652.011 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg
2025-02-06T01:00:52.165Z,1738803652.165 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg
2025-02-06T01:00:52.342Z,1738803652.342 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg
2025-02-06T01:00:52.471Z,1738803652.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg
2025-02-06T01:00:52.749Z,1738803652.749 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-02-06T01:00:52.750Z,1738803652.750 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-02-06T01:00:56.106Z,1738803656.106 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-02-06T01:00:56.489Z,1738803656.489 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-02-06T01:00:56.489Z,1738803656.489 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-02-06T01:00:57.007Z,1738803657.007 [AHRS_M2] Loaded
2025-02-06T01:00:57.008Z,1738803657.008 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-02-06T01:00:57.046Z,1738803657.046 [BackseatComponent] Loaded
2025-02-06T01:00:57.047Z,1738803657.047 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-02-06T01:00:57.048Z,1738803657.048 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408AB4E0
2025-02-06T01:00:57.048Z,1738803657.048 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1148
2025-02-06T01:00:57.051Z,1738803657.051 [LcmUniversalReporter] Loaded
2025-02-06T01:00:57.051Z,1738803657.051 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-02-06T01:00:57.058Z,1738803657.058 [BioacousticsDataBridge] Loaded
2025-02-06T01:00:57.058Z,1738803657.058 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2025-02-06T01:00:57.893Z,1738803657.893 [BPC1] Loaded
2025-02-06T01:00:57.893Z,1738803657.893 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-02-06T01:00:57.967Z,1738803657.967 [DataOverHttps] Loaded
2025-02-06T01:00:57.968Z,1738803657.968 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-02-06T01:00:57.969Z,1738803657.969 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408DB4E0
2025-02-06T01:00:57.969Z,1738803657.969 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1149
2025-02-06T01:00:57.992Z,1738803657.992 [Depth_Keller] Loaded
2025-02-06T01:00:57.992Z,1738803657.992 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-02-06T01:00:57.997Z,1738803657.997 [DropWeight] Loaded
2025-02-06T01:00:57.997Z,1738803657.997 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-02-06T01:00:58.061Z,1738803658.061 [NAL9602] Loaded
2025-02-06T01:00:58.061Z,1738803658.061 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-02-06T01:00:58.090Z,1738803658.090 [Onboard] Loaded
2025-02-06T01:00:58.090Z,1738803658.090 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-02-06T01:00:58.091Z,1738803658.091 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0
2025-02-06T01:00:58.092Z,1738803658.092 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1150
2025-02-06T01:00:58.106Z,1738803658.106 [Power24vConverter] Loaded
2025-02-06T01:00:58.106Z,1738803658.106 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-02-06T01:00:58.123Z,1738803658.123 [Radio_Surface] Loaded
2025-02-06T01:00:58.123Z,1738803658.123 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-02-06T01:00:58.124Z,1738803658.124 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0
2025-02-06T01:00:58.124Z,1738803658.124 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1151
2025-02-06T01:00:58.139Z,1738803658.139 [Sonardyne_Nano] Loaded
2025-02-06T01:00:58.140Z,1738803658.140 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2025-02-06T01:00:58.140Z,1738803658.140 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-02-06T01:00:58.141Z,1738803658.141 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-02-06T01:00:58.280Z,1738803658.280 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-02-06T01:00:58.281Z,1738803658.281 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-02-06T01:00:58.335Z,1738803658.335 [VerticalControl](DEBUG): Construct VerticalControl.
2025-02-06T01:00:58.395Z,1738803658.395 [VerticalControl] Loaded
2025-02-06T01:00:58.395Z,1738803658.395 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-02-06T01:00:58.398Z,1738803658.398 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-02-06T01:00:58.446Z,1738803658.446 [HorizontalControl] Loaded
2025-02-06T01:00:58.446Z,1738803658.446 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-02-06T01:00:58.448Z,1738803658.448 [SpeedControl](DEBUG): Construct SpeedControl.
2025-02-06T01:00:58.452Z,1738803658.452 [SpeedControl] Loaded
2025-02-06T01:00:58.452Z,1738803658.452 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-02-06T01:00:58.455Z,1738803658.455 [LoopControl](DEBUG): Construct LoopControl.
2025-02-06T01:00:58.455Z,1738803658.455 [LoopControl] Loaded
2025-02-06T01:00:58.455Z,1738803658.455 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-02-06T01:00:58.456Z,1738803658.456 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-02-06T01:00:58.456Z,1738803658.456 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-02-06T01:00:58.467Z,1738803658.467 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-02-06T01:00:58.467Z,1738803658.467 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-02-06T01:00:58.494Z,1738803658.494 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-02-06T01:00:58.495Z,1738803658.495 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-02-06T01:00:58.609Z,1738803658.609 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-02-06T01:00:58.610Z,1738803658.610 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-02-06T01:00:58.623Z,1738803658.623 [NavChart] Loaded
2025-02-06T01:00:58.623Z,1738803658.623 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-02-06T01:00:58.629Z,1738803658.629 [UniversalFixResidualReporter] Loaded
2025-02-06T01:00:58.629Z,1738803658.629 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-02-06T01:00:58.630Z,1738803658.630 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-02-06T01:00:58.630Z,1738803658.630 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-02-06T01:00:58.780Z,1738803658.780 [SBIT](DEBUG): Construct Startup Built In Test.
2025-02-06T01:00:58.789Z,1738803658.789 [SBIT] Loaded
2025-02-06T01:00:58.790Z,1738803658.790 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-02-06T01:00:58.792Z,1738803658.792 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-02-06T01:00:58.805Z,1738803658.805 [IBIT] Loaded
2025-02-06T01:00:58.805Z,1738803658.805 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-02-06T01:00:58.811Z,1738803658.811 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-02-06T01:00:58.929Z,1738803658.929 [CBIT] Loaded
2025-02-06T01:00:58.930Z,1738803658.930 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-02-06T01:00:58.930Z,1738803658.930 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-02-06T01:00:58.931Z,1738803658.931 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-02-06T01:00:59.113Z,1738803659.113 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-02-06T01:00:59.114Z,1738803659.114 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-02-06T01:00:59.253Z,1738803659.253 [BuoyancyServo] Loaded
2025-02-06T01:00:59.253Z,1738803659.253 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-02-06T01:00:59.274Z,1738803659.274 [ElevatorServo] Loaded
2025-02-06T01:00:59.274Z,1738803659.274 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-02-06T01:00:59.296Z,1738803659.296 [MassServo] Loaded
2025-02-06T01:00:59.296Z,1738803659.296 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-02-06T01:00:59.317Z,1738803659.317 [RudderServo] Loaded
2025-02-06T01:00:59.317Z,1738803659.317 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-02-06T01:00:59.334Z,1738803659.334 [ThrusterHE] Loaded
2025-02-06T01:00:59.334Z,1738803659.334 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-02-06T01:00:59.335Z,1738803659.335 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-02-06T01:00:59.335Z,1738803659.335 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-02-06T01:00:59.515Z,1738803659.515 [CTD_Seabird] Loaded
2025-02-06T01:00:59.516Z,1738803659.516 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-02-06T01:00:59.517Z,1738803659.517 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B6C4E0
2025-02-06T01:00:59.517Z,1738803659.517 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1152
2025-02-06T01:00:59.540Z,1738803659.540 [PAR_Licor] Loaded
2025-02-06T01:00:59.540Z,1738803659.540 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-02-06T01:00:59.585Z,1738803659.585 [WetLabsBB2FL] Loaded
2025-02-06T01:00:59.585Z,1738803659.585 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-02-06T01:00:59.586Z,1738803659.586 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B9C4E0
2025-02-06T01:00:59.587Z,1738803659.587 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1153
2025-02-06T01:00:59.587Z,1738803659.587 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-02-06T01:00:59.588Z,1738803659.588 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-02-06T01:00:59.640Z,1738803659.640 [DepthRateCalculator] Loaded
2025-02-06T01:00:59.640Z,1738803659.640 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-02-06T01:00:59.645Z,1738803659.645 [PitchRateCalculator] Loaded
2025-02-06T01:00:59.645Z,1738803659.645 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-02-06T01:00:59.654Z,1738803659.654 [SpeedCalculator] Loaded
2025-02-06T01:00:59.655Z,1738803659.655 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-02-06T01:00:59.659Z,1738803659.659 [YawRateCalculator] Loaded
2025-02-06T01:00:59.659Z,1738803659.659 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-02-06T01:00:59.679Z,1738803659.679 [ElevatorOffsetCalculator] Loaded
2025-02-06T01:00:59.680Z,1738803659.680 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-02-06T01:00:59.680Z,1738803659.680 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-02-06T01:00:59.681Z,1738803659.681 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-02-06T01:00:59.742Z,1738803659.742 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-02-06T01:00:59.748Z,1738803659.748 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-02-06T01:00:59.751Z,1738803659.751 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-02-06T01:00:59.784Z,1738803659.784 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-02-06T01:00:59.794Z,1738803659.794 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C294E0
2025-02-06T01:00:59.794Z,1738803659.794 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1154
2025-02-06T01:01:06.227Z,1738803666.227 [Supervisor](INFO): Main Thread ID is 827
2025-02-06T01:01:06.227Z,1738803666.227 [Supervisor](DEBUG): Running supervisor.
2025-02-06T01:01:06.227Z,1738803666.227 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1155
2025-02-06T01:01:06.228Z,1738803666.228 [CommandExec](INFO): Initializing the command executive.
2025-02-06T01:01:06.230Z,1738803666.230 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1156
2025-02-06T01:01:06.232Z,1738803666.232 [controlThread ThreadHandler](INFO): Handler Thread ID is 1157
2025-02-06T01:01:06.233Z,1738803666.233 [controlThread](DEBUG): Initializing ControlThread
2025-02-06T01:01:06.238Z,1738803666.238 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-02-06T01:01:06.239Z,1738803666.239 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-02-06T01:01:06.240Z,1738803666.240 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-02-06T01:01:06.241Z,1738803666.241 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-02-06T01:01:06.241Z,1738803666.241 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-02-06T01:01:06.242Z,1738803666.242 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-02-06T01:01:06.242Z,1738803666.242 [SBIT](INFO): Initialize SBIT Component.
2025-02-06T01:01:06.242Z,1738803666.242 [SBIT](IMPORTANT): git: 2025-02-05
2025-02-06T01:01:06.243Z,1738803666.243 [SBIT](INFO): git hash: a4c59949123439bf87ea957d0729f09aa77b2fd6
2025-02-06T01:01:06.243Z,1738803666.243 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-02-06T01:01:06.244Z,1738803666.244 [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 Dec 4 01:17:04 UTC 2024
2025-02-06T01:01:06.245Z,1738803666.245 [SBIT](INFO): Beginning SBIT in 46.000000 seconds.
2025-02-06T01:01:06.246Z,1738803666.246 [IBIT](INFO): Initialize IBIT Component.
2025-02-06T01:01:06.247Z,1738803666.247 [CBIT](DEBUG): Initialize CBIT Component.
2025-02-06T01:01:06.248Z,1738803666.248 [logger ThreadHandler](INFO): Handler Thread ID is 1158
2025-02-06T01:01:06.260Z,1738803666.260 [CBIT](DEBUG): Initialized mux pins.
2025-02-06T01:01:06.260Z,1738803666.260 [CBIT](DEBUG): Initializing the watchdog timer.
2025-02-06T01:01:06.268Z,1738803666.268 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1159
2025-02-06T01:01:06.280Z,1738803666.280 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1160
2025-02-06T01:01:06.282Z,1738803666.282 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-02-06T01:01:06.284Z,1738803666.284 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-02-06T01:01:06.284Z,1738803666.284 [CBIT](DEBUG): Initializing heartbeat.
2025-02-06T01:01:06.296Z,1738803666.296 [Onboard ThreadHandler](INFO): Handler Thread ID is 1161
2025-02-06T01:01:06.329Z,1738803666.329 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1164
2025-02-06T01:01:06.331Z,1738803666.331 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1162
2025-02-06T01:01:06.336Z,1738803666.336 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1163
2025-02-06T01:01:06.336Z,1738803666.336 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-02-06T01:01:06.338Z,1738803666.338 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1166
2025-02-06T01:01:06.341Z,1738803666.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-02-06T01:01:06.341Z,1738803666.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-02-06T01:01:06.341Z,1738803666.341 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-02-06T01:01:06.341Z,1738803666.341 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-02-06T01:01:06.342Z,1738803666.342 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-02-06T01:01:06.342Z,1738803666.342 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-02-06T01:01:06.342Z,1738803666.342 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-02-06T01:01:06.342Z,1738803666.342 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-02-06T01:01:06.356Z,1738803666.356 [CBIT](DEBUG): Deactivating GF circuits.
2025-02-06T01:01:06.356Z,1738803666.356 [CBIT](DEBUG): Deactivating emergency mode.
2025-02-06T01:01:06.360Z,1738803666.360 [WetLabsBB2FL](INFO): Powering up
2025-02-06T01:01:06.396Z,1738803666.396 [CBIT](DEBUG): Backplane powered.
2025-02-06T01:01:06.400Z,1738803666.400 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-02-06T01:01:06.401Z,1738803666.401 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-02-06T01:01:06.401Z,1738803666.401 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-02-06T01:01:06.401Z,1738803666.401 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-02-06T01:01:06.402Z,1738803666.402 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-02-06T01:01:06.403Z,1738803666.403 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-02-06T01:01:06.403Z,1738803666.403 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-02-06T01:01:06.404Z,1738803666.404 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-02-06T01:01:06.405Z,1738803666.405 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-02-06T01:01:06.489Z,1738803666.489 [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-02-06T01:01:06.493Z,1738803666.493 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-06T01:01:06.549Z,1738803666.549 [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-02-06T01:01:06.550Z,1738803666.550 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-02-06T01:01:06.550Z,1738803666.550 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-02-06T01:01:06.551Z,1738803666.551 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-02-06T01:01:06.764Z,1738803666.764 [Radio_Surface](INFO): Powering up
2025-02-06T01:01:06.823Z,1738803666.823 [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-02-06T01:01:06.854Z,1738803666.854 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-02-06T01:01:06.855Z,1738803666.855 [Default:A.Wait](DEBUG): Construct Wait.
2025-02-06T01:01:06.865Z,1738803666.865 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-06T01:01:06.886Z,1738803666.886 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-02-06T01:01:06.913Z,1738803666.913 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-02-06T01:01:06.919Z,1738803666.919 [Default:E.Execute](DEBUG): Construct Execute.
2025-02-06T01:01:06.934Z,1738803666.934 [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-02-06T01:01:06.939Z,1738803666.939 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,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,LcmUniversalReporter,Reporter,LogSplitter,
2025-02-06T01:01:06.965Z,1738803666.965 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-02-06T01:01:07.030Z,1738803667.030 [Power24vConverter](INFO): Powering up.
2025-02-06T01:01:07.031Z,1738803667.031 [Sonardyne_Nano](INFO): Initializing.
2025-02-06T01:01:07.118Z,1738803667.118 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-02-06T01:01:07.124Z,1738803667.124 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-02-06T01:01:07.125Z,1738803667.125 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-02-06T01:01:07.132Z,1738803667.132 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-02-06T01:01:07.133Z,1738803667.133 [MassServo](DEBUG): Initializing EZServoServo.
2025-02-06T01:01:07.140Z,1738803667.140 [MassServo](DEBUG): Initializing MassServo.
2025-02-06T01:01:07.141Z,1738803667.141 [RudderServo](DEBUG): Initializing EZServoServo.
2025-02-06T01:01:07.148Z,1738803667.148 [RudderServo](DEBUG): Initializing RudderServo.
2025-02-06T01:01:07.149Z,1738803667.149 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-06T01:01:07.156Z,1738803667.156 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-06T01:01:08.440Z,1738803668.440 [WetLabsBB2FL](INFO): Powering down
2025-02-06T01:01:08.966Z,1738803668.966 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2025-02-06T01:01:10.252Z,1738803670.252 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409
2025-02-06T01:01:12.845Z,1738803672.845 [ThrusterHE](ERROR): Zero Speed Commanded.
2025-02-06T01:01:13.396Z,1738803673.396 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-02-06T01:01:28.361Z,1738803688.361 [NAL9602](INFO): Powering up NAL9602
2025-02-06T01:01:39.274Z,1738803699.274 [NAL9602](INFO): NAL9602 initialized
2025-02-06T01:01:53.019Z,1738803713.019 [SBIT](IMPORTANT): Beginning Startup BIT
2025-02-06T01:01:53.024Z,1738803713.024 [CBIT](IMPORTANT): Beginning ground fault scan
2025-02-06T01:02:03.511Z,1738803723.511 [NAL9602](INFO): SBD MO Status=2, MOMSN=12518, MT Status=2, MTMSN=0
2025-02-06T01:02:03.512Z,1738803723.512 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-06T01:02:04.391Z,1738803724.391 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000311
CHAN A1 (24V): -0.000421
CHAN A2 (12V): 0.000787
CHAN A3 (5V): -0.001977
CHAN B0 (3.3V): -0.001108
CHAN B1 (3.15aV): -0.001285
CHAN B2 (3.15bV): -0.000867
CHAN B3 (GND): -0.002248
OPEN: 0.003923
Full Scale: +/- 1 mA
2025-02-06T01:02:24.955Z,1738803744.955 [NAL9602](INFO): SBD MO Status=0, MOMSN=12518, MT Status=0, MTMSN=0
2025-02-06T01:02:24.955Z,1738803744.955 [NAL9602](INFO): No messages in MT queue
2025-02-06T01:02:47.269Z,1738803767.269 [SBIT](IMPORTANT): SBIT PASSED
2025-02-06T01:02:47.269Z,1738803767.269 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-02-06T01:02:47.271Z,1738803767.271 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2025-02-06T01:02:47.271Z,1738803767.271 [SBIT](IMPORTANT): DATMMP.loadAtStartup=0 bool;

2025-02-06T01:02:47.271Z,1738803767.271 [SBIT](IMPORTANT): DATMMP.simulateHardware=0 bool;

2025-02-06T01:02:47.272Z,1738803767.272 [SBIT](IMPORTANT): Express none platform_roll_angle;

2025-02-06T01:02:47.272Z,1738803767.272 [SBIT](IMPORTANT): SpeedControl.rollOptimum=0.925 meter_per_second;

2025-02-06T01:02:47.272Z,1738803767.272 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=424.293083 cubic_centimeter;

2025-02-06T01:02:47.272Z,1738803767.272 [SBIT](IMPORTANT): VerticalControl.massDefault=6.708742 millimeter;

2025-02-06T01:02:47.678Z,1738803767.678 [MissionManager](IMPORTANT): Started mission Startup
2025-02-06T01:02:47.679Z,1738803767.679 [Startup] Running Loop=1
2025-02-06T01:02:47.679Z,1738803767.679 [Startup](DEBUG): Aggregate::initialize Startup
2025-02-06T01:02:47.684Z,1738803767.684 [Startup:A.GoToSurface] Running Loop=1
2025-02-06T01:02:47.684Z,1738803767.684 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-06T01:02:47.685Z,1738803767.685 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-06T01:02:47.685Z,1738803767.685 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-06T01:02:47.685Z,1738803767.685 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-06T01:02:47.686Z,1738803767.686 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-06T01:02:47.686Z,1738803767.686 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-06T01:02:47.686Z,1738803767.686 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-06T01:02:47.696Z,1738803767.696 [Startup:StartupSatComms] Running Loop=1
2025-02-06T01:02:47.696Z,1738803767.696 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-02-06T01:02:47.697Z,1738803767.697 [Startup:StartupSatComms:A] Running Loop=1
2025-02-06T01:02:48.054Z,1738803768.054 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-02-06T01:03:27.226Z,1738803807.226 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004487
2025-02-06T01:03:47.699Z,1738803827.699 [Startup:StartupSatComms:A](INFO): Timed out from 2025-02-06T01:02:47.7Z
2025-02-06T01:03:47.699Z,1738803827.699 [Startup:StartupSatComms:A] Stopped
2025-02-06T01:03:47.699Z,1738803827.699 [Startup:StartupSatComms:B] Running Loop=1
2025-02-06T01:03:48.103Z,1738803828.103 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-06T01:03:56.439Z,1738803836.439 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T005104/Courier0007.lzma
2025-02-06T01:03:57.442Z,1738803837.442 [DataOverHttps](INFO): Moved sent file to Logs/20250206T005104/Courier0007.lzma.bak
2025-02-06T01:03:57.442Z,1738803837.442 [DataOverHttps](INFO): SBD MOMSN=23957946
2025-02-06T01:04:06.270Z,1738803846.270 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-02-06T01:04:06.271Z,1738803846.271 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-02-06T01:04:06.281Z,1738803846.281 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-02-06T01:04:06.688Z,1738803846.688 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-02-06T01:04:06.689Z,1738803846.689 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-02-06T01:04:13.697Z,1738803853.697 [CommandExec](IMPORTANT): got command failComponent
2025-02-06T01:04:13.697Z,1738803853.697 [CommandExec](IMPORTANT): Failed components:
2025-02-06T01:04:13.697Z,1738803853.697 [CommandExec](IMPORTANT): No failed Components.
2025-02-06T01:04:13.819Z,1738803853.819 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250206T010046/Courier0000.lzma
2025-02-06T01:04:14.822Z,1738803854.822 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0000.lzma.bak
2025-02-06T01:04:14.822Z,1738803854.822 [DataOverHttps](INFO): SBD MOMSN=23957948
2025-02-06T01:04:16.144Z,1738803856.144 [CommandExec](IMPORTANT): got command get latitude
2025-02-06T01:04:16.145Z,1738803856.145 [CommandExec](FAULT): Element has no value
2025-02-06T01:04:30.863Z,1738803870.863 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20250206T005104/Express0008.lzma
2025-02-06T01:04:31.866Z,1738803871.866 [DataOverHttps](INFO): Moved sent file to Logs/20250206T005104/Express0008.lzma.bak
2025-02-06T01:04:31.866Z,1738803871.866 [DataOverHttps](INFO): SBD MOMSN=23957951
2025-02-06T01:04:47.906Z,1738803887.906 [Startup:StartupSatComms:B](INFO): Timed out from 2025-02-06T01:03:47.7Z
2025-02-06T01:04:47.906Z,1738803887.906 [Startup:StartupSatComms:B] Stopped
2025-02-06T01:04:47.906Z,1738803887.906 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-02-06T01:04:47.907Z,1738803887.907 [Startup:StartupSatComms] Stopped
2025-02-06T01:04:47.907Z,1738803887.907 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-02-06T01:04:47.913Z,1738803887.913 [Startup](INFO): Completed Startup
2025-02-06T01:04:47.913Z,1738803887.913 [MissionManager](INFO): Startup is completed.
2025-02-06T01:04:47.913Z,1738803887.913 [MissionManager](INFO): Uninitializing Mission Startup
2025-02-06T01:04:47.913Z,1738803887.913 [Startup] Stopped
2025-02-06T01:04:47.913Z,1738803887.913 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-02-06T01:04:47.913Z,1738803887.913 [Startup:A.GoToSurface] Stopped
2025-02-06T01:04:47.913Z,1738803887.913 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-06T01:04:48.286Z,1738803888.286 [MissionManager](IMPORTANT): Started mission Default
2025-02-06T01:04:48.286Z,1738803888.286 [Default] Running Loop=1
2025-02-06T01:04:48.286Z,1738803888.286 [Default](DEBUG): Aggregate::initialize Default
2025-02-06T01:04:48.286Z,1738803888.286 [Default:B.GoToSurface] Running Loop=1
2025-02-06T01:04:48.286Z,1738803888.286 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-06T01:04:48.287Z,1738803888.287 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-06T01:04:48.287Z,1738803888.287 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-06T01:04:48.287Z,1738803888.287 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-06T01:04:48.288Z,1738803888.288 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-06T01:04:48.288Z,1738803888.288 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-06T01:04:48.291Z,1738803888.291 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-06T01:04:48.291Z,1738803888.291 [Default:A.Wait] Running Loop=1
2025-02-06T01:04:48.291Z,1738803888.291 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-06T01:04:49.169Z,1738803889.169 [DataOverHttps](INFO): Sending 821 bytes from file Logs/20250206T010046/Express0001.lzma
2025-02-06T01:04:50.169Z,1738803890.169 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0001.lzma.bak
2025-02-06T01:04:50.170Z,1738803890.170 [DataOverHttps](INFO): SBD MOMSN=23957955
2025-02-06T01:05:01.628Z,1738803901.628 [Default:A.Wait](INFO): Done Waiting.
2025-02-06T01:05:01.628Z,1738803901.628 [Default:A.Wait] Stopped
2025-02-06T01:05:01.628Z,1738803901.628 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-06T01:05:02.047Z,1738803902.047 [Default:CheckIn] Running Loop=1
2025-02-06T01:05:02.047Z,1738803902.047 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-06T01:05:02.047Z,1738803902.047 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-06T01:05:02.443Z,1738803902.443 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-06T01:05:11.819Z,1738803911.819 [CommandExec](IMPORTANT): got command ibit
2025-02-06T01:05:12.133Z,1738803912.133 [IBIT](IMPORTANT): Beginning Initiated BIT
2025-02-06T01:05:12.133Z,1738803912.133 [IBIT](IMPORTANT): Beginning control surface checks.
2025-02-06T01:05:12.136Z,1738803912.136 [CBIT](IMPORTANT): Beginning ground fault scan
2025-02-06T01:05:23.064Z,1738803923.064 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000505
CHAN A1 (24V): -0.000274
CHAN A2 (12V): 0.000781
CHAN A3 (5V): -0.001953
CHAN B0 (3.3V): -0.001002
CHAN B1 (3.15aV): -0.000817
CHAN B2 (3.15bV): -0.001534
CHAN B3 (GND): -0.001766
OPEN: 0.003916
Full Scale: +/- 1 mA
2025-02-06T01:05:31.912Z,1738803931.912 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010528.00,A,3647.07527,N,12149.86596,W,1.516,272.96,060225,,,A*70
2025-02-06T01:05:31.915Z,1738803931.915 [NAL9602](INFO): GPS fix at 20250206T010528: (36.784588, -121.831099)
2025-02-06T01:05:34.747Z,1738803934.747 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010531.00,A,3647.07484,N,12149.86499,W,0.855,244.25,060225,,,A*78
2025-02-06T01:05:34.757Z,1738803934.757 [NAL9602](INFO): GPS fix at 20250206T010531: (36.784581, -121.831083)
2025-02-06T01:05:37.983Z,1738803937.983 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010534.00,A,3647.07481,N,12149.86541,W,0.603,244.25,060225,,,A*71
2025-02-06T01:05:37.994Z,1738803937.994 [NAL9602](INFO): GPS fix at 20250206T010534: (36.784580, -121.831090)
2025-02-06T01:05:40.809Z,1738803940.809 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010537.00,A,3647.07403,N,12149.86526,W,0.097,188.68,060225,,,A*78
2025-02-06T01:05:40.811Z,1738803940.811 [NAL9602](INFO): GPS fix at 20250206T010537: (36.784567, -121.831088)
2025-02-06T01:05:44.071Z,1738803944.071 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010540.00,A,3647.07337,N,12149.86526,W,0.350,169.81,060225,,,A*78
2025-02-06T01:05:44.093Z,1738803944.093 [NAL9602](INFO): GPS fix at 20250206T010540: (36.784556, -121.831088)
2025-02-06T01:05:46.875Z,1738803946.875 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010543.00,A,3647.07257,N,12149.86467,W,1.225,152.69,060225,,,A*74
2025-02-06T01:05:46.882Z,1738803946.882 [NAL9602](INFO): GPS fix at 20250206T010543: (36.784543, -121.831078)
2025-02-06T01:05:50.123Z,1738803950.123 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010546.00,A,3647.07224,N,12149.86465,W,0.641,157.44,060225,,,A*7A
2025-02-06T01:05:50.125Z,1738803950.125 [NAL9602](INFO): GPS fix at 20250206T010546: (36.784537, -121.831078)
2025-02-06T01:05:52.931Z,1738803952.931 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010549.00,A,3647.07176,N,12149.86442,W,1.244,144.36,060225,,,A*73
2025-02-06T01:05:52.933Z,1738803952.933 [NAL9602](INFO): GPS fix at 20250206T010549: (36.784529, -121.831074)
2025-02-06T01:05:55.755Z,1738803955.755 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010552.00,A,3647.07124,N,12149.86425,W,0.408,144.36,060225,,,A*70
2025-02-06T01:05:55.757Z,1738803955.757 [NAL9602](INFO): GPS fix at 20250206T010552: (36.784521, -121.831071)
2025-02-06T01:05:58.234Z,1738803958.234 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 36.784519 Longitude: -121.831070
2025-02-06T01:05:58.646Z,1738803958.646 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2025-02-06T01:05:58.987Z,1738803958.987 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010555.00,A,3647.07082,N,12149.86419,W,0.816,144.36,060225,,,A*76
2025-02-06T01:05:58.997Z,1738803958.997 [NAL9602](INFO): GPS fix at 20250206T010555: (36.784514, -121.831070)
2025-02-06T01:05:59.018Z,1738803959.018 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2025-02-06T01:05:59.018Z,1738803959.018 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2025-02-06T01:05:59.019Z,1738803959.019 [IBIT](IMPORTANT): Pressure:9.493982 PSI
2025-02-06T01:05:59.019Z,1738803959.019 [IBIT](IMPORTANT): Humidity:11.543158 %
2025-02-06T01:05:59.433Z,1738803959.433 [IBIT](IMPORTANT): Vehicle Pitch:-4.187039 degrees
2025-02-06T01:05:59.433Z,1738803959.433 [IBIT](IMPORTANT): Vehicle  Roll:17.063799 degrees
2025-02-06T01:05:59.433Z,1738803959.433 [IBIT](IMPORTANT): Vehicle  Heading:330.090881 degrees
2025-02-06T01:05:59.847Z,1738803959.847 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2025-02-06T01:05:59.847Z,1738803959.847 [IBIT](IMPORTANT): buoyancyNeutral: 424.293091 cc
2025-02-06T01:05:59.856Z,1738803959.856 [IBIT](IMPORTANT): massDefault: 0.670874 cm
2025-02-06T01:05:59.857Z,1738803959.857 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2025-02-06T01:05:59.857Z,1738803959.857 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2025-02-06T01:05:59.857Z,1738803959.857 [IBIT](IMPORTANT): IBIT PASSED
2025-02-06T01:06:00.262Z,1738803960.262 [Default:CheckIn:Read_GPS] Stopped
2025-02-06T01:06:00.262Z,1738803960.262 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-06T01:06:00.653Z,1738803960.653 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-06T01:06:00.946Z,1738803960.946 [DataOverHttps](IMPORTANT): SBD MTMSN=20250206T010559
2025-02-06T01:06:10.388Z,1738803970.388 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20250206T010046/Courier0004.lzma
2025-02-06T01:06:10.391Z,1738803970.391 [DataOverHttps](INFO): Received command: schedule resume
2025-02-06T01:06:10.430Z,1738803970.430 [CommandExec](IMPORTANT): got command schedule resume
2025-02-06T01:06:11.674Z,1738803971.674 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0004.lzma.bak
2025-02-06T01:06:11.674Z,1738803971.674 [DataOverHttps](INFO): SBD MOMSN=23957976
2025-02-06T01:06:28.828Z,1738803988.828 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0007.lzma
2025-02-06T01:06:29.838Z,1738803989.838 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0007.lzma.bak
2025-02-06T01:06:29.838Z,1738803989.838 [DataOverHttps](INFO): SBD MOMSN=23957980
2025-02-06T01:06:31.373Z,1738803991.373 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-06T01:06:48.510Z,1738804008.510 [DataOverHttps](INFO): Sending 941 bytes from file Logs/20250206T010046/Express0005.lzma
2025-02-06T01:06:50.172Z,1738804010.172 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0005.lzma.bak
2025-02-06T01:06:50.173Z,1738804010.173 [DataOverHttps](IMPORTANT): SBD MOMSN=23957984, MTMSN=20250206T010648
2025-02-06T01:06:58.304Z,1738804018.304 [DataOverHttps](INFO): Received command: sched asap "load Transport/transit.tl;set transit.MissionTimeout 60 min;set transit.NeedCommsTime 30 min;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Speed 1.4 m/s;set transit.MaxDepth 20 m" 1adr4 1 2
2025-02-06T01:06:58.357Z,1738804018.357 [CommandExec](IMPORTANT): got command schedule asap "load Transport/transit.tl;set transit.MissionTimeout 60 min;set transit.NeedCommsTime 30 min;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Speed 1.4 m/s;set transit.MaxDepth 20 m" 1adr4 1 2.000000
2025-02-06T01:06:58.357Z,1738804018.357 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=1adr4
2025-02-06T01:06:58.358Z,1738804018.358 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='1adr4'): "load Transport/transit.tl;set transit.MissionTimeout 60 min;set transit.NeedCommsTime 30 min;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Speed 1.4 m/s;set transit.MaxDepth 20 m", ASAP
2025-02-06T01:06:59.501Z,1738804019.501 [DataOverHttps](IMPORTANT): SBD MTMSN=20250206T010658
2025-02-06T01:07:10.563Z,1738804030.563 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20250206T010046/Express0006.lzma
2025-02-06T01:07:10.566Z,1738804030.566 [DataOverHttps](INFO): Received command: sched asap "set transit.MinOffshore 1 km;run" 1adr4 2 2
2025-02-06T01:07:10.595Z,1738804030.595 [CommandExec](IMPORTANT): got command schedule asap "set transit.MinOffshore 1 km;run" 1adr4 2 2.000000
2025-02-06T01:07:10.595Z,1738804030.595 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=1adr4
2025-02-06T01:07:10.596Z,1738804030.596 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='1adr4'): "set transit.MinOffshore 1 km;run", ASAP
2025-02-06T01:07:11.967Z,1738804031.967 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0006.lzma.bak
2025-02-06T01:07:11.980Z,1738804031.980 [DataOverHttps](INFO): SBD MOMSN=23958013
2025-02-06T01:07:12.302Z,1738804032.302 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2025-02-06T01:07:12.303Z,1738804032.303 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2025-02-06T01:07:12.303Z,1738804032.303 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/transit.tl
2025-02-06T01:07:12.310Z,1738804032.310 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/transit.tl
2025-02-06T01:07:14.435Z,1738804034.435 [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-02-06T01:07:14.449Z,1738804034.449 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2025-02-06T01:07:14.484Z,1738804034.484 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2025-02-06T01:07:14.487Z,1738804034.487 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2025-02-06T01:07:14.498Z,1738804034.498 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2025-02-06T01:07:14.529Z,1738804034.529 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2025-02-06T01:07:14.545Z,1738804034.545 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2025-02-06T01:07:14.547Z,1738804034.547 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2025-02-06T01:07:14.571Z,1738804034.571 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2025-02-06T01:07:14.575Z,1738804034.575 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2025-02-06T01:07:14.654Z,1738804034.654 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2025-02-06T01:07:14.665Z,1738804034.665 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2025-02-06T01:07:14.736Z,1738804034.736 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2025-02-06T01:07:14.739Z,1738804034.739 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2025-02-06T01:07:14.739Z,1738804034.739 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-02-06T01:07:14.760Z,1738804034.760 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-02-06T01:07:14.761Z,1738804034.761 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-02-06T01:07:15.713Z,1738804035.713 [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-02-06T01:07:15.783Z,1738804035.783 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 1.000000 h
2025-02-06T01:07:15.791Z,1738804035.791 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2025-02-06T01:07:15.856Z,1738804035.856 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-02-06T01:07:15.859Z,1738804035.859 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2025-02-06T01:07:15.870Z,1738804035.870 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-02-06T01:07:15.881Z,1738804035.881 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2025-02-06T01:07:15.940Z,1738804035.940 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2025-02-06T01:07:15.943Z,1738804035.943 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2025-02-06T01:07:15.991Z,1738804035.991 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-06T01:07:16.115Z,1738804036.115 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-02-06T01:07:16.115Z,1738804036.115 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-02-06T01:07:16.140Z,1738804036.140 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-02-06T01:07:16.391Z,1738804036.391 [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-02-06T01:07:16.423Z,1738804036.423 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2025-02-06T01:07:16.426Z,1738804036.426 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-02-06T01:07:16.456Z,1738804036.456 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2025-02-06T01:07:16.459Z,1738804036.459 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-02-06T01:07:16.460Z,1738804036.460 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-02-06T01:07:16.508Z,1738804036.508 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-02-06T01:07:16.549Z,1738804036.549 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-02-06T01:07:16.594Z,1738804036.594 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-02-06T01:07:16.594Z,1738804036.594 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-02-06T01:07:16.595Z,1738804036.595 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-02-06T01:07:16.743Z,1738804036.743 [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-02-06T01:07:16.763Z,1738804036.763 [MissionManager](INFO): DefineArg transit:BackseatDriver.EnableBackseat = 0 bool
2025-02-06T01:07:16.782Z,1738804036.782 [transit:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-02-06T01:07:16.802Z,1738804036.802 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-02-06T01:07:16.802Z,1738804036.802 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-02-06T01:07:16.803Z,1738804036.803 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-02-06T01:07:17.234Z,1738804037.234 [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-02-06T01:07:17.262Z,1738804037.262 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleAll = 0 bool
2025-02-06T01:07:17.264Z,1738804037.264 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad1 = 0 bool
2025-02-06T01:07:17.267Z,1738804037.267 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad2 = 0 bool
2025-02-06T01:07:17.294Z,1738804037.294 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad3 = 0 bool
2025-02-06T01:07:17.297Z,1738804037.297 [MissionManager](INFO): DefineArg transit:PowerOnly.EnabledPowerOnly = 0 bool
2025-02-06T01:07:17.328Z,1738804037.328 [transit:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-02-06T01:07:17.330Z,1738804037.330 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2025-02-06T01:07:17.358Z,1738804037.358 [transit:MassHold.Pitch](DEBUG): Construct.
2025-02-06T01:07:17.393Z,1738804037.393 [transit:Transit:A.Pitch](DEBUG): Construct.
2025-02-06T01:07:17.399Z,1738804037.399 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2025-02-06T01:07:17.426Z,1738804037.426 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-02-06T01:07:17.518Z,1738804037.518 [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-02-06T01:07:17.519Z,1738804037.519 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl id=transit
2025-02-06T01:07:27.494Z,1738804047.494 [DataOverHttps](IMPORTANT): SBD MTMSN=20250206T010726
2025-02-06T01:07:40.117Z,1738804060.117 [CommandExec](IMPORTANT): got command set transit.MissionTimeout 60 minute
2025-02-06T01:07:40.118Z,1738804060.118 [CommandExec](IMPORTANT): got command set transit.NeedCommsTime 30 minute
2025-02-06T01:07:40.119Z,1738804060.119 [CommandExec](IMPORTANT): got command set transit.Latitude 36.797 degree
2025-02-06T01:07:40.120Z,1738804060.120 [CommandExec](IMPORTANT): got command set transit.Longitude -121.847 degree
2025-02-06T01:07:40.120Z,1738804060.120 [CommandExec](IMPORTANT): got command set transit.Speed 1.4 meter_per_second
2025-02-06T01:07:40.121Z,1738804060.121 [CommandExec](IMPORTANT): got command set transit.MaxDepth 20 meter
2025-02-06T01:07:40.515Z,1738804060.515 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0010.lzma
2025-02-06T01:07:40.517Z,1738804060.517 [DataOverHttps](INFO): Received command: sched "run Maintenance/ballast_and_trim.tl"
2025-02-06T01:07:41.964Z,1738804061.964 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0010.lzma.bak
2025-02-06T01:07:41.964Z,1738804061.964 [DataOverHttps](INFO): SBD MOMSN=23958018
2025-02-06T01:07:43.110Z,1738804063.110 [CommandExec](IMPORTANT): got command set transit.MinOffshore 1 kilometer
2025-02-06T01:07:43.110Z,1738804063.110 [CommandExec](IMPORTANT): got command run
2025-02-06T01:07:43.112Z,1738804063.112 [CommandExec](IMPORTANT): Running 
2025-02-06T01:07:43.116Z,1738804063.116 [CommandExec](IMPORTANT): got command schedule "run Maintenance/ballast_and_trim.tl"
2025-02-06T01:07:43.117Z,1738804063.117 [CommandExec](IMPORTANT): Scheduled #3: "run Maintenance/ballast_and_trim.tl", AFTER MISSION
2025-02-06T01:07:43.403Z,1738804063.403 [Default] Stopped
2025-02-06T01:07:43.403Z,1738804063.403 [Default](DEBUG): Aggregate::uninitialize Default
2025-02-06T01:07:43.403Z,1738804063.403 [Default:B.GoToSurface] Stopped
2025-02-06T01:07:43.403Z,1738804063.403 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-06T01:07:43.403Z,1738804063.403 [Default:CheckIn] Stopped
2025-02-06T01:07:43.403Z,1738804063.403 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-06T01:07:43.403Z,1738804063.403 [Default:CheckIn:Read_Iridium] Stopped
2025-02-06T01:07:43.404Z,1738804063.404 [MissionManager](IMPORTANT): Started mission transit
2025-02-06T01:07:43.404Z,1738804063.404 [transit] Running Loop=1
2025-02-06T01:07:43.404Z,1738804063.404 [transit](DEBUG): Aggregate::initialize transit
2025-02-06T01:07:43.404Z,1738804063.404 [transit:StandardEnvelopes] Running Loop=1
2025-02-06T01:07:43.404Z,1738804063.404 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2025-02-06T01:07:43.404Z,1738804063.404 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-06T01:07:43.405Z,1738804063.405 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-02-06T01:07:43.405Z,1738804063.405 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-06T01:07:43.405Z,1738804063.405 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-02-06T01:07:43.405Z,1738804063.405 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-06T01:07:43.405Z,1738804063.405 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-02-06T01:07:43.405Z,1738804063.405 [transit:BackseatDriver] Running Loop=1
2025-02-06T01:07:43.405Z,1738804063.405 [transit:BackseatDriver](DEBUG): Aggregate::initialize transit:BackseatDriver
2025-02-06T01:07:43.406Z,1738804063.406 [transit:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly](DEBUG): Aggregate::initialize transit:PowerOnly
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly:A] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly:B] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly:C] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly:D] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly:E.Wait] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-02-06T01:07:43.406Z,1738804063.406 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-06T01:07:43.406Z,1738804063.406 [transit:MassHold.Pitch] Running Loop=1
2025-02-06T01:07:43.406Z,1738804063.406 [transit:MassHold.Pitch](DEBUG): Initialize.
2025-02-06T01:07:43.407Z,1738804063.407 [transit:B] Running Loop=1
2025-02-06T01:07:43.407Z,1738804063.407 [transit:MassHold.Pitch] Running Loop=1
2025-02-06T01:07:43.432Z,1738804063.432 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-06T01:07:43.432Z,1738804063.432 [transit:PowerOnly] Running Loop=1
2025-02-06T01:07:43.433Z,1738804063.433 [transit:PowerOnly:D] Stopped
2025-02-06T01:07:43.433Z,1738804063.433 [transit:PowerOnly:C] Stopped
2025-02-06T01:07:43.433Z,1738804063.433 [transit:PowerOnly:B] Stopped
2025-02-06T01:07:43.433Z,1738804063.433 [transit:PowerOnly:A] Stopped
2025-02-06T01:07:43.433Z,1738804063.433 [transit:BackseatDriver] Running Loop=1
2025-02-06T01:07:43.433Z,1738804063.433 [transit:StandardEnvelopes] Running Loop=1
2025-02-06T01:07:43.433Z,1738804063.433 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-06T01:07:43.434Z,1738804063.434 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-06T01:07:43.434Z,1738804063.434 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-06T01:07:43.435Z,1738804063.435 [transit:B] Stopped
2025-02-06T01:07:43.435Z,1738804063.435 [transit:C] Running Loop=1
2025-02-06T01:07:43.819Z,1738804063.819 [transit:C] Stopped
2025-02-06T01:07:43.819Z,1738804063.819 [transit:E] Running Loop=1
2025-02-06T01:07:44.224Z,1738804064.224 [transit:E] Stopped
2025-02-06T01:07:44.224Z,1738804064.224 [transit:F] Running Loop=1
2025-02-06T01:07:44.643Z,1738804064.643 [transit:F] Stopped
2025-02-06T01:07:44.643Z,1738804064.643 [transit:G] Running Loop=1
2025-02-06T01:07:45.041Z,1738804065.041 [transit:G] Stopped
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit] Running Loop=1
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit:A.Pitch] Running Loop=1
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit:A.Pitch](DEBUG): Initialize.
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit:B.SetSpeed] Running Loop=1
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2025-02-06T01:07:45.042Z,1738804065.042 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2025-02-06T01:07:45.043Z,1738804065.043 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-06T01:07:45.057Z,1738804065.057 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2025-02-06T01:07:45.058Z,1738804065.058 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2025-02-06T01:07:45.478Z,1738804065.478 [transit:Transit:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000
2025-02-06T01:07:45.478Z,1738804065.478 [transit:Transit:B.SetSpeed] Running Loop=1
2025-02-06T01:07:45.479Z,1738804065.479 [transit:Transit:A.Pitch] Running Loop=1
2025-02-06T01:07:45.530Z,1738804065.530 [HorizontalControl](DEBUG): kpHeading = 0.400000
2025-02-06T01:07:45.530Z,1738804065.530 [HorizontalControl](DEBUG): kiHeading = 0.001000
2025-02-06T01:07:45.531Z,1738804065.531 [HorizontalControl](DEBUG): kdHeading = 0.050000
2025-02-06T01:07:50.244Z,1738804070.244 [ThrusterHE](FAULT): Could not get status:serial timeout
2025-02-06T01:07:51.407Z,1738804071.407 [DataOverHttps](IMPORTANT): SBD MTMSN=20250206T010750
2025-02-06T01:07:52.784Z,1738804072.784 [ThrusterHE](FAULT): Could not get status:serial timeout
2025-02-06T01:07:56.616Z,1738804076.616 [ThrusterHE](FAULT): Could not get status:serial timeout
2025-02-06T01:08:01.151Z,1738804081.151 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0013.lzma
2025-02-06T01:08:01.154Z,1738804081.154 [DataOverHttps](INFO): Received command: sched "run Maintenance/calibrate_sparton_compass.tl"
2025-02-06T01:08:01.196Z,1738804081.196 [CommandExec](IMPORTANT): got command schedule "run Maintenance/calibrate_sparton_compass.tl"
2025-02-06T01:08:01.197Z,1738804081.197 [CommandExec](IMPORTANT): Scheduled #4: "run Maintenance/calibrate_sparton_compass.tl", AFTER MISSION
2025-02-06T01:08:02.154Z,1738804082.154 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0013.lzma.bak
2025-02-06T01:08:02.154Z,1738804082.154 [DataOverHttps](INFO): SBD MOMSN=23958022
2025-02-06T01:08:03.148Z,1738804083.148 [ThrusterHE](FAULT): Could not get status:serial timeout
2025-02-06T01:08:04.938Z,1738804084.938 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000
2025-02-06T01:08:04.938Z,1738804084.938 [transit:Transit:Wpt1.Waypoint] Stopped
2025-02-06T01:08:04.938Z,1738804084.938 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-06T01:08:04.938Z,1738804084.938 [transit:Transit:PhoneHome] Running Loop=1
2025-02-06T01:08:04.938Z,1738804084.938 [transit:Transit:PhoneHome](DEBUG): Aggregate::initialize transit:Transit:PhoneHome
2025-02-06T01:08:05.347Z,1738804085.347 [transit:NeedComms] Running Loop=1
2025-02-06T01:08:05.347Z,1738804085.347 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2025-02-06T01:08:05.347Z,1738804085.347 [transit:NeedComms:B.GoToSurface] Running Loop=1
2025-02-06T01:08:05.348Z,1738804085.348 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-06T01:08:05.352Z,1738804085.352 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-02-06T01:08:05.353Z,1738804085.353 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-02-06T01:08:05.353Z,1738804085.353 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-02-06T01:08:05.353Z,1738804085.353 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-02-06T01:08:05.354Z,1738804085.354 [transit:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-06T01:08:05.354Z,1738804085.354 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-06T01:08:05.354Z,1738804085.354 [transit:NeedComms:A] Running Loop=1
2025-02-06T01:08:05.355Z,1738804085.355 [transit:NeedComms:A](INFO): last time_fix was:  1738803955.000000 second since 1970/01/01T00:00:00Z 
2025-02-06T01:08:05.356Z,1738804085.356 [transit:NeedComms:A] Stopped
2025-02-06T01:08:05.755Z,1738804085.755 [transit:NeedComms:C] Running Loop=1
2025-02-06T01:08:06.195Z,1738804086.195 [transit:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-06T01:08:07.787Z,1738804087.787 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010804.00,A,3647.05571,N,12149.86380,W,1.030,300.02,060225,,,A*7B
2025-02-06T01:08:07.805Z,1738804087.805 [NAL9602](INFO): GPS fix at 20250206T010804: (36.784262, -121.831063)
2025-02-06T01:08:07.827Z,1738804087.827 [UniversalFixResidualReporter](INFO): Fix residual: 98.7 %DT, over the last 2147.6 m. Residual distance 2119.6 m at bearing -59.6 degrees. Fix at (36.7843, -121.8311) with 28.0 m made good.
2025-02-06T01:08:07.830Z,1738804087.830 [transit:NeedComms:C] Stopped
2025-02-06T01:08:07.830Z,1738804087.830 [transit:NeedComms:D] Running Loop=1
2025-02-06T01:08:08.264Z,1738804088.264 [transit:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-06T01:08:21.711Z,1738804101.711 [NAL9602](INFO): SBD MO Status=0, MOMSN=12519, MT Status=0, MTMSN=0
2025-02-06T01:08:21.711Z,1738804101.711 [NAL9602](INFO): No messages in MT queue
2025-02-06T01:08:27.411Z,1738804107.411 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0016.lzma
2025-02-06T01:08:28.414Z,1738804108.414 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0016.lzma.bak
2025-02-06T01:08:28.414Z,1738804108.414 [DataOverHttps](INFO): SBD MOMSN=23958025
2025-02-06T01:08:47.257Z,1738804127.257 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20250206T010046/Courier0019.lzma
2025-02-06T01:08:48.258Z,1738804128.258 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0019.lzma.bak
2025-02-06T01:08:48.258Z,1738804128.258 [DataOverHttps](INFO): SBD MOMSN=23958027
2025-02-06T01:08:52.425Z,1738804132.425 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-06T01:08:56.677Z,1738804136.677 [CommandExec](IMPORTANT): got command show stack
2025-02-06T01:08:56.678Z,1738804136.678 [CommandExec](IMPORTANT): Behavior Stack:

2025-02-06T01:08:56.678Z,1738804136.678 [transit:NeedComms](IMPORTANT): Priority 0: transit:NeedComms:B.GoToSurface
2025-02-06T01:08:56.678Z,1738804136.678 [transit:NeedComms](IMPORTANT): Priority 1: transit:NeedComms:D
2025-02-06T01:08:56.679Z,1738804136.679 [transit:StandardEnvelopes](IMPORTANT): Priority 2: transit:StandardEnvelopes:A.AltitudeEnvelope
2025-02-06T01:08:56.679Z,1738804136.679 [transit:StandardEnvelopes](IMPORTANT): Priority 3: transit:StandardEnvelopes:B.DepthEnvelope
2025-02-06T01:08:56.679Z,1738804136.679 [transit:StandardEnvelopes](IMPORTANT): Priority 4: transit:StandardEnvelopes:C.OffshoreEnvelope
2025-02-06T01:08:56.679Z,1738804136.679 [transit:BackseatDriver](IMPORTANT): Priority 5: transit:BackseatDriver:A.BackseatDriver
2025-02-06T01:08:56.680Z,1738804136.680 [transit:PowerOnly](IMPORTANT): Priority 6: transit:PowerOnly:E.Wait
2025-02-06T01:08:56.680Z,1738804136.680 [transit](IMPORTANT): Priority 7: transit:BuoyancyHold.Buoyancy
2025-02-06T01:08:56.680Z,1738804136.680 [transit](IMPORTANT): Priority 8: transit:MassHold.Pitch
2025-02-06T01:08:56.681Z,1738804136.681 [transit:Transit](IMPORTANT): Priority 9: transit:Transit:A.Pitch
2025-02-06T01:08:56.681Z,1738804136.681 [transit:Transit](IMPORTANT): Priority 10: transit:Transit:B.SetSpeed
2025-02-06T01:08:57.215Z,1738804137.215 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-02-06T01:09:10.228Z,1738804150.228 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20250206T010046/Express0008.lzma
2025-02-06T01:09:11.232Z,1738804151.232 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0008.lzma.bak
2025-02-06T01:09:11.232Z,1738804151.232 [DataOverHttps](INFO): SBD MOMSN=23958031
2025-02-06T01:09:24.685Z,1738804164.685 [CommandExec](IMPORTANT): got command get platform_buoyancy_position
2025-02-06T01:09:24.685Z,1738804164.685 [CommandExec](IMPORTANT): platform_buoyancy_position 900.605774 cc
2025-02-06T01:09:30.783Z,1738804170.783 [CommandExec](IMPORTANT): got command get platform_buoyancy_position
2025-02-06T01:09:30.800Z,1738804170.800 [CommandExec](IMPORTANT): platform_buoyancy_position 900.605774 cc
2025-02-06T01:09:33.901Z,1738804173.901 [CommandExec](IMPORTANT): got command stop
2025-02-06T01:09:33.901Z,1738804173.901 [CommandExec](IMPORTANT): Scheduling is paused for 2 commands
2025-02-06T01:09:33.901Z,1738804173.901 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-02-06T01:09:34.230Z,1738804174.230 [MissionManager](INFO): MissionManager is completed.
2025-02-06T01:09:34.231Z,1738804174.231 [MissionManager](INFO): Uninitializing Mission transit
2025-02-06T01:09:34.231Z,1738804174.231 [transit] Stopped
2025-02-06T01:09:34.231Z,1738804174.231 [transit](DEBUG): Aggregate::uninitialize transit
2025-02-06T01:09:34.231Z,1738804174.231 [transit:NeedComms] Stopped
2025-02-06T01:09:34.231Z,1738804174.231 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2025-02-06T01:09:34.231Z,1738804174.231 [transit:NeedComms:B.GoToSurface] Stopped
2025-02-06T01:09:34.231Z,1738804174.231 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-06T01:09:34.231Z,1738804174.231 [transit:NeedComms:D] Stopped
2025-02-06T01:09:34.231Z,1738804174.231 [transit:StandardEnvelopes] Stopped
2025-02-06T01:09:34.231Z,1738804174.231 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2025-02-06T01:09:34.231Z,1738804174.231 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-02-06T01:09:34.231Z,1738804174.231 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-02-06T01:09:34.231Z,1738804174.231 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-02-06T01:09:34.236Z,1738804174.236 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-02-06T01:09:34.236Z,1738804174.236 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-02-06T01:09:34.236Z,1738804174.236 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-02-06T01:09:34.236Z,1738804174.236 [transit:BackseatDriver] Stopped
2025-02-06T01:09:34.236Z,1738804174.236 [transit:BackseatDriver](DEBUG): Aggregate::uninitialize transit:BackseatDriver
2025-02-06T01:09:34.236Z,1738804174.236 [transit:BackseatDriver:A.BackseatDriver] Stopped
2025-02-06T01:09:34.236Z,1738804174.236 [transit:PowerOnly] Stopped
2025-02-06T01:09:34.236Z,1738804174.236 [transit:PowerOnly](DEBUG): Aggregate::uninitialize transit:PowerOnly
2025-02-06T01:09:34.236Z,1738804174.236 [transit:PowerOnly:E.Wait] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-02-06T01:09:34.237Z,1738804174.237 [transit:BuoyancyHold.Buoyancy] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-06T01:09:34.237Z,1738804174.237 [transit:MassHold.Pitch] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit:A.Pitch] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit:B.SetSpeed] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit:PhoneHome] Stopped
2025-02-06T01:09:34.237Z,1738804174.237 [transit:Transit:PhoneHome](DEBUG): Aggregate::uninitialize transit:Transit:PhoneHome
2025-02-06T01:09:34.595Z,1738804174.595 [MissionManager](IMPORTANT): Started mission Default
2025-02-06T01:09:34.595Z,1738804174.595 [Default] Running Loop=1
2025-02-06T01:09:34.595Z,1738804174.595 [Default](DEBUG): Aggregate::initialize Default
2025-02-06T01:09:34.595Z,1738804174.595 [Default:B.GoToSurface] Running Loop=1
2025-02-06T01:09:34.595Z,1738804174.595 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-06T01:09:34.596Z,1738804174.596 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-06T01:09:34.596Z,1738804174.596 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-06T01:09:34.596Z,1738804174.596 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-06T01:09:34.597Z,1738804174.597 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-06T01:09:34.597Z,1738804174.597 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-06T01:09:34.597Z,1738804174.597 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-06T01:09:34.598Z,1738804174.598 [Default:A.Wait] Running Loop=1
2025-02-06T01:09:34.598Z,1738804174.598 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-06T01:09:35.248Z,1738804175.248 [DataOverHttps](INFO): Sending 330 bytes from file Logs/20250206T010046/Express0011.lzma
2025-02-06T01:09:36.250Z,1738804176.250 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0011.lzma.bak
2025-02-06T01:09:36.250Z,1738804176.250 [DataOverHttps](INFO): SBD MOMSN=23958034
2025-02-06T01:09:46.436Z,1738804186.436 [CommandExec](IMPORTANT): got command schedule clear
2025-02-06T01:09:46.436Z,1738804186.436 [CommandExec](IMPORTANT): Cleared 2 scheduled commands.
2025-02-06T01:09:46.436Z,1738804186.436 [CommandExec](IMPORTANT): got command schedule resume
2025-02-06T01:09:46.437Z,1738804186.437 [CommandExec](IMPORTANT): Scheduling is resumed
2025-02-06T01:09:47.928Z,1738804187.928 [Default:A.Wait](INFO): Done Waiting.
2025-02-06T01:09:47.928Z,1738804187.928 [Default:A.Wait] Stopped
2025-02-06T01:09:47.928Z,1738804187.928 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-06T01:09:48.343Z,1738804188.343 [Default:CheckIn] Running Loop=1
2025-02-06T01:09:48.344Z,1738804188.344 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-06T01:09:48.344Z,1738804188.344 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-06T01:09:50.351Z,1738804190.351 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010946.00,A,3647.05175,N,12149.86635,W,0.622,168.50,060225,,,A*78
2025-02-06T01:09:50.361Z,1738804190.361 [NAL9602](INFO): GPS fix at 20250206T010946: (36.784196, -121.831106)
2025-02-06T01:09:50.373Z,1738804190.373 [Default:CheckIn:Read_GPS] Stopped
2025-02-06T01:09:50.373Z,1738804190.373 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-06T01:09:59.219Z,1738804199.219 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250206T010046/Courier0025.lzma
2025-02-06T01:10:00.222Z,1738804200.222 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0025.lzma.bak
2025-02-06T01:10:00.222Z,1738804200.222 [DataOverHttps](INFO): SBD MOMSN=23958042
2025-02-06T01:10:10.766Z,1738804210.766 [DataOverHttps](IMPORTANT): SBD MTMSN=20250206T011009
2025-02-06T01:10:17.062Z,1738804217.062 [NAL9602](INFO): SBD MO Status=2, MOMSN=12520, MT Status=2, MTMSN=0
2025-02-06T01:10:17.062Z,1738804217.062 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-06T01:10:19.604Z,1738804219.604 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20250206T010046/Express0014.lzma
2025-02-06T01:10:19.607Z,1738804219.607 [DataOverHttps](INFO): Received command: sched asap "load Transport/transit.tl;set transit.MissionTimeout 60 min;set transit.NeedCommsTime 30 min;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Speed 1.4 m/s;set transit.MaxDepth 20 m" 1adws 1 2
2025-02-06T01:10:19.673Z,1738804219.673 [CommandExec](IMPORTANT): got command schedule asap "load Transport/transit.tl;set transit.MissionTimeout 60 min;set transit.NeedCommsTime 30 min;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Speed 1.4 m/s;set transit.MaxDepth 20 m" 1adws 1 2.000000
2025-02-06T01:10:19.673Z,1738804219.673 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=1adws
2025-02-06T01:10:19.674Z,1738804219.674 [CommandExec](IMPORTANT): Scheduled #5 (#1 of 2 with id='1adws'): "load Transport/transit.tl;set transit.MissionTimeout 60 min;set transit.NeedCommsTime 30 min;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Speed 1.4 m/s;set transit.MaxDepth 20 m", ASAP
2025-02-06T01:10:20.878Z,1738804220.878 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0014.lzma.bak
2025-02-06T01:10:20.878Z,1738804220.878 [DataOverHttps](IMPORTANT): SBD MOMSN=23958046, MTMSN=20250206T011019
2025-02-06T01:10:29.272Z,1738804229.272 [DataOverHttps](INFO): Received command: sched asap "set transit.MinOffshore 1 km;run" 1adws 2 2
2025-02-06T01:10:29.292Z,1738804229.292 [CommandExec](IMPORTANT): got command schedule asap "set transit.MinOffshore 1 km;run" 1adws 2 2.000000
2025-02-06T01:10:29.293Z,1738804229.293 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=1adws
2025-02-06T01:10:29.294Z,1738804229.294 [CommandExec](IMPORTANT): Scheduled #6 (#2 of 2 with id='1adws'): "set transit.MinOffshore 1 km;run", ASAP
2025-02-06T01:10:29.409Z,1738804229.409 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2025-02-06T01:10:29.410Z,1738804229.410 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2025-02-06T01:10:29.410Z,1738804229.410 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/transit.tl
2025-02-06T01:10:29.411Z,1738804229.411 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/transit.tl
2025-02-06T01:10:31.075Z,1738804231.075 [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-02-06T01:10:31.083Z,1738804231.083 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2025-02-06T01:10:31.090Z,1738804231.090 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2025-02-06T01:10:31.096Z,1738804231.096 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2025-02-06T01:10:31.098Z,1738804231.098 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2025-02-06T01:10:31.148Z,1738804231.148 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2025-02-06T01:10:31.206Z,1738804231.206 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2025-02-06T01:10:31.232Z,1738804231.232 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2025-02-06T01:10:31.234Z,1738804231.234 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2025-02-06T01:10:31.241Z,1738804231.241 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2025-02-06T01:10:31.243Z,1738804231.243 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2025-02-06T01:10:31.271Z,1738804231.271 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2025-02-06T01:10:31.279Z,1738804231.279 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2025-02-06T01:10:31.289Z,1738804231.289 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2025-02-06T01:10:31.289Z,1738804231.289 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-02-06T01:10:31.290Z,1738804231.290 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-02-06T01:10:31.291Z,1738804231.291 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-02-06T01:10:31.738Z,1738804231.738 [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-02-06T01:10:31.742Z,1738804231.742 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 1.000000 h
2025-02-06T01:10:31.758Z,1738804231.758 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2025-02-06T01:10:31.760Z,1738804231.760 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-02-06T01:10:31.762Z,1738804231.762 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2025-02-06T01:10:31.765Z,1738804231.765 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-02-06T01:10:31.767Z,1738804231.767 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2025-02-06T01:10:31.769Z,1738804231.769 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2025-02-06T01:10:31.771Z,1738804231.771 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2025-02-06T01:10:31.777Z,1738804231.777 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-06T01:10:31.794Z,1738804231.794 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-02-06T01:10:31.794Z,1738804231.794 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-02-06T01:10:31.795Z,1738804231.795 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-02-06T01:10:31.967Z,1738804231.967 [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-02-06T01:10:31.970Z,1738804231.970 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2025-02-06T01:10:32.016Z,1738804232.016 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-02-06T01:10:32.018Z,1738804232.018 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2025-02-06T01:10:32.022Z,1738804232.022 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-02-06T01:10:32.023Z,1738804232.023 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-02-06T01:10:32.067Z,1738804232.067 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-02-06T01:10:32.094Z,1738804232.094 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-02-06T01:10:32.119Z,1738804232.119 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-02-06T01:10:32.124Z,1738804232.124 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-02-06T01:10:32.718Z,1738804232.718 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-02-06T01:10:32.735Z,1738804232.735 [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-02-06T01:10:32.738Z,1738804232.738 [MissionManager](INFO): DefineArg transit:BackseatDriver.EnableBackseat = 0 bool
2025-02-06T01:10:32.740Z,1738804232.740 [transit:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-02-06T01:10:32.762Z,1738804232.762 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-02-06T01:10:32.762Z,1738804232.762 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-02-06T01:10:32.826Z,1738804232.826 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-02-06T01:10:32.961Z,1738804232.961 [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-02-06T01:10:32.965Z,1738804232.965 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleAll = 0 bool
2025-02-06T01:10:32.966Z,1738804232.966 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad1 = 0 bool
2025-02-06T01:10:32.968Z,1738804232.968 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad2 = 0 bool
2025-02-06T01:10:32.970Z,1738804232.970 [MissionManager](INFO): DefineArg transit:PowerOnly.SampleLoad3 = 0 bool
2025-02-06T01:10:32.972Z,1738804232.972 [MissionManager](INFO): DefineArg transit:PowerOnly.EnabledPowerOnly = 0 bool
2025-02-06T01:10:33.033Z,1738804233.033 [transit:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-02-06T01:10:33.035Z,1738804233.035 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2025-02-06T01:10:33.038Z,1738804233.038 [transit:MassHold.Pitch](DEBUG): Construct.
2025-02-06T01:10:33.043Z,1738804233.043 [transit:Transit:A.Pitch](DEBUG): Construct.
2025-02-06T01:10:33.047Z,1738804233.047 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2025-02-06T01:10:33.050Z,1738804233.050 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-02-06T01:10:33.065Z,1738804233.065 [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-02-06T01:10:33.066Z,1738804233.066 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl id=transit
2025-02-06T01:10:37.255Z,1738804237.255 [NAL9602](INFO): SBD MO Status=0, MOMSN=12520, MT Status=0, MTMSN=0
2025-02-06T01:10:37.255Z,1738804237.255 [NAL9602](INFO): No messages in MT queue
2025-02-06T01:10:43.440Z,1738804243.440 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0028.lzma
2025-02-06T01:10:44.442Z,1738804244.442 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0028.lzma.bak
2025-02-06T01:10:44.442Z,1738804244.442 [DataOverHttps](INFO): SBD MOMSN=23958056
2025-02-06T01:11:00.517Z,1738804260.517 [CommandExec](IMPORTANT): got command set transit.MissionTimeout 60 minute
2025-02-06T01:11:00.517Z,1738804260.517 [CommandExec](IMPORTANT): got command set transit.NeedCommsTime 30 minute
2025-02-06T01:11:00.518Z,1738804260.518 [CommandExec](IMPORTANT): got command set transit.Latitude 36.797 degree
2025-02-06T01:11:00.519Z,1738804260.519 [CommandExec](IMPORTANT): got command set transit.Longitude -121.847 degree
2025-02-06T01:11:00.519Z,1738804260.519 [CommandExec](IMPORTANT): got command set transit.Speed 1.4 meter_per_second
2025-02-06T01:11:00.524Z,1738804260.524 [CommandExec](IMPORTANT): got command set transit.MaxDepth 20 meter
2025-02-06T01:11:02.086Z,1738804262.086 [CommandExec](IMPORTANT): got command get VerticalControl.buoyancyDefault
2025-02-06T01:11:02.086Z,1738804262.086 [CommandExec](IMPORTANT): VerticalControl.buoyancyDefault 905.000000 cc
2025-02-06T01:11:07.709Z,1738804267.709 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-06T01:11:08.117Z,1738804268.117 [Power24vConverter](INFO): Powering down.
2025-02-06T01:11:09.683Z,1738804269.683 [CommandExec](IMPORTANT): got command set transit.MinOffshore 1 kilometer
2025-02-06T01:11:09.683Z,1738804269.683 [CommandExec](IMPORTANT): got command run
2025-02-06T01:11:09.758Z,1738804269.758 [CommandExec](IMPORTANT): Running 
2025-02-06T01:11:09.821Z,1738804269.821 [Default] Stopped
2025-02-06T01:11:09.821Z,1738804269.821 [Default](DEBUG): Aggregate::uninitialize Default
2025-02-06T01:11:09.821Z,1738804269.821 [Default:B.GoToSurface] Stopped
2025-02-06T01:11:09.821Z,1738804269.821 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-06T01:11:09.821Z,1738804269.821 [Default:CheckIn] Stopped
2025-02-06T01:11:09.822Z,1738804269.822 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-06T01:11:09.822Z,1738804269.822 [Default:CheckIn:Read_Iridium] Stopped
2025-02-06T01:11:09.822Z,1738804269.822 [MissionManager](IMPORTANT): Started mission transit
2025-02-06T01:11:09.822Z,1738804269.822 [transit] Running Loop=1
2025-02-06T01:11:09.822Z,1738804269.822 [transit](DEBUG): Aggregate::initialize transit
2025-02-06T01:11:09.822Z,1738804269.822 [transit:StandardEnvelopes] Running Loop=1
2025-02-06T01:11:09.822Z,1738804269.822 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2025-02-06T01:11:09.822Z,1738804269.822 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-06T01:11:09.822Z,1738804269.822 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-02-06T01:11:09.825Z,1738804269.825 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-06T01:11:09.825Z,1738804269.825 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-02-06T01:11:09.825Z,1738804269.825 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-06T01:11:09.825Z,1738804269.825 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-02-06T01:11:09.825Z,1738804269.825 [transit:BackseatDriver] Running Loop=1
2025-02-06T01:11:09.825Z,1738804269.825 [transit:BackseatDriver](DEBUG): Aggregate::initialize transit:BackseatDriver
2025-02-06T01:11:09.826Z,1738804269.826 [transit:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly](DEBUG): Aggregate::initialize transit:PowerOnly
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly:A] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly:B] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly:C] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly:D] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly:E.Wait] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-02-06T01:11:09.826Z,1738804269.826 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-06T01:11:09.826Z,1738804269.826 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-06T01:11:09.826Z,1738804269.826 [transit:MassHold.Pitch] Running Loop=1
2025-02-06T01:11:09.827Z,1738804269.827 [transit:MassHold.Pitch](DEBUG): Initialize.
2025-02-06T01:11:09.827Z,1738804269.827 [transit:B] Running Loop=1
2025-02-06T01:11:09.827Z,1738804269.827 [transit:MassHold.Pitch] Running Loop=1
2025-02-06T01:11:09.848Z,1738804269.848 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-06T01:11:09.848Z,1738804269.848 [transit:PowerOnly] Running Loop=1
2025-02-06T01:11:09.849Z,1738804269.849 [transit:PowerOnly:D] Stopped
2025-02-06T01:11:09.849Z,1738804269.849 [transit:PowerOnly:C] Stopped
2025-02-06T01:11:09.849Z,1738804269.849 [transit:PowerOnly:B] Stopped
2025-02-06T01:11:09.849Z,1738804269.849 [transit:PowerOnly:A] Stopped
2025-02-06T01:11:09.849Z,1738804269.849 [transit:BackseatDriver] Running Loop=1
2025-02-06T01:11:09.849Z,1738804269.849 [transit:StandardEnvelopes] Running Loop=1
2025-02-06T01:11:09.849Z,1738804269.849 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-06T01:11:09.849Z,1738804269.849 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-06T01:11:09.850Z,1738804269.850 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-06T01:11:09.850Z,1738804269.850 [transit:B] Stopped
2025-02-06T01:11:09.850Z,1738804269.850 [transit:C] Running Loop=1
2025-02-06T01:11:10.198Z,1738804270.198 [transit:C] Stopped
2025-02-06T01:11:10.198Z,1738804270.198 [transit:E] Running Loop=1
2025-02-06T01:11:10.608Z,1738804270.608 [transit:E] Stopped
2025-02-06T01:11:10.608Z,1738804270.608 [transit:F] Running Loop=1
2025-02-06T01:11:11.058Z,1738804271.058 [transit:F] Stopped
2025-02-06T01:11:11.058Z,1738804271.058 [transit:G] Running Loop=1
2025-02-06T01:11:11.466Z,1738804271.466 [transit:G] Stopped
2025-02-06T01:11:11.466Z,1738804271.466 [transit:Transit] Running Loop=1
2025-02-06T01:11:11.466Z,1738804271.466 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2025-02-06T01:11:11.466Z,1738804271.466 [transit:Transit:A.Pitch] Running Loop=1
2025-02-06T01:11:11.466Z,1738804271.466 [transit:Transit:A.Pitch](DEBUG): Initialize.
2025-02-06T01:11:11.466Z,1738804271.466 [transit:Transit:B.SetSpeed] Running Loop=1
2025-02-06T01:11:11.467Z,1738804271.467 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2025-02-06T01:11:11.467Z,1738804271.467 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2025-02-06T01:11:11.467Z,1738804271.467 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-06T01:11:11.505Z,1738804271.505 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2025-02-06T01:11:11.505Z,1738804271.505 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2025-02-06T01:11:11.841Z,1738804271.841 [transit:Transit:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000
2025-02-06T01:11:11.842Z,1738804271.842 [transit:Transit:B.SetSpeed] Running Loop=1
2025-02-06T01:11:11.842Z,1738804271.842 [transit:Transit:A.Pitch] Running Loop=1
2025-02-06T01:11:16.188Z,1738804276.188 [ThrusterHE](FAULT): Could not get status:serial timeout
2025-02-06T01:11:16.423Z,1738804276.423 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0031.lzma
2025-02-06T01:11:17.426Z,1738804277.426 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0031.lzma.bak
2025-02-06T01:11:17.426Z,1738804277.426 [DataOverHttps](INFO): SBD MOMSN=23958060
2025-02-06T01:12:19.256Z,1738804339.256 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:12:50.380Z,1738804370.380 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:13:09.037Z,1738804389.037 [Radio_Surface](INFO): Powering down
2025-02-06T01:13:21.504Z,1738804401.504 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:13:22.508Z,1738804402.508 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-02-06T01:14:28.776Z,1738804468.776 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.723190
2025-02-06T01:17:57.862Z,1738804677.862 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-02-06T01:32:07.340Z,1738805527.340 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-02-06T01:32:07.341Z,1738805527.341 [BPC1](INFO): Calculating totals. Valid battery stick count: 27. Valid reserve battery stick count: 3.
2025-02-06T01:32:07.344Z,1738805527.344 [BPC1](CRITICAL): Battery Capacity Below Threshold. 22.859000 Ah.
2025-02-06T01:32:07.344Z,1738805527.344 [BPC1](CRITICAL): Battery Voltage Below Threshold. 13.674444 V.
2025-02-06T01:32:07.345Z,1738805527.345 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2025-02-06T01:32:07.445Z,1738805527.445 [CommandExec](FAULT): Scheduling is paused
2025-02-06T01:32:07.445Z,1738805527.445 [CBIT](INFO): Critical error at 20250206T013207
2025-02-06T01:32:07.446Z,1738805527.446 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-02-06T01:32:07.762Z,1738805527.762 [MissionManager](INFO): MissionManager is completed.
2025-02-06T01:32:07.762Z,1738805527.762 [MissionManager](INFO): Uninitializing Mission transit
2025-02-06T01:32:07.762Z,1738805527.762 [transit] Stopped
2025-02-06T01:32:07.762Z,1738805527.762 [transit](DEBUG): Aggregate::uninitialize transit
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-02-06T01:32:07.763Z,1738805527.763 [transit:BackseatDriver] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:BackseatDriver](DEBUG): Aggregate::uninitialize transit:BackseatDriver
2025-02-06T01:32:07.763Z,1738805527.763 [transit:BackseatDriver:A.BackseatDriver] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:PowerOnly] Stopped
2025-02-06T01:32:07.763Z,1738805527.763 [transit:PowerOnly](DEBUG): Aggregate::uninitialize transit:PowerOnly
2025-02-06T01:32:07.804Z,1738805527.804 [transit:PowerOnly:E.Wait] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-02-06T01:32:07.804Z,1738805527.804 [transit:BuoyancyHold.Buoyancy] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-06T01:32:07.804Z,1738805527.804 [transit:MassHold.Pitch] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit:A.Pitch] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit:B.SetSpeed] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit:Wpt1.Waypoint] Stopped
2025-02-06T01:32:07.804Z,1738805527.804 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-06T01:32:08.167Z,1738805528.167 [MissionManager](IMPORTANT): Started mission Default
2025-02-06T01:32:08.167Z,1738805528.167 [Default] Running Loop=1
2025-02-06T01:32:08.167Z,1738805528.167 [Default](DEBUG): Aggregate::initialize Default
2025-02-06T01:32:08.167Z,1738805528.167 [Default:B.GoToSurface] Running Loop=1
2025-02-06T01:32:08.167Z,1738805528.167 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-06T01:32:08.168Z,1738805528.168 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-06T01:32:08.168Z,1738805528.168 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-06T01:32:08.168Z,1738805528.168 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-06T01:32:08.169Z,1738805528.169 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-06T01:32:08.169Z,1738805528.169 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-06T01:32:08.169Z,1738805528.169 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-06T01:32:08.170Z,1738805528.170 [Default:A.Wait] Running Loop=1
2025-02-06T01:32:08.170Z,1738805528.170 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-06T01:32:08.559Z,1738805528.559 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm (1 active estimators).
2025-02-06T01:32:08.670Z,1738805528.670 [Radio_Surface](INFO): Powering up
2025-02-06T01:32:13.712Z,1738805533.712 [ThrusterHE](FAULT): Could not get status:serial timeout
2025-02-06T01:32:13.808Z,1738805533.808 [ThrusterHE](FAULT): getSpeed error serial timeout
2025-02-06T01:32:13.808Z,1738805533.808 [ThrusterHE](FAULT): Thruster uart error: serial timeout
2025-02-06T01:32:13.808Z,1738805533.808 [ThrusterHE] Communications Fault, FailCount= 1
2025-02-06T01:32:13.808Z,1738805533.808 [ThrusterHE](ERROR): Communications Fault
2025-02-06T01:32:13.812Z,1738805533.812 [CBIT](ERROR): Communications Fault in component: ThrusterHE
2025-02-06T01:32:14.153Z,1738805534.153 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-02-06T01:32:14.153Z,1738805534.153 [ThrusterHE](INFO): Powering down
2025-02-06T01:32:14.208Z,1738805534.208 [DataOverHttps](INFO): Radio surface powered ON.
2025-02-06T01:32:14.833Z,1738805534.833 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-06T01:32:14.953Z,1738805534.953 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-06T01:32:14.957Z,1738805534.957 [CBIT](INFO): Clearing failed state for component ThrusterHE
2025-02-06T01:32:14.957Z,1738805534.957 [ThrusterHE] No Fault, FailCount= 1
2025-02-06T01:32:21.220Z,1738805541.220 [Default:A.Wait](INFO): Done Waiting.
2025-02-06T01:32:21.220Z,1738805541.220 [Default:A.Wait] Stopped
2025-02-06T01:32:21.221Z,1738805541.221 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-06T01:32:28.092Z,1738805548.092 [Default:CheckIn] Running Loop=1
2025-02-06T01:32:28.093Z,1738805548.093 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-06T01:32:28.093Z,1738805548.093 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-06T01:32:44.336Z,1738805564.336 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:33:15.484Z,1738805595.484 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:33:44.024Z,1738805624.024 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=12521, MT Status=1, MTMSN=226
2025-02-06T01:33:44.024Z,1738805624.024 [NAL9602](INFO): Data available in MT queue
2025-02-06T01:33:44.561Z,1738805624.561 [NAL9602](INFO): Received command: sched "run Maintenance/ballast_and_trim.tl"
2025-02-06T01:33:44.655Z,1738805624.655 [CommandExec](IMPORTANT): got command schedule "run Maintenance/ballast_and_trim.tl"
2025-02-06T01:33:44.656Z,1738805624.656 [CommandExec](IMPORTANT): Scheduled #7: "run Maintenance/ballast_and_trim.tl", AFTER MISSION
2025-02-06T01:33:44.656Z,1738805624.656 [CommandExec](FAULT): Scheduling was paused by an error at 2025-02-06T01:32:07Z
2025-02-06T01:33:45.640Z,1738805625.640 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013342.00,A,3647.54117,N,12150.63788,W,0.972,164.08,060225,,,A*7A
2025-02-06T01:33:45.642Z,1738805625.642 [NAL9602](INFO): GPS fix at 20250206T013342: (36.792353, -121.843965)
2025-02-06T01:33:45.674Z,1738805625.674 [UniversalFixResidualReporter](INFO): Fix residual: 19.4 %DT, over the last 1747.9 m. Residual distance 338.6 m at bearing -13.6 degrees. Fix at (36.7924, -121.8440) with 1460.8 m made good.
2025-02-06T01:33:45.675Z,1738805625.675 [Default:CheckIn:Read_GPS] Stopped
2025-02-06T01:33:45.675Z,1738805625.675 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-06T01:33:46.608Z,1738805626.608 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:33:59.486Z,1738805639.486 [NAL9602](INFO): SBD MO Status=2, MOMSN=12522, MT Status=2, MTMSN=0
2025-02-06T01:33:59.487Z,1738805639.487 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-06T01:34:17.727Z,1738805657.727 [NAL9602](INFO): SBD MO Status=1, MOMSN=12522, MT Status=0, MTMSN=0
2025-02-06T01:34:17.744Z,1738805657.744 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-06T01:34:17.784Z,1738805657.784 [NAL9602](INFO): Sent 296 bytes from file Logs/20250206T010046/Courier0034.lzma
2025-02-06T01:34:17.784Z,1738805657.784 [NAL9602](INFO): Packets left to send: 0
2025-02-06T01:34:26.204Z,1738805666.204 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003001
2025-02-06T01:34:27.922Z,1738805667.922 [NAL9602](INFO): SBD MO Status=1, MOMSN=12523, MT Status=0, MTMSN=0
2025-02-06T01:34:27.973Z,1738805667.973 [NAL9602](INFO): Sent 298 bytes from file Logs/20250206T010046/Express0017.lzma
2025-02-06T01:34:27.973Z,1738805667.973 [NAL9602](INFO): Packets left to send: 0
2025-02-06T01:34:48.415Z,1738805688.415 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250206T010046/Courier0037.lzma
2025-02-06T01:34:49.418Z,1738805689.418 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Courier0037.lzma.bak
2025-02-06T01:34:49.418Z,1738805689.418 [DataOverHttps](INFO): SBD MOMSN=23958087
2025-02-06T01:34:59.425Z,1738805699.425 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-06T01:35:07.876Z,1738805707.876 [DataOverHttps](INFO): Sending 503 bytes from file Logs/20250206T010046/Express0020.lzma
2025-02-06T01:35:08.878Z,1738805708.878 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0020.lzma.bak
2025-02-06T01:35:08.878Z,1738805708.878 [DataOverHttps](INFO): SBD MOMSN=23958104
2025-02-06T01:35:25.957Z,1738805725.957 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250206T010046/Express0023.lzma
2025-02-06T01:35:26.958Z,1738805726.958 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0023.lzma.bak
2025-02-06T01:35:26.958Z,1738805726.958 [DataOverHttps](INFO): SBD MOMSN=23958121
2025-02-06T01:35:42.752Z,1738805742.752 [DataOverHttps](INFO): Sending 567 bytes from file Logs/20250206T010046/Express0026.lzma
2025-02-06T01:35:43.754Z,1738805743.754 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0026.lzma.bak
2025-02-06T01:35:43.754Z,1738805743.754 [DataOverHttps](INFO): SBD MOMSN=23958123
2025-02-06T01:36:06.516Z,1738805766.516 [DataOverHttps](INFO): Sending 330 bytes from file Logs/20250206T010046/Express0029.lzma
2025-02-06T01:36:07.518Z,1738805767.518 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0029.lzma.bak
2025-02-06T01:36:07.518Z,1738805767.518 [DataOverHttps](INFO): SBD MOMSN=23958149
2025-02-06T01:36:23.340Z,1738805783.340 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20250206T010046/Express0032.lzma
2025-02-06T01:36:24.342Z,1738805784.342 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0032.lzma.bak
2025-02-06T01:36:24.342Z,1738805784.342 [DataOverHttps](INFO): SBD MOMSN=23958155
2025-02-06T01:36:40.429Z,1738805800.429 [DataOverHttps](INFO): Sending 733 bytes from file Logs/20250206T010046/Express0035.lzma
2025-02-06T01:36:41.430Z,1738805801.430 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0035.lzma.bak
2025-02-06T01:36:41.430Z,1738805801.430 [DataOverHttps](INFO): SBD MOMSN=23958162
2025-02-06T01:36:57.235Z,1738805817.235 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250206T010046/Express0038.lzma
2025-02-06T01:36:58.238Z,1738805818.238 [DataOverHttps](INFO): Moved sent file to Logs/20250206T010046/Express0038.lzma.bak
2025-02-06T01:36:58.238Z,1738805818.238 [DataOverHttps](INFO): SBD MOMSN=23958188
2025-02-06T01:36:59.499Z,1738805819.499 [Default:CheckIn:Read_Iridium] Stopped
2025-02-06T01:36:59.500Z,1738805819.500 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-06T01:36:59.500Z,1738805819.500 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-06T01:38:03.227Z,1738805883.227 [CommandExec](IMPORTANT): got command failComponent
2025-02-06T01:38:03.227Z,1738805883.227 [CommandExec](IMPORTANT): Failed components:
2025-02-06T01:38:03.227Z,1738805883.227 [CommandExec](IMPORTANT): No failed Components.
2025-02-06T01:38:08.325Z,1738805888.325 [CommandExec](IMPORTANT): got command show variable voltage
2025-02-06T01:38:08.330Z,1738805888.330 [CommandExec](IMPORTANT): platform_battery_voltage (volt)
2025-02-06T01:38:08.349Z,1738805888.349 [CommandExec](IMPORTANT): IBIT.batteryVoltageThreshold (volt)
2025-02-06T01:38:08.415Z,1738805888.415 [CommandExec](IMPORTANT): AHRS_M2.component_voltage (volt)
2025-02-06T01:38:08.415Z,1738805888.415 [CommandExec](IMPORTANT): AHRS_M2.component_avgVoltage (volt)
2025-02-06T01:38:08.417Z,1738805888.417 [CommandExec](IMPORTANT): BackseatComponent.component_voltage (volt)
2025-02-06T01:38:08.417Z,1738805888.417 [CommandExec](IMPORTANT): BackseatComponent.component_avgVoltage (volt)
2025-02-06T01:38:08.418Z,1738805888.418 [CommandExec](IMPORTANT): BPC1.reserve_battery_voltage (volt)
2025-02-06T01:38:08.418Z,1738805888.418 [CommandExec](IMPORTANT): BPC1.platform_battery_voltage (volt)
2025-02-06T01:38:08.419Z,1738805888.419 [CommandExec](IMPORTANT): BPC1.BattVoltage_1 (millivolt)
2025-02-06T01:38:08.419Z,1738805888.419 [CommandExec](IMPORTANT): BPC1.BattVoltage_2 (millivolt)
2025-02-06T01:38:08.456Z,1738805888.456 [CommandExec](IMPORTANT): BPC1.BattVoltage_3 (millivolt)
2025-02-06T01:38:08.456Z,1738805888.456 [CommandExec](IMPORTANT): BPC1.BattVoltage_4 (millivolt)
2025-02-06T01:38:08.457Z,1738805888.457 [CommandExec](IMPORTANT): BPC1.BattVoltage_5 (millivolt)
2025-02-06T01:38:08.457Z,1738805888.457 [CommandExec](IMPORTANT): BPC1.BattVoltage_6 (millivolt)
2025-02-06T01:38:08.458Z,1738805888.458 [CommandExec](IMPORTANT): BPC1.BattVoltage_7 (millivolt)
2025-02-06T01:38:08.458Z,1738805888.458 [CommandExec](IMPORTANT): BPC1.BattVoltage_8 (millivolt)
2025-02-06T01:38:08.459Z,1738805888.459 [CommandExec](IMPORTANT): BPC1.BattVoltage_9 (millivolt)
2025-02-06T01:38:08.459Z,1738805888.459 [CommandExec](IMPORTANT): BPC1.BattVoltage_10 (millivolt)
2025-02-06T01:38:08.459Z,1738805888.459 [CommandExec](IMPORTANT): BPC1.BattVoltage_11 (millivolt)
2025-02-06T01:38:08.460Z,1738805888.460 [CommandExec](IMPORTANT): BPC1.BattVoltage_12 (millivolt)
2025-02-06T01:38:08.460Z,1738805888.460 [CommandExec](IMPORTANT): BPC1.BattVoltage_13 (millivolt)
2025-02-06T01:38:08.461Z,1738805888.461 [CommandExec](IMPORTANT): BPC1.BattVoltage_14 (millivolt)
2025-02-06T01:38:08.461Z,1738805888.461 [CommandExec](IMPORTANT): BPC1.BattVoltage_15 (millivolt)
2025-02-06T01:38:08.462Z,1738805888.462 [CommandExec](IMPORTANT): BPC1.BattVoltage_16 (millivolt)
2025-02-06T01:38:08.462Z,1738805888.462 [CommandExec](IMPORTANT): BPC1.BattVoltage_17 (millivolt)
2025-02-06T01:38:08.463Z,1738805888.463 [CommandExec](IMPORTANT): BPC1.BattVoltage_18 (millivolt)
2025-02-06T01:38:08.463Z,1738805888.463 [CommandExec](IMPORTANT): BPC1.BattVoltage_19 (millivolt)
2025-02-06T01:38:08.463Z,1738805888.463 [CommandExec](IMPORTANT): BPC1.BattVoltage_20 (millivolt)
2025-02-06T01:38:08.493Z,1738805888.493 [CommandExec](IMPORTANT): BPC1.BattVoltage_21 (millivolt)
2025-02-06T01:38:08.493Z,1738805888.493 [CommandExec](IMPORTANT): BPC1.BattVoltage_22 (millivolt)
2025-02-06T01:38:08.494Z,1738805888.494 [CommandExec](IMPORTANT): BPC1.BattVoltage_23 (millivolt)
2025-02-06T01:38:08.494Z,1738805888.494 [CommandExec](IMPORTANT): BPC1.BattVoltage_24 (millivolt)
2025-02-06T01:38:08.495Z,1738805888.495 [CommandExec](IMPORTANT): BPC1.BattVoltage_25 (millivolt)
2025-02-06T01:38:08.495Z,1738805888.495 [CommandExec](IMPORTANT): BPC1.BattVoltage_26 (millivolt)
2025-02-06T01:38:08.496Z,1738805888.496 [CommandExec](IMPORTANT): BPC1.BattVoltage_27 (millivolt)
2025-02-06T01:38:08.497Z,1738805888.497 [CommandExec](IMPORTANT): BPC1.BattVoltage_28 (millivolt)
2025-02-06T01:38:08.497Z,1738805888.497 [CommandExec](IMPORTANT): BPC1.BattVoltage_29 (millivolt)
2025-02-06T01:38:08.498Z,1738805888.498 [CommandExec](IMPORTANT): BPC1.BattVoltage_30 (millivolt)
2025-02-06T01:38:08.498Z,1738805888.498 [CommandExec](IMPORTANT): BPC1.BattVoltage_31 (millivolt)
2025-02-06T01:38:08.498Z,1738805888.498 [CommandExec](IMPORTANT): BPC1.BattVoltage_32 (millivolt)
2025-02-06T01:38:08.499Z,1738805888.499 [CommandExec](IMPORTANT): BPC1.BattVoltage_33 (millivolt)
2025-02-06T01:38:08.499Z,1738805888.499 [CommandExec](IMPORTANT): BPC1.BattVoltage_34 (millivolt)
2025-02-06T01:38:08.516Z,1738805888.516 [CommandExec](IMPORTANT): BPC1.BattVoltage_35 (millivolt)
2025-02-06T01:38:08.517Z,1738805888.517 [CommandExec](IMPORTANT): BPC1.BattVoltage_36 (millivolt)
2025-02-06T01:38:08.517Z,1738805888.517 [CommandExec](IMPORTANT): BPC1.BattVoltage_37 (millivolt)
2025-02-06T01:38:08.518Z,1738805888.518 [CommandExec](IMPORTANT): BPC1.BattVoltage_38 (millivolt)
2025-02-06T01:38:08.518Z,1738805888.518 [CommandExec](IMPORTANT): BPC1.BattVoltage_39 (millivolt)
2025-02-06T01:38:08.518Z,1738805888.518 [CommandExec](IMPORTANT): BPC1.BattVoltage_40 (millivolt)
2025-02-06T01:38:08.519Z,1738805888.519 [CommandExec](IMPORTANT): BPC1.BattVoltage_41 (millivolt)
2025-02-06T01:38:08.519Z,1738805888.519 [CommandExec](IMPORTANT): BPC1.BattVoltage_42 (millivolt)
2025-02-06T01:38:08.520Z,1738805888.520 [CommandExec](IMPORTANT): BPC1.BattVoltage_43 (millivolt)
2025-02-06T01:38:08.520Z,1738805888.520 [CommandExec](IMPORTANT): BPC1.BattVoltage_44 (millivolt)
2025-02-06T01:38:08.521Z,1738805888.521 [CommandExec](IMPORTANT): BPC1.BattVoltage_45 (millivolt)
2025-02-06T01:38:08.521Z,1738805888.521 [CommandExec](IMPORTANT): BPC1.BattVoltage_46 (millivolt)
2025-02-06T01:38:08.522Z,1738805888.522 [CommandExec](IMPORTANT): BPC1.BattVoltage_47 (millivolt)
2025-02-06T01:38:08.522Z,1738805888.522 [CommandExec](IMPORTANT): BPC1.BattVoltage_48 (millivolt)
2025-02-06T01:38:08.522Z,1738805888.522 [CommandExec](IMPORTANT): BPC1.BattVoltage_49 (millivolt)
2025-02-06T01:38:08.523Z,1738805888.523 [CommandExec](IMPORTANT): BPC1.BattVoltage_50 (millivolt)
2025-02-06T01:38:08.523Z,1738805888.523 [CommandExec](IMPORTANT): BPC1.BattVoltage_51 (millivolt)
2025-02-06T01:38:08.541Z,1738805888.541 [CommandExec](IMPORTANT): BPC1.BattVoltage_52 (millivolt)
2025-02-06T01:38:08.542Z,1738805888.542 [CommandExec](IMPORTANT): BPC1.BattVoltage_53 (millivolt)
2025-02-06T01:38:08.542Z,1738805888.542 [CommandExec](IMPORTANT): BPC1.BattVoltage_54 (millivolt)
2025-02-06T01:38:08.543Z,1738805888.543 [CommandExec](IMPORTANT): BPC1.BattVoltage_55 (millivolt)
2025-02-06T01:38:08.543Z,1738805888.543 [CommandExec](IMPORTANT): BPC1.BattVoltage_56 (millivolt)
2025-02-06T01:38:08.544Z,1738805888.544 [CommandExec](IMPORTANT): BPC1.BattVoltage_57 (millivolt)
2025-02-06T01:38:08.544Z,1738805888.544 [CommandExec](IMPORTANT): BPC1.BattVoltage_58 (millivolt)
2025-02-06T01:38:08.545Z,1738805888.545 [CommandExec](IMPORTANT): BPC1.BattVoltage_59 (millivolt)
2025-02-06T01:38:08.545Z,1738805888.545 [CommandExec](IMPORTANT): BPC1.BattVoltage_60 (millivolt)
2025-02-06T01:38:08.546Z,1738805888.546 [CommandExec](IMPORTANT): BPC1.BattVoltage_61 (millivolt)
2025-02-06T01:38:08.546Z,1738805888.546 [CommandExec](IMPORTANT): BPC1.BattVoltage_62 (millivolt)
2025-02-06T01:38:08.547Z,1738805888.547 [CommandExec](IMPORTANT): Depth_Keller.component_voltage (volt)
2025-02-06T01:38:08.547Z,1738805888.547 [CommandExec](IMPORTANT): Depth_Keller.component_avgVoltage (volt)
2025-02-06T01:38:08.612Z,1738805888.612 [CommandExec](IMPORTANT): NAL9602.component_voltage (volt)
2025-02-06T01:38:08.612Z,1738805888.612 [CommandExec](IMPORTANT): NAL9602.component_avgVoltage (volt)
2025-02-06T01:38:08.613Z,1738805888.613 [CommandExec](IMPORTANT): Onboard.platform_battery_voltage (volt)
2025-02-06T01:38:08.614Z,1738805888.614 [CommandExec](IMPORTANT): Onboard.MainBatteryVoltage (volt)
2025-02-06T01:38:08.614Z,1738805888.614 [CommandExec](IMPORTANT): Onboard.BackupBatteryVoltage (volt)
2025-02-06T01:38:08.615Z,1738805888.615 [CommandExec](IMPORTANT): Power24vConverter.component_voltage (volt)
2025-02-06T01:38:08.615Z,1738805888.615 [CommandExec](IMPORTANT): Power24vConverter.component_avgVoltage (volt)
2025-02-06T01:38:08.620Z,1738805888.620 [CommandExec](IMPORTANT): Radio_Surface.component_voltage (volt)
2025-02-06T01:38:08.620Z,1738805888.620 [CommandExec](IMPORTANT): Radio_Surface.component_avgVoltage (volt)
2025-02-06T01:38:08.621Z,1738805888.621 [CommandExec](IMPORTANT): Sonardyne_Nano.component_voltage (volt)
2025-02-06T01:38:08.621Z,1738805888.621 [CommandExec](IMPORTANT): Sonardyne_Nano.component_avgVoltage (volt)
2025-02-06T01:38:08.639Z,1738805888.639 [CommandExec](IMPORTANT): BuoyancyServo.component_voltage (volt)
2025-02-06T01:38:08.639Z,1738805888.639 [CommandExec](IMPORTANT): BuoyancyServo.component_avgVoltage (volt)
2025-02-06T01:38:08.644Z,1738805888.644 [CommandExec](IMPORTANT): ElevatorServo.component_voltage (volt)
2025-02-06T01:38:08.645Z,1738805888.645 [CommandExec](IMPORTANT): ElevatorServo.component_avgVoltage (volt)
2025-02-06T01:38:08.646Z,1738805888.646 [CommandExec](IMPORTANT): MassServo.component_voltage (volt)
2025-02-06T01:38:08.646Z,1738805888.646 [CommandExec](IMPORTANT): MassServo.component_avgVoltage (volt)
2025-02-06T01:38:08.647Z,1738805888.647 [CommandExec](IMPORTANT): RudderServo.component_voltage (volt)
2025-02-06T01:38:08.647Z,1738805888.647 [CommandExec](IMPORTANT): RudderServo.component_avgVoltage (volt)
2025-02-06T01:38:08.653Z,1738805888.653 [CommandExec](IMPORTANT): ThrusterHE.component_voltage (volt)
2025-02-06T01:38:08.653Z,1738805888.653 [CommandExec](IMPORTANT): ThrusterHE.component_avgVoltage (volt)
2025-02-06T01:38:08.653Z,1738805888.653 [CommandExec](IMPORTANT): CTD_Seabird.component_voltage (volt)
2025-02-06T01:38:08.654Z,1738805888.654 [CommandExec](IMPORTANT): CTD_Seabird.component_avgVoltage (volt)
2025-02-06T01:38:08.655Z,1738805888.655 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt)
2025-02-06T01:38:08.655Z,1738805888.655 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt)
2025-02-06T01:38:08.663Z,1738805888.663 [CommandExec](IMPORTANT): WetLabsBB2FL.component_voltage (volt)
2025-02-06T01:38:08.664Z,1738805888.664 [CommandExec](IMPORTANT): WetLabsBB2FL.component_avgVoltage (volt)
2025-02-06T01:38:20.385Z,1738805900.385 [CommandExec](IMPORTANT): got command get Onboard.platform_battery_voltage
2025-02-06T01:38:20.386Z,1738805900.386 [CommandExec](IMPORTANT): Onboard.platform_battery_voltage 13.558000 V
2025-02-06T01:38:38.351Z,1738805918.351 [CommandExec](IMPORTANT): got command get Onboard.MainBatteryVoltage
2025-02-06T01:38:38.352Z,1738805918.352 [CommandExec](IMPORTANT): Onboard.MainBatteryVoltage 13.558000 V
2025-02-06T01:38:45.470Z,1738805925.470 [CommandExec](IMPORTANT): got command get Onboard.BackupBatteryVoltage
2025-02-06T01:38:45.470Z,1738805925.470 [CommandExec](IMPORTANT): Onboard.BackupBatteryVoltage 15.818000 V
2025-02-06T01:41:02.582Z,1738806062.582 [CommandExec](IMPORTANT): got command show variable voltage
2025-02-06T01:41:02.585Z,1738806062.585 [CommandExec](IMPORTANT): platform_battery_voltage (volt)
2025-02-06T01:41:02.609Z,1738806062.609 [CommandExec](IMPORTANT): IBIT.batteryVoltageThreshold (volt)
2025-02-06T01:41:02.698Z,1738806062.698 [CommandExec](IMPORTANT): AHRS_M2.component_voltage (volt)
2025-02-06T01:41:02.698Z,1738806062.698 [CommandExec](IMPORTANT): AHRS_M2.component_avgVoltage (volt)
2025-02-06T01:41:02.699Z,1738806062.699 [CommandExec](IMPORTANT): BackseatComponent.component_voltage (volt)
2025-02-06T01:41:02.699Z,1738806062.699 [CommandExec](IMPORTANT): BackseatComponent.component_avgVoltage (volt)
2025-02-06T01:41:02.700Z,1738806062.700 [CommandExec](IMPORTANT): BPC1.reserve_battery_voltage (volt)
2025-02-06T01:41:02.701Z,1738806062.701 [CommandExec](IMPORTANT): BPC1.platform_battery_voltage (volt)
2025-02-06T01:41:02.701Z,1738806062.701 [CommandExec](IMPORTANT): BPC1.BattVoltage_1 (millivolt)
2025-02-06T01:41:02.702Z,1738806062.702 [CommandExec](IMPORTANT): BPC1.BattVoltage_2 (millivolt)
2025-02-06T01:41:02.702Z,1738806062.702 [CommandExec](IMPORTANT): BPC1.BattVoltage_3 (millivolt)
2025-02-06T01:41:02.702Z,1738806062.702 [CommandExec](IMPORTANT): BPC1.BattVoltage_4 (millivolt)
2025-02-06T01:41:02.703Z,1738806062.703 [CommandExec](IMPORTANT): BPC1.BattVoltage_5 (millivolt)
2025-02-06T01:41:02.703Z,1738806062.703 [CommandExec](IMPORTANT): BPC1.BattVoltage_6 (millivolt)
2025-02-06T01:41:02.713Z,1738806062.713 [CommandExec](IMPORTANT): BPC1.BattVoltage_7 (millivolt)
2025-02-06T01:41:02.713Z,1738806062.713 [CommandExec](IMPORTANT): BPC1.BattVoltage_8 (millivolt)
2025-02-06T01:41:02.713Z,1738806062.713 [CommandExec](IMPORTANT): BPC1.BattVoltage_9 (millivolt)
2025-02-06T01:41:02.714Z,1738806062.714 [CommandExec](IMPORTANT): BPC1.BattVoltage_10 (millivolt)
2025-02-06T01:41:02.714Z,1738806062.714 [CommandExec](IMPORTANT): BPC1.BattVoltage_11 (millivolt)
2025-02-06T01:41:02.715Z,1738806062.715 [CommandExec](IMPORTANT): BPC1.BattVoltage_12 (millivolt)
2025-02-06T01:41:02.715Z,1738806062.715 [CommandExec](IMPORTANT): BPC1.BattVoltage_13 (millivolt)
2025-02-06T01:41:02.716Z,1738806062.716 [CommandExec](IMPORTANT): BPC1.BattVoltage_14 (millivolt)
2025-02-06T01:41:02.716Z,1738806062.716 [CommandExec](IMPORTANT): BPC1.BattVoltage_15 (millivolt)
2025-02-06T01:41:02.717Z,1738806062.717 [CommandExec](IMPORTANT): BPC1.BattVoltage_16 (millivolt)
2025-02-06T01:41:02.717Z,1738806062.717 [CommandExec](IMPORTANT): BPC1.BattVoltage_17 (millivolt)
2025-02-06T01:41:02.717Z,1738806062.717 [CommandExec](IMPORTANT): BPC1.BattVoltage_18 (millivolt)
2025-02-06T01:41:02.718Z,1738806062.718 [CommandExec](IMPORTANT): BPC1.BattVoltage_19 (millivolt)
2025-02-06T01:41:02.718Z,1738806062.718 [CommandExec](IMPORTANT): BPC1.BattVoltage_20 (millivolt)
2025-02-06T01:41:02.719Z,1738806062.719 [CommandExec](IMPORTANT): BPC1.BattVoltage_21 (millivolt)
2025-02-06T01:41:02.719Z,1738806062.719 [CommandExec](IMPORTANT): BPC1.BattVoltage_22 (millivolt)
2025-02-06T01:41:02.720Z,1738806062.720 [CommandExec](IMPORTANT): BPC1.BattVoltage_23 (millivolt)
2025-02-06T01:41:02.720Z,1738806062.720 [CommandExec](IMPORTANT): BPC1.BattVoltage_24 (millivolt)
2025-02-06T01:41:02.721Z,1738806062.721 [CommandExec](IMPORTANT): BPC1.BattVoltage_25 (millivolt)
2025-02-06T01:41:02.721Z,1738806062.721 [CommandExec](IMPORTANT): BPC1.BattVoltage_26 (millivolt)
2025-02-06T01:41:02.722Z,1738806062.722 [CommandExec](IMPORTANT): BPC1.BattVoltage_27 (millivolt)
2025-02-06T01:41:02.722Z,1738806062.722 [CommandExec](IMPORTANT): BPC1.BattVoltage_28 (millivolt)
2025-02-06T01:41:02.722Z,1738806062.722 [CommandExec](IMPORTANT): BPC1.BattVoltage_29 (millivolt)
2025-02-06T01:41:02.723Z,1738806062.723 [CommandExec](IMPORTANT): BPC1.BattVoltage_30 (millivolt)
2025-02-06T01:41:02.723Z,1738806062.723 [CommandExec](IMPORTANT): BPC1.BattVoltage_31 (millivolt)
2025-02-06T01:41:02.724Z,1738806062.724 [CommandExec](IMPORTANT): BPC1.BattVoltage_32 (millivolt)
2025-02-06T01:41:02.724Z,1738806062.724 [CommandExec](IMPORTANT): BPC1.BattVoltage_33 (millivolt)
2025-02-06T01:41:02.725Z,1738806062.725 [CommandExec](IMPORTANT): BPC1.BattVoltage_34 (millivolt)
2025-02-06T01:41:02.725Z,1738806062.725 [CommandExec](IMPORTANT): BPC1.BattVoltage_35 (millivolt)
2025-02-06T01:41:02.725Z,1738806062.725 [CommandExec](IMPORTANT): BPC1.BattVoltage_36 (millivolt)
2025-02-06T01:41:02.726Z,1738806062.726 [CommandExec](IMPORTANT): BPC1.BattVoltage_37 (millivolt)
2025-02-06T01:41:02.726Z,1738806062.726 [CommandExec](IMPORTANT): BPC1.BattVoltage_38 (millivolt)
2025-02-06T01:41:02.727Z,1738806062.727 [CommandExec](IMPORTANT): BPC1.BattVoltage_39 (millivolt)
2025-02-06T01:41:02.727Z,1738806062.727 [CommandExec](IMPORTANT): BPC1.BattVoltage_40 (millivolt)
2025-02-06T01:41:02.736Z,1738806062.736 [CommandExec](IMPORTANT): BPC1.BattVoltage_41 (millivolt)
2025-02-06T01:41:02.737Z,1738806062.737 [CommandExec](IMPORTANT): BPC1.BattVoltage_42 (millivolt)
2025-02-06T01:41:02.737Z,1738806062.737 [CommandExec](IMPORTANT): BPC1.BattVoltage_43 (millivolt)
2025-02-06T01:41:02.738Z,1738806062.738 [CommandExec](IMPORTANT): BPC1.BattVoltage_44 (millivolt)
2025-02-06T01:41:02.738Z,1738806062.738 [CommandExec](IMPORTANT): BPC1.BattVoltage_45 (millivolt)
2025-02-06T01:41:02.738Z,1738806062.738 [CommandExec](IMPORTANT): BPC1.BattVoltage_46 (millivolt)
2025-02-06T01:41:02.739Z,1738806062.739 [CommandExec](IMPORTANT): BPC1.BattVoltage_47 (millivolt)
2025-02-06T01:41:02.739Z,1738806062.739 [CommandExec](IMPORTANT): BPC1.BattVoltage_48 (millivolt)
2025-02-06T01:41:02.837Z,1738806062.837 [CommandExec](IMPORTANT): BPC1.BattVoltage_49 (millivolt)
2025-02-06T01:41:02.837Z,1738806062.837 [CommandExec](IMPORTANT): BPC1.BattVoltage_50 (millivolt)
2025-02-06T01:41:02.838Z,1738806062.838 [CommandExec](IMPORTANT): BPC1.BattVoltage_51 (millivolt)
2025-02-06T01:41:02.838Z,1738806062.838 [CommandExec](IMPORTANT): BPC1.BattVoltage_52 (millivolt)
2025-02-06T01:41:02.838Z,1738806062.838 [CommandExec](IMPORTANT): BPC1.BattVoltage_53 (millivolt)
2025-02-06T01:41:02.839Z,1738806062.839 [CommandExec](IMPORTANT): BPC1.BattVoltage_54 (millivolt)
2025-02-06T01:41:02.839Z,1738806062.839 [CommandExec](IMPORTANT): BPC1.BattVoltage_55 (millivolt)
2025-02-06T01:41:02.840Z,1738806062.840 [CommandExec](IMPORTANT): BPC1.BattVoltage_56 (millivolt)
2025-02-06T01:41:02.840Z,1738806062.840 [CommandExec](IMPORTANT): BPC1.BattVoltage_57 (millivolt)
2025-02-06T01:41:02.841Z,1738806062.841 [CommandExec](IMPORTANT): BPC1.BattVoltage_58 (millivolt)
2025-02-06T01:41:02.841Z,1738806062.841 [CommandExec](IMPORTANT): BPC1.BattVoltage_59 (millivolt)
2025-02-06T01:41:02.842Z,1738806062.842 [CommandExec](IMPORTANT): BPC1.BattVoltage_60 (millivolt)
2025-02-06T01:41:02.842Z,1738806062.842 [CommandExec](IMPORTANT): BPC1.BattVoltage_61 (millivolt)
2025-02-06T01:41:02.843Z,1738806062.843 [CommandExec](IMPORTANT): BPC1.BattVoltage_62 (millivolt)
2025-02-06T01:41:02.843Z,1738806062.843 [CommandExec](IMPORTANT): Depth_Keller.component_voltage (volt)
2025-02-06T01:41:02.843Z,1738806062.843 [CommandExec](IMPORTANT): Depth_Keller.component_avgVoltage (volt)
2025-02-06T01:41:02.908Z,1738806062.908 [CommandExec](IMPORTANT): NAL9602.component_voltage (volt)
2025-02-06T01:41:02.909Z,1738806062.909 [CommandExec](IMPORTANT): NAL9602.component_avgVoltage (volt)
2025-02-06T01:41:02.910Z,1738806062.910 [CommandExec](IMPORTANT): Onboard.platform_battery_voltage (volt)
2025-02-06T01:41:02.910Z,1738806062.910 [CommandExec](IMPORTANT): Onboard.MainBatteryVoltage (volt)
2025-02-06T01:41:02.911Z,1738806062.911 [CommandExec](IMPORTANT): Onboard.BackupBatteryVoltage (volt)
2025-02-06T01:41:02.911Z,1738806062.911 [CommandExec](IMPORTANT): Power24vConverter.component_voltage (volt)
2025-02-06T01:41:02.911Z,1738806062.911 [CommandExec](IMPORTANT): Power24vConverter.component_avgVoltage (volt)
2025-02-06T01:41:02.945Z,1738806062.945 [CommandExec](IMPORTANT): Radio_Surface.component_voltage (volt)
2025-02-06T01:41:02.945Z,1738806062.945 [CommandExec](IMPORTANT): Radio_Surface.component_avgVoltage (volt)
2025-02-06T01:41:02.946Z,1738806062.946 [CommandExec](IMPORTANT): Sonardyne_Nano.component_voltage (volt)
2025-02-06T01:41:02.946Z,1738806062.946 [CommandExec](IMPORTANT): Sonardyne_Nano.component_avgVoltage (volt)
2025-02-06T01:41:02.951Z,1738806062.951 [CommandExec](IMPORTANT): BuoyancyServo.component_voltage (volt)
2025-02-06T01:41:02.951Z,1738806062.951 [CommandExec](IMPORTANT): BuoyancyServo.component_avgVoltage (volt)
2025-02-06T01:41:03.000Z,1738806063.000 [CommandExec](IMPORTANT): ElevatorServo.component_voltage (volt)
2025-02-06T01:41:03.001Z,1738806063.001 [CommandExec](IMPORTANT): ElevatorServo.component_avgVoltage (volt)
2025-02-06T01:41:03.002Z,1738806063.002 [CommandExec](IMPORTANT): MassServo.component_voltage (volt)
2025-02-06T01:41:03.002Z,1738806063.002 [CommandExec](IMPORTANT): MassServo.component_avgVoltage (volt)
2025-02-06T01:41:03.003Z,1738806063.003 [CommandExec](IMPORTANT): RudderServo.component_voltage (volt)
2025-02-06T01:41:03.003Z,1738806063.003 [CommandExec](IMPORTANT): RudderServo.component_avgVoltage (volt)
2025-02-06T01:41:03.032Z,1738806063.032 [CommandExec](IMPORTANT): ThrusterHE.component_voltage (volt)
2025-02-06T01:41:03.033Z,1738806063.033 [CommandExec](IMPORTANT): ThrusterHE.component_avgVoltage (volt)
2025-02-06T01:41:03.033Z,1738806063.033 [CommandExec](IMPORTANT): CTD_Seabird.component_voltage (volt)
2025-02-06T01:41:03.034Z,1738806063.034 [CommandExec](IMPORTANT): CTD_Seabird.component_avgVoltage (volt)
2025-02-06T01:41:03.034Z,1738806063.034 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt)
2025-02-06T01:41:03.035Z,1738806063.035 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt)
2025-02-06T01:41:03.035Z,1738806063.035 [CommandExec](IMPORTANT): WetLabsBB2FL.component_voltage (volt)
2025-02-06T01:41:03.036Z,1738806063.036 [CommandExec](IMPORTANT): WetLabsBB2FL.component_avgVoltage (volt)
2025-02-06T01:41:19.230Z,1738806079.230 [CommandExec](IMPORTANT): got command get BPC1.platform_battery_charge
2025-02-06T01:41:19.230Z,1738806079.230 [CommandExec](IMPORTANT): BPC1.platform_battery_charge 22.858999 Ah
2025-02-06T01:42:00.229Z,1738806120.229 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-02-06T01:42:00.229Z,1738806120.229 [Default:CheckIn:C.Wait] Stopped
2025-02-06T01:42:00.229Z,1738806120.229 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-06T01:42:00.229Z,1738806120.229 [Default:CheckIn:D] Running Loop=1
2025-02-06T01:42:00.635Z,1738806120.635 [Default:CheckIn:D] Stopped
2025-02-06T01:42:00.635Z,1738806120.635 [Default:CheckIn:E] Running Loop=1
2025-02-06T01:42:01.044Z,1738806121.044 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  9.874464 min 
2025-02-06T01:42:01.044Z,1738806121.044 [Default:CheckIn:E] Stopped
2025-02-06T01:42:01.044Z,1738806121.044 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-02-06T01:42:01.044Z,1738806121.044 [Default:CheckIn] Stopped
2025-02-06T01:42:01.044Z,1738806121.044 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-06T01:42:01.045Z,1738806121.045 [Default:CheckIn](INFO): Running loop #2
2025-02-06T01:42:01.045Z,1738806121.045 [Default:CheckIn] Running Loop=2
2025-02-06T01:42:01.045Z,1738806121.045 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-06T01:42:01.045Z,1738806121.045 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-06T01:42:03.046Z,17388