2026-03-05T23:08:44.923Z,1772752124.923 [Supervisor](DEBUG): Initializing supervisor. 2026-03-05T23:08:44.927Z,1772752124.927 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2026-03-05T23:08:44.927Z,1772752124.927 [SyncHandler](INFO): Protected caller Thread ID is 1005 2026-03-05T23:08:44.928Z,1772752124.928 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2026-03-05T23:08:44.929Z,1772752124.929 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2026-03-05T23:08:44.929Z,1772752124.929 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1006 2026-03-05T23:08:44.933Z,1772752124.933 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2026-03-05T23:08:44.952Z,1772752124.952 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2026-03-05T23:08:44.953Z,1772752124.953 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2026-03-05T23:08:44.954Z,1772752124.954 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1007 2026-03-05T23:08:44.958Z,1772752124.958 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2026-03-05T23:08:44.959Z,1772752124.959 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2026-03-05T23:08:44.959Z,1772752124.959 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1008 2026-03-05T23:08:44.961Z,1772752124.961 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2026-03-05T23:08:44.962Z,1772752124.962 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2026-03-05T23:08:44.963Z,1772752124.963 [logger ThreadHandler](INFO): Protected caller Thread ID is 1009 2026-03-05T23:08:44.966Z,1772752124.966 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2026-03-05T23:08:44.967Z,1772752124.967 [Supervisor](INFO): Looking for Config files in directory: Config/ 2026-03-05T23:08:44.968Z,1772752124.968 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2026-03-05T23:08:45.449Z,1772752125.449 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2026-03-05T23:08:45.450Z,1772752125.450 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2026-03-05T23:08:45.667Z,1772752125.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2026-03-05T23:08:45.668Z,1772752125.668 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2026-03-05T23:08:45.767Z,1772752125.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2026-03-05T23:08:45.768Z,1772752125.768 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2026-03-05T23:08:46.009Z,1772752126.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2026-03-05T23:08:46.010Z,1772752126.010 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2026-03-05T23:08:46.098Z,1772752126.098 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2026-03-05T23:08:46.203Z,1772752126.203 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2026-03-05T23:08:46.204Z,1772752126.204 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2026-03-05T23:08:46.562Z,1772752126.562 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2026-03-05T23:08:46.563Z,1772752126.563 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2026-03-05T23:08:46.705Z,1772752126.705 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2026-03-05T23:08:46.705Z,1772752126.705 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2026-03-05T23:08:47.253Z,1772752127.253 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2026-03-05T23:08:47.254Z,1772752127.254 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2026-03-05T23:08:47.443Z,1772752127.443 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2026-03-05T23:08:47.444Z,1772752127.444 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2026-03-05T23:08:47.870Z,1772752127.870 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2026-03-05T23:08:47.871Z,1772752127.871 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2026-03-05T23:08:48.177Z,1772752128.177 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2026-03-05T23:08:48.177Z,1772752128.177 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2026-03-05T23:08:48.621Z,1772752128.621 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2026-03-05T23:08:48.622Z,1772752128.622 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2026-03-05T23:08:49.671Z,1772752129.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2026-03-05T23:08:49.672Z,1772752129.672 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2026-03-05T23:08:50.024Z,1772752130.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2026-03-05T23:08:50.025Z,1772752130.025 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2026-03-05T23:08:50.276Z,1772752130.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2026-03-05T23:08:50.278Z,1772752130.278 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2026-03-05T23:08:50.279Z,1772752130.279 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2026-03-05T23:08:50.407Z,1772752130.407 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2026-03-05T23:08:50.499Z,1772752130.499 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2026-03-05T23:08:50.644Z,1772752130.644 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2026-03-05T23:08:50.738Z,1772752130.738 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2026-03-05T23:08:51.009Z,1772752131.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2026-03-05T23:08:51.010Z,1772752131.010 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2026-03-05T23:08:51.123Z,1772752131.123 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2026-03-05T23:08:51.239Z,1772752131.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2026-03-05T23:08:51.346Z,1772752131.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2026-03-05T23:08:51.507Z,1772752131.507 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2026-03-05T23:08:51.613Z,1772752131.613 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2026-03-05T23:08:51.710Z,1772752131.710 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/ 2026-03-05T23:08:51.710Z,1772752131.710 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2026-03-05T23:08:51.719Z,1772752131.719 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2026-03-05T23:08:51.729Z,1772752131.729 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2026-03-05T23:08:51.730Z,1772752131.730 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2026-03-05T23:08:51.863Z,1772752131.863 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2026-03-05T23:08:51.863Z,1772752131.863 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2026-03-05T23:08:51.915Z,1772752131.915 [VerticalControl](DEBUG): Construct VerticalControl. 2026-03-05T23:08:51.975Z,1772752131.975 [VerticalControl] Loaded 2026-03-05T23:08:51.975Z,1772752131.975 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2026-03-05T23:08:51.978Z,1772752131.978 [HorizontalControl](DEBUG): Construct HorizontalControl. 2026-03-05T23:08:52.024Z,1772752132.024 [HorizontalControl] Loaded 2026-03-05T23:08:52.024Z,1772752132.024 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2026-03-05T23:08:52.027Z,1772752132.027 [SpeedControl](DEBUG): Construct SpeedControl. 2026-03-05T23:08:52.030Z,1772752132.030 [SpeedControl] Loaded 2026-03-05T23:08:52.030Z,1772752132.030 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2026-03-05T23:08:52.033Z,1772752132.033 [LoopControl](DEBUG): Construct LoopControl. 2026-03-05T23:08:52.033Z,1772752132.033 [LoopControl] Loaded 2026-03-05T23:08:52.033Z,1772752132.033 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2026-03-05T23:08:52.034Z,1772752132.034 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2026-03-05T23:08:52.034Z,1772752132.034 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2026-03-05T23:08:52.192Z,1772752132.192 [BuoyancyServo] Loaded 2026-03-05T23:08:52.192Z,1772752132.192 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2026-03-05T23:08:52.214Z,1772752132.214 [ElevatorServo] Loaded 2026-03-05T23:08:52.214Z,1772752132.214 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2026-03-05T23:08:52.234Z,1772752132.234 [MassServo] Loaded 2026-03-05T23:08:52.235Z,1772752132.235 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2026-03-05T23:08:52.254Z,1772752132.254 [RudderServo] Loaded 2026-03-05T23:08:52.254Z,1772752132.254 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2026-03-05T23:08:52.271Z,1772752132.271 [ThrusterHE] Loaded 2026-03-05T23:08:52.271Z,1772752132.271 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2026-03-05T23:08:52.272Z,1772752132.272 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2026-03-05T23:08:52.272Z,1772752132.272 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2026-03-05T23:08:52.322Z,1772752132.322 [DepthRateCalculator] Loaded 2026-03-05T23:08:52.322Z,1772752132.322 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2026-03-05T23:08:52.327Z,1772752132.327 [PitchRateCalculator] Loaded 2026-03-05T23:08:52.327Z,1772752132.327 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2026-03-05T23:08:52.337Z,1772752132.337 [SpeedCalculator] Loaded 2026-03-05T23:08:52.337Z,1772752132.337 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2026-03-05T23:08:52.341Z,1772752132.341 [YawRateCalculator] Loaded 2026-03-05T23:08:52.341Z,1772752132.341 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2026-03-05T23:08:52.359Z,1772752132.359 [ElevatorOffsetCalculator] Loaded 2026-03-05T23:08:52.360Z,1772752132.360 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2026-03-05T23:08:52.360Z,1772752132.360 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2026-03-05T23:08:52.361Z,1772752132.361 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2026-03-05T23:08:52.473Z,1772752132.473 [DeadReckonUsingMultipleVelocitySources] Loaded 2026-03-05T23:08:52.473Z,1772752132.473 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2026-03-05T23:08:52.487Z,1772752132.487 [NavChart] Loaded 2026-03-05T23:08:52.487Z,1772752132.487 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2026-03-05T23:08:52.493Z,1772752132.493 [UniversalFixResidualReporter] Loaded 2026-03-05T23:08:52.493Z,1772752132.493 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2026-03-05T23:08:52.493Z,1772752132.493 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2026-03-05T23:08:52.494Z,1772752132.494 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2026-03-05T23:08:52.987Z,1772752132.987 [AHRS_M2] Loaded 2026-03-05T23:08:52.988Z,1772752132.988 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2026-03-05T23:08:53.026Z,1772752133.026 [BackseatComponent] Loaded 2026-03-05T23:08:53.026Z,1772752133.026 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2026-03-05T23:08:53.027Z,1772752133.027 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409454E0 2026-03-05T23:08:53.027Z,1772752133.027 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1091 2026-03-05T23:08:53.030Z,1772752133.030 [LcmPublisher] Loaded 2026-03-05T23:08:53.031Z,1772752133.031 [ComponentRegistry](DEBUG): SyncComponent "LcmPublisher" handled in the control thread. 2026-03-05T23:08:53.037Z,1772752133.037 [BioacousticsDataBridge] Loaded 2026-03-05T23:08:53.037Z,1772752133.037 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2026-03-05T23:08:53.850Z,1772752133.850 [BPC1] Loaded 2026-03-05T23:08:53.850Z,1772752133.850 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2026-03-05T23:08:53.946Z,1772752133.946 [DAT] Loaded 2026-03-05T23:08:53.947Z,1772752133.947 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2026-03-05T23:08:53.948Z,1772752133.948 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409754E0 2026-03-05T23:08:53.948Z,1772752133.948 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1092 2026-03-05T23:08:54.021Z,1772752134.021 [DataOverHttps] Loaded 2026-03-05T23:08:54.022Z,1772752134.022 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2026-03-05T23:08:54.022Z,1772752134.022 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409A54E0 2026-03-05T23:08:54.023Z,1772752134.023 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1093 2026-03-05T23:08:54.046Z,1772752134.046 [Depth_Keller] Loaded 2026-03-05T23:08:54.046Z,1772752134.046 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2026-03-05T23:08:54.051Z,1772752134.051 [DropWeight] Loaded 2026-03-05T23:08:54.051Z,1772752134.051 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2026-03-05T23:08:54.114Z,1772752134.114 [NAL9602] Loaded 2026-03-05T23:08:54.114Z,1772752134.114 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2026-03-05T23:08:54.143Z,1772752134.143 [Onboard] Loaded 2026-03-05T23:08:54.143Z,1772752134.143 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2026-03-05T23:08:54.144Z,1772752134.144 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409D54E0 2026-03-05T23:08:54.145Z,1772752134.145 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1094 2026-03-05T23:08:54.151Z,1772752134.151 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2026-03-05T23:08:54.164Z,1772752134.164 [PowerOnly] Loaded 2026-03-05T23:08:54.165Z,1772752134.165 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2026-03-05T23:08:54.179Z,1772752134.179 [Power24vConverter] Loaded 2026-03-05T23:08:54.179Z,1772752134.179 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2026-03-05T23:08:54.193Z,1772752134.193 [Radio_Surface] Loaded 2026-03-05T23:08:54.193Z,1772752134.193 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2026-03-05T23:08:54.194Z,1772752134.194 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A054E0 2026-03-05T23:08:54.195Z,1772752134.195 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1095 2026-03-05T23:08:54.210Z,1772752134.210 [Sonardyne_Nano] Loaded 2026-03-05T23:08:54.210Z,1772752134.210 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2026-03-05T23:08:54.211Z,1772752134.211 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2026-03-05T23:08:54.211Z,1772752134.211 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2026-03-05T23:08:54.554Z,1772752134.554 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2026-03-05T23:08:54.554Z,1772752134.554 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2026-03-05T23:08:54.961Z,1772752134.961 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2026-03-05T23:08:54.961Z,1772752134.961 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2026-03-05T23:08:55.091Z,1772752135.091 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2026-03-05T23:08:55.092Z,1772752135.092 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2026-03-05T23:08:55.266Z,1772752135.266 [CTD_Seabird] Loaded 2026-03-05T23:08:55.266Z,1772752135.266 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2026-03-05T23:08:55.267Z,1772752135.267 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B514E0 2026-03-05T23:08:55.267Z,1772752135.267 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1096 2026-03-05T23:08:55.289Z,1772752135.289 [PAR_Licor] Loaded 2026-03-05T23:08:55.289Z,1772752135.289 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2026-03-05T23:08:55.334Z,1772752135.334 [WetLabsBB2FL] Loaded 2026-03-05T23:08:55.334Z,1772752135.334 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2026-03-05T23:08:55.335Z,1772752135.335 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B814E0 2026-03-05T23:08:55.335Z,1772752135.335 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1097 2026-03-05T23:08:55.336Z,1772752135.336 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2026-03-05T23:08:55.337Z,1772752135.337 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2026-03-05T23:08:55.675Z,1772752135.675 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2026-03-05T23:08:55.676Z,1772752135.676 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2026-03-05T23:08:55.834Z,1772752135.834 [SBIT](DEBUG): Construct Startup Built In Test. 2026-03-05T23:08:55.844Z,1772752135.844 [SBIT] Loaded 2026-03-05T23:08:55.844Z,1772752135.844 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2026-03-05T23:08:55.847Z,1772752135.847 [IBIT](DEBUG): Construct Initiated Built In Test. 2026-03-05T23:08:55.859Z,1772752135.859 [IBIT] Loaded 2026-03-05T23:08:55.860Z,1772752135.860 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2026-03-05T23:08:55.865Z,1772752135.865 [CBIT](DEBUG): Construct Continuous Built In Test. 2026-03-05T23:08:55.945Z,1772752135.945 [CBIT] Loaded 2026-03-05T23:08:55.945Z,1772752135.945 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2026-03-05T23:08:55.977Z,1772752135.977 [GFScanner] Loaded 2026-03-05T23:08:55.977Z,1772752135.977 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2026-03-05T23:08:55.977Z,1772752135.977 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2026-03-05T23:08:55.983Z,1772752135.983 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2026-03-05T23:08:55.986Z,1772752135.986 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2026-03-05T23:08:55.997Z,1772752135.997 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2026-03-05T23:08:55.998Z,1772752135.998 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C8A4E0 2026-03-05T23:08:55.999Z,1772752135.999 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1098 2026-03-05T23:08:56.003Z,1772752136.003 [Supervisor](INFO): Main Thread ID is 830 2026-03-05T23:08:56.003Z,1772752136.003 [Supervisor](DEBUG): Running supervisor. 2026-03-05T23:08:56.004Z,1772752136.004 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1099 2026-03-05T23:08:56.004Z,1772752136.004 [CommandExec](INFO): Initializing the command executive. 2026-03-05T23:08:56.006Z,1772752136.006 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1100 2026-03-05T23:08:56.009Z,1772752136.009 [controlThread ThreadHandler](INFO): Handler Thread ID is 1101 2026-03-05T23:08:56.010Z,1772752136.010 [controlThread](DEBUG): Initializing ControlThread 2026-03-05T23:08:56.011Z,1772752136.011 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2026-03-05T23:08:56.012Z,1772752136.012 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2026-03-05T23:08:56.013Z,1772752136.013 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2026-03-05T23:08:56.013Z,1772752136.013 [LoopControl](DEBUG): Initialize LoopControlComponent. 2026-03-05T23:08:56.015Z,1772752136.015 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2026-03-05T23:08:56.015Z,1772752136.015 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2026-03-05T23:08:56.015Z,1772752136.015 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2026-03-05T23:08:56.016Z,1772752136.016 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2026-03-05T23:08:56.016Z,1772752136.016 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2026-03-05T23:08:56.017Z,1772752136.017 [NavChart](DEBUG): Initialize NavChart Navigation. 2026-03-05T23:08:56.018Z,1772752136.018 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2026-03-05T23:08:56.024Z,1772752136.024 [SBIT](INFO): Initialize SBIT Component. 2026-03-05T23:08:56.025Z,1772752136.025 [SBIT](IMPORTANT): git: 2026-03-03 2026-03-05T23:08:56.025Z,1772752136.025 [SBIT](INFO): git hash: f7a2e94ac3e2178d8a146c43cd471ee86a10fe19 2026-03-05T23:08:56.025Z,1772752136.025 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2026-03-05T23:08:56.026Z,1772752136.026 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2026-03-05T23:08:56.027Z,1772752136.027 [SBIT](INFO): Beginning SBIT in 49.000000 seconds. 2026-03-05T23:08:56.028Z,1772752136.028 [IBIT](INFO): Initialize IBIT Component. 2026-03-05T23:08:56.029Z,1772752136.029 [CBIT](DEBUG): Initialize CBIT Component. 2026-03-05T23:08:56.030Z,1772752136.030 [logger ThreadHandler](INFO): Handler Thread ID is 1102 2026-03-05T23:08:56.040Z,1772752136.040 [CBIT](DEBUG): Initialized mux pins. 2026-03-05T23:08:56.040Z,1772752136.040 [CBIT](DEBUG): Initializing the watchdog timer. 2026-03-05T23:08:56.048Z,1772752136.048 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1103 2026-03-05T23:08:56.060Z,1772752136.060 [DAT ThreadHandler](INFO): Handler Thread ID is 1104 2026-03-05T23:08:56.061Z,1772752136.061 [DAT](INFO): Powering up 2026-03-05T23:08:56.061Z,1772752136.061 [DAT](DEBUG): Initializing DAT. 2026-03-05T23:08:56.064Z,1772752136.064 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2026-03-05T23:08:56.064Z,1772752136.064 [CBIT](DEBUG): Initializing heartbeat. 2026-03-05T23:08:56.066Z,1772752136.066 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1106 2026-03-05T23:08:56.068Z,1772752136.068 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2026-03-05T23:08:56.077Z,1772752136.077 [Onboard ThreadHandler](INFO): Handler Thread ID is 1107 2026-03-05T23:08:56.094Z,1772752136.094 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1108 2026-03-05T23:08:56.120Z,1772752136.120 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1109 2026-03-05T23:08:56.120Z,1772752136.120 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2026-03-05T23:08:56.122Z,1772752136.122 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1111 2026-03-05T23:08:56.129Z,1772752136.129 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1113 2026-03-05T23:08:56.133Z,1772752136.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000 2026-03-05T23:08:56.133Z,1772752136.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000 2026-03-05T23:08:56.133Z,1772752136.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QL.000 2026-03-05T23:08:56.133Z,1772752136.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QL.000 2026-03-05T23:08:56.133Z,1772752136.133 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QM.000 2026-03-05T23:08:56.133Z,1772752136.133 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QM.000 2026-03-05T23:08:56.134Z,1772752136.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2PM.000 2026-03-05T23:08:56.134Z,1772752136.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2PM.000 2026-03-05T23:08:56.134Z,1772752136.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI74M.000 2026-03-05T23:08:56.134Z,1772752136.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI74M.000 2026-03-05T23:08:56.134Z,1772752136.134 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QN.000 2026-03-05T23:08:56.134Z,1772752136.134 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QN.000 2026-03-05T23:08:56.135Z,1772752136.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QO.000 2026-03-05T23:08:56.135Z,1772752136.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QO.000 2026-03-05T23:08:56.135Z,1772752136.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RO.000 2026-03-05T23:08:56.135Z,1772752136.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RO.000 2026-03-05T23:08:56.135Z,1772752136.135 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RN.000 2026-03-05T23:08:56.135Z,1772752136.135 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RN.000 2026-03-05T23:08:56.136Z,1772752136.136 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QP.000 2026-03-05T23:08:56.136Z,1772752136.136 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QP.000 2026-03-05T23:08:56.136Z,1772752136.136 [CBIT](DEBUG): Deactivating emergency mode. 2026-03-05T23:08:56.156Z,1772752136.156 [WetLabsBB2FL](INFO): Powering up 2026-03-05T23:08:56.176Z,1772752136.176 [CBIT](DEBUG): Backplane powered. 2026-03-05T23:08:56.176Z,1772752136.176 [GFScanner](DEBUG): Initializing GFScanner 2026-03-05T23:08:56.176Z,1772752136.176 [GFScanner](DEBUG): Deactivating GF circuits. 2026-03-05T23:08:56.181Z,1772752136.181 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2026-03-05T23:08:56.182Z,1772752136.182 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2026-03-05T23:08:56.182Z,1772752136.182 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2026-03-05T23:08:56.183Z,1772752136.183 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2026-03-05T23:08:56.244Z,1772752136.244 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2026-03-05T23:08:56.248Z,1772752136.248 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-05T23:08:56.305Z,1772752136.305 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2026-03-05T23:08:56.306Z,1772752136.306 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2026-03-05T23:08:56.306Z,1772752136.306 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2026-03-05T23:08:56.307Z,1772752136.307 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2026-03-05T23:08:56.500Z,1772752136.500 [Radio_Surface](INFO): Powering up 2026-03-05T23:08:56.649Z,1772752136.649 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2026-03-05T23:08:56.655Z,1772752136.655 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2026-03-05T23:08:56.673Z,1772752136.673 [Default:A.Wait](DEBUG): Construct Wait. 2026-03-05T23:08:56.675Z,1772752136.675 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-05T23:08:56.725Z,1772752136.725 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-03-05T23:08:56.727Z,1772752136.727 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-03-05T23:08:56.749Z,1772752136.749 [Default:E.Execute](DEBUG): Construct Execute. 2026-03-05T23:08:56.752Z,1772752136.752 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2026-03-05T23:08:56.764Z,1772752136.764 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmPublisher,Reporter,LogSplitter, 2026-03-05T23:08:56.780Z,1772752136.780 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2026-03-05T23:08:56.844Z,1772752136.844 [Depth_Keller](INFO): Initializing. 2026-03-05T23:08:56.847Z,1772752136.847 [Power24vConverter](INFO): Powering up. 2026-03-05T23:08:56.847Z,1772752136.847 [Sonardyne_Nano](INFO): Initializing. 2026-03-05T23:08:56.896Z,1772752136.896 [DepthRateCalculator](ERROR): Depth measurement is not active 2026-03-05T23:08:56.931Z,1772752136.931 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2026-03-05T23:08:56.936Z,1772752136.936 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2026-03-05T23:08:56.937Z,1772752136.937 [ElevatorServo](DEBUG): Initializing EZServoServo. 2026-03-05T23:08:56.944Z,1772752136.944 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2026-03-05T23:08:56.945Z,1772752136.945 [MassServo](DEBUG): Initializing EZServoServo. 2026-03-05T23:08:56.952Z,1772752136.952 [MassServo](DEBUG): Initializing MassServo. 2026-03-05T23:08:56.953Z,1772752136.953 [RudderServo](DEBUG): Initializing EZServoServo. 2026-03-05T23:08:56.960Z,1772752136.960 [RudderServo](DEBUG): Initializing RudderServo. 2026-03-05T23:08:56.961Z,1772752136.961 [ThrusterHE](DEBUG): Initializing EZServoServo. 2026-03-05T23:08:56.968Z,1772752136.968 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2026-03-05T23:08:58.756Z,1772752138.756 [WetLabsBB2FL](INFO): Powering down 2026-03-05T23:08:58.795Z,1772752138.795 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2026-03-05T23:09:00.082Z,1772752140.082 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107 2026-03-05T23:09:02.654Z,1772752142.654 [ThrusterHE](ERROR): Zero Speed Commanded. 2026-03-05T23:09:07.905Z,1772752147.905 [DAT](INFO): DAT read: 2026-03-05T23:09:07.906Z,1772752147.906 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2026-03-05T23:09:09.669Z,1772752149.669 [DAT](INFO): DAT read: MF Frequency Band 5120 bandwidth 2026-03-05T23:09:09.671Z,1772752149.671 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.19.1 2026-03-05T23:09:09.671Z,1772752149.671 [DAT](INFO): DAT read: Mar 5 2026 23:09:05 2026-03-05T23:09:10.173Z,1772752150.173 [DAT](INFO): DAT read: Features enabled [Bearing] 2026-03-05T23:09:10.175Z,1772752150.175 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2026-03-05T23:09:10.175Z,1772752150.175 [DAT](INFO): commRate: 800 2026-03-05T23:09:12.240Z,1772752152.240 [DAT](INFO): entering command mode 2026-03-05T23:09:12.441Z,1772752152.441 [DAT](INFO): DAT read: 2026-03-05T23:09:12.442Z,1772752152.442 [DAT](INFO): DAT read: user:1> 2026-03-05T23:09:12.442Z,1772752152.442 [DAT](INFO): setting verbose to 3 2026-03-05T23:09:12.693Z,1772752152.693 [DAT](INFO): DAT read: user:1> 2026-03-05T23:09:12.694Z,1772752152.694 [DAT](INFO): DAT read: Verbose | 3 2026-03-05T23:09:12.694Z,1772752152.694 [DAT](INFO): set verbose to 3 2026-03-05T23:09:12.695Z,1772752152.695 [DAT](INFO): setting DatVerbose to 27440 2026-03-05T23:09:12.945Z,1772752152.945 [DAT](INFO): DAT read: user:2> 2026-03-05T23:09:12.946Z,1772752152.946 [DAT](INFO): DAT read: DatVerbose | 27440 2026-03-05T23:09:12.946Z,1772752152.946 [DAT](INFO): set DatVerbose to 27440 2026-03-05T23:09:12.946Z,1772752152.946 [DAT](INFO): setting transmit power to 8 2026-03-05T23:09:13.197Z,1772752153.197 [DAT](INFO): DAT read: user:3> 2026-03-05T23:09:13.198Z,1772752153.198 [DAT](INFO): DAT read: TxPower | 8 (Max) 2026-03-05T23:09:13.198Z,1772752153.198 [DAT](INFO): set transmit power to 8 2026-03-05T23:09:13.198Z,1772752153.198 [DAT](INFO): setting local address to 12 2026-03-05T23:09:13.449Z,1772752153.449 [DAT](INFO): DAT read: user:4> 2026-03-05T23:09:13.450Z,1772752153.450 [DAT](INFO): DAT read: LocalAddr | 12 2026-03-05T23:09:13.450Z,1772752153.450 [DAT](INFO): set local address to 12 2026-03-05T23:09:13.451Z,1772752153.451 [DAT](INFO): Setting time to: 23:9:13 And date to:3/5/2026 2026-03-05T23:09:13.701Z,1772752153.701 [DAT](INFO): DAT read: user:5> 2026-03-05T23:09:13.709Z,1772752153.709 [DAT](INFO): DAT read: Thu Mar 5, 2026 23:09:13 2026-03-05T23:09:13.709Z,1772752153.709 [DAT](INFO): Local DAT time set to Thu Mar 5, 2026 23:09:13 2026-03-05T23:09:24.250Z,1772752164.250 [NAL9602](INFO): Powering up NAL9602 2026-03-05T23:09:35.160Z,1772752175.160 [NAL9602](INFO): NAL9602 initialized 2026-03-05T23:09:45.680Z,1772752185.680 [SBIT](IMPORTANT): Beginning Startup BIT 2026-03-05T23:09:45.685Z,1772752185.685 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-03-05T23:09:50.177Z,1772752190.177 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.005289 CHAN A1 (24V): -0.007727 CHAN A2 (12V): -0.005213 CHAN A3 (5V): -0.002766 CHAN B0 (3.3V): -0.000855 CHAN B1 (3.15aV): -0.001526 CHAN B2 (3.15bV): -0.000793 CHAN B3 (GND): -0.000515 OPEN: 0.004514 Full Scale: +/- 1 mA 2026-03-05T23:10:39.832Z,1772752239.832 [SBIT](IMPORTANT): SBIT PASSED 2026-03-05T23:10:39.832Z,1772752239.832 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2026-03-05T23:10:39.833Z,1772752239.833 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count; 2026-03-05T23:10:39.833Z,1772752239.833 [SBIT](IMPORTANT): Express linearApproximation DAT.acoustic_contact_range 15.000000 meter; 2026-03-05T23:10:39.833Z,1772752239.833 [SBIT](IMPORTANT): Express linearApproximation acoustic_contact_range 15.000000 meter; 2026-03-05T23:10:39.833Z,1772752239.833 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool; 2026-03-05T23:10:39.833Z,1772752239.833 [SBIT](IMPORTANT): PowerOnly.simulateHardware=0 bool; 2026-03-05T23:10:39.833Z,1772752239.833 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=170.891507 cubic_centimeter; 2026-03-05T23:10:39.834Z,1772752239.834 [SBIT](IMPORTANT): VerticalControl.massDefault=7.460123 millimeter; 2026-03-05T23:10:39.834Z,1772752239.834 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=0 bool; 2026-03-05T23:10:40.240Z,1772752240.240 [MissionManager](IMPORTANT): Started mission Startup 2026-03-05T23:10:40.241Z,1772752240.241 [Startup] Running Loop=1 2026-03-05T23:10:40.241Z,1772752240.241 [Startup](DEBUG): Aggregate::initialize Startup 2026-03-05T23:10:40.241Z,1772752240.241 [Startup:A.GoToSurface] Running Loop=1 2026-03-05T23:10:40.241Z,1772752240.241 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:10:40.242Z,1772752240.242 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:10:40.242Z,1772752240.242 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:10:40.242Z,1772752240.242 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:10:40.243Z,1772752240.243 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:10:40.243Z,1772752240.243 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:10:40.243Z,1772752240.243 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:10:40.245Z,1772752240.245 [Startup:StartupSatComms] Running Loop=1 2026-03-05T23:10:40.245Z,1772752240.245 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2026-03-05T23:10:40.245Z,1772752240.245 [Startup:StartupSatComms:A] Running Loop=1 2026-03-05T23:10:40.635Z,1772752240.635 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2026-03-05T23:10:50.377Z,1772752250.377 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-05T23:11:24.022Z,1772752284.022 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004682 2026-03-05T23:11:40.422Z,1772752300.422 [Startup:StartupSatComms:A](INFO): Timed out from 2026-03-05T23:10:40.2Z 2026-03-05T23:11:40.422Z,1772752300.422 [Startup:StartupSatComms:A] Stopped 2026-03-05T23:11:40.422Z,1772752300.422 [Startup:StartupSatComms:B] Running Loop=1 2026-03-05T23:11:40.830Z,1772752300.830 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-03-05T23:11:44.556Z,1772752304.556 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-05T23:11:47.508Z,1772752307.508 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260305T225805/Courier0007.lzma 2026-03-05T23:11:48.510Z,1772752308.510 [DataOverHttps](INFO): Moved sent file to Logs/20260305T225805/Courier0007.lzma.bak 2026-03-05T23:11:48.510Z,1772752308.510 [DataOverHttps](INFO): SBD MOMSN=26699704 2026-03-05T23:11:56.200Z,1772752316.200 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2026-03-05T23:11:56.200Z,1772752316.200 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:11:56.210Z,1772752316.210 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:11:56.621Z,1772752316.621 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:11:56.621Z,1772752316.621 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2026-03-05T23:11:57.049Z,1772752317.049 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-05T23:12:05.696Z,1772752325.696 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20260305T230844/Courier0000.lzma 2026-03-05T23:12:06.345Z,1772752326.345 [CommandExec](IMPORTANT): got command strobe off 2026-03-05T23:12:06.346Z,1772752326.346 [CommandExec](IMPORTANT): Deactivating strobe 2026-03-05T23:12:06.698Z,1772752326.698 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Courier0000.lzma.bak 2026-03-05T23:12:06.698Z,1772752326.698 [DataOverHttps](INFO): SBD MOMSN=26699706 2026-03-05T23:12:22.379Z,1772752342.379 [DataOverHttps](INFO): Sending 113 bytes from file Logs/20260305T225805/Express0008.lzma 2026-03-05T23:12:23.382Z,1772752343.382 [DataOverHttps](INFO): Moved sent file to Logs/20260305T225805/Express0008.lzma.bak 2026-03-05T23:12:23.382Z,1772752343.382 [DataOverHttps](INFO): SBD MOMSN=26699709 2026-03-05T23:12:39.105Z,1772752359.105 [DataOverHttps](INFO): Sending 869 bytes from file Logs/20260305T230844/Express0001.lzma 2026-03-05T23:12:40.106Z,1772752360.106 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Express0001.lzma.bak 2026-03-05T23:12:40.106Z,1772752360.106 [DataOverHttps](INFO): SBD MOMSN=26699712 2026-03-05T23:12:40.630Z,1772752360.630 [Startup:StartupSatComms:B](INFO): Timed out from 2026-03-05T23:11:40.4Z 2026-03-05T23:12:40.630Z,1772752360.630 [Startup:StartupSatComms:B] Stopped 2026-03-05T23:12:40.630Z,1772752360.630 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2026-03-05T23:12:40.630Z,1772752360.630 [Startup:StartupSatComms] Stopped 2026-03-05T23:12:40.630Z,1772752360.630 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2026-03-05T23:12:40.631Z,1772752360.631 [Startup](INFO): Completed Startup 2026-03-05T23:12:40.631Z,1772752360.631 [MissionManager](INFO): Startup is completed. 2026-03-05T23:12:40.631Z,1772752360.631 [MissionManager](INFO): Uninitializing Mission Startup 2026-03-05T23:12:40.631Z,1772752360.631 [Startup] Stopped 2026-03-05T23:12:40.631Z,1772752360.631 [Startup](DEBUG): Aggregate::uninitialize Startup 2026-03-05T23:12:40.632Z,1772752360.632 [Startup:A.GoToSurface] Stopped 2026-03-05T23:12:40.632Z,1772752360.632 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:12:41.053Z,1772752361.053 [MissionManager](IMPORTANT): Started mission Default 2026-03-05T23:12:41.053Z,1772752361.053 [Default] Running Loop=1 2026-03-05T23:12:41.054Z,1772752361.054 [Default](DEBUG): Aggregate::initialize Default 2026-03-05T23:12:41.054Z,1772752361.054 [Default:B.GoToSurface] Running Loop=1 2026-03-05T23:12:41.054Z,1772752361.054 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:12:41.054Z,1772752361.054 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:12:41.054Z,1772752361.054 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:12:41.055Z,1772752361.055 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:12:41.055Z,1772752361.055 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:12:41.055Z,1772752361.055 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:12:41.055Z,1772752361.055 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:12:41.056Z,1772752361.056 [Default:A.Wait] Running Loop=1 2026-03-05T23:12:41.057Z,1772752361.057 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:12:51.186Z,1772752371.186 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-05T23:12:54.368Z,1772752374.368 [Default:A.Wait](INFO): Done Waiting. 2026-03-05T23:12:54.368Z,1772752374.368 [Default:A.Wait] Stopped 2026-03-05T23:12:54.368Z,1772752374.368 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:12:54.780Z,1772752374.780 [Default:CheckIn] Running Loop=1 2026-03-05T23:12:54.780Z,1772752374.780 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-05T23:12:54.780Z,1772752374.780 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:12:55.171Z,1772752375.171 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-05T23:12:58.795Z,1772752378.795 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:13:15.762Z,1772752395.762 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:13:24.077Z,1772752404.077 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:13:24.077Z,1772752404.077 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:13:24.078Z,1772752404.078 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:13:24.079Z,1772752404.079 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:13:24.377Z,1772752404.377 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into: 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2026-03-05T23:13:24.381Z,1772752404.381 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2026-03-05T23:13:24.382Z,1772752404.382 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2026-03-05T23:13:24.382Z,1772752404.382 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2026-03-05T23:13:24.383Z,1772752404.383 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2026-03-05T23:13:24.434Z,1772752404.434 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2026-03-05T23:13:24.438Z,1772752404.438 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2026-03-05T23:13:24.441Z,1772752404.441 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2026-03-05T23:13:24.445Z,1772752404.445 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2026-03-05T23:13:24.446Z,1772752404.446 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2026-03-05T23:13:24.447Z,1772752404.447 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2026-03-05T23:13:24.777Z,1772752404.777 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2026-03-05T23:13:24.786Z,1772752404.786 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool 2026-03-05T23:13:24.789Z,1772752404.789 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool 2026-03-05T23:13:24.791Z,1772752404.791 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool 2026-03-05T23:13:24.794Z,1772752404.794 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool 2026-03-05T23:13:24.798Z,1772752404.798 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool 2026-03-05T23:13:24.805Z,1772752404.805 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait. 2026-03-05T23:13:24.807Z,1772752404.807 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-05T23:13:24.820Z,1772752404.820 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-03-05T23:13:24.823Z,1772752404.823 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-03-05T23:13:24.829Z,1772752404.829 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute. 2026-03-05T23:13:24.869Z,1772752404.869 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission run_backseat_on_surface { arguments { ElapsedSinceMissionStarted = 0 minute } # Power the science payload. # insert id="Science" Insert/Science.tl # Power the Backseat payload. insert Insert/BackseatDriver.tl assign in sequence BackseatDriver:EnableBackseat = true insert Insert/PowerOnly.tl behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P2H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started ) syslog important "run_backseat_on_surface mission has been running for " + ElapsedSinceMissionStarted~minute } syslog important "Restarting logs and run_backseat_on_surface mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2026-03-05T23:13:24.871Z,1772752404.871 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:13:25.074Z,1772752405.074 [Default] Stopped 2026-03-05T23:13:25.074Z,1772752405.074 [Default](DEBUG): Aggregate::uninitialize Default 2026-03-05T23:13:25.074Z,1772752405.074 [Default:B.GoToSurface] Stopped 2026-03-05T23:13:25.074Z,1772752405.074 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:13:25.074Z,1772752405.074 [Default:CheckIn] Stopped 2026-03-05T23:13:25.074Z,1772752405.074 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-03-05T23:13:25.074Z,1772752405.074 [Default:CheckIn:Read_GPS] Stopped 2026-03-05T23:13:25.074Z,1772752405.074 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface] Running Loop=1 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:PowerOnly:A] Running Loop=1 2026-03-05T23:13:25.075Z,1772752405.075 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:PowerOnly:C] Running Loop=1 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:PowerOnly:D] Running Loop=1 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:D.GoToSurface] Running Loop=1 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:13:25.076Z,1772752405.076 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:13:25.077Z,1772752405.077 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:13:25.077Z,1772752405.077 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:13:25.077Z,1772752405.077 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:13:25.078Z,1772752405.078 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:13:25.078Z,1772752405.078 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:13:25.078Z,1772752405.078 [run_backseat_on_surface:B] Running Loop=1 2026-03-05T23:13:25.079Z,1772752405.079 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-05T23:13:25.079Z,1772752405.079 [run_backseat_on_surface:PowerOnly:D] Stopped 2026-03-05T23:13:25.079Z,1772752405.079 [run_backseat_on_surface:PowerOnly:C] Stopped 2026-03-05T23:13:25.079Z,1772752405.079 [run_backseat_on_surface:PowerOnly:B] Stopped 2026-03-05T23:13:25.079Z,1772752405.079 [run_backseat_on_surface:PowerOnly:A] Stopped 2026-03-05T23:13:25.080Z,1772752405.080 [run_backseat_on_surface:B] Stopped 2026-03-05T23:13:25.081Z,1772752405.081 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-05T23:13:25.081Z,1772752405.081 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2026-03-05T23:13:25.408Z,1772752405.408 [BackseatComponent](INFO): Powering up 2026-03-05T23:13:25.409Z,1772752405.409 [BackseatComponent](INFO): Subscribing to LCM channels. 2026-03-05T23:13:25.499Z,1772752405.499 [run_backseat_on_surface:CheckIn] Running Loop=1 2026-03-05T23:13:25.499Z,1772752405.499 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-05T23:13:25.499Z,1772752405.499 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:13:25.884Z,1772752405.884 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-05T23:13:32.001Z,1772752412.001 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-05T23:13:45.617Z,1772752425.617 [CommandExec](IMPORTANT): got command stop 2026-03-05T23:13:45.617Z,1772752425.617 [CommandExec](IMPORTANT): Scheduling is paused 2026-03-05T23:13:45.617Z,1772752425.617 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-03-05T23:13:45.748Z,1772752425.748 [MissionManager](INFO): MissionManager is completed. 2026-03-05T23:13:45.748Z,1772752425.748 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2026-03-05T23:13:45.748Z,1772752425.748 [run_backseat_on_surface] Stopped 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:BackseatDriver] Stopped 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:PowerOnly] Stopped 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:D.GoToSurface] Stopped 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:13:45.749Z,1772752425.749 [run_backseat_on_surface:CheckIn] Stopped 2026-03-05T23:13:45.750Z,1772752425.750 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-05T23:13:45.750Z,1772752425.750 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-05T23:13:46.074Z,1772752426.074 [MissionManager](IMPORTANT): Started mission Default 2026-03-05T23:13:46.074Z,1772752426.074 [Default] Running Loop=1 2026-03-05T23:13:46.074Z,1772752426.074 [Default](DEBUG): Aggregate::initialize Default 2026-03-05T23:13:46.074Z,1772752426.074 [Default:B.GoToSurface] Running Loop=1 2026-03-05T23:13:46.074Z,1772752426.074 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:13:46.074Z,1772752426.074 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:13:46.075Z,1772752426.075 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:13:46.075Z,1772752426.075 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:13:46.075Z,1772752426.075 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:13:46.076Z,1772752426.076 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:13:46.096Z,1772752426.096 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:13:46.096Z,1772752426.096 [Default:A.Wait] Running Loop=1 2026-03-05T23:13:46.096Z,1772752426.096 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:13:46.317Z,1772752426.317 [BackseatComponent](INFO): Sent LCM shutdown request. 2026-03-05T23:13:46.317Z,1772752426.317 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2026-03-05T23:13:48.890Z,1772752428.890 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:13:59.425Z,1772752439.425 [Default:A.Wait](INFO): Done Waiting. 2026-03-05T23:13:59.425Z,1772752439.425 [Default:A.Wait] Stopped 2026-03-05T23:13:59.426Z,1772752439.426 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:13:59.831Z,1772752439.831 [Default:CheckIn] Running Loop=1 2026-03-05T23:13:59.832Z,1772752439.832 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-05T23:13:59.832Z,1772752439.832 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:14:04.502Z,1772752444.502 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2026-03-05T23:14:04.503Z,1772752444.503 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2026-03-05T23:14:04.503Z,1772752444.503 [LcmPublisher](INFO): Deactivating messaging. 2026-03-05T23:14:05.096Z,1772752445.096 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-05T23:14:22.426Z,1772752462.426 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:14:38.594Z,1772752478.594 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-03-05T23:14:39.397Z,1772752479.397 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:14:43.433Z,1772752483.433 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2026-03-05T23:14:55.958Z,1772752495.958 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:14:57.186Z,1772752497.186 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2026-03-05T23:14:57.186Z,1772752497.186 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:14:57.227Z,1772752497.227 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:14:57.598Z,1772752497.598 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:14:57.598Z,1772752497.598 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2026-03-05T23:15:00.401Z,1772752500.401 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2026-03-05T23:15:13.331Z,1772752513.331 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2026-03-05T23:15:16.157Z,1772752516.157 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2026-03-05T23:15:19.801Z,1772752519.801 [BPC1](INFO): Calculating totals. Valid battery stick count: 46. Valid reserve battery stick count: 5. 2026-03-05T23:15:19.805Z,1772752519.805 [BPC1](INFO): Received data from all battery sticks. 2026-03-05T23:17:58.197Z,1772752678.197 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2026-03-05T23:17:58.197Z,1772752678.197 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:17:58.208Z,1772752678.208 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:17:58.598Z,1772752678.598 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:17:58.598Z,1772752678.598 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2026-03-05T23:18:59.991Z,1772752739.991 [Default:CheckIn:Read_GPS](INFO): Timed out from 2026-03-05T23:13:59.8Z 2026-03-05T23:18:59.991Z,1772752739.991 [Default:CheckIn:Read_GPS] Stopped 2026-03-05T23:18:59.991Z,1772752739.991 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-03-05T23:19:00.406Z,1772752740.406 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-03-05T23:19:07.696Z,1772752747.696 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20260305T230844/Courier0004.lzma 2026-03-05T23:19:08.698Z,1772752748.698 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Courier0004.lzma.bak 2026-03-05T23:19:08.698Z,1772752748.698 [DataOverHttps](INFO): SBD MOMSN=26699742 2026-03-05T23:19:24.200Z,1772752764.200 [DataOverHttps](INFO): Sending 355 bytes from file Logs/20260305T230844/Express0005.lzma 2026-03-05T23:19:25.202Z,1772752765.202 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Express0005.lzma.bak 2026-03-05T23:19:25.202Z,1772752765.202 [DataOverHttps](INFO): SBD MOMSN=26699744 2026-03-05T23:19:26.279Z,1772752766.279 [Default:CheckIn:Read_Iridium] Stopped 2026-03-05T23:19:26.279Z,1772752766.279 [Default:CheckIn:C.Wait] Running Loop=1 2026-03-05T23:19:26.279Z,1772752766.279 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:19:37.554Z,1772752777.554 [NAL9602](FAULT): GPS failed to acquire within timeout. 2026-03-05T23:19:37.555Z,1772752777.555 [NAL9602] Data Fault, FailCount= 1 2026-03-05T23:19:37.555Z,1772752777.555 [NAL9602](ERROR): Data Fault 2026-03-05T23:19:37.572Z,1772752777.572 [CBIT](ERROR): Data Fault in component: NAL9602 2026-03-05T23:19:37.953Z,1772752777.953 [NAL9602](INFO): Powering down 2026-03-05T23:19:38.782Z,1772752778.782 [CBIT](INFO): Clearing failed state for component NAL9602 2026-03-05T23:19:38.782Z,1772752778.782 [NAL9602] No Fault, FailCount= 1 2026-03-05T23:20:08.257Z,1772752808.257 [NAL9602](INFO): Powering up NAL9602 2026-03-05T23:20:19.164Z,1772752819.164 [NAL9602](INFO): NAL9602 initialized 2026-03-05T23:20:59.170Z,1772752859.170 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2026-03-05T23:20:59.170Z,1772752859.170 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:20:59.180Z,1772752859.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:20:59.644Z,1772752859.644 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:20:59.644Z,1772752859.644 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2026-03-05T23:24:00.220Z,1772753040.220 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2026-03-05T23:24:00.220Z,1772753040.220 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:24:00.263Z,1772753040.263 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:24:00.638Z,1772753040.638 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:24:00.638Z,1772753040.638 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2026-03-05T23:24:26.865Z,1772753066.865 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-03-05T23:24:26.866Z,1772753066.866 [Default:CheckIn:C.Wait] Stopped 2026-03-05T23:24:26.866Z,1772753066.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:24:26.866Z,1772753066.866 [Default:CheckIn:D] Running Loop=1 2026-03-05T23:24:27.286Z,1772753067.286 [Default:CheckIn:D] Stopped 2026-03-05T23:24:27.286Z,1772753067.286 [Default:CheckIn:E] Running Loop=1 2026-03-05T23:24:27.694Z,1772753067.694 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.686870 min 2026-03-05T23:24:27.694Z,1772753067.694 [Default:CheckIn:E] Stopped 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn] Stopped 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn](INFO): Running loop #2 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn] Running Loop=2 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-05T23:24:27.695Z,1772753067.695 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:27:01.217Z,1772753221.217 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2026-03-05T23:27:01.217Z,1772753221.217 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:27:01.227Z,1772753221.227 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:27:01.606Z,1772753221.606 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:27:01.606Z,1772753221.606 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2026-03-05T23:29:27.870Z,1772753367.870 [Default:CheckIn:Read_GPS](INFO): Timed out from 2026-03-05T23:24:27.7Z 2026-03-05T23:29:27.870Z,1772753367.870 [Default:CheckIn:Read_GPS] Stopped 2026-03-05T23:29:27.871Z,1772753367.871 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-03-05T23:29:34.987Z,1772753374.987 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260305T230844/Courier0007.lzma 2026-03-05T23:29:35.990Z,1772753375.990 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Courier0007.lzma.bak 2026-03-05T23:29:35.990Z,1772753375.990 [DataOverHttps](INFO): SBD MOMSN=26699762 2026-03-05T23:29:51.649Z,1772753391.649 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20260305T230844/Express0008.lzma 2026-03-05T23:29:52.650Z,1772753392.650 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Express0008.lzma.bak 2026-03-05T23:29:52.650Z,1772753392.650 [DataOverHttps](INFO): SBD MOMSN=26699764 2026-03-05T23:29:53.702Z,1772753393.702 [Default:CheckIn:Read_Iridium] Stopped 2026-03-05T23:29:53.702Z,1772753393.702 [Default:CheckIn:C.Wait] Running Loop=1 2026-03-05T23:29:53.702Z,1772753393.702 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:30:02.227Z,1772753402.227 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2026-03-05T23:30:02.227Z,1772753402.227 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:30:02.238Z,1772753402.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:30:02.598Z,1772753402.598 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:30:02.598Z,1772753402.598 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2026-03-05T23:30:14.156Z,1772753414.156 [CommandExec](IMPORTANT): got command load ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:30:14.157Z,1772753414.157 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:30:14.157Z,1772753414.157 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:30:14.158Z,1772753414.158 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:30:14.459Z,1772753414.459 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into: 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2026-03-05T23:30:14.462Z,1772753414.462 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2026-03-05T23:30:14.463Z,1772753414.463 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2026-03-05T23:30:14.463Z,1772753414.463 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2026-03-05T23:30:14.464Z,1772753414.464 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2026-03-05T23:30:14.482Z,1772753414.482 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2026-03-05T23:30:14.485Z,1772753414.485 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2026-03-05T23:30:14.487Z,1772753414.487 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2026-03-05T23:30:14.535Z,1772753414.535 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2026-03-05T23:30:14.535Z,1772753414.535 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2026-03-05T23:30:14.549Z,1772753414.549 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2026-03-05T23:30:14.649Z,1772753414.649 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2026-03-05T23:30:14.653Z,1772753414.653 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool 2026-03-05T23:30:14.655Z,1772753414.655 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool 2026-03-05T23:30:14.683Z,1772753414.683 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool 2026-03-05T23:30:14.733Z,1772753414.733 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool 2026-03-05T23:30:14.735Z,1772753414.735 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool 2026-03-05T23:30:14.766Z,1772753414.766 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait. 2026-03-05T23:30:14.767Z,1772753414.767 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-05T23:30:14.794Z,1772753414.794 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-03-05T23:30:14.800Z,1772753414.800 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-03-05T23:30:14.809Z,1772753414.809 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute. 2026-03-05T23:30:14.813Z,1772753414.813 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission run_backseat_on_surface { arguments { ElapsedSinceMissionStarted = 0 minute } # Power the science payload. # insert id="Science" Insert/Science.tl # Power the Backseat payload. insert Insert/BackseatDriver.tl assign in sequence BackseatDriver:EnableBackseat = true insert Insert/PowerOnly.tl behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P2H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started ) syslog important "run_backseat_on_surface mission has been running for " + ElapsedSinceMissionStarted~minute } syslog important "Restarting logs and run_backseat_on_surface mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2026-03-05T23:30:14.814Z,1772753414.814 [CommandExec](IMPORTANT): Loaded ./Missions/Maintenance/run_backseat_on_surface.tl id=run_backseat_on_surface 2026-03-05T23:30:22.379Z,1772753422.379 [NAL9602](FAULT): GPS failed to acquire within timeout. 2026-03-05T23:30:22.379Z,1772753422.379 [NAL9602] Data Fault, FailCount= 2 2026-03-05T23:30:22.380Z,1772753422.380 [NAL9602](ERROR): Data Fault 2026-03-05T23:30:22.397Z,1772753422.397 [CBIT](ERROR): Data Fault in component: NAL9602 2026-03-05T23:30:22.781Z,1772753422.781 [NAL9602](INFO): Powering down 2026-03-05T23:30:23.606Z,1772753423.606 [CBIT](INFO): Clearing failed state for component NAL9602 2026-03-05T23:30:23.606Z,1772753423.606 [NAL9602] No Fault, FailCount= 2 2026-03-05T23:30:53.081Z,1772753453.081 [NAL9602](INFO): Powering up NAL9602 2026-03-05T23:30:55.991Z,1772753455.991 [CommandExec](IMPORTANT): got command set run_backseat_on_surface:PowerOnly.SampleLoad1 1 bool 2026-03-05T23:30:55.993Z,1772753455.993 [CommandExec](IMPORTANT): got command run 2026-03-05T23:30:55.994Z,1772753455.994 [CommandExec](IMPORTANT): Running 2026-03-05T23:30:56.326Z,1772753456.326 [Default] Stopped 2026-03-05T23:30:56.326Z,1772753456.326 [Default](DEBUG): Aggregate::uninitialize Default 2026-03-05T23:30:56.326Z,1772753456.326 [Default:B.GoToSurface] Stopped 2026-03-05T23:30:56.326Z,1772753456.326 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:30:56.326Z,1772753456.326 [Default:CheckIn] Stopped 2026-03-05T23:30:56.326Z,1772753456.326 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-03-05T23:30:56.327Z,1772753456.327 [Default:CheckIn:C.Wait] Stopped 2026-03-05T23:30:56.327Z,1772753456.327 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:30:56.327Z,1772753456.327 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2026-03-05T23:30:56.327Z,1772753456.327 [run_backseat_on_surface] Running Loop=1 2026-03-05T23:30:56.327Z,1772753456.327 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2026-03-05T23:30:56.327Z,1772753456.327 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-05T23:30:56.327Z,1772753456.327 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2026-03-05T23:30:56.327Z,1772753456.327 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2026-03-05T23:30:56.327Z,1772753456.327 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly:A] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly:C] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly:D] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:D.GoToSurface] Running Loop=1 2026-03-05T23:30:56.328Z,1772753456.328 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:30:56.329Z,1772753456.329 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:30:56.329Z,1772753456.329 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:30:56.329Z,1772753456.329 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:30:56.330Z,1772753456.330 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:30:56.330Z,1772753456.330 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:30:56.330Z,1772753456.330 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:30:56.330Z,1772753456.330 [run_backseat_on_surface:B] Running Loop=1 2026-03-05T23:30:56.331Z,1772753456.331 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-05T23:30:56.332Z,1772753456.332 [run_backseat_on_surface:PowerOnly:D] Stopped 2026-03-05T23:30:56.332Z,1772753456.332 [run_backseat_on_surface:PowerOnly:C] Stopped 2026-03-05T23:30:56.332Z,1772753456.332 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-05T23:30:56.332Z,1772753456.332 [run_backseat_on_surface:PowerOnly:B](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1 2026-03-05T23:30:56.333Z,1772753456.333 [run_backseat_on_surface:PowerOnly:A] Stopped 2026-03-05T23:30:56.333Z,1772753456.333 [run_backseat_on_surface:B] Stopped 2026-03-05T23:30:56.333Z,1772753456.333 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-05T23:30:56.333Z,1772753456.333 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2026-03-05T23:30:56.668Z,1772753456.668 [BackseatComponent](INFO): Powering up 2026-03-05T23:30:56.669Z,1772753456.669 [BackseatComponent](INFO): Subscribing to LCM channels. 2026-03-05T23:30:56.739Z,1772753456.739 [run_backseat_on_surface:CheckIn] Running Loop=1 2026-03-05T23:30:56.739Z,1772753456.739 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-05T23:30:56.739Z,1772753456.739 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:30:57.126Z,1772753457.126 [PowerOnly](INFO): Powering up loadControl 2026-03-05T23:30:57.165Z,1772753457.165 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-05T23:31:03.994Z,1772753463.994 [NAL9602](INFO): NAL9602 initialized 2026-03-05T23:31:48.765Z,1772753508.765 [BackseatComponent](IMPORTANT): conch: running backseat application. 2026-03-05T23:31:51.472Z,1772753511.472 [BackseatComponent](INFO): Created universal data reader for depth with code: 6 2026-03-05T23:31:51.472Z,1772753511.472 [BackseatComponent](INFO): Requesting data from depth (6). Requested size is: 1 2026-03-05T23:31:51.475Z,1772753511.475 [BackseatComponent](INFO): Created universal data reader for latitude with code: 23 2026-03-05T23:31:51.475Z,1772753511.475 [BackseatComponent](INFO): Requesting data from latitude (23). Requested size is: 2 2026-03-05T23:31:51.478Z,1772753511.478 [BackseatComponent](INFO): Created universal data reader for longitude with code: 26 2026-03-05T23:31:51.478Z,1772753511.478 [BackseatComponent](INFO): Requesting data from longitude (26). Requested size is: 3 2026-03-05T23:31:51.481Z,1772753511.481 [BackseatComponent](INFO): Created universal data reader for platform_orientation with code: 52 2026-03-05T23:31:51.481Z,1772753511.481 [BackseatComponent](INFO): Requesting data from platform_orientation (52). Requested size is: 4 2026-03-05T23:31:51.487Z,1772753511.487 [BackseatComponent](INFO): Created universal data reader for platform_pitch_angle with code: 54 2026-03-05T23:31:51.487Z,1772753511.487 [BackseatComponent](INFO): Requesting data from platform_pitch_angle (54). Requested size is: 5 2026-03-05T23:31:51.490Z,1772753511.490 [BackseatComponent](INFO): Created universal data reader for platform_roll_angle with code: 59 2026-03-05T23:31:51.491Z,1772753511.491 [BackseatComponent](INFO): Requesting data from platform_roll_angle (59). Requested size is: 6 2026-03-05T23:31:51.494Z,1772753511.494 [BackseatComponent](INFO): Created universal data reader for platform_x_velocity_wrt_ground with code: 69 2026-03-05T23:31:51.494Z,1772753511.494 [BackseatComponent](INFO): Requesting data from platform_x_velocity_wrt_ground (69). Requested size is: 7 2026-03-05T23:31:51.496Z,1772753511.496 [BackseatComponent](INFO): Created universal data reader for platform_y_velocity_wrt_ground with code: 73 2026-03-05T23:31:51.497Z,1772753511.497 [BackseatComponent](INFO): Requesting data from platform_y_velocity_wrt_ground (73). Requested size is: 8 2026-03-05T23:31:51.498Z,1772753511.498 [BackseatComponent](INFO): Created universal data reader for platform_z_velocity_wrt_ground with code: 79 2026-03-05T23:31:51.499Z,1772753511.499 [BackseatComponent](INFO): Requesting data from platform_z_velocity_wrt_ground (79). Requested size is: 9 2026-03-05T23:31:51.500Z,1772753511.500 [BackseatComponent](INFO): Created universal data reader for sea_water_pressure with code: 90 2026-03-05T23:31:51.501Z,1772753511.501 [BackseatComponent](INFO): Requesting data from sea_water_pressure (90). Requested size is: 10 2026-03-05T23:33:03.186Z,1772753583.186 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2026-03-05T23:33:03.186Z,1772753583.186 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:33:03.200Z,1772753583.200 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:33:03.612Z,1772753583.612 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:33:03.613Z,1772753583.613 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2026-03-05T23:35:56.898Z,1772753756.898 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2026-03-05T23:30:56.7Z 2026-03-05T23:35:56.899Z,1772753756.899 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-05T23:35:56.899Z,1772753756.899 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1 2026-03-05T23:35:57.311Z,1772753757.311 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-03-05T23:36:04.184Z,1772753764.184 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2026-03-05T23:36:04.184Z,1772753764.184 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:36:04.191Z,1772753764.191 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260305T230844/Courier0010.lzma 2026-03-05T23:36:04.203Z,1772753764.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:36:04.612Z,1772753764.612 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:36:04.612Z,1772753764.612 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2026-03-05T23:36:05.194Z,1772753765.194 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Courier0010.lzma.bak 2026-03-05T23:36:05.194Z,1772753765.194 [DataOverHttps](INFO): SBD MOMSN=26699774 2026-03-05T23:36:21.085Z,1772753781.085 [DataOverHttps](INFO): Sending 322 bytes from file Logs/20260305T230844/Express0011.lzma 2026-03-05T23:36:22.087Z,1772753782.087 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Express0011.lzma.bak 2026-03-05T23:36:22.087Z,1772753782.087 [DataOverHttps](INFO): SBD MOMSN=26699776 2026-03-05T23:36:23.162Z,1772753783.162 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2026-03-05T23:36:23.162Z,1772753783.162 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1 2026-03-05T23:36:23.162Z,1772753783.162 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:39:05.170Z,1772753945.170 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2026-03-05T23:39:05.170Z,1772753945.170 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:39:05.184Z,1772753945.184 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:39:05.608Z,1772753945.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:39:05.609Z,1772753945.609 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2026-03-05T23:41:05.150Z,1772754065.150 [NAL9602](FAULT): GPS failed to acquire within timeout. 2026-03-05T23:41:05.150Z,1772754065.150 [NAL9602] Data Fault, FailCount= 3 2026-03-05T23:41:05.150Z,1772754065.150 [NAL9602](ERROR): Data Fault 2026-03-05T23:41:05.176Z,1772754065.176 [CBIT](ERROR): Data Fault in component: NAL9602 2026-03-05T23:41:05.557Z,1772754065.557 [NAL9602](INFO): Powering down 2026-03-05T23:41:06.397Z,1772754066.397 [CBIT](INFO): Clearing failed state for component NAL9602 2026-03-05T23:41:06.397Z,1772754066.397 [NAL9602] No Fault, FailCount= 3 2026-03-05T23:41:23.741Z,1772754083.741 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting. 2026-03-05T23:41:23.741Z,1772754083.741 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2026-03-05T23:41:23.742Z,1772754083.742 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:41:23.742Z,1772754083.742 [run_backseat_on_surface:CheckIn:D] Running Loop=1 2026-03-05T23:41:24.149Z,1772754084.149 [run_backseat_on_surface:CheckIn:D] Stopped 2026-03-05T23:41:24.149Z,1772754084.149 [run_backseat_on_surface:CheckIn:E] Running Loop=1 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 10.463704 min 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn:E] Stopped 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn] Stopped 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn](INFO): Running loop #2 2026-03-05T23:41:24.558Z,1772754084.558 [run_backseat_on_surface:CheckIn] Running Loop=2 2026-03-05T23:41:24.559Z,1772754084.559 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-05T23:41:24.559Z,1772754084.559 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:41:35.854Z,1772754095.854 [NAL9602](INFO): Powering up NAL9602 2026-03-05T23:41:46.757Z,1772754106.757 [NAL9602](INFO): NAL9602 initialized 2026-03-05T23:42:06.161Z,1772754126.161 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2026-03-05T23:42:06.161Z,1772754126.161 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:42:06.172Z,1772754126.172 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:42:06.608Z,1772754126.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:42:06.608Z,1772754126.608 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2026-03-05T23:44:17.475Z,1772754257.475 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1979 2026-03-05T23:44:28.797Z,1772754268.797 [CommandExec](IMPORTANT): got command stop 2026-03-05T23:44:28.797Z,1772754268.797 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-03-05T23:44:29.188Z,1772754269.188 [MissionManager](INFO): MissionManager is completed. 2026-03-05T23:44:29.188Z,1772754269.188 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2026-03-05T23:44:29.188Z,1772754269.188 [run_backseat_on_surface] Stopped 2026-03-05T23:44:29.188Z,1772754269.188 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2026-03-05T23:44:29.188Z,1772754269.188 [run_backseat_on_surface:BackseatDriver] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:PowerOnly] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:PowerOnly:B] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:D.GoToSurface] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:CheckIn] Stopped 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-05T23:44:29.189Z,1772754269.189 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-05T23:44:29.573Z,1772754269.573 [BioacousticsDataBridge](INFO): No valid data from altitude reader, stopping 2026-03-05T23:44:29.590Z,1772754269.590 [MissionManager](IMPORTANT): Started mission Default 2026-03-05T23:44:29.591Z,1772754269.591 [Default] Running Loop=1 2026-03-05T23:44:29.591Z,1772754269.591 [Default](DEBUG): Aggregate::initialize Default 2026-03-05T23:44:29.591Z,1772754269.591 [Default:B.GoToSurface] Running Loop=1 2026-03-05T23:44:29.591Z,1772754269.591 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:44:29.591Z,1772754269.591 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:44:29.591Z,1772754269.591 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:44:29.592Z,1772754269.592 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:44:29.592Z,1772754269.592 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:44:29.593Z,1772754269.593 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:44:29.593Z,1772754269.593 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:44:29.593Z,1772754269.593 [Default:A.Wait] Running Loop=1 2026-03-05T23:44:29.593Z,1772754269.593 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:44:30.121Z,1772754270.121 [BackseatComponent](INFO): Sent LCM shutdown request. 2026-03-05T23:44:30.122Z,1772754270.122 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2026-03-05T23:44:42.954Z,1772754282.954 [Default:A.Wait](INFO): Done Waiting. 2026-03-05T23:44:42.954Z,1772754282.954 [Default:A.Wait] Stopped 2026-03-05T23:44:42.955Z,1772754282.954 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:44:43.342Z,1772754283.342 [Default:CheckIn] Running Loop=1 2026-03-05T23:44:43.342Z,1772754283.342 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-05T23:44:43.342Z,1772754283.342 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:44:48.300Z,1772754288.300 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2026-03-05T23:44:48.301Z,1772754288.301 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2026-03-05T23:44:48.301Z,1772754288.301 [LcmPublisher](INFO): Deactivating messaging. 2026-03-05T23:45:07.155Z,1772754307.155 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2026-03-05T23:45:07.155Z,1772754307.155 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:45:07.165Z,1772754307.165 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:45:07.594Z,1772754307.594 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:45:07.594Z,1772754307.594 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2026-03-05T23:45:59.688Z,1772754359.688 [PowerOnly](INFO): Powering down loadControl 2026-03-05T23:46:51.051Z,1772754411.051 [CommandExec](IMPORTANT): got command load ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:46:51.051Z,1772754411.051 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:46:51.051Z,1772754411.051 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:46:51.058Z,1772754411.058 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:46:51.302Z,1772754411.302 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into: 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2026-03-05T23:46:51.306Z,1772754411.306 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2026-03-05T23:46:51.306Z,1772754411.306 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2026-03-05T23:46:51.307Z,1772754411.307 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2026-03-05T23:46:51.308Z,1772754411.308 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2026-03-05T23:46:51.327Z,1772754411.327 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2026-03-05T23:46:51.330Z,1772754411.330 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2026-03-05T23:46:51.332Z,1772754411.332 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2026-03-05T23:46:51.336Z,1772754411.336 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2026-03-05T23:46:51.336Z,1772754411.336 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2026-03-05T23:46:51.337Z,1772754411.337 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2026-03-05T23:46:51.549Z,1772754411.549 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2026-03-05T23:46:51.553Z,1772754411.553 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool 2026-03-05T23:46:51.555Z,1772754411.555 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool 2026-03-05T23:46:51.557Z,1772754411.557 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool 2026-03-05T23:46:51.559Z,1772754411.559 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool 2026-03-05T23:46:51.610Z,1772754411.610 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool 2026-03-05T23:46:51.631Z,1772754411.631 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait. 2026-03-05T23:46:51.634Z,1772754411.634 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-05T23:46:51.645Z,1772754411.645 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-03-05T23:46:51.647Z,1772754411.647 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-03-05T23:46:51.652Z,1772754411.652 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute. 2026-03-05T23:46:51.657Z,1772754411.657 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission run_backseat_on_surface { arguments { ElapsedSinceMissionStarted = 0 minute } # Power the science payload. # insert id="Science" Insert/Science.tl # Power the Backseat payload. insert Insert/BackseatDriver.tl assign in sequence BackseatDriver:EnableBackseat = true insert Insert/PowerOnly.tl behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P2H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started ) syslog important "run_backseat_on_surface mission has been running for " + ElapsedSinceMissionStarted~minute } syslog important "Restarting logs and run_backseat_on_surface mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2026-03-05T23:46:51.657Z,1772754411.657 [CommandExec](IMPORTANT): Loaded ./Missions/Maintenance/run_backseat_on_surface.tl id=run_backseat_on_surface 2026-03-05T23:47:14.064Z,1772754434.064 [CommandExec](IMPORTANT): got command set run_backseat_on_surface:PowerOnly.SampleLoad1 1 bool 2026-03-05T23:47:14.066Z,1772754434.066 [CommandExec](IMPORTANT): got command run 2026-03-05T23:47:14.067Z,1772754434.067 [CommandExec](IMPORTANT): Running 2026-03-05T23:47:14.442Z,1772754434.442 [Default] Stopped 2026-03-05T23:47:14.442Z,1772754434.442 [Default](DEBUG): Aggregate::uninitialize Default 2026-03-05T23:47:14.442Z,1772754434.442 [Default:B.GoToSurface] Stopped 2026-03-05T23:47:14.442Z,1772754434.442 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:47:14.442Z,1772754434.442 [Default:CheckIn] Stopped 2026-03-05T23:47:14.442Z,1772754434.442 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-03-05T23:47:14.442Z,1772754434.442 [Default:CheckIn:Read_GPS] Stopped 2026-03-05T23:47:14.443Z,1772754434.443 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface] Running Loop=1 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly 2026-03-05T23:47:14.443Z,1772754434.443 [run_backseat_on_surface:PowerOnly:A] Running Loop=1 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:PowerOnly:C] Running Loop=1 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:PowerOnly:D] Running Loop=1 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:D.GoToSurface] Running Loop=1 2026-03-05T23:47:14.444Z,1772754434.444 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:47:14.445Z,1772754434.445 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:47:14.445Z,1772754434.445 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:47:14.445Z,1772754434.445 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:47:14.445Z,1772754434.445 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:47:14.446Z,1772754434.446 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:47:14.446Z,1772754434.446 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:47:14.446Z,1772754434.446 [run_backseat_on_surface:B] Running Loop=1 2026-03-05T23:47:14.447Z,1772754434.447 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-05T23:47:14.447Z,1772754434.447 [run_backseat_on_surface:PowerOnly:D] Stopped 2026-03-05T23:47:14.447Z,1772754434.447 [run_backseat_on_surface:PowerOnly:C] Stopped 2026-03-05T23:47:14.447Z,1772754434.447 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-05T23:47:14.448Z,1772754434.448 [run_backseat_on_surface:PowerOnly:B](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1 2026-03-05T23:47:14.448Z,1772754434.448 [run_backseat_on_surface:PowerOnly:A] Stopped 2026-03-05T23:47:14.449Z,1772754434.449 [run_backseat_on_surface:B] Stopped 2026-03-05T23:47:14.449Z,1772754434.449 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-05T23:47:14.449Z,1772754434.449 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2026-03-05T23:47:14.728Z,1772754434.728 [BackseatComponent](INFO): Powering up 2026-03-05T23:47:14.729Z,1772754434.729 [BackseatComponent](INFO): Subscribing to LCM channels. 2026-03-05T23:47:14.834Z,1772754434.834 [run_backseat_on_surface:CheckIn] Running Loop=1 2026-03-05T23:47:14.834Z,1772754434.834 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-05T23:47:14.834Z,1772754434.834 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:47:15.222Z,1772754435.222 [PowerOnly](INFO): Powering up loadControl 2026-03-05T23:47:15.262Z,1772754435.262 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-05T23:47:43.533Z,1772754463.533 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1979 2026-03-05T23:47:43.896Z,1772754463.896 [BioacousticsDataBridge](INFO): Received valid altitude data, resuming 2026-03-05T23:48:07.530Z,1772754487.530 [BackseatComponent](IMPORTANT): conch: running backseat application. 2026-03-05T23:48:08.205Z,1772754488.205 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2026-03-05T23:48:08.205Z,1772754488.205 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:48:08.221Z,1772754488.221 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:48:08.590Z,1772754488.590 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:48:08.590Z,1772754488.590 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2026-03-05T23:51:09.151Z,1772754669.151 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2026-03-05T23:51:09.151Z,1772754669.151 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:51:09.165Z,1772754669.165 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:51:09.578Z,1772754669.578 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:51:09.578Z,1772754669.578 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2026-03-05T23:51:49.558Z,1772754709.558 [NAL9602](FAULT): GPS failed to acquire within timeout. 2026-03-05T23:51:49.558Z,1772754709.558 [NAL9602] Data Fault, FailCount= 4 2026-03-05T23:51:49.558Z,1772754709.558 [NAL9602](ERROR): Data Fault 2026-03-05T23:51:49.658Z,1772754709.658 [CBIT](ERROR): Data Fault in component: NAL9602 2026-03-05T23:51:49.937Z,1772754709.937 [NAL9602](INFO): Powering down 2026-03-05T23:51:50.805Z,1772754710.805 [CBIT](INFO): Clearing failed state for component NAL9602 2026-03-05T23:51:50.805Z,1772754710.805 [NAL9602] No Fault, FailCount= 4 2026-03-05T23:52:14.999Z,1772754734.999 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2026-03-05T23:47:14.8Z 2026-03-05T23:52:14.999Z,1772754734.999 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-05T23:52:14.000Z,1772754735.000 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1 2026-03-05T23:52:15.415Z,1772754735.415 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-03-05T23:52:20.250Z,1772754740.250 [NAL9602](INFO): Powering up NAL9602 2026-03-05T23:52:22.395Z,1772754742.395 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260305T230844/Courier0013.lzma 2026-03-05T23:52:23.398Z,1772754743.398 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Courier0013.lzma.bak 2026-03-05T23:52:23.398Z,1772754743.398 [DataOverHttps](INFO): SBD MOMSN=26699792 2026-03-05T23:52:31.150Z,1772754751.150 [NAL9602](INFO): NAL9602 initialized 2026-03-05T23:52:39.368Z,1772754759.368 [DataOverHttps](INFO): Sending 395 bytes from file Logs/20260305T230844/Express0014.lzma 2026-03-05T23:52:40.370Z,1772754760.370 [DataOverHttps](INFO): Moved sent file to Logs/20260305T230844/Express0014.lzma.bak 2026-03-05T23:52:40.370Z,1772754760.370 [DataOverHttps](INFO): SBD MOMSN=26699794 2026-03-05T23:52:41.686Z,1772754761.686 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2026-03-05T23:52:41.686Z,1772754761.686 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1 2026-03-05T23:52:41.686Z,1772754761.686 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:54:10.157Z,1772754850.157 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2026-03-05T23:54:10.157Z,1772754850.157 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:54:10.171Z,1772754850.171 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:54:10.584Z,1772754850.584 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:54:10.584Z,1772754850.584 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2026-03-05T23:57:11.133Z,1772755031.133 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2026-03-05T23:57:11.133Z,1772755031.133 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-05T23:57:11.173Z,1772755031.173 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-05T23:57:11.544Z,1772755031.544 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-05T23:57:11.544Z,1772755031.544 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2026-03-05T23:57:42.275Z,1772755062.275 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting. 2026-03-05T23:57:42.275Z,1772755062.275 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2026-03-05T23:57:42.276Z,1772755062.276 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:57:42.276Z,1772755062.276 [run_backseat_on_surface:CheckIn:D] Running Loop=1 2026-03-05T23:57:42.685Z,1772755062.685 [run_backseat_on_surface:CheckIn:D] Stopped 2026-03-05T23:57:42.685Z,1772755062.685 [run_backseat_on_surface:CheckIn:E] Running Loop=1 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 10.470703 min 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn:E] Stopped 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn] Stopped 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn](INFO): Running loop #2 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn] Running Loop=2 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-05T23:57:43.074Z,1772755063.074 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:58:22.701Z,1772755102.701 [CommandExec](IMPORTANT): got command stop 2026-03-05T23:58:22.701Z,1772755102.701 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-03-05T23:58:23.068Z,1772755103.068 [MissionManager](INFO): MissionManager is completed. 2026-03-05T23:58:23.068Z,1772755103.068 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2026-03-05T23:58:23.068Z,1772755103.068 [run_backseat_on_surface] Stopped 2026-03-05T23:58:23.068Z,1772755103.068 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2026-03-05T23:58:23.068Z,1772755103.068 [run_backseat_on_surface:BackseatDriver] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:PowerOnly] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:PowerOnly:B] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:D.GoToSurface] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:CheckIn] Stopped 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-05T23:58:23.069Z,1772755103.069 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-05T23:58:23.433Z,1772755103.433 [BioacousticsDataBridge](INFO): No valid data from altitude reader, stopping 2026-03-05T23:58:23.472Z,1772755103.472 [MissionManager](IMPORTANT): Started mission Default 2026-03-05T23:58:23.472Z,1772755103.472 [Default] Running Loop=1 2026-03-05T23:58:23.472Z,1772755103.472 [Default](DEBUG): Aggregate::initialize Default 2026-03-05T23:58:23.472Z,1772755103.472 [Default:B.GoToSurface] Running Loop=1 2026-03-05T23:58:23.472Z,1772755103.472 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-05T23:58:23.473Z,1772755103.473 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-05T23:58:23.473Z,1772755103.473 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-05T23:58:23.473Z,1772755103.473 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-05T23:58:23.473Z,1772755103.473 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-05T23:58:23.474Z,1772755103.474 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-05T23:58:23.474Z,1772755103.474 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-05T23:58:23.474Z,1772755103.474 [Default:A.Wait] Running Loop=1 2026-03-05T23:58:23.475Z,1772755103.475 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-05T23:58:24.053Z,1772755104.053 [BackseatComponent](INFO): Sent LCM shutdown request. 2026-03-05T23:58:24.054Z,1772755104.054 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2026-03-05T23:58:36.789Z,1772755116.789 [Default:A.Wait](INFO): Done Waiting. 2026-03-05T23:58:36.789Z,1772755116.789 [Default:A.Wait] Stopped 2026-03-05T23:58:36.789Z,1772755116.789 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-05T23:58:37.202Z,1772755117.202 [Default:CheckIn] Running Loop=1 2026-03-05T23:58:37.202Z,1772755117.202 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-05T23:58:37.202Z,1772755117.202 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-05T23:58:38.671Z,1772755118.671 [CommandExec](IMPORTANT): got command load ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:58:38.672Z,1772755118.672 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:58:38.672Z,1772755118.672 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:58:38.673Z,1772755118.673 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-05T23:58:39.217Z,1772755119.217 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into: 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2026-03-05T23:58:39.254Z,1772755119.254 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2026-03-05T23:58:39.255Z,1772755119.255 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2026-03-05T23:58:39.255Z,1772755119.255 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2026-03-05T23:58:39.260Z,1772755119.260 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2026-03-05T23:58:39.311Z,1772755119.311 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2026-03-05T23:58:39.318Z,1772755119.318 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2026-03-05T23:58:39.341Z,1772755119.341 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2026-03-05T23:58:39.348Z,1772755119.348 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2026-03-05T23:58:39.349Z,1772755119.349 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2026-03-05T23:58:39.350Z,1772755119.350 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2026-03-05T23:58:39.561Z,1772755119.561 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2026-03-05T23:58:39.569Z,1772755119.569 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool 2026-03-05T23:58:39.571Z,1772755119.571 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool 2026-03-05T23:58:39.577Z,1772755119.577 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool 2026-03-05T23:58:39.579Z,1772755119.579 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool 2026-03-05T23:58:39.677Z,1772755119.677 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool 2026-03-05T23:58:39.708Z,1772755119.708 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait. 2026-03-05T23:58:39.738Z,1772755119.738 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-05T23:58:39.773Z,1772755119.773 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-03-05T23:58:39.775Z,1772755119.775 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-03-05T23:58:39.788Z,1772755119.788 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute. 2026-03-05T23:58:39.797Z,1772755119.797 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission run_backseat_on_surface { arguments { ElapsedSinceMissionStarted = 0 minute } # Power the science payload. # insert id="Science" Insert/Science.tl # Power the Backseat payload. insert Insert/BackseatDriver.tl assign in sequence BackseatDriver:EnableBackseat = true insert Insert/PowerOnly.tl behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P2H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started ) syslog important "run_backseat_on_surface mission has been running for " + ElapsedSinceMissionStarted~minute } syslog important "Restarting logs and run_backseat_on_surface mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2026-03-05T23:58:39.797Z,1772755119.797 [CommandExec](IMPORTANT): Loaded ./Missions/Maintenance/run_backseat_on_surface.tl id=run_backseat_on_surface 2026-03-05T23:58:42.208Z,1772755122.208 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2026-03-05T23:58:42.209Z,1772755122.209 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2026-03-05T23:58:42.209Z,1772755122.209 [LcmPublisher](INFO): Deactivating messaging. 2026-03-05T23:58:56.643Z,1772755136.643 [CommandExec](IMPORTANT): got command set run_backseat_on_surface:PowerOnly.SampleLoad1 1 bool 2026-03-05T23:59:53.567Z,1772755193.567 [PowerOnly](INFO): Powering down loadControl 2026-03-06T00:00:12.169Z,1772755212.169 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2026-03-06T00:00:12.170Z,1772755212.170 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-06T00:00:12.208Z,1772755212.208 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-06T00:00:12.590Z,1772755212.590 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-06T00:00:12.590Z,1772755212.590 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2026-03-06T00:00:23.429Z,1772755223.429 [CommandExec](IMPORTANT): got command run 2026-03-06T00:00:23.430Z,1772755223.430 [CommandExec](IMPORTANT): Running 2026-03-06T00:00:23.505Z,1772755223.505 [Default] Stopped 2026-03-06T00:00:23.505Z,1772755223.505 [Default](DEBUG): Aggregate::uninitialize Default 2026-03-06T00:00:23.505Z,1772755223.505 [Default:B.GoToSurface] Stopped 2026-03-06T00:00:23.505Z,1772755223.505 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-06T00:00:23.505Z,1772755223.505 [Default:CheckIn] Stopped 2026-03-06T00:00:23.505Z,1772755223.505 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-03-06T00:00:23.506Z,1772755223.506 [Default:CheckIn:Read_GPS] Stopped 2026-03-06T00:00:23.506Z,1772755223.506 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2026-03-06T00:00:23.506Z,1772755223.506 [run_backseat_on_surface] Running Loop=1 2026-03-06T00:00:23.506Z,1772755223.506 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2026-03-06T00:00:23.506Z,1772755223.506 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-06T00:00:23.506Z,1772755223.506 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2026-03-06T00:00:23.506Z,1772755223.506 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2026-03-06T00:00:23.506Z,1772755223.506 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly:A] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly:C] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly:D] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:D.GoToSurface] Running Loop=1 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-06T00:00:23.507Z,1772755223.507 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-06T00:00:23.508Z,1772755223.508 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-06T00:00:23.508Z,1772755223.508 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-06T00:00:23.509Z,1772755223.509 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-06T00:00:23.509Z,1772755223.509 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-06T00:00:23.509Z,1772755223.509 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-06T00:00:23.509Z,1772755223.509 [run_backseat_on_surface:B] Running Loop=1 2026-03-06T00:00:23.510Z,1772755223.510 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-06T00:00:23.511Z,1772755223.511 [run_backseat_on_surface:PowerOnly:D] Stopped 2026-03-06T00:00:23.511Z,1772755223.511 [run_backseat_on_surface:PowerOnly:C] Stopped 2026-03-06T00:00:23.511Z,1772755223.511 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-06T00:00:23.511Z,1772755223.511 [run_backseat_on_surface:PowerOnly:B](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1 2026-03-06T00:00:23.511Z,1772755223.511 [run_backseat_on_surface:PowerOnly:A] Stopped 2026-03-06T00:00:23.511Z,1772755223.511 [run_backseat_on_surface:B] Stopped 2026-03-06T00:00:23.512Z,1772755223.512 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-06T00:00:23.512Z,1772755223.512 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2026-03-06T00:00:23.760Z,1772755223.760 [BackseatComponent](INFO): Powering up 2026-03-06T00:00:23.760Z,1772755223.760 [BackseatComponent](INFO): Subscribing to LCM channels. 2026-03-06T00:00:23.890Z,1772755223.890 [run_backseat_on_surface:CheckIn] Running Loop=1 2026-03-06T00:00:23.891Z,1772755223.891 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-06T00:00:23.891Z,1772755223.891 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-06T00:00:24.279Z,1772755224.279 [PowerOnly](INFO): Powering up loadControl 2026-03-06T00:00:24.310Z,1772755224.310 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-06T00:00:52.590Z,1772755252.590 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1979 2026-03-06T00:00:52.944Z,1772755252.944 [BioacousticsDataBridge](INFO): Received valid altitude data, resuming 2026-03-06T00:01:15.615Z,1772755275.615 [BackseatComponent](IMPORTANT): conch: running backseat application. 2026-03-06T00:02:07.713Z,1772755327.713 [CommandExec](IMPORTANT): got command stop 2026-03-06T00:02:07.713Z,1772755327.713 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-03-06T00:02:07.728Z,1772755327.728 [MissionManager](INFO): MissionManager is completed. 2026-03-06T00:02:07.728Z,1772755327.728 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2026-03-06T00:02:07.728Z,1772755327.728 [run_backseat_on_surface] Stopped 2026-03-06T00:02:07.728Z,1772755327.728 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2026-03-06T00:02:07.728Z,1772755327.728 [run_backseat_on_surface:BackseatDriver] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:PowerOnly] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:PowerOnly:B] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:D.GoToSurface] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:CheckIn] Stopped 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-06T00:02:07.729Z,1772755327.729 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-06T00:02:07.841Z,1772755327.841 [BackseatComponent](INFO): Sent LCM shutdown request. 2026-03-06T00:02:07.842Z,1772755327.842 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2026-03-06T00:02:08.090Z,1772755328.090 [BioacousticsDataBridge](DEBUG): Backseat LCM timeout, waiting for message to resume 2026-03-06T00:02:08.136Z,1772755328.136 [MissionManager](IMPORTANT): Started mission Default 2026-03-06T00:02:08.136Z,1772755328.136 [Default] Running Loop=1 2026-03-06T00:02:08.136Z,1772755328.136 [Default](DEBUG): Aggregate::initialize Default 2026-03-06T00:02:08.136Z,1772755328.136 [Default:B.GoToSurface] Running Loop=1 2026-03-06T00:02:08.136Z,1772755328.136 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-06T00:02:08.137Z,1772755328.137 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-06T00:02:08.137Z,1772755328.137 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-06T00:02:08.137Z,1772755328.137 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-06T00:02:08.137Z,1772755328.137 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-06T00:02:08.138Z,1772755328.138 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-06T00:02:08.138Z,1772755328.138 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-06T00:02:08.138Z,1772755328.138 [Default:A.Wait] Running Loop=1 2026-03-06T00:02:08.139Z,1772755328.139 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-06T00:02:21.435Z,1772755341.435 [Default:A.Wait](INFO): Done Waiting. 2026-03-06T00:02:21.435Z,1772755341.435 [Default:A.Wait] Stopped 2026-03-06T00:02:21.436Z,1772755341.436 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-06T00:02:21.843Z,1772755341.843 [Default:CheckIn] Running Loop=1 2026-03-06T00:02:21.843Z,1772755341.843 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-06T00:02:21.843Z,1772755341.843 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-06T00:02:25.869Z,1772755345.869 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2026-03-06T00:02:25.870Z,1772755345.870 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2026-03-06T00:02:25.870Z,1772755345.870 [LcmPublisher](INFO): Deactivating messaging. 2026-03-06T00:02:34.354Z,1772755354.354 [NAL9602](FAULT): GPS failed to acquire within timeout. 2026-03-06T00:02:34.354Z,1772755354.354 [NAL9602] Data Fault, FailCount= 5 2026-03-06T00:02:34.354Z,1772755354.354 [NAL9602](ERROR): Data Fault 2026-03-06T00:02:34.419Z,1772755354.419 [CBIT](ERROR): Data Fault in component: NAL9602 2026-03-06T00:02:34.419Z,1772755354.419 [CBIT](CRITICAL): Data Fault in component: NAL9602 2026-03-06T00:02:34.757Z,1772755354.757 [NAL9602](INFO): Powering down 2026-03-06T00:02:34.800Z,1772755354.800 [CommandExec](FAULT): Scheduling is paused 2026-03-06T00:02:34.801Z,1772755354.801 [CBIT](INFO): Critical error at 20260306T000234 2026-03-06T00:03:13.148Z,1772755393.148 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2026-03-06T00:03:13.148Z,1772755393.148 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-06T00:03:13.158Z,1772755393.158 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-06T00:03:13.575Z,1772755393.575 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-06T00:03:13.575Z,1772755393.575 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2026-03-06T00:03:38.181Z,1772755418.181 [PowerOnly](INFO): Powering down loadControl 2026-03-06T00:03:54.948Z,1772755434.948 [CommandExec](IMPORTANT): got command load ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-06T00:03:54.949Z,1772755434.949 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-06T00:03:54.949Z,1772755434.949 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-06T00:03:54.950Z,1772755434.950 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl 2026-03-06T00:03:55.664Z,1772755435.664 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into: 0 Burn on Dropped weight due to communications timeout. 5 run_backseat_on_surface mission has been running for Restarting logs and run_backseat_on_surface mission. restart logs 2026-03-06T00:03:55.675Z,1772755435.675 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min 2026-03-06T00:03:55.676Z,1772755435.676 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2026-03-06T00:03:55.680Z,1772755435.680 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2026-03-06T00:03:55.681Z,1772755435.681 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2026-03-06T00:03:55.749Z,1772755435.749 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2026-03-06T00:03:55.757Z,1772755435.757 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool 2026-03-06T00:03:55.759Z,1772755435.759 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2026-03-06T00:03:55.767Z,1772755435.767 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2026-03-06T00:03:55.767Z,1772755435.767 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2026-03-06T00:03:55.788Z,1772755435.788 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2026-03-06T00:03:56.155Z,1772755436.155 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2026-03-06T00:03:56.170Z,1772755436.170 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool 2026-03-06T00:03:56.171Z,1772755436.171 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool 2026-03-06T00:03:56.173Z,1772755436.173 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool 2026-03-06T00:03:56.175Z,1772755436.175 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool 2026-03-06T00:03:56.177Z,1772755436.177 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool 2026-03-06T00:03:56.196Z,1772755436.196 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait. 2026-03-06T00:03:56.198Z,1772755436.198 [run_backseat_on_surface:D.GoToSurface](DEBUG): Construct GoToSurface. 2026-03-06T00:03:56.307Z,1772755436.307 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2026-03-06T00:03:56.309Z,1772755436.309 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait. 2026-03-06T00:03:56.339Z,1772755436.339 [run_backseat_on_surface:G.Execute](DEBUG): Construct Execute. 2026-03-06T00:03:56.343Z,1772755436.343 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission run_backseat_on_surface { arguments { ElapsedSinceMissionStarted = 0 minute } # Power the science payload. # insert id="Science" Insert/Science.tl # Power the Backseat payload. insert Insert/BackseatDriver.tl assign in sequence BackseatDriver:EnableBackseat = true insert Insert/PowerOnly.tl behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P2H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started ) syslog important "run_backseat_on_surface mission has been running for " + ElapsedSinceMissionStarted~minute } syslog important "Restarting logs and run_backseat_on_surface mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2026-03-06T00:03:56.360Z,1772755436.360 [CommandExec](IMPORTANT): Loaded ./Missions/Maintenance/run_backseat_on_surface.tl id=run_backseat_on_surface 2026-03-06T00:04:14.459Z,1772755454.459 [CommandExec](IMPORTANT): got command set run_backseat_on_surface:PowerOnly.SampleLoad1 1 bool 2026-03-06T00:04:16.337Z,1772755456.337 [CommandExec](IMPORTANT): got command run 2026-03-06T00:04:16.338Z,1772755456.338 [CommandExec](IMPORTANT): Running 2026-03-06T00:04:16.590Z,1772755456.590 [Default] Stopped 2026-03-06T00:04:16.590Z,1772755456.590 [Default](DEBUG): Aggregate::uninitialize Default 2026-03-06T00:04:16.590Z,1772755456.590 [Default:B.GoToSurface] Stopped 2026-03-06T00:04:16.590Z,1772755456.590 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-06T00:04:16.590Z,1772755456.590 [Default:CheckIn] Stopped 2026-03-06T00:04:16.590Z,1772755456.590 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-03-06T00:04:16.590Z,1772755456.590 [Default:CheckIn:Read_GPS] Stopped 2026-03-06T00:04:16.590Z,1772755456.590 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface] Running Loop=1 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:PowerOnly:A] Running Loop=1 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-06T00:04:16.591Z,1772755456.591 [run_backseat_on_surface:PowerOnly:C] Running Loop=1 2026-03-06T00:04:16.592Z,1772755456.592 [run_backseat_on_surface:PowerOnly:D] Running Loop=1 2026-03-06T00:04:16.592Z,1772755456.592 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1 2026-03-06T00:04:16.592Z,1772755456.592 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2026-03-06T00:04:16.592Z,1772755456.592 [run_backseat_on_surface:D.GoToSurface] Running Loop=1 2026-03-06T00:04:16.592Z,1772755456.592 [run_backseat_on_surface:D.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-06T00:04:16.592Z,1772755456.592 [run_backseat_on_surface:D.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-06T00:04:16.593Z,1772755456.593 [run_backseat_on_surface:D.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-06T00:04:16.593Z,1772755456.593 [run_backseat_on_surface:D.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-06T00:04:16.593Z,1772755456.593 [run_backseat_on_surface:D.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-06T00:04:16.594Z,1772755456.594 [run_backseat_on_surface:D.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-06T00:04:16.594Z,1772755456.594 [run_backseat_on_surface:D.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-06T00:04:16.594Z,1772755456.594 [run_backseat_on_surface:B] Running Loop=1 2026-03-06T00:04:16.595Z,1772755456.595 [run_backseat_on_surface:PowerOnly] Running Loop=1 2026-03-06T00:04:16.595Z,1772755456.595 [run_backseat_on_surface:PowerOnly:D] Stopped 2026-03-06T00:04:16.595Z,1772755456.595 [run_backseat_on_surface:PowerOnly:C] Stopped 2026-03-06T00:04:16.595Z,1772755456.595 [run_backseat_on_surface:PowerOnly:B] Running Loop=1 2026-03-06T00:04:16.612Z,1772755456.612 [run_backseat_on_surface:PowerOnly:B](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1 2026-03-06T00:04:16.612Z,1772755456.612 [run_backseat_on_surface:PowerOnly:A] Stopped 2026-03-06T00:04:16.612Z,1772755456.612 [run_backseat_on_surface:B] Stopped 2026-03-06T00:04:16.613Z,1772755456.613 [run_backseat_on_surface:BackseatDriver] Running Loop=1 2026-03-06T00:04:16.613Z,1772755456.613 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2026-03-06T00:04:16.984Z,1772755456.984 [BackseatComponent](INFO): Powering up 2026-03-06T00:04:16.985Z,1772755456.985 [BackseatComponent](INFO): Subscribing to LCM channels. 2026-03-06T00:04:16.993Z,1772755456.993 [run_backseat_on_surface:CheckIn] Running Loop=1 2026-03-06T00:04:16.994Z,1772755456.994 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn 2026-03-06T00:04:16.994Z,1772755456.994 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1 2026-03-06T00:04:17.389Z,1772755457.389 [PowerOnly](INFO): Powering up loadControl 2026-03-06T00:04:17.416Z,1772755457.416 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-06T00:04:34.411Z,1772755474.411 [CBIT](INFO): Clearing failed state for component NAL9602 2026-03-06T00:04:34.411Z,1772755474.411 [NAL9602] No Fault, FailCount= 5 2026-03-06T00:04:34.757Z,1772755474.757 [NAL9602](INFO): Powering up NAL9602 2026-03-06T00:04:35.964Z,1772755475.964 [BioacousticsDataBridge](INFO): No valid data from altitude reader, stopping 2026-03-06T00:04:45.670Z,1772755485.670 [NAL9602](INFO): NAL9602 initialized 2026-03-06T00:05:09.061Z,1772755509.061 [BackseatComponent](IMPORTANT): conch: running backseat application. 2026-03-06T00:05:34.581Z,1772755534.581 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1979 2026-03-06T00:05:34.949Z,1772755534.949 [BioacousticsDataBridge](INFO): Received valid altitude data, resuming 2026-03-06T00:06:14.187Z,1772755574.187 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2026-03-06T00:06:14.187Z,1772755574.187 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2026-03-06T00:06:14.202Z,1772755574.202 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2026-03-06T00:06:14.569Z,1772755574.569 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2026-03-06T00:06:14.569Z,1772755574.569 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2026-03-06T00:06:42.469Z,1772755602.469 [CommandExec](IMPORTANT): got command restart application 2026-03-06T00:06:43.472Z,1772755603.472 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2026-03-06T00:06:43.472Z,1772755603.472 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:43.473Z,1772755603.473 [CommandExec](INFO): Uninitializing the command executive. 2026-03-06T00:06:43.473Z,1772755603.473 [CommandExec](INFO): Uninitializing the command scheduler. 2026-03-06T00:06:43.473Z,1772755603.473 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:43.548Z,1772755603.548 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2026-03-06T00:06:43.548Z,1772755603.548 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2026-03-06T00:06:43.548Z,1772755603.548 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:43.549Z,1772755603.549 [NavChartDb](INFO): Join timeout helper Thread ID is 1216 2026-03-06T00:06:43.677Z,1772755603.677 [MissionManager](INFO): MissionManager is completed. 2026-03-06T00:06:43.678Z,1772755603.678 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:BackseatDriver] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:PowerOnly] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:PowerOnly:B] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:D.GoToSurface] Stopped 2026-03-06T00:06:43.678Z,1772755603.678 [run_backseat_on_surface:D.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-06T00:06:43.679Z,1772755603.679 [run_backseat_on_surface:CheckIn] Stopped 2026-03-06T00:06:43.679Z,1772755603.679 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2026-03-06T00:06:43.679Z,1772755603.679 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped 2026-03-06T00:06:43.924Z,1772755603.924 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:43.925Z,1772755603.925 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:43.944Z,1772755603.944 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2026-03-06T00:06:43.944Z,1772755603.944 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:43.944Z,1772755603.944 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1217 2026-03-06T00:06:44.033Z,1772755604.033 [BioacousticsDataBridge](INFO): No valid data from altitude reader, stopping 2026-03-06T00:06:44.040Z,1772755604.040 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:44.041Z,1772755604.041 [WetLabsBB2FL](INFO): Powering down 2026-03-06T00:06:44.041Z,1772755604.041 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:44.056Z,1772755604.056 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2026-03-06T00:06:44.056Z,1772755604.056 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:44.056Z,1772755604.056 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1218 2026-03-06T00:06:44.065Z,1772755604.065 [MissionManager](IMPORTANT): Started mission Default 2026-03-06T00:06:44.065Z,1772755604.065 [Default] Running Loop=1 2026-03-06T00:06:44.065Z,1772755604.065 [Default](DEBUG): Aggregate::initialize Default 2026-03-06T00:06:44.066Z,1772755604.066 [Default:B.GoToSurface] Running Loop=1 2026-03-06T00:06:44.066Z,1772755604.066 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-06T00:06:44.066Z,1772755604.066 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-06T00:06:44.066Z,1772755604.066 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-06T00:06:44.066Z,1772755604.066 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-06T00:06:44.067Z,1772755604.067 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-06T00:06:44.067Z,1772755604.067 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-06T00:06:44.067Z,1772755604.067 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-06T00:06:44.068Z,1772755604.068 [Default:A.Wait] Running Loop=1 2026-03-06T00:06:44.068Z,1772755604.068 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-06T00:06:44.597Z,1772755604.597 [CTD_Seabird](INFO): Powering down 2026-03-06T00:06:44.618Z,1772755604.618 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:44.618Z,1772755604.618 [CTD_Seabird](INFO): Powering down 2026-03-06T00:06:44.632Z,1772755604.632 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:44.638Z,1772755604.638 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2026-03-06T00:06:44.638Z,1772755604.638 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:44.639Z,1772755604.639 [Radio_Surface](INFO): Join timeout helper Thread ID is 1219 2026-03-06T00:06:44.964Z,1772755604.964 [Radio_Surface](INFO): Powering down 2026-03-06T00:06:44.965Z,1772755604.965 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:44.965Z,1772755604.965 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:44.975Z,1772755604.975 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2026-03-06T00:06:44.976Z,1772755604.976 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:44.976Z,1772755604.976 [Onboard](INFO): Join timeout helper Thread ID is 1220 2026-03-06T00:06:45.256Z,1772755605.256 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-03-06T00:06:45.877Z,1772755605.877 [BackseatComponent](INFO): Sent LCM shutdown request. 2026-03-06T00:06:45.877Z,1772755605.877 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2026-03-06T00:06:49.076Z,1772755609.076 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.076Z,1772755609.076 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.089Z,1772755609.089 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2026-03-06T00:06:49.089Z,1772755609.089 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.089Z,1772755609.089 [DataOverHttps](INFO): Join timeout helper Thread ID is 1221 2026-03-06T00:06:49.272Z,1772755609.272 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.272Z,1772755609.272 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.293Z,1772755609.293 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2026-03-06T00:06:49.293Z,1772755609.293 [DAT ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.294Z,1772755609.294 [DAT](INFO): Join timeout helper Thread ID is 1222 2026-03-06T00:06:49.384Z,1772755609.384 [DAT](INFO): Powering down 2026-03-06T00:06:49.457Z,1772755609.457 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.457Z,1772755609.457 [DAT](INFO): Powering down 2026-03-06T00:06:49.458Z,1772755609.458 [DAT ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.473Z,1772755609.473 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2026-03-06T00:06:49.473Z,1772755609.473 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.473Z,1772755609.473 [BackseatComponent](INFO): Join timeout helper Thread ID is 1223 2026-03-06T00:06:49.560Z,1772755609.560 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.560Z,1772755609.560 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.577Z,1772755609.577 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2026-03-06T00:06:49.577Z,1772755609.577 [logger ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.577Z,1772755609.577 [logger](INFO): Join timeout helper Thread ID is 1224 2026-03-06T00:06:49.584Z,1772755609.584 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.584Z,1772755609.584 [logger ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.597Z,1772755609.597 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2026-03-06T00:06:49.597Z,1772755609.597 [CommandLine ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.597Z,1772755609.597 [CommandLine](INFO): Join timeout helper Thread ID is 1225 2026-03-06T00:06:49.692Z,1772755609.692 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.693Z,1772755609.693 [CommandLine ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.697Z,1772755609.697 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2026-03-06T00:06:49.697Z,1772755609.697 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.697Z,1772755609.697 [CommandExec](INFO): Join timeout helper Thread ID is 1226 2026-03-06T00:06:49.698Z,1772755609.698 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2026-03-06T00:06:49.698Z,1772755609.698 [controlThread ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:49.699Z,1772755609.699 [controlThread](INFO): Join timeout helper Thread ID is 1227 2026-03-06T00:06:49.736Z,1772755609.736 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2026-03-06T00:06:49.737Z,1772755609.737 [controlThread](DEBUG): Uninitializing ControlThread 2026-03-06T00:06:49.737Z,1772755609.737 [AHRS_M2](INFO): Powering down 2026-03-06T00:06:49.816Z,1772755609.816 [NAL9602](INFO): Powering down 2026-03-06T00:06:49.818Z,1772755609.818 [Sonardyne_Nano](INFO): Powering down 2026-03-06T00:06:50.020Z,1772755610.020 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2026-03-06T00:06:50.021Z,1772755610.021 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2026-03-06T00:06:50.022Z,1772755610.022 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2026-03-06T00:06:50.022Z,1772755610.022 [MissionManager](INFO): Uninitializing Mission Default 2026-03-06T00:06:50.022Z,1772755610.022 [Default] Stopped 2026-03-06T00:06:50.022Z,1772755610.022 [Default](DEBUG): Aggregate::uninitialize Default 2026-03-06T00:06:50.022Z,1772755610.022 [Default:A.Wait] Stopped 2026-03-06T00:06:50.023Z,1772755610.023 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-06T00:06:50.023Z,1772755610.023 [Default:B.GoToSurface] Stopped 2026-03-06T00:06:50.023Z,1772755610.023 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-06T00:06:50.026Z,1772755610.026 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2026-03-06T00:06:50.026Z,1772755610.026 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2026-03-06T00:06:50.026Z,1772755610.026 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2026-03-06T00:06:50.027Z,1772755610.027 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2026-03-06T00:06:50.027Z,1772755610.027 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2026-03-06T00:06:50.027Z,1772755610.027 [BuoyancyServo](INFO): Powering down 2026-03-06T00:06:50.040Z,1772755610.040 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2026-03-06T00:06:50.040Z,1772755610.040 [ElevatorServo](INFO): Powering down 2026-03-06T00:06:50.041Z,1772755610.041 [MassServo](DEBUG): Uninitialize Mass Servo. 2026-03-06T00:06:50.041Z,1772755610.041 [MassServo](INFO): Powering down 2026-03-06T00:06:50.042Z,1772755610.042 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2026-03-06T00:06:50.042Z,1772755610.042 [RudderServo](INFO): Powering down 2026-03-06T00:06:50.043Z,1772755610.043 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2026-03-06T00:06:50.043Z,1772755610.043 [ThrusterHE](INFO): Powering down 2026-03-06T00:06:50.044Z,1772755610.044 [SBIT](DEBUG): Uninitialize SBIT Component. 2026-03-06T00:06:50.044Z,1772755610.044 [IBIT](DEBUG): Uninitialize IBIT Component. 2026-03-06T00:06:50.045Z,1772755610.045 [CBIT](DEBUG): Uninitialize CBIT Component. 2026-03-06T00:06:50.045Z,1772755610.045 [CBIT](DEBUG): Powering off loads. 2026-03-06T00:06:50.056Z,1772755610.056 [CBIT](DEBUG): Disabling WDT. 2026-03-06T00:06:50.068Z,1772755610.068 [GFScanner](DEBUG): Uninitialize GFScanner component. 2026-03-06T00:06:50.068Z,1772755610.068 [GFScanner](DEBUG): Opening all GF detection circuits. 2026-03-06T00:06:50.069Z,1772755610.069 [controlThread ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.129Z,1772755610.129 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.133Z,1772755610.133 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.139Z,1772755610.139 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.145Z,1772755610.145 [DAT ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.189Z,1772755610.189 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.232Z,1772755610.232 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.237Z,1772755610.237 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.256Z,1772755610.256 [GFScanner](DEBUG): Uninitialize GFScanner component. 2026-03-06T00:06:50.256Z,1772755610.256 [GFScanner](DEBUG): Opening all GF detection circuits. 2026-03-06T00:06:50.271Z,1772755610.271 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-03-06T00:06:50.321Z,1772755610.321 [logger ThreadHandler](INFO): Thread cancelled.