2025-02-21T02:49:29.958Z,1740106169.958 [MissionManager](INFO): Uninitializing Mission keepstation 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation] Stopped 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes] Stopped 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-02-21T02:49:29.958Z,1740106169.958 [keepstation:BackseatDriver] Stopped 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:PowerOnly] Stopped 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:PowerOnly:E.Wait] Stopped 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:H.Pitch] Stopped 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:KeepStation] Stopped 2025-02-21T02:49:29.959Z,1740106169.959 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2025-02-21T02:49:29.960Z,1740106169.960 [keepstation:KeepStation:A] Stopped 2025-02-21T02:49:29.960Z,1740106169.960 [keepstation:KeepStation:B.Pitch] Stopped 2025-02-21T02:49:29.960Z,1740106169.960 [keepstation:KeepStation:C.KeepStation] Stopped 2025-02-21T02:49:29.960Z,1740106169.960 [keepstation:KeepStation:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2025-02-21T02:49:29.960Z,1740106169.960 [keepstation:KeepStation:D.Wait] Stopped 2025-02-21T02:49:29.960Z,1740106169.960 [keepstation:KeepStation:D.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T02:49:30.013Z,1740106170.013 [CommandExec](IMPORTANT): got command restart logs 2025-02-21T02:49:30.186Z,1740106170.186 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-21T02:49:30.186Z,1740106170.186 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-21T02:49:30.371Z,1740106170.371 [MissionManager](IMPORTANT): Started mission Default 2025-02-21T02:49:30.371Z,1740106170.371 [Default] Running Loop=1 2025-02-21T02:49:30.371Z,1740106170.371 [Default](DEBUG): Aggregate::initialize Default 2025-02-21T02:49:30.372Z,1740106170.372 [Default:B.GoToSurface] Running Loop=1 2025-02-21T02:49:30.372Z,1740106170.372 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T02:49:30.372Z,1740106170.372 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-21T02:49:30.372Z,1740106170.372 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-21T02:49:30.372Z,1740106170.372 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-21T02:49:30.373Z,1740106170.373 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-21T02:49:30.373Z,1740106170.373 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T02:49:30.373Z,1740106170.373 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T02:49:30.374Z,1740106170.374 [Default:A.Wait] Running Loop=1 2025-02-21T02:49:30.374Z,1740106170.374 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-02-21T02:49:30.879Z,1740106170.879 [Radio_Surface](INFO): Powering up 2025-02-21T02:49:36.647Z,1740106176.647 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T02:49:38.124Z,1740106178.124 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl 2025-02-21T02:49:38.124Z,1740106178.124 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl 2025-02-21T02:49:38.124Z,1740106178.124 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl 2025-02-21T02:49:38.125Z,1740106178.125 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl 2025-02-21T02:49:39.562Z,1740106179.562 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into: 4 45 NaN NaN 30 15 4 0.75 200 45 2 2025-02-21T02:49:39.576Z,1740106179.576 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h 2025-02-21T02:49:39.578Z,1740106179.578 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min 2025-02-21T02:49:39.581Z,1740106179.581 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg 2025-02-21T02:49:39.583Z,1740106179.583 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg 2025-02-21T02:49:39.593Z,1740106179.593 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m 2025-02-21T02:49:39.627Z,1740106179.627 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m 2025-02-21T02:49:39.630Z,1740106179.630 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m 2025-02-21T02:49:39.636Z,1740106179.636 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s 2025-02-21T02:49:39.638Z,1740106179.638 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m 2025-02-21T02:49:39.653Z,1740106179.653 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m 2025-02-21T02:49:39.664Z,1740106179.664 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km 2025-02-21T02:49:39.664Z,1740106179.664 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2025-02-21T02:49:39.664Z,1740106179.664 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2025-02-21T02:49:39.665Z,1740106179.665 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2025-02-21T02:49:40.057Z,1740106180.057 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into: 1 10 20 NaN 1 1000 7 30 0 last time_fix was: first GPS update timeout Comms timed out after minutes second GPS update timeout 2025-02-21T02:49:40.082Z,1740106180.082 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h 2025-02-21T02:49:40.097Z,1740106180.097 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min 2025-02-21T02:49:40.102Z,1740106180.102 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg 2025-02-21T02:49:40.112Z,1740106180.112 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s 2025-02-21T02:49:40.114Z,1740106180.114 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s 2025-02-21T02:49:40.129Z,1740106180.129 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1000.000000 s 2025-02-21T02:49:40.131Z,1740106180.131 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min 2025-02-21T02:49:40.138Z,1740106180.138 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min 2025-02-21T02:49:40.160Z,1740106180.160 [keepstation:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-02-21T02:49:40.192Z,1740106180.192 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-02-21T02:49:40.192Z,1740106180.192 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-02-21T02:49:40.193Z,1740106180.193 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-02-21T02:49:40.271Z,1740106180.271 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2025-02-21T02:49:40.279Z,1740106180.279 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m 2025-02-21T02:49:40.282Z,1740106180.282 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2025-02-21T02:49:40.284Z,1740106180.284 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m 2025-02-21T02:49:40.286Z,1740106180.286 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-02-21T02:49:40.287Z,1740106180.287 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-02-21T02:49:40.293Z,1740106180.293 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-02-21T02:49:40.299Z,1740106180.299 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-02-21T02:49:40.306Z,1740106180.306 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-02-21T02:49:40.306Z,1740106180.306 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-02-21T02:49:40.308Z,1740106180.308 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-02-21T02:49:40.326Z,1740106180.326 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-02-21T02:49:40.357Z,1740106180.357 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool 2025-02-21T02:49:40.363Z,1740106180.363 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-02-21T02:49:40.366Z,1740106180.366 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-02-21T02:49:40.366Z,1740106180.366 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-02-21T02:49:40.371Z,1740106180.371 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-02-21T02:49:40.558Z,1740106180.558 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-02-21T02:49:40.566Z,1740106180.566 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool 2025-02-21T02:49:40.569Z,1740106180.569 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool 2025-02-21T02:49:40.570Z,1740106180.570 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool 2025-02-21T02:49:40.572Z,1740106180.572 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool 2025-02-21T02:49:40.575Z,1740106180.575 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool 2025-02-21T02:49:40.582Z,1740106180.582 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-02-21T02:49:40.584Z,1740106180.584 [keepstation:H.Pitch](DEBUG): Construct. 2025-02-21T02:49:40.614Z,1740106180.614 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Construct Buoyancy. 2025-02-21T02:49:40.625Z,1740106180.625 [keepstation:TransitToStation:B.Pitch](DEBUG): Construct. 2025-02-21T02:49:40.630Z,1740106180.630 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Construct. 2025-02-21T02:49:40.632Z,1740106180.632 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2025-02-21T02:49:40.646Z,1740106180.646 [keepstation:KeepStation:B.Pitch](DEBUG): Construct. 2025-02-21T02:49:40.650Z,1740106180.650 [keepstation:KeepStation:C.KeepStation](DEBUG): Construct KeepStation. 2025-02-21T02:49:40.655Z,1740106180.655 [keepstation:KeepStation:D.Wait](DEBUG): Construct Wait. 2025-02-21T02:49:40.666Z,1740106180.666 [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. """ MaxDepth = 45 meter """ Maximum allowable depth during the mission. """ MinOffshore = 2 kilometer """ Minimum distance from the shoreline to maintain """ } 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 } call id="StartingMission" refId="NeedComms" aggregate TransitToStation { """ Need a separate aggregate for transit if we want to specify a different depth for the approach. """ 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 } behavior Guidance:Waypoint id="Wpt1" { run in sequence set latitude = Latitude set longitude = Longitude } } call id="OnStation" refId="NeedComms" aggregate KeepStation { run in sequence 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 } 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-02-21T02:49:40.667Z,1740106180.667 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation 2025-02-21T02:49:43.689Z,1740106183.689 [Default:A.Wait](INFO): Done Waiting. 2025-02-21T02:49:43.689Z,1740106183.689 [Default:A.Wait] Stopped 2025-02-21T02:49:43.689Z,1740106183.689 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T02:49:48.345Z,1740106188.345 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-21T02:49:48.345Z,1740106188.345 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-21T02:49:48.346Z,1740106188.346 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-21T02:50:01.340Z,1740106201.340 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 60 minute 2025-02-21T02:50:01.341Z,1740106201.341 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 60 minute 2025-02-21T02:50:01.341Z,1740106201.341 [CommandExec](IMPORTANT): got command set keepstation.Latitude 36.797 degree 2025-02-21T02:50:01.342Z,1740106201.342 [CommandExec](IMPORTANT): got command set keepstation.Longitude -121.847 degree 2025-02-21T02:50:01.343Z,1740106201.343 [CommandExec](IMPORTANT): got command set keepstation.DepthDeadband 10 meter 2025-02-21T02:50:06.767Z,1740106206.767 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:50:08.342Z,1740106208.342 [CommandExec](IMPORTANT): got command set keepstation:BackseatDriver.EnableBackseat 1 bool 2025-02-21T02:50:08.343Z,1740106208.343 [CommandExec](IMPORTANT): got command run 2025-02-21T02:50:08.345Z,1740106208.345 [CommandExec](IMPORTANT): Running 2025-02-21T02:50:08.657Z,1740106208.657 [Default] Stopped 2025-02-21T02:50:08.657Z,1740106208.657 [Default](DEBUG): Aggregate::uninitialize Default 2025-02-21T02:50:08.657Z,1740106208.657 [Default:B.GoToSurface] Stopped 2025-02-21T02:50:08.657Z,1740106208.657 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T02:50:08.657Z,1740106208.657 [MissionManager](IMPORTANT): Started mission keepstation 2025-02-21T02:50:08.657Z,1740106208.657 [keepstation] Running Loop=1 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation](DEBUG): Aggregate::initialize keepstation 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes] Running Loop=1 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-02-21T02:50:08.658Z,1740106208.658 [keepstation:BackseatDriver] Running Loop=1 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:PowerOnly] Running Loop=1 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:PowerOnly:A] Running Loop=1 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:PowerOnly:B] Running Loop=1 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:PowerOnly:C] Running Loop=1 2025-02-21T02:50:08.659Z,1740106208.659 [keepstation:PowerOnly:D] Running Loop=1 2025-02-21T02:50:08.660Z,1740106208.660 [keepstation:PowerOnly:E.Wait] Running Loop=1 2025-02-21T02:50:08.660Z,1740106208.660 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-02-21T02:50:08.660Z,1740106208.660 [keepstation:H.Pitch] Running Loop=1 2025-02-21T02:50:08.660Z,1740106208.660 [keepstation:H.Pitch](DEBUG): Initialize. 2025-02-21T02:50:08.660Z,1740106208.660 [keepstation:B] Running Loop=1 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:H.Pitch] Running Loop=1 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:PowerOnly] Running Loop=1 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:PowerOnly:D] Stopped 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:PowerOnly:C] Stopped 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:PowerOnly:B] Stopped 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:PowerOnly:A] Stopped 2025-02-21T02:50:08.661Z,1740106208.661 [keepstation:BackseatDriver] Running Loop=1 2025-02-21T02:50:08.662Z,1740106208.662 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2025-02-21T02:50:08.677Z,1740106208.677 [keepstation:StandardEnvelopes] Running Loop=1 2025-02-21T02:50:08.677Z,1740106208.677 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-02-21T02:50:08.677Z,1740106208.677 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-02-21T02:50:08.677Z,1740106208.677 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-02-21T02:50:08.678Z,1740106208.678 [keepstation:B] Stopped 2025-02-21T02:50:08.678Z,1740106208.678 [keepstation:D] Running Loop=1 2025-02-21T02:50:08.752Z,1740106208.752 [BackseatComponent](INFO): Powering up 2025-02-21T02:50:08.752Z,1740106208.752 [BackseatComponent](INFO): Subscribing to LCM channels. 2025-02-21T02:50:09.083Z,1740106209.083 [keepstation:D] Stopped 2025-02-21T02:50:09.083Z,1740106209.083 [keepstation:E] Running Loop=1 2025-02-21T02:50:09.488Z,1740106209.488 [keepstation:E] Stopped 2025-02-21T02:50:09.488Z,1740106209.488 [keepstation:StartingMission] Running Loop=1 2025-02-21T02:50:09.488Z,1740106209.488 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission 2025-02-21T02:50:09.892Z,1740106209.892 [keepstation:NeedComms] Running Loop=1 2025-02-21T02:50:09.892Z,1740106209.892 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-02-21T02:50:09.892Z,1740106209.892 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-02-21T02:50:09.892Z,1740106209.892 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T02:50:09.893Z,1740106209.893 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-02-21T02:50:09.893Z,1740106209.893 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-02-21T02:50:09.893Z,1740106209.893 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-02-21T02:50:09.894Z,1740106209.894 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-02-21T02:50:09.894Z,1740106209.894 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T02:50:09.894Z,1740106209.894 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T02:50:09.894Z,1740106209.894 [keepstation:NeedComms:A] Running Loop=1 2025-02-21T02:50:09.896Z,1740106209.896 [keepstation:NeedComms:A](INFO): last time_fix was: 1740103725.000000 second since 1970/01/01T00:00:00Z 2025-02-21T02:50:09.896Z,1740106209.896 [keepstation:NeedComms:A] Stopped 2025-02-21T02:50:10.304Z,1740106210.304 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2025-02-21T02:50:37.891Z,1740106237.891 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:51:04.352Z,1740106264.352 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20250221T025108 2025-02-21T02:51:09.031Z,1740106269.031 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:51:10.031Z,1740106270.031 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T02:51:10.263Z,1740106270.263 [Radio_Surface](INFO): Powering down 2025-02-21T02:51:36.053Z,1740106296.053 [keepstation:NeedComms:C] Running Loop=1 2025-02-21T02:51:36.456Z,1740106296.456 [keepstation:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-21T02:51:36.524Z,1740106296.524 [Radio_Surface](INFO): Powering up 2025-02-21T02:51:42.159Z,1740106302.159 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T02:52:01.611Z,1740106321.611 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1975 2025-02-21T02:52:12.279Z,1740106332.279 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:52:34.722Z,1740106354.722 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12987, MT Status=1, MTMSN=262 2025-02-21T02:52:34.722Z,1740106354.722 [NAL9602](INFO): Data available in MT queue 2025-02-21T02:52:35.456Z,1740106355.456 [NAL9602](INFO): Received command: sched "set sci2_slowyo_test.SlowYoDiveAngle 10 degree;set sci2_slowyo_test.Speed SpeedControl.rollOptimum m/s;set sci2_slowyo_test.SlowYoMaxDepth 150 m;set sci2_slowyo_test.SlowYoTurningWindow 30 m;set sci2_slowyo_test.MassDefault NaN mm" 2269q 2 3 2025-02-21T02:52:35.521Z,1740106355.521 [CommandExec](IMPORTANT): got command schedule "set sci2_slowyo_test.SlowYoDiveAngle 10 degree;set sci2_slowyo_test.Speed SpeedControl.rollOptimum m/s;set sci2_slowyo_test.SlowYoMaxDepth 150 m;set sci2_slowyo_test.SlowYoTurningWindow 30 m;set sci2_slowyo_test.MassDefault NaN mm" 2269q 2 3.000000 2025-02-21T02:52:35.522Z,1740106355.522 [CommandExec](IMPORTANT): Scheduling command #2 of 3 with id=2269q 2025-02-21T02:52:35.523Z,1740106355.523 [CommandExec](IMPORTANT): Scheduled #17 (#2 of 3 with id='2269q'): "set sci2_slowyo_test.SlowYoDiveAngle 10 degree;set sci2_slowyo_test.Speed SpeedControl.rollOptimum m/s;set sci2_slowyo_test.SlowYoMaxDepth 150 m;set sci2_slowyo_test.SlowYoTurningWindow 30 m;set sci2_slowyo_test.MassDefault NaN mm", AFTER MISSION 2025-02-21T02:52:36.489Z,1740106356.489 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,025235.00,A,3647.63671,N,12150.91577,W,1.166,147.17,210225,,,A*74 2025-02-21T02:52:36.491Z,1740106356.491 [NAL9602](INFO): GPS fix at 20250221T025235: (36.793945, -121.848596) 2025-02-21T02:52:36.508Z,1740106356.508 [keepstation:NeedComms:C] Stopped 2025-02-21T02:52:36.508Z,1740106356.508 [keepstation:NeedComms:D] Running Loop=1 2025-02-21T02:52:36.960Z,1740106356.960 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-02-21T02:52:43.409Z,1740106363.409 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:52:57.352Z,1740106377.352 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12988, MT Status=1, MTMSN=263 2025-02-21T02:52:57.399Z,1740106377.399 [NAL9602](INFO): Sent 204 bytes from file Logs/20250221T014851/Courier0006.lzma 2025-02-21T02:52:57.399Z,1740106377.399 [NAL9602](INFO): Packets left to send: 0 2025-02-21T02:52:57.996Z,1740106377.996 [NAL9602](INFO): Received command: sched "set sci2_slowyo_test.MinAltitude 20 m;set sci2_slowyo_test.MaxDepth 190 m;set sci2_slowyo_test:BackseatDriver.EnableBackseat 1 bool;run" 2269q 3 3 2025-02-21T02:52:58.013Z,1740106378.013 [CommandExec](IMPORTANT): got command schedule "set sci2_slowyo_test.MinAltitude 20 m;set sci2_slowyo_test.MaxDepth 190 m;set sci2_slowyo_test:BackseatDriver.EnableBackseat 1 bool;run" 2269q 3 3.000000 2025-02-21T02:52:58.013Z,1740106378.013 [CommandExec](IMPORTANT): Scheduling command #3 of 3 with id=2269q 2025-02-21T02:52:58.014Z,1740106378.014 [CommandExec](IMPORTANT): Scheduled #18 (#3 of 3 with id='2269q'): "set sci2_slowyo_test.MinAltitude 20 m;set sci2_slowyo_test.MaxDepth 190 m;set sci2_slowyo_test:BackseatDriver.EnableBackseat 1 bool;run", AFTER MISSION 2025-02-21T02:53:08.929Z,1740106388.929 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12989, MT Status=1, MTMSN=264 2025-02-21T02:53:08.981Z,1740106388.981 [NAL9602](INFO): Sent 268 bytes from file Logs/20250221T024930/Courier0000.lzma 2025-02-21T02:53:08.981Z,1740106388.981 [NAL9602](INFO): Packets left to send: 0 2025-02-21T02:53:11.232Z,1740106391.232 [NAL9602](INFO): Received command: sched "restart logs" 2025-02-21T02:53:11.329Z,1740106391.329 [CommandExec](IMPORTANT): got command schedule "restart logs" 2025-02-21T02:53:11.330Z,1740106391.330 [CommandExec](IMPORTANT): Scheduled #19: "restart logs", AFTER MISSION 2025-02-21T02:53:14.533Z,1740106394.533 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:53:26.461Z,1740106406.461 [NAL9602](INFO): SBD MO Status=1, MOMSN=12990, MT Status=0, MTMSN=0 2025-02-21T02:53:26.515Z,1740106406.515 [NAL9602](INFO): Sent 305 bytes from file Logs/20250221T014851/Express0007.lzma 2025-02-21T02:53:26.516Z,1740106406.516 [NAL9602](INFO): Packets left to send: 0 2025-02-21T02:53:34.908Z,1740106414.908 [NAL9602](INFO): SBD MO Status=1, MOMSN=12991, MT Status=0, MTMSN=0 2025-02-21T02:53:34.955Z,1740106414.955 [NAL9602](INFO): Sent 332 bytes from file Logs/20250221T024930/Express0001.lzma 2025-02-21T02:53:34.956Z,1740106414.956 [NAL9602](INFO): Packets left to send: 2 2025-02-21T02:53:45.442Z,1740106425.442 [NAL9602](INFO): SBD MO Status=1, MOMSN=12992, MT Status=0, MTMSN=0 2025-02-21T02:53:45.495Z,1740106425.495 [NAL9602](INFO): Sent 332 bytes from file Logs/20250221T024930/Express0001.lzma 2025-02-21T02:53:45.495Z,1740106425.495 [NAL9602](INFO): Packets left to send: 1 2025-02-21T02:53:45.664Z,1740106425.664 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:53:56.236Z,1740106436.236 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003170 2025-02-21T02:53:56.310Z,1740106436.310 [NAL9602](INFO): SBD MO Status=1, MOMSN=12993, MT Status=0, MTMSN=0 2025-02-21T02:53:56.368Z,1740106436.368 [NAL9602](INFO): Sent 251 bytes from file Logs/20250221T024930/Express0001.lzma 2025-02-21T02:53:56.368Z,1740106436.368 [NAL9602](INFO): Packets left to send: 0 2025-02-21T02:54:04.975Z,1740106444.975 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250221T024930/Courier0003.lzma 2025-02-21T02:54:05.977Z,1740106445.977 [DataOverHttps](INFO): Moved sent file to Logs/20250221T024930/Courier0003.lzma.bak 2025-02-21T02:54:05.977Z,1740106445.977 [DataOverHttps](INFO): SBD MOMSN=23970487 2025-02-21T02:54:25.200Z,1740106465.200 [DataOverHttps](INFO): Sending 351 bytes from file Logs/20250221T024930/Express0004.lzma 2025-02-21T02:54:26.201Z,1740106466.201 [DataOverHttps](INFO): Moved sent file to Logs/20250221T024930/Express0004.lzma.bak 2025-02-21T02:54:26.201Z,1740106466.201 [DataOverHttps](INFO): SBD MOMSN=23970489 2025-02-21T02:54:27.704Z,1740106467.704 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T02:54:27.748Z,1740106467.748 [keepstation:NeedComms:D] Stopped 2025-02-21T02:54:27.748Z,1740106467.748 [keepstation:NeedComms:E] Running Loop=1 2025-02-21T02:54:28.124Z,1740106468.124 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-21T02:54:29.730Z,1740106469.730 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,025429.00,A,3647.62279,N,12150.91329,W,1.011,177.21,210225,,,A*78 2025-02-21T02:54:29.733Z,1740106469.733 [NAL9602](INFO): GPS fix at 20250221T025429: (36.793713, -121.848555) 2025-02-21T02:54:29.764Z,1740106469.764 [keepstation:NeedComms:E] Stopped 2025-02-21T02:54:29.765Z,1740106469.765 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-02-21T02:54:29.765Z,1740106469.765 [keepstation:NeedComms] Stopped 2025-02-21T02:54:29.765Z,1740106469.765 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-02-21T02:54:29.765Z,1740106469.765 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-02-21T02:54:29.765Z,1740106469.765 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:StartingMission] Stopped 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:TransitToStation] Running Loop=1 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-02-21T02:54:30.172Z,1740106470.172 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-02-21T02:54:30.173Z,1740106470.173 [keepstation:TransitToStation:B.Pitch](DEBUG): Initialize. 2025-02-21T02:54:30.173Z,1740106470.173 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-02-21T02:54:30.173Z,1740106470.173 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Initialize. 2025-02-21T02:54:30.173Z,1740106470.173 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2025-02-21T02:54:30.173Z,1740106470.173 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2025-02-21T02:54:30.174Z,1740106470.174 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000 2025-02-21T02:54:30.562Z,1740106470.562 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm. 2025-02-21T02:54:30.577Z,1740106470.577 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000 2025-02-21T02:54:30.577Z,1740106470.577 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-02-21T02:54:30.577Z,1740106470.577 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-02-21T02:54:30.578Z,1740106470.578 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-02-21T02:54:46.812Z,1740106486.812 [NAL9602](INFO): SBD MO Status=0, MOMSN=12994, MT Status=0, MTMSN=0 2025-02-21T02:54:46.812Z,1740106486.812 [NAL9602](INFO): No messages in MT queue 2025-02-21T02:55:17.585Z,1740106517.585 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T02:55:58.596Z,1740106558.596 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:56:05.430Z,1740106565.430 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.simrad_data_logging_rate with code: 1976 2025-02-21T02:56:26.163Z,1740106586.163 [Radio_Surface](INFO): Powering down 2025-02-21T02:56:29.719Z,1740106589.719 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:56:30.724Z,1740106590.724 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T02:58:18.160Z,1740106698.160 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.754532 2025-02-21T03:04:17.966Z,1740107057.966 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000 2025-02-21T03:04:17.966Z,1740107057.966 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2025-02-21T03:04:17.966Z,1740107057.966 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2025-02-21T03:04:17.968Z,1740107057.968 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation 2025-02-21T03:04:17.968Z,1740107057.968 [keepstation:TransitToStation] Stopped 2025-02-21T03:04:17.968Z,1740107057.968 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:TransitToStation:A.Buoyancy] Stopped 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:TransitToStation:B.Pitch] Stopped 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:TransitToStation:C.SetSpeed] Stopped 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Uninitialize. 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:OnStation] Running Loop=1 2025-02-21T03:04:17.969Z,1740107057.969 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation 2025-02-21T03:04:18.376Z,1740107058.376 [keepstation:NeedComms] Running Loop=1 2025-02-21T03:04:18.376Z,1740107058.376 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-02-21T03:04:18.376Z,1740107058.376 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-02-21T03:04:18.376Z,1740107058.376 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T03:04:18.377Z,1740107058.377 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-02-21T03:04:18.377Z,1740107058.377 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-02-21T03:04:18.377Z,1740107058.377 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-02-21T03:04:18.378Z,1740107058.378 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-02-21T03:04:18.378Z,1740107058.378 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T03:04:18.378Z,1740107058.378 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T03:04:18.378Z,1740107058.378 [keepstation:NeedComms:A] Running Loop=1 2025-02-21T03:04:18.380Z,1740107058.380 [keepstation:NeedComms:A](INFO): last time_fix was: 1740106469.000000 second since 1970/01/01T00:00:00Z 2025-02-21T03:04:18.380Z,1740107058.380 [keepstation:NeedComms:A] Stopped 2025-02-21T03:05:07.717Z,1740107107.717 [keepstation:NeedComms:C] Running Loop=1 2025-02-21T03:05:08.371Z,1740107108.371 [Radio_Surface](INFO): Powering up 2025-02-21T03:05:13.851Z,1740107113.851 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T03:05:43.980Z,1740107143.980 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:06:00.934Z,1740107160.934 [NAL9602](INFO): SBD MO Status=0, MOMSN=12995, MT Status=0, MTMSN=0 2025-02-21T03:06:00.934Z,1740107160.934 [NAL9602](INFO): No messages in MT queue 2025-02-21T03:06:02.143Z,1740107162.143 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,030601.00,A,3647.76250,N,12150.77796,W,0.253,167.66,210225,,,A*75 2025-02-21T03:06:02.145Z,1740107162.145 [NAL9602](INFO): GPS fix at 20250221T030601: (36.796042, -121.846299) 2025-02-21T03:06:02.160Z,1740107162.160 [keepstation:NeedComms:C] Stopped 2025-02-21T03:06:02.160Z,1740107162.160 [keepstation:NeedComms:D] Running Loop=1 2025-02-21T03:06:15.119Z,1740107175.119 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:06:18.118Z,1740107178.118 [NAL9602](INFO): SBD MO Status=2, MOMSN=12996, MT Status=2, MTMSN=0 2025-02-21T03:06:18.119Z,1740107178.119 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T03:06:37.325Z,1740107197.325 [NAL9602](INFO): SBD MO Status=1, MOMSN=12996, MT Status=0, MTMSN=0 2025-02-21T03:06:37.371Z,1740107197.371 [NAL9602](INFO): Sent 73 bytes from file Logs/20250221T024930/Courier0006.lzma 2025-02-21T03:06:37.372Z,1740107197.372 [NAL9602](INFO): Packets left to send: 0 2025-02-21T03:06:46.244Z,1740107206.244 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:06:47.898Z,1740107207.898 [NAL9602](INFO): SBD MO Status=1, MOMSN=12997, MT Status=0, MTMSN=0 2025-02-21T03:06:47.947Z,1740107207.947 [NAL9602](INFO): Sent 237 bytes from file Logs/20250221T024930/Express0007.lzma 2025-02-21T03:06:47.948Z,1740107207.948 [NAL9602](INFO): Packets left to send: 0 2025-02-21T03:07:02.750Z,1740107222.750 [NAL9602](INFO): SBD MO Status=0, MOMSN=12998, MT Status=0, MTMSN=0 2025-02-21T03:07:02.836Z,1740107222.836 [keepstation:NeedComms:D] Stopped 2025-02-21T03:07:02.837Z,1740107222.837 [keepstation:NeedComms:E] Running Loop=1 2025-02-21T03:07:05.170Z,1740107225.170 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,030704.00,A,3647.75659,N,12150.76977,W,0.389,143.29,210225,,,A*74 2025-02-21T03:07:05.172Z,1740107225.172 [NAL9602](INFO): GPS fix at 20250221T030704: (36.795943, -121.846163) 2025-02-21T03:07:05.213Z,1740107225.213 [keepstation:NeedComms:E] Stopped 2025-02-21T03:07:05.214Z,1740107225.214 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-02-21T03:07:05.214Z,1740107225.214 [keepstation:NeedComms] Stopped 2025-02-21T03:07:05.214Z,1740107225.214 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-02-21T03:07:05.214Z,1740107225.214 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-02-21T03:07:05.214Z,1740107225.214 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:OnStation](INFO): Completed keepstation:OnStation 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:OnStation] Stopped 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:KeepStation] Running Loop=1 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:KeepStation:A] Running Loop=1 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:KeepStation:B.Pitch] Running Loop=1 2025-02-21T03:07:05.601Z,1740107225.601 [keepstation:KeepStation:B.Pitch](DEBUG): Initialize. 2025-02-21T03:07:05.602Z,1740107225.602 [keepstation:KeepStation:C.KeepStation] Running Loop=1 2025-02-21T03:07:05.602Z,1740107225.602 [keepstation:KeepStation:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2025-02-21T03:07:05.605Z,1740107225.605 [keepstation:KeepStation:D.Wait] Running Loop=1 2025-02-21T03:07:05.605Z,1740107225.605 [keepstation:KeepStation:D.Wait](DEBUG): Initialize Wait Component. 2025-02-21T03:07:06.017Z,1740107226.017 [keepstation:KeepStation:C.KeepStation] Running Loop=1 2025-02-21T03:07:06.017Z,1740107226.017 [keepstation:KeepStation:B.Pitch] Running Loop=1 2025-02-21T03:07:06.018Z,1740107226.018 [keepstation:KeepStation:A] Running Loop=1 2025-02-21T03:07:17.404Z,1740107237.404 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:07:37.192Z,1740107257.192 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T03:07:37.548Z,1740107257.548 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003188 2025-02-21T03:08:48.721Z,1740107328.721 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:09:19.848Z,1740107359.848 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:09:37.167Z,1740107377.167 [Radio_Surface](INFO): Powering down 2025-02-21T03:09:50.972Z,1740107390.972 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T03:09:51.976Z,1740107391.976 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T03:10:57.252Z,1740107457.252 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.739349 2025-02-21T03:35:07.530Z,1740108907.530 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:35:20.864Z,1740108920.864 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:35:33.790Z,1740108933.790 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:35:46.314Z,1740108946.314 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:35:59.646Z,1740108959.646 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:36:12.980Z,1740108972.980 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:36:25.502Z,1740108985.502 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T03:41:31.736Z,1740109291.736 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T03:41:33.772Z,1740109293.772 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-02-21T03:41:33.772Z,1740109293.772 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 6. 2025-02-21T03:41:33.774Z,1740109293.774 [BPC1](INFO): Received data from all battery sticks. 2025-02-21T03:47:59.336Z,1740109679.336 [CBIT](IMPORTANT): Beginning ground fault scan 2025-02-21T03:48:10.255Z,1740109690.255 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.000823 CHAN A1 (24V): -0.000715 CHAN A2 (12V): 0.000445 CHAN A3 (5V): -0.001807 CHAN B0 (3.3V): -0.001290 CHAN B1 (3.15aV): -0.001223 CHAN B2 (3.15bV): -0.001358 CHAN B3 (GND): -0.002305 OPEN: 0.004824 Full Scale: +/- 1 mA 2025-02-21T03:50:08.874Z,1740109808.874 [keepstation](INFO): Timed out from 2025-02-21T02:50:08.7Z 2025-02-21T03:50:08.874Z,1740109808.874 [MissionManager](INFO): keepstation is completed. 2025-02-21T03:50:08.874Z,1740109808.874 [MissionManager](INFO): Uninitializing Mission keepstation 2025-02-21T03:50:08.874Z,1740109808.874 [keepstation] Stopped 2025-02-21T03:50:08.874Z,1740109808.874 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2025-02-21T03:50:08.874Z,1740109808.874 [keepstation:StandardEnvelopes] Stopped 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:BackseatDriver] Stopped 2025-02-21T03:50:08.875Z,1740109808.875 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:PowerOnly] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:PowerOnly:E.Wait] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:H.Pitch] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation:A] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation:B.Pitch] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation:C.KeepStation] Stopped 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2025-02-21T03:50:08.876Z,1740109808.876 [keepstation:KeepStation:D.Wait] Stopped 2025-02-21T03:50:08.877Z,1740109808.877 [keepstation:KeepStation:D.Wait](DEBUG): Uninitialize Wait Component.