2025-12-08T01:15:00.356Z,1765156500.356 [CommandExec](IMPORTANT): got command restart logs 2025-12-08T01:15:11.515Z,1765156511.515 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl 2025-12-08T01:15:11.515Z,1765156511.515 [MissionManager](INFO): Uninitializing Mission sci2_vtyoyo 2025-12-08T01:15:11.515Z,1765156511.515 [sci2_vtyoyo] Stopped 2025-12-08T01:15:11.515Z,1765156511.515 [sci2_vtyoyo](DEBUG): Aggregate::uninitialize sci2_vtyoyo 2025-12-08T01:15:11.515Z,1765156511.515 [sci2_vtyoyo:Science] Stopped 2025-12-08T01:15:11.515Z,1765156511.515 [sci2_vtyoyo:Science](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Science 2025-12-08T01:15:11.515Z,1765156511.515 [sci2_vtyoyo:Science:B] Stopped 2025-12-08T01:15:11.520Z,1765156511.520 [sci2_vtyoyo:Science:C] Stopped 2025-12-08T01:15:11.520Z,1765156511.520 [sci2_vtyoyo:Science:E] Stopped 2025-12-08T01:15:11.521Z,1765156511.521 [sci2_vtyoyo:Science:OceanCurrent] Stopped 2025-12-08T01:15:11.521Z,1765156511.521 [sci2_vtyoyo:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Science:OceanCurrent 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:Science:OceanCurrent:A.] Stopped 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes] Stopped 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2_vtyoyo:StandardEnvelopes 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-12-08T01:15:11.522Z,1765156511.522 [sci2_vtyoyo:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:BackseatDriver] Stopped 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:BackseatDriver](DEBUG): Aggregate::uninitialize sci2_vtyoyo:BackseatDriver 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:BackseatDriver:A.BackseatDriver] Stopped 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:PowerOnly] Stopped 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:PowerOnly](DEBUG): Aggregate::uninitialize sci2_vtyoyo:PowerOnly 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:PowerOnly:E.Wait] Stopped 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-12-08T01:15:11.523Z,1765156511.523 [sci2_vtyoyo:manageDiveMode] Stopped 2025-12-08T01:15:11.528Z,1765156511.528 [sci2_vtyoyo:manageDiveMode](DEBUG): Aggregate::uninitialize sci2_vtyoyo:manageDiveMode 2025-12-08T01:15:11.528Z,1765156511.528 [sci2_vtyoyo:Lap] Stopped 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive] Stopped 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap:Dive 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive:A] Stopped 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive:A](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap:Dive:A 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive:A:SurfaceSink] Stopped 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive:A:SurfaceSink](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap:Dive:A:SurfaceSink 2025-12-08T01:15:11.529Z,1765156511.529 [sci2_vtyoyo:Lap:Dive:A:YoYoDive] Stopped 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap:Dive:A:YoYoDive 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive] Stopped 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:A.Pitch] Stopped 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:B.Buoyancy] Stopped 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:C.SetSpeed] Stopped 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:C.SetSpeed](DEBUG): Uninitialize. 2025-12-08T01:15:11.530Z,1765156511.530 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:D.DepthEnvelope] Stopped 2025-12-08T01:15:11.531Z,1765156511.531 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:D.DepthEnvelope](DEBUG): Uninitialize. 2025-12-08T01:15:11.531Z,1765156511.531 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:E.AltitudeEnvelope] Stopped 2025-12-08T01:15:11.531Z,1765156511.531 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:E.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-12-08T01:15:11.531Z,1765156511.531 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:F.YoYoPARLicor] Stopped 2025-12-08T01:15:11.531Z,1765156511.531 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:F.YoYoPARLicor](DEBUG): Uninitialize Value-Terminated YoYo. 2025-12-08T01:15:11.533Z,1765156511.533 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:G.YoYo] Stopped 2025-12-08T01:15:11.533Z,1765156511.533 [sci2_vtyoyo:Lap:Dive:A:YoYoDive:dive:G.YoYo](DEBUG): Uninitialize YoYoComponent. 2025-12-08T01:15:11.533Z,1765156511.533 [sci2_vtyoyo:Lap:Wpt3] Stopped 2025-12-08T01:15:11.534Z,1765156511.534 [sci2_vtyoyo:Lap:Wpt3](DEBUG): Aggregate::uninitialize sci2_vtyoyo:Lap:Wpt3 2025-12-08T01:15:11.534Z,1765156511.534 [sci2_vtyoyo:Lap:Wpt3:A.Waypoint] Stopped 2025-12-08T01:15:11.534Z,1765156511.534 [sci2_vtyoyo:Lap:Wpt3:A.Waypoint](DEBUG): Uninitialize WaypointComponent. 2025-12-08T01:15:11.648Z,1765156511.648 [WetLabsBB2FL](INFO): Powering down 2025-12-08T01:15:11.844Z,1765156511.844 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl 2025-12-08T01:15:11.844Z,1765156511.844 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl 2025-12-08T01:15:11.855Z,1765156511.855 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl 2025-12-08T01:15:11.959Z,1765156511.959 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-12-08T01:15:11.960Z,1765156511.960 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-12-08T01:15:14.409Z,1765156514.409 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into: 4 45 NaN NaN 30 15 4 0.75 200 10 10 45 2 0 0 1 2 3 NaN 0 Sinking to Timed out while trying to reach target sink depth at current depth of 2025-12-08T01:15:14.418Z,1765156514.418 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h 2025-12-08T01:15:14.432Z,1765156514.432 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min 2025-12-08T01:15:14.434Z,1765156514.434 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg 2025-12-08T01:15:14.436Z,1765156514.436 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg 2025-12-08T01:15:14.438Z,1765156514.438 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m 2025-12-08T01:15:14.441Z,1765156514.441 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m 2025-12-08T01:15:14.443Z,1765156514.443 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m 2025-12-08T01:15:14.461Z,1765156514.461 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s 2025-12-08T01:15:14.463Z,1765156514.463 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m 2025-12-08T01:15:14.465Z,1765156514.465 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool 2025-12-08T01:15:14.467Z,1765156514.467 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m 2025-12-08T01:15:14.470Z,1765156514.470 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min 2025-12-08T01:15:14.484Z,1765156514.484 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m 2025-12-08T01:15:14.486Z,1765156514.486 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km 2025-12-08T01:15:14.488Z,1765156514.488 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count 2025-12-08T01:15:14.490Z,1765156514.490 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count 2025-12-08T01:15:14.493Z,1765156514.493 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count 2025-12-08T01:15:14.495Z,1765156514.495 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count 2025-12-08T01:15:14.521Z,1765156514.521 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count 2025-12-08T01:15:14.523Z,1765156514.523 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool 2025-12-08T01:15:14.523Z,1765156514.523 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2025-12-08T01:15:14.524Z,1765156514.524 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2025-12-08T01:15:14.525Z,1765156514.525 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2025-12-08T01:15:15.129Z,1765156515.129 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into: 1 10 20 NaN 1 1500 7 30 0 0 0 0 last time_fix was: first GPS update timeout Comms timed out after minutes second GPS update timeout 2025-12-08T01:15:15.136Z,1765156515.136 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h 2025-12-08T01:15:15.138Z,1765156515.138 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min 2025-12-08T01:15:15.141Z,1765156515.141 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg 2025-12-08T01:15:15.143Z,1765156515.143 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s 2025-12-08T01:15:15.145Z,1765156515.145 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s 2025-12-08T01:15:15.147Z,1765156515.147 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1500.000000 s 2025-12-08T01:15:15.150Z,1765156515.150 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min 2025-12-08T01:15:15.152Z,1765156515.152 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min 2025-12-08T01:15:15.154Z,1765156515.154 [MissionManager](INFO): DefineArg keepstation:NeedComms.DoingCommsMode = 0.000000 count 2025-12-08T01:15:15.185Z,1765156515.185 [MissionManager](INFO): DefineArg keepstation:NeedComms.RestoreMode = 0.000000 count 2025-12-08T01:15:15.187Z,1765156515.187 [MissionManager](INFO): DefineOutput keepstation:NeedComms.IsActive = 0 bool 2025-12-08T01:15:15.197Z,1765156515.197 [MissionManager](INFO): DefineOutput keepstation:NeedComms.RequiredDiveMode = 0.000000 count 2025-12-08T01:15:15.223Z,1765156515.223 [keepstation:NeedComms:C.GoToSurface](DEBUG): Construct GoToSurface. 2025-12-08T01:15:15.259Z,1765156515.259 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-12-08T01:15:15.259Z,1765156515.259 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-12-08T01:15:15.266Z,1765156515.266 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-12-08T01:15:15.327Z,1765156515.327 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 1.5 200 2000 2025-12-08T01:15:15.331Z,1765156515.331 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m 2025-12-08T01:15:15.334Z,1765156515.334 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m 2025-12-08T01:15:15.385Z,1765156515.385 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m 2025-12-08T01:15:15.387Z,1765156515.387 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-12-08T01:15:15.393Z,1765156515.393 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-12-08T01:15:15.402Z,1765156515.402 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-12-08T01:15:15.426Z,1765156515.426 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-12-08T01:15:15.455Z,1765156515.455 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-12-08T01:15:15.455Z,1765156515.455 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-12-08T01:15:15.458Z,1765156515.458 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-12-08T01:15:15.506Z,1765156515.506 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-12-08T01:15:15.509Z,1765156515.509 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool 2025-12-08T01:15:15.511Z,1765156515.511 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-12-08T01:15:15.514Z,1765156515.514 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-12-08T01:15:15.514Z,1765156515.514 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-12-08T01:15:15.515Z,1765156515.515 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-12-08T01:15:15.629Z,1765156515.629 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-12-08T01:15:15.632Z,1765156515.632 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool 2025-12-08T01:15:15.634Z,1765156515.634 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool 2025-12-08T01:15:15.637Z,1765156515.637 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool 2025-12-08T01:15:15.639Z,1765156515.639 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool 2025-12-08T01:15:15.642Z,1765156515.642 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 1 bool 2025-12-08T01:15:15.648Z,1765156515.648 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-12-08T01:15:15.650Z,1765156515.650 [keepstation:H.Pitch](DEBUG): Construct. 2025-12-08T01:15:15.703Z,1765156515.703 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2025-12-08T01:15:15.726Z,1765156515.726 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct. 2025-12-08T01:15:15.770Z,1765156515.770 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct. 2025-12-08T01:15:15.795Z,1765156515.795 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy. 2025-12-08T01:15:15.806Z,1765156515.806 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct. 2025-12-08T01:15:15.819Z,1765156515.819 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct. 2025-12-08T01:15:15.843Z,1765156515.843 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct. 2025-12-08T01:15:15.863Z,1765156515.863 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation. 2025-12-08T01:15:15.876Z,1765156515.876 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2025-12-08T01:15:15.894Z,1765156515.894 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait. 2025-12-08T01:15:15.962Z,1765156515.962 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission keepstation { """ Vehicle transits to desired waypoint (or stays put if none is commanded) and stays within the specified radius. """ arguments { MissionTimeout = 4 hour """ Maximum duration of mission """ NeedCommsTime = 45 minute """ How often to surface for communications """ Latitude = NaN degree """ Latitude of waypoint to hold. If NaN, hold the latitude at start of mission. """ Longitude = NaN degree """ Longitude of waypoint to hold. If NaN, hold the longitude at start of mission. """ Depth = 30 meter """ Depth held during drift mode """ ApproachDepth = 15 meter """ Depth for initial approach to station. """ DepthDeadband = 4 meter """ How much vertical drift from the specified depth is allowed in drift mode """ Speed = 0.75 meter_per_second """ Vehicle transit speed. """ Radius = 200 meter """ Radius of circle around waypoint to hold. """ SinkOffSurface = false """ If true, use buoyancy only to decend to SinkDepth before driving to first target depth """ SinkDepth = 10 meter """ Initial depth to decend using only buoyancy before driving """ SinkDepthTimeout = 10 minute """ Max wait time for the vehicle to reach the target depth """ MaxDepth = 45 meter """ Maximum allowable depth during the mission. """ MinOffshore = 2 kilometer """ Minimum distance from the shoreline to maintain """ } output { DiveMode = 0 count """ Mission variable (don't change). The mission sets this variable to switch between dive modes. Initialized to DoingComms. """ DoingComms = 0 count """ Mission variable (don't change). The mission will run in this mode when doing surface comms. """ SurfaceSink = 1 count """ Mission variable (don't change). The mission will run in this mode when sinking from the surface using only buoyancy. """ TransitToStation = 2 count """ Mission variable (don't change). The mission will run in this mode when performing the transit to station """ StationKeep = 3 count """ Mission variable (don't change). The mission will run in this mode when keeping station """ OnStation = false """ Mission variable (don't change). Determines last mode (Transit or StationKeep) to resume after needcomms """ } timeout duration=MissionTimeout insert id="NeedComms" Insert/NeedComms.tl assign in sequence NeedComms:DiveInterval = NeedCommsTime insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl behavior Guidance:Pitch { run in parallel set massPosition = Control:VerticalControl.massDefault } aggregate SurfaceComms { run when ( called or ( elapsed ( Universal:time_fix ) > NeedCommsTime ) ) assign in sequence DiveMode = DoingComms call priorityHere=false refId="NeedComms" aggregate HandleNan { run in sequence break if ( not isNaN ( Latitude ) and not isNaN ( Longitude ) ) # If both lat and lon are nan, we are implicitly on station and should skip initial transit, so force OnStation to true aggregate SetOnStation { run in sequence break if ( not isNaN ( Latitude ) or not isNaN ( Longitude ) ) assign in sequence OnStation = true } # The "assigns" here mean we should only ever run these aggregates once # An initial NaN lat/lon should be set here during the initial surface NeedComms call # Use the most recent fix -- if there isn't one, the keepstation behavior will use Universal:lat/lon aggregate SetLat { run in sequence break if ( not isNaN ( Latitude ) ) assign in sequence Latitude = Universal:latitude_fix } aggregate SetLon { run in sequence break if ( not isNaN ( Longitude ) ) assign in sequence Longitude = Universal:longitude_fix } } aggregate setTransit { run in sequence break if ( SinkOffSurface or OnStation ) assign in sequence DiveMode = TransitToStation } aggregate setStation { run in sequence break if ( SinkOffSurface or not OnStation ) assign in sequence DiveMode = StationKeep } aggregate setSink { run in sequence break if ( not SinkOffSurface ) assign in sequence DiveMode = SurfaceSink } } call id="StartingMission" priorityHere=false refId="SurfaceComms" aggregate DiveCmd { run when ( called ) aggregate SurfaceSink { run while ( DiveMode == SurfaceSink ) aggregate sink { run in sequence behavior Guidance:Buoyancy id="BuoyancyHold" { run in parallel set position = NaN cc } behavior Guidance:SetSpeed { run in parallel set speed = 0 m/s } syslog info "Sinking to " + SinkDepth~meter behavior Guidance:Pitch { run in sequence timeout duration=SinkDepthTimeout { syslog important "Timed out while trying to reach target sink depth at current depth of " + Universal:depth~meter } set depth = SinkDepth } # Once we've sunk, either resume transit or station keeping depths and speeds aggregate sinkToTransit { run in sequence break if ( OnStation ) assign in sequence DiveMode = TransitToStation } aggregate sinkToStation { run in sequence break if ( not OnStation ) assign in sequence DiveMode = StationKeep } } } aggregate TransitToStation { run while ( DiveMode == TransitToStation ) aggregate dive { run in sequence behavior Guidance:Buoyancy { run in parallel set position = Control:VerticalControl.buoyancyNeutral } behavior Guidance:Pitch { run in parallel set depth = ApproachDepth } behavior Guidance:SetSpeed { run in parallel set speed = Speed } } } aggregate StationKeep { run while ( DiveMode == StationKeep ) assign in parallel Control:VerticalControl.depthDeadband = DepthDeadband behavior Guidance:Pitch { run in parallel set depth = Depth } behavior Guidance:KeepStation { run in parallel set latitude = Latitude set longitude = Longitude set radius = Radius set speed = Speed } } } aggregate TransitToStation { """ Need a separate aggregate for transit if we want to specify a different depth for the approach. """ run in sequence aggregate Dive { run while ( not ( DiveMode == DoingComms ) ) call priorityHere=false refId="DiveCmd" } behavior Guidance:Waypoint id="Wpt1" { run in sequence set latitude = Latitude set longitude = Longitude } assign in sequence DiveMode = StationKeep assign in sequence OnStation = true } call id="OnStation" priorityHere=false refId="NeedComms" aggregate KeepStation { run in sequence aggregate Dive { run while ( not ( DiveMode == DoingComms ) ) call priorityHere=false refId="DiveCmd" } behavior Guidance:Wait { """ Due to the way the KeepStation behavior is currently implemented, we must run it in parallel and use a Wait to keep from completing the mission before the timeout expires. However, this new version of the mission uses a top-level timeout so that the entire mission will not run for longer then MissionTimeout. """ run in sequence set duration = MissionTimeout } } } 2025-12-08T01:15:15.962Z,1765156515.962 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation 2025-12-08T01:15:16.191Z,1765156516.191 [MissionManager](IMPORTANT): Started mission Default 2025-12-08T01:15:16.191Z,1765156516.191 [Default] Running Loop=1 2025-12-08T01:15:16.191Z,1765156516.191 [Default](DEBUG): Aggregate::initialize Default 2025-12-08T01:15:16.191Z,1765156516.191 [Default:B.GoToSurface] Running Loop=1 2025-12-08T01:15:16.191Z,1765156516.191 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-12-08T01:15:16.196Z,1765156516.196 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-12-08T01:15:16.196Z,1765156516.196 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-12-08T01:15:16.196Z,1765156516.196 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-12-08T01:15:16.197Z,1765156516.197 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-12-08T01:15:16.197Z,1765156516.197 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-12-08T01:15:16.197Z,1765156516.197 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-12-08T01:15:16.198Z,1765156516.198 [Default:A.Wait] Running Loop=1 2025-12-08T01:15:16.198Z,1765156516.198 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-12-08T01:15:16.596Z,1765156516.596 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm (3 active estimators). 2025-12-08T01:15:16.816Z,1765156516.816 [Radio_Surface](INFO): Powering up 2025-12-08T01:15:22.941Z,1765156522.941 [DataOverHttps](INFO): Radio surface powered ON. 2025-12-08T01:15:29.297Z,1765156529.297 [Default:A.Wait](INFO): Done Waiting. 2025-12-08T01:15:29.297Z,1765156529.297 [Default:A.Wait] Stopped 2025-12-08T01:15:29.297Z,1765156529.297 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-12-08T01:15:30.153Z,1765156530.153 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-12-08T01:15:30.153Z,1765156530.153 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-12-08T01:15:30.153Z,1765156530.153 [LcmPublisher](INFO): Deactivating messaging. 2025-12-08T01:15:41.140Z,1765156541.140 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 14 hour 2025-12-08T01:15:41.141Z,1765156541.141 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 90 minute 2025-12-08T01:15:41.142Z,1765156541.142 [CommandExec](IMPORTANT): got command set keepstation.Depth 20 meter 2025-12-08T01:15:41.143Z,1765156541.143 [CommandExec](IMPORTANT): got command set keepstation.Speed 1 meter_per_second 2025-12-08T01:15:41.143Z,1765156541.143 [CommandExec](IMPORTANT): got command set keepstation.SinkOffSurface 1 bool 2025-12-08T01:15:43.992Z,1765156543.992 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 0.70 m/s, pitch -20.00 deg, mass-position 31.17 mm. 2025-12-08T01:15:44.002Z,1765156544.002 [Default:CheckIn] Running Loop=1 2025-12-08T01:15:44.002Z,1765156544.002 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-12-08T01:15:44.002Z,1765156544.002 [Default:CheckIn:Read_GPS] Running Loop=1 2025-12-08T01:15:53.096Z,1765156553.096 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:15:59.380Z,1765156559.380 [CommandExec](IMPORTANT): got command set keepstation.MaxDepth 45 meter 2025-12-08T01:15:59.381Z,1765156559.381 [CommandExec](IMPORTANT): got command set keepstation:NeedComms.SurfaceSpeed 1 meter_per_second 2025-12-08T01:15:59.381Z,1765156559.381 [CommandExec](IMPORTANT): got command set keepstation:NeedComms.CommsTimeout 30 minute 2025-12-08T01:15:59.382Z,1765156559.382 [CommandExec](IMPORTANT): got command run 2025-12-08T01:15:59.406Z,1765156559.406 [CommandExec](IMPORTANT): Running 2025-12-08T01:15:59.583Z,1765156559.583 [Default] Stopped 2025-12-08T01:15:59.583Z,1765156559.583 [Default](DEBUG): Aggregate::uninitialize Default 2025-12-08T01:15:59.583Z,1765156559.583 [Default:B.GoToSurface] Stopped 2025-12-08T01:15:59.584Z,1765156559.584 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-12-08T01:15:59.584Z,1765156559.584 [Default:CheckIn] Stopped 2025-12-08T01:15:59.584Z,1765156559.584 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-12-08T01:15:59.584Z,1765156559.584 [Default:CheckIn:Read_GPS] Stopped 2025-12-08T01:15:59.584Z,1765156559.584 [MissionManager](IMPORTANT): Started mission keepstation 2025-12-08T01:15:59.584Z,1765156559.584 [keepstation] Running Loop=1 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation](DEBUG): Aggregate::initialize keepstation 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes] Running Loop=1 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-12-08T01:15:59.585Z,1765156559.585 [keepstation:BackseatDriver] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly:A] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly:B] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly:C] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly:D] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly:E.Wait] Running Loop=1 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-12-08T01:15:59.586Z,1765156559.586 [keepstation:H.Pitch] Running Loop=1 2025-12-08T01:15:59.587Z,1765156559.587 [keepstation:H.Pitch](DEBUG): Initialize. 2025-12-08T01:15:59.587Z,1765156559.587 [keepstation:B] Running Loop=1 2025-12-08T01:15:59.588Z,1765156559.588 [keepstation:H.Pitch] Running Loop=1 2025-12-08T01:15:59.588Z,1765156559.588 [keepstation:PowerOnly] Running Loop=1 2025-12-08T01:15:59.588Z,1765156559.588 [keepstation:PowerOnly:D] Stopped 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:PowerOnly:C] Stopped 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:PowerOnly:B] Stopped 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:PowerOnly:A] Stopped 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:BackseatDriver] Running Loop=1 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:StandardEnvelopes] Running Loop=1 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-12-08T01:15:59.589Z,1765156559.589 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-12-08T01:15:59.590Z,1765156559.590 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-12-08T01:15:59.590Z,1765156559.590 [keepstation:B] Stopped 2025-12-08T01:15:59.590Z,1765156559.590 [keepstation:D] Running Loop=1 2025-12-08T01:15:59.995Z,1765156559.995 [keepstation:D] Stopped 2025-12-08T01:15:59.996Z,1765156559.996 [keepstation:E] Running Loop=1 2025-12-08T01:16:00.399Z,1765156560.399 [keepstation:E] Stopped 2025-12-08T01:16:00.399Z,1765156560.399 [keepstation:StartingMission] Running Loop=1 2025-12-08T01:16:00.399Z,1765156560.399 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission 2025-12-08T01:16:00.820Z,1765156560.820 [keepstation:SurfaceComms] Running Loop=1 2025-12-08T01:16:00.821Z,1765156560.821 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2025-12-08T01:16:00.821Z,1765156560.821 [keepstation:SurfaceComms:A] Running Loop=1 2025-12-08T01:16:00.821Z,1765156560.821 [keepstation:SurfaceComms:A] Stopped 2025-12-08T01:16:00.821Z,1765156560.821 [keepstation:SurfaceComms:B] Running Loop=1 2025-12-08T01:16:00.822Z,1765156560.822 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2025-12-08T01:16:01.207Z,1765156561.207 [keepstation:NeedComms] Running Loop=1 2025-12-08T01:16:01.207Z,1765156561.207 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-12-08T01:16:01.207Z,1765156561.207 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2025-12-08T01:16:01.207Z,1765156561.207 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-12-08T01:16:01.207Z,1765156561.207 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-12-08T01:16:01.208Z,1765156561.208 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-12-08T01:16:01.208Z,1765156561.208 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-12-08T01:16:01.209Z,1765156561.209 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2025-12-08T01:16:01.209Z,1765156561.209 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-12-08T01:16:01.209Z,1765156561.209 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-12-08T01:16:01.210Z,1765156561.210 [keepstation:NeedComms:A] Running Loop=1 2025-12-08T01:16:01.211Z,1765156561.211 [keepstation:NeedComms:A](INFO): last time_fix was: 1765155422.000000 second since 1970/01/01T00:00:00Z 2025-12-08T01:16:01.211Z,1765156561.211 [keepstation:NeedComms:A] Stopped 2025-12-08T01:16:01.211Z,1765156561.211 [keepstation:NeedComms:setActive] Running Loop=1 2025-12-08T01:16:01.211Z,1765156561.211 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2025-12-08T01:16:01.211Z,1765156561.211 [keepstation:NeedComms:setActive:A] Running Loop=1 2025-12-08T01:16:01.676Z,1765156561.676 [keepstation:NeedComms:setActive:A] Stopped 2025-12-08T01:16:01.676Z,1765156561.676 [keepstation:NeedComms:setActive:B] Running Loop=1 2025-12-08T01:16:02.028Z,1765156562.028 [keepstation:NeedComms:setActive:B] Stopped 2025-12-08T01:16:02.029Z,1765156562.029 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2025-12-08T01:16:02.029Z,1765156562.029 [keepstation:NeedComms:setActive] Stopped 2025-12-08T01:16:02.029Z,1765156562.029 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2025-12-08T01:16:02.431Z,1765156562.431 [keepstation:NeedComms:D] Running Loop=1 2025-12-08T01:16:02.860Z,1765156562.860 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-12-08T01:16:16.945Z,1765156576.945 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-12-08T01:16:17.024Z,1765156577.024 [NAL9602](ERROR): received: +CSQ:0 OK386, 2, 0, 0, 0 OK 2025-12-08T01:16:24.224Z,1765156584.224 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:16:55.352Z,1765156615.352 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:17:13.907Z,1765156633.907 [NAL9602](INFO): SBD MO Status=2, MOMSN=24386, MT Status=2, MTMSN=0 2025-12-08T01:17:13.907Z,1765156633.907 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-12-08T01:17:26.480Z,1765156646.480 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:17:26.839Z,1765156646.839 [NAL9602](INFO): SBD MO Status=2, MOMSN=24386, MT Status=2, MTMSN=0 2025-12-08T01:17:26.841Z,1765156646.841 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-12-08T01:17:57.604Z,1765156677.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:18:06.216Z,1765156686.216 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003113 2025-12-08T01:18:33.945Z,1765156713.945 [NAL9602](INFO): SBD MO Status=2, MOMSN=24386, MT Status=2, MTMSN=0 2025-12-08T01:18:33.945Z,1765156713.945 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-12-08T01:20:48.448Z,1765156848.448 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-12-08T01:20:54.108Z,1765156854.108 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012052.00,A,3631.48039,N,12200.07431,W,0.156,166.05,081225,,,D*76 2025-12-08T01:20:54.110Z,1765156854.110 [NAL9602](INFO): GPS fix at 20251208T012052: (36.524673, -122.001238) 2025-12-08T01:20:54.122Z,1765156854.122 [UniversalFixResidualReporter](INFO): Fix residual: 55.4 %DT, over the last 533.5 m. Residual distance 295.5 m at bearing 48.8 degrees. Fix at (36.5247, -122.0012) with 700.4 m made good. 2025-12-08T01:20:54.125Z,1765156854.125 [keepstation:NeedComms:D] Stopped 2025-12-08T01:20:54.125Z,1765156854.125 [keepstation:NeedComms:E] Running Loop=1 2025-12-08T01:20:54.542Z,1765156854.542 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-12-08T01:21:01.911Z,1765156861.911 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20251207T143000/Courier0023.lzma 2025-12-08T01:21:02.914Z,1765156862.914 [DataOverHttps](INFO): Moved sent file to Logs/20251207T143000/Courier0023.lzma.bak 2025-12-08T01:21:02.914Z,1765156862.914 [DataOverHttps](INFO): SBD MOMSN=26456660 2025-12-08T01:21:19.169Z,1765156879.169 [DataOverHttps](INFO): Sending 326 bytes from file Logs/20251208T011500/Courier0000.lzma 2025-12-08T01:21:20.170Z,1765156880.170 [DataOverHttps](INFO): Moved sent file to Logs/20251208T011500/Courier0000.lzma.bak 2025-12-08T01:21:20.170Z,1765156880.170 [DataOverHttps](INFO): SBD MOMSN=26456663 2025-12-08T01:21:26.018Z,1765156886.018 [NAL9602](INFO): Not Powering down - fast GPS 2025-12-08T01:21:36.677Z,1765156896.677 [DataOverHttps](INFO): Sending 432 bytes from file Logs/20251207T143000/Express0025.lzma 2025-12-08T01:21:37.678Z,1765156897.678 [DataOverHttps](INFO): Moved sent file to Logs/20251207T143000/Express0025.lzma.bak 2025-12-08T01:21:37.678Z,1765156897.678 [DataOverHttps](INFO): SBD MOMSN=26456667 2025-12-08T01:21:38.550Z,1765156898.550 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T01:21:53.830Z,1765156913.830 [DataOverHttps](INFO): Sending 1090 bytes from file Logs/20251208T011500/Express0001.lzma 2025-12-08T01:21:54.830Z,1765156914.830 [DataOverHttps](INFO): Moved sent file to Logs/20251208T011500/Express0001.lzma.bak 2025-12-08T01:21:54.830Z,1765156914.830 [DataOverHttps](INFO): SBD MOMSN=26456671 2025-12-08T01:21:56.334Z,1765156916.334 [keepstation:NeedComms:E] Stopped 2025-12-08T01:21:56.334Z,1765156916.334 [keepstation:NeedComms:F] Running Loop=1 2025-12-08T01:21:56.745Z,1765156916.745 [keepstation:NeedComms:F](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-12-08T01:21:58.339Z,1765156918.339 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012156.00,A,3631.47708,N,12200.07604,W,0.330,183.72,081225,,,A*71 2025-12-08T01:21:58.350Z,1765156918.350 [NAL9602](INFO): GPS fix at 20251208T012156: (36.524618, -122.001267) 2025-12-08T01:21:58.366Z,1765156918.366 [keepstation:NeedComms:F] Stopped 2025-12-08T01:21:58.366Z,1765156918.366 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2025-12-08T01:21:58.366Z,1765156918.366 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2025-12-08T01:21:58.366Z,1765156918.366 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2025-12-08T01:21:58.790Z,1765156918.790 [keepstation:NeedComms:setRestoreMode:A] Stopped 2025-12-08T01:21:58.790Z,1765156918.790 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2025-12-08T01:21:58.790Z,1765156918.790 [keepstation:NeedComms:setRestoreMode] Stopped 2025-12-08T01:21:58.790Z,1765156918.790 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2025-12-08T01:21:58.790Z,1765156918.790 [keepstation:NeedComms:setInactive] Running Loop=1 2025-12-08T01:21:58.791Z,1765156918.791 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2025-12-08T01:21:58.791Z,1765156918.791 [keepstation:NeedComms:setInactive:A] Running Loop=1 2025-12-08T01:21:59.166Z,1765156919.166 [keepstation:NeedComms:setInactive:A] Stopped 2025-12-08T01:21:59.166Z,1765156919.166 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2025-12-08T01:21:59.166Z,1765156919.166 [keepstation:NeedComms:setInactive] Stopped 2025-12-08T01:21:59.166Z,1765156919.166 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2025-12-08T01:21:59.167Z,1765156919.167 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-12-08T01:21:59.167Z,1765156919.167 [keepstation:NeedComms] Stopped 2025-12-08T01:21:59.167Z,1765156919.167 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-12-08T01:21:59.167Z,1765156919.167 [keepstation:NeedComms:C.GoToSurface] Stopped 2025-12-08T01:21:59.167Z,1765156919.167 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-12-08T01:21:59.659Z,1765156919.659 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2025-12-08T01:21:59.664Z,1765156919.664 [keepstation:SurfaceComms:B] Stopped 2025-12-08T01:21:59.664Z,1765156919.664 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2025-12-08T01:21:59.664Z,1765156919.664 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2025-12-08T01:21:59.664Z,1765156919.664 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2025-12-08T01:21:59.664Z,1765156919.664 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2025-12-08T01:21:59.665Z,1765156919.665 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2025-12-08T01:21:59.665Z,1765156919.665 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2025-12-08T01:21:59.986Z,1765156919.986 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2025-12-08T01:21:59.987Z,1765156919.987 [keepstation:SurfaceComms:HandleNan:SetOnStation](INFO): Completed keepstation:SurfaceComms:HandleNan:SetOnStation 2025-12-08T01:21:59.987Z,1765156919.987 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2025-12-08T01:21:59.987Z,1765156919.987 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2025-12-08T01:21:59.987Z,1765156919.987 [keepstation:SurfaceComms:HandleNan:SetLat] Running Loop=1 2025-12-08T01:21:59.987Z,1765156919.987 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLat 2025-12-08T01:21:59.987Z,1765156919.987 [keepstation:SurfaceComms:HandleNan:SetLat:A] Running Loop=1 2025-12-08T01:22:00.397Z,1765156920.397 [keepstation:SurfaceComms:HandleNan:SetLat:A] Stopped 2025-12-08T01:22:00.398Z,1765156920.398 [keepstation:SurfaceComms:HandleNan:SetLat](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLat 2025-12-08T01:22:00.398Z,1765156920.398 [keepstation:SurfaceComms:HandleNan:SetLat] Stopped 2025-12-08T01:22:00.398Z,1765156920.398 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLat 2025-12-08T01:22:00.398Z,1765156920.398 [keepstation:SurfaceComms:HandleNan:SetLon] Running Loop=1 2025-12-08T01:22:00.398Z,1765156920.398 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLon 2025-12-08T01:22:00.398Z,1765156920.398 [keepstation:SurfaceComms:HandleNan:SetLon:A] Running Loop=1 2025-12-08T01:22:00.781Z,1765156920.781 [keepstation:SurfaceComms:HandleNan:SetLon:A] Stopped 2025-12-08T01:22:00.781Z,1765156920.781 [keepstation:SurfaceComms:HandleNan:SetLon](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLon 2025-12-08T01:22:00.781Z,1765156920.781 [keepstation:SurfaceComms:HandleNan:SetLon] Stopped 2025-12-08T01:22:00.781Z,1765156920.781 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLon 2025-12-08T01:22:00.781Z,1765156920.781 [keepstation:SurfaceComms:HandleNan](INFO): Completed keepstation:SurfaceComms:HandleNan 2025-12-08T01:22:00.782Z,1765156920.782 [keepstation:SurfaceComms:HandleNan] Stopped 2025-12-08T01:22:00.782Z,1765156920.782 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2025-12-08T01:22:00.782Z,1765156920.782 [keepstation:SurfaceComms:setTransit] Running Loop=1 2025-12-08T01:22:00.782Z,1765156920.782 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2025-12-08T01:22:00.782Z,1765156920.782 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2025-12-08T01:22:01.196Z,1765156921.196 [keepstation:SurfaceComms:setTransit] Stopped 2025-12-08T01:22:01.197Z,1765156921.197 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2025-12-08T01:22:01.197Z,1765156921.197 [keepstation:SurfaceComms:setTransit:A] Stopped 2025-12-08T01:22:01.197Z,1765156921.197 [keepstation:SurfaceComms:setStation] Running Loop=1 2025-12-08T01:22:01.197Z,1765156921.197 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2025-12-08T01:22:01.197Z,1765156921.197 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2025-12-08T01:22:01.605Z,1765156921.605 [keepstation:SurfaceComms:setStation] Stopped 2025-12-08T01:22:01.606Z,1765156921.606 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2025-12-08T01:22:01.606Z,1765156921.606 [keepstation:SurfaceComms:setStation:A] Stopped 2025-12-08T01:22:01.606Z,1765156921.606 [keepstation:SurfaceComms:setSink] Running Loop=1 2025-12-08T01:22:01.606Z,1765156921.606 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2025-12-08T01:22:01.606Z,1765156921.606 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2025-12-08T01:22:01.988Z,1765156921.988 [keepstation:SurfaceComms:setSink:A] Stopped 2025-12-08T01:22:01.989Z,1765156921.989 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink 2025-12-08T01:22:01.989Z,1765156921.989 [keepstation:SurfaceComms:setSink] Stopped 2025-12-08T01:22:01.989Z,1765156921.989 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2025-12-08T01:22:01.989Z,1765156921.989 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2025-12-08T01:22:01.989Z,1765156921.989 [keepstation:SurfaceComms] Stopped 2025-12-08T01:22:01.989Z,1765156921.989 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2025-12-08T01:22:02.451Z,1765156922.451 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2025-12-08T01:22:02.451Z,1765156922.451 [keepstation:StartingMission] Stopped 2025-12-08T01:22:02.451Z,1765156922.451 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2025-12-08T01:22:02.452Z,1765156922.452 [keepstation:TransitToStation] Running Loop=1 2025-12-08T01:22:02.452Z,1765156922.452 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2025-12-08T01:22:02.452Z,1765156922.452 [keepstation:TransitToStation:Dive] Running Loop=1 2025-12-08T01:22:02.452Z,1765156922.452 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive 2025-12-08T01:22:02.452Z,1765156922.452 [keepstation:TransitToStation:Dive:A] Running Loop=1 2025-12-08T01:22:02.452Z,1765156922.452 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A 2025-12-08T01:22:02.453Z,1765156922.453 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2025-12-08T01:22:02.453Z,1765156922.453 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2025-12-08T01:22:02.453Z,1765156922.453 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.524618,-122.001267 2025-12-08T01:22:02.804Z,1765156922.804 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.524618,-122.001267 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:TransitToStation:Dive] Running Loop=1 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd] Running Loop=1 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd:SurfaceSink] Running Loop=1 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1 2025-12-08T01:22:02.805Z,1765156922.805 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize. 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation] Running Loop=1 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-12-08T01:22:02.806Z,1765156922.806 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize. 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize. 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep] Running Loop=1 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2025-12-08T01:22:02.807Z,1765156922.807 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2025-12-08T01:22:02.808Z,1765156922.808 [keepstation:DiveCmd:StationKeep] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:StationKeep:A] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped 2025-12-08T01:22:02.809Z,1765156922.809 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize. 2025-12-08T01:22:02.810Z,1765156922.810 [keepstation:DiveCmd:SurfaceSink] Running Loop=1 2025-12-08T01:22:02.810Z,1765156922.810 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to 10.000000 m 2025-12-08T01:22:02.810Z,1765156922.810 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped 2025-12-08T01:22:02.810Z,1765156922.810 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1 2025-12-08T01:22:02.810Z,1765156922.810 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize. 2025-12-08T01:22:02.811Z,1765156922.811 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1 2025-12-08T01:22:02.811Z,1765156922.811 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1 2025-12-08T01:22:10.067Z,1765156930.067 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2025-12-08T01:22:10.070Z,1765156930.070 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2025-12-08T01:22:29.042Z,1765156949.042 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-12-08T01:22:29.120Z,1765156949.120 [NAL9602](ERROR): received: +CSQ:0 OK386, 2, 0, 0, 0 OK 2025-12-08T01:24:29.496Z,1765157069.496 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:25:00.620Z,1765157100.620 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:25:17.672Z,1765157117.672 [Radio_Surface](INFO): Powering down 2025-12-08T01:25:31.744Z,1765157131.744 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T01:25:32.748Z,1765157132.748 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-12-08T01:26:22.194Z,1765157182.194 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped 2025-12-08T01:26:22.194Z,1765157182.194 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1 2025-12-08T01:26:22.194Z,1765157182.194 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit 2025-12-08T01:26:22.194Z,1765157182.194 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1 2025-12-08T01:26:22.615Z,1765157182.615 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped 2025-12-08T01:26:22.615Z,1765157182.615 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit 2025-12-08T01:26:22.615Z,1765157182.615 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped 2025-12-08T01:26:22.615Z,1765157182.615 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1 2025-12-08T01:26:22.615Z,1765157182.615 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation 2025-12-08T01:26:22.615Z,1765157182.615 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1 2025-12-08T01:26:22.990Z,1765157182.990 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped 2025-12-08T01:26:22.990Z,1765157182.990 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation 2025-12-08T01:26:22.990Z,1765157182.990 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped 2025-12-08T01:26:22.990Z,1765157182.990 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink] Stopped 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped 2025-12-08T01:26:22.991Z,1765157182.991 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize. 2025-12-08T01:26:22.992Z,1765157182.992 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink 2025-12-08T01:26:23.402Z,1765157183.402 [keepstation:DiveCmd:StationKeep] Running Loop=1 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep] Running Loop=1 2025-12-08T01:26:23.403Z,1765157183.403 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2025-12-08T01:26:23.404Z,1765157183.404 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2025-12-08T01:26:23.405Z,1765157183.405 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2025-12-08T01:26:37.004Z,1765157197.004 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.719269 2025-12-08T01:27:00.138Z,1765157220.138 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-12-08T01:27:30.831Z,1765157250.831 [NAL9602](INFO): Not Powering down - fast GPS 2025-12-08T01:31:38.890Z,1765157498.890 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T01:39:49.141Z,1765157989.141 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-12-08T01:39:53.462Z,1765157993.462 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.002243 CHAN A1 (24V): 0.008175 CHAN A2 (12V): -0.008297 CHAN A3 (5V): -0.010630 CHAN B0 (3.3V): -0.002649 CHAN B1 (3.15aV): -0.002295 CHAN B2 (3.15bV): -0.000694 CHAN B3 (GND): -0.001377 OPEN: 0.012171 Full Scale: +/- 1 mA 2025-12-08T01:41:39.246Z,1765158099.246 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T01:41:57.012Z,1765158117.012 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-12-08T01:44:24.512Z,1765158264.512 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-12-08T01:51:39.579Z,1765158699.579 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:01:39.923Z,1765159299.923 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:03:12.030Z,1765159392.030 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2025-12-08T02:03:12.044Z,1765159392.044 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2025-12-08T02:11:40.290Z,1765159900.290 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:21:40.611Z,1765160500.611 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:29:13.495Z,1765160953.495 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-12-08T02:30:35.912Z,1765161035.912 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2025-12-08T02:31:40.981Z,1765161100.981 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:33:07.022Z,1765161187.022 [DVL_micro](ERROR): Failed to parse: 2025-12-08T02:36:47.592Z,1765161407.592 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-12-08T02:41:41.312Z,1765161701.312 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:44:14.006Z,1765161854.006 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2025-12-08T02:44:14.010Z,1765161854.010 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2025-12-08T02:45:12.244Z,1765161912.244 [DVL_micro](ERROR): only read 3 of 4 data items for beam range. Device response is::RD,+9999.99,+9999.99,+99999.99 2025-12-08T02:45:12.244Z,1765161912.244 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+99999.99 2025-12-08T02:46:39.866Z,1765161999.866 [DVL_micro](ERROR): Failed to parse: :SA,-06.30,-00.36,028.1 2025-12-08T02:51:41.649Z,1765162301.649 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-12-08T02:51:58.659Z,1765162318.659 [keepstation:SurfaceComms] Running Loop=1 2025-12-08T02:51:58.659Z,1765162318.659 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2025-12-08T02:51:58.659Z,1765162318.659 [keepstation:SurfaceComms:A] Running Loop=1 2025-12-08T02:51:58.659Z,1765162318.659 [keepstation:SurfaceComms:A] Stopped 2025-12-08T02:51:58.659Z,1765162318.659 [keepstation:SurfaceComms:B] Running Loop=1 2025-12-08T02:51:58.660Z,1765162318.660 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2025-12-08T02:51:58.661Z,1765162318.661 [keepstation:NeedComms] Running Loop=1 2025-12-08T02:51:58.662Z,1765162318.662 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-12-08T02:51:58.662Z,1765162318.662 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2025-12-08T02:51:58.662Z,1765162318.662 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-12-08T02:51:58.662Z,1765162318.662 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-12-08T02:51:58.663Z,1765162318.663 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-12-08T02:51:58.663Z,1765162318.663 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-12-08T02:51:58.663Z,1765162318.663 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2025-12-08T02:51:58.664Z,1765162318.664 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-12-08T02:51:58.664Z,1765162318.664 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-12-08T02:51:58.664Z,1765162318.664 [keepstation:NeedComms:A] Running Loop=1 2025-12-08T02:51:58.666Z,1765162318.666 [keepstation:NeedComms:A](INFO): last time_fix was: 1765156916.000000 second since 1970/01/01T00:00:00Z 2025-12-08T02:51:58.666Z,1765162318.666 [keepstation:NeedComms:A] Stopped 2025-12-08T02:51:58.666Z,1765162318.666 [keepstation:NeedComms:setActive] Running Loop=1 2025-12-08T02:51:58.666Z,1765162318.666 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2025-12-08T02:51:58.666Z,1765162318.666 [keepstation:NeedComms:setActive:A] Running Loop=1 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:TransitToStation:Dive] Stopped 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:TransitToStation:Dive:A] Stopped 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:DiveCmd:StationKeep] Stopped 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2025-12-08T02:51:59.029Z,1765162319.029 [keepstation:DiveCmd:StationKeep:A] Stopped 2025-12-08T02:51:59.030Z,1765162319.030 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2025-12-08T02:51:59.030Z,1765162319.030 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2025-12-08T02:51:59.030Z,1765162319.030 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2025-12-08T02:51:59.033Z,1765162319.033 [keepstation:NeedComms:setActive:A] Stopped 2025-12-08T02:51:59.033Z,1765162319.033 [keepstation:NeedComms:setActive:B] Running Loop=1 2025-12-08T02:51:59.445Z,1765162319.445 [keepstation:NeedComms:setActive:B] Stopped 2025-12-08T02:51:59.446Z,1765162319.446 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2025-12-08T02:51:59.446Z,1765162319.446 [keepstation:NeedComms:setActive] Stopped 2025-12-08T02:51:59.446Z,1765162319.446 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2025-12-08T02:53:16.220Z,1765162396.220 [keepstation:NeedComms:D] Running Loop=1 2025-12-08T02:53:16.808Z,1765162396.808 [Radio_Surface](INFO): Powering up 2025-12-08T02:53:22.525Z,1765162402.525 [DataOverHttps](INFO): Radio surface powered ON. 2025-12-08T02:53:52.658Z,1765162432.658 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T02:54:23.780Z,1765162463.780 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T02:54:54.904Z,1765162494.904 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T02:55:12.213Z,1765162512.213 [DVL_micro](ERROR): only read 3 of 4 data items for bottom velocity. Device response is::BI,-00468,-00022,+00245,+00+00000000.00,+00000000.00,9999.99,000.00 2025-12-08T02:55:12.213Z,1765162512.213 [DVL_micro](ERROR): Failed to parse: :BI,-00468,-00022,+00245,+00+00000000.00,+00000000.00,9999.99,000.00 2025-12-08T02:55:26.028Z,1765162526.028 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-12-08T02:55:34.777Z,1765162534.777 [DataOverHttps](IMPORTANT): SBD MTMSN=20251208T025532 2025-12-08T02:55:34.781Z,1765162534.781 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003477 2025-12-08T02:55:42.115Z,1765162542.115 [DVL_micro](ERROR): Failed to parse: :SA,+04.87,-03.56,119.4 2025-12-08T02:55:42.420Z,1765162542.420 [DataOverHttps](INFO): Received command: configSet DVL_micro.loadAtStartup 0 bool persist;restart app 2025-12-08T02:55:42.784Z,1765162542.784 [CommandExec](IMPORTANT): got command configSet DVL_micro.loadAtStartup 0 bool persist 2025-12-08T02:55:42.784Z,1765162542.784 [CommandExec](IMPORTANT): configSet DVL_micro.loadAtStartup requires a restart to take effect. 2025-12-08T02:55:42.786Z,1765162542.786 [CommandExec](IMPORTANT): got command restart application 2025-12-08T02:55:43.792Z,1765162543.792 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2025-12-08T02:55:43.792Z,1765162543.792 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:43.792Z,1765162543.792 [CommandExec](INFO): Uninitializing the command executive. 2025-12-08T02:55:43.792Z,1765162543.792 [CommandExec](INFO): Uninitializing the command scheduler. 2025-12-08T02:55:43.793Z,1765162543.793 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:43.956Z,1765162543.956 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-12-08T02:55:43.956Z,1765162543.956 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-12-08T02:55:43.956Z,1765162543.956 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:43.956Z,1765162543.956 [NavChartDb](INFO): Join timeout helper Thread ID is 1333 2025-12-08T02:55:44.161Z,1765162544.161 [MissionManager](INFO): MissionManager is completed. 2025-12-08T02:55:44.161Z,1765162544.161 [MissionManager](INFO): Uninitializing Mission keepstation 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation] Stopped 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation:NeedComms] Stopped 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation:NeedComms:C.GoToSurface] Stopped 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation:NeedComms:D] Stopped 2025-12-08T02:55:44.161Z,1765162544.161 [keepstation:StandardEnvelopes] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:BackseatDriver] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:PowerOnly] Stopped 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2025-12-08T02:55:44.162Z,1765162544.162 [keepstation:PowerOnly:E.Wait] Stopped 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:H.Pitch] Stopped 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:SurfaceComms] Stopped 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:SurfaceComms:B] Stopped 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:DiveCmd] Stopped 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:DiveCmd](DEBUG): Aggregate::uninitialize keepstation:DiveCmd 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:DiveCmd:SurfaceSink] Stopped 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink 2025-12-08T02:55:44.163Z,1765162544.163 [keepstation:TransitToStation] Stopped 2025-12-08T02:55:44.164Z,1765162544.164 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2025-12-08T02:55:44.164Z,1765162544.164 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2025-12-08T02:55:44.164Z,1765162544.164 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2025-12-08T02:55:44.244Z,1765162544.244 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:44.244Z,1765162544.244 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:44.256Z,1765162544.256 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-12-08T02:55:44.256Z,1765162544.256 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:44.256Z,1765162544.256 [Radio_Surface](INFO): Join timeout helper Thread ID is 1334 2025-12-08T02:55:44.268Z,1765162544.268 [Radio_Surface](INFO): Powering down 2025-12-08T02:55:44.269Z,1765162544.269 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:44.269Z,1765162544.269 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:44.284Z,1765162544.284 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-12-08T02:55:44.284Z,1765162544.284 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:44.284Z,1765162544.284 [Onboard](INFO): Join timeout helper Thread ID is 1335 2025-12-08T02:55:44.425Z,1765162544.425 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-12-08T02:55:44.564Z,1765162544.564 [MissionManager](IMPORTANT): Started mission Default 2025-12-08T02:55:44.564Z,1765162544.564 [Default] Running Loop=1 2025-12-08T02:55:44.564Z,1765162544.564 [Default](DEBUG): Aggregate::initialize Default 2025-12-08T02:55:44.564Z,1765162544.564 [Default:B.GoToSurface] Running Loop=1 2025-12-08T02:55:44.564Z,1765162544.564 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-12-08T02:55:44.565Z,1765162544.565 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-12-08T02:55:44.565Z,1765162544.565 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-12-08T02:55:44.565Z,1765162544.565 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-12-08T02:55:44.565Z,1765162544.565 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-12-08T02:55:44.566Z,1765162544.566 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-12-08T02:55:44.566Z,1765162544.566 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-12-08T02:55:44.567Z,1765162544.567 [Default:A.Wait] Running Loop=1 2025-12-08T02:55:44.567Z,1765162544.567 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-12-08T02:55:44.652Z,1765162544.652 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:44.652Z,1765162544.652 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:44.660Z,1765162544.660 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-12-08T02:55:44.660Z,1765162544.660 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:44.660Z,1765162544.660 [DataOverHttps](INFO): Join timeout helper Thread ID is 1336 2025-12-08T02:55:45.429Z,1765162545.429 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:45.429Z,1765162545.429 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.448Z,1765162545.448 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-12-08T02:55:45.448Z,1765162545.448 [DAT ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.448Z,1765162545.448 [DAT](INFO): Join timeout helper Thread ID is 1338 2025-12-08T02:55:45.536Z,1765162545.536 [DAT](INFO): Powering down 2025-12-08T02:55:45.608Z,1765162545.608 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:45.609Z,1765162545.609 [DAT](INFO): Powering down 2025-12-08T02:55:45.609Z,1765162545.609 [DAT ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.629Z,1765162545.629 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-12-08T02:55:45.629Z,1765162545.629 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.629Z,1765162545.629 [BackseatComponent](INFO): Join timeout helper Thread ID is 1339 2025-12-08T02:55:45.648Z,1765162545.648 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:45.649Z,1765162545.649 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.651Z,1765162545.651 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-12-08T02:55:45.651Z,1765162545.651 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.651Z,1765162545.651 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1340 2025-12-08T02:55:45.921Z,1765162545.921 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:45.921Z,1765162545.921 [WetLabsBB2FL](INFO): Powering down 2025-12-08T02:55:45.921Z,1765162545.921 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.929Z,1765162545.929 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-12-08T02:55:45.929Z,1765162545.929 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:45.929Z,1765162545.929 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1341 2025-12-08T02:55:46.924Z,1765162546.924 [CTD_Seabird](INFO): Powering down 2025-12-08T02:55:46.943Z,1765162546.943 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:46.948Z,1765162546.948 [CTD_Seabird](INFO): Powering down 2025-12-08T02:55:46.960Z,1765162546.960 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:46.961Z,1765162546.961 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-12-08T02:55:46.961Z,1765162546.961 [logger ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:46.962Z,1765162546.962 [logger](INFO): Join timeout helper Thread ID is 1342 2025-12-08T02:55:46.995Z,1765162546.995 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:47.020Z,1765162547.020 [logger ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.041Z,1765162547.041 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-12-08T02:55:47.041Z,1765162547.041 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.041Z,1765162547.041 [CommandLine](INFO): Join timeout helper Thread ID is 1343 2025-12-08T02:55:47.048Z,1765162547.048 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:47.048Z,1765162547.048 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.065Z,1765162547.065 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-12-08T02:55:47.065Z,1765162547.065 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.065Z,1765162547.065 [CommandExec](INFO): Join timeout helper Thread ID is 1344 2025-12-08T02:55:47.066Z,1765162547.066 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-12-08T02:55:47.066Z,1765162547.066 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.067Z,1765162547.067 [controlThread](INFO): Join timeout helper Thread ID is 1345 2025-12-08T02:55:47.154Z,1765162547.154 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-12-08T02:55:47.154Z,1765162547.154 [controlThread](DEBUG): Uninitializing ControlThread 2025-12-08T02:55:47.155Z,1765162547.155 [AHRS_M2](INFO): Powering down 2025-12-08T02:55:47.364Z,1765162547.364 [DVL_micro](INFO): Powering down 2025-12-08T02:55:47.365Z,1765162547.365 [NAL9602](INFO): Powering down 2025-12-08T02:55:47.366Z,1765162547.366 [Sonardyne_Nano](INFO): Powering down 2025-12-08T02:55:47.572Z,1765162547.572 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-12-08T02:55:47.573Z,1765162547.573 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-12-08T02:55:47.573Z,1765162547.573 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-12-08T02:55:47.574Z,1765162547.574 [MissionManager](INFO): Uninitializing Mission Default 2025-12-08T02:55:47.574Z,1765162547.574 [Default] Stopped 2025-12-08T02:55:47.574Z,1765162547.574 [Default](DEBUG): Aggregate::uninitialize Default 2025-12-08T02:55:47.574Z,1765162547.574 [Default:A.Wait] Stopped 2025-12-08T02:55:47.574Z,1765162547.574 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-12-08T02:55:47.574Z,1765162547.574 [Default:B.GoToSurface] Stopped 2025-12-08T02:55:47.574Z,1765162547.574 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-12-08T02:55:47.577Z,1765162547.577 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-12-08T02:55:47.578Z,1765162547.578 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-12-08T02:55:47.578Z,1765162547.578 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-12-08T02:55:47.578Z,1765162547.578 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-12-08T02:55:47.579Z,1765162547.579 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-12-08T02:55:47.579Z,1765162547.579 [BuoyancyServo](INFO): Powering down 2025-12-08T02:55:47.592Z,1765162547.592 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-12-08T02:55:47.592Z,1765162547.592 [ElevatorServo](INFO): Powering down 2025-12-08T02:55:47.593Z,1765162547.593 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-12-08T02:55:47.593Z,1765162547.593 [MassServo](INFO): Powering down 2025-12-08T02:55:47.594Z,1765162547.594 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-12-08T02:55:47.594Z,1765162547.594 [RudderServo](INFO): Powering down 2025-12-08T02:55:47.595Z,1765162547.595 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-12-08T02:55:47.595Z,1765162547.595 [ThrusterHE](INFO): Powering down 2025-12-08T02:55:47.596Z,1765162547.596 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-12-08T02:55:47.596Z,1765162547.596 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-12-08T02:55:47.596Z,1765162547.596 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-12-08T02:55:47.596Z,1765162547.596 [CBIT](DEBUG): Powering off loads. 2025-12-08T02:55:47.608Z,1765162547.608 [CBIT](DEBUG): Disabling WDT. 2025-12-08T02:55:47.620Z,1765162547.620 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-12-08T02:55:47.620Z,1765162547.620 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-12-08T02:55:47.621Z,1765162547.621 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.777Z,1765162547.777 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-12-08T02:55:47.777Z,1765162547.777 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-12-08T02:55:47.793Z,1765162547.793 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.800Z,1765162547.800 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.836Z,1765162547.836 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.839Z,1765162547.839 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.847Z,1765162547.847 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.854Z,1765162547.854 [DAT ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.897Z,1765162547.897 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:47.954Z,1765162547.954 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-12-08T02:55:48.055Z,1765162548.055 [logger ThreadHandler](INFO): Thread cancelled.