2023-01-26T17:20:23.187Z,1674753623.187 [Supervisor](DEBUG): Initializing supervisor.
2023-01-26T17:20:23.192Z,1674753623.192 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-01-26T17:20:23.193Z,1674753623.193 [SyncHandler](INFO): Protected caller Thread ID is 1130
2023-01-26T17:20:23.193Z,1674753623.193 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-01-26T17:20:23.194Z,1674753623.194 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-01-26T17:20:23.195Z,1674753623.195 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1131
2023-01-26T17:20:23.199Z,1674753623.199 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-01-26T17:20:23.216Z,1674753623.216 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-01-26T17:20:23.217Z,1674753623.217 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-01-26T17:20:23.218Z,1674753623.218 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1132
2023-01-26T17:20:23.222Z,1674753623.222 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-01-26T17:20:23.223Z,1674753623.223 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-01-26T17:20:23.223Z,1674753623.223 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1133
2023-01-26T17:20:23.225Z,1674753623.225 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-01-26T17:20:23.226Z,1674753623.226 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-01-26T17:20:23.227Z,1674753623.227 [logger ThreadHandler](INFO): Protected caller Thread ID is 1134
2023-01-26T17:20:23.230Z,1674753623.230 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-01-26T17:20:23.231Z,1674753623.231 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-01-26T17:20:23.232Z,1674753623.232 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-01-26T17:20:23.439Z,1674753623.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-01-26T17:20:23.439Z,1674753623.439 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-01-26T17:20:23.543Z,1674753623.543 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-01-26T17:20:23.543Z,1674753623.543 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-01-26T17:20:23.636Z,1674753623.636 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-01-26T17:20:23.637Z,1674753623.637 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-01-26T17:20:24.074Z,1674753624.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-01-26T17:20:24.074Z,1674753624.074 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-01-26T17:20:24.406Z,1674753624.406 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-01-26T17:20:24.406Z,1674753624.406 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-01-26T17:20:24.725Z,1674753624.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-01-26T17:20:24.726Z,1674753624.726 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-01-26T17:20:24.902Z,1674753624.902 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-01-26T17:20:24.903Z,1674753624.903 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-01-26T17:20:24.981Z,1674753624.981 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-01-26T17:20:25.061Z,1674753625.061 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-01-26T17:20:25.438Z,1674753625.438 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-01-26T17:20:25.438Z,1674753625.438 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-01-26T17:20:25.718Z,1674753625.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-01-26T17:20:25.718Z,1674753625.718 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-01-26T17:20:26.386Z,1674753626.386 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-01-26T17:20:26.387Z,1674753626.387 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-01-26T17:20:26.593Z,1674753626.593 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-01-26T17:20:26.593Z,1674753626.593 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-01-26T17:20:26.824Z,1674753626.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-01-26T17:20:26.825Z,1674753626.825 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-01-26T17:20:26.959Z,1674753626.959 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-01-26T17:20:26.960Z,1674753626.960 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-01-26T17:20:27.696Z,1674753627.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-01-26T17:20:27.698Z,1674753627.698 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2023-01-26T17:20:27.699Z,1674753627.699 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2023-01-26T17:20:27.782Z,1674753627.782 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2023-01-26T17:20:27.954Z,1674753627.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2023-01-26T17:20:28.212Z,1674753628.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-01-26T17:20:28.213Z,1674753628.213 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2023-01-26T17:20:28.331Z,1674753628.331 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2023-01-26T17:20:28.429Z,1674753628.429 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2023-01-26T17:20:28.519Z,1674753628.519 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2023-01-26T17:20:28.628Z,1674753628.628 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2023-01-26T17:20:28.719Z,1674753628.719 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2023-01-26T17:20:28.803Z,1674753628.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2023-01-26T17:20:28.900Z,1674753628.900 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2023-01-26T17:20:29.054Z,1674753629.054 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2023-01-26T17:20:29.054Z,1674753629.054 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-01-26T17:20:29.064Z,1674753629.064 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-01-26T17:20:29.113Z,1674753629.113 [DepthRateCalculator] Loaded
2023-01-26T17:20:29.113Z,1674753629.113 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-01-26T17:20:29.119Z,1674753629.119 [PitchRateCalculator] Loaded
2023-01-26T17:20:29.119Z,1674753629.119 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-01-26T17:20:29.129Z,1674753629.129 [SpeedCalculator] Loaded
2023-01-26T17:20:29.129Z,1674753629.129 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-01-26T17:20:29.134Z,1674753629.134 [YawRateCalculator] Loaded
2023-01-26T17:20:29.134Z,1674753629.134 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-01-26T17:20:29.156Z,1674753629.156 [ElevatorOffsetCalculator] Loaded
2023-01-26T17:20:29.156Z,1674753629.156 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-01-26T17:20:29.156Z,1674753629.156 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-01-26T17:20:29.157Z,1674753629.157 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-01-26T17:20:29.182Z,1674753629.182 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-01-26T17:20:29.183Z,1674753629.183 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-01-26T17:20:29.193Z,1674753629.193 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-01-26T17:20:29.193Z,1674753629.193 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-01-26T17:20:29.617Z,1674753629.617 [AHRS_M2] Loaded
2023-01-26T17:20:29.617Z,1674753629.617 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-01-26T17:20:29.651Z,1674753629.651 [BackseatComponent] Loaded
2023-01-26T17:20:29.652Z,1674753629.652 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-01-26T17:20:29.653Z,1674753629.653 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4083F4E0
2023-01-26T17:20:29.653Z,1674753629.653 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1216
2023-01-26T17:20:29.656Z,1674753629.656 [LcmUniversalReporter] Loaded
2023-01-26T17:20:29.656Z,1674753629.656 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-01-26T17:20:30.446Z,1674753630.446 [BPC1] Loaded
2023-01-26T17:20:30.446Z,1674753630.446 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-01-26T17:20:30.525Z,1674753630.525 [DataOverHttps] Loaded
2023-01-26T17:20:30.525Z,1674753630.525 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-01-26T17:20:30.526Z,1674753630.526 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4086F4E0
2023-01-26T17:20:30.526Z,1674753630.526 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1217
2023-01-26T17:20:30.546Z,1674753630.546 [Depth_Keller] Loaded
2023-01-26T17:20:30.546Z,1674753630.546 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-01-26T17:20:30.551Z,1674753630.551 [DropWeight] Loaded
2023-01-26T17:20:30.551Z,1674753630.551 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-01-26T17:20:30.613Z,1674753630.613 [NAL9602] Loaded
2023-01-26T17:20:30.613Z,1674753630.613 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-01-26T17:20:30.641Z,1674753630.641 [Onboard] Loaded
2023-01-26T17:20:30.641Z,1674753630.641 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-01-26T17:20:30.642Z,1674753630.642 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4089F4E0
2023-01-26T17:20:30.643Z,1674753630.643 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1218
2023-01-26T17:20:30.649Z,1674753630.649 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2023-01-26T17:20:30.659Z,1674753630.659 [PowerOnly] Loaded
2023-01-26T17:20:30.660Z,1674753630.660 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-01-26T17:20:30.671Z,1674753630.671 [Power24vConverter] Loaded
2023-01-26T17:20:30.671Z,1674753630.671 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-01-26T17:20:30.685Z,1674753630.685 [Radio_Surface] Loaded
2023-01-26T17:20:30.685Z,1674753630.685 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-01-26T17:20:30.686Z,1674753630.686 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408CF4E0
2023-01-26T17:20:30.687Z,1674753630.687 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1219
2023-01-26T17:20:30.688Z,1674753630.688 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-01-26T17:20:30.688Z,1674753630.688 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-01-26T17:20:30.799Z,1674753630.799 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-01-26T17:20:30.799Z,1674753630.799 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-01-26T17:20:30.840Z,1674753630.840 [DeadReckonUsingSpeedCalculator] Loaded
2023-01-26T17:20:30.840Z,1674753630.840 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-01-26T17:20:30.854Z,1674753630.854 [NavChart] Loaded
2023-01-26T17:20:30.854Z,1674753630.854 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-01-26T17:20:30.860Z,1674753630.860 [UniversalFixResidualReporter] Loaded
2023-01-26T17:20:30.860Z,1674753630.860 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-01-26T17:20:30.860Z,1674753630.860 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-01-26T17:20:30.861Z,1674753630.861 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-01-26T17:20:31.152Z,1674753631.152 [SBIT](DEBUG): Construct Startup Built In Test.
2023-01-26T17:20:31.168Z,1674753631.168 [SBIT] Loaded
2023-01-26T17:20:31.169Z,1674753631.169 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-01-26T17:20:31.171Z,1674753631.171 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-01-26T17:20:31.184Z,1674753631.184 [IBIT] Loaded
2023-01-26T17:20:31.184Z,1674753631.184 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-01-26T17:20:31.190Z,1674753631.190 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-01-26T17:20:31.514Z,1674753631.514 [CBIT] Loaded
2023-01-26T17:20:31.514Z,1674753631.514 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-01-26T17:20:31.514Z,1674753631.514 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-01-26T17:20:31.515Z,1674753631.515 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-01-26T17:20:31.721Z,1674753631.721 [CTD_Seabird] Loaded
2023-01-26T17:20:31.721Z,1674753631.721 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-01-26T17:20:31.722Z,1674753631.722 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409D34E0
2023-01-26T17:20:31.722Z,1674753631.722 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1220
2023-01-26T17:20:31.742Z,1674753631.742 [PAR_Licor] Loaded
2023-01-26T17:20:31.743Z,1674753631.743 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-01-26T17:20:31.773Z,1674753631.773 [WetLabsBB2FL] Loaded
2023-01-26T17:20:31.773Z,1674753631.773 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-01-26T17:20:31.774Z,1674753631.774 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A034E0
2023-01-26T17:20:31.775Z,1674753631.775 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1221
2023-01-26T17:20:31.775Z,1674753631.775 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-01-26T17:20:31.776Z,1674753631.776 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-01-26T17:20:31.904Z,1674753631.904 [BuoyancyServo] Loaded
2023-01-26T17:20:31.904Z,1674753631.904 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-01-26T17:20:31.926Z,1674753631.926 [ElevatorServo] Loaded
2023-01-26T17:20:31.926Z,1674753631.926 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-01-26T17:20:31.946Z,1674753631.946 [MassServo] Loaded
2023-01-26T17:20:31.947Z,1674753631.947 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-01-26T17:20:31.967Z,1674753631.967 [RudderServo] Loaded
2023-01-26T17:20:31.967Z,1674753631.967 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-01-26T17:20:31.982Z,1674753631.982 [ThrusterHE] Loaded
2023-01-26T17:20:31.982Z,1674753631.982 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-01-26T17:20:31.983Z,1674753631.983 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-01-26T17:20:31.983Z,1674753631.983 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-01-26T17:20:32.032Z,1674753632.032 [VerticalControl](DEBUG): Construct VerticalControl.
2023-01-26T17:20:32.084Z,1674753632.084 [VerticalControl] Loaded
2023-01-26T17:20:32.084Z,1674753632.084 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-01-26T17:20:32.087Z,1674753632.087 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-01-26T17:20:32.124Z,1674753632.124 [HorizontalControl] Loaded
2023-01-26T17:20:32.124Z,1674753632.124 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-01-26T17:20:32.127Z,1674753632.127 [SpeedControl](DEBUG): Construct SpeedControl.
2023-01-26T17:20:32.128Z,1674753632.128 [SpeedControl] Loaded
2023-01-26T17:20:32.129Z,1674753632.129 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-01-26T17:20:32.132Z,1674753632.132 [LoopControl](DEBUG): Construct LoopControl.
2023-01-26T17:20:32.132Z,1674753632.132 [LoopControl] Loaded
2023-01-26T17:20:32.132Z,1674753632.132 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-01-26T17:20:32.133Z,1674753632.133 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-01-26T17:20:32.133Z,1674753632.133 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-01-26T17:20:32.229Z,1674753632.229 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-01-26T17:20:32.230Z,1674753632.230 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-01-26T17:20:32.374Z,1674753632.374 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-01-26T17:20:32.375Z,1674753632.375 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-01-26T17:20:32.673Z,1674753632.673 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-01-26T17:20:32.673Z,1674753632.673 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-01-26T17:20:32.727Z,1674753632.727 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-01-26T17:20:32.733Z,1674753632.733 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-01-26T17:20:32.736Z,1674753632.736 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-01-26T17:20:32.747Z,1674753632.747 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-01-26T17:20:32.748Z,1674753632.748 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA64E0
2023-01-26T17:20:32.749Z,1674753632.749 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1222
2023-01-26T17:20:32.753Z,1674753632.753 [Supervisor](INFO): Main Thread ID is 829
2023-01-26T17:20:32.753Z,1674753632.753 [Supervisor](DEBUG): Running supervisor.
2023-01-26T17:20:32.754Z,1674753632.754 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1223
2023-01-26T17:20:32.754Z,1674753632.754 [CommandExec](INFO): Initializing the command executive.
2023-01-26T17:20:32.756Z,1674753632.756 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1224
2023-01-26T17:20:32.758Z,1674753632.758 [controlThread ThreadHandler](INFO): Handler Thread ID is 1225
2023-01-26T17:20:32.758Z,1674753632.758 [controlThread](DEBUG): Initializing ControlThread
2023-01-26T17:20:32.759Z,1674753632.759 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-01-26T17:20:32.759Z,1674753632.759 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-01-26T17:20:32.760Z,1674753632.760 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-01-26T17:20:32.760Z,1674753632.760 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-01-26T17:20:32.760Z,1674753632.760 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-01-26T17:20:32.767Z,1674753632.767 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:20:32.767Z,1674753632.767 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-01-26T17:20:32.767Z,1674753632.767 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-01-26T17:20:32.768Z,1674753632.768 [SBIT](INFO): Initialize SBIT Component.
2023-01-26T17:20:32.768Z,1674753632.768 [SBIT](IMPORTANT): git: 2023-01-26
2023-01-26T17:20:32.768Z,1674753632.768 [SBIT](INFO): git hash: fbcd350f88251f9a867f3fca05699dec8f096e0d
2023-01-26T17:20:32.769Z,1674753632.769 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-01-26T17:20:32.770Z,1674753632.770 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-01-26T17:20:32.771Z,1674753632.771 [SBIT](INFO): Beginning SBIT in 95.000000 seconds.
2023-01-26T17:20:32.771Z,1674753632.771 [IBIT](INFO): Initialize IBIT Component.
2023-01-26T17:20:32.773Z,1674753632.773 [CBIT](DEBUG): Initialize CBIT Component.
2023-01-26T17:20:32.774Z,1674753632.774 [logger ThreadHandler](INFO): Handler Thread ID is 1226
2023-01-26T17:20:32.784Z,1674753632.784 [CBIT](DEBUG): Initialized mux pins.
2023-01-26T17:20:32.784Z,1674753632.784 [CBIT](DEBUG): Initializing the watchdog timer.
2023-01-26T17:20:32.793Z,1674753632.793 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1227
2023-01-26T17:20:32.804Z,1674753632.805 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1228
2023-01-26T17:20:32.805Z,1674753632.805 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-01-26T17:20:32.808Z,1674753632.808 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-01-26T17:20:32.809Z,1674753632.809 [CBIT](DEBUG): Initializing heartbeat.
2023-01-26T17:20:32.817Z,1674753632.817 [Onboard ThreadHandler](INFO): Handler Thread ID is 1229
2023-01-26T17:20:32.834Z,1674753632.834 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1230
2023-01-26T17:20:32.857Z,1674753632.857 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1231
2023-01-26T17:20:32.858Z,1674753632.858 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-01-26T17:20:32.862Z,1674753632.862 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1233
2023-01-26T17:20:32.865Z,1674753632.865 [WetLabsBB2FL](INFO): Powering up
2023-01-26T17:20:32.866Z,1674753632.866 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1235
2023-01-26T17:20:32.868Z,1674753632.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-01-26T17:20:32.868Z,1674753632.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-01-26T17:20:32.869Z,1674753632.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-01-26T17:20:32.869Z,1674753632.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-01-26T17:20:32.869Z,1674753632.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-01-26T17:20:32.869Z,1674753632.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-01-26T17:20:32.869Z,1674753632.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-01-26T17:20:32.869Z,1674753632.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-01-26T17:20:32.880Z,1674753632.880 [CBIT](DEBUG): Deactivating GF circuits.
2023-01-26T17:20:32.880Z,1674753632.880 [CBIT](DEBUG): Deactivating emergency mode.
2023-01-26T17:20:32.916Z,1674753632.916 [CBIT](DEBUG): Backplane powered.
2023-01-26T17:20:32.921Z,1674753632.921 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-01-26T17:20:32.923Z,1674753632.923 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-01-26T17:20:32.924Z,1674753632.924 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-01-26T17:20:32.925Z,1674753632.925 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-01-26T17:20:32.925Z,1674753632.925 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-01-26T17:20:32.938Z,1674753632.938 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T17:20:32.962Z,1674753632.962 [MissionManager](DEBUG):
2023-01-26T17:20:32.963Z,1674753632.963 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-01-26T17:20:33.024Z,1674753633.024 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-01-26T17:20:33.026Z,1674753633.026 [Default:A.Wait](DEBUG): Construct Wait.
2023-01-26T17:20:33.040Z,1674753633.040 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T17:20:33.051Z,1674753633.051 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-01-26T17:20:33.066Z,1674753633.066 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-01-26T17:20:33.072Z,1674753633.072 [Default:E.Execute](DEBUG): Construct Execute.
2023-01-26T17:20:33.075Z,1674753633.075 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2023-01-26T17:20:33.088Z,1674753633.088 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-01-26T17:20:33.108Z,1674753633.108 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-01-26T17:20:33.175Z,1674753633.175 [Power24vConverter](INFO): Powering up.
2023-01-26T17:20:33.214Z,1674753633.214 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-01-26T17:20:33.220Z,1674753633.220 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-01-26T17:20:33.221Z,1674753633.221 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-01-26T17:20:33.228Z,1674753633.228 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-01-26T17:20:33.229Z,1674753633.229 [MassServo](DEBUG): Initializing EZServoServo.
2023-01-26T17:20:33.236Z,1674753633.236 [MassServo](DEBUG): Initializing MassServo.
2023-01-26T17:20:33.237Z,1674753633.237 [RudderServo](DEBUG): Initializing EZServoServo.
2023-01-26T17:20:33.244Z,1674753633.244 [RudderServo](DEBUG): Initializing RudderServo.
2023-01-26T17:20:33.245Z,1674753633.245 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-01-26T17:20:33.248Z,1674753633.248 [Radio_Surface](INFO): Powering up
2023-01-26T17:20:33.252Z,1674753633.252 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-01-26T17:20:35.508Z,1674753635.508 [WetLabsBB2FL](INFO): Powering down
2023-01-26T17:20:38.997Z,1674753638.997 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-01-26T17:20:39.889Z,1674753639.889 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2023-01-26T17:21:00.978Z,1674753660.978 [NAL9602](INFO): Powering up NAL9602
2023-01-26T17:21:11.891Z,1674753671.891 [NAL9602](INFO): NAL9602 initialized
2023-01-26T17:22:08.492Z,1674753728.492 [SBIT](IMPORTANT): Beginning Startup BIT
2023-01-26T17:22:08.496Z,1674753728.496 [CBIT](IMPORTANT): Beginning ground fault scan
2023-01-26T17:22:19.409Z,1674753739.409 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.003520
CHAN A1 (24V): 0.001090
CHAN A2 (12V): -0.005629
CHAN A3 (5V): -0.002443
CHAN B0 (3.3V): -0.001092
CHAN B1 (3.15aV): -0.001412
CHAN B2 (3.15bV): -0.002162
CHAN B3 (GND): -0.000347
OPEN: 0.004461
Full Scale: +/- 1 mA
2023-01-26T17:22:27.092Z,1674753747.092 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-01-26T17:22:41.227Z,1674753761.227 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2023-01-26T17:23:00.603Z,1674753780.603 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004788
2023-01-26T17:23:02.599Z,1674753782.599 [SBIT](IMPORTANT): SBIT PASSED
2023-01-26T17:23:02.599Z,1674753782.599 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-01-26T17:23:02.600Z,1674753782.600 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;
2023-01-26T17:23:02.600Z,1674753782.600 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2023-01-26T17:23:02.600Z,1674753782.600 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte;
2023-01-26T17:23:02.601Z,1674753782.601 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second;
2023-01-26T17:23:02.601Z,1674753782.601 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_shape 10.000000 count_per_second;
2023-01-26T17:23:02.601Z,1674753782.601 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_slope 0.200000 count_per_millimeter;
2023-01-26T17:23:02.601Z,1674753782.601 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=274.275554 cubic_centimeter;
2023-01-26T17:23:02.601Z,1674753782.601 [SBIT](IMPORTANT): VerticalControl.massDefault=18.860602 millimeter;
2023-01-26T17:23:02.601Z,1674753782.601 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=1 bool;
2023-01-26T17:23:02.000Z,1674753783.000 [MissionManager](IMPORTANT): Started mission Startup
2023-01-26T17:23:03.000Z,1674753783.000 [Startup] Running Loop=1
2023-01-26T17:23:03.000Z,1674753783.000 [Startup](DEBUG): Aggregate::initialize Startup
2023-01-26T17:23:03.000Z,1674753783.000 [Startup:A.GoToSurface] Running Loop=1
2023-01-26T17:23:03.000Z,1674753783.000 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T17:23:03.001Z,1674753783.001 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T17:23:03.002Z,1674753783.002 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T17:23:03.002Z,1674753783.002 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T17:23:03.002Z,1674753783.002 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T17:23:03.003Z,1674753783.003 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T17:23:03.004Z,1674753783.004 [Startup:StartupSatComms] Running Loop=1
2023-01-26T17:23:03.004Z,1674753783.004 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-01-26T17:23:03.005Z,1674753783.005 [Startup:StartupSatComms:A] Running Loop=1
2023-01-26T17:23:03.415Z,1674753783.415 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-01-26T17:23:10.581Z,1674753790.581 [CommandExec](IMPORTANT): got command failComponent
2023-01-26T17:23:10.581Z,1674753790.581 [CommandExec](IMPORTANT): Failed components:
2023-01-26T17:23:10.581Z,1674753790.581 [CommandExec](IMPORTANT): No failed Components.
2023-01-26T17:23:32.904Z,1674753812.904 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-01-26T17:23:32.904Z,1674753812.904 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:23:32.905Z,1674753812.905 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-01-26T17:23:32.905Z,1674753812.905 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:23:32.955Z,1674753812.955 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:23:32.955Z,1674753812.955 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:23:33.310Z,1674753813.310 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:23:33.310Z,1674753813.310 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-01-26T17:23:33.310Z,1674753813.310 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:23:33.310Z,1674753813.310 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-01-26T17:23:33.716Z,1674753813.716 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:23:48.692Z,1674753828.692 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-01-26T17:24:03.194Z,1674753843.194 [Startup:StartupSatComms:A](INFO): Timed out from 2023-01-26T17:23:03.0Z
2023-01-26T17:24:03.194Z,1674753843.194 [Startup:StartupSatComms:A] Stopped
2023-01-26T17:24:03.194Z,1674753843.194 [Startup:StartupSatComms:B] Running Loop=1
2023-01-26T17:24:03.594Z,1674753843.594 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-01-26T17:24:15.008Z,1674753855.008 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-01-26T17:24:17.403Z,1674753857.403 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2023-01-26T17:25:03.390Z,1674753903.390 [Startup:StartupSatComms:B](INFO): Timed out from 2023-01-26T17:24:03.2Z
2023-01-26T17:25:03.390Z,1674753903.390 [Startup:StartupSatComms:B] Stopped
2023-01-26T17:25:03.391Z,1674753903.391 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-01-26T17:25:03.391Z,1674753903.391 [Startup:StartupSatComms] Stopped
2023-01-26T17:25:03.391Z,1674753903.391 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-01-26T17:25:03.391Z,1674753903.391 [Startup](INFO): Completed Startup
2023-01-26T17:25:03.392Z,1674753903.392 [MissionManager](INFO): Startup is completed.
2023-01-26T17:25:03.392Z,1674753903.392 [MissionManager](INFO): Uninitializing Mission Startup
2023-01-26T17:25:03.392Z,1674753903.392 [Startup] Stopped
2023-01-26T17:25:03.392Z,1674753903.392 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-01-26T17:25:03.392Z,1674753903.392 [Startup:A.GoToSurface] Stopped
2023-01-26T17:25:03.392Z,1674753903.392 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T17:25:03.801Z,1674753903.801 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T17:25:03.801Z,1674753903.801 [Default] Running Loop=1
2023-01-26T17:25:03.802Z,1674753903.802 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T17:25:03.802Z,1674753903.802 [Default:B.GoToSurface] Running Loop=1
2023-01-26T17:25:03.802Z,1674753903.802 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T17:25:03.802Z,1674753903.802 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T17:25:03.802Z,1674753903.802 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T17:25:03.803Z,1674753903.803 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T17:25:03.803Z,1674753903.803 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T17:25:03.803Z,1674753903.803 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T17:25:03.803Z,1674753903.803 [Default:A.Wait] Running Loop=1
2023-01-26T17:25:03.803Z,1674753903.803 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T17:25:09.496Z,1674753909.496 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-01-26T17:25:17.139Z,1674753917.139 [Default:A.Wait](INFO): Done Waiting.
2023-01-26T17:25:17.139Z,1674753917.139 [Default:A.Wait] Stopped
2023-01-26T17:25:17.139Z,1674753917.139 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T17:25:17.530Z,1674753917.530 [Default:CheckIn] Running Loop=1
2023-01-26T17:25:17.530Z,1674753917.530 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T17:25:17.530Z,1674753917.530 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T17:25:17.935Z,1674753917.935 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-01-26T17:25:43.423Z,1674753943.423 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2023-01-26T17:26:15.294Z,1674753975.294 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-01-26T17:26:33.913Z,1674753993.913 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-01-26T17:26:33.913Z,1674753993.913 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:26:33.914Z,1674753993.914 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2023-01-26T17:26:33.914Z,1674753993.914 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:26:33.925Z,1674753993.925 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:26:33.925Z,1674753993.925 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:26:34.331Z,1674753994.331 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:26:34.331Z,1674753994.331 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-01-26T17:26:34.340Z,1674753994.340 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:26:34.340Z,1674753994.340 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2023-01-26T17:26:34.694Z,1674753994.694 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:27:26.098Z,1674754046.098 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-01-26T17:27:53.115Z,1674754073.115 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2023-01-26T17:28:20.937Z,1674754100.937 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-01-26T17:28:20.940Z,1674754100.940 [BPC1](INFO): Received data from all battery sticks.
2023-01-26T17:29:34.876Z,1674754174.876 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-01-26T17:29:34.876Z,1674754174.876 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:29:34.877Z,1674754174.877 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2023-01-26T17:29:34.877Z,1674754174.877 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:29:34.888Z,1674754174.888 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:29:34.888Z,1674754174.888 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:29:35.290Z,1674754175.290 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:29:35.290Z,1674754175.290 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-01-26T17:29:35.291Z,1674754175.291 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:29:35.291Z,1674754175.291 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2023-01-26T17:29:35.687Z,1674754175.687 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:30:17.710Z,1674754217.710 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-01-26T17:25:17.5Z
2023-01-26T17:30:17.710Z,1674754217.710 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T17:30:17.710Z,1674754217.710 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T17:30:18.103Z,1674754218.103 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-01-26T17:30:33.078Z,1674754233.078 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T17:30:34.262Z,1674754234.262 [Power24vConverter](INFO): Powering down.
2023-01-26T17:31:13.478Z,1674754273.478 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-01-26T17:31:13.478Z,1674754273.478 [NAL9602] Data Fault, FailCount= 1
2023-01-26T17:31:13.478Z,1674754273.478 [NAL9602](ERROR): Data Fault
2023-01-26T17:31:13.516Z,1674754273.516 [CBIT](ERROR): Data Fault in component: NAL9602
2023-01-26T17:31:13.878Z,1674754273.878 [NAL9602](INFO): Powering down
2023-01-26T17:31:14.716Z,1674754274.716 [CBIT](INFO): Clearing failed state for component NAL9602
2023-01-26T17:31:14.716Z,1674754274.716 [NAL9602] No Fault, FailCount= 1
2023-01-26T17:31:44.182Z,1674754304.182 [NAL9602](INFO): Powering up NAL9602
2023-01-26T17:31:55.094Z,1674754315.094 [NAL9602](INFO): NAL9602 initialized
2023-01-26T17:32:35.903Z,1674754355.903 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-01-26T17:32:35.904Z,1674754355.904 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:32:35.905Z,1674754355.905 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2023-01-26T17:32:35.905Z,1674754355.905 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:32:35.944Z,1674754355.944 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:32:35.944Z,1674754355.944 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:32:36.317Z,1674754356.317 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:32:36.317Z,1674754356.317 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-01-26T17:32:36.318Z,1674754356.318 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:32:36.318Z,1674754356.318 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2023-01-26T17:32:36.713Z,1674754356.713 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:35:36.944Z,1674754536.944 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-01-26T17:35:36.945Z,1674754536.945 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:35:36.946Z,1674754536.946 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2023-01-26T17:35:36.946Z,1674754536.946 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:35:36.962Z,1674754536.962 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:35:36.962Z,1674754536.962 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:35:37.379Z,1674754537.379 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:35:37.379Z,1674754537.379 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-01-26T17:35:37.379Z,1674754537.379 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:35:37.379Z,1674754537.379 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2023-01-26T17:35:37.761Z,1674754537.761 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:36:15.333Z,1674754575.333 [CommandExec](IMPORTANT): got command burn on
2023-01-26T17:36:15.333Z,1674754575.333 [CommandExec](IMPORTANT): Activating dropweight wire
2023-01-26T17:36:43.853Z,1674754603.853 [CommandExec](IMPORTANT): got command burn off
2023-01-26T17:36:43.853Z,1674754603.853 [CommandExec](IMPORTANT): Deactivating dropweight wire
2023-01-26T17:37:35.737Z,1674754655.737 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230126T015010/Courier0265.lzma
2023-01-26T17:37:36.738Z,1674754656.738 [DataOverHttps](INFO): Moved sent file to Logs/20230126T015010/Courier0265.lzma.bak
2023-01-26T17:37:36.738Z,1674754656.738 [DataOverHttps](INFO): SBD MOMSN=17405164
2023-01-26T17:37:52.089Z,1674754672.089 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230126T165614/Courier0000.lzma
2023-01-26T17:37:53.090Z,1674754673.090 [DataOverHttps](INFO): Moved sent file to Logs/20230126T165614/Courier0000.lzma.bak
2023-01-26T17:37:53.090Z,1674754673.090 [DataOverHttps](INFO): SBD MOMSN=17405166
2023-01-26T17:38:08.477Z,1674754688.477 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20230126T165614/Courier0004.lzma
2023-01-26T17:38:09.478Z,1674754689.478 [DataOverHttps](INFO): Moved sent file to Logs/20230126T165614/Courier0004.lzma.bak
2023-01-26T17:38:09.478Z,1674754689.478 [DataOverHttps](INFO): SBD MOMSN=17405169
2023-01-26T17:38:24.895Z,1674754704.895 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230126T165614/Courier0007.lzma
2023-01-26T17:38:25.894Z,1674754705.894 [DataOverHttps](INFO): Moved sent file to Logs/20230126T165614/Courier0007.lzma.bak
2023-01-26T17:38:25.894Z,1674754705.894 [DataOverHttps](INFO): SBD MOMSN=17405171
2023-01-26T17:38:37.964Z,1674754717.964 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-01-26T17:38:37.964Z,1674754717.964 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:38:37.965Z,1674754717.965 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2023-01-26T17:38:37.965Z,1674754717.965 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:38:38.028Z,1674754718.028 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:38:38.028Z,1674754718.028 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:38:38.418Z,1674754718.418 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:38:38.418Z,1674754718.418 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-01-26T17:38:38.418Z,1674754718.418 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:38:38.418Z,1674754718.418 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2023-01-26T17:38:38.776Z,1674754718.776 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:38:41.336Z,1674754721.336 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230126T171457/Courier0000.lzma
2023-01-26T17:38:42.338Z,1674754722.338 [DataOverHttps](INFO): Moved sent file to Logs/20230126T171457/Courier0000.lzma.bak
2023-01-26T17:38:42.338Z,1674754722.338 [DataOverHttps](INFO): SBD MOMSN=17405173
2023-01-26T17:38:57.644Z,1674754737.644 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230126T171841/Courier0000.lzma
2023-01-26T17:38:58.646Z,1674754738.646 [DataOverHttps](INFO): Moved sent file to Logs/20230126T171841/Courier0000.lzma.bak
2023-01-26T17:38:58.646Z,1674754738.646 [DataOverHttps](INFO): SBD MOMSN=17405176
2023-01-26T17:39:13.506Z,1674754753.506 [CommandExec](IMPORTANT): got command burn off
2023-01-26T17:39:13.506Z,1674754753.506 [CommandExec](IMPORTANT): Deactivating dropweight wire
2023-01-26T17:39:14.324Z,1674754754.324 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230126T172023/Courier0000.lzma
2023-01-26T17:39:15.326Z,1674754755.326 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0000.lzma.bak
2023-01-26T17:39:15.326Z,1674754755.326 [DataOverHttps](INFO): SBD MOMSN=17405179
2023-01-26T17:39:30.648Z,1674754770.648 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230126T172023/Courier0004.lzma
2023-01-26T17:39:31.650Z,1674754771.650 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0004.lzma.bak
2023-01-26T17:39:31.650Z,1674754771.650 [DataOverHttps](INFO): SBD MOMSN=17405182
2023-01-26T17:39:47.481Z,1674754787.481 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20230126T015010/Express0266.lzma
2023-01-26T17:39:48.482Z,1674754788.482 [DataOverHttps](INFO): Moved sent file to Logs/20230126T015010/Express0266.lzma.bak
2023-01-26T17:39:48.482Z,1674754788.482 [DataOverHttps](INFO): SBD MOMSN=17405184
2023-01-26T17:40:04.015Z,1674754804.015 [DataOverHttps](INFO): Sending 1199 bytes from file Logs/20230126T165614/Express0001.lzma
2023-01-26T17:40:05.014Z,1674754805.014 [DataOverHttps](INFO): Moved sent file to Logs/20230126T165614/Express0001.lzma.bak
2023-01-26T17:40:05.014Z,1674754805.014 [DataOverHttps](INFO): SBD MOMSN=17405188
2023-01-26T17:40:20.717Z,1674754820.717 [DataOverHttps](INFO): Sending 378 bytes from file Logs/20230126T165614/Express0005.lzma
2023-01-26T17:40:21.718Z,1674754821.718 [DataOverHttps](INFO): Moved sent file to Logs/20230126T165614/Express0005.lzma.bak
2023-01-26T17:40:21.718Z,1674754821.718 [DataOverHttps](INFO): SBD MOMSN=17405232
2023-01-26T17:40:33.158Z,1674754833.158 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T17:40:37.011Z,1674754837.011 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230126T165614/Express0008.lzma
2023-01-26T17:40:38.014Z,1674754838.014 [DataOverHttps](INFO): Moved sent file to Logs/20230126T165614/Express0008.lzma.bak
2023-01-26T17:40:38.014Z,1674754838.014 [DataOverHttps](INFO): SBD MOMSN=17405245
2023-01-26T17:40:53.366Z,1674754853.366 [DataOverHttps](INFO): Sending 1132 bytes from file Logs/20230126T171457/Express0001.lzma
2023-01-26T17:40:54.366Z,1674754854.366 [DataOverHttps](INFO): Moved sent file to Logs/20230126T171457/Express0001.lzma.bak
2023-01-26T17:40:54.366Z,1674754854.366 [DataOverHttps](INFO): SBD MOMSN=17405247
2023-01-26T17:41:10.111Z,1674754870.111 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230126T171457/Express0005.lzma
2023-01-26T17:41:11.114Z,1674754871.114 [DataOverHttps](INFO): Moved sent file to Logs/20230126T171457/Express0005.lzma.bak
2023-01-26T17:41:11.114Z,1674754871.114 [DataOverHttps](INFO): SBD MOMSN=17405287
2023-01-26T17:41:26.488Z,1674754886.488 [DataOverHttps](INFO): Sending 456 bytes from file Logs/20230126T171841/Express0001.lzma
2023-01-26T17:41:27.492Z,1674754887.492 [DataOverHttps](INFO): Moved sent file to Logs/20230126T171841/Express0001.lzma.bak
2023-01-26T17:41:27.492Z,1674754887.492 [DataOverHttps](INFO): SBD MOMSN=17405289
2023-01-26T17:41:38.996Z,1674754898.996 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-01-26T17:41:38.996Z,1674754898.996 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:41:38.998Z,1674754898.998 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2023-01-26T17:41:38.998Z,1674754898.998 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:41:39.087Z,1674754899.087 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:41:39.087Z,1674754899.087 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:41:39.435Z,1674754899.435 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:41:39.435Z,1674754899.435 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-01-26T17:41:39.435Z,1674754899.435 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:41:39.435Z,1674754899.435 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2023-01-26T17:41:39.800Z,1674754899.800 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:41:43.205Z,1674754903.205 [DataOverHttps](INFO): Sending 878 bytes from file Logs/20230126T172023/Express0001.lzma
2023-01-26T17:41:44.206Z,1674754904.206 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0001.lzma.bak
2023-01-26T17:41:44.206Z,1674754904.206 [DataOverHttps](INFO): SBD MOMSN=17405300
2023-01-26T17:41:56.342Z,1674754916.342 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-01-26T17:41:56.342Z,1674754916.342 [NAL9602] Data Fault, FailCount= 2
2023-01-26T17:41:56.342Z,1674754916.342 [NAL9602](ERROR): Data Fault
2023-01-26T17:41:56.428Z,1674754916.428 [CBIT](ERROR): Data Fault in component: NAL9602
2023-01-26T17:41:56.745Z,1674754916.745 [NAL9602](INFO): Powering down
2023-01-26T17:41:57.599Z,1674754917.599 [CBIT](INFO): Clearing failed state for component NAL9602
2023-01-26T17:41:57.599Z,1674754917.599 [NAL9602] No Fault, FailCount= 2
2023-01-26T17:41:59.604Z,1674754919.604 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20230126T172023/Express0005.lzma
2023-01-26T17:42:00.606Z,1674754920.606 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0005.lzma.bak
2023-01-26T17:42:00.606Z,1674754920.606 [DataOverHttps](INFO): SBD MOMSN=17405323
2023-01-26T17:42:02.007Z,1674754922.007 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T17:42:02.007Z,1674754922.007 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T17:42:02.007Z,1674754922.007 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T17:42:27.066Z,1674754947.066 [NAL9602](INFO): Powering up NAL9602
2023-01-26T17:42:37.970Z,1674754957.970 [NAL9602](INFO): NAL9602 initialized
2023-01-26T17:44:39.991Z,1674755079.991 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2023-01-26T17:44:39.992Z,1674755079.992 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:44:39.993Z,1674755079.993 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2023-01-26T17:44:39.993Z,1674755079.993 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:44:40.003Z,1674755080.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:44:40.003Z,1674755080.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:44:40.427Z,1674755080.427 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:44:40.427Z,1674755080.427 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2023-01-26T17:44:40.427Z,1674755080.427 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:44:40.427Z,1674755080.427 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2023-01-26T17:44:40.817Z,1674755080.817 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:47:02.606Z,1674755222.606 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T17:47:02.606Z,1674755222.606 [Default:CheckIn:C.Wait] Stopped
2023-01-26T17:47:02.606Z,1674755222.606 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T17:47:02.606Z,1674755222.606 [Default:CheckIn:D] Running Loop=1
2023-01-26T17:47:03.011Z,1674755223.011 [Default:CheckIn:D] Stopped
2023-01-26T17:47:03.011Z,1674755223.011 [Default:CheckIn:E] Running Loop=1
2023-01-26T17:47:03.415Z,1674755223.415 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.986820 min
2023-01-26T17:47:03.415Z,1674755223.415 [Default:CheckIn:E] Stopped
2023-01-26T17:47:03.415Z,1674755223.415 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T17:47:03.415Z,1674755223.415 [Default:CheckIn] Stopped
2023-01-26T17:47:03.415Z,1674755223.415 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T17:47:03.415Z,1674755223.415 [Default:CheckIn](INFO): Running loop #2
2023-01-26T17:47:03.416Z,1674755223.416 [Default:CheckIn] Running Loop=2
2023-01-26T17:47:03.416Z,1674755223.416 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T17:47:03.416Z,1674755223.416 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T17:47:40.988Z,1674755260.988 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2023-01-26T17:47:40.988Z,1674755260.988 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:47:40.989Z,1674755260.989 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2023-01-26T17:47:40.989Z,1674755260.989 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:47:41.016Z,1674755261.016 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:47:41.016Z,1674755261.016 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:47:41.415Z,1674755261.415 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:47:41.415Z,1674755261.415 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2023-01-26T17:47:41.415Z,1674755261.415 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:47:41.415Z,1674755261.415 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2023-01-26T17:47:41.813Z,1674755261.813 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:50:33.538Z,1674755433.538 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T17:50:42.012Z,1674755442.012 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2023-01-26T17:50:42.012Z,1674755442.012 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:50:42.013Z,1674755442.013 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2023-01-26T17:50:42.013Z,1674755442.013 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:50:42.024Z,1674755442.024 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:50:42.024Z,1674755442.024 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:50:42.433Z,1674755442.433 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:50:42.433Z,1674755442.433 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2023-01-26T17:50:42.434Z,1674755442.434 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:50:42.434Z,1674755442.434 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2023-01-26T17:50:42.820Z,1674755442.820 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:52:03.622Z,1674755523.622 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-01-26T17:47:03.4Z
2023-01-26T17:52:03.622Z,1674755523.622 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T17:52:03.622Z,1674755523.622 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T17:52:09.815Z,1674755529.815 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230126T172023/Courier0007.lzma
2023-01-26T17:52:10.818Z,1674755530.818 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0007.lzma.bak
2023-01-26T17:52:10.818Z,1674755530.818 [DataOverHttps](INFO): SBD MOMSN=17405327
2023-01-26T17:52:26.272Z,1674755546.272 [DataOverHttps](INFO): Sending 311 bytes from file Logs/20230126T172023/Express0008.lzma
2023-01-26T17:52:27.274Z,1674755547.274 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0008.lzma.bak
2023-01-26T17:52:27.274Z,1674755547.274 [DataOverHttps](INFO): SBD MOMSN=17405329
2023-01-26T17:52:28.695Z,1674755548.695 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T17:52:28.695Z,1674755548.695 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T17:52:28.695Z,1674755548.695 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T17:52:39.571Z,1674755559.571 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-01-26T17:52:39.571Z,1674755559.571 [NAL9602] Data Fault, FailCount= 3
2023-01-26T17:52:39.571Z,1674755559.571 [NAL9602](ERROR): Data Fault
2023-01-26T17:52:39.588Z,1674755559.588 [CBIT](ERROR): Data Fault in component: NAL9602
2023-01-26T17:52:39.966Z,1674755559.966 [NAL9602](INFO): Powering down
2023-01-26T17:52:40.798Z,1674755560.798 [CBIT](INFO): Clearing failed state for component NAL9602
2023-01-26T17:52:40.798Z,1674755560.798 [NAL9602] No Fault, FailCount= 3
2023-01-26T17:53:10.267Z,1674755590.267 [NAL9602](INFO): Powering up NAL9602
2023-01-26T17:53:21.182Z,1674755601.182 [NAL9602](INFO): NAL9602 initialized
2023-01-26T17:53:43.032Z,1674755623.032 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2023-01-26T17:53:43.032Z,1674755623.032 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:53:43.034Z,1674755623.034 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11
2023-01-26T17:53:43.034Z,1674755623.034 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:53:43.089Z,1674755623.089 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:53:43.089Z,1674755623.089 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:53:43.455Z,1674755623.455 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:53:43.455Z,1674755623.455 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2023-01-26T17:53:43.455Z,1674755623.455 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:53:43.455Z,1674755623.455 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11
2023-01-26T17:53:43.808Z,1674755623.808 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:56:44.021Z,1674755804.021 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2023-01-26T17:56:44.021Z,1674755804.021 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:56:44.022Z,1674755804.022 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12
2023-01-26T17:56:44.022Z,1674755804.022 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:56:44.034Z,1674755804.034 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:56:44.034Z,1674755804.034 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:56:44.430Z,1674755804.430 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:56:44.430Z,1674755804.430 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2023-01-26T17:56:44.431Z,1674755804.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:56:44.431Z,1674755804.431 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12
2023-01-26T17:56:44.797Z,1674755804.797 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T17:57:29.260Z,1674755849.260 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T17:57:29.260Z,1674755849.260 [Default:CheckIn:C.Wait] Stopped
2023-01-26T17:57:29.260Z,1674755849.260 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T17:57:29.260Z,1674755849.260 [Default:CheckIn:D] Running Loop=1
2023-01-26T17:57:29.672Z,1674755849.672 [Default:CheckIn:D] Stopped
2023-01-26T17:57:29.672Z,1674755849.672 [Default:CheckIn:E] Running Loop=1
2023-01-26T17:57:30.052Z,1674755850.052 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.431167 min
2023-01-26T17:57:30.052Z,1674755850.052 [Default:CheckIn:E] Stopped
2023-01-26T17:57:30.052Z,1674755850.052 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T17:57:30.052Z,1674755850.052 [Default:CheckIn] Stopped
2023-01-26T17:57:30.052Z,1674755850.052 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T17:57:30.052Z,1674755850.052 [Default:CheckIn](INFO): Running loop #3
2023-01-26T17:57:30.052Z,1674755850.053 [Default:CheckIn] Running Loop=3
2023-01-26T17:57:30.053Z,1674755850.053 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T17:57:30.053Z,1674755850.053 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T17:59:45.021Z,1674755985.021 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2023-01-26T17:59:45.021Z,1674755985.021 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-01-26T17:59:45.022Z,1674755985.022 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13
2023-01-26T17:59:45.022Z,1674755985.022 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-01-26T17:59:45.077Z,1674755985.077 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-01-26T17:59:45.077Z,1674755985.077 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-01-26T17:59:45.440Z,1674755985.440 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-01-26T17:59:45.444Z,1674755985.444 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2023-01-26T17:59:45.444Z,1674755985.444 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-01-26T17:59:45.445Z,1674755985.445 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13
2023-01-26T17:59:45.816Z,1674755985.816 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-01-26T18:00:33.924Z,1674756033.924 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T18:00:58.939Z,1674756058.939 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180057.00,A,3648.17601,N,12147.28142,W,0.117,0.00,260123,,,A*70
2023-01-26T18:00:58.943Z,1674756058.943 [NAL9602](INFO): GPS fix at 20230126T180057: (36.802934, -121.788024)
2023-01-26T18:00:58.957Z,1674756058.957 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:00:58.957Z,1674756058.957 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:01:06.308Z,1674756066.308 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20230126T172023/Courier0010.lzma
2023-01-26T18:01:07.310Z,1674756067.310 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0010.lzma.bak
2023-01-26T18:01:07.310Z,1674756067.310 [DataOverHttps](INFO): SBD MOMSN=17405343
2023-01-26T18:01:22.920Z,1674756082.920 [DataOverHttps](INFO): Sending 318 bytes from file Logs/20230126T172023/Express0011.lzma
2023-01-26T18:01:23.922Z,1674756083.922 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0011.lzma.bak
2023-01-26T18:01:23.922Z,1674756083.922 [DataOverHttps](INFO): SBD MOMSN=17405346
2023-01-26T18:01:25.613Z,1674756085.613 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:01:25.613Z,1674756085.613 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:01:25.613Z,1674756085.613 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:01:31.255Z,1674756091.255 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:01:51.365Z,1674756111.365 [CommandExec](IMPORTANT): got command ibit
2023-01-26T18:01:51.483Z,1674756111.483 [IBIT](IMPORTANT): Beginning Initiated BIT
2023-01-26T18:01:51.483Z,1674756111.483 [IBIT](IMPORTANT): Beginning control surface checks.
2023-01-26T18:01:51.487Z,1674756111.487 [CBIT](IMPORTANT): Beginning ground fault scan
2023-01-26T18:01:53.084Z,1674756113.084 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180151.00,A,3648.17554,N,12147.27949,W,0.097,0.00,260123,,,A*71
2023-01-26T18:01:53.086Z,1674756113.086 [NAL9602](INFO): GPS fix at 20230126T180151: (36.802926, -121.787992)
2023-01-26T18:01:54.421Z,1674756114.421 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2023-01-26T18:02:02.390Z,1674756122.390 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006668
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.005123
CHAN A3 (5V): -0.003452
CHAN B0 (3.3V): -0.001302
CHAN B1 (3.15aV): -0.002061
CHAN B2 (3.15bV): -0.000881
CHAN B3 (GND): -0.000454
OPEN: 0.004158
Full Scale: +/- 1 mA
2023-01-26T18:02:38.025Z,1674756158.025 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 2
Latitude: 36.802925 Longitude: -121.787994
2023-01-26T18:02:38.323Z,1674756158.323 [NAL9602](INFO): SBD MO Status=2, MOMSN=11067, MT Status=2, MTMSN=0
2023-01-26T18:02:38.323Z,1674756158.323 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-01-26T18:02:38.402Z,1674756158.402 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.660000
2023-01-26T18:02:38.402Z,1674756158.402 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2023-01-26T18:02:38.402Z,1674756158.402 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2023-01-26T18:02:38.791Z,1674756158.791 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2023-01-26T18:02:38.791Z,1674756158.791 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2023-01-26T18:02:38.791Z,1674756158.791 [IBIT](IMPORTANT): Pressure:9.190597 PSI
2023-01-26T18:02:38.792Z,1674756158.792 [IBIT](IMPORTANT): Humidity:15.608595 %
2023-01-26T18:02:39.167Z,1674756159.167 [IBIT](IMPORTANT): Vehicle Pitch:-0.540703 degrees
2023-01-26T18:02:39.167Z,1674756159.167 [IBIT](IMPORTANT): Vehicle Roll:-2.896957 degrees
2023-01-26T18:02:39.168Z,1674756159.168 [IBIT](IMPORTANT): Vehicle Heading:72.973724 degrees
2023-01-26T18:02:39.589Z,1674756159.589 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2023-01-26T18:02:39.589Z,1674756159.589 [IBIT](IMPORTANT): buoyancyNeutral: 274.275543 cc
2023-01-26T18:02:39.589Z,1674756159.589 [IBIT](IMPORTANT): massDefault: 1.886060 cm
2023-01-26T18:02:39.590Z,1674756159.590 [IBIT](IMPORTANT): stopDepth: 290.000000 m
2023-01-26T18:02:39.590Z,1674756159.590 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2023-01-26T18:02:39.590Z,1674756159.590 [IBIT](IMPORTANT): IBIT PASSED
2023-01-26T18:03:01.351Z,1674756181.351 [NAL9602](INFO): SBD MO Status=0, MOMSN=11067, MT Status=0, MTMSN=0
2023-01-26T18:03:01.351Z,1674756181.351 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:03:32.053Z,1674756212.053 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:06:26.246Z,1674756386.246 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T18:06:26.246Z,1674756386.246 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:06:26.246Z,1674756386.246 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:06:26.246Z,1674756386.246 [Default:CheckIn:D] Running Loop=1
2023-01-26T18:06:26.636Z,1674756386.636 [Default:CheckIn:D] Stopped
2023-01-26T18:06:26.636Z,1674756386.636 [Default:CheckIn:E] Running Loop=1
2023-01-26T18:06:27.039Z,1674756387.039 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.380570 min
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn:E] Stopped
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn] Stopped
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn](INFO): Running loop #4
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn] Running Loop=4
2023-01-26T18:06:27.040Z,1674756387.040 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:06:27.041Z,1674756387.041 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:06:29.063Z,1674756389.063 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180628.00,A,3648.17186,N,12147.27815,W,0.117,0.00,260123,,,A*72
2023-01-26T18:06:29.065Z,1674756389.065 [NAL9602](INFO): GPS fix at 20230126T180628: (36.802864, -121.787969)
2023-01-26T18:06:29.077Z,1674756389.077 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:06:29.077Z,1674756389.077 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:06:36.199Z,1674756396.199 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230126T172023/Courier0013.lzma
2023-01-26T18:06:37.202Z,1674756397.202 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0013.lzma.bak
2023-01-26T18:06:37.202Z,1674756397.202 [DataOverHttps](INFO): SBD MOMSN=17405352
2023-01-26T18:06:46.422Z,1674756406.422 [NAL9602](INFO): SBD MO Status=0, MOMSN=11068, MT Status=0, MTMSN=0
2023-01-26T18:06:46.422Z,1674756406.422 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:06:52.825Z,1674756412.825 [DataOverHttps](INFO): Sending 776 bytes from file Logs/20230126T172023/Express0014.lzma
2023-01-26T18:06:53.826Z,1674756413.826 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0014.lzma.bak
2023-01-26T18:06:53.826Z,1674756413.826 [DataOverHttps](INFO): SBD MOMSN=17405355
2023-01-26T18:06:55.320Z,1674756415.320 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:06:55.320Z,1674756415.320 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:06:55.320Z,1674756415.320 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:07:17.129Z,1674756437.129 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:10:34.298Z,1674756634.298 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T18:11:10.182Z,1674756670.182 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T181109
2023-01-26T18:11:17.476Z,1674756677.476 [DataOverHttps](INFO): Received command: sched asap "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.80125 degree;set transit.Longitude -121.79578 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b3uf 1 2
2023-01-26T18:11:17.497Z,1674756677.497 [CommandExec](IMPORTANT): got command schedule asap "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.80125 degree;set transit.Longitude -121.79578 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b3uf 1 2.000000
2023-01-26T18:11:17.498Z,1674756677.498 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=4b3uf
2023-01-26T18:11:17.499Z,1674756677.499 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='4b3uf'): "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.80125 degree;set transit.Longitude -121.79578 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m", ASAP
2023-01-26T18:11:18.478Z,1674756678.478 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T181117
2023-01-26T18:11:25.756Z,1674756685.756 [DataOverHttps](INFO): Received command: sched asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b3uf 2 2
2023-01-26T18:11:25.815Z,1674756685.815 [CommandExec](IMPORTANT): got command schedule asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b3uf 2 2.000000
2023-01-26T18:11:25.815Z,1674756685.815 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=4b3uf
2023-01-26T18:11:25.816Z,1674756685.816 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='4b3uf'): "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run", ASAP
2023-01-26T18:11:25.930Z,1674756685.930 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2023-01-26T18:11:25.930Z,1674756685.930 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2023-01-26T18:11:25.930Z,1674756685.930 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Transport/transit.tx
2023-01-26T18:11:26.034Z,1674756686.034 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2023-01-26T18:11:26.049Z,1674756686.049 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2023-01-26T18:11:26.051Z,1674756686.051 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2023-01-26T18:11:26.058Z,1674756686.058 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2023-01-26T18:11:26.061Z,1674756686.061 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2023-01-26T18:11:26.064Z,1674756686.064 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2023-01-26T18:11:26.066Z,1674756686.066 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2023-01-26T18:11:26.093Z,1674756686.093 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2023-01-26T18:11:26.096Z,1674756686.096 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2023-01-26T18:11:26.099Z,1674756686.099 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2023-01-26T18:11:26.101Z,1674756686.101 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2023-01-26T18:11:26.104Z,1674756686.104 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2023-01-26T18:11:26.118Z,1674756686.118 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2023-01-26T18:11:26.119Z,1674756686.119 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2023-01-26T18:11:26.202Z,1674756686.202 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h
2023-01-26T18:11:26.213Z,1674756686.213 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2023-01-26T18:11:26.220Z,1674756686.220 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2023-01-26T18:11:26.223Z,1674756686.223 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2023-01-26T18:11:26.234Z,1674756686.234 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2023-01-26T18:11:26.238Z,1674756686.238 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2023-01-26T18:11:26.249Z,1674756686.249 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2023-01-26T18:11:26.256Z,1674756686.256 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2023-01-26T18:11:26.267Z,1674756686.267 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T18:11:26.306Z,1674756686.306 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2023-01-26T18:11:26.347Z,1674756686.347 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2023-01-26T18:11:26.364Z,1674756686.364 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2023-01-26T18:11:26.367Z,1674756686.367 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2023-01-26T18:11:26.368Z,1674756686.368 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2023-01-26T18:11:26.435Z,1674756686.435 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2023-01-26T18:11:26.457Z,1674756686.457 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2023-01-26T18:11:26.480Z,1674756686.480 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2023-01-26T18:11:26.483Z,1674756686.483 [transit:MassHold.Pitch](DEBUG): Construct.
2023-01-26T18:11:26.503Z,1674756686.503 [transit:Transit:A.Pitch](DEBUG): Construct.
2023-01-26T18:11:26.513Z,1674756686.513 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2023-01-26T18:11:26.520Z,1674756686.520 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2023-01-26T18:11:26.577Z,1674756686.577 [MissionManager](DEBUG):
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.xml
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 1 second
insert Insert/StandardEnvelopes.xml
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
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"
}
}
2023-01-26T18:11:26.577Z,1674756686.577 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl
2023-01-26T18:11:34.538Z,1674756694.538 [CommandExec](IMPORTANT): got command set transit.MissionTimeout 20 minute
2023-01-26T18:11:34.539Z,1674756694.539 [CommandExec](IMPORTANT): got command set transit.NeedCommsTime 10 minute
2023-01-26T18:11:34.540Z,1674756694.540 [CommandExec](IMPORTANT): got command set transit.Latitude 36.80125 degree
2023-01-26T18:11:34.541Z,1674756694.541 [CommandExec](IMPORTANT): got command set transit.Longitude -121.79578 degree
2023-01-26T18:11:34.541Z,1674756694.541 [CommandExec](IMPORTANT): got command set transit.Depth 0.5 meter
2023-01-26T18:11:34.542Z,1674756694.542 [CommandExec](IMPORTANT): got command set transit.MaxDepth 1 meter
2023-01-26T18:11:37.383Z,1674756697.383 [CommandExec](IMPORTANT): got command set transit.MinOffshore 0.0001 kilometer
2023-01-26T18:11:37.384Z,1674756697.384 [CommandExec](IMPORTANT): got command set transit.MinAltitude 1 meter
2023-01-26T18:11:37.384Z,1674756697.384 [CommandExec](IMPORTANT): got command run
2023-01-26T18:11:37.386Z,1674756697.386 [CommandExec](IMPORTANT): Running
2023-01-26T18:11:37.745Z,1674756697.745 [Default] Stopped
2023-01-26T18:11:37.745Z,1674756697.745 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T18:11:37.745Z,1674756697.745 [Default:B.GoToSurface] Stopped
2023-01-26T18:11:37.745Z,1674756697.745 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T18:11:37.745Z,1674756697.745 [Default:CheckIn] Stopped
2023-01-26T18:11:37.745Z,1674756697.745 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:11:37.745Z,1674756697.745 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:11:37.745Z,1674756697.745 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:11:37.746Z,1674756697.746 [MissionManager](IMPORTANT): Started mission transit
2023-01-26T18:11:37.746Z,1674756697.746 [transit] Running Loop=1
2023-01-26T18:11:37.746Z,1674756697.746 [transit](DEBUG): Aggregate::initialize transit
2023-01-26T18:11:37.746Z,1674756697.746 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:11:37.746Z,1674756697.746 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2023-01-26T18:11:37.746Z,1674756697.746 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:11:37.746Z,1674756697.746 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2023-01-26T18:11:37.747Z,1674756697.747 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:11:37.747Z,1674756697.747 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2023-01-26T18:11:37.747Z,1674756697.747 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:11:37.747Z,1674756697.747 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2023-01-26T18:11:37.747Z,1674756697.747 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:11:37.747Z,1674756697.747 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2023-01-26T18:11:37.747Z,1674756697.747 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:11:37.747Z,1674756697.747 [transit:MassHold.Pitch](DEBUG): Initialize.
2023-01-26T18:11:37.748Z,1674756697.748 [transit:B] Running Loop=1
2023-01-26T18:11:37.748Z,1674756697.748 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:11:37.749Z,1674756697.749 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:11:37.749Z,1674756697.749 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:11:37.749Z,1674756697.749 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:11:37.749Z,1674756697.749 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:11:37.750Z,1674756697.750 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:11:37.751Z,1674756697.751 [transit:B] Stopped
2023-01-26T18:11:37.751Z,1674756697.751 [transit:C] Running Loop=1
2023-01-26T18:11:38.132Z,1674756698.132 [transit:C] Stopped
2023-01-26T18:11:38.132Z,1674756698.132 [transit:E] Running Loop=1
2023-01-26T18:11:38.529Z,1674756698.529 [transit:E] Stopped
2023-01-26T18:11:38.529Z,1674756698.529 [transit:F] Running Loop=1
2023-01-26T18:11:38.945Z,1674756698.945 [transit:F] Stopped
2023-01-26T18:11:38.945Z,1674756698.945 [transit:G] Running Loop=1
2023-01-26T18:11:39.336Z,1674756699.336 [transit:G] Stopped
2023-01-26T18:11:39.336Z,1674756699.336 [transit:Transit] Running Loop=1
2023-01-26T18:11:39.336Z,1674756699.336 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2023-01-26T18:11:39.336Z,1674756699.336 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:11:39.336Z,1674756699.336 [transit:Transit:A.Pitch](DEBUG): Initialize.
2023-01-26T18:11:39.336Z,1674756699.336 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:11:39.336Z,1674756699.336 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2023-01-26T18:11:39.337Z,1674756699.337 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2023-01-26T18:11:39.337Z,1674756699.337 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2023-01-26T18:11:39.338Z,1674756699.338 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.801250,-121.795776
2023-01-26T18:11:39.339Z,1674756699.339 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2023-01-26T18:11:39.747Z,1674756699.747 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:11:39.747Z,1674756699.747 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:13:13.986Z,1674756793.986 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T181313
2023-01-26T18:13:21.688Z,1674756801.688 [DataOverHttps](INFO): Received command: load Transport/transit.tl;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Depth 5 m;set transit.MaxDepth 10 m;set transit.MinOffshore 0.1 km;run
2023-01-26T18:13:21.763Z,1674756801.763 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2023-01-26T18:13:21.764Z,1674756801.764 [MissionManager](INFO): Uninitializing Mission transit
2023-01-26T18:13:21.764Z,1674756801.764 [transit] Stopped
2023-01-26T18:13:21.764Z,1674756801.764 [transit](DEBUG): Aggregate::uninitialize transit
2023-01-26T18:13:21.764Z,1674756801.764 [transit:StandardEnvelopes] Stopped
2023-01-26T18:13:21.764Z,1674756801.764 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2023-01-26T18:13:21.764Z,1674756801.764 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2023-01-26T18:13:21.764Z,1674756801.764 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2023-01-26T18:13:21.765Z,1674756801.765 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2023-01-26T18:13:21.765Z,1674756801.765 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2023-01-26T18:13:21.765Z,1674756801.765 [transit:BuoyancyHold.Buoyancy] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2023-01-26T18:13:21.765Z,1674756801.765 [transit:MassHold.Pitch] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit:A.Pitch] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit:B.SetSpeed] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit:Wpt1.Waypoint] Stopped
2023-01-26T18:13:21.765Z,1674756801.765 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2023-01-26T18:13:21.776Z,1674756801.776 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2023-01-26T18:13:21.777Z,1674756801.777 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Transport/transit.tx
2023-01-26T18:13:21.892Z,1674756801.892 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2023-01-26T18:13:21.894Z,1674756801.894 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2023-01-26T18:13:21.896Z,1674756801.896 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2023-01-26T18:13:21.898Z,1674756801.898 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2023-01-26T18:13:21.899Z,1674756801.899 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2023-01-26T18:13:21.902Z,1674756801.902 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2023-01-26T18:13:21.927Z,1674756801.927 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2023-01-26T18:13:21.929Z,1674756801.929 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2023-01-26T18:13:21.931Z,1674756801.931 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2023-01-26T18:13:21.934Z,1674756801.934 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2023-01-26T18:13:21.936Z,1674756801.936 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2023-01-26T18:13:21.982Z,1674756801.982 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2023-01-26T18:13:21.984Z,1674756801.984 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2023-01-26T18:13:21.984Z,1674756801.984 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2023-01-26T18:13:22.114Z,1674756802.114 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h
2023-01-26T18:13:22.120Z,1674756802.120 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2023-01-26T18:13:22.122Z,1674756802.122 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2023-01-26T18:13:22.132Z,1674756802.132 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2023-01-26T18:13:22.138Z,1674756802.138 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2023-01-26T18:13:22.145Z,1674756802.145 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2023-01-26T18:13:22.147Z,1674756802.147 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2023-01-26T18:13:22.149Z,1674756802.149 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2023-01-26T18:13:22.167Z,1674756802.167 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T18:13:22.205Z,1674756802.205 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2023-01-26T18:13:22.243Z,1674756802.243 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2023-01-26T18:13:22.250Z,1674756802.250 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2023-01-26T18:13:22.257Z,1674756802.257 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2023-01-26T18:13:22.257Z,1674756802.257 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2023-01-26T18:13:22.267Z,1674756802.267 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2023-01-26T18:13:22.281Z,1674756802.281 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2023-01-26T18:13:22.290Z,1674756802.290 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2023-01-26T18:13:22.293Z,1674756802.293 [transit:MassHold.Pitch](DEBUG): Construct.
2023-01-26T18:13:22.298Z,1674756802.298 [transit:Transit:A.Pitch](DEBUG): Construct.
2023-01-26T18:13:22.302Z,1674756802.302 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2023-01-26T18:13:22.304Z,1674756802.304 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2023-01-26T18:13:22.317Z,1674756802.317 [MissionManager](DEBUG):
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.xml
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 1 second
insert Insert/StandardEnvelopes.xml
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
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"
}
}
2023-01-26T18:13:22.317Z,1674756802.317 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl
2023-01-26T18:13:22.403Z,1674756802.403 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T18:13:22.403Z,1674756802.403 [Default] Running Loop=1
2023-01-26T18:13:22.403Z,1674756802.403 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T18:13:22.403Z,1674756802.403 [Default:B.GoToSurface] Running Loop=1
2023-01-26T18:13:22.403Z,1674756802.403 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T18:13:22.404Z,1674756802.404 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T18:13:22.404Z,1674756802.404 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T18:13:22.404Z,1674756802.404 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T18:13:22.405Z,1674756802.405 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T18:13:22.405Z,1674756802.405 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T18:13:22.405Z,1674756802.405 [Default:A.Wait] Running Loop=1
2023-01-26T18:13:22.405Z,1674756802.405 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:13:28.788Z,1674756808.788 [CommandExec](IMPORTANT): got command set transit.Latitude 36.797 degree
2023-01-26T18:13:28.789Z,1674756808.789 [CommandExec](IMPORTANT): got command set transit.Longitude -121.847 degree
2023-01-26T18:13:28.789Z,1674756808.789 [CommandExec](IMPORTANT): got command set transit.Depth 5 meter
2023-01-26T18:13:28.790Z,1674756808.790 [CommandExec](IMPORTANT): got command set transit.MaxDepth 10 meter
2023-01-26T18:13:28.791Z,1674756808.791 [CommandExec](IMPORTANT): got command set transit.MinOffshore 0.1 kilometer
2023-01-26T18:13:28.791Z,1674756808.791 [CommandExec](IMPORTANT): got command run
2023-01-26T18:13:28.861Z,1674756808.861 [CommandExec](IMPORTANT): Running
2023-01-26T18:13:28.867Z,1674756808.867 [Default] Stopped
2023-01-26T18:13:28.867Z,1674756808.867 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T18:13:28.867Z,1674756808.867 [Default:A.Wait] Stopped
2023-01-26T18:13:28.867Z,1674756808.867 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:13:28.867Z,1674756808.867 [Default:B.GoToSurface] Stopped
2023-01-26T18:13:28.867Z,1674756808.867 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T18:13:28.867Z,1674756808.867 [MissionManager](IMPORTANT): Started mission transit
2023-01-26T18:13:28.868Z,1674756808.868 [transit] Running Loop=1
2023-01-26T18:13:28.876Z,1674756808.876 [transit](DEBUG): Aggregate::initialize transit
2023-01-26T18:13:28.876Z,1674756808.876 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:13:28.876Z,1674756808.876 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2023-01-26T18:13:28.876Z,1674756808.876 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:13:28.877Z,1674756808.877 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2023-01-26T18:13:28.877Z,1674756808.877 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:13:28.877Z,1674756808.877 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2023-01-26T18:13:28.877Z,1674756808.877 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:13:28.877Z,1674756808.877 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2023-01-26T18:13:28.877Z,1674756808.877 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:13:28.877Z,1674756808.877 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2023-01-26T18:13:28.877Z,1674756808.877 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:13:28.877Z,1674756808.877 [transit:MassHold.Pitch](DEBUG): Initialize.
2023-01-26T18:13:28.878Z,1674756808.878 [transit:B] Running Loop=1
2023-01-26T18:13:28.878Z,1674756808.878 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:13:28.878Z,1674756808.878 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:13:28.879Z,1674756808.879 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:13:28.879Z,1674756808.879 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:13:28.879Z,1674756808.879 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:13:28.879Z,1674756808.879 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:13:28.888Z,1674756808.888 [transit:B] Stopped
2023-01-26T18:13:28.888Z,1674756808.888 [transit:C] Running Loop=1
2023-01-26T18:13:29.300Z,1674756809.300 [transit:C] Stopped
2023-01-26T18:13:29.300Z,1674756809.300 [transit:E] Running Loop=1
2023-01-26T18:13:29.694Z,1674756809.694 [transit:E] Stopped
2023-01-26T18:13:29.694Z,1674756809.694 [transit:F] Running Loop=1
2023-01-26T18:13:30.053Z,1674756810.053 [transit:F] Stopped
2023-01-26T18:13:30.053Z,1674756810.053 [transit:G] Running Loop=1
2023-01-26T18:13:30.484Z,1674756810.484 [transit:G] Stopped
2023-01-26T18:13:30.484Z,1674756810.484 [transit:Transit] Running Loop=1
2023-01-26T18:13:30.484Z,1674756810.484 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2023-01-26T18:13:30.484Z,1674756810.484 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:13:30.484Z,1674756810.484 [transit:Transit:A.Pitch](DEBUG): Initialize.
2023-01-26T18:13:30.484Z,1674756810.484 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:13:30.484Z,1674756810.484 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2023-01-26T18:13:30.485Z,1674756810.485 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2023-01-26T18:13:30.485Z,1674756810.485 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2023-01-26T18:13:30.486Z,1674756810.486 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2023-01-26T18:13:30.487Z,1674756810.487 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2023-01-26T18:13:30.863Z,1674756810.863 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:13:30.863Z,1674756810.863 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:13:35.970Z,1674756815.970 [CommandExec](IMPORTANT): got command stop
2023-01-26T18:13:35.971Z,1674756815.971 [CommandExec](IMPORTANT): Scheduling is paused
2023-01-26T18:13:35.971Z,1674756815.971 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2023-01-26T18:13:36.127Z,1674756816.127 [MissionManager](INFO): MissionManager is completed.
2023-01-26T18:13:36.128Z,1674756816.128 [MissionManager](INFO): Uninitializing Mission transit
2023-01-26T18:13:36.128Z,1674756816.128 [transit] Stopped
2023-01-26T18:13:36.128Z,1674756816.128 [transit](DEBUG): Aggregate::uninitialize transit
2023-01-26T18:13:36.128Z,1674756816.128 [transit:StandardEnvelopes] Stopped
2023-01-26T18:13:36.128Z,1674756816.128 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2023-01-26T18:13:36.128Z,1674756816.128 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2023-01-26T18:13:36.128Z,1674756816.128 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2023-01-26T18:13:36.128Z,1674756816.128 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2023-01-26T18:13:36.128Z,1674756816.128 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2023-01-26T18:13:36.129Z,1674756816.129 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2023-01-26T18:13:36.129Z,1674756816.129 [transit:BuoyancyHold.Buoyancy] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2023-01-26T18:13:36.129Z,1674756816.129 [transit:MassHold.Pitch] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit:A.Pitch] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit:B.SetSpeed] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit:Wpt1.Waypoint] Stopped
2023-01-26T18:13:36.129Z,1674756816.129 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2023-01-26T18:13:36.519Z,1674756816.519 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T18:13:36.519Z,1674756816.519 [Default] Running Loop=1
2023-01-26T18:13:36.519Z,1674756816.519 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T18:13:36.519Z,1674756816.519 [Default:B.GoToSurface] Running Loop=1
2023-01-26T18:13:36.519Z,1674756816.519 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T18:13:36.520Z,1674756816.520 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T18:13:36.544Z,1674756816.544 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T18:13:36.544Z,1674756816.544 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T18:13:36.545Z,1674756816.545 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T18:13:36.545Z,1674756816.545 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T18:13:36.545Z,1674756816.545 [Default:A.Wait] Running Loop=1
2023-01-26T18:13:36.545Z,1674756816.545 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:13:49.877Z,1674756829.877 [Default:A.Wait](INFO): Done Waiting.
2023-01-26T18:13:49.877Z,1674756829.877 [Default:A.Wait] Stopped
2023-01-26T18:13:49.877Z,1674756829.877 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:13:50.288Z,1674756830.288 [Default:CheckIn] Running Loop=1
2023-01-26T18:13:50.288Z,1674756830.288 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:13:50.288Z,1674756830.288 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:13:52.283Z,1674756832.283 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181351.00,A,3648.17540,N,12147.27644,W,0.117,0.00,260123,,,A*7C
2023-01-26T18:13:52.285Z,1674756832.285 [NAL9602](INFO): GPS fix at 20230126T181351: (36.802923, -121.787941)
2023-01-26T18:13:52.341Z,1674756832.341 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:13:52.341Z,1674756832.341 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:13:57.920Z,1674756837.920 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230126T172023/Courier0016.lzma
2023-01-26T18:13:58.922Z,1674756838.922 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0016.lzma.bak
2023-01-26T18:13:58.922Z,1674756838.922 [DataOverHttps](INFO): SBD MOMSN=17405386
2023-01-26T18:14:14.901Z,1674756854.901 [DataOverHttps](INFO): Sending 846 bytes from file Logs/20230126T172023/Express0017.lzma
2023-01-26T18:14:15.902Z,1674756855.902 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0017.lzma.bak
2023-01-26T18:14:15.902Z,1674756855.902 [DataOverHttps](INFO): SBD MOMSN=17405389
2023-01-26T18:14:17.341Z,1674756857.341 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:14:17.341Z,1674756857.341 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:14:17.342Z,1674756857.342 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:14:18.145Z,1674756858.145 [NAL9602](INFO): SBD MO Status=0, MOMSN=11069, MT Status=0, MTMSN=0
2023-01-26T18:14:18.145Z,1674756858.145 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:14:48.845Z,1674756888.845 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:19:17.945Z,1674757157.945 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T18:19:17.945Z,1674757157.945 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:19:17.945Z,1674757157.945 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:19:17.945Z,1674757157.945 [Default:CheckIn:D] Running Loop=1
2023-01-26T18:19:18.361Z,1674757158.361 [Default:CheckIn:D] Stopped
2023-01-26T18:19:18.361Z,1674757158.361 [Default:CheckIn:E] Running Loop=1
2023-01-26T18:19:18.750Z,1674757158.750 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 5.697358 min
2023-01-26T18:19:18.750Z,1674757158.750 [Default:CheckIn:E] Stopped
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn] Stopped
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn](INFO): Running loop #2
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn] Running Loop=2
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:19:18.751Z,1674757158.751 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:19:20.767Z,1674757160.767 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181920.00,A,3648.33402,N,12147.22816,W,1.030,343.89,260123,,,D*78
2023-01-26T18:19:20.769Z,1674757160.769 [NAL9602](INFO): GPS fix at 20230126T181920: (36.805567, -121.787136)
2023-01-26T18:19:20.781Z,1674757160.781 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:19:20.781Z,1674757160.781 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:19:28.027Z,1674757168.027 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230126T172023/Courier0019.lzma
2023-01-26T18:19:29.183Z,1674757169.183 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0019.lzma.bak
2023-01-26T18:19:29.183Z,1674757169.183 [DataOverHttps](INFO): SBD MOMSN=17405433
2023-01-26T18:19:45.800Z,1674757185.800 [DataOverHttps](INFO): Sending 127 bytes from file Logs/20230126T172023/Express0021.lzma
2023-01-26T18:19:46.227Z,1674757186.227 [NAL9602](INFO): SBD MO Status=0, MOMSN=11070, MT Status=0, MTMSN=0
2023-01-26T18:19:46.227Z,1674757186.227 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:19:46.802Z,1674757186.802 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0021.lzma.bak
2023-01-26T18:19:46.802Z,1674757186.802 [DataOverHttps](INFO): SBD MOMSN=17405437
2023-01-26T18:19:48.673Z,1674757188.673 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:19:48.673Z,1674757188.673 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:19:48.673Z,1674757188.673 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:20:16.951Z,1674757216.951 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:20:34.357Z,1674757234.357 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T18:24:49.264Z,1674757489.264 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T18:24:49.264Z,1674757489.264 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:24:49.264Z,1674757489.264 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:24:49.264Z,1674757489.264 [Default:CheckIn:D] Running Loop=1
2023-01-26T18:24:49.663Z,1674757489.663 [Default:CheckIn:D] Stopped
2023-01-26T18:24:49.663Z,1674757489.663 [Default:CheckIn:E] Running Loop=1
2023-01-26T18:24:50.073Z,1674757490.073 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.219059 min
2023-01-26T18:24:50.073Z,1674757490.073 [Default:CheckIn:E] Stopped
2023-01-26T18:24:50.073Z,1674757490.073 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T18:24:50.073Z,1674757490.073 [Default:CheckIn] Stopped
2023-01-26T18:24:50.073Z,1674757490.073 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:24:50.074Z,1674757490.074 [Default:CheckIn](INFO): Running loop #3
2023-01-26T18:24:50.074Z,1674757490.074 [Default:CheckIn] Running Loop=3
2023-01-26T18:24:50.074Z,1674757490.074 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:24:50.074Z,1674757490.074 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:24:52.083Z,1674757492.083 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182451.00,A,3648.35797,N,12147.31783,W,0.019,199.49,260123,,,D*7B
2023-01-26T18:24:52.098Z,1674757492.098 [NAL9602](INFO): GPS fix at 20230126T182451: (36.805966, -121.788630)
2023-01-26T18:24:52.109Z,1674757492.109 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:24:52.109Z,1674757492.109 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:24:59.059Z,1674757499.059 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230126T172023/Courier0025.lzma
2023-01-26T18:25:00.062Z,1674757500.062 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0025.lzma.bak
2023-01-26T18:25:00.062Z,1674757500.062 [DataOverHttps](INFO): SBD MOMSN=17405441
2023-01-26T18:25:16.004Z,1674757516.004 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20230126T172023/Express0026.lzma
2023-01-26T18:25:16.323Z,1674757516.323 [NAL9602](INFO): SBD MO Status=2, MOMSN=11071, MT Status=2, MTMSN=0
2023-01-26T18:25:16.323Z,1674757516.323 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-01-26T18:25:17.006Z,1674757517.006 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0026.lzma.bak
2023-01-26T18:25:17.006Z,1674757517.006 [DataOverHttps](INFO): SBD MOMSN=17405444
2023-01-26T18:25:18.350Z,1674757518.350 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:25:18.351Z,1674757518.351 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:25:18.351Z,1674757518.351 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:25:28.847Z,1674757528.847 [NAL9602](INFO): SBD MO Status=0, MOMSN=11071, MT Status=0, MTMSN=0
2023-01-26T18:25:28.847Z,1674757528.847 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:25:59.549Z,1674757559.549 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:30:18.923Z,1674757818.923 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T18:30:18.923Z,1674757818.923 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:30:18.923Z,1674757818.923 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:30:18.924Z,1674757818.924 [Default:CheckIn:D] Running Loop=1
2023-01-26T18:30:19.332Z,1674757819.332 [Default:CheckIn:D] Stopped
2023-01-26T18:30:19.333Z,1674757819.333 [Default:CheckIn:E] Running Loop=1
2023-01-26T18:30:19.733Z,1674757819.733 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.713554 min
2023-01-26T18:30:19.733Z,1674757819.733 [Default:CheckIn:E] Stopped
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn] Stopped
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn](INFO): Running loop #4
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn] Running Loop=4
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:30:19.734Z,1674757819.734 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:30:21.753Z,1674757821.753 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183021.00,A,3648.35782,N,12147.31785,W,0.039,199.49,260123,,,D*79
2023-01-26T18:30:21.756Z,1674757821.756 [NAL9602](INFO): GPS fix at 20230126T183021: (36.805964, -121.788631)
2023-01-26T18:30:21.767Z,1674757821.767 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:30:21.767Z,1674757821.767 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:30:29.503Z,1674757829.503 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230126T172023/Courier0028.lzma
2023-01-26T18:30:30.506Z,1674757830.506 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0028.lzma.bak
2023-01-26T18:30:30.506Z,1674757830.506 [DataOverHttps](INFO): SBD MOMSN=17405449
2023-01-26T18:30:34.713Z,1674757834.713 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T18:30:46.391Z,1674757846.391 [NAL9602](INFO): SBD MO Status=0, MOMSN=11072, MT Status=0, MTMSN=0
2023-01-26T18:30:46.391Z,1674757846.391 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:30:46.404Z,1674757846.404 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20230126T172023/Express0029.lzma
2023-01-26T18:30:47.406Z,1674757847.406 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0029.lzma.bak
2023-01-26T18:30:47.406Z,1674757847.406 [DataOverHttps](INFO): SBD MOMSN=17405452
2023-01-26T18:30:48.824Z,1674757848.824 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:30:48.824Z,1674757848.824 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:30:48.824Z,1674757848.824 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:31:17.213Z,1674757877.213 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:35:46.997Z,1674758146.997 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-01-26T18:35:47.016Z,1674758147.016 [BPC1](INFO): Received data from all battery sticks.
2023-01-26T18:35:49.433Z,1674758149.433 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-01-26T18:35:49.433Z,1674758149.433 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:35:49.433Z,1674758149.433 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:35:49.433Z,1674758149.433 [Default:CheckIn:D] Running Loop=1
2023-01-26T18:35:49.855Z,1674758149.855 [Default:CheckIn:D] Stopped
2023-01-26T18:35:49.855Z,1674758149.855 [Default:CheckIn:E] Running Loop=1
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.222264 min
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn:E] Stopped
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn] Stopped
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn](INFO): Running loop #5
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn] Running Loop=5
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:35:50.235Z,1674758150.235 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:35:52.247Z,1674758152.247 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183551.00,A,3648.35747,N,12147.31836,W,0.078,199.49,260123,,,D*70
2023-01-26T18:35:52.249Z,1674758152.249 [NAL9602](INFO): GPS fix at 20230126T183551: (36.805958, -121.788639)
2023-01-26T18:35:52.269Z,1674758152.269 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:35:52.269Z,1674758152.269 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:36:05.147Z,1674758165.147 [DataOverHttps](INFO): Sending 83 bytes from file Logs/20230126T172023/Courier0031.lzma
2023-01-26T18:36:06.174Z,1674758166.174 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0031.lzma.bak
2023-01-26T18:36:06.174Z,1674758166.174 [DataOverHttps](INFO): SBD MOMSN=17405457
2023-01-26T18:36:07.331Z,1674758167.331 [NAL9602](INFO): SBD MO Status=0, MOMSN=11073, MT Status=0, MTMSN=0
2023-01-26T18:36:07.332Z,1674758167.332 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:36:26.860Z,1674758186.860 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230126T172023/Express0032.lzma
2023-01-26T18:36:27.862Z,1674758187.862 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0032.lzma.bak
2023-01-26T18:36:27.862Z,1674758187.862 [DataOverHttps](INFO): SBD MOMSN=17405460
2023-01-26T18:36:29.201Z,1674758189.201 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:36:29.201Z,1674758189.201 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:36:29.201Z,1674758189.201 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:36:38.032Z,1674758198.032 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:40:09.138Z,1674758409.138 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184008
2023-01-26T18:40:16.512Z,1674758416.512 [DataOverHttps](INFO): Received command: sched asap "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.80125 degree;set transit.Longitude -121.79578 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b560 1 2
2023-01-26T18:40:16.565Z,1674758416.565 [CommandExec](IMPORTANT): got command schedule asap "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.80125 degree;set transit.Longitude -121.79578 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b560 1 2.000000
2023-01-26T18:40:16.565Z,1674758416.565 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=4b560
2023-01-26T18:40:16.566Z,1674758416.566 [CommandExec](IMPORTANT): Scheduled #3 (#1 of 2 with id='4b560'): "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.80125 degree;set transit.Longitude -121.79578 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m", ASAP
2023-01-26T18:40:17.514Z,1674758417.514 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184016
2023-01-26T18:40:24.836Z,1674758424.836 [DataOverHttps](INFO): Received command: sched asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b560 2 2
2023-01-26T18:40:24.891Z,1674758424.891 [CommandExec](IMPORTANT): got command schedule asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b560 2 2.000000
2023-01-26T18:40:24.891Z,1674758424.891 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=4b560
2023-01-26T18:40:24.892Z,1674758424.892 [CommandExec](IMPORTANT): Scheduled #4 (#2 of 2 with id='4b560'): "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run", ASAP
2023-01-26T18:40:25.003Z,1674758425.003 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2023-01-26T18:40:25.004Z,1674758425.004 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2023-01-26T18:40:25.004Z,1674758425.004 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Transport/transit.tx
2023-01-26T18:40:25.072Z,1674758425.072 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2023-01-26T18:40:25.074Z,1674758425.074 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2023-01-26T18:40:25.076Z,1674758425.076 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2023-01-26T18:40:25.078Z,1674758425.078 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2023-01-26T18:40:25.080Z,1674758425.080 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2023-01-26T18:40:25.082Z,1674758425.082 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2023-01-26T18:40:25.084Z,1674758425.084 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2023-01-26T18:40:25.085Z,1674758425.085 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2023-01-26T18:40:25.087Z,1674758425.087 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2023-01-26T18:40:25.090Z,1674758425.090 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2023-01-26T18:40:25.091Z,1674758425.091 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2023-01-26T18:40:25.093Z,1674758425.093 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2023-01-26T18:40:25.095Z,1674758425.095 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2023-01-26T18:40:25.095Z,1674758425.095 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2023-01-26T18:40:25.267Z,1674758425.267 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h
2023-01-26T18:40:25.270Z,1674758425.270 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2023-01-26T18:40:25.272Z,1674758425.272 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2023-01-26T18:40:25.280Z,1674758425.280 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2023-01-26T18:40:25.282Z,1674758425.282 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2023-01-26T18:40:25.284Z,1674758425.284 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2023-01-26T18:40:25.286Z,1674758425.286 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2023-01-26T18:40:25.307Z,1674758425.307 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2023-01-26T18:40:25.323Z,1674758425.323 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T18:40:25.345Z,1674758425.345 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2023-01-26T18:40:25.373Z,1674758425.373 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2023-01-26T18:40:25.375Z,1674758425.375 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2023-01-26T18:40:25.378Z,1674758425.378 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2023-01-26T18:40:25.380Z,1674758425.380 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2023-01-26T18:40:25.387Z,1674758425.387 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2023-01-26T18:40:25.393Z,1674758425.393 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2023-01-26T18:40:25.422Z,1674758425.422 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2023-01-26T18:40:25.425Z,1674758425.425 [transit:MassHold.Pitch](DEBUG): Construct.
2023-01-26T18:40:25.431Z,1674758425.431 [transit:Transit:A.Pitch](DEBUG): Construct.
2023-01-26T18:40:25.434Z,1674758425.434 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2023-01-26T18:40:25.437Z,1674758425.437 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2023-01-26T18:40:25.449Z,1674758425.449 [MissionManager](DEBUG):
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.xml
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 1 second
insert Insert/StandardEnvelopes.xml
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
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"
}
}
2023-01-26T18:40:25.449Z,1674758425.449 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl
2023-01-26T18:40:33.133Z,1674758433.133 [CommandExec](IMPORTANT): got command set transit.MissionTimeout 20 minute
2023-01-26T18:40:33.134Z,1674758433.134 [CommandExec](IMPORTANT): got command set transit.NeedCommsTime 10 minute
2023-01-26T18:40:33.135Z,1674758433.135 [CommandExec](IMPORTANT): got command set transit.Latitude 36.80125 degree
2023-01-26T18:40:33.135Z,1674758433.135 [CommandExec](IMPORTANT): got command set transit.Longitude -121.79578 degree
2023-01-26T18:40:33.136Z,1674758433.136 [CommandExec](IMPORTANT): got command set transit.Depth 0.5 meter
2023-01-26T18:40:33.137Z,1674758433.137 [CommandExec](IMPORTANT): got command set transit.MaxDepth 1 meter
2023-01-26T18:40:34.851Z,1674758434.851 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T18:40:35.927Z,1674758435.927 [CommandExec](IMPORTANT): got command set transit.MinOffshore 0.0001 kilometer
2023-01-26T18:40:35.927Z,1674758435.927 [CommandExec](IMPORTANT): got command set transit.MinAltitude 1 meter
2023-01-26T18:40:35.928Z,1674758435.928 [CommandExec](IMPORTANT): got command run
2023-01-26T18:40:35.930Z,1674758435.930 [CommandExec](IMPORTANT): Running
2023-01-26T18:40:36.034Z,1674758436.034 [Default] Stopped
2023-01-26T18:40:36.034Z,1674758436.034 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T18:40:36.034Z,1674758436.034 [Default:B.GoToSurface] Stopped
2023-01-26T18:40:36.034Z,1674758436.034 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T18:40:36.034Z,1674758436.034 [Default:CheckIn] Stopped
2023-01-26T18:40:36.034Z,1674758436.034 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:40:36.035Z,1674758436.035 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:40:36.035Z,1674758436.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:40:36.035Z,1674758436.035 [MissionManager](IMPORTANT): Started mission transit
2023-01-26T18:40:36.035Z,1674758436.035 [transit] Running Loop=1
2023-01-26T18:40:36.035Z,1674758436.035 [transit](DEBUG): Aggregate::initialize transit
2023-01-26T18:40:36.035Z,1674758436.035 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:40:36.035Z,1674758436.035 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2023-01-26T18:40:36.035Z,1674758436.035 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:40:36.035Z,1674758436.035 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2023-01-26T18:40:36.036Z,1674758436.036 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:40:36.036Z,1674758436.036 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2023-01-26T18:40:36.036Z,1674758436.036 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:40:36.036Z,1674758436.036 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2023-01-26T18:40:36.036Z,1674758436.036 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:40:36.036Z,1674758436.036 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2023-01-26T18:40:36.036Z,1674758436.036 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:40:36.037Z,1674758436.037 [transit:MassHold.Pitch](DEBUG): Initialize.
2023-01-26T18:40:36.037Z,1674758436.037 [transit:B] Running Loop=1
2023-01-26T18:40:36.037Z,1674758436.037 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:40:36.038Z,1674758436.038 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:40:36.038Z,1674758436.038 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:40:36.038Z,1674758436.038 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:40:36.038Z,1674758436.038 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:40:36.039Z,1674758436.039 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:40:36.039Z,1674758436.039 [transit:B] Stopped
2023-01-26T18:40:36.039Z,1674758436.039 [transit:C] Running Loop=1
2023-01-26T18:40:36.446Z,1674758436.446 [transit:C] Stopped
2023-01-26T18:40:36.447Z,1674758436.447 [transit:E] Running Loop=1
2023-01-26T18:40:36.840Z,1674758436.840 [transit:E] Stopped
2023-01-26T18:40:36.840Z,1674758436.840 [transit:F] Running Loop=1
2023-01-26T18:40:37.247Z,1674758437.247 [transit:F] Stopped
2023-01-26T18:40:37.247Z,1674758437.247 [transit:G] Running Loop=1
2023-01-26T18:40:37.650Z,1674758437.650 [transit:G] Stopped
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit] Running Loop=1
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit:A.Pitch](DEBUG): Initialize.
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2023-01-26T18:40:37.650Z,1674758437.650 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2023-01-26T18:40:37.652Z,1674758437.652 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.801250,-121.795776
2023-01-26T18:40:37.653Z,1674758437.653 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2023-01-26T18:40:38.065Z,1674758438.065 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:40:38.065Z,1674758438.065 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:42:12.749Z,1674758532.749 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184211
2023-01-26T18:42:20.616Z,1674758540.616 [DataOverHttps](INFO): Received command: stop
2023-01-26T18:42:20.645Z,1674758540.645 [CommandExec](IMPORTANT): got command stop
2023-01-26T18:42:20.646Z,1674758540.646 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2023-01-26T18:42:20.691Z,1674758540.691 [MissionManager](INFO): MissionManager is completed.
2023-01-26T18:42:20.692Z,1674758540.692 [MissionManager](INFO): Uninitializing Mission transit
2023-01-26T18:42:20.692Z,1674758540.692 [transit] Stopped
2023-01-26T18:42:20.692Z,1674758540.692 [transit](DEBUG): Aggregate::uninitialize transit
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes] Stopped
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2023-01-26T18:42:20.692Z,1674758540.692 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2023-01-26T18:42:20.693Z,1674758540.693 [transit:BuoyancyHold.Buoyancy] Stopped
2023-01-26T18:42:20.693Z,1674758540.693 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2023-01-26T18:42:20.693Z,1674758540.693 [transit:MassHold.Pitch] Stopped
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit] Stopped
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit:A.Pitch] Stopped
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit:B.SetSpeed] Stopped
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit:Wpt1.Waypoint] Stopped
2023-01-26T18:42:20.693Z,1674758540.693 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2023-01-26T18:42:21.094Z,1674758541.094 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T18:42:21.094Z,1674758541.094 [Default] Running Loop=1
2023-01-26T18:42:21.095Z,1674758541.095 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T18:42:21.095Z,1674758541.095 [Default:B.GoToSurface] Running Loop=1
2023-01-26T18:42:21.095Z,1674758541.095 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T18:42:21.095Z,1674758541.095 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T18:42:21.095Z,1674758541.095 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T18:42:21.096Z,1674758541.096 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T18:42:21.096Z,1674758541.096 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T18:42:21.097Z,1674758541.097 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T18:42:21.097Z,1674758541.097 [Default:A.Wait] Running Loop=1
2023-01-26T18:42:21.097Z,1674758541.097 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:42:34.404Z,1674758554.404 [Default:A.Wait](INFO): Done Waiting.
2023-01-26T18:42:34.404Z,1674758554.404 [Default:A.Wait] Stopped
2023-01-26T18:42:34.404Z,1674758554.404 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:42:34.809Z,1674758554.809 [Default:CheckIn] Running Loop=1
2023-01-26T18:42:34.809Z,1674758554.809 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:42:34.809Z,1674758554.809 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:42:36.823Z,1674758556.823 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184236.00,A,3648.34933,N,12147.34187,W,0.019,236.57,260123,,,D*75
2023-01-26T18:42:36.825Z,1674758556.825 [NAL9602](INFO): GPS fix at 20230126T184236: (36.805822, -121.789031)
2023-01-26T18:42:36.837Z,1674758556.837 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:42:36.837Z,1674758556.837 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:42:44.207Z,1674758564.207 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20230126T172023/Courier0034.lzma
2023-01-26T18:42:45.210Z,1674758565.210 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0034.lzma.bak
2023-01-26T18:42:45.210Z,1674758565.210 [DataOverHttps](INFO): SBD MOMSN=17405471
2023-01-26T18:42:52.187Z,1674758572.187 [NAL9602](INFO): SBD MO Status=0, MOMSN=11074, MT Status=0, MTMSN=0
2023-01-26T18:42:52.187Z,1674758572.187 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:43:01.129Z,1674758581.129 [DataOverHttps](INFO): Sending 696 bytes from file Logs/20230126T172023/Express0035.lzma
2023-01-26T18:43:02.130Z,1674758582.130 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0035.lzma.bak
2023-01-26T18:43:02.130Z,1674758582.130 [DataOverHttps](INFO): SBD MOMSN=17405474
2023-01-26T18:43:17.951Z,1674758597.951 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20230126T172023/Express0038.lzma
2023-01-26T18:43:18.954Z,1674758598.954 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0038.lzma.bak
2023-01-26T18:43:18.954Z,1674758598.954 [DataOverHttps](INFO): SBD MOMSN=17405503
2023-01-26T18:43:20.473Z,1674758600.473 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:43:20.473Z,1674758600.473 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:43:20.473Z,1674758600.473 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:43:22.873Z,1674758602.873 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:44:03.194Z,1674758643.194 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184402
2023-01-26T18:44:10.508Z,1674758650.508 [DataOverHttps](INFO): Received command: sched asap "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.79715 degree;set transit.Longitude -121.80109 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b5ce 1 2
2023-01-26T18:44:10.556Z,1674758650.556 [CommandExec](IMPORTANT): got command schedule asap "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.79715 degree;set transit.Longitude -121.80109 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b5ce 1 2.000000
2023-01-26T18:44:10.557Z,1674758650.557 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=4b5ce
2023-01-26T18:44:10.558Z,1674758650.558 [CommandExec](IMPORTANT): Scheduled #5 (#1 of 2 with id='4b5ce'): "load Transport/transit.tl;set transit.MissionTimeout 20 min;set transit.NeedCommsTime 10 min;set transit.Latitude 36.79715 degree;set transit.Longitude -121.80109 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m", ASAP
2023-01-26T18:44:11.510Z,1674758651.510 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184410
2023-01-26T18:44:18.872Z,1674758658.872 [DataOverHttps](INFO): Received command: sched asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b5ce 2 2
2023-01-26T18:44:18.907Z,1674758658.907 [CommandExec](IMPORTANT): got command schedule asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b5ce 2 2.000000
2023-01-26T18:44:18.907Z,1674758658.907 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=4b5ce
2023-01-26T18:44:18.908Z,1674758658.908 [CommandExec](IMPORTANT): Scheduled #6 (#2 of 2 with id='4b5ce'): "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run", ASAP
2023-01-26T18:44:19.037Z,1674758659.037 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2023-01-26T18:44:19.037Z,1674758659.037 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2023-01-26T18:44:19.037Z,1674758659.037 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Transport/transit.tx
2023-01-26T18:44:19.159Z,1674758659.159 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2023-01-26T18:44:19.161Z,1674758659.161 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2023-01-26T18:44:19.164Z,1674758659.164 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2023-01-26T18:44:19.167Z,1674758659.167 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2023-01-26T18:44:19.169Z,1674758659.169 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2023-01-26T18:44:19.171Z,1674758659.171 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2023-01-26T18:44:19.174Z,1674758659.174 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2023-01-26T18:44:19.176Z,1674758659.176 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2023-01-26T18:44:19.178Z,1674758659.178 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2023-01-26T18:44:19.180Z,1674758659.180 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2023-01-26T18:44:19.182Z,1674758659.182 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2023-01-26T18:44:19.184Z,1674758659.184 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2023-01-26T18:44:19.186Z,1674758659.186 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2023-01-26T18:44:19.187Z,1674758659.187 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2023-01-26T18:44:19.298Z,1674758659.298 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h
2023-01-26T18:44:19.309Z,1674758659.309 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2023-01-26T18:44:19.314Z,1674758659.314 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2023-01-26T18:44:19.316Z,1674758659.316 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2023-01-26T18:44:19.318Z,1674758659.318 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2023-01-26T18:44:19.320Z,1674758659.320 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2023-01-26T18:44:19.322Z,1674758659.322 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2023-01-26T18:44:19.324Z,1674758659.324 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2023-01-26T18:44:19.330Z,1674758659.330 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T18:44:19.343Z,1674758659.343 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2023-01-26T18:44:19.390Z,1674758659.390 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2023-01-26T18:44:19.410Z,1674758659.410 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2023-01-26T18:44:19.412Z,1674758659.412 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2023-01-26T18:44:19.413Z,1674758659.413 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2023-01-26T18:44:19.438Z,1674758659.438 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2023-01-26T18:44:19.444Z,1674758659.444 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2023-01-26T18:44:19.488Z,1674758659.488 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2023-01-26T18:44:19.491Z,1674758659.491 [transit:MassHold.Pitch](DEBUG): Construct.
2023-01-26T18:44:19.509Z,1674758659.509 [transit:Transit:A.Pitch](DEBUG): Construct.
2023-01-26T18:44:19.512Z,1674758659.512 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2023-01-26T18:44:19.515Z,1674758659.515 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2023-01-26T18:44:19.539Z,1674758659.539 [MissionManager](DEBUG):
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.xml
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 1 second
insert Insert/StandardEnvelopes.xml
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
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"
}
}
2023-01-26T18:44:19.551Z,1674758659.551 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl
2023-01-26T18:44:27.229Z,1674758667.229 [CommandExec](IMPORTANT): got command set transit.MissionTimeout 20 minute
2023-01-26T18:44:27.229Z,1674758667.229 [CommandExec](IMPORTANT): got command set transit.NeedCommsTime 10 minute
2023-01-26T18:44:27.230Z,1674758667.230 [CommandExec](IMPORTANT): got command set transit.Latitude 36.79715 degree
2023-01-26T18:44:27.231Z,1674758667.231 [CommandExec](IMPORTANT): got command set transit.Longitude -121.80109 degree
2023-01-26T18:44:27.231Z,1674758667.231 [CommandExec](IMPORTANT): got command set transit.Depth 0.5 meter
2023-01-26T18:44:27.233Z,1674758667.233 [CommandExec](IMPORTANT): got command set transit.MaxDepth 1 meter
2023-01-26T18:44:29.988Z,1674758669.988 [CommandExec](IMPORTANT): got command set transit.MinOffshore 0.0001 kilometer
2023-01-26T18:44:29.988Z,1674758669.988 [CommandExec](IMPORTANT): got command set transit.MinAltitude 1 meter
2023-01-26T18:44:29.989Z,1674758669.989 [CommandExec](IMPORTANT): got command run
2023-01-26T18:44:29.990Z,1674758669.990 [CommandExec](IMPORTANT): Running
2023-01-26T18:44:30.352Z,1674758670.352 [Default] Stopped
2023-01-26T18:44:30.352Z,1674758670.352 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T18:44:30.352Z,1674758670.352 [Default:B.GoToSurface] Stopped
2023-01-26T18:44:30.352Z,1674758670.352 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T18:44:30.352Z,1674758670.352 [Default:CheckIn] Stopped
2023-01-26T18:44:30.353Z,1674758670.353 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:44:30.353Z,1674758670.353 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:44:30.353Z,1674758670.353 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:44:30.353Z,1674758670.353 [MissionManager](IMPORTANT): Started mission transit
2023-01-26T18:44:30.353Z,1674758670.353 [transit] Running Loop=1
2023-01-26T18:44:30.353Z,1674758670.353 [transit](DEBUG): Aggregate::initialize transit
2023-01-26T18:44:30.353Z,1674758670.353 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:44:30.353Z,1674758670.353 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2023-01-26T18:44:30.353Z,1674758670.353 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:44:30.354Z,1674758670.354 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2023-01-26T18:44:30.354Z,1674758670.354 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:44:30.354Z,1674758670.354 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2023-01-26T18:44:30.354Z,1674758670.354 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:44:30.354Z,1674758670.354 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2023-01-26T18:44:30.354Z,1674758670.354 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:44:30.354Z,1674758670.354 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2023-01-26T18:44:30.354Z,1674758670.354 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:44:30.354Z,1674758670.354 [transit:MassHold.Pitch](DEBUG): Initialize.
2023-01-26T18:44:30.355Z,1674758670.355 [transit:B] Running Loop=1
2023-01-26T18:44:30.355Z,1674758670.355 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:44:30.355Z,1674758670.355 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:44:30.356Z,1674758670.356 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:44:30.356Z,1674758670.356 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:44:30.368Z,1674758670.368 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:44:30.368Z,1674758670.368 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:44:30.369Z,1674758670.369 [transit:B] Stopped
2023-01-26T18:44:30.369Z,1674758670.369 [transit:C] Running Loop=1
2023-01-26T18:44:30.763Z,1674758670.763 [transit:C] Stopped
2023-01-26T18:44:30.763Z,1674758670.763 [transit:E] Running Loop=1
2023-01-26T18:44:31.165Z,1674758671.165 [transit:E] Stopped
2023-01-26T18:44:31.165Z,1674758671.165 [transit:F] Running Loop=1
2023-01-26T18:44:31.578Z,1674758671.578 [transit:F] Stopped
2023-01-26T18:44:31.578Z,1674758671.578 [transit:G] Running Loop=1
2023-01-26T18:44:31.967Z,1674758671.967 [transit:G] Stopped
2023-01-26T18:44:31.967Z,1674758671.967 [transit:Transit] Running Loop=1
2023-01-26T18:44:31.968Z,1674758671.968 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2023-01-26T18:44:31.968Z,1674758671.968 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:44:31.968Z,1674758671.968 [transit:Transit:A.Pitch](DEBUG): Initialize.
2023-01-26T18:44:31.968Z,1674758671.968 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:44:31.968Z,1674758671.968 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2023-01-26T18:44:31.968Z,1674758671.968 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2023-01-26T18:44:31.969Z,1674758671.969 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2023-01-26T18:44:31.970Z,1674758671.970 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797150,-121.801086
2023-01-26T18:44:31.970Z,1674758671.970 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2023-01-26T18:44:32.380Z,1674758672.380 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:44:32.380Z,1674758672.380 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:44:55.945Z,1674758695.945 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184455
2023-01-26T18:45:03.896Z,1674758703.896 [DataOverHttps](INFO): Received command: stop
2023-01-26T18:45:03.941Z,1674758703.941 [CommandExec](IMPORTANT): got command stop
2023-01-26T18:45:03.942Z,1674758703.942 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2023-01-26T18:45:04.291Z,1674758704.291 [MissionManager](INFO): MissionManager is completed.
2023-01-26T18:45:04.292Z,1674758704.292 [MissionManager](INFO): Uninitializing Mission transit
2023-01-26T18:45:04.292Z,1674758704.292 [transit] Stopped
2023-01-26T18:45:04.292Z,1674758704.292 [transit](DEBUG): Aggregate::uninitialize transit
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes] Stopped
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2023-01-26T18:45:04.292Z,1674758704.292 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2023-01-26T18:45:04.292Z,1674758704.292 [transit:BuoyancyHold.Buoyancy] Stopped
2023-01-26T18:45:04.293Z,1674758704.293 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2023-01-26T18:45:04.293Z,1674758704.293 [transit:MassHold.Pitch] Stopped
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit] Stopped
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit:A.Pitch] Stopped
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit:B.SetSpeed] Stopped
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit:Wpt1.Waypoint] Stopped
2023-01-26T18:45:04.293Z,1674758704.293 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2023-01-26T18:45:04.700Z,1674758704.700 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T18:45:04.701Z,1674758704.701 [Default] Running Loop=1
2023-01-26T18:45:04.701Z,1674758704.701 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T18:45:04.701Z,1674758704.701 [Default:B.GoToSurface] Running Loop=1
2023-01-26T18:45:04.701Z,1674758704.701 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T18:45:04.701Z,1674758704.701 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T18:45:04.701Z,1674758704.701 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T18:45:04.702Z,1674758704.702 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T18:45:04.702Z,1674758704.702 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T18:45:04.702Z,1674758704.702 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T18:45:04.703Z,1674758704.703 [Default:A.Wait] Running Loop=1
2023-01-26T18:45:04.703Z,1674758704.703 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:45:18.029Z,1674758718.029 [Default:A.Wait](INFO): Done Waiting.
2023-01-26T18:45:18.029Z,1674758718.029 [Default:A.Wait] Stopped
2023-01-26T18:45:18.029Z,1674758718.029 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:45:18.460Z,1674758718.460 [Default:CheckIn] Running Loop=1
2023-01-26T18:45:18.460Z,1674758718.460 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T18:45:18.460Z,1674758718.460 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T18:45:20.438Z,1674758720.438 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184519.00,A,3648.34963,N,12147.34217,W,0.019,236.57,260123,,,D*70
2023-01-26T18:45:20.440Z,1674758720.440 [NAL9602](INFO): GPS fix at 20230126T184519: (36.805827, -121.789036)
2023-01-26T18:45:20.452Z,1674758720.452 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T18:45:20.452Z,1674758720.452 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T18:45:27.395Z,1674758727.395 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230126T172023/Courier0040.lzma
2023-01-26T18:45:28.398Z,1674758728.398 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0040.lzma.bak
2023-01-26T18:45:28.398Z,1674758728.398 [DataOverHttps](INFO): SBD MOMSN=17405511
2023-01-26T18:45:36.193Z,1674758736.193 [NAL9602](INFO): SBD MO Status=0, MOMSN=11075, MT Status=0, MTMSN=0
2023-01-26T18:45:36.194Z,1674758736.194 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:45:44.196Z,1674758744.196 [DataOverHttps](INFO): Sending 657 bytes from file Logs/20230126T172023/Express0041.lzma
2023-01-26T18:45:45.198Z,1674758745.198 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0041.lzma.bak
2023-01-26T18:45:45.198Z,1674758745.198 [DataOverHttps](INFO): SBD MOMSN=17405514
2023-01-26T18:45:46.807Z,1674758746.807 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T18:45:46.807Z,1674758746.807 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T18:45:46.807Z,1674758746.807 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T18:46:06.977Z,1674758766.977 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T18:48:15.878Z,1674758895.878 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184814
2023-01-26T18:48:23.160Z,1674758903.160 [DataOverHttps](INFO): Received command: sched asap "load Transport/transit.tl;set transit.MissionTimeout 25 min;set transit.NeedCommsTime 12 min;set transit.Latitude 36.79715 degree;set transit.Longitude -121.80109 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b5jr 1 2
2023-01-26T18:48:23.260Z,1674758903.260 [CommandExec](IMPORTANT): got command schedule asap "load Transport/transit.tl;set transit.MissionTimeout 25 min;set transit.NeedCommsTime 12 min;set transit.Latitude 36.79715 degree;set transit.Longitude -121.80109 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m" 4b5jr 1 2.000000
2023-01-26T18:48:23.261Z,1674758903.261 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=4b5jr
2023-01-26T18:48:23.262Z,1674758903.262 [CommandExec](IMPORTANT): Scheduled #7 (#1 of 2 with id='4b5jr'): "load Transport/transit.tl;set transit.MissionTimeout 25 min;set transit.NeedCommsTime 12 min;set transit.Latitude 36.79715 degree;set transit.Longitude -121.80109 degree;set transit.Depth 0.5 m;set transit.MaxDepth 1 m", ASAP
2023-01-26T18:48:24.161Z,1674758904.161 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T184823
2023-01-26T18:48:41.608Z,1674758921.608 [DataOverHttps](INFO): Received command: sched asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b5jr 2 2
2023-01-26T18:48:41.707Z,1674758921.707 [CommandExec](IMPORTANT): got command schedule asap "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run" 4b5jr 2 2.000000
2023-01-26T18:48:41.708Z,1674758921.708 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=4b5jr
2023-01-26T18:48:41.709Z,1674758921.709 [CommandExec](IMPORTANT): Scheduled #8 (#2 of 2 with id='4b5jr'): "set transit.MinOffshore 0.0001 km;set transit.MinAltitude 1 m;run", ASAP
2023-01-26T18:48:41.820Z,1674758921.820 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2023-01-26T18:48:41.820Z,1674758921.820 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2023-01-26T18:48:41.821Z,1674758921.821 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Transport/transit.tx
2023-01-26T18:48:41.892Z,1674758921.892 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2023-01-26T18:48:41.894Z,1674758921.894 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2023-01-26T18:48:41.905Z,1674758921.905 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2023-01-26T18:48:41.907Z,1674758921.907 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2023-01-26T18:48:41.909Z,1674758921.909 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2023-01-26T18:48:41.911Z,1674758921.911 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2023-01-26T18:48:41.913Z,1674758921.913 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2023-01-26T18:48:41.915Z,1674758921.915 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2023-01-26T18:48:41.917Z,1674758921.917 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2023-01-26T18:48:41.919Z,1674758921.919 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2023-01-26T18:48:41.922Z,1674758921.922 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2023-01-26T18:48:41.923Z,1674758921.923 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2023-01-26T18:48:41.925Z,1674758921.925 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2023-01-26T18:48:41.926Z,1674758921.926 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2023-01-26T18:48:42.019Z,1674758922.019 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h
2023-01-26T18:48:42.032Z,1674758922.032 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2023-01-26T18:48:42.034Z,1674758922.034 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2023-01-26T18:48:42.036Z,1674758922.036 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2023-01-26T18:48:42.038Z,1674758922.038 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2023-01-26T18:48:42.040Z,1674758922.040 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2023-01-26T18:48:42.042Z,1674758922.042 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2023-01-26T18:48:42.044Z,1674758922.044 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2023-01-26T18:48:42.050Z,1674758922.050 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T18:48:42.138Z,1674758922.138 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2023-01-26T18:48:42.190Z,1674758922.190 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2023-01-26T18:48:42.193Z,1674758922.193 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2023-01-26T18:48:42.195Z,1674758922.195 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2023-01-26T18:48:42.195Z,1674758922.195 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2023-01-26T18:48:42.213Z,1674758922.213 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2023-01-26T18:48:42.218Z,1674758922.218 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2023-01-26T18:48:42.241Z,1674758922.241 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2023-01-26T18:48:42.244Z,1674758922.244 [transit:MassHold.Pitch](DEBUG): Construct.
2023-01-26T18:48:42.261Z,1674758922.261 [transit:Transit:A.Pitch](DEBUG): Construct.
2023-01-26T18:48:42.264Z,1674758922.264 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2023-01-26T18:48:42.267Z,1674758922.267 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2023-01-26T18:48:42.280Z,1674758922.280 [MissionManager](DEBUG):
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.xml
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 1 second
insert Insert/StandardEnvelopes.xml
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
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"
}
}
2023-01-26T18:48:42.280Z,1674758922.280 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl
2023-01-26T18:48:49.958Z,1674758929.958 [CommandExec](IMPORTANT): got command set transit.MissionTimeout 25 minute
2023-01-26T18:48:49.959Z,1674758929.959 [CommandExec](IMPORTANT): got command set transit.NeedCommsTime 12 minute
2023-01-26T18:48:49.960Z,1674758929.960 [CommandExec](IMPORTANT): got command set transit.Latitude 36.79715 degree
2023-01-26T18:48:49.960Z,1674758929.960 [CommandExec](IMPORTANT): got command set transit.Longitude -121.80109 degree
2023-01-26T18:48:49.961Z,1674758929.961 [CommandExec](IMPORTANT): got command set transit.Depth 0.5 meter
2023-01-26T18:48:49.962Z,1674758929.962 [CommandExec](IMPORTANT): got command set transit.MaxDepth 1 meter
2023-01-26T18:48:52.790Z,1674758932.790 [CommandExec](IMPORTANT): got command set transit.MinOffshore 0.0001 kilometer
2023-01-26T18:48:52.791Z,1674758932.791 [CommandExec](IMPORTANT): got command set transit.MinAltitude 1 meter
2023-01-26T18:48:52.792Z,1674758932.792 [CommandExec](IMPORTANT): got command run
2023-01-26T18:48:52.793Z,1674758932.793 [CommandExec](IMPORTANT): Running
2023-01-26T18:48:53.028Z,1674758933.028 [Default] Stopped
2023-01-26T18:48:53.028Z,1674758933.028 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T18:48:53.028Z,1674758933.028 [Default:B.GoToSurface] Stopped
2023-01-26T18:48:53.028Z,1674758933.028 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T18:48:53.028Z,1674758933.028 [Default:CheckIn] Stopped
2023-01-26T18:48:53.028Z,1674758933.028 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T18:48:53.028Z,1674758933.028 [Default:CheckIn:C.Wait] Stopped
2023-01-26T18:48:53.028Z,1674758933.028 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T18:48:53.028Z,1674758933.028 [MissionManager](IMPORTANT): Started mission transit
2023-01-26T18:48:53.029Z,1674758933.029 [transit] Running Loop=1
2023-01-26T18:48:53.029Z,1674758933.029 [transit](DEBUG): Aggregate::initialize transit
2023-01-26T18:48:53.029Z,1674758933.029 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:48:53.029Z,1674758933.029 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2023-01-26T18:48:53.029Z,1674758933.029 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:48:53.029Z,1674758933.029 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2023-01-26T18:48:53.029Z,1674758933.029 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:48:53.029Z,1674758933.029 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2023-01-26T18:48:53.030Z,1674758933.030 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:48:53.030Z,1674758933.030 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2023-01-26T18:48:53.030Z,1674758933.030 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:48:53.030Z,1674758933.030 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2023-01-26T18:48:53.030Z,1674758933.030 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:48:53.030Z,1674758933.030 [transit:MassHold.Pitch](DEBUG): Initialize.
2023-01-26T18:48:53.030Z,1674758933.030 [transit:B] Running Loop=1
2023-01-26T18:48:53.031Z,1674758933.031 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T18:48:53.031Z,1674758933.031 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T18:48:53.031Z,1674758933.031 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T18:48:53.031Z,1674758933.031 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T18:48:53.031Z,1674758933.031 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T18:48:53.032Z,1674758933.032 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T18:48:53.032Z,1674758933.032 [transit:B] Stopped
2023-01-26T18:48:53.032Z,1674758933.032 [transit:C] Running Loop=1
2023-01-26T18:48:53.440Z,1674758933.440 [transit:C] Stopped
2023-01-26T18:48:53.440Z,1674758933.440 [transit:E] Running Loop=1
2023-01-26T18:48:53.835Z,1674758933.835 [transit:E] Stopped
2023-01-26T18:48:53.836Z,1674758933.836 [transit:F] Running Loop=1
2023-01-26T18:48:54.245Z,1674758934.245 [transit:F] Stopped
2023-01-26T18:48:54.245Z,1674758934.245 [transit:G] Running Loop=1
2023-01-26T18:48:54.649Z,1674758934.649 [transit:G] Stopped
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit] Running Loop=1
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit:A.Pitch](DEBUG): Initialize.
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2023-01-26T18:48:54.649Z,1674758934.649 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2023-01-26T18:48:54.650Z,1674758934.650 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2023-01-26T18:48:54.651Z,1674758934.651 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797150,-121.801086
2023-01-26T18:48:54.651Z,1674758934.651 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2023-01-26T18:48:55.057Z,1674758935.057 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T18:48:55.058Z,1674758935.058 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T18:50:34.938Z,1674759034.938 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T18:52:55.488Z,1674759175.488 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.910297
2023-01-26T18:53:29.458Z,1674759209.458 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003933
2023-01-26T18:55:15.324Z,1674759315.324 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.918507
2023-01-26T18:56:33.877Z,1674759393.877 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003934
2023-01-26T18:57:21.452Z,1674759441.452 [transit:NeedComms] Running Loop=1
2023-01-26T18:57:21.452Z,1674759441.452 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2023-01-26T18:57:21.452Z,1674759441.452 [transit:NeedComms:B.GoToSurface] Running Loop=1
2023-01-26T18:57:21.452Z,1674759441.452 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T18:57:21.452Z,1674759441.452 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2023-01-26T18:57:21.453Z,1674759441.453 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2023-01-26T18:57:21.453Z,1674759441.453 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2023-01-26T18:57:21.454Z,1674759441.454 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2023-01-26T18:57:21.454Z,1674759441.454 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T18:57:21.454Z,1674759441.454 [transit:NeedComms:A] Running Loop=1
2023-01-26T18:57:21.455Z,1674759441.455 [transit:NeedComms:A](INFO): last time_fix was: 1674758719.000000 second since 1970/01/01T00:00:00Z
2023-01-26T18:57:21.456Z,1674759441.456 [transit:NeedComms:A] Stopped
2023-01-26T18:57:21.828Z,1674759441.828 [transit:NeedComms:C] Running Loop=1
2023-01-26T18:57:22.242Z,1674759442.242 [transit:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-01-26T18:57:23.807Z,1674759443.807 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185723.00,A,3648.19316,N,12147.57638,W,2.119,231.09,260123,,,A*7B
2023-01-26T18:57:23.809Z,1674759443.809 [NAL9602](INFO): GPS fix at 20230126T185723: (36.803219, -121.792940)
2023-01-26T18:57:23.869Z,1674759443.869 [transit:NeedComms:C] Stopped
2023-01-26T18:57:23.869Z,1674759443.869 [transit:NeedComms:D] Running Loop=1
2023-01-26T18:57:24.290Z,1674759444.290 [transit:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-01-26T18:57:33.956Z,1674759453.956 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.082558
2023-01-26T18:57:57.761Z,1674759477.761 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003324
2023-01-26T18:58:05.471Z,1674759485.471 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230126T172023/Courier0043.lzma
2023-01-26T18:58:06.474Z,1674759486.474 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0043.lzma.bak
2023-01-26T18:58:06.474Z,1674759486.474 [DataOverHttps](INFO): SBD MOMSN=17405547
2023-01-26T18:58:18.115Z,1674759498.115 [NAL9602](INFO): SBD MO Status=0, MOMSN=11076, MT Status=0, MTMSN=0
2023-01-26T18:58:18.115Z,1674759498.115 [NAL9602](INFO): No messages in MT queue
2023-01-26T18:58:22.933Z,1674759502.933 [DataOverHttps](INFO): Sending 798 bytes from file Logs/20230126T172023/Express0045.lzma
2023-01-26T18:58:23.934Z,1674759503.934 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0045.lzma.bak
2023-01-26T18:58:23.934Z,1674759503.934 [DataOverHttps](INFO): SBD MOMSN=17405550
2023-01-26T18:58:40.099Z,1674759520.099 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20230126T172023/Express0050.lzma
2023-01-26T18:58:41.102Z,1674759521.102 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0050.lzma.bak
2023-01-26T18:58:41.102Z,1674759521.102 [DataOverHttps](INFO): SBD MOMSN=17405576
2023-01-26T18:58:42.765Z,1674759522.765 [transit:NeedComms:D] Stopped
2023-01-26T18:58:42.766Z,1674759522.766 [transit:NeedComms:E] Running Loop=1
2023-01-26T18:58:43.174Z,1674759523.174 [transit:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-01-26T18:58:44.777Z,1674759524.777 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185844.00,A,3648.17381,N,12147.58679,W,0.350,209.54,260123,,,D*74
2023-01-26T18:58:44.779Z,1674759524.779 [NAL9602](INFO): GPS fix at 20230126T185844: (36.802897, -121.793113)
2023-01-26T18:58:44.808Z,1674759524.808 [transit:NeedComms:E] Stopped
2023-01-26T18:58:44.809Z,1674759524.809 [transit:NeedComms](INFO): Completed transit:NeedComms
2023-01-26T18:58:44.809Z,1674759524.809 [transit:NeedComms] Stopped
2023-01-26T18:58:44.809Z,1674759524.809 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2023-01-26T18:58:44.809Z,1674759524.809 [transit:NeedComms:B.GoToSurface] Stopped
2023-01-26T18:58:44.810Z,1674759524.810 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T18:59:17.499Z,1674759557.499 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T19:00:11.643Z,1674759611.643 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 18.86 mm (1 active estimators).
2023-01-26T19:00:35.343Z,1674759635.343 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T19:01:21.548Z,1674759681.548 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.806561
2023-01-26T19:02:47.745Z,1674759767.745 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:03:58.561Z,1674759838.561 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003331
2023-01-26T19:08:30.037Z,1674760110.037 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.835335
2023-01-26T19:09:55.249Z,1674760195.249 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:10:35.658Z,1674760235.658 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T19:10:46.083Z,1674760246.083 [transit:NeedComms] Running Loop=1
2023-01-26T19:10:46.083Z,1674760246.083 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2023-01-26T19:10:46.083Z,1674760246.083 [transit:NeedComms:B.GoToSurface] Running Loop=1
2023-01-26T19:10:46.083Z,1674760246.083 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T19:10:46.083Z,1674760246.083 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2023-01-26T19:10:46.084Z,1674760246.084 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2023-01-26T19:10:46.084Z,1674760246.084 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2023-01-26T19:10:46.084Z,1674760246.084 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2023-01-26T19:10:46.085Z,1674760246.085 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T19:10:46.085Z,1674760246.085 [transit:NeedComms:A] Running Loop=1
2023-01-26T19:10:46.086Z,1674760246.086 [transit:NeedComms:A](INFO): last time_fix was: 1674759524.000000 second since 1970/01/01T00:00:00Z
2023-01-26T19:10:46.086Z,1674760246.086 [transit:NeedComms:A] Stopped
2023-01-26T19:10:46.497Z,1674760246.497 [transit:NeedComms:C] Running Loop=1
2023-01-26T19:10:48.506Z,1674760248.506 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191047.00,A,3647.91323,N,12147.93186,W,2.119,219.37,260123,,,A*7F
2023-01-26T19:10:48.508Z,1674760248.508 [NAL9602](INFO): GPS fix at 20230126T191047: (36.798554, -121.798864)
2023-01-26T19:10:48.523Z,1674760248.523 [UniversalFixResidualReporter](INFO): Fix residual: 7.4 %DT, over the last 685.6 m. Residual distance 50.8 m at bearing 29.7 degrees. Fix at (36.7986, -121.7989) with 703.9 m made good.
2023-01-26T19:10:48.527Z,1674760248.527 [transit:NeedComms:C] Stopped
2023-01-26T19:10:48.527Z,1674760248.527 [transit:NeedComms:D] Running Loop=1
2023-01-26T19:10:49.105Z,1674760249.105 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003400
2023-01-26T19:11:29.708Z,1674760289.708 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20230126T172023/Courier0052.lzma
2023-01-26T19:11:30.710Z,1674760290.710 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0052.lzma.bak
2023-01-26T19:11:30.710Z,1674760290.710 [DataOverHttps](IMPORTANT): SBD MOMSN=17405580, MTMSN=20230126T191129
2023-01-26T19:11:38.368Z,1674760298.368 [DataOverHttps](INFO): Received command: stop
2023-01-26T19:11:38.461Z,1674760298.461 [CommandExec](IMPORTANT): got command stop
2023-01-26T19:11:38.461Z,1674760298.461 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2023-01-26T19:11:38.632Z,1674760298.632 [MissionManager](INFO): MissionManager is completed.
2023-01-26T19:11:38.633Z,1674760298.633 [MissionManager](INFO): Uninitializing Mission transit
2023-01-26T19:11:38.633Z,1674760298.633 [transit] Stopped
2023-01-26T19:11:38.633Z,1674760298.633 [transit](DEBUG): Aggregate::uninitialize transit
2023-01-26T19:11:38.633Z,1674760298.633 [transit:NeedComms] Stopped
2023-01-26T19:11:38.633Z,1674760298.633 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2023-01-26T19:11:38.633Z,1674760298.633 [transit:NeedComms:B.GoToSurface] Stopped
2023-01-26T19:11:38.633Z,1674760298.633 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T19:11:38.633Z,1674760298.633 [transit:NeedComms:D] Stopped
2023-01-26T19:11:38.633Z,1674760298.633 [transit:StandardEnvelopes] Stopped
2023-01-26T19:11:38.633Z,1674760298.633 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2023-01-26T19:11:38.633Z,1674760298.633 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2023-01-26T19:11:38.634Z,1674760298.634 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2023-01-26T19:11:38.634Z,1674760298.634 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2023-01-26T19:11:38.634Z,1674760298.634 [transit:BuoyancyHold.Buoyancy] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2023-01-26T19:11:38.634Z,1674760298.634 [transit:MassHold.Pitch] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit:A.Pitch] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit:B.SetSpeed] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit:Wpt1.Waypoint] Stopped
2023-01-26T19:11:38.634Z,1674760298.634 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2023-01-26T19:11:39.070Z,1674760299.070 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T19:11:39.071Z,1674760299.071 [Default] Running Loop=1
2023-01-26T19:11:39.071Z,1674760299.071 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T19:11:39.071Z,1674760299.071 [Default:B.GoToSurface] Running Loop=1
2023-01-26T19:11:39.071Z,1674760299.071 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T19:11:39.071Z,1674760299.071 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T19:11:39.071Z,1674760299.071 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T19:11:39.072Z,1674760299.072 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T19:11:39.117Z,1674760299.117 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T19:11:39.118Z,1674760299.118 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T19:11:39.128Z,1674760299.128 [Default:A.Wait] Running Loop=1
2023-01-26T19:11:39.128Z,1674760299.128 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T19:11:47.548Z,1674760307.548 [DataOverHttps](INFO): Sending 357 bytes from file Logs/20230126T172023/Express0053.lzma
2023-01-26T19:11:48.550Z,1674760308.550 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Express0053.lzma.bak
2023-01-26T19:11:48.550Z,1674760308.550 [DataOverHttps](INFO): SBD MOMSN=17405584
2023-01-26T19:11:52.349Z,1674760312.349 [Default:A.Wait](INFO): Done Waiting.
2023-01-26T19:11:52.349Z,1674760312.349 [Default:A.Wait] Stopped
2023-01-26T19:11:52.350Z,1674760312.350 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T19:11:52.757Z,1674760312.757 [Default:CheckIn] Running Loop=1
2023-01-26T19:11:52.758Z,1674760312.758 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T19:11:52.758Z,1674760312.758 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T19:12:16.975Z,1674760336.975 [NAL9602](INFO): SBD MO Status=2, MOMSN=11077, MT Status=2, MTMSN=0
2023-01-26T19:12:16.975Z,1674760336.975 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-01-26T19:12:36.770Z,1674760356.770 [NAL9602](INFO): SBD MO Status=0, MOMSN=11077, MT Status=0, MTMSN=0
2023-01-26T19:12:36.770Z,1674760356.770 [NAL9602](INFO): No messages in MT queue
2023-01-26T19:12:37.987Z,1674760357.987 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191237.00,A,3647.89646,N,12147.96135,W,0.758,238.07,260123,,,A*79
2023-01-26T19:12:37.997Z,1674760357.997 [NAL9602](INFO): GPS fix at 20230126T191237: (36.798274, -121.799356)
2023-01-26T19:12:38.010Z,1674760358.010 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T19:12:38.010Z,1674760358.010 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T19:12:45.599Z,1674760365.599 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230126T172023/Courier0055.lzma
2023-01-26T19:12:46.602Z,1674760366.602 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0055.lzma.bak
2023-01-26T19:12:46.602Z,1674760366.602 [DataOverHttps](INFO): SBD MOMSN=17405588
2023-01-26T19:12:54.906Z,1674760374.906 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T191254
2023-01-26T19:13:02.219Z,1674760382.219 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230126T172023/Courier0058.lzma
2023-01-26T19:13:02.222Z,1674760382.222 [DataOverHttps](INFO): Received command: load Transport/transit.tl;set transit.Latitude 36.797 degree;set transit.Longitude -121.847 degree;set transit.Depth 5 m;set transit.MaxDepth 10 m;set transit.MinOffshore 0.1 km;run
2023-01-26T19:13:02.248Z,1674760382.248 [CommandExec](IMPORTANT): got command load ./Missions/Transport/transit.tl
2023-01-26T19:13:02.249Z,1674760382.249 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/transit.tl
2023-01-26T19:13:02.249Z,1674760382.249 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Transport/transit.tx
2023-01-26T19:13:02.374Z,1674760382.374 [MissionManager](INFO): DefineArg transit.MissionTimeout = 60.000000 min
2023-01-26T19:13:02.376Z,1674760382.376 [MissionManager](INFO): DefineArg transit.NeedCommsTime = 30.000000 min
2023-01-26T19:13:02.378Z,1674760382.378 [MissionManager](INFO): DefineArg transit.Latitude = nan arcdeg
2023-01-26T19:13:02.381Z,1674760382.381 [MissionManager](INFO): DefineArg transit.Longitude = nan arcdeg
2023-01-26T19:13:02.383Z,1674760382.383 [MissionManager](INFO): DefineArg transit.Northings = 0.000000 m
2023-01-26T19:13:02.409Z,1674760382.409 [MissionManager](INFO): DefineArg transit.Eastings = 0.000000 m
2023-01-26T19:13:02.411Z,1674760382.411 [MissionManager](INFO): DefineArg transit.Depth = 10.000000 m
2023-01-26T19:13:02.417Z,1674760382.417 [MissionManager](INFO): DefineArg transit.Speed = 1.000000 m/s
2023-01-26T19:13:02.420Z,1674760382.420 [MissionManager](INFO): DefineArg transit.MaxDepth = 20.000000 m
2023-01-26T19:13:02.426Z,1674760382.426 [MissionManager](INFO): DefineArg transit.MinOffshore = 1.000000 km
2023-01-26T19:13:02.440Z,1674760382.440 [MissionManager](INFO): DefineArg transit.MinAltitude = 7.000000 m
2023-01-26T19:13:02.442Z,1674760382.442 [MissionManager](INFO): DefineArg transit.MassHold = 1 bool
2023-01-26T19:13:02.448Z,1674760382.448 [MissionManager](INFO): DefineArg transit.BuoyancyHold = 1 bool
2023-01-26T19:13:02.449Z,1674760382.449 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2023-01-26T19:13:02.517Z,1674760382.517 [MissionManager](INFO): DefineArg transit:NeedComms.DiveInterval = 3.000000 h
2023-01-26T19:13:02.519Z,1674760382.519 [MissionManager](INFO): DefineArg transit:NeedComms.WaitForPitchUp = 10.000000 min
2023-01-26T19:13:02.521Z,1674760382.521 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacePitch = 20.000000 arcdeg
2023-01-26T19:13:02.523Z,1674760382.523 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceDepthRate = nan m/s
2023-01-26T19:13:02.525Z,1674760382.525 [MissionManager](INFO): DefineArg transit:NeedComms.SurfaceSpeed = 1.000000 m/s
2023-01-26T19:13:02.527Z,1674760382.527 [MissionManager](INFO): DefineArg transit:NeedComms.SurfacingTimeout = 1000.000000 s
2023-01-26T19:13:02.529Z,1674760382.529 [MissionManager](INFO): DefineArg transit:NeedComms.GPSTimeout = 7.000000 min
2023-01-26T19:13:02.531Z,1674760382.531 [MissionManager](INFO): DefineArg transit:NeedComms.CommsTimeout = 30.000000 min
2023-01-26T19:13:02.536Z,1674760382.536 [transit:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-01-26T19:13:02.594Z,1674760382.594 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2023-01-26T19:13:02.635Z,1674760382.635 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinAltitude = 5.000000 m
2023-01-26T19:13:02.637Z,1674760382.637 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MaxDepth = 200.000000 m
2023-01-26T19:13:02.639Z,1674760382.639 [MissionManager](INFO): DefineArg transit:StandardEnvelopes.MinOffshore = 2000.000000 m
2023-01-26T19:13:02.640Z,1674760382.640 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2023-01-26T19:13:02.677Z,1674760382.677 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2023-01-26T19:13:02.683Z,1674760382.683 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2023-01-26T19:13:02.707Z,1674760382.707 [transit:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2023-01-26T19:13:02.726Z,1674760382.726 [transit:MassHold.Pitch](DEBUG): Construct.
2023-01-26T19:13:02.732Z,1674760382.732 [transit:Transit:A.Pitch](DEBUG): Construct.
2023-01-26T19:13:02.735Z,1674760382.735 [transit:Transit:B.SetSpeed](DEBUG): Construct.
2023-01-26T19:13:02.751Z,1674760382.751 [transit:Transit:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2023-01-26T19:13:02.773Z,1674760382.773 [MissionManager](DEBUG):
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.xml
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 1 second
insert Insert/StandardEnvelopes.xml
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
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"
}
}
2023-01-26T19:13:02.773Z,1674760382.773 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/transit.tl
2023-01-26T19:13:03.648Z,1674760383.648 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0058.lzma.bak
2023-01-26T19:13:03.648Z,1674760383.648 [DataOverHttps](INFO): SBD MOMSN=17405592
2023-01-26T19:13:10.301Z,1674760390.301 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T19:13:12.807Z,1674760392.807 [CommandExec](IMPORTANT): got command set transit.Latitude 36.797 degree
2023-01-26T19:13:12.808Z,1674760392.808 [CommandExec](IMPORTANT): got command set transit.Longitude -121.847 degree
2023-01-26T19:13:12.809Z,1674760392.809 [CommandExec](IMPORTANT): got command set transit.Depth 5 meter
2023-01-26T19:13:12.809Z,1674760392.809 [CommandExec](IMPORTANT): got command set transit.MaxDepth 10 meter
2023-01-26T19:13:12.810Z,1674760392.810 [CommandExec](IMPORTANT): got command set transit.MinOffshore 0.1 kilometer
2023-01-26T19:13:12.810Z,1674760392.810 [CommandExec](IMPORTANT): got command run
2023-01-26T19:13:12.862Z,1674760392.862 [CommandExec](IMPORTANT): Running
2023-01-26T19:13:13.152Z,1674760393.152 [Default] Stopped
2023-01-26T19:13:13.152Z,1674760393.152 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T19:13:13.152Z,1674760393.152 [Default:B.GoToSurface] Stopped
2023-01-26T19:13:13.152Z,1674760393.152 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T19:13:13.152Z,1674760393.152 [Default:CheckIn] Stopped
2023-01-26T19:13:13.153Z,1674760393.153 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T19:13:13.153Z,1674760393.153 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T19:13:13.153Z,1674760393.153 [MissionManager](IMPORTANT): Started mission transit
2023-01-26T19:13:13.153Z,1674760393.153 [transit] Running Loop=1
2023-01-26T19:13:13.153Z,1674760393.153 [transit](DEBUG): Aggregate::initialize transit
2023-01-26T19:13:13.153Z,1674760393.153 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T19:13:13.153Z,1674760393.153 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2023-01-26T19:13:13.153Z,1674760393.153 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T19:13:13.154Z,1674760393.154 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2023-01-26T19:13:13.154Z,1674760393.154 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T19:13:13.154Z,1674760393.154 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2023-01-26T19:13:13.154Z,1674760393.154 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T19:13:13.154Z,1674760393.154 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2023-01-26T19:13:13.154Z,1674760393.154 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T19:13:13.154Z,1674760393.154 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2023-01-26T19:13:13.154Z,1674760393.154 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T19:13:13.154Z,1674760393.154 [transit:MassHold.Pitch](DEBUG): Initialize.
2023-01-26T19:13:13.155Z,1674760393.155 [transit:B] Running Loop=1
2023-01-26T19:13:13.155Z,1674760393.155 [transit:MassHold.Pitch] Running Loop=1
2023-01-26T19:13:13.155Z,1674760393.155 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2023-01-26T19:13:13.156Z,1674760393.156 [transit:StandardEnvelopes] Running Loop=1
2023-01-26T19:13:13.156Z,1674760393.156 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2023-01-26T19:13:13.156Z,1674760393.156 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2023-01-26T19:13:13.156Z,1674760393.156 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2023-01-26T19:13:13.157Z,1674760393.157 [transit:B] Stopped
2023-01-26T19:13:13.157Z,1674760393.157 [transit:C] Running Loop=1
2023-01-26T19:13:13.571Z,1674760393.571 [transit:C] Stopped
2023-01-26T19:13:13.571Z,1674760393.571 [transit:E] Running Loop=1
2023-01-26T19:13:13.953Z,1674760393.953 [transit:E] Stopped
2023-01-26T19:13:13.953Z,1674760393.953 [transit:F] Running Loop=1
2023-01-26T19:13:14.362Z,1674760394.362 [transit:F] Stopped
2023-01-26T19:13:14.362Z,1674760394.362 [transit:G] Running Loop=1
2023-01-26T19:13:14.766Z,1674760394.766 [transit:G] Stopped
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit] Running Loop=1
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit:A.Pitch](DEBUG): Initialize.
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2023-01-26T19:13:14.766Z,1674760394.766 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2023-01-26T19:13:14.767Z,1674760394.767 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2023-01-26T19:13:14.768Z,1674760394.768 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2023-01-26T19:13:14.768Z,1674760394.768 [transit:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2023-01-26T19:13:15.187Z,1674760395.187 [transit:Transit:B.SetSpeed] Running Loop=1
2023-01-26T19:13:15.187Z,1674760395.187 [transit:Transit:A.Pitch] Running Loop=1
2023-01-26T19:13:22.944Z,1674760402.944 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230126T172023/Courier0061.lzma
2023-01-26T19:13:23.946Z,1674760403.946 [DataOverHttps](INFO): Moved sent file to Logs/20230126T172023/Courier0061.lzma.bak
2023-01-26T19:13:23.946Z,1674760403.946 [DataOverHttps](INFO): SBD MOMSN=17405595
2023-01-26T19:14:58.036Z,1674760498.036 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:15:00.045Z,1674760500.045 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.247284
2023-01-26T19:15:32.385Z,1674760532.385 [Radio_Surface](INFO): Powering down
2023-01-26T19:15:33.177Z,1674760533.177 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:15:34.180Z,1674760534.180 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-01-26T19:20:36.026Z,1674760836.026 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T19:30:36.418Z,1674761436.418 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T19:40:36.718Z,1674762036.718 [CBIT](FAULT): Could not open coulomb counter log file
2023-01-26T19:42:38.227Z,1674762158.227 [transit:NeedComms] Running Loop=1
2023-01-26T19:42:38.227Z,1674762158.227 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2023-01-26T19:42:38.227Z,1674762158.227 [transit:NeedComms:B.GoToSurface] Running Loop=1
2023-01-26T19:42:38.227Z,1674762158.227 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T19:42:38.227Z,1674762158.227 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2023-01-26T19:42:38.228Z,1674762158.228 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2023-01-26T19:42:38.228Z,1674762158.228 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2023-01-26T19:42:38.229Z,1674762158.229 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2023-01-26T19:42:38.229Z,1674762158.229 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T19:42:38.229Z,1674762158.229 [transit:NeedComms:A] Running Loop=1
2023-01-26T19:42:38.231Z,1674762158.231 [transit:NeedComms:A](INFO): last time_fix was: 1674760357.000000 second since 1970/01/01T00:00:00Z
2023-01-26T19:42:38.231Z,1674762158.231 [transit:NeedComms:A] Stopped
2023-01-26T19:43:00.462Z,1674762180.462 [transit:NeedComms:C] Running Loop=1
2023-01-26T19:43:00.874Z,1674762180.874 [transit:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-01-26T19:43:01.108Z,1674762181.108 [Radio_Surface](INFO): Powering up
2023-01-26T19:43:07.072Z,1674762187.072 [DataOverHttps](INFO): Radio surface powered ON.
2023-01-26T19:43:13.364Z,1674762193.364 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-01-26T19:43:13.366Z,1674762193.366 [BPC1](INFO): Received data from all battery sticks.
2023-01-26T19:43:14.569Z,1674762194.569 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=11078, MT Status=1, MTMSN=375
2023-01-26T19:43:14.569Z,1674762194.569 [NAL9602](INFO): Data available in MT queue
2023-01-26T19:43:15.056Z,1674762195.056 [NAL9602](INFO): Received command: stop
2023-01-26T19:43:15.130Z,1674762195.130 [CommandExec](IMPORTANT): got command stop
2023-01-26T19:43:15.130Z,1674762195.130 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2023-01-26T19:43:15.400Z,1674762195.400 [MissionManager](INFO): MissionManager is completed.
2023-01-26T19:43:15.401Z,1674762195.401 [MissionManager](INFO): Uninitializing Mission transit
2023-01-26T19:43:15.401Z,1674762195.401 [transit] Stopped
2023-01-26T19:43:15.401Z,1674762195.401 [transit](DEBUG): Aggregate::uninitialize transit
2023-01-26T19:43:15.401Z,1674762195.401 [transit:NeedComms] Stopped
2023-01-26T19:43:15.401Z,1674762195.401 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2023-01-26T19:43:15.401Z,1674762195.401 [transit:NeedComms:B.GoToSurface] Stopped
2023-01-26T19:43:15.401Z,1674762195.401 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T19:43:15.401Z,1674762195.401 [transit:NeedComms:C] Stopped
2023-01-26T19:43:15.401Z,1674762195.401 [transit:StandardEnvelopes] Stopped
2023-01-26T19:43:15.401Z,1674762195.401 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2023-01-26T19:43:15.401Z,1674762195.401 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2023-01-26T19:43:15.401Z,1674762195.401 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2023-01-26T19:43:15.401Z,1674762195.401 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2023-01-26T19:43:15.402Z,1674762195.402 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2023-01-26T19:43:15.402Z,1674762195.402 [transit:BuoyancyHold.Buoyancy] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2023-01-26T19:43:15.402Z,1674762195.402 [transit:MassHold.Pitch] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit:A.Pitch] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit:B.SetSpeed] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit:Wpt1.Waypoint] Stopped
2023-01-26T19:43:15.402Z,1674762195.402 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2023-01-26T19:43:15.817Z,1674762195.817 [MissionManager](IMPORTANT): Started mission Default
2023-01-26T19:43:15.817Z,1674762195.817 [Default] Running Loop=1
2023-01-26T19:43:15.818Z,1674762195.818 [Default](DEBUG): Aggregate::initialize Default
2023-01-26T19:43:15.818Z,1674762195.818 [Default:B.GoToSurface] Running Loop=1
2023-01-26T19:43:15.818Z,1674762195.818 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-01-26T19:43:15.818Z,1674762195.818 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-01-26T19:43:15.818Z,1674762195.818 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-01-26T19:43:15.819Z,1674762195.819 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-01-26T19:43:15.819Z,1674762195.819 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-01-26T19:43:15.819Z,1674762195.819 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-01-26T19:43:15.820Z,1674762195.820 [Default:A.Wait] Running Loop=1
2023-01-26T19:43:15.820Z,1674762195.820 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-01-26T19:43:16.187Z,1674762196.187 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194315.00,A,3647.73003,N,12149.19809,W,1.244,256.67,260123,,,A*77
2023-01-26T19:43:16.189Z,1674762196.189 [NAL9602](INFO): GPS fix at 20230126T194315: (36.795501, -121.819968)
2023-01-26T19:43:16.204Z,1674762196.204 [UniversalFixResidualReporter](INFO): Fix residual: 15.7 %DT, over the last 1753.4 m. Residual distance 274.9 m at bearing 24.6 degrees. Fix at (36.7955, -121.8200) with 1861.1 m made good.
2023-01-26T19:43:29.131Z,1674762209.131 [Default:A.Wait](INFO): Done Waiting.
2023-01-26T19:43:29.131Z,1674762209.131 [Default:A.Wait] Stopped
2023-01-26T19:43:29.131Z,1674762209.131 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T19:43:29.532Z,1674762209.532 [Default:CheckIn] Running Loop=1
2023-01-26T19:43:29.532Z,1674762209.532 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-01-26T19:43:29.532Z,1674762209.532 [Default:CheckIn:Read_GPS] Running Loop=1
2023-01-26T19:43:31.545Z,1674762211.545 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194330.00,A,3647.72855,N,12149.20175,W,0.680,247.47,260123,,,A*7D
2023-01-26T19:43:31.547Z,1674762211.547 [NAL9602](INFO): GPS fix at 20230126T194330: (36.795476, -121.820029)
2023-01-26T19:43:31.559Z,1674762211.559 [Default:CheckIn:Read_GPS] Stopped
2023-01-26T19:43:31.559Z,1674762211.559 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-01-26T19:43:37.196Z,1674762217.196 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:44:06.059Z,1674762246.059 [NAL9602](INFO): SBD MO Status=1, MOMSN=11079, MT Status=0, MTMSN=0
2023-01-26T19:44:06.108Z,1674762246.108 [NAL9602](INFO): Sent 94 bytes from file Logs/20230126T172023/Courier0064.lzma
2023-01-26T19:44:06.109Z,1674762246.109 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:44:12.337Z,1674762252.337 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:44:15.417Z,1674762255.417 [NAL9602](INFO): SBD MO Status=1, MOMSN=11080, MT Status=0, MTMSN=0
2023-01-26T19:44:15.466Z,1674762255.466 [NAL9602](INFO): Sent 190 bytes from file Logs/20230126T172023/Express0056.lzma
2023-01-26T19:44:15.466Z,1674762255.466 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:44:23.206Z,1674762263.206 [NAL9602](INFO): SBD MO Status=1, MOMSN=11081, MT Status=0, MTMSN=0
2023-01-26T19:44:23.260Z,1674762263.260 [NAL9602](INFO): Sent 61 bytes from file Logs/20230126T172023/Express0059.lzma
2023-01-26T19:44:23.261Z,1674762263.261 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:44:32.974Z,1674762272.974 [NAL9602](INFO): SBD MO Status=1, MOMSN=11082, MT Status=0, MTMSN=0
2023-01-26T19:44:33.030Z,1674762273.030 [NAL9602](INFO): Sent 203 bytes from file Logs/20230126T172023/Express0062.lzma
2023-01-26T19:44:33.030Z,1674762273.030 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:44:41.543Z,1674762281.543 [NAL9602](INFO): SBD MO Status=1, MOMSN=11083, MT Status=0, MTMSN=0
2023-01-26T19:44:41.596Z,1674762281.596 [NAL9602](INFO): Sent 332 bytes from file Logs/20230126T172023/Express0065.lzma
2023-01-26T19:44:41.596Z,1674762281.596 [NAL9602](INFO): Packets left to send: 2
2023-01-26T19:44:47.492Z,1674762287.492 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:44:49.686Z,1674762289.686 [NAL9602](INFO): SBD MO Status=1, MOMSN=11084, MT Status=0, MTMSN=0
2023-01-26T19:44:49.740Z,1674762289.740 [NAL9602](INFO): Sent 332 bytes from file Logs/20230126T172023/Express0065.lzma
2023-01-26T19:44:49.740Z,1674762289.740 [NAL9602](INFO): Packets left to send: 1
2023-01-26T19:45:07.605Z,1674762307.605 [NAL9602](INFO): SBD MO Status=2, MOMSN=11085, MT Status=2, MTMSN=0
2023-01-26T19:45:07.605Z,1674762307.605 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-01-26T19:45:22.640Z,1674762322.640 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:45:22.679Z,1674762322.679 [NAL9602](INFO): SBD MO Status=1, MOMSN=11085, MT Status=0, MTMSN=0
2023-01-26T19:45:22.728Z,1674762322.728 [NAL9602](INFO): Sent 29 bytes from file Logs/20230126T172023/Express0065.lzma
2023-01-26T19:45:22.729Z,1674762322.729 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:45:31.159Z,1674762331.159 [NAL9602](INFO): SBD MO Status=0, MOMSN=11086, MT Status=0, MTMSN=0
2023-01-26T19:45:48.579Z,1674762348.579 [NAL9602](INFO): SBD MO Status=1, MOMSN=11087, MT Status=0, MTMSN=0
2023-01-26T19:45:48.632Z,1674762348.632 [NAL9602](INFO): Sent 39 bytes from file Logs/20230126T172023/Courier0067.lzma
2023-01-26T19:45:48.632Z,1674762348.632 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:45:57.784Z,1674762357.784 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-01-26T19:45:59.475Z,1674762359.475 [NAL9602](INFO): SBD MO Status=1, MOMSN=11088, MT Status=0, MTMSN=0
2023-01-26T19:45:59.528Z,1674762359.528 [NAL9602](INFO): Sent 71 bytes from file Logs/20230126T172023/Express0068.lzma
2023-01-26T19:45:59.528Z,1674762359.528 [NAL9602](INFO): Packets left to send: 0
2023-01-26T19:46:14.427Z,1674762374.427 [NAL9602](INFO): SBD MO Status=0, MOMSN=11089, MT Status=0, MTMSN=0
2023-01-26T19:46:14.517Z,1674762374.517 [Default:CheckIn:Read_Iridium] Stopped
2023-01-26T19:46:14.518Z,1674762374.518 [Default:CheckIn:C.Wait] Running Loop=1
2023-01-26T19:46:14.518Z,1674762374.518 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-01-26T19:46:30.285Z,1674762390.285 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003404
2023-01-26T19:46:45.129Z,1674762405.129 [NAL9602](INFO): Not Powering down - fast GPS
2023-01-26T19:49:42.657Z,1674762582.657 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T194941
2023-01-26T19:49:52.588Z,1674762592.588 [DataOverHttps](INFO): Received command: configSet Express linearApproximation height_above_sea_floor 5 meter persist
2023-01-26T19:49:53.597Z,1674762593.597 [DataOverHttps](IMPORTANT): SBD MTMSN=20230126T194952
2023-01-26T19:49:54.059Z,1674762594.059 [CommandExec](IMPORTANT): got command configSet Express linearApproximation height_above_sea_floor 5 meter persist
2023-01-26T19:50:01.028Z,1674762601.028 [DataOverHttps](INFO): Received command: restart app
2023-01-26T19:50:01.061Z,1674762601.061 [CommandExec](IMPORTANT): got command restart application
2023-01-26T19:50:02.064Z,1674762602.064 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:02.065Z,1674762602.065 [CommandExec](INFO): Uninitializing the command executive.
2023-01-26T19:50:02.065Z,1674762602.065 [CommandExec](INFO): Uninitializing the command scheduler.
2023-01-26T19:50:02.065Z,1674762602.065 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:02.092Z,1674762602.092 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2023-01-26T19:50:02.092Z,1674762602.092 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-01-26T19:50:02.092Z,1674762602.092 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:02.093Z,1674762602.093 [NavChartDb](INFO): Join timeout helper Thread ID is 2956
2023-01-26T19:50:02.464Z,1674762602.464 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:02.465Z,1674762602.464 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:02.468Z,1674762602.468 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-01-26T19:50:02.468Z,1674762602.468 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:02.469Z,1674762602.469 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2957
2023-01-26T19:50:02.728Z,1674762602.728 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:02.729Z,1674762602.729 [WetLabsBB2FL](INFO): Powering down
2023-01-26T19:50:02.729Z,1674762602.729 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:02.732Z,1674762602.732 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-01-26T19:50:02.732Z,1674762602.732 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:02.732Z,1674762602.732 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2958
2023-01-26T19:50:03.649Z,1674762603.649 [CTD_Seabird](INFO): Powering down
2023-01-26T19:50:03.660Z,1674762603.660 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:03.660Z,1674762603.660 [CTD_Seabird](INFO): Powering down
2023-01-26T19:50:03.672Z,1674762603.672 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:03.684Z,1674762603.684 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-01-26T19:50:03.684Z,1674762603.684 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:03.684Z,1674762603.684 [Radio_Surface](INFO): Join timeout helper Thread ID is 2959
2023-01-26T19:50:03.772Z,1674762603.772 [Radio_Surface](INFO): Powering down
2023-01-26T19:50:03.773Z,1674762603.773 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:03.773Z,1674762603.773 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:03.792Z,1674762603.792 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-01-26T19:50:03.792Z,1674762603.792 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:03.792Z,1674762603.792 [Onboard](INFO): Join timeout helper Thread ID is 2960
2023-01-26T19:50:04.036Z,1674762604.036 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-01-26T19:50:05.452Z,1674762605.452 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:05.452Z,1674762605.452 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:05.476Z,1674762605.476 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-01-26T19:50:05.476Z,1674762605.476 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:05.476Z,1674762605.476 [DataOverHttps](INFO): Join timeout helper Thread ID is 2961
2023-01-26T19:50:06.045Z,1674762606.045 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:06.045Z,1674762606.045 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.049Z,1674762606.049 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-01-26T19:50:06.049Z,1674762606.049 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.049Z,1674762606.049 [BackseatComponent](INFO): Join timeout helper Thread ID is 2962
2023-01-26T19:50:06.236Z,1674762606.236 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:06.236Z,1674762606.236 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.249Z,1674762606.249 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-01-26T19:50:06.249Z,1674762606.249 [logger ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.249Z,1674762606.249 [logger](INFO): Join timeout helper Thread ID is 2963
2023-01-26T19:50:06.284Z,1674762606.284 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:06.284Z,1674762606.284 [logger ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.289Z,1674762606.289 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-01-26T19:50:06.289Z,1674762606.289 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.289Z,1674762606.289 [CommandLine](INFO): Join timeout helper Thread ID is 2964
2023-01-26T19:50:06.312Z,1674762606.312 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:06.312Z,1674762606.312 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.329Z,1674762606.329 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-01-26T19:50:06.329Z,1674762606.329 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.330Z,1674762606.330 [CommandExec](INFO): Join timeout helper Thread ID is 2965
2023-01-26T19:50:06.331Z,1674762606.331 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-01-26T19:50:06.331Z,1674762606.331 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.331Z,1674762606.331 [controlThread](INFO): Join timeout helper Thread ID is 2966
2023-01-26T19:50:06.372Z,1674762606.372 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-01-26T19:50:06.372Z,1674762606.372 [controlThread](DEBUG): Uninitializing ControlThread
2023-01-26T19:50:06.373Z,1674762606.373 [AHRS_M2](INFO): Powering down
2023-01-26T19:50:06.445Z,1674762606.445 [NAL9602](INFO): Powering down
2023-01-26T19:50:06.447Z,1674762606.447 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-01-26T19:50:06.448Z,1674762606.448 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-01-26T19:50:06.448Z,1674762606.448 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-01-26T19:50:06.449Z,1674762606.449 [MissionManager](INFO): Uninitializing Mission Default
2023-01-26T19:50:06.449Z,1674762606.449 [Default] Stopped
2023-01-26T19:50:06.449Z,1674762606.449 [Default](DEBUG): Aggregate::uninitialize Default
2023-01-26T19:50:06.449Z,1674762606.449 [Default:B.GoToSurface] Stopped
2023-01-26T19:50:06.449Z,1674762606.449 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-01-26T19:50:06.449Z,1674762606.449 [Default:CheckIn] Stopped
2023-01-26T19:50:06.450Z,1674762606.450 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-01-26T19:50:06.450Z,1674762606.450 [Default:CheckIn:C.Wait] Stopped
2023-01-26T19:50:06.450Z,1674762606.450 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-01-26T19:50:06.452Z,1674762606.452 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-01-26T19:50:06.453Z,1674762606.453 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-01-26T19:50:06.453Z,1674762606.453 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-01-26T19:50:06.453Z,1674762606.453 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-01-26T19:50:06.454Z,1674762606.454 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-01-26T19:50:06.454Z,1674762606.454 [BuoyancyServo](INFO): Powering down
2023-01-26T19:50:06.468Z,1674762606.468 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-01-26T19:50:06.468Z,1674762606.468 [ElevatorServo](INFO): Powering down
2023-01-26T19:50:06.469Z,1674762606.469 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-01-26T19:50:06.469Z,1674762606.469 [MassServo](INFO): Powering down
2023-01-26T19:50:06.470Z,1674762606.470 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-01-26T19:50:06.470Z,1674762606.470 [RudderServo](INFO): Powering down
2023-01-26T19:50:06.471Z,1674762606.471 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-01-26T19:50:06.471Z,1674762606.471 [ThrusterHE](INFO): Powering down
2023-01-26T19:50:06.472Z,1674762606.472 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-01-26T19:50:06.472Z,1674762606.472 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-01-26T19:50:06.473Z,1674762606.473 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-01-26T19:50:06.473Z,1674762606.473 [CBIT](DEBUG): Powering off loads.
2023-01-26T19:50:06.484Z,1674762606.484 [CBIT](DEBUG): Disabling WDT.
2023-01-26T19:50:06.496Z,1674762606.496 [CBIT](DEBUG): Opening all GF detection circuits.
2023-01-26T19:50:06.497Z,1674762606.497 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.521Z,1674762606.521 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.525Z,1674762606.525 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.531Z,1674762606.531 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.575Z,1674762606.575 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.625Z,1674762606.625 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.629Z,1674762606.629 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.683Z,1674762606.683 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-01-26T19:50:06.727Z,1674762606.727 [logger ThreadHandler](INFO): Thread cancelled.