2025-02-21T01:48:51.365Z,1740102531.365 [CommandExec](IMPORTANT): got command restart logs 2025-02-21T01:48:51.675Z,1740102531.675 [MissionManager](IMPORTANT): Started mission Default 2025-02-21T01:48:51.675Z,1740102531.675 [Default] Running Loop=1 2025-02-21T01:48:51.675Z,1740102531.675 [Default](DEBUG): Aggregate::initialize Default 2025-02-21T01:48:51.676Z,1740102531.676 [Default:B.GoToSurface] Running Loop=1 2025-02-21T01:48:51.676Z,1740102531.676 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T01:48:51.676Z,1740102531.676 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-21T01:48:51.676Z,1740102531.676 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-21T01:48:51.676Z,1740102531.676 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-21T01:48:51.677Z,1740102531.677 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-21T01:48:51.677Z,1740102531.677 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T01:48:51.677Z,1740102531.677 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T01:48:51.678Z,1740102531.678 [Default:A.Wait] Running Loop=1 2025-02-21T01:48:51.678Z,1740102531.678 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-02-21T01:48:52.296Z,1740102532.296 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-21T01:48:52.297Z,1740102532.297 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-21T01:48:52.399Z,1740102532.399 [Radio_Surface](INFO): Powering up 2025-02-21T01:48:58.239Z,1740102538.239 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T01:48:59.473Z,1740102539.473 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl 2025-02-21T01:48:59.473Z,1740102539.473 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl 2025-02-21T01:48:59.474Z,1740102539.474 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl 2025-02-21T01:48:59.483Z,1740102539.483 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl 2025-02-21T01:49:00.884Z,1740102540.884 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into: 4 45 NaN NaN 30 15 4 0.75 200 45 2 2025-02-21T01:49:00.893Z,1740102540.893 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h 2025-02-21T01:49:00.899Z,1740102540.899 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min 2025-02-21T01:49:00.901Z,1740102540.901 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg 2025-02-21T01:49:00.908Z,1740102540.908 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg 2025-02-21T01:49:00.910Z,1740102540.910 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m 2025-02-21T01:49:00.948Z,1740102540.948 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m 2025-02-21T01:49:00.950Z,1740102540.950 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m 2025-02-21T01:49:00.961Z,1740102540.961 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s 2025-02-21T01:49:00.972Z,1740102540.972 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m 2025-02-21T01:49:00.980Z,1740102540.980 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m 2025-02-21T01:49:00.982Z,1740102540.982 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km 2025-02-21T01:49:00.994Z,1740102540.994 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2025-02-21T01:49:01.003Z,1740102541.003 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2025-02-21T01:49:01.005Z,1740102541.005 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2025-02-21T01:49:01.365Z,1740102541.365 [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-21T01:49:01.372Z,1740102541.372 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h 2025-02-21T01:49:01.374Z,1740102541.374 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min 2025-02-21T01:49:01.377Z,1740102541.377 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg 2025-02-21T01:49:01.380Z,1740102541.380 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s 2025-02-21T01:49:01.383Z,1740102541.383 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s 2025-02-21T01:49:01.386Z,1740102541.386 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1000.000000 s 2025-02-21T01:49:01.404Z,1740102541.404 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min 2025-02-21T01:49:01.407Z,1740102541.407 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min 2025-02-21T01:49:01.418Z,1740102541.418 [keepstation:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-02-21T01:49:01.484Z,1740102541.484 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-02-21T01:49:01.484Z,1740102541.484 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-02-21T01:49:01.485Z,1740102541.485 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-02-21T01:49:01.571Z,1740102541.571 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2025-02-21T01:49:01.575Z,1740102541.575 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m 2025-02-21T01:49:01.579Z,1740102541.579 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2025-02-21T01:49:01.581Z,1740102541.581 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m 2025-02-21T01:49:01.584Z,1740102541.584 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-02-21T01:49:01.584Z,1740102541.584 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-02-21T01:49:01.590Z,1740102541.590 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-02-21T01:49:01.598Z,1740102541.598 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-02-21T01:49:01.636Z,1740102541.636 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-02-21T01:49:01.636Z,1740102541.636 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-02-21T01:49:01.637Z,1740102541.637 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-02-21T01:49:01.662Z,1740102541.662 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-02-21T01:49:01.666Z,1740102541.666 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool 2025-02-21T01:49:01.668Z,1740102541.668 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-02-21T01:49:01.670Z,1740102541.670 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-02-21T01:49:01.670Z,1740102541.670 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-02-21T01:49:01.671Z,1740102541.671 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-02-21T01:49:01.870Z,1740102541.870 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-02-21T01:49:01.874Z,1740102541.874 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool 2025-02-21T01:49:01.876Z,1740102541.876 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool 2025-02-21T01:49:01.878Z,1740102541.878 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool 2025-02-21T01:49:01.880Z,1740102541.880 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool 2025-02-21T01:49:01.882Z,1740102541.882 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool 2025-02-21T01:49:01.889Z,1740102541.889 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-02-21T01:49:01.891Z,1740102541.891 [keepstation:H.Pitch](DEBUG): Construct. 2025-02-21T01:49:01.897Z,1740102541.897 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Construct Buoyancy. 2025-02-21T01:49:01.900Z,1740102541.900 [keepstation:TransitToStation:B.Pitch](DEBUG): Construct. 2025-02-21T01:49:01.904Z,1740102541.904 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Construct. 2025-02-21T01:49:01.906Z,1740102541.906 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2025-02-21T01:49:01.934Z,1740102541.934 [keepstation:KeepStation:B.Pitch](DEBUG): Construct. 2025-02-21T01:49:01.947Z,1740102541.947 [keepstation:KeepStation:C.KeepStation](DEBUG): Construct KeepStation. 2025-02-21T01:49:01.956Z,1740102541.956 [keepstation:KeepStation:D.Wait](DEBUG): Construct Wait. 2025-02-21T01:49:01.977Z,1740102541.977 [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-21T01:49:01.977Z,1740102541.977 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation 2025-02-21T01:49:05.016Z,1740102545.016 [Default:A.Wait](INFO): Done Waiting. 2025-02-21T01:49:05.016Z,1740102545.016 [Default:A.Wait] Stopped 2025-02-21T01:49:05.016Z,1740102545.016 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T01:49:10.480Z,1740102550.480 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-21T01:49:10.481Z,1740102550.481 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-21T01:49:10.481Z,1740102550.481 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-21T01:49:22.389Z,1740102562.389 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 60 minute 2025-02-21T01:49:22.389Z,1740102562.389 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 60 minute 2025-02-21T01:49:22.390Z,1740102562.390 [CommandExec](IMPORTANT): got command set keepstation.Latitude 36.797 degree 2025-02-21T01:49:22.391Z,1740102562.391 [CommandExec](IMPORTANT): got command set keepstation.Longitude -121.847 degree 2025-02-21T01:49:22.392Z,1740102562.392 [CommandExec](IMPORTANT): got command set keepstation.DepthDeadband 20 meter 2025-02-21T01:49:28.359Z,1740102568.359 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:49:29.546Z,1740102569.546 [CommandExec](IMPORTANT): got command set keepstation:BackseatDriver.EnableBackseat 1 bool 2025-02-21T01:49:29.546Z,1740102569.546 [CommandExec](IMPORTANT): got command run 2025-02-21T01:49:29.548Z,1740102569.548 [CommandExec](IMPORTANT): Running 2025-02-21T01:49:29.733Z,1740102569.733 [Default] Stopped 2025-02-21T01:49:29.733Z,1740102569.733 [Default](DEBUG): Aggregate::uninitialize Default 2025-02-21T01:49:29.733Z,1740102569.733 [Default:B.GoToSurface] Stopped 2025-02-21T01:49:29.733Z,1740102569.733 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T01:49:29.734Z,1740102569.734 [MissionManager](IMPORTANT): Started mission keepstation 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation] Running Loop=1 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation](DEBUG): Aggregate::initialize keepstation 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation:StandardEnvelopes] Running Loop=1 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-02-21T01:49:29.734Z,1740102569.734 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:BackseatDriver] Running Loop=1 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-02-21T01:49:29.735Z,1740102569.735 [keepstation:PowerOnly] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly:A] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly:B] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly:C] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly:D] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly:E.Wait] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:H.Pitch] Running Loop=1 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:H.Pitch](DEBUG): Initialize. 2025-02-21T01:49:29.736Z,1740102569.736 [keepstation:B] Running Loop=1 2025-02-21T01:49:29.737Z,1740102569.737 [keepstation:H.Pitch] Running Loop=1 2025-02-21T01:49:29.737Z,1740102569.737 [keepstation:PowerOnly] Running Loop=1 2025-02-21T01:49:29.738Z,1740102569.738 [keepstation:PowerOnly:D] Stopped 2025-02-21T01:49:29.738Z,1740102569.738 [keepstation:PowerOnly:C] Stopped 2025-02-21T01:49:29.738Z,1740102569.738 [keepstation:PowerOnly:B] Stopped 2025-02-21T01:49:29.738Z,1740102569.738 [keepstation:PowerOnly:A] Stopped 2025-02-21T01:49:29.738Z,1740102569.738 [keepstation:BackseatDriver] Running Loop=1 2025-02-21T01:49:29.738Z,1740102569.738 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2025-02-21T01:49:29.753Z,1740102569.753 [keepstation:StandardEnvelopes] Running Loop=1 2025-02-21T01:49:29.753Z,1740102569.753 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-02-21T01:49:29.753Z,1740102569.753 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-02-21T01:49:29.754Z,1740102569.754 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-02-21T01:49:29.754Z,1740102569.754 [keepstation:B] Stopped 2025-02-21T01:49:29.754Z,1740102569.754 [keepstation:D] Running Loop=1 2025-02-21T01:49:29.891Z,1740102569.891 [BackseatComponent](INFO): Powering up 2025-02-21T01:49:29.892Z,1740102569.892 [BackseatComponent](INFO): Subscribing to LCM channels. 2025-02-21T01:49:30.287Z,1740102570.287 [keepstation:D] Stopped 2025-02-21T01:49:30.288Z,1740102570.288 [keepstation:E] Running Loop=1 2025-02-21T01:49:30.687Z,1740102570.687 [keepstation:E] Stopped 2025-02-21T01:49:30.687Z,1740102570.687 [keepstation:StartingMission] Running Loop=1 2025-02-21T01:49:30.688Z,1740102570.688 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission 2025-02-21T01:49:31.100Z,1740102571.100 [keepstation:NeedComms] Running Loop=1 2025-02-21T01:49:31.100Z,1740102571.100 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-02-21T01:49:31.100Z,1740102571.100 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-02-21T01:49:31.101Z,1740102571.101 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T01:49:31.101Z,1740102571.101 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-02-21T01:49:31.101Z,1740102571.101 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-02-21T01:49:31.102Z,1740102571.102 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-02-21T01:49:31.102Z,1740102571.102 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-02-21T01:49:31.102Z,1740102571.102 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T01:49:31.103Z,1740102571.103 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T01:49:31.104Z,1740102571.104 [keepstation:NeedComms:A] Running Loop=1 2025-02-21T01:49:31.106Z,1740102571.106 [keepstation:NeedComms:A](INFO): last time_fix was: 1740100256.000000 second since 1970/01/01T00:00:00Z 2025-02-21T01:49:31.106Z,1740102571.106 [keepstation:NeedComms:A] Stopped 2025-02-21T01:49:31.504Z,1740102571.504 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2025-02-21T01:49:59.484Z,1740102599.484 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:50:30.607Z,1740102630.607 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:50:31.439Z,1740102631.439 [Radio_Surface](INFO): Powering down 2025-02-21T01:50:31.612Z,1740102631.612 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T01:50:39.761Z,1740102639.761 [keepstation:NeedComms:C] Running Loop=1 2025-02-21T01:50:40.168Z,1740102640.168 [keepstation:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-21T01:50:40.327Z,1740102640.327 [Radio_Surface](INFO): Powering up 2025-02-21T01:50:45.668Z,1740102645.668 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T01:51:15.787Z,1740102675.787 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:51:41.374Z,1740102701.374 [NAL9602](INFO): SBD MO Status=2, MOMSN=12983, MT Status=2, MTMSN=0 2025-02-21T01:51:41.374Z,1740102701.374 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T01:51:46.911Z,1740102706.911 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:52:18.039Z,1740102738.039 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:52:33.489Z,1740102753.489 [NAL9602](INFO): SBD MO Status=2, MOMSN=12983, MT Status=2, MTMSN=0 2025-02-21T01:52:33.489Z,1740102753.489 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T01:52:49.180Z,1740102769.180 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:52:50.085Z,1740102770.085 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=12983, MT Status=1, MTMSN=258 2025-02-21T01:52:50.086Z,1740102770.086 [NAL9602](INFO): Data available in MT queue 2025-02-21T01:52:50.812Z,1740102770.812 [NAL9602](INFO): Received command: sched "load Transport/keepstation.tl;set keepstation.MissionTimeout 60 min;set keepstation.NeedCommsTime 60 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;set keepstation.DepthDeadband 10 m" 2264q 1 2 2025-02-21T01:52:50.907Z,1740102770.907 [CommandExec](IMPORTANT): got command schedule "load Transport/keepstation.tl;set keepstation.MissionTimeout 60 min;set keepstation.NeedCommsTime 60 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;set keepstation.DepthDeadband 10 m" 2264q 1 2.000000 2025-02-21T01:52:50.908Z,1740102770.908 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=2264q 2025-02-21T01:52:50.909Z,1740102770.909 [CommandExec](IMPORTANT): Scheduled #13 (#1 of 2 with id='2264q'): "load Transport/keepstation.tl;set keepstation.MissionTimeout 60 min;set keepstation.NeedCommsTime 60 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;set keepstation.DepthDeadband 10 m", AFTER MISSION 2025-02-21T01:52:51.902Z,1740102771.902 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,015251.00,A,3647.60134,N,12150.84199,W,0.505,173.90,210225,,,A*78 2025-02-21T01:52:51.905Z,1740102771.905 [NAL9602](INFO): GPS fix at 20250221T015251: (36.793356, -121.847367) 2025-02-21T01:52:52.051Z,1740102772.051 [keepstation:NeedComms:C] Stopped 2025-02-21T01:52:52.052Z,1740102772.052 [keepstation:NeedComms:D] Running Loop=1 2025-02-21T01:52:52.401Z,1740102772.401 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-02-21T01:53:07.492Z,1740102787.492 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003758 2025-02-21T01:53:16.134Z,1740102796.134 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12984, MT Status=1, MTMSN=259 2025-02-21T01:53:16.207Z,1740102796.207 [NAL9602](INFO): Sent 202 bytes from file Logs/20250221T004812/Courier0009.lzma 2025-02-21T01:53:16.208Z,1740102796.208 [NAL9602](INFO): Packets left to send: 0 2025-02-21T01:53:16.700Z,1740102796.700 [NAL9602](INFO): Received command: sched "set keepstation:BackseatDriver.EnableBackseat 1 bool;run" 2264q 2 2 2025-02-21T01:53:16.736Z,1740102796.736 [CommandExec](IMPORTANT): got command schedule "set keepstation:BackseatDriver.EnableBackseat 1 bool;run" 2264q 2 2.000000 2025-02-21T01:53:16.737Z,1740102796.737 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=2264q 2025-02-21T01:53:16.738Z,1740102796.738 [CommandExec](IMPORTANT): Scheduled #14 (#2 of 2 with id='2264q'): "set keepstation:BackseatDriver.EnableBackseat 1 bool;run", AFTER MISSION 2025-02-21T01:53:18.396Z,1740102798.396 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20250221T014851/Courier0000.lzma 2025-02-21T01:53:18.929Z,1740102798.929 [DataOverHttps](INFO): Moved sent file to Logs/20250221T014851/Courier0000.lzma.bak 2025-02-21T01:53:18.929Z,1740102798.929 [DataOverHttps](INFO): SBD MOMSN=23970420 2025-02-21T01:53:35.369Z,1740102815.369 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20250221T004812/Express0010.lzma 2025-02-21T01:53:36.369Z,1740102816.369 [DataOverHttps](INFO): Moved sent file to Logs/20250221T004812/Express0010.lzma.bak 2025-02-21T01:53:36.369Z,1740102816.369 [DataOverHttps](INFO): SBD MOMSN=23970424 2025-02-21T01:53:47.376Z,1740102827.376 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T01:53:59.460Z,1740102839.460 [DataOverHttps](INFO): Sending 770 bytes from file Logs/20250221T014851/Express0001.lzma 2025-02-21T01:54:00.461Z,1740102840.461 [DataOverHttps](INFO): Moved sent file to Logs/20250221T014851/Express0001.lzma.bak 2025-02-21T01:54:00.462Z,1740102840.462 [DataOverHttps](INFO): SBD MOMSN=23970429 2025-02-21T01:54:01.948Z,1740102841.948 [keepstation:NeedComms:D] Stopped 2025-02-21T01:54:01.948Z,1740102841.948 [keepstation:NeedComms:E] Running Loop=1 2025-02-21T01:54:02.345Z,1740102842.345 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-21T01:54:03.946Z,1740102843.946 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,015403.00,A,3647.58804,N,12150.83887,W,0.641,200.04,210225,,,A*70 2025-02-21T01:54:03.948Z,1740102843.948 [NAL9602](INFO): GPS fix at 20250221T015403: (36.793134, -121.847314) 2025-02-21T01:54:03.996Z,1740102843.996 [keepstation:NeedComms:E] Stopped 2025-02-21T01:54:03.997Z,1740102843.997 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-02-21T01:54:03.997Z,1740102843.997 [keepstation:NeedComms] Stopped 2025-02-21T01:54:03.997Z,1740102843.997 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-02-21T01:54:03.997Z,1740102843.997 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-02-21T01:54:03.997Z,1740102843.997 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:StartingMission] Stopped 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:TransitToStation] Running Loop=1 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-02-21T01:54:04.385Z,1740102844.385 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-02-21T01:54:04.386Z,1740102844.386 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-02-21T01:54:04.386Z,1740102844.386 [keepstation:TransitToStation:B.Pitch](DEBUG): Initialize. 2025-02-21T01:54:04.386Z,1740102844.386 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-02-21T01:54:04.386Z,1740102844.386 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Initialize. 2025-02-21T01:54:04.386Z,1740102844.386 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2025-02-21T01:54:04.386Z,1740102844.386 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2025-02-21T01:54:04.392Z,1740102844.392 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000 2025-02-21T01:54:04.777Z,1740102844.777 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000 2025-02-21T01:54:04.777Z,1740102844.777 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-02-21T01:54:04.778Z,1740102844.778 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-02-21T01:54:04.778Z,1740102844.778 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-02-21T01:54:19.974Z,1740102859.974 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=12985, MT Status=1, MTMSN=260 2025-02-21T01:54:19.974Z,1740102859.974 [NAL9602](INFO): Data available in MT queue 2025-02-21T01:54:20.492Z,1740102860.492 [NAL9602](INFO): Received command: sched "restart logs" 2025-02-21T01:54:20.529Z,1740102860.529 [CommandExec](IMPORTANT): got command schedule "restart logs" 2025-02-21T01:54:20.530Z,1740102860.530 [CommandExec](IMPORTANT): Scheduled #15: "restart logs", AFTER MISSION 2025-02-21T01:54:48.319Z,1740102888.319 [BackseatComponent](FAULT): Failed to receive device response within the specified timeout. 2025-02-21T01:54:48.319Z,1740102888.319 [BackseatComponent] Communications Fault, FailCount= 1 2025-02-21T01:54:48.319Z,1740102888.319 [BackseatComponent](ERROR): Communications Fault 2025-02-21T01:54:48.319Z,1740102888.319 [Power24vConverter] Hardware Fault, FailCount= 1 2025-02-21T01:54:48.320Z,1740102888.320 [Power24vConverter](ERROR): Hardware Fault 2025-02-21T01:54:48.634Z,1740102888.634 [CBIT](ERROR): Communications Fault in component: BackseatComponent 2025-02-21T01:54:48.635Z,1740102888.635 [CBIT](ERROR): Hardware Fault in component: Power24vConverter 2025-02-21T01:54:48.712Z,1740102888.712 [Power24vConverter](INFO): Powering down. 2025-02-21T01:54:48.725Z,1740102888.725 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-21T01:54:48.725Z,1740102888.725 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-21T01:54:49.515Z,1740102889.515 [Power24vConverter](INFO): Powering up. 2025-02-21T01:54:49.822Z,1740102889.822 [CBIT](INFO): Clearing failed state for component Power24vConverter 2025-02-21T01:54:49.823Z,1740102889.823 [Power24vConverter] No Fault, FailCount= 1 2025-02-21T01:54:51.139Z,1740102891.139 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T01:55:01.983Z,1740102901.983 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:55:06.935Z,1740102906.935 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-21T01:55:06.936Z,1740102906.936 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-21T01:55:06.936Z,1740102906.936 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-21T01:55:25.519Z,1740102925.519 [BackseatComponent](INFO): Powering up 2025-02-21T01:55:25.520Z,1740102925.520 [BackseatComponent](INFO): Subscribing to LCM channels. 2025-02-21T01:55:25.694Z,1740102925.694 [CBIT](INFO): Clearing failed state for component BackseatComponent 2025-02-21T01:55:25.695Z,1740102925.695 [BackseatComponent] No Fault, FailCount= 1 2025-02-21T01:55:33.107Z,1740102933.107 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:55:50.467Z,1740102950.467 [Radio_Surface](INFO): Powering down 2025-02-21T01:56:04.232Z,1740102964.232 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T01:56:05.236Z,1740102965.236 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T01:56:32.212Z,1740102992.212 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20250221T015635 2025-02-21T01:57:10.512Z,1740103030.512 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.747070 2025-02-21T01:57:30.434Z,1740103050.434 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1975 2025-02-21T02:01:32.763Z,1740103292.763 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.simrad_data_logging_rate with code: 1976 2025-02-21T02:04:53.862Z,1740103493.862 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000 2025-02-21T02:04:53.862Z,1740103493.862 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2025-02-21T02:04:53.862Z,1740103493.862 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation] Stopped 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation:A.Buoyancy] Stopped 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation:B.Pitch] Stopped 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation:C.SetSpeed] Stopped 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Uninitialize. 2025-02-21T02:04:53.880Z,1740103493.880 [keepstation:OnStation] Running Loop=1 2025-02-21T02:04:53.881Z,1740103493.881 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation 2025-02-21T02:04:54.272Z,1740103494.272 [keepstation:NeedComms] Running Loop=1 2025-02-21T02:04:54.272Z,1740103494.272 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-02-21T02:04:54.272Z,1740103494.272 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-02-21T02:04:54.272Z,1740103494.272 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T02:04:54.273Z,1740103494.273 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-02-21T02:04:54.273Z,1740103494.273 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-02-21T02:04:54.273Z,1740103494.273 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-02-21T02:04:54.274Z,1740103494.274 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-02-21T02:04:54.274Z,1740103494.274 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T02:04:54.274Z,1740103494.274 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T02:04:54.275Z,1740103494.275 [keepstation:NeedComms:A] Running Loop=1 2025-02-21T02:04:54.276Z,1740103494.276 [keepstation:NeedComms:A](INFO): last time_fix was: 1740102843.000000 second since 1970/01/01T00:00:00Z 2025-02-21T02:04:54.276Z,1740103494.276 [keepstation:NeedComms:A] Stopped 2025-02-21T02:05:43.525Z,1740103543.525 [keepstation:NeedComms:C] Running Loop=1 2025-02-21T02:05:44.023Z,1740103544.023 [Radio_Surface](INFO): Powering up 2025-02-21T02:05:49.664Z,1740103549.664 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T02:06:19.800Z,1740103579.800 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:06:32.491Z,1740103592.491 [BackseatComponent](FAULT): IBASE811F-02: AOS log size (413.72 MB) did not increase within specified timeout. Restarting logger 2025-02-21T02:06:32.491Z,1740103592.491 [BackseatComponent] Data Fault, FailCount= 1 2025-02-21T02:06:32.491Z,1740103592.491 [BackseatComponent](ERROR): Data Fault 2025-02-21T02:06:32.772Z,1740103592.772 [CBIT](ERROR): Data Fault in component: BackseatComponent 2025-02-21T02:06:32.896Z,1740103592.896 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-21T02:06:32.896Z,1740103592.896 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-21T02:06:50.931Z,1740103610.931 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:06:51.076Z,1740103611.076 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-21T02:06:51.076Z,1740103611.076 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-21T02:06:51.076Z,1740103611.076 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-21T02:06:59.349Z,1740103619.349 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=12986, MT Status=1, MTMSN=261 2025-02-21T02:06:59.349Z,1740103619.349 [NAL9602](INFO): Data available in MT queue 2025-02-21T02:07:00.060Z,1740103620.060 [NAL9602](INFO): Received command: sched "load Science/sci2_slowyo_test.tl;set sci2_slowyo_test.MissionTimeout 1.5 h;set sci2_slowyo_test.NeedCommsTime 90 min;set sci2_slowyo_test.Lat1 36.79631 degree;set sci2_slowyo_test.Lon1 -121.87204 degree" 2269q 1 3 2025-02-21T02:07:00.086Z,1740103620.086 [CommandExec](IMPORTANT): got command schedule "load Science/sci2_slowyo_test.tl;set sci2_slowyo_test.MissionTimeout 1.5 h;set sci2_slowyo_test.NeedCommsTime 90 min;set sci2_slowyo_test.Lat1 36.79631 degree;set sci2_slowyo_test.Lon1 -121.87204 degree" 2269q 1 3.000000 2025-02-21T02:07:00.086Z,1740103620.086 [CommandExec](IMPORTANT): Scheduling command #1 of 3 with id=2269q 2025-02-21T02:07:00.087Z,1740103620.087 [CommandExec](IMPORTANT): Scheduled #16 (#1 of 3 with id='2269q'): "load Science/sci2_slowyo_test.tl;set sci2_slowyo_test.MissionTimeout 1.5 h;set sci2_slowyo_test.NeedCommsTime 90 min;set sci2_slowyo_test.Lat1 36.79631 degree;set sci2_slowyo_test.Lon1 -121.87204 degree", AFTER MISSION 2025-02-21T02:07:01.097Z,1740103621.097 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,020700.00,A,3647.76670,N,12150.83916,W,1.886,115.95,210225,,,A*75 2025-02-21T02:07:01.100Z,1740103621.100 [NAL9602](INFO): GPS fix at 20250221T020700: (36.796112, -121.847319) 2025-02-21T02:07:01.129Z,1740103621.129 [UniversalFixResidualReporter](INFO): Fix residual: 30.5 %DT, over the last 534.0 m. Residual distance 163.1 m at bearing 21.2 degrees. Fix at (36.7961, -121.8473) with 331.1 m made good. 2025-02-21T02:07:01.132Z,1740103621.132 [keepstation:NeedComms:C] Stopped 2025-02-21T02:07:01.132Z,1740103621.132 [keepstation:NeedComms:D] Running Loop=1 2025-02-21T02:07:09.668Z,1740103629.668 [BackseatComponent](INFO): Powering up 2025-02-21T02:07:09.669Z,1740103629.669 [BackseatComponent](INFO): Subscribing to LCM channels. 2025-02-21T02:07:09.723Z,1740103629.723 [CBIT](INFO): Clearing failed state for component BackseatComponent 2025-02-21T02:07:09.723Z,1740103629.723 [BackseatComponent] No Fault, FailCount= 0 2025-02-21T02:07:22.068Z,1740103642.068 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:07:26.094Z,1740103646.094 [NAL9602](INFO): SBD MO Status=2, MOMSN=12987, MT Status=2, MTMSN=0 2025-02-21T02:07:26.094Z,1740103646.094 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T02:07:52.738Z,1740103672.738 [NAL9602](INFO): SBD MO Status=2, MOMSN=12987, MT Status=2, MTMSN=0 2025-02-21T02:07:52.738Z,1740103672.738 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T02:07:53.204Z,1740103673.204 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:08:09.675Z,1740103689.675 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003139 2025-02-21T02:08:13.666Z,1740103693.666 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20250221T020817 2025-02-21T02:08:18.183Z,1740103698.183 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20250221T014851/Courier0003.lzma 2025-02-21T02:08:19.185Z,1740103699.185 [DataOverHttps](INFO): Moved sent file to Logs/20250221T014851/Courier0003.lzma.bak 2025-02-21T02:08:19.186Z,1740103699.186 [DataOverHttps](INFO): SBD MOMSN=23970450 2025-02-21T02:08:28.232Z,1740103708.232 [NAL9602](INFO): SBD MO Status=2, MOMSN=12987, MT Status=2, MTMSN=0 2025-02-21T02:08:28.232Z,1740103708.232 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T02:08:41.749Z,1740103721.749 [DataOverHttps](INFO): Sending 790 bytes from file Logs/20250221T014851/Express0004.lzma 2025-02-21T02:08:42.749Z,1740103722.749 [DataOverHttps](INFO): Moved sent file to Logs/20250221T014851/Express0004.lzma.bak 2025-02-21T02:08:42.749Z,1740103722.749 [DataOverHttps](INFO): SBD MOMSN=23970453 2025-02-21T02:08:44.432Z,1740103724.432 [keepstation:NeedComms:D] Stopped 2025-02-21T02:08:44.433Z,1740103724.433 [keepstation:NeedComms:E] Running Loop=1 2025-02-21T02:08:46.426Z,1740103726.426 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,020845.00,A,3647.75383,N,12150.83647,W,0.428,160.32,210225,,,A*7C 2025-02-21T02:08:46.428Z,1740103726.428 [NAL9602](INFO): GPS fix at 20250221T020845: (36.795897, -121.847274) 2025-02-21T02:08:46.488Z,1740103726.488 [keepstation:NeedComms:E] Stopped 2025-02-21T02:08:46.489Z,1740103726.489 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-02-21T02:08:46.489Z,1740103726.489 [keepstation:NeedComms] Stopped 2025-02-21T02:08:46.489Z,1740103726.489 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-02-21T02:08:46.489Z,1740103726.489 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-02-21T02:08:46.489Z,1740103726.489 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T02:08:46.898Z,1740103726.898 [keepstation:OnStation](INFO): Completed keepstation:OnStation 2025-02-21T02:08:46.898Z,1740103726.898 [keepstation:OnStation] Stopped 2025-02-21T02:08:46.898Z,1740103726.898 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation 2025-02-21T02:08:46.899Z,1740103726.899 [keepstation:KeepStation] Running Loop=1 2025-02-21T02:08:46.899Z,1740103726.899 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation 2025-02-21T02:08:46.903Z,1740103726.903 [keepstation:KeepStation:A] Running Loop=1 2025-02-21T02:08:46.903Z,1740103726.903 [keepstation:KeepStation:B.Pitch] Running Loop=1 2025-02-21T02:08:46.903Z,1740103726.903 [keepstation:KeepStation:B.Pitch](DEBUG): Initialize. 2025-02-21T02:08:46.903Z,1740103726.903 [keepstation:KeepStation:C.KeepStation] Running Loop=1 2025-02-21T02:08:46.903Z,1740103726.903 [keepstation:KeepStation:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2025-02-21T02:08:46.904Z,1740103726.904 [keepstation:KeepStation:D.Wait] Running Loop=1 2025-02-21T02:08:46.904Z,1740103726.904 [keepstation:KeepStation:D.Wait](DEBUG): Initialize Wait Component. 2025-02-21T02:08:47.275Z,1740103727.275 [keepstation:KeepStation:C.KeepStation] Running Loop=1 2025-02-21T02:08:47.276Z,1740103727.276 [keepstation:KeepStation:B.Pitch] Running Loop=1 2025-02-21T02:08:47.276Z,1740103727.276 [keepstation:KeepStation:A] Running Loop=1 2025-02-21T02:09:18.344Z,1740103758.344 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T02:11:16.068Z,1740103876.068 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:11:37.048Z,1740103897.048 [Radio_Surface](INFO): Powering down 2025-02-21T02:11:47.203Z,1740103907.203 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T02:11:48.207Z,1740103908.207 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T02:13:23.632Z,1740104003.632 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.775391 2025-02-21T02:17:59.103Z,1740104279.103 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:18:11.632Z,1740104291.632 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:18:24.150Z,1740104304.150 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:18:36.670Z,1740104316.670 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:18:49.598Z,1740104329.598 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:19:02.932Z,1740104342.932 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:19:15.454Z,1740104355.454 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:24:22.130Z,1740104662.130 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:24:34.250Z,1740104674.250 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:24:46.774Z,1740104686.774 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:25:00.106Z,1740104700.106 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:25:13.438Z,1740104713.438 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:25:25.962Z,1740104725.962 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:25:38.486Z,1740104738.486 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:25:51.414Z,1740104751.414 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:26:03.938Z,1740104763.938 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:26:16.462Z,1740104776.462 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:26:28.985Z,1740104788.985 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:26:41.914Z,1740104801.914 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T02:26:50.007Z,1740104810.007 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:27:02.527Z,1740104822.527 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:27:15.509Z,1740104835.509 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:27:27.970Z,1740104847.970 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:27:41.326Z,1740104861.326 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:27:54.254Z,1740104874.254 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:28:07.586Z,1740104887.586 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:28:20.110Z,1740104900.110 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:28:33.044Z,1740104913.044 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:28:45.562Z,1740104925.562 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:28:58.491Z,1740104938.491 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:29:11.014Z,1740104951.014 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T02:34:00.738Z,1740105240.738 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-02-21T02:34:00.745Z,1740105240.745 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-02-21T02:34:00.745Z,1740105240.745 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 6. 2025-02-21T02:34:00.748Z,1740105240.748 [BPC1](INFO): Received data from all battery sticks. 2025-02-21T02:42:37.915Z,1740105757.915 [BuoyancyServo](FAULT): Overload Error 2025-02-21T02:42:37.916Z,1740105757.916 [BuoyancyServo] Hardware Fault, FailCount= 1 2025-02-21T02:42:37.916Z,1740105757.916 [BuoyancyServo](ERROR): Hardware Fault 2025-02-21T02:42:38.160Z,1740105758.160 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2025-02-21T02:42:39.909Z,1740105759.909 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-02-21T02:42:39.909Z,1740105759.909 [BuoyancyServo](INFO): Powering down 2025-02-21T02:42:40.743Z,1740105760.743 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2025-02-21T02:42:40.744Z,1740105760.744 [BuoyancyServo] No Fault, FailCount= 1 2025-02-21T02:42:41.114Z,1740105761.114 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-02-21T02:42:41.114Z,1740105761.114 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-02-21T02:43:04.187Z,1740105784.187 [BuoyancyServo](FAULT): Overload Error 2025-02-21T02:43:04.187Z,1740105784.187 [BuoyancyServo] Hardware Fault, FailCount= 2 2025-02-21T02:43:04.187Z,1740105784.187 [BuoyancyServo](ERROR): Hardware Fault 2025-02-21T02:43:04.328Z,1740105784.328 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2025-02-21T02:43:06.161Z,1740105786.161 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-02-21T02:43:06.161Z,1740105786.161 [BuoyancyServo](INFO): Powering down 2025-02-21T02:43:07.116Z,1740105787.116 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2025-02-21T02:43:07.116Z,1740105787.116 [BuoyancyServo] No Fault, FailCount= 2 2025-02-21T02:43:07.397Z,1740105787.397 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-02-21T02:43:07.403Z,1740105787.403 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-02-21T02:44:03.563Z,1740105843.563 [BuoyancyServo](FAULT): Overload Error 2025-02-21T02:44:03.563Z,1740105843.563 [BuoyancyServo] Hardware Fault, FailCount= 3 2025-02-21T02:44:03.564Z,1740105843.564 [BuoyancyServo](ERROR): Hardware Fault 2025-02-21T02:44:03.704Z,1740105843.704 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2025-02-21T02:44:05.561Z,1740105845.561 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-02-21T02:44:05.561Z,1740105845.561 [BuoyancyServo](INFO): Powering down 2025-02-21T02:44:06.507Z,1740105846.507 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2025-02-21T02:44:06.508Z,1740105846.508 [BuoyancyServo] No Fault, FailCount= 3 2025-02-21T02:44:06.773Z,1740105846.773 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-02-21T02:44:06.774Z,1740105846.774 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-02-21T02:49:29.957Z,1740106169.957 [keepstation](INFO): Timed out from 2025-02-21T01:49:29.7Z 2025-02-21T02:49:29.957Z,1740106169.957 [MissionManager](INFO): keepstation is completed.