2025-02-21T00:48:12.679Z,1740098892.679 [sci2_slowyo_test](INFO): Completed sci2_slowyo_test
2025-02-21T00:48:12.679Z,1740098892.679 [MissionManager](INFO): sci2_slowyo_test is completed.
2025-02-21T00:48:12.679Z,1740098892.679 [MissionManager](INFO): Uninitializing Mission sci2_slowyo_test
2025-02-21T00:48:12.679Z,1740098892.679 [sci2_slowyo_test] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test](DEBUG): Aggregate::uninitialize sci2_slowyo_test
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science:B] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science:C] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science:E] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science:OceanCurrent] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sci2_slowyo_test:Science:OceanCurrent
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:Science:OceanCurrent:A.] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:StandardEnvelopes] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2_slowyo_test:StandardEnvelopes
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-02-21T00:48:12.680Z,1740098892.680 [sci2_slowyo_test:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:BackseatDriver] Stopped
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:BackseatDriver](DEBUG): Aggregate::uninitialize sci2_slowyo_test:BackseatDriver
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:BackseatDriver:A.BackseatDriver] Stopped
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:PowerOnly] Stopped
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:PowerOnly](DEBUG): Aggregate::uninitialize sci2_slowyo_test:PowerOnly
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:PowerOnly:E.Wait] Stopped
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T00:48:12.681Z,1740098892.681 [sci2_slowyo_test:DiveCmd] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:InitialDive] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:InitialDive](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:InitialDive
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:B.Pitch] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed] Stopped
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:C.SetSpeed](DEBUG): Uninitialize.
2025-02-21T00:48:12.682Z,1740098892.682 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop] Stopped
2025-02-21T00:48:12.683Z,1740098892.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop](DEBUG): Aggregate::uninitialize sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop
2025-02-21T00:48:12.683Z,1740098892.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo] Stopped
2025-02-21T00:48:12.683Z,1740098892.683 [sci2_slowyo_test:DiveCmd:SlowYoToWaypoint:SlowYoTask:SlowYoLoop:A.SlowYo](DEBUG): Uninitialize SlowYoComponent.
2025-02-21T00:48:12.745Z,1740098892.745 [CommandExec](IMPORTANT): got command restart logs
2025-02-21T00:48:12.803Z,1740098892.803 [WetLabsBB2FL](INFO): Powering down
2025-02-21T00:48:13.238Z,1740098893.238 [MissionManager](IMPORTANT): Started mission Default
2025-02-21T00:48:13.238Z,1740098893.238 [Default] Running Loop=1
2025-02-21T00:48:13.238Z,1740098893.238 [Default](DEBUG): Aggregate::initialize Default
2025-02-21T00:48:13.238Z,1740098893.238 [Default:B.GoToSurface] Running Loop=1
2025-02-21T00:48:13.238Z,1740098893.238 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-21T00:48:13.239Z,1740098893.239 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-21T00:48:13.243Z,1740098893.243 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-21T00:48:13.243Z,1740098893.243 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-21T00:48:13.244Z,1740098893.244 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-21T00:48:13.244Z,1740098893.244 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-21T00:48:13.244Z,1740098893.244 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-21T00:48:13.245Z,1740098893.245 [Default:A.Wait] Running Loop=1
2025-02-21T00:48:13.245Z,1740098893.245 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-21T00:48:13.703Z,1740098893.703 [Radio_Surface](INFO): Powering up
2025-02-21T00:48:14.745Z,1740098894.745 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-02-21T00:48:14.746Z,1740098894.746 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-02-21T00:48:19.021Z,1740098899.021 [DataOverHttps](INFO): Radio surface powered ON.
2025-02-21T00:48:20.906Z,1740098900.906 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl
2025-02-21T00:48:20.911Z,1740098900.911 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl
2025-02-21T00:48:20.912Z,1740098900.912 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl
2025-02-21T00:48:20.913Z,1740098900.913 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl
2025-02-21T00:48:22.482Z,1740098902.482 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into:
4
45
NaN
NaN
30
15
4
0.75
200
45
2
2025-02-21T00:48:22.495Z,1740098902.495 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h
2025-02-21T00:48:22.497Z,1740098902.497 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min
2025-02-21T00:48:22.501Z,1740098902.501 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg
2025-02-21T00:48:22.503Z,1740098902.503 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg
2025-02-21T00:48:22.513Z,1740098902.513 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m
2025-02-21T00:48:22.519Z,1740098902.519 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m
2025-02-21T00:48:22.522Z,1740098902.522 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m
2025-02-21T00:48:22.528Z,1740098902.528 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s
2025-02-21T00:48:22.530Z,1740098902.530 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m
2025-02-21T00:48:22.536Z,1740098902.536 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m
2025-02-21T00:48:22.539Z,1740098902.539 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km
2025-02-21T00:48:22.571Z,1740098902.571 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-02-21T00:48:22.571Z,1740098902.571 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-02-21T00:48:22.573Z,1740098902.573 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-02-21T00:48:23.111Z,1740098903.111 [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-21T00:48:23.121Z,1740098903.121 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h
2025-02-21T00:48:23.140Z,1740098903.140 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min
2025-02-21T00:48:23.142Z,1740098903.142 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-02-21T00:48:23.148Z,1740098903.148 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s
2025-02-21T00:48:23.151Z,1740098903.151 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-02-21T00:48:23.164Z,1740098903.164 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1000.000000 s
2025-02-21T00:48:23.166Z,1740098903.166 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min
2025-02-21T00:48:23.168Z,1740098903.168 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min
2025-02-21T00:48:23.182Z,1740098903.182 [keepstation:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-02-21T00:48:23.214Z,1740098903.214 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-02-21T00:48:23.215Z,1740098903.215 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-02-21T00:48:23.228Z,1740098903.228 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-02-21T00:48:23.321Z,1740098903.321 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
0
200
2000
2025-02-21T00:48:23.325Z,1740098903.325 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m
2025-02-21T00:48:23.327Z,1740098903.327 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-02-21T00:48:23.368Z,1740098903.368 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m
2025-02-21T00:48:23.371Z,1740098903.371 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-02-21T00:48:23.378Z,1740098903.378 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-02-21T00:48:23.514Z,1740098903.514 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-02-21T00:48:23.529Z,1740098903.529 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-02-21T00:48:23.536Z,1740098903.536 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-02-21T00:48:23.537Z,1740098903.537 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-02-21T00:48:23.538Z,1740098903.538 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-02-21T00:48:23.562Z,1740098903.562 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-02-21T00:48:23.565Z,1740098903.565 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool
2025-02-21T00:48:23.567Z,1740098903.567 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-02-21T00:48:23.585Z,1740098903.585 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-02-21T00:48:23.585Z,1740098903.585 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-02-21T00:48:23.586Z,1740098903.586 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-02-21T00:48:23.686Z,1740098903.686 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-02-21T00:48:23.690Z,1740098903.690 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool
2025-02-21T00:48:23.692Z,1740098903.692 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool
2025-02-21T00:48:23.693Z,1740098903.693 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool
2025-02-21T00:48:23.695Z,1740098903.695 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool
2025-02-21T00:48:23.698Z,1740098903.698 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool
2025-02-21T00:48:23.706Z,1740098903.706 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-02-21T00:48:23.707Z,1740098903.707 [keepstation:H.Pitch](DEBUG): Construct.
2025-02-21T00:48:23.713Z,1740098903.713 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-02-21T00:48:23.716Z,1740098903.716 [keepstation:TransitToStation:B.Pitch](DEBUG): Construct.
2025-02-21T00:48:23.721Z,1740098903.721 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Construct.
2025-02-21T00:48:23.783Z,1740098903.783 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-02-21T00:48:23.811Z,1740098903.811 [keepstation:KeepStation:B.Pitch](DEBUG): Construct.
2025-02-21T00:48:23.829Z,1740098903.829 [keepstation:KeepStation:C.KeepStation](DEBUG): Construct KeepStation.
2025-02-21T00:48:23.838Z,1740098903.838 [keepstation:KeepStation:D.Wait](DEBUG): Construct Wait.
2025-02-21T00:48:23.873Z,1740098903.873 [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-21T00:48:23.874Z,1740098903.874 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation
2025-02-21T00:48:26.626Z,1740098906.626 [Default:A.Wait](INFO): Done Waiting.
2025-02-21T00:48:26.626Z,1740098906.626 [Default:A.Wait] Stopped
2025-02-21T00:48:26.626Z,1740098906.626 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T00:48:32.936Z,1740098912.936 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-02-21T00:48:32.936Z,1740098912.936 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-02-21T00:48:32.937Z,1740098912.937 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-02-21T00:48:43.704Z,1740098923.704 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 60 minute
2025-02-21T00:48:43.705Z,1740098923.705 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 60 minute
2025-02-21T00:48:43.706Z,1740098923.706 [CommandExec](IMPORTANT): got command set keepstation.Latitude 36.797 degree
2025-02-21T00:48:43.707Z,1740098923.707 [CommandExec](IMPORTANT): got command set keepstation.Longitude -121.847 degree
2025-02-21T00:48:43.708Z,1740098923.708 [CommandExec](IMPORTANT): got command set keepstation.DepthDeadband 1 meter
2025-02-21T00:48:49.151Z,1740098929.151 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:48:50.865Z,1740098930.865 [CommandExec](IMPORTANT): got command set keepstation:BackseatDriver.EnableBackseat 1 bool
2025-02-21T00:48:50.865Z,1740098930.865 [CommandExec](IMPORTANT): got command run
2025-02-21T00:48:50.871Z,1740098930.871 [CommandExec](IMPORTANT): Running
2025-02-21T00:48:50.892Z,1740098930.892 [Default] Stopped
2025-02-21T00:48:50.892Z,1740098930.892 [Default](DEBUG): Aggregate::uninitialize Default
2025-02-21T00:48:50.892Z,1740098930.892 [Default:B.GoToSurface] Stopped
2025-02-21T00:48:50.893Z,1740098930.893 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-21T00:48:50.893Z,1740098930.893 [MissionManager](IMPORTANT): Started mission keepstation
2025-02-21T00:48:50.893Z,1740098930.893 [keepstation] Running Loop=1
2025-02-21T00:48:50.893Z,1740098930.893 [keepstation](DEBUG): Aggregate::initialize keepstation
2025-02-21T00:48:50.893Z,1740098930.893 [keepstation:StandardEnvelopes] Running Loop=1
2025-02-21T00:48:50.893Z,1740098930.893 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes
2025-02-21T00:48:50.893Z,1740098930.893 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-21T00:48:50.893Z,1740098930.893 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:BackseatDriver] Running Loop=1
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:PowerOnly] Running Loop=1
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly
2025-02-21T00:48:50.894Z,1740098930.894 [keepstation:PowerOnly:A] Running Loop=1
2025-02-21T00:48:50.895Z,1740098930.895 [keepstation:PowerOnly:B] Running Loop=1
2025-02-21T00:48:50.895Z,1740098930.895 [keepstation:PowerOnly:C] Running Loop=1
2025-02-21T00:48:50.895Z,1740098930.895 [keepstation:PowerOnly:D] Running Loop=1
2025-02-21T00:48:50.899Z,1740098930.899 [keepstation:PowerOnly:E.Wait] Running Loop=1
2025-02-21T00:48:50.900Z,1740098930.900 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-02-21T00:48:50.900Z,1740098930.900 [keepstation:H.Pitch] Running Loop=1
2025-02-21T00:48:50.900Z,1740098930.900 [keepstation:H.Pitch](DEBUG): Initialize.
2025-02-21T00:48:50.900Z,1740098930.900 [keepstation:B] Running Loop=1
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:H.Pitch] Running Loop=1
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:PowerOnly] Running Loop=1
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:PowerOnly:D] Stopped
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:PowerOnly:C] Stopped
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:PowerOnly:B] Stopped
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:PowerOnly:A] Stopped
2025-02-21T00:48:50.901Z,1740098930.901 [keepstation:BackseatDriver] Running Loop=1
2025-02-21T00:48:50.902Z,1740098930.902 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-02-21T00:48:50.945Z,1740098930.945 [keepstation:StandardEnvelopes] Running Loop=1
2025-02-21T00:48:50.945Z,1740098930.945 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-21T00:48:50.945Z,1740098930.945 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-21T00:48:50.946Z,1740098930.946 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-21T00:48:50.946Z,1740098930.946 [keepstation:B] Stopped
2025-02-21T00:48:50.946Z,1740098930.946 [keepstation:D] Running Loop=1
2025-02-21T00:48:51.308Z,1740098931.308 [BackseatComponent](INFO): Powering up
2025-02-21T00:48:51.308Z,1740098931.308 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-02-21T00:48:51.367Z,1740098931.367 [keepstation:D] Stopped
2025-02-21T00:48:51.367Z,1740098931.367 [keepstation:E] Running Loop=1
2025-02-21T00:48:51.755Z,1740098931.755 [keepstation:E] Stopped
2025-02-21T00:48:51.756Z,1740098931.756 [keepstation:StartingMission] Running Loop=1
2025-02-21T00:48:51.756Z,1740098931.756 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission
2025-02-21T00:48:52.156Z,1740098932.156 [keepstation:NeedComms] Running Loop=1
2025-02-21T00:48:52.157Z,1740098932.157 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-02-21T00:48:52.157Z,1740098932.157 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-02-21T00:48:52.157Z,1740098932.157 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-21T00:48:52.157Z,1740098932.157 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-02-21T00:48:52.157Z,1740098932.157 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-02-21T00:48:52.158Z,1740098932.158 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-02-21T00:48:52.158Z,1740098932.158 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-02-21T00:48:52.158Z,1740098932.158 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-21T00:48:52.159Z,1740098932.159 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-21T00:48:52.159Z,1740098932.159 [keepstation:NeedComms:A] Running Loop=1
2025-02-21T00:48:52.161Z,1740098932.161 [keepstation:NeedComms:A](INFO): last time_fix was: 1740096166.000000 second since 1970/01/01T00:00:00Z
2025-02-21T00:48:52.161Z,1740098932.161 [keepstation:NeedComms:A] Stopped
2025-02-21T00:48:52.572Z,1740098932.572 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2025-02-21T00:49:20.287Z,1740098960.287 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:49:47.277Z,1740098987.277 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20250221T004950
2025-02-21T00:49:51.413Z,1740098991.413 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:49:51.895Z,1740098991.895 [Radio_Surface](INFO): Powering down
2025-02-21T00:49:52.416Z,1740098992.416 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-02-21T00:50:42.508Z,1740099042.508 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-02-21T00:50:42.509Z,1740099042.509 [ThrusterHE](INFO): Powering down
2025-02-21T00:50:43.149Z,1740099043.149 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1975
2025-02-21T00:50:43.344Z,1740099043.344 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-21T00:50:43.464Z,1740099043.464 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-21T00:51:54.809Z,1740099114.809 [keepstation:NeedComms:C] Running Loop=1
2025-02-21T00:51:55.217Z,1740099115.217 [keepstation:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-21T00:51:55.519Z,1740099115.519 [Radio_Surface](INFO): Powering up
2025-02-21T00:52:00.947Z,1740099120.947 [DataOverHttps](INFO): Radio surface powered ON.
2025-02-21T00:52:31.068Z,1740099151.068 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:52:50.645Z,1740099170.645 [NAL9602](INFO): SBD MO Status=0, MOMSN=12968, MT Status=0, MTMSN=0
2025-02-21T00:52:50.646Z,1740099170.646 [NAL9602](INFO): No messages in MT queue
2025-02-21T00:52:51.858Z,1740099171.858 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,005251.00,A,3647.56909,N,12150.95548,W,0.622,248.44,210225,,,A*76
2025-02-21T00:52:51.860Z,1740099171.860 [NAL9602](INFO): GPS fix at 20250221T005251: (36.792818, -121.849258)
2025-02-21T00:52:51.874Z,1740099171.874 [UniversalFixResidualReporter](INFO): Fix residual: 15.6 %DT, over the last 2684.0 m. Residual distance 419.9 m at bearing 31.9 degrees. Fix at (36.7928, -121.8493) with 1986.9 m made good.
2025-02-21T00:52:51.880Z,1740099171.880 [keepstation:NeedComms:C] Stopped
2025-02-21T00:52:51.880Z,1740099171.880 [keepstation:NeedComms:D] Running Loop=1
2025-02-21T00:52:52.292Z,1740099172.292 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-21T00:53:02.195Z,1740099182.195 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:53:08.512Z,1740099188.512 [NAL9602](INFO): SBD MO Status=1, MOMSN=12969, MT Status=0, MTMSN=0
2025-02-21T00:53:08.575Z,1740099188.575 [NAL9602](INFO): Sent 203 bytes from file Logs/20250220T235022/Courier0030.lzma
2025-02-21T00:53:08.576Z,1740099188.576 [NAL9602](INFO): Packets left to send: 0
2025-02-21T00:53:18.022Z,1740099198.022 [NAL9602](INFO): SBD MO Status=1, MOMSN=12970, MT Status=0, MTMSN=0
2025-02-21T00:53:18.075Z,1740099198.075 [NAL9602](INFO): Sent 325 bytes from file Logs/20250221T004812/Courier0000.lzma
2025-02-21T00:53:18.075Z,1740099198.075 [NAL9602](INFO): Packets left to send: 0
2025-02-21T00:53:29.689Z,1740099209.689 [NAL9602](INFO): SBD MO Status=1, MOMSN=12971, MT Status=0, MTMSN=0
2025-02-21T00:53:29.744Z,1740099209.744 [NAL9602](INFO): Sent 332 bytes from file Logs/20250220T235022/Express0031.lzma
2025-02-21T00:53:29.745Z,1740099209.745 [NAL9602](INFO): Packets left to send: 2
2025-02-21T00:53:33.320Z,1740099213.320 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:53:50.642Z,1740099230.642 [NAL9602](INFO): SBD MO Status=1, MOMSN=12972, MT Status=0, MTMSN=0
2025-02-21T00:53:50.703Z,1740099230.703 [NAL9602](INFO): Sent 332 bytes from file Logs/20250220T235022/Express0031.lzma
2025-02-21T00:53:50.704Z,1740099230.704 [NAL9602](INFO): Packets left to send: 1
2025-02-21T00:54:01.166Z,1740099241.166 [NAL9602](INFO): SBD MO Status=1, MOMSN=12973, MT Status=0, MTMSN=0
2025-02-21T00:54:01.228Z,1740099241.228 [NAL9602](INFO): Sent 61 bytes from file Logs/20250220T235022/Express0031.lzma
2025-02-21T00:54:01.228Z,1740099241.228 [NAL9602](INFO): Packets left to send: 0
2025-02-21T00:54:04.452Z,1740099244.452 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:54:11.974Z,1740099251.974 [NAL9602](INFO): SBD MO Status=1, MOMSN=12974, MT Status=0, MTMSN=0
2025-02-21T00:54:12.040Z,1740099252.040 [NAL9602](INFO): Sent 332 bytes from file Logs/20250221T004812/Express0001.lzma
2025-02-21T00:54:12.040Z,1740099252.040 [NAL9602](INFO): Packets left to send: 1
2025-02-21T00:54:19.264Z,1740099259.264 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.007256
2025-02-21T00:54:23.214Z,1740099263.214 [NAL9602](INFO): SBD MO Status=1, MOMSN=12975, MT Status=0, MTMSN=0
2025-02-21T00:54:23.280Z,1740099263.280 [NAL9602](INFO): Sent 327 bytes from file Logs/20250221T004812/Express0001.lzma
2025-02-21T00:54:23.280Z,1740099263.280 [NAL9602](INFO): Packets left to send: 0
2025-02-21T00:54:24.880Z,1740099264.880 [keepstation:NeedComms:D] Stopped
2025-02-21T00:54:24.881Z,1740099264.881 [keepstation:NeedComms:E] Running Loop=1
2025-02-21T00:54:25.293Z,1740099265.293 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-21T00:54:26.867Z,1740099266.867 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,005426.00,A,3647.55545,N,12150.96327,W,1.380,154.75,210225,,,A*7B
2025-02-21T00:54:26.869Z,1740099266.869 [NAL9602](INFO): GPS fix at 20250221T005426: (36.792591, -121.849388)
2025-02-21T00:54:26.985Z,1740099266.985 [keepstation:NeedComms:E] Stopped
2025-02-21T00:54:26.986Z,1740099266.986 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-02-21T00:54:26.986Z,1740099266.986 [keepstation:NeedComms] Stopped
2025-02-21T00:54:26.986Z,1740099266.986 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-02-21T00:54:26.986Z,1740099266.986 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-02-21T00:54:26.986Z,1740099266.986 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-21T00:54:27.391Z,1740099267.391 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:StartingMission] Stopped
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation] Running Loop=1
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation:B.Pitch] Running Loop=1
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation:B.Pitch](DEBUG): Initialize.
2025-02-21T00:54:27.392Z,1740099267.392 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1
2025-02-21T00:54:27.393Z,1740099267.393 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Initialize.
2025-02-21T00:54:27.393Z,1740099267.393 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1
2025-02-21T00:54:27.393Z,1740099267.393 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-21T00:54:27.394Z,1740099267.394 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2025-02-21T00:54:27.782Z,1740099267.782 [ElevatorOffsetCalculator](IMPORTANT): Completed estimation for commanded vars: speed 0.95 m/s, pitch -0.00 deg, mass-position 11.65 mm. Average elevator angle=0.016125 +/- 0.063337 deg (conf. level 99.90%, sigma: 0.039251 deg).
2025-02-21T00:54:27.841Z,1740099267.841 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000
2025-02-21T00:54:27.842Z,1740099267.842 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1
2025-02-21T00:54:27.842Z,1740099267.842 [keepstation:TransitToStation:B.Pitch] Running Loop=1
2025-02-21T00:54:27.843Z,1740099267.843 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1
2025-02-21T00:54:48.388Z,1740099288.388 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.simrad_data_logging_rate with code: 1976
2025-02-21T00:54:58.671Z,1740099298.671 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.75 m/s, pitch 20.00 deg, mass-position 11.65 mm (B active estimators).
2025-02-21T00:54:59.915Z,1740099299.915 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-21T00:55:39.855Z,1740099339.855 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:56:10.984Z,1740099370.984 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:56:42.109Z,1740099402.109 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:57:13.231Z,1740099433.231 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:57:21.259Z,1740099441.259 [Radio_Surface](INFO): Powering down
2025-02-21T00:57:44.368Z,1740099464.368 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T00:57:45.372Z,1740099465.372 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-02-21T00:57:48.384Z,1740099468.384 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.742798
2025-02-21T01:07:30.347Z,1740100050.347 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000
2025-02-21T01:07:30.347Z,1740100050.347 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped
2025-02-21T01:07:30.348Z,1740100050.348 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation] Stopped
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation:A.Buoyancy] Stopped
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation:B.Pitch] Stopped
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation:C.SetSpeed] Stopped
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Uninitialize.
2025-02-21T01:07:30.349Z,1740100050.349 [keepstation:OnStation] Running Loop=1
2025-02-21T01:07:30.350Z,1740100050.350 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation
2025-02-21T01:07:30.744Z,1740100050.744 [keepstation:NeedComms] Running Loop=1
2025-02-21T01:07:30.744Z,1740100050.744 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-02-21T01:07:30.744Z,1740100050.744 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-02-21T01:07:30.744Z,1740100050.744 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-21T01:07:30.745Z,1740100050.745 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-02-21T01:07:30.745Z,1740100050.745 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-02-21T01:07:30.745Z,1740100050.745 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-02-21T01:07:30.746Z,1740100050.746 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-02-21T01:07:30.746Z,1740100050.746 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-21T01:07:30.746Z,1740100050.746 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-21T01:07:30.746Z,1740100050.746 [keepstation:NeedComms:A] Running Loop=1
2025-02-21T01:07:30.765Z,1740100050.765 [keepstation:NeedComms:A](INFO): last time_fix was: 1740099266.000000 second since 1970/01/01T00:00:00Z
2025-02-21T01:07:30.765Z,1740100050.765 [keepstation:NeedComms:A] Stopped
2025-02-21T01:08:00.128Z,1740100080.128 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-02-21T01:08:00.128Z,1740100080.128 [ThrusterHE](INFO): Powering down
2025-02-21T01:08:00.904Z,1740100080.904 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-02-21T01:08:01.024Z,1740100081.024 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-02-21T01:08:20.613Z,1740100100.613 [keepstation:NeedComms:C] Running Loop=1
2025-02-21T01:08:21.187Z,1740100101.187 [Radio_Surface](INFO): Powering up
2025-02-21T01:08:27.055Z,1740100107.055 [DataOverHttps](INFO): Radio surface powered ON.
2025-02-21T01:08:51.723Z,1740100131.723 [NAL9602](INFO): SBD MO Status=2, MOMSN=12976, MT Status=2, MTMSN=0
2025-02-21T01:08:51.724Z,1740100131.724 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-21T01:08:57.204Z,1740100137.204 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:09:02.613Z,1740100142.613 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=12976, MT Status=1, MTMSN=254
2025-02-21T01:09:02.613Z,1740100142.613 [NAL9602](INFO): Data available in MT queue
2025-02-21T01:09:03.124Z,1740100143.124 [NAL9602](INFO): Received command: sched "restart logs"
2025-02-21T01:09:03.225Z,1740100143.225 [CommandExec](IMPORTANT): got command schedule "restart logs"
2025-02-21T01:09:03.226Z,1740100143.226 [CommandExec](IMPORTANT): Scheduled #9: "restart logs", AFTER MISSION
2025-02-21T01:09:04.229Z,1740100144.229 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010903.00,A,3647.73691,N,12150.86579,W,0.408,148.93,210225,,,A*74
2025-02-21T01:09:04.232Z,1740100144.232 [NAL9602](INFO): GPS fix at 20250221T010903: (36.795615, -121.847763)
2025-02-21T01:09:04.273Z,1740100144.273 [UniversalFixResidualReporter](INFO): Fix residual: 34.3 %DT, over the last 615.9 m. Residual distance 211.4 m at bearing 27.3 degrees. Fix at (36.7956, -121.8478) with 366.1 m made good.
2025-02-21T01:09:04.277Z,1740100144.277 [keepstation:NeedComms:C] Stopped
2025-02-21T01:09:04.277Z,1740100144.277 [keepstation:NeedComms:D] Running Loop=1
2025-02-21T01:09:15.862Z,1740100155.862 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12977, MT Status=1, MTMSN=255
2025-02-21T01:09:15.923Z,1740100155.923 [NAL9602](INFO): Sent 82 bytes from file Logs/20250221T004812/Courier0003.lzma
2025-02-21T01:09:15.923Z,1740100155.923 [NAL9602](INFO): Packets left to send: 0
2025-02-21T01:09:16.576Z,1740100156.576 [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 20 m" 225kg 1 2
2025-02-21T01:09:16.677Z,1740100156.677 [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 20 m" 225kg 1 2.000000
2025-02-21T01:09:16.678Z,1740100156.678 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=225kg
2025-02-21T01:09:16.679Z,1740100156.679 [CommandExec](IMPORTANT): Scheduled #10 (#1 of 2 with id='225kg'): "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 20 m", AFTER MISSION
2025-02-21T01:09:28.352Z,1740100168.352 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:09:40.278Z,1740100180.278 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12978, MT Status=1, MTMSN=256
2025-02-21T01:09:40.339Z,1740100180.339 [NAL9602](INFO): Sent 332 bytes from file Logs/20250221T004812/Express0004.lzma
2025-02-21T01:09:40.340Z,1740100180.340 [NAL9602](INFO): Packets left to send: 1
2025-02-21T01:09:40.832Z,1740100180.832 [NAL9602](INFO): Received command: sched "set keepstation:BackseatDriver.EnableBackseat 1 bool;run" 225kg 2 2
2025-02-21T01:09:40.851Z,1740100180.851 [CommandExec](IMPORTANT): got command schedule "set keepstation:BackseatDriver.EnableBackseat 1 bool;run" 225kg 2 2.000000
2025-02-21T01:09:40.852Z,1740100180.852 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=225kg
2025-02-21T01:09:40.853Z,1740100180.853 [CommandExec](IMPORTANT): Scheduled #11 (#2 of 2 with id='225kg'): "set keepstation:BackseatDriver.EnableBackseat 1 bool;run", AFTER MISSION
2025-02-21T01:09:57.674Z,1740100197.674 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=12979, MT Status=1, MTMSN=257
2025-02-21T01:09:57.731Z,1740100197.731 [NAL9602](INFO): Sent 186 bytes from file Logs/20250221T004812/Express0004.lzma
2025-02-21T01:09:57.732Z,1740100197.732 [NAL9602](INFO): Packets left to send: 0
2025-02-21T01:09:58.176Z,1740100198.176 [NAL9602](INFO): Received command: sched "restart logs"
2025-02-21T01:09:58.246Z,1740100198.246 [CommandExec](IMPORTANT): got command schedule "restart logs"
2025-02-21T01:09:58.246Z,1740100198.246 [CommandExec](IMPORTANT): Scheduled #12: "restart logs", AFTER MISSION
2025-02-21T01:09:59.476Z,1740100199.476 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:10:05.453Z,1740100205.453 [NAL9602](INFO): SBD MO Status=0, MOMSN=12980, MT Status=0, MTMSN=0
2025-02-21T01:10:24.574Z,1740100224.574 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:10:30.608Z,1740100230.608 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:10:33.062Z,1740100233.062 [NAL9602](INFO): SBD MO Status=1, MOMSN=12981, MT Status=0, MTMSN=0
2025-02-21T01:10:33.108Z,1740100233.108 [NAL9602](INFO): Sent 38 bytes from file Logs/20250221T004812/Courier0006.lzma
2025-02-21T01:10:33.108Z,1740100233.108 [NAL9602](INFO): Packets left to send: 0
2025-02-21T01:10:38.050Z,1740100238.050 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:10:42.336Z,1740100242.336 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003112
2025-02-21T01:10:46.242Z,1740100246.242 [NAL9602](INFO): SBD MO Status=1, MOMSN=12982, MT Status=0, MTMSN=0
2025-02-21T01:10:46.295Z,1740100246.295 [NAL9602](INFO): Sent 332 bytes from file Logs/20250221T004812/Express0007.lzma
2025-02-21T01:10:46.296Z,1740100246.296 [NAL9602](INFO): Packets left to send: 1
2025-02-21T01:10:51.075Z,1740100251.075 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:10:52.283Z,1740100252.283 [DataOverHttps](INFO): Sending 460 bytes from file Logs/20250221T004812/Express0007.lzma
2025-02-21T01:10:53.285Z,1740100253.285 [DataOverHttps](INFO): Moved sent file to Logs/20250221T004812/Express0007.lzma.bak
2025-02-21T01:10:53.285Z,1740100253.285 [DataOverHttps](INFO): SBD MOMSN=23970385
2025-02-21T01:10:55.160Z,1740100255.160 [keepstation:NeedComms:D] Stopped
2025-02-21T01:10:55.161Z,1740100255.161 [keepstation:NeedComms:E] Running Loop=1
2025-02-21T01:10:57.159Z,1740100257.159 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011056.00,A,3647.72249,N,12150.86161,W,0.467,192.90,210225,,,A*7C
2025-02-21T01:10:57.162Z,1740100257.162 [NAL9602](INFO): GPS fix at 20250221T011056: (36.795375, -121.847694)
2025-02-21T01:10:57.188Z,1740100257.188 [keepstation:NeedComms:E] Stopped
2025-02-21T01:10:57.189Z,1740100257.189 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-02-21T01:10:57.189Z,1740100257.189 [keepstation:NeedComms] Stopped
2025-02-21T01:10:57.189Z,1740100257.189 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-02-21T01:10:57.189Z,1740100257.189 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-02-21T01:10:57.189Z,1740100257.189 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:OnStation](INFO): Completed keepstation:OnStation
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:OnStation] Stopped
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:KeepStation] Running Loop=1
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:KeepStation:A] Running Loop=1
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:KeepStation:B.Pitch] Running Loop=1
2025-02-21T01:10:57.584Z,1740100257.584 [keepstation:KeepStation:B.Pitch](DEBUG): Initialize.
2025-02-21T01:10:57.585Z,1740100257.585 [keepstation:KeepStation:C.KeepStation] Running Loop=1
2025-02-21T01:10:57.585Z,1740100257.585 [keepstation:KeepStation:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-02-21T01:10:57.585Z,1740100257.585 [keepstation:KeepStation:D.Wait] Running Loop=1
2025-02-21T01:10:57.585Z,1740100257.585 [keepstation:KeepStation:D.Wait](DEBUG): Initialize Wait Component.
2025-02-21T01:10:57.970Z,1740100257.970 [keepstation:KeepStation:C.KeepStation] Running Loop=1
2025-02-21T01:10:57.971Z,1740100257.971 [keepstation:KeepStation:B.Pitch] Running Loop=1
2025-02-21T01:10:57.991Z,1740100257.991 [keepstation:KeepStation:A] Running Loop=1
2025-02-21T01:11:04.266Z,1740100264.266 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:11:17.557Z,1740100277.557 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:11:29.362Z,1740100289.362 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-21T01:11:31.362Z,1740100291.362 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:11:43.884Z,1740100303.884 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-21T01:13:03.937Z,1740100383.937 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-02-21T01:14:28.707Z,1740100468.707 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:14:59.831Z,1740100499.831 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:15:09.559Z,1740100509.559 [Radio_Surface](INFO): Powering down
2025-02-21T01:15:30.955Z,1740100530.955 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-21T01:15:31.960Z,1740100531.960 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-02-21T01:16:06.096Z,1740100566.096 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.655075
2025-02-21T01:16:42.949Z,1740100602.949 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2025-02-21T01:16:51.846Z,1740100611.846 [BPC1](ERROR): Battery stick #21 (s/n: 0094) reported OVER_TEMP_ALARM. Status code: 0x1717.
2025-02-21T01:16:51.847Z,1740100611.847 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-02-21T01:16:51.847Z,1740100611.847 [BPC1](INFO): Calculating totals. Valid battery stick count: 50. Valid reserve battery stick count: 6.
2025-02-21T01:16:51.850Z,1740100611.850 [BPC1](INFO): Received data from all battery sticks.
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation](INFO): Timed out from 2025-02-21T00:48:50.9Z
2025-02-21T01:48:51.261Z,1740102531.261 [MissionManager](INFO): keepstation is completed.
2025-02-21T01:48:51.261Z,1740102531.261 [MissionManager](INFO): Uninitializing Mission keepstation
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation] Stopped
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation](DEBUG): Aggregate::uninitialize keepstation
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation:StandardEnvelopes] Stopped
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-02-21T01:48:51.261Z,1740102531.261 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:BackseatDriver] Stopped
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:BackseatDriver:A.BackseatDriver] Stopped
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:PowerOnly] Stopped
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:PowerOnly:E.Wait] Stopped
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-02-21T01:48:51.262Z,1740102531.262 [keepstation:H.Pitch] Stopped
2025-02-21T01:48:51.263Z,1740102531.263 [keepstation:KeepStation] Stopped
2025-02-21T01:48:51.263Z,1740102531.263 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation
2025-02-21T01:48:51.263Z,1740102531.263 [keepstation:KeepStation:A] Stopped
2025-02-21T01:48:51.263Z,1740102531.263 [keepstation:KeepStation:B.Pitch] Stopped
2025-02-21T01:48:51.279Z,1740102531.279 [keepstation:KeepStation:C.KeepStation] Stopped
2025-02-21T01:48:51.279Z,1740102531.279 [keepstation:KeepStation:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-02-21T01:48:51.279Z,1740102531.279 [keepstation:KeepStation:D.Wait] Stopped
2025-02-21T01:48:51.279Z,1740102531.279 [keepstation:KeepStation:D.Wait](DEBUG): Uninitialize Wait Component.