2026-03-12T23:00:47.457Z,1773356447.457 [CommandExec](IMPORTANT): got command restart logs
2026-03-12T23:01:58.106Z,1773356518.106 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2026-03-12T23:01:58.106Z,1773356518.106 [Default:CheckIn:C.Wait] Stopped
2026-03-12T23:01:58.106Z,1773356518.106 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2026-03-12T23:01:58.107Z,1773356518.107 [Default:CheckIn:D] Running Loop=1
2026-03-12T23:01:58.511Z,1773356518.511 [Default:CheckIn:D] Stopped
2026-03-12T23:01:58.511Z,1773356518.511 [Default:CheckIn:E] Running Loop=1
2026-03-12T23:01:58.919Z,1773356518.919 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.678689 min
2026-03-12T23:01:58.919Z,1773356518.919 [Default:CheckIn:E] Stopped
2026-03-12T23:01:58.919Z,1773356518.919 [Default:CheckIn](INFO): Completed Default:CheckIn
2026-03-12T23:01:58.919Z,1773356518.919 [Default:CheckIn] Stopped
2026-03-12T23:01:58.920Z,1773356518.920 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2026-03-12T23:01:58.920Z,1773356518.920 [Default:CheckIn](INFO): Running loop #2
2026-03-12T23:01:58.920Z,1773356518.920 [Default:CheckIn] Running Loop=2
2026-03-12T23:01:58.920Z,1773356518.920 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2026-03-12T23:01:58.920Z,1773356518.920 [Default:CheckIn:Read_GPS] Running Loop=1
2026-03-12T23:02:00.932Z,1773356520.932 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230156.00,A,3648.38297,N,12151.13826,W,0.311,229.85,120326,,,D*7F
2026-03-12T23:02:00.934Z,1773356520.934 [NAL9602](INFO): GPS fix at 20260312T230156: (36.806383, -121.852304)
2026-03-12T23:02:00.945Z,1773356520.945 [Default:CheckIn:Read_GPS] Stopped
2026-03-12T23:02:00.945Z,1773356520.945 [Default:CheckIn:Read_Iridium] Running Loop=1
2026-03-12T23:02:08.015Z,1773356528.015 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260312T221723/Courier0018.lzma
2026-03-12T23:02:09.017Z,1773356529.017 [DataOverHttps](INFO): Moved sent file to Logs/20260312T221723/Courier0018.lzma.bak
2026-03-12T23:02:09.018Z,1773356529.018 [DataOverHttps](INFO): SBD MOMSN=26726882
2026-03-12T23:02:18.106Z,1773356538.106 [NAL9602](INFO): SBD MO Status=0, MOMSN=13250, MT Status=0, MTMSN=0
2026-03-12T23:02:18.106Z,1773356538.106 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:02:24.720Z,1773356544.720 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20260312T230047/Courier0000.lzma
2026-03-12T23:02:25.721Z,1773356545.721 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Courier0000.lzma.bak
2026-03-12T23:02:25.722Z,1773356545.722 [DataOverHttps](INFO): SBD MOMSN=26726884
2026-03-12T23:02:42.475Z,1773356562.475 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260312T230047/Courier0001.lzma
2026-03-12T23:02:43.477Z,1773356563.477 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Courier0001.lzma.bak
2026-03-12T23:02:43.477Z,1773356563.477 [DataOverHttps](INFO): SBD MOMSN=26726888
2026-03-12T23:02:48.808Z,1773356568.808 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:02:59.239Z,1773356579.239 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20260312T221723/Express0019.lzma
2026-03-12T23:03:00.241Z,1773356580.241 [DataOverHttps](INFO): Moved sent file to Logs/20260312T221723/Express0019.lzma.bak
2026-03-12T23:03:00.242Z,1773356580.242 [DataOverHttps](INFO): SBD MOMSN=26726891
2026-03-12T23:03:16.044Z,1773356596.044 [DataOverHttps](INFO): Sending 502 bytes from file Logs/20260312T230047/Express0001.lzma
2026-03-12T23:03:17.045Z,1773356597.045 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Express0001.lzma.bak
2026-03-12T23:03:17.045Z,1773356597.045 [DataOverHttps](INFO): SBD MOMSN=26726894
2026-03-12T23:03:18.706Z,1773356598.706 [Default:CheckIn:Read_Iridium] Stopped
2026-03-12T23:03:18.706Z,1773356598.706 [Default:CheckIn:C.Wait] Running Loop=1
2026-03-12T23:03:18.706Z,1773356598.706 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2026-03-12T23:03:59.507Z,1773356639.507 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-12T23:05:11.997Z,1773356711.997 [DataOverHttps](IMPORTANT): SBD MTMSN=20260312T230507
2026-03-12T23:05:19.403Z,1773356719.403 [DataOverHttps](INFO): Received command: load Transport/keepstation.tl;set keepstation.MissionTimeout 2 h;set keepstation.NeedCommsTime 15 min;set keepstation.Speed 1 m/s;run
2026-03-12T23:05:19.438Z,1773356719.438 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl
2026-03-12T23:05:19.448Z,1773356719.448 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl
2026-03-12T23:05:19.448Z,1773356719.448 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl
2026-03-12T23:05:19.450Z,1773356719.450 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl
2026-03-12T23:05:20.737Z,1773356720.737 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into:
4
45
NaN
NaN
30
15
4
0.75
200
10
10
45
2
0
0
1
2
3
NaN
0
Sinking to
Timed out while trying to reach target sink depth at current depth of
2026-03-12T23:05:20.749Z,1773356720.749 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h
2026-03-12T23:05:20.751Z,1773356720.751 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min
2026-03-12T23:05:20.754Z,1773356720.754 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg
2026-03-12T23:05:20.796Z,1773356720.796 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg
2026-03-12T23:05:20.799Z,1773356720.799 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m
2026-03-12T23:05:20.810Z,1773356720.810 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m
2026-03-12T23:05:20.820Z,1773356720.820 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m
2026-03-12T23:05:20.822Z,1773356720.822 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s
2026-03-12T23:05:20.837Z,1773356720.837 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m
2026-03-12T23:05:20.839Z,1773356720.839 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool
2026-03-12T23:05:20.845Z,1773356720.845 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m
2026-03-12T23:05:20.852Z,1773356720.852 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min
2026-03-12T23:05:20.854Z,1773356720.854 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m
2026-03-12T23:05:20.858Z,1773356720.858 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km
2026-03-12T23:05:20.873Z,1773356720.873 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count
2026-03-12T23:05:20.880Z,1773356720.880 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count
2026-03-12T23:05:20.882Z,1773356720.882 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count
2026-03-12T23:05:20.901Z,1773356720.901 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count
2026-03-12T23:05:20.903Z,1773356720.903 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count
2026-03-12T23:05:20.909Z,1773356720.909 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool
2026-03-12T23:05:20.910Z,1773356720.910 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2026-03-12T23:05:20.910Z,1773356720.910 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2026-03-12T23:05:20.916Z,1773356720.916 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2026-03-12T23:05:21.255Z,1773356721.255 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into:
1
10
20
NaN
1
1500
7
30
0
0
0
0
last time_fix was:
first GPS update timeout
Comms timed out after
minutes
second GPS update timeout
2026-03-12T23:05:21.260Z,1773356721.260 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h
2026-03-12T23:05:21.263Z,1773356721.263 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min
2026-03-12T23:05:21.265Z,1773356721.265 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg
2026-03-12T23:05:21.267Z,1773356721.267 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s
2026-03-12T23:05:21.270Z,1773356721.270 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s
2026-03-12T23:05:21.272Z,1773356721.272 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1500.000000 s
2026-03-12T23:05:21.274Z,1773356721.274 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min
2026-03-12T23:05:21.277Z,1773356721.277 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min
2026-03-12T23:05:21.279Z,1773356721.279 [MissionManager](INFO): DefineArg keepstation:NeedComms.DoingCommsMode = 0.000000 count
2026-03-12T23:05:21.282Z,1773356721.282 [MissionManager](INFO): DefineArg keepstation:NeedComms.RestoreMode = 0.000000 count
2026-03-12T23:05:21.285Z,1773356721.285 [MissionManager](INFO): DefineOutput keepstation:NeedComms.IsActive = 0 bool
2026-03-12T23:05:21.287Z,1773356721.287 [MissionManager](INFO): DefineOutput keepstation:NeedComms.RequiredDiveMode = 0.000000 count
2026-03-12T23:05:21.329Z,1773356721.329 [keepstation:NeedComms:C.GoToSurface](DEBUG): Construct GoToSurface.
2026-03-12T23:05:21.381Z,1773356721.381 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2026-03-12T23:05:21.381Z,1773356721.381 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2026-03-12T23:05:21.382Z,1773356721.382 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2026-03-12T23:05:21.456Z,1773356721.456 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
1.5
200
2000
2026-03-12T23:05:21.460Z,1773356721.460 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m
2026-03-12T23:05:21.462Z,1773356721.462 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2026-03-12T23:05:21.464Z,1773356721.464 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m
2026-03-12T23:05:21.466Z,1773356721.466 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m
2026-03-12T23:05:21.468Z,1773356721.468 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2026-03-12T23:05:21.474Z,1773356721.474 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2026-03-12T23:05:21.480Z,1773356721.480 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2026-03-12T23:05:21.487Z,1773356721.487 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2026-03-12T23:05:21.488Z,1773356721.488 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2026-03-12T23:05:21.489Z,1773356721.489 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2026-03-12T23:05:21.595Z,1773356721.595 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2026-03-12T23:05:21.621Z,1773356721.621 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool
2026-03-12T23:05:21.623Z,1773356721.623 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2026-03-12T23:05:21.629Z,1773356721.629 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2026-03-12T23:05:21.630Z,1773356721.630 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2026-03-12T23:05:21.631Z,1773356721.631 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2026-03-12T23:05:21.757Z,1773356721.757 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2026-03-12T23:05:21.764Z,1773356721.764 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool
2026-03-12T23:05:21.766Z,1773356721.766 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool
2026-03-12T23:05:21.768Z,1773356721.768 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool
2026-03-12T23:05:21.770Z,1773356721.770 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool
2026-03-12T23:05:21.772Z,1773356721.772 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool
2026-03-12T23:05:21.779Z,1773356721.779 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait.
2026-03-12T23:05:21.780Z,1773356721.780 [keepstation:H.Pitch](DEBUG): Construct.
2026-03-12T23:05:21.842Z,1773356721.842 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2026-03-12T23:05:21.845Z,1773356721.845 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct.
2026-03-12T23:05:21.849Z,1773356721.849 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct.
2026-03-12T23:05:21.861Z,1773356721.861 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy.
2026-03-12T23:05:21.870Z,1773356721.870 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct.
2026-03-12T23:05:21.874Z,1773356721.874 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct.
2026-03-12T23:05:21.880Z,1773356721.880 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct.
2026-03-12T23:05:21.884Z,1773356721.884 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation.
2026-03-12T23:05:21.891Z,1773356721.891 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2026-03-12T23:05:21.903Z,1773356721.903 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait.
2026-03-12T23:05:21.961Z,1773356721.961 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission keepstation {
"""
Vehicle transits to desired waypoint (or stays put if none is commanded)
and stays within the specified radius.
"""
arguments {
MissionTimeout = 4 hour
"""
Maximum duration of mission
"""
NeedCommsTime = 45 minute
"""
How often to surface for communications
"""
Latitude = NaN degree
"""
Latitude of waypoint to hold. If NaN, hold the latitude at start of
mission.
"""
Longitude = NaN degree
"""
Longitude of waypoint to hold. If NaN, hold the longitude at start of
mission.
"""
Depth = 30 meter
"""
Depth held during drift mode
"""
ApproachDepth = 15 meter
"""
Depth for initial approach to station.
"""
DepthDeadband = 4 meter
"""
How much vertical drift from the specified depth is allowed in drift
mode
"""
Speed = 0.75 meter_per_second
"""
Vehicle transit speed.
"""
Radius = 200 meter
"""
Radius of circle around waypoint to hold.
"""
SinkOffSurface = false
"""
If true, use buoyancy only to decend to SinkDepth before driving to first target depth
"""
SinkDepth = 10 meter
"""
Initial depth to decend using only buoyancy before driving
"""
SinkDepthTimeout = 10 minute
"""
Max wait time for the vehicle to reach the target depth
"""
MaxDepth = 45 meter
"""
Maximum allowable depth during the mission.
"""
MinOffshore = 2 kilometer
"""
Minimum distance from the shoreline to maintain
"""
}
output {
DiveMode = 0 count
"""
Mission variable (don't change). The mission sets this variable to
switch between dive modes. Initialized to DoingComms.
"""
DoingComms = 0 count
"""
Mission variable (don't change). The mission will run in this mode
when doing surface comms.
"""
SurfaceSink = 1 count
"""
Mission variable (don't change). The mission will run in this mode
when sinking from the surface using only buoyancy.
"""
TransitToStation = 2 count
"""
Mission variable (don't change). The mission will run in this mode
when performing the transit to station
"""
StationKeep = 3 count
"""
Mission variable (don't change). The mission will run in this mode
when keeping station
"""
OnStation = false
"""
Mission variable (don't change). Determines last mode (Transit or StationKeep)
to resume after needcomms
"""
}
timeout duration=MissionTimeout
insert id="NeedComms" Insert/NeedComms.tl
assign in sequence NeedComms:DiveInterval = NeedCommsTime
insert Insert/StandardEnvelopes.tl
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
insert Insert/BackseatDriver.tl
insert Insert/PowerOnly.tl
behavior Guidance:Pitch {
run in parallel
set massPosition = Control:VerticalControl.massDefault
}
aggregate SurfaceComms {
run when (
called
or ( elapsed ( Universal:time_fix ) > NeedCommsTime )
)
assign in sequence DiveMode = DoingComms
call priorityHere=false refId="NeedComms"
aggregate HandleNan {
run in sequence
break if (
not isNaN ( Latitude )
and not isNaN ( Longitude )
)
# If both lat and lon are nan, we are implicitly on station and should skip initial transit, so force OnStation to true
aggregate SetOnStation {
run in sequence
break if (
not isNaN ( Latitude )
or not isNaN ( Longitude )
)
assign in sequence OnStation = true
}
# The "assigns" here mean we should only ever run these aggregates once
# An initial NaN lat/lon should be set here during the initial surface NeedComms call
# Use the most recent fix -- if there isn't one, the keepstation behavior will use Universal:lat/lon
aggregate SetLat {
run in sequence
break if ( not isNaN ( Latitude ) )
assign in sequence Latitude = Universal:latitude_fix
}
aggregate SetLon {
run in sequence
break if ( not isNaN ( Longitude ) )
assign in sequence Longitude = Universal:longitude_fix
}
}
aggregate setTransit {
run in sequence
break if (
SinkOffSurface
or OnStation
)
assign in sequence DiveMode = TransitToStation
}
aggregate setStation {
run in sequence
break if (
SinkOffSurface
or not OnStation
)
assign in sequence DiveMode = StationKeep
}
aggregate setSink {
run in sequence
break if ( not SinkOffSurface )
assign in sequence DiveMode = SurfaceSink
}
}
call id="StartingMission" priorityHere=false refId="SurfaceComms"
aggregate DiveCmd {
run when ( called )
aggregate SurfaceSink {
run while ( DiveMode == SurfaceSink )
aggregate sink {
run in sequence
behavior Guidance:Buoyancy id="BuoyancyHold" {
run in parallel
set position = NaN cc
}
behavior Guidance:SetSpeed {
run in parallel
set speed = 0 m/s
}
syslog info "Sinking to " + SinkDepth~meter
behavior Guidance:Pitch {
run in sequence
timeout duration=SinkDepthTimeout {
syslog important "Timed out while trying to reach target sink depth at current depth of "
+ Universal:depth~meter
}
set depth = SinkDepth
}
# Once we've sunk, either resume transit or station keeping depths and speeds
aggregate sinkToTransit {
run in sequence
break if ( OnStation )
assign in sequence DiveMode = TransitToStation
}
aggregate sinkToStation {
run in sequence
break if ( not OnStation )
assign in sequence DiveMode = StationKeep
}
}
}
aggregate TransitToStation {
run while ( DiveMode == TransitToStation )
aggregate dive {
run in sequence
behavior Guidance:Buoyancy {
run in parallel
set position = Control:VerticalControl.buoyancyNeutral
}
behavior Guidance:Pitch {
run in parallel
set depth = ApproachDepth
}
behavior Guidance:SetSpeed {
run in parallel
set speed = Speed
}
}
}
aggregate StationKeep {
run while ( DiveMode == StationKeep )
assign in parallel Control:VerticalControl.depthDeadband = DepthDeadband
behavior Guidance:Pitch {
run in parallel
set depth = Depth
}
behavior Guidance:KeepStation {
run in parallel
set latitude = Latitude
set longitude = Longitude
set radius = Radius
set speed = Speed
}
}
}
aggregate TransitToStation {
"""
Need a separate aggregate for transit if we want to specify a
different depth for the approach.
"""
run in sequence
aggregate Dive {
run while ( not ( DiveMode == DoingComms ) )
call priorityHere=false refId="DiveCmd"
}
behavior Guidance:Waypoint id="Wpt1" {
run in sequence
set latitude = Latitude
set longitude = Longitude
}
assign in sequence DiveMode = StationKeep
assign in sequence OnStation = true
}
call id="OnStation" priorityHere=false refId="NeedComms"
aggregate KeepStation {
run in sequence
aggregate Dive {
run while ( not ( DiveMode == DoingComms ) )
call priorityHere=false refId="DiveCmd"
}
behavior Guidance:Wait {
"""
Due to the way the KeepStation behavior is currently
implemented, we must run it in parallel and use a Wait to keep
from completing the mission before the timeout expires. However,
this new version of the mission uses a top-level timeout so that
the entire mission will not run for longer then MissionTimeout.
"""
run in sequence
set duration = MissionTimeout
}
}
}
2026-03-12T23:05:21.962Z,1773356721.962 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation
2026-03-12T23:05:37.708Z,1773356737.708 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 2 hour
2026-03-12T23:05:37.708Z,1773356737.708 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 15 minute
2026-03-12T23:05:37.709Z,1773356737.709 [CommandExec](IMPORTANT): got command set keepstation.Speed 1 meter_per_second
2026-03-12T23:05:37.710Z,1773356737.710 [CommandExec](IMPORTANT): got command run
2026-03-12T23:05:37.712Z,1773356737.712 [CommandExec](IMPORTANT): Running
2026-03-12T23:05:37.728Z,1773356737.728 [Default] Stopped
2026-03-12T23:05:37.728Z,1773356737.728 [Default](DEBUG): Aggregate::uninitialize Default
2026-03-12T23:05:37.728Z,1773356737.728 [Default:B.GoToSurface] Stopped
2026-03-12T23:05:37.728Z,1773356737.728 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:05:37.728Z,1773356737.728 [Default:CheckIn] Stopped
2026-03-12T23:05:37.728Z,1773356737.728 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2026-03-12T23:05:37.728Z,1773356737.728 [Default:CheckIn:C.Wait] Stopped
2026-03-12T23:05:37.728Z,1773356737.728 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2026-03-12T23:05:37.728Z,1773356737.728 [MissionManager](IMPORTANT): Started mission keepstation
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation] Running Loop=1
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation](DEBUG): Aggregate::initialize keepstation
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes] Running Loop=1
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2026-03-12T23:05:37.729Z,1773356737.729 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:BackseatDriver] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly:A] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly:B] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly:C] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly:D] Running Loop=1
2026-03-12T23:05:37.730Z,1773356737.730 [keepstation:PowerOnly:E.Wait] Running Loop=1
2026-03-12T23:05:37.731Z,1773356737.731 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2026-03-12T23:05:37.731Z,1773356737.731 [keepstation:H.Pitch] Running Loop=1
2026-03-12T23:05:37.731Z,1773356737.731 [keepstation:H.Pitch](DEBUG): Initialize.
2026-03-12T23:05:37.731Z,1773356737.731 [keepstation:B] Running Loop=1
2026-03-12T23:05:37.776Z,1773356737.776 [keepstation:H.Pitch] Running Loop=1
2026-03-12T23:05:37.776Z,1773356737.776 [keepstation:PowerOnly] Running Loop=1
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:PowerOnly:D] Stopped
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:PowerOnly:C] Stopped
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:PowerOnly:B] Stopped
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:PowerOnly:A] Stopped
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:BackseatDriver] Running Loop=1
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:StandardEnvelopes] Running Loop=1
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2026-03-12T23:05:37.777Z,1773356737.777 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2026-03-12T23:05:37.778Z,1773356737.778 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2026-03-12T23:05:37.778Z,1773356737.778 [keepstation:B] Stopped
2026-03-12T23:05:37.778Z,1773356737.778 [keepstation:D] Running Loop=1
2026-03-12T23:05:38.125Z,1773356738.125 [keepstation:D] Stopped
2026-03-12T23:05:38.125Z,1773356738.125 [keepstation:E] Running Loop=1
2026-03-12T23:05:38.533Z,1773356738.533 [keepstation:E] Stopped
2026-03-12T23:05:38.533Z,1773356738.533 [keepstation:StartingMission] Running Loop=1
2026-03-12T23:05:38.533Z,1773356738.533 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission
2026-03-12T23:05:38.929Z,1773356738.929 [keepstation:SurfaceComms] Running Loop=1
2026-03-12T23:05:38.929Z,1773356738.929 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-12T23:05:38.929Z,1773356738.929 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-12T23:05:38.929Z,1773356738.929 [keepstation:SurfaceComms:A] Stopped
2026-03-12T23:05:38.929Z,1773356738.929 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-12T23:05:38.930Z,1773356738.930 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-12T23:05:39.329Z,1773356739.329 [keepstation:NeedComms] Running Loop=1
2026-03-12T23:05:39.329Z,1773356739.329 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-12T23:05:39.329Z,1773356739.329 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-12T23:05:39.329Z,1773356739.329 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-12T23:05:39.330Z,1773356739.330 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-12T23:05:39.330Z,1773356739.330 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-12T23:05:39.330Z,1773356739.330 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-12T23:05:39.331Z,1773356739.331 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-12T23:05:39.331Z,1773356739.331 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-12T23:05:39.331Z,1773356739.331 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-12T23:05:39.332Z,1773356739.332 [keepstation:NeedComms:A] Running Loop=1
2026-03-12T23:05:39.333Z,1773356739.333 [keepstation:NeedComms:A](INFO): last time_fix was: 1773356516.000000 second since 1970/01/01T00:00:00Z
2026-03-12T23:05:39.333Z,1773356739.333 [keepstation:NeedComms:A] Stopped
2026-03-12T23:05:39.333Z,1773356739.333 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-12T23:05:39.333Z,1773356739.333 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-12T23:05:39.333Z,1773356739.333 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-12T23:05:39.735Z,1773356739.735 [keepstation:NeedComms:setActive:A] Stopped
2026-03-12T23:05:39.735Z,1773356739.735 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-12T23:05:40.145Z,1773356740.145 [keepstation:NeedComms:setActive:B] Stopped
2026-03-12T23:05:40.146Z,1773356740.146 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-12T23:05:40.146Z,1773356740.146 [keepstation:NeedComms:setActive] Stopped
2026-03-12T23:05:40.146Z,1773356740.146 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-12T23:05:40.539Z,1773356740.539 [keepstation:NeedComms:D] Running Loop=1
2026-03-12T23:05:40.940Z,1773356740.940 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense time_fix
2026-03-12T23:05:42.546Z,1773356742.546 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230537.00,A,3648.36840,N,12151.14641,W,0.350,195.33,120326,,,D*76
2026-03-12T23:05:42.549Z,1773356742.549 [NAL9602](INFO): GPS fix at 20260312T230537: (36.806140, -121.852440)
2026-03-12T23:05:42.561Z,1773356742.561 [keepstation:NeedComms:D] Stopped
2026-03-12T23:05:42.561Z,1773356742.561 [keepstation:NeedComms:E] Running Loop=1
2026-03-12T23:05:42.982Z,1773356742.982 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense platform_communications
2026-03-12T23:05:49.939Z,1773356749.939 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260312T230047/Courier0004.lzma
2026-03-12T23:05:50.941Z,1773356750.941 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Courier0004.lzma.bak
2026-03-12T23:05:50.941Z,1773356750.941 [DataOverHttps](INFO): SBD MOMSN=26726929
2026-03-12T23:05:53.866Z,1773356753.866 [NAL9602](INFO): SBD MO Status=0, MOMSN=13251, MT Status=0, MTMSN=0
2026-03-12T23:05:53.866Z,1773356753.866 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:06:06.996Z,1773356766.996 [DataOverHttps](INFO): Sending 372 bytes from file Logs/20260312T230047/Express0005.lzma
2026-03-12T23:06:07.998Z,1773356767.998 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Express0005.lzma.bak
2026-03-12T23:06:07.998Z,1773356767.998 [DataOverHttps](INFO): SBD MOMSN=26726934
2026-03-12T23:06:23.703Z,1773356783.703 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20260312T230047/Express0010.lzma
2026-03-12T23:06:24.569Z,1773356784.569 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:06:24.705Z,1773356784.705 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Express0010.lzma.bak
2026-03-12T23:06:24.706Z,1773356784.706 [DataOverHttps](INFO): SBD MOMSN=26726943
2026-03-12T23:06:26.198Z,1773356786.198 [keepstation:NeedComms:E] Stopped
2026-03-12T23:06:26.198Z,1773356786.198 [keepstation:NeedComms:F] Running Loop=1
2026-03-12T23:06:26.606Z,1773356786.606 [keepstation:NeedComms:F](DEBUG): Initialize ReadDataComponent to sense time_fix
2026-03-12T23:06:28.199Z,1773356788.199 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230623.00,A,3648.36510,N,12151.14959,W,0.389,225.73,120326,,,D*76
2026-03-12T23:06:28.201Z,1773356788.201 [NAL9602](INFO): GPS fix at 20260312T230623: (36.806085, -121.852493)
2026-03-12T23:06:28.253Z,1773356788.253 [keepstation:NeedComms:F] Stopped
2026-03-12T23:06:28.253Z,1773356788.253 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-12T23:06:28.253Z,1773356788.253 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:06:28.253Z,1773356788.253 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-12T23:06:28.657Z,1773356788.657 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-12T23:06:29.033Z,1773356789.033 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-12T23:06:29.033Z,1773356789.033 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-12T23:06:29.034Z,1773356789.034 [keepstation:NeedComms:setInactive] Stopped
2026-03-12T23:06:29.034Z,1773356789.034 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-12T23:06:29.034Z,1773356789.034 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-12T23:06:29.034Z,1773356789.034 [keepstation:NeedComms] Stopped
2026-03-12T23:06:29.035Z,1773356789.035 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-12T23:06:29.035Z,1773356789.035 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-12T23:06:29.035Z,1773356789.035 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:B] Stopped
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-12T23:06:29.450Z,1773356789.450 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:06:29.451Z,1773356789.451 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-12T23:06:29.857Z,1773356789.857 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-12T23:06:29.857Z,1773356789.857 [keepstation:SurfaceComms:HandleNan:SetOnStation](INFO): Completed keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:06:29.857Z,1773356789.857 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-12T23:06:29.857Z,1773356789.857 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:06:29.857Z,1773356789.857 [keepstation:SurfaceComms:HandleNan:SetLat] Running Loop=1
2026-03-12T23:06:29.857Z,1773356789.857 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLat
2026-03-12T23:06:29.858Z,1773356789.858 [keepstation:SurfaceComms:HandleNan:SetLat:A] Running Loop=1
2026-03-12T23:06:30.260Z,1773356790.260 [keepstation:SurfaceComms:HandleNan:SetLat:A] Stopped
2026-03-12T23:06:30.260Z,1773356790.260 [keepstation:SurfaceComms:HandleNan:SetLat](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLat
2026-03-12T23:06:30.260Z,1773356790.260 [keepstation:SurfaceComms:HandleNan:SetLat] Stopped
2026-03-12T23:06:30.260Z,1773356790.260 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLat
2026-03-12T23:06:30.261Z,1773356790.261 [keepstation:SurfaceComms:HandleNan:SetLon] Running Loop=1
2026-03-12T23:06:30.261Z,1773356790.261 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLon
2026-03-12T23:06:30.261Z,1773356790.261 [keepstation:SurfaceComms:HandleNan:SetLon:A] Running Loop=1
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan:SetLon:A] Stopped
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan:SetLon](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLon
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan:SetLon] Stopped
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLon
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan](INFO): Completed keepstation:SurfaceComms:HandleNan
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:06:30.648Z,1773356790.648 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-12T23:06:30.649Z,1773356790.649 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-12T23:06:30.649Z,1773356790.649 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-12T23:06:31.060Z,1773356791.060 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-12T23:06:31.060Z,1773356791.060 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-12T23:06:31.060Z,1773356791.060 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-12T23:06:31.060Z,1773356791.060 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-12T23:06:31.061Z,1773356791.061 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-12T23:06:31.061Z,1773356791.061 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-12T23:06:31.463Z,1773356791.463 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-12T23:06:31.463Z,1773356791.463 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-12T23:06:31.463Z,1773356791.463 [keepstation:SurfaceComms:setStation] Stopped
2026-03-12T23:06:31.464Z,1773356791.464 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-12T23:06:31.464Z,1773356791.464 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-12T23:06:31.464Z,1773356791.464 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-12T23:06:31.464Z,1773356791.464 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-12T23:06:31.847Z,1773356791.847 [keepstation:SurfaceComms:setSink] Stopped
2026-03-12T23:06:31.847Z,1773356791.847 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-12T23:06:31.848Z,1773356791.848 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-12T23:06:31.848Z,1773356791.848 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-12T23:06:31.848Z,1773356791.848 [keepstation:SurfaceComms] Stopped
2026-03-12T23:06:31.848Z,1773356791.848 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:StartingMission] Stopped
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:TransitToStation] Running Loop=1
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:TransitToStation:Dive:A] Running Loop=1
2026-03-12T23:06:32.249Z,1773356792.249 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2026-03-12T23:06:32.250Z,1773356792.250 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1
2026-03-12T23:06:32.250Z,1773356792.250 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2026-03-12T23:06:32.251Z,1773356792.251 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.806085,-121.852493
2026-03-12T23:06:32.662Z,1773356792.662 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.806085,-121.852493
2026-03-12T23:06:32.662Z,1773356792.662 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:06:32.662Z,1773356792.662 [keepstation:DiveCmd] Running Loop=1
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2026-03-12T23:06:32.663Z,1773356792.663 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2026-03-12T23:06:32.664Z,1773356792.664 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:06:32.665Z,1773356792.665 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-12T23:06:32.666Z,1773356792.666 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:06:32.666Z,1773356792.666 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:06:32.667Z,1773356792.667 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:06:32.667Z,1773356792.667 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:06:32.667Z,1773356792.667 [keepstation:DiveCmd:TransitToStation] Stopped
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:SurfaceSink] Stopped
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink
2026-03-12T23:06:32.668Z,1773356792.668 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2026-03-12T23:06:32.669Z,1773356792.669 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2026-03-12T23:06:32.669Z,1773356792.669 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2026-03-12T23:06:32.669Z,1773356792.669 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2026-03-12T23:06:32.669Z,1773356792.669 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2026-03-12T23:06:32.669Z,1773356792.669 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2026-03-12T23:06:32.669Z,1773356792.669 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2026-03-12T23:06:39.918Z,1773356799.918 [NAL9602](INFO): SBD MO Status=0, MOMSN=13252, MT Status=0, MTMSN=0
2026-03-12T23:06:39.918Z,1773356799.918 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:07:10.617Z,1773356830.617 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:09:18.296Z,1773356958.296 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:09:20.304Z,1773356960.304 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.263241
2026-03-12T23:09:53.436Z,1773356993.436 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:09:56.451Z,1773356996.451 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2026-03-12T23:09:56.816Z,1773356996.816 [Radio_Surface](INFO): Powering down
2026-03-12T23:10:42.751Z,1773357042.751 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:10:44.367Z,1773357044.367 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:10:57.701Z,1773357057.701 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:10:59.855Z,1773357059.855 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:13.214Z,1773357073.214 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:14.807Z,1773357074.807 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:28.140Z,1773357088.140 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:29.755Z,1773357089.755 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:43.153Z,1773357103.153 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:45.174Z,1773357105.174 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:11:58.512Z,1773357118.512 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:01.348Z,1773357121.348 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:13.857Z,1773357133.857 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:17.110Z,1773357137.110 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:28.826Z,1773357148.826 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:32.442Z,1773357152.442 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:44.560Z,1773357164.560 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:44.566Z,1773357164.566 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2026-03-12T23:12:47.400Z,1773357167.400 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:12:59.510Z,1773357179.510 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2026-03-12T23:13:02.762Z,1773357182.762 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2026-03-12T23:13:02.777Z,1773357182.777 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5.
2026-03-12T23:13:02.783Z,1773357182.783 [BPC1](INFO): Received data from all battery sticks.
2026-03-12T23:13:59.709Z,1773357239.709 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-12T23:21:28.307Z,1773357688.307 [keepstation:SurfaceComms] Running Loop=1
2026-03-12T23:21:28.307Z,1773357688.307 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-12T23:21:28.307Z,1773357688.307 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-12T23:21:28.308Z,1773357688.308 [keepstation:SurfaceComms:A] Stopped
2026-03-12T23:21:28.308Z,1773357688.308 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-12T23:21:28.308Z,1773357688.308 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-12T23:21:28.309Z,1773357688.309 [keepstation:NeedComms] Running Loop=1
2026-03-12T23:21:28.310Z,1773357688.310 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-12T23:21:28.310Z,1773357688.310 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-12T23:21:28.310Z,1773357688.310 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-12T23:21:28.310Z,1773357688.310 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-12T23:21:28.310Z,1773357688.310 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-12T23:21:28.311Z,1773357688.311 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-12T23:21:28.311Z,1773357688.311 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-12T23:21:28.312Z,1773357688.312 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-12T23:21:28.312Z,1773357688.312 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-12T23:21:28.312Z,1773357688.312 [keepstation:NeedComms:A] Running Loop=1
2026-03-12T23:21:28.314Z,1773357688.314 [keepstation:NeedComms:A](INFO): last time_fix was: 1773356783.000000 second since 1970/01/01T00:00:00Z
2026-03-12T23:21:28.314Z,1773357688.314 [keepstation:NeedComms:A] Stopped
2026-03-12T23:21:28.314Z,1773357688.314 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-12T23:21:28.314Z,1773357688.314 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-12T23:21:28.314Z,1773357688.314 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-12T23:21:28.727Z,1773357688.727 [keepstation:TransitToStation:Dive] Stopped
2026-03-12T23:21:28.727Z,1773357688.727 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2026-03-12T23:21:28.727Z,1773357688.727 [keepstation:TransitToStation:Dive:A] Stopped
2026-03-12T23:21:28.727Z,1773357688.727 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2026-03-12T23:21:28.732Z,1773357688.732 [keepstation:DiveCmd:StationKeep] Stopped
2026-03-12T23:21:28.732Z,1773357688.732 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2026-03-12T23:21:28.732Z,1773357688.732 [keepstation:DiveCmd:StationKeep:A] Stopped
2026-03-12T23:21:28.732Z,1773357688.732 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2026-03-12T23:21:28.732Z,1773357688.732 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2026-03-12T23:21:28.732Z,1773357688.732 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2026-03-12T23:21:28.735Z,1773357688.735 [keepstation:NeedComms:setActive:A] Stopped
2026-03-12T23:21:28.735Z,1773357688.735 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-12T23:21:29.154Z,1773357689.154 [keepstation:NeedComms:setActive:B] Stopped
2026-03-12T23:21:29.154Z,1773357689.154 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-12T23:21:29.155Z,1773357689.155 [keepstation:NeedComms:setActive] Stopped
2026-03-12T23:21:29.155Z,1773357689.155 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-12T23:23:20.562Z,1773357800.562 [keepstation:NeedComms:D] Running Loop=1
2026-03-12T23:23:21.144Z,1773357801.144 [Radio_Surface](INFO): Powering up
2026-03-12T23:23:21.184Z,1773357801.184 [Waterlinked](INFO): Powering down
2026-03-12T23:23:26.920Z,1773357806.920 [DataOverHttps](INFO): Radio surface powered ON.
2026-03-12T23:23:57.041Z,1773357837.041 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:24:00.062Z,1773357840.062 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-12T23:24:21.462Z,1773357861.462 [NAL9602](INFO): SBD MO Status=0, MOMSN=13253, MT Status=0, MTMSN=0
2026-03-12T23:24:21.462Z,1773357861.462 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:24:22.678Z,1773357862.678 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232417.00,A,3648.40250,N,12151.21518,W,0.816,226.07,120326,,,D*71
2026-03-12T23:24:22.681Z,1773357862.681 [NAL9602](INFO): GPS fix at 20260312T232417: (36.806708, -121.853586)
2026-03-12T23:24:22.716Z,1773357862.716 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.806085,-121.852493
2026-03-12T23:24:22.719Z,1773357862.719 [keepstation:NeedComms:D] Stopped
2026-03-12T23:24:22.719Z,1773357862.719 [keepstation:NeedComms:E] Running Loop=1
2026-03-12T23:24:32.180Z,1773357872.180 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:24:42.175Z,1773357882.175 [NAL9602](INFO): SBD MO Status=1, MOMSN=13254, MT Status=0, MTMSN=0
2026-03-12T23:24:42.236Z,1773357882.236 [NAL9602](INFO): Sent 201 bytes from file Logs/20260312T230047/Courier0012.lzma
2026-03-12T23:24:42.236Z,1773357882.236 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:24:55.615Z,1773357895.615 [NAL9602](INFO): SBD MO Status=1, MOMSN=13255, MT Status=0, MTMSN=0
2026-03-12T23:24:55.672Z,1773357895.672 [NAL9602](INFO): Sent 307 bytes from file Logs/20260312T230047/Express0013.lzma
2026-03-12T23:24:55.672Z,1773357895.672 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:25:07.324Z,1773357907.324 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:25:10.566Z,1773357910.566 [NAL9602](INFO): SBD MO Status=0, MOMSN=13256, MT Status=0, MTMSN=0
2026-03-12T23:25:10.651Z,1773357910.651 [keepstation:NeedComms:E] Stopped
2026-03-12T23:25:10.651Z,1773357910.651 [keepstation:NeedComms:F] Running Loop=1
2026-03-12T23:25:12.982Z,1773357912.982 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232508.00,A,3648.39877,N,12151.21935,W,0.136,199.64,120326,,,A*70
2026-03-12T23:25:12.984Z,1773357912.984 [NAL9602](INFO): GPS fix at 20260312T232508: (36.806646, -121.853656)
2026-03-12T23:25:12.996Z,1773357912.996 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.806085,-121.852493
2026-03-12T23:25:12.999Z,1773357912.999 [keepstation:NeedComms:F] Stopped
2026-03-12T23:25:12.999Z,1773357912.999 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-12T23:25:12.999Z,1773357912.999 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:25:13.020Z,1773357913.020 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-12T23:25:13.432Z,1773357913.432 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-12T23:25:13.432Z,1773357913.432 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-12T23:25:13.432Z,1773357913.432 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-12T23:25:13.432Z,1773357913.432 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:25:13.432Z,1773357913.432 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-12T23:25:13.432Z,1773357913.432 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-12T23:25:13.433Z,1773357913.433 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-12T23:25:13.803Z,1773357913.803 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-12T23:25:13.803Z,1773357913.803 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-12T23:25:13.803Z,1773357913.803 [keepstation:NeedComms:setInactive] Stopped
2026-03-12T23:25:13.803Z,1773357913.803 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-12T23:25:13.804Z,1773357913.804 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-12T23:25:13.804Z,1773357913.804 [keepstation:NeedComms] Stopped
2026-03-12T23:25:13.804Z,1773357913.804 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-12T23:25:13.804Z,1773357913.804 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-12T23:25:13.804Z,1773357913.804 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:B] Stopped
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:25:14.216Z,1773357914.216 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-12T23:25:14.613Z,1773357914.613 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-12T23:25:14.614Z,1773357914.614 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-12T23:25:15.023Z,1773357915.023 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-12T23:25:15.023Z,1773357915.023 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-12T23:25:15.024Z,1773357915.024 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-12T23:25:15.024Z,1773357915.024 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-12T23:25:15.024Z,1773357915.024 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-12T23:25:15.024Z,1773357915.024 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-12T23:25:15.418Z,1773357915.418 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-12T23:25:15.418Z,1773357915.418 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-12T23:25:15.418Z,1773357915.418 [keepstation:SurfaceComms:setStation] Stopped
2026-03-12T23:25:15.418Z,1773357915.418 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-12T23:25:15.418Z,1773357915.418 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-12T23:25:15.419Z,1773357915.419 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-12T23:25:15.419Z,1773357915.419 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-12T23:25:15.829Z,1773357915.829 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:25:15.829Z,1773357915.829 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2026-03-12T23:25:15.829Z,1773357915.829 [keepstation:TransitToStation:Dive:A] Running Loop=1
2026-03-12T23:25:15.829Z,1773357915.829 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:25:15.830Z,1773357915.830 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-12T23:25:15.832Z,1773357915.832 [keepstation:SurfaceComms:setSink] Stopped
2026-03-12T23:25:15.832Z,1773357915.832 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-12T23:25:15.832Z,1773357915.832 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-12T23:25:15.832Z,1773357915.832 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-12T23:25:15.833Z,1773357915.833 [keepstation:SurfaceComms] Stopped
2026-03-12T23:25:15.833Z,1773357915.833 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-12T23:25:42.464Z,1773357942.464 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:25:45.709Z,1773357945.709 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:26:17.609Z,1773357977.609 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:26:54.220Z,1773358014.220 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003117
2026-03-12T23:27:28.896Z,1773358048.896 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-03-12T23:28:40.045Z,1773358120.045 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-03-12T23:28:43.056Z,1773358123.056 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.659035
2026-03-12T23:29:15.184Z,1773358155.184 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:29:50.333Z,1773358190.333 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:29:52.340Z,1773358192.340 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2026-03-12T23:29:52.664Z,1773358192.664 [Radio_Surface](INFO): Powering down
2026-03-12T23:34:00.278Z,1773358440.278 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-12T23:40:13.193Z,1773358813.193 [keepstation:SurfaceComms] Running Loop=1
2026-03-12T23:40:13.193Z,1773358813.193 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-12T23:40:13.193Z,1773358813.193 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-12T23:40:13.193Z,1773358813.193 [keepstation:SurfaceComms:A] Stopped
2026-03-12T23:40:13.194Z,1773358813.194 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-12T23:40:13.194Z,1773358813.194 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-12T23:40:13.195Z,1773358813.195 [keepstation:NeedComms] Running Loop=1
2026-03-12T23:40:13.196Z,1773358813.196 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-12T23:40:13.196Z,1773358813.196 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-12T23:40:13.196Z,1773358813.196 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-12T23:40:13.196Z,1773358813.196 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-12T23:40:13.196Z,1773358813.196 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-12T23:40:13.197Z,1773358813.197 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-12T23:40:13.197Z,1773358813.197 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-12T23:40:13.197Z,1773358813.197 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-12T23:40:13.198Z,1773358813.198 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-12T23:40:13.198Z,1773358813.198 [keepstation:NeedComms:A] Running Loop=1
2026-03-12T23:40:13.200Z,1773358813.200 [keepstation:NeedComms:A](INFO): last time_fix was: 1773357908.000000 second since 1970/01/01T00:00:00Z
2026-03-12T23:40:13.200Z,1773358813.200 [keepstation:NeedComms:A] Stopped
2026-03-12T23:40:13.200Z,1773358813.200 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-12T23:40:13.200Z,1773358813.200 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-12T23:40:13.200Z,1773358813.200 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-12T23:40:13.734Z,1773358813.734 [keepstation:TransitToStation:Dive] Stopped
2026-03-12T23:40:13.734Z,1773358813.734 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2026-03-12T23:40:13.734Z,1773358813.734 [keepstation:TransitToStation:Dive:A] Stopped
2026-03-12T23:40:13.734Z,1773358813.734 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2026-03-12T23:40:13.734Z,1773358813.734 [keepstation:DiveCmd:StationKeep] Stopped
2026-03-12T23:40:13.734Z,1773358813.734 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2026-03-12T23:40:13.735Z,1773358813.735 [keepstation:DiveCmd:StationKeep:A] Stopped
2026-03-12T23:40:13.735Z,1773358813.735 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2026-03-12T23:40:13.735Z,1773358813.735 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2026-03-12T23:40:13.735Z,1773358813.735 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2026-03-12T23:40:13.738Z,1773358813.738 [keepstation:NeedComms:setActive:A] Stopped
2026-03-12T23:40:13.738Z,1773358813.738 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-12T23:40:14.089Z,1773358814.089 [keepstation:NeedComms:setActive:B] Stopped
2026-03-12T23:40:14.089Z,1773358814.089 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-12T23:40:14.089Z,1773358814.089 [keepstation:NeedComms:setActive] Stopped
2026-03-12T23:40:14.090Z,1773358814.090 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-12T23:40:32.309Z,1773358832.309 [Waterlinked](ERROR): only read 0 of 1 data item for BIT error. Device response::TS,24052713 0
2026-03-12T23:42:23.937Z,1773358943.937 [keepstation:NeedComms:D] Running Loop=1
2026-03-12T23:42:24.412Z,1773358944.412 [Waterlinked](INFO): Powering down
2026-03-12T23:42:24.696Z,1773358944.696 [Radio_Surface](INFO): Powering up
2026-03-12T23:42:30.496Z,1773358950.496 [DataOverHttps](INFO): Radio surface powered ON.
2026-03-12T23:43:00.616Z,1773358980.616 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:43:22.958Z,1773359002.958 [NAL9602](INFO): SBD MO Status=2, MOMSN=13257, MT Status=2, MTMSN=0
2026-03-12T23:43:22.958Z,1773359002.958 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:43:35.756Z,1773359015.756 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:43:54.464Z,1773359034.464 [NAL9602](INFO): SBD MO Status=2, MOMSN=13257, MT Status=2, MTMSN=0
2026-03-12T23:43:54.465Z,1773359034.465 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:44:00.529Z,1773359040.529 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-12T23:44:10.896Z,1773359050.896 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:44:17.496Z,1773359057.496 [NAL9602](INFO): SBD MO Status=2, MOMSN=13257, MT Status=2, MTMSN=0
2026-03-12T23:44:17.496Z,1773359057.496 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:44:46.044Z,1773359086.044 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:44:46.181Z,1773359086.181 [NAL9602](INFO): SBD MO Status=0, MOMSN=13257, MT Status=0, MTMSN=0
2026-03-12T23:44:46.182Z,1773359086.182 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:44:47.391Z,1773359087.391 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234442.00,A,3648.33614,N,12151.25627,W,0.719,243.86,120326,,,D*76
2026-03-12T23:44:47.393Z,1773359087.393 [NAL9602](INFO): GPS fix at 20260312T234442: (36.805602, -121.854271)
2026-03-12T23:44:47.405Z,1773359087.405 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.806085,-121.852493
2026-03-12T23:44:47.408Z,1773359087.408 [keepstation:NeedComms:D] Stopped
2026-03-12T23:44:47.408Z,1773359087.408 [keepstation:NeedComms:E] Running Loop=1
2026-03-12T23:45:05.018Z,1773359105.018 [NAL9602](INFO): SBD MO Status=1, MOMSN=13258, MT Status=0, MTMSN=0
2026-03-12T23:45:05.072Z,1773359105.072 [NAL9602](INFO): Sent 73 bytes from file Logs/20260312T230047/Courier0015.lzma
2026-03-12T23:45:05.072Z,1773359105.072 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:45:21.212Z,1773359121.212 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:45:23.258Z,1773359123.258 [NAL9602](INFO): SBD MO Status=2, MOMSN=13259, MT Status=2, MTMSN=0
2026-03-12T23:45:23.258Z,1773359123.258 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:45:46.363Z,1773359146.363 [NAL9602](INFO): SBD MO Status=2, MOMSN=13259, MT Status=2, MTMSN=0
2026-03-12T23:45:46.363Z,1773359146.363 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:45:54.048Z,1773359154.048 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003104
2026-03-12T23:46:01.552Z,1773359161.552 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20260312T230047/Express0016.lzma
2026-03-12T23:46:02.553Z,1773359162.553 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Express0016.lzma.bak
2026-03-12T23:46:02.554Z,1773359162.554 [DataOverHttps](INFO): SBD MOMSN=26727276
2026-03-12T23:46:04.094Z,1773359164.094 [keepstation:NeedComms:E] Stopped
2026-03-12T23:46:04.095Z,1773359164.095 [keepstation:NeedComms:F] Running Loop=1
2026-03-12T23:46:12.166Z,1773359172.166 [NAL9602](INFO): SBD MO Status=2, MOMSN=13259, MT Status=2, MTMSN=0
2026-03-12T23:46:12.167Z,1773359172.167 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:46:13.380Z,1773359173.380 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234608.00,A,3648.32944,N,12151.26018,W,0.505,221.72,120326,,,D*78
2026-03-12T23:46:13.382Z,1773359173.382 [NAL9602](INFO): GPS fix at 20260312T234608: (36.805491, -121.854336)
2026-03-12T23:46:13.394Z,1773359173.394 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.806085,-121.852493
2026-03-12T23:46:13.397Z,1773359173.397 [keepstation:NeedComms:F] Stopped
2026-03-12T23:46:13.397Z,1773359173.397 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-12T23:46:13.397Z,1773359173.397 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:46:13.397Z,1773359173.397 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-12T23:46:13.810Z,1773359173.810 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-12T23:46:13.810Z,1773359173.810 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-12T23:46:13.810Z,1773359173.810 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-12T23:46:13.810Z,1773359173.810 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:46:13.810Z,1773359173.810 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-12T23:46:13.811Z,1773359173.811 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-12T23:46:13.811Z,1773359173.811 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-12T23:46:14.194Z,1773359174.194 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-12T23:46:14.194Z,1773359174.194 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-12T23:46:14.194Z,1773359174.194 [keepstation:NeedComms:setInactive] Stopped
2026-03-12T23:46:14.194Z,1773359174.194 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-12T23:46:14.195Z,1773359174.195 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-12T23:46:14.195Z,1773359174.195 [keepstation:NeedComms] Stopped
2026-03-12T23:46:14.195Z,1773359174.195 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-12T23:46:14.195Z,1773359174.195 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-12T23:46:14.195Z,1773359174.195 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:46:14.598Z,1773359174.598 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-12T23:46:14.598Z,1773359174.598 [keepstation:SurfaceComms:B] Stopped
2026-03-12T23:46:14.598Z,1773359174.598 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-12T23:46:14.598Z,1773359174.598 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-12T23:46:14.598Z,1773359174.598 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:46:14.599Z,1773359174.599 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-12T23:46:14.599Z,1773359174.599 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:46:14.599Z,1773359174.599 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-12T23:46:15.124Z,1773359175.124 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-12T23:46:15.125Z,1773359175.125 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-12T23:46:15.405Z,1773359175.405 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-12T23:46:15.405Z,1773359175.405 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-12T23:46:15.405Z,1773359175.405 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-12T23:46:15.405Z,1773359175.405 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-12T23:46:15.405Z,1773359175.405 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-12T23:46:15.405Z,1773359175.405 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-12T23:46:15.807Z,1773359175.807 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-12T23:46:15.808Z,1773359175.808 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-12T23:46:15.808Z,1773359175.808 [keepstation:SurfaceComms:setStation] Stopped
2026-03-12T23:46:15.808Z,1773359175.808 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-12T23:46:15.808Z,1773359175.808 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-12T23:46:15.808Z,1773359175.808 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-12T23:46:15.808Z,1773359175.808 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-12T23:46:16.219Z,1773359176.219 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:46:16.219Z,1773359176.219 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2026-03-12T23:46:16.219Z,1773359176.219 [keepstation:TransitToStation:Dive:A] Running Loop=1
2026-03-12T23:46:16.219Z,1773359176.219 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:46:16.220Z,1773359176.220 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-12T23:46:16.222Z,1773359176.222 [keepstation:SurfaceComms:setSink] Stopped
2026-03-12T23:46:16.222Z,1773359176.222 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-12T23:46:16.222Z,1773359176.222 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-12T23:46:16.222Z,1773359176.222 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-12T23:46:16.222Z,1773359176.222 [keepstation:SurfaceComms] Stopped
2026-03-12T23:46:16.222Z,1773359176.222 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-12T23:46:45.689Z,1773359205.689 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:54:00.806Z,1773359640.806 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-12T23:55:28.784Z,1773359728.784 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2026-03-12T23:55:30.792Z,1773359730.792 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.615173
2026-03-12T23:56:03.940Z,1773359763.940 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:56:31.196Z,1773359791.196 [Radio_Surface](INFO): Powering down
2026-03-12T23:56:39.080Z,1773359799.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:56:40.085Z,1773359800.085 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2026-03-13T00:01:13.607Z,1773360073.607 [keepstation:SurfaceComms] Running Loop=1
2026-03-13T00:01:13.608Z,1773360073.608 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-13T00:01:13.608Z,1773360073.608 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-13T00:01:13.609Z,1773360073.609 [keepstation:SurfaceComms:A] Stopped
2026-03-13T00:01:13.609Z,1773360073.609 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-13T00:01:13.610Z,1773360073.610 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-13T00:01:13.614Z,1773360073.614 [keepstation:NeedComms] Running Loop=1
2026-03-13T00:01:13.614Z,1773360073.614 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-13T00:01:13.614Z,1773360073.614 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-13T00:01:13.614Z,1773360073.614 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-13T00:01:13.615Z,1773360073.615 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-13T00:01:13.616Z,1773360073.616 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-13T00:01:13.617Z,1773360073.617 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-13T00:01:13.618Z,1773360073.618 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-13T00:01:13.618Z,1773360073.618 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-13T00:01:13.619Z,1773360073.619 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-13T00:01:13.640Z,1773360073.640 [keepstation:NeedComms:A] Running Loop=1
2026-03-13T00:01:13.648Z,1773360073.648 [keepstation:NeedComms:A](INFO): last time_fix was: 1773359168.000000 second since 1970/01/01T00:00:00Z
2026-03-13T00:01:13.648Z,1773360073.648 [keepstation:NeedComms:A] Stopped
2026-03-13T00:01:13.649Z,1773360073.649 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-13T00:01:13.649Z,1773360073.649 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-13T00:01:13.649Z,1773360073.649 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-13T00:01:13.945Z,1773360073.945 [keepstation:TransitToStation:Dive] Stopped
2026-03-13T00:01:13.945Z,1773360073.945 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2026-03-13T00:01:13.945Z,1773360073.945 [keepstation:TransitToStation:Dive:A] Stopped
2026-03-13T00:01:13.945Z,1773360073.945 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2026-03-13T00:01:13.946Z,1773360073.946 [keepstation:DiveCmd:StationKeep] Stopped
2026-03-13T00:01:13.946Z,1773360073.946 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2026-03-13T00:01:13.946Z,1773360073.946 [keepstation:DiveCmd:StationKeep:A] Stopped
2026-03-13T00:01:13.946Z,1773360073.946 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2026-03-13T00:01:13.946Z,1773360073.946 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2026-03-13T00:01:13.946Z,1773360073.946 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2026-03-13T00:01:13.949Z,1773360073.949 [keepstation:NeedComms:setActive:A] Stopped
2026-03-13T00:01:13.949Z,1773360073.949 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-13T00:01:14.398Z,1773360074.398 [keepstation:NeedComms:setActive:B] Stopped
2026-03-13T00:01:14.398Z,1773360074.398 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-13T00:01:14.398Z,1773360074.398 [keepstation:NeedComms:setActive] Stopped
2026-03-13T00:01:14.398Z,1773360074.398 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-13T00:01:46.881Z,1773360106.881 [Waterlinked](ERROR): only read 0 of 1 data item for altitude. Device response::BD, , 0.00
2026-03-13T00:02:26.322Z,1773360146.322 [keepstation:NeedComms:D] Running Loop=1
2026-03-13T00:02:26.881Z,1773360146.881 [Radio_Surface](INFO): Powering up
2026-03-13T00:02:26.952Z,1773360146.952 [Waterlinked](INFO): Powering down
2026-03-13T00:02:32.568Z,1773360152.568 [DataOverHttps](INFO): Radio surface powered ON.
2026-03-13T00:03:02.688Z,1773360182.688 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:03:37.840Z,1773360217.840 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:03:50.673Z,1773360230.673 [NAL9602](INFO): SBD MO Status=1, MOMSN=13259, MT Status=0, MTMSN=0
2026-03-13T00:03:50.673Z,1773360230.673 [NAL9602](INFO): No messages in MT queue
2026-03-13T00:03:50.965Z,1773360230.965 [DAT](INFO): DAT read: user:12>Rx Time:00:03:50.2840
2026-03-13T00:03:50.966Z,1773360230.966 [DAT](INFO): Rx dataTimestamp_ set to:1773360230.965666
2026-03-13T00:03:50.966Z,1773360230.966 [DAT](INFO): DAT read:
2026-03-13T00:03:50.967Z,1773360230.967 [DAT](INFO): DAT read: $Packet for address 0
2026-03-13T00:03:50.967Z,1773360230.967 [DAT](INFO): received a packet notification
2026-03-13T00:03:51.886Z,1773360231.886 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000347.00,A,3648.31349,N,12151.28831,W,0.447,200.70,130326,,,D*7D
2026-03-13T00:03:51.888Z,1773360231.888 [NAL9602](INFO): GPS fix at 20260313T000347: (36.805225, -121.854805)
2026-03-13T00:03:51.900Z,1773360231.900 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.806085,-121.852493
2026-03-13T00:03:51.903Z,1773360231.903 [keepstation:NeedComms:D] Stopped
2026-03-13T00:03:51.903Z,1773360231.903 [keepstation:NeedComms:E] Running Loop=1
2026-03-13T00:04:01.204Z,1773360241.204 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging
2026-03-13T00:04:12.980Z,1773360252.980 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:04:23.666Z,1773360263.666 [NAL9602](INFO): SBD MO Status=2, MOMSN=13260, MT Status=2, MTMSN=0
2026-03-13T00:04:23.666Z,1773360263.666 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-13T00:04:41.560Z,1773360281.560 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2026-03-13T00:04:41.560Z,1773360281.560 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2026-03-13T00:04:41.560Z,1773360281.560 [BuoyancyServo] Communications Fault, FailCount= 1
2026-03-13T00:04:41.560Z,1773360281.560 [BuoyancyServo](ERROR): Communications Fault
2026-03-13T00:04:41.567Z,1773360281.567 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2026-03-13T00:04:43.485Z,1773360283.485 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2026-03-13T00:04:43.485Z,1773360283.485 [BuoyancyServo](INFO): Powering down
2026-03-13T00:04:44.328Z,1773360284.328 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2026-03-13T00:04:44.328Z,1773360284.328 [BuoyancyServo] No Fault, FailCount= 1
2026-03-13T00:04:44.697Z,1773360284.697 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2026-03-13T00:04:44.698Z,1773360284.698 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2026-03-13T00:04:48.120Z,1773360288.120 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:05:23.260Z,1773360323.260 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:05:24.985Z,1773360324.985 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=13260, MT Status=1, MTMSN=1633
2026-03-13T00:05:25.050Z,1773360325.050 [NAL9602](INFO): Sent 73 bytes from file Logs/20260312T230047/Courier0018.lzma
2026-03-13T00:05:25.050Z,1773360325.050 [NAL9602](INFO): Packets left to send: 0
2026-03-13T00:05:25.472Z,1773360325.472 [NAL9602](INFO): Received command: stop
2026-03-13T00:05:25.476Z,1773360325.476 [CommandExec](IMPORTANT): got command stop
2026-03-13T00:05:25.476Z,1773360325.476 [CommandExec](IMPORTANT): Scheduling is paused
2026-03-13T00:05:25.477Z,1773360325.477 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2026-03-13T00:05:25.494Z,1773360325.494 [MissionManager](INFO): MissionManager is completed.
2026-03-13T00:05:25.494Z,1773360325.494 [MissionManager](INFO): Uninitializing Mission keepstation
2026-03-13T00:05:25.494Z,1773360325.494 [keepstation] Stopped
2026-03-13T00:05:25.494Z,1773360325.494 [keepstation](DEBUG): Aggregate::uninitialize keepstation
2026-03-13T00:05:25.494Z,1773360325.494 [keepstation:NeedComms] Stopped
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:NeedComms:E] Stopped
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:StandardEnvelopes] Stopped
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped
2026-03-13T00:05:25.495Z,1773360325.495 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:BackseatDriver] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:BackseatDriver:A.BackseatDriver] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:PowerOnly] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:PowerOnly:E.Wait] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:H.Pitch] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:SurfaceComms] Stopped
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-13T00:05:25.496Z,1773360325.496 [keepstation:SurfaceComms:B] Stopped
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:DiveCmd] Stopped
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:DiveCmd](DEBUG): Aggregate::uninitialize keepstation:DiveCmd
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:TransitToStation] Stopped
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped
2026-03-13T00:05:25.497Z,1773360325.497 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2026-03-13T00:05:25.804Z,1773360325.804 [MissionManager](IMPORTANT): Started mission Default
2026-03-13T00:05:25.805Z,1773360325.805 [Default] Running Loop=1
2026-03-13T00:05:25.805Z,1773360325.805 [Default](DEBUG): Aggregate::initialize Default
2026-03-13T00:05:25.805Z,1773360325.805 [Default:B.GoToSurface] Running Loop=1
2026-03-13T00:05:25.805Z,1773360325.805 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-13T00:05:25.805Z,1773360325.805 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2026-03-13T00:05:25.805Z,1773360325.805 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2026-03-13T00:05:25.806Z,1773360325.806 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2026-03-13T00:05:25.806Z,1773360325.806 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2026-03-13T00:05:25.806Z,1773360325.806 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-13T00:05:25.807Z,1773360325.807 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-13T00:05:25.807Z,1773360325.807 [Default:A.Wait] Running Loop=1
2026-03-13T00:05:25.807Z,1773360325.807 [Default:A.Wait](DEBUG): Initialize Wait Component.
2026-03-13T00:05:39.139Z,1773360339.139 [Default:A.Wait](INFO): Done Waiting.
2026-03-13T00:05:39.139Z,1773360339.139 [Default:A.Wait] Stopped
2026-03-13T00:05:39.141Z,1773360339.141 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2026-03-13T00:05:39.548Z,1773360339.548 [Default:CheckIn] Running Loop=1
2026-03-13T00:05:39.548Z,1773360339.548 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2026-03-13T00:05:39.548Z,1773360339.548 [Default:CheckIn:Read_GPS] Running Loop=1
2026-03-13T00:05:41.554Z,1773360341.554 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000536.00,A,3648.30739,N,12151.29683,W,0.253,249.51,130326,,,A*71
2026-03-13T00:05:41.558Z,1773360341.558 [NAL9602](INFO): GPS fix at 20260313T000536: (36.805123, -121.854947)
2026-03-13T00:05:41.589Z,1773360341.589 [Default:CheckIn:Read_GPS] Stopped
2026-03-13T00:05:41.589Z,1773360341.589 [Default:CheckIn:Read_Iridium] Running Loop=1
2026-03-13T00:05:59.836Z,1773360359.836 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003118
2026-03-13T00:06:07.931Z,1773360367.931 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20260312T230047/Courier0021.lzma
2026-03-13T00:06:08.933Z,1773360368.933 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Courier0021.lzma.bak
2026-03-13T00:06:08.934Z,1773360368.934 [DataOverHttps](INFO): SBD MOMSN=26727404
2026-03-13T00:06:22.414Z,1773360382.414 [NAL9602](INFO): SBD MO Status=2, MOMSN=13261, MT Status=2, MTMSN=0
2026-03-13T00:06:22.415Z,1773360382.415 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-13T00:06:25.916Z,1773360385.916 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20260312T230047/Express0019.lzma
2026-03-13T00:06:26.933Z,1773360386.933 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Express0019.lzma.bak
2026-03-13T00:06:26.933Z,1773360386.933 [DataOverHttps](INFO): SBD MOMSN=26727407
2026-03-13T00:06:43.188Z,1773360403.188 [DataOverHttps](INFO): Sending 296 bytes from file Logs/20260312T230047/Express0022.lzma
2026-03-13T00:06:44.190Z,1773360404.190 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230047/Express0022.lzma.bak
2026-03-13T00:06:44.190Z,1773360404.190 [DataOverHttps](INFO): SBD MOMSN=26727411
2026-03-13T00:06:45.872Z,1773360405.872 [Default:CheckIn:Read_Iridium] Stopped
2026-03-13T00:06:45.872Z,1773360405.872 [Default:CheckIn:C.Wait] Running Loop=1
2026-03-13T00:06:45.872Z,1773360405.872 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2026-03-13T00:06:53.116Z,1773360413.116 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-13T00:08:39.197Z,1773360519.197 [DataOverHttps](IMPORTANT): SBD MTMSN=20260313T000834
2026-03-13T00:08:51.007Z,1773360531.007 [DataOverHttps](INFO): Received command: restart logs;schedule resume