2026-03-12T23:00:54.131Z,1773356454.131 [DataOverHttps](INFO): Received command: restart logs
2026-03-12T23:00:54.145Z,1773356454.145 [CommandExec](IMPORTANT): got command restart logs
2026-03-12T23:01:05.476Z,1773356465.476 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:05:45.612Z,1773356745.612 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2026-03-12T23:05:45.612Z,1773356745.612 [Default:CheckIn:C.Wait] Stopped
2026-03-12T23:05:45.612Z,1773356745.612 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2026-03-12T23:05:45.612Z,1773356745.612 [Default:CheckIn:D] Running Loop=1
2026-03-12T23:05:46.024Z,1773356746.024 [Default:CheckIn:D] Stopped
2026-03-12T23:05:46.025Z,1773356746.025 [Default:CheckIn:E] Running Loop=1
2026-03-12T23:05:46.418Z,1773356746.418 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.557694 min
2026-03-12T23:05:46.418Z,1773356746.418 [Default:CheckIn:E] Stopped
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn](INFO): Completed Default:CheckIn
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn] Stopped
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn](INFO): Running loop #3
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn] Running Loop=3
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2026-03-12T23:05:46.419Z,1773356746.419 [Default:CheckIn:Read_GPS] Running Loop=1
2026-03-12T23:05:48.429Z,1773356748.429 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230547.00,A,3648.26636,N,12151.04475,W,1.497,197.93,120326,,,D*7E
2026-03-12T23:05:48.432Z,1773356748.432 [NAL9602](INFO): GPS fix at 20260312T230547: (36.804439, -121.850746)
2026-03-12T23:05:48.442Z,1773356748.442 [Default:CheckIn:Read_GPS] Stopped
2026-03-12T23:05:48.442Z,1773356748.442 [Default:CheckIn:Read_Iridium] Running Loop=1
2026-03-12T23:05:55.739Z,1773356755.739 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260312T221930/Courier0015.lzma
2026-03-12T23:05:56.741Z,1773356756.741 [DataOverHttps](INFO): Moved sent file to Logs/20260312T221930/Courier0015.lzma.bak
2026-03-12T23:05:56.742Z,1773356756.742 [DataOverHttps](IMPORTANT): SBD MOMSN=26726932, MTMSN=20260312T230555
2026-03-12T23:06:04.139Z,1773356764.139 [DataOverHttps](INFO): Received command: load Transport/keepstation.tl;set keepstation.NeedCommsTime 15 min;run
2026-03-12T23:06:04.221Z,1773356764.221 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl
2026-03-12T23:06:04.222Z,1773356764.222 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl
2026-03-12T23:06:04.222Z,1773356764.222 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl
2026-03-12T23:06:04.245Z,1773356764.245 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl
2026-03-12T23:06:05.699Z,1773356765.699 [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:06:05.708Z,1773356765.708 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h
2026-03-12T23:06:05.710Z,1773356765.710 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min
2026-03-12T23:06:05.712Z,1773356765.712 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg
2026-03-12T23:06:05.715Z,1773356765.715 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg
2026-03-12T23:06:05.717Z,1773356765.717 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m
2026-03-12T23:06:05.719Z,1773356765.719 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m
2026-03-12T23:06:05.721Z,1773356765.721 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m
2026-03-12T23:06:05.724Z,1773356765.724 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s
2026-03-12T23:06:05.726Z,1773356765.726 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m
2026-03-12T23:06:05.728Z,1773356765.728 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool
2026-03-12T23:06:05.731Z,1773356765.731 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m
2026-03-12T23:06:05.733Z,1773356765.733 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min
2026-03-12T23:06:05.767Z,1773356765.767 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m
2026-03-12T23:06:05.770Z,1773356765.770 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km
2026-03-12T23:06:05.776Z,1773356765.776 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count
2026-03-12T23:06:05.779Z,1773356765.779 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count
2026-03-12T23:06:05.781Z,1773356765.781 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count
2026-03-12T23:06:05.824Z,1773356765.824 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count
2026-03-12T23:06:05.826Z,1773356765.826 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count
2026-03-12T23:06:05.833Z,1773356765.833 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool
2026-03-12T23:06:05.833Z,1773356765.833 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2026-03-12T23:06:05.833Z,1773356765.833 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2026-03-12T23:06:05.835Z,1773356765.835 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2026-03-12T23:06:06.186Z,1773356766.186 [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:06:06.220Z,1773356766.220 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h
2026-03-12T23:06:06.222Z,1773356766.222 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min
2026-03-12T23:06:06.258Z,1773356766.258 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg
2026-03-12T23:06:06.268Z,1773356766.268 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s
2026-03-12T23:06:06.271Z,1773356766.271 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s
2026-03-12T23:06:06.281Z,1773356766.281 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1500.000000 s
2026-03-12T23:06:06.287Z,1773356766.287 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min
2026-03-12T23:06:06.290Z,1773356766.290 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min
2026-03-12T23:06:06.295Z,1773356766.295 [MissionManager](INFO): DefineArg keepstation:NeedComms.DoingCommsMode = 0.000000 count
2026-03-12T23:06:06.305Z,1773356766.305 [MissionManager](INFO): DefineArg keepstation:NeedComms.RestoreMode = 0.000000 count
2026-03-12T23:06:06.312Z,1773356766.312 [MissionManager](INFO): DefineOutput keepstation:NeedComms.IsActive = 0 bool
2026-03-12T23:06:06.314Z,1773356766.314 [MissionManager](INFO): DefineOutput keepstation:NeedComms.RequiredDiveMode = 0.000000 count
2026-03-12T23:06:06.348Z,1773356766.348 [keepstation:NeedComms:C.GoToSurface](DEBUG): Construct GoToSurface.
2026-03-12T23:06:06.382Z,1773356766.382 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2026-03-12T23:06:06.383Z,1773356766.383 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2026-03-12T23:06:06.400Z,1773356766.400 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2026-03-12T23:06:06.495Z,1773356766.495 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
1.5
200
2000
2026-03-12T23:06:06.499Z,1773356766.499 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m
2026-03-12T23:06:06.501Z,1773356766.501 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2026-03-12T23:06:06.503Z,1773356766.503 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m
2026-03-12T23:06:06.505Z,1773356766.505 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m
2026-03-12T23:06:06.506Z,1773356766.506 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2026-03-12T23:06:06.512Z,1773356766.512 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2026-03-12T23:06:06.519Z,1773356766.519 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2026-03-12T23:06:06.526Z,1773356766.526 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2026-03-12T23:06:06.526Z,1773356766.526 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2026-03-12T23:06:06.527Z,1773356766.527 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2026-03-12T23:06:06.580Z,1773356766.580 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2026-03-12T23:06:06.583Z,1773356766.583 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool
2026-03-12T23:06:06.585Z,1773356766.585 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2026-03-12T23:06:06.588Z,1773356766.588 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2026-03-12T23:06:06.588Z,1773356766.588 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2026-03-12T23:06:06.589Z,1773356766.589 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2026-03-12T23:06:06.758Z,1773356766.758 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2026-03-12T23:06:06.762Z,1773356766.762 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool
2026-03-12T23:06:06.764Z,1773356766.764 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool
2026-03-12T23:06:06.766Z,1773356766.766 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool
2026-03-12T23:06:06.768Z,1773356766.768 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool
2026-03-12T23:06:06.771Z,1773356766.771 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool
2026-03-12T23:06:06.782Z,1773356766.782 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait.
2026-03-12T23:06:06.784Z,1773356766.784 [keepstation:H.Pitch](DEBUG): Construct.
2026-03-12T23:06:06.873Z,1773356766.873 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2026-03-12T23:06:06.876Z,1773356766.876 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct.
2026-03-12T23:06:06.879Z,1773356766.879 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct.
2026-03-12T23:06:06.892Z,1773356766.892 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy.
2026-03-12T23:06:06.895Z,1773356766.895 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct.
2026-03-12T23:06:06.899Z,1773356766.899 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct.
2026-03-12T23:06:06.904Z,1773356766.904 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct.
2026-03-12T23:06:06.909Z,1773356766.909 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation.
2026-03-12T23:06:06.927Z,1773356766.927 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2026-03-12T23:06:06.938Z,1773356766.938 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait.
2026-03-12T23:06:06.958Z,1773356766.958 [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:06:06.959Z,1773356766.959 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation
2026-03-12T23:06:09.438Z,1773356769.438 [NAL9602](INFO): SBD MO Status=2, MOMSN=32656, MT Status=2, MTMSN=0
2026-03-12T23:06:09.438Z,1773356769.438 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:06:13.682Z,1773356773.682 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 15 minute
2026-03-12T23:06:13.683Z,1773356773.683 [CommandExec](IMPORTANT): got command run
2026-03-12T23:06:13.689Z,1773356773.689 [CommandExec](IMPORTANT): Running
2026-03-12T23:06:13.915Z,1773356773.915 [Default] Stopped
2026-03-12T23:06:13.915Z,1773356773.915 [Default](DEBUG): Aggregate::uninitialize Default
2026-03-12T23:06:13.919Z,1773356773.919 [Default:B.GoToSurface] Stopped
2026-03-12T23:06:13.919Z,1773356773.919 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:06:13.919Z,1773356773.919 [Default:CheckIn] Stopped
2026-03-12T23:06:13.920Z,1773356773.920 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2026-03-12T23:06:13.920Z,1773356773.920 [Default:CheckIn:Read_Iridium] Stopped
2026-03-12T23:06:13.920Z,1773356773.920 [MissionManager](IMPORTANT): Started mission keepstation
2026-03-12T23:06:13.920Z,1773356773.920 [keepstation] Running Loop=1
2026-03-12T23:06:13.920Z,1773356773.920 [keepstation](DEBUG): Aggregate::initialize keepstation
2026-03-12T23:06:13.920Z,1773356773.920 [keepstation:StandardEnvelopes] Running Loop=1
2026-03-12T23:06:13.920Z,1773356773.920 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes
2026-03-12T23:06:13.920Z,1773356773.920 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:BackseatDriver] Running Loop=1
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1
2026-03-12T23:06:13.921Z,1773356773.921 [keepstation:PowerOnly] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly:A] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly:B] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly:C] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly:D] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly:E.Wait] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:H.Pitch] Running Loop=1
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:H.Pitch](DEBUG): Initialize.
2026-03-12T23:06:13.922Z,1773356773.922 [keepstation:B] Running Loop=1
2026-03-12T23:06:13.928Z,1773356773.928 [keepstation:H.Pitch] Running Loop=1
2026-03-12T23:06:13.928Z,1773356773.928 [keepstation:PowerOnly] Running Loop=1
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:PowerOnly:D] Stopped
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:PowerOnly:C] Stopped
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:PowerOnly:B] Stopped
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:PowerOnly:A] Stopped
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:BackseatDriver] Running Loop=1
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:StandardEnvelopes] Running Loop=1
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2026-03-12T23:06:13.929Z,1773356773.929 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2026-03-12T23:06:13.930Z,1773356773.930 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2026-03-12T23:06:13.930Z,1773356773.930 [keepstation:B] Stopped
2026-03-12T23:06:13.930Z,1773356773.930 [keepstation:D] Running Loop=1
2026-03-12T23:06:14.329Z,1773356774.329 [keepstation:D] Stopped
2026-03-12T23:06:14.329Z,1773356774.329 [keepstation:E] Running Loop=1
2026-03-12T23:06:14.713Z,1773356774.713 [keepstation:E] Stopped
2026-03-12T23:06:14.713Z,1773356774.713 [keepstation:StartingMission] Running Loop=1
2026-03-12T23:06:14.713Z,1773356774.713 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission
2026-03-12T23:06:15.112Z,1773356775.112 [keepstation:SurfaceComms] Running Loop=1
2026-03-12T23:06:15.112Z,1773356775.112 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-12T23:06:15.112Z,1773356775.112 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-12T23:06:15.112Z,1773356775.112 [keepstation:SurfaceComms:A] Stopped
2026-03-12T23:06:15.112Z,1773356775.112 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-12T23:06:15.112Z,1773356775.112 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-12T23:06:15.467Z,1773356775.467 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20260312T230054/Courier0000.lzma
2026-03-12T23:06:15.524Z,1773356775.524 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2026-03-12T23:06:15.524Z,1773356775.524 [keepstation:NeedComms] Running Loop=1
2026-03-12T23:06:15.524Z,1773356775.524 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-12T23:06:15.524Z,1773356775.524 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-12T23:06:15.524Z,1773356775.524 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-12T23:06:15.524Z,1773356775.524 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-12T23:06:15.525Z,1773356775.525 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-12T23:06:15.525Z,1773356775.525 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-12T23:06:15.526Z,1773356775.526 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-12T23:06:15.526Z,1773356775.526 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-12T23:06:15.526Z,1773356775.526 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-12T23:06:15.526Z,1773356775.526 [keepstation:NeedComms:A] Running Loop=1
2026-03-12T23:06:15.528Z,1773356775.528 [keepstation:NeedComms:A](INFO): last time_fix was: 1773356747.000000 second since 1970/01/01T00:00:00Z
2026-03-12T23:06:15.528Z,1773356775.528 [keepstation:NeedComms:A] Stopped
2026-03-12T23:06:15.528Z,1773356775.528 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-12T23:06:15.528Z,1773356775.528 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-12T23:06:15.528Z,1773356775.528 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-12T23:06:15.918Z,1773356775.918 [keepstation:NeedComms:setActive:A] Stopped
2026-03-12T23:06:15.919Z,1773356775.919 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-12T23:06:16.317Z,1773356776.317 [keepstation:NeedComms:setActive:B] Stopped
2026-03-12T23:06:16.317Z,1773356776.317 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-12T23:06:16.317Z,1773356776.317 [keepstation:NeedComms:setActive] Stopped
2026-03-12T23:06:16.317Z,1773356776.317 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-12T23:06:16.470Z,1773356776.470 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Courier0000.lzma.bak
2026-03-12T23:06:16.471Z,1773356776.471 [DataOverHttps](INFO): SBD MOMSN=26726939
2026-03-12T23:06:16.722Z,1773356776.722 [keepstation:NeedComms:D] Running Loop=1
2026-03-12T23:06:17.136Z,1773356777.136 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense time_fix
2026-03-12T23:06:26.405Z,1773356786.405 [NAL9602](INFO): SBD MO Status=1, MOMSN=32656, MT Status=0, MTMSN=0
2026-03-12T23:06:26.405Z,1773356786.405 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:06:27.622Z,1773356787.622 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230626.00,A,3648.26420,N,12151.04577,W,0.855,263.66,120326,,,D*7D
2026-03-12T23:06:27.625Z,1773356787.625 [NAL9602](INFO): GPS fix at 20260312T230626: (36.804403, -121.850763)
2026-03-12T23:06:27.657Z,1773356787.657 [keepstation:NeedComms:D] Stopped
2026-03-12T23:06:27.658Z,1773356787.658 [keepstation:NeedComms:E] Running Loop=1
2026-03-12T23:06:28.066Z,1773356788.066 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense platform_communications
2026-03-12T23:06:34.651Z,1773356794.651 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260312T230054/Courier0006.lzma
2026-03-12T23:06:35.653Z,1773356795.653 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Courier0006.lzma.bak
2026-03-12T23:06:35.653Z,1773356795.653 [DataOverHttps](INFO): SBD MOMSN=26726946
2026-03-12T23:06:54.359Z,1773356814.359 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260312T230054/Courier0009.lzma
2026-03-12T23:06:55.361Z,1773356815.361 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Courier0009.lzma.bak
2026-03-12T23:06:55.361Z,1773356815.361 [DataOverHttps](INFO): SBD MOMSN=26726951
2026-03-12T23:06:59.632Z,1773356819.632 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:07:11.815Z,1773356831.815 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20260312T221930/Express0016.lzma
2026-03-12T23:07:12.817Z,1773356832.817 [DataOverHttps](INFO): Moved sent file to Logs/20260312T221930/Express0016.lzma.bak
2026-03-12T23:07:12.817Z,1773356832.817 [DataOverHttps](INFO): SBD MOMSN=26726960
2026-03-12T23:07:28.780Z,1773356848.780 [DataOverHttps](INFO): Sending 492 bytes from file Logs/20260312T230054/Express0001.lzma
2026-03-12T23:07:29.781Z,1773356849.781 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Express0001.lzma.bak
2026-03-12T23:07:29.782Z,1773356849.782 [DataOverHttps](INFO): SBD MOMSN=26726965
2026-03-12T23:07:45.623Z,1773356865.623 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20260312T230054/Express0004.lzma
2026-03-12T23:07:46.626Z,1773356866.626 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Express0004.lzma.bak
2026-03-12T23:07:46.626Z,1773356866.626 [DataOverHttps](INFO): SBD MOMSN=26726969
2026-03-12T23:08:02.567Z,1773356882.567 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20260312T230054/Express0007.lzma
2026-03-12T23:08:03.569Z,1773356883.569 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Express0007.lzma.bak
2026-03-12T23:08:03.569Z,1773356883.569 [DataOverHttps](INFO): SBD MOMSN=26726974
2026-03-12T23:08:19.611Z,1773356899.611 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20260312T230054/Express0010.lzma
2026-03-12T23:08:20.613Z,1773356900.613 [DataOverHttps](INFO): Moved sent file to Logs/20260312T230054/Express0010.lzma.bak
2026-03-12T23:08:20.613Z,1773356900.613 [DataOverHttps](INFO): SBD MOMSN=26726978
2026-03-12T23:08:22.066Z,1773356902.066 [keepstation:NeedComms:E] Stopped
2026-03-12T23:08:22.066Z,1773356902.066 [keepstation:NeedComms:F] Running Loop=1
2026-03-12T23:08:22.465Z,1773356902.465 [keepstation:NeedComms:F](DEBUG): Initialize ReadDataComponent to sense time_fix
2026-03-12T23:08:24.070Z,1773356904.070 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230823.00,A,3648.25556,N,12151.04999,W,0.836,228.87,120326,,,D*7C
2026-03-12T23:08:24.072Z,1773356904.072 [NAL9602](INFO): GPS fix at 20260312T230823: (36.804259, -121.850833)
2026-03-12T23:08:24.098Z,1773356904.098 [keepstation:NeedComms:F] Stopped
2026-03-12T23:08:24.098Z,1773356904.098 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-12T23:08:24.098Z,1773356904.098 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:08:24.098Z,1773356904.098 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-12T23:08:24.517Z,1773356904.517 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-12T23:08:24.517Z,1773356904.517 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-12T23:08:24.517Z,1773356904.517 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-12T23:08:24.517Z,1773356904.517 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:08:24.518Z,1773356904.518 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-12T23:08:24.518Z,1773356904.518 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-12T23:08:24.518Z,1773356904.518 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-12T23:08:24.910Z,1773356904.910 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-12T23:08:24.911Z,1773356904.911 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-12T23:08:24.911Z,1773356904.911 [keepstation:NeedComms:setInactive] Stopped
2026-03-12T23:08:24.911Z,1773356904.911 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-12T23:08:24.916Z,1773356904.916 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-12T23:08:24.916Z,1773356904.916 [keepstation:NeedComms] Stopped
2026-03-12T23:08:24.916Z,1773356904.916 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-12T23:08:24.916Z,1773356904.916 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-12T23:08:24.916Z,1773356904.916 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:08:25.300Z,1773356905.300 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-12T23:08:25.300Z,1773356905.300 [keepstation:SurfaceComms:B] Stopped
2026-03-12T23:08:25.300Z,1773356905.300 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-12T23:08:25.300Z,1773356905.300 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-12T23:08:25.300Z,1773356905.300 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:08:25.300Z,1773356905.300 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-12T23:08:25.301Z,1773356905.301 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:08:25.301Z,1773356905.301 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetOnStation](INFO): Completed keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetLat] Running Loop=1
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLat
2026-03-12T23:08:25.744Z,1773356905.744 [keepstation:SurfaceComms:HandleNan:SetLat:A] Running Loop=1
2026-03-12T23:08:26.120Z,1773356906.120 [keepstation:SurfaceComms:HandleNan:SetLat:A] Stopped
2026-03-12T23:08:26.120Z,1773356906.120 [keepstation:SurfaceComms:HandleNan:SetLat](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLat
2026-03-12T23:08:26.120Z,1773356906.120 [keepstation:SurfaceComms:HandleNan:SetLat] Stopped
2026-03-12T23:08:26.121Z,1773356906.121 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLat
2026-03-12T23:08:26.121Z,1773356906.121 [keepstation:SurfaceComms:HandleNan:SetLon] Running Loop=1
2026-03-12T23:08:26.121Z,1773356906.121 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLon
2026-03-12T23:08:26.121Z,1773356906.121 [keepstation:SurfaceComms:HandleNan:SetLon:A] Running Loop=1
2026-03-12T23:08:26.531Z,1773356906.531 [keepstation:SurfaceComms:HandleNan:SetLon:A] Stopped
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:HandleNan:SetLon](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLon
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:HandleNan:SetLon] Stopped
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLon
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:HandleNan](INFO): Completed keepstation:SurfaceComms:HandleNan
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-12T23:08:26.532Z,1773356906.532 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-12T23:08:26.920Z,1773356906.920 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-12T23:08:26.920Z,1773356906.920 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-12T23:08:26.920Z,1773356906.920 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-12T23:08:26.920Z,1773356906.920 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-12T23:08:26.920Z,1773356906.920 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-12T23:08:26.920Z,1773356906.920 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-12T23:08:27.317Z,1773356907.317 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-12T23:08:27.317Z,1773356907.317 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-12T23:08:27.317Z,1773356907.317 [keepstation:SurfaceComms:setStation] Stopped
2026-03-12T23:08:27.317Z,1773356907.317 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-12T23:08:27.317Z,1773356907.317 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-12T23:08:27.317Z,1773356907.317 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-12T23:08:27.318Z,1773356907.318 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-12T23:08:27.728Z,1773356907.728 [keepstation:SurfaceComms:setSink] Stopped
2026-03-12T23:08:27.728Z,1773356907.728 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-12T23:08:27.729Z,1773356907.729 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-12T23:08:27.729Z,1773356907.729 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-12T23:08:27.729Z,1773356907.729 [keepstation:SurfaceComms] Stopped
2026-03-12T23:08:27.729Z,1773356907.729 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:StartingMission] Stopped
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:TransitToStation] Running Loop=1
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2026-03-12T23:08:28.116Z,1773356908.116 [keepstation:TransitToStation:Dive:A] Running Loop=1
2026-03-12T23:08:28.117Z,1773356908.117 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2026-03-12T23:08:28.117Z,1773356908.117 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1
2026-03-12T23:08:28.117Z,1773356908.117 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2026-03-12T23:08:28.118Z,1773356908.118 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.804259,-121.850833
2026-03-12T23:08:28.529Z,1773356908.529 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.804259,-121.850833
2026-03-12T23:08:28.530Z,1773356908.530 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:08:28.530Z,1773356908.530 [keepstation:DiveCmd] Running Loop=1
2026-03-12T23:08:28.530Z,1773356908.530 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd
2026-03-12T23:08:28.530Z,1773356908.530 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2026-03-12T23:08:28.530Z,1773356908.530 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2026-03-12T23:08:28.530Z,1773356908.530 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2026-03-12T23:08:28.531Z,1773356908.531 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2026-03-12T23:08:28.532Z,1773356908.532 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:08:28.533Z,1773356908.533 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-12T23:08:28.533Z,1773356908.533 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:08:28.533Z,1773356908.533 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:08:28.533Z,1773356908.533 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-12T23:08:28.533Z,1773356908.533 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:08:28.533Z,1773356908.533 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-12T23:08:28.534Z,1773356908.534 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:08:28.534Z,1773356908.534 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:08:28.534Z,1773356908.534 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:08:28.535Z,1773356908.535 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:08:28.535Z,1773356908.535 [keepstation:DiveCmd:TransitToStation] Stopped
2026-03-12T23:08:28.535Z,1773356908.535 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2026-03-12T23:08:28.535Z,1773356908.535 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2026-03-12T23:08:28.535Z,1773356908.535 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2026-03-12T23:08:28.536Z,1773356908.536 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2026-03-12T23:08:28.537Z,1773356908.537 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2026-03-12T23:08:36.589Z,1773356916.589 [NAL9602](INFO): SBD MO Status=1, MOMSN=32657, MT Status=0, MTMSN=0
2026-03-12T23:08:36.589Z,1773356916.589 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:09:07.291Z,1773356947.291 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:11:55.461Z,1773357115.461 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:12:26.617Z,1773357146.617 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:12:36.667Z,1773357156.667 [Radio_Surface](INFO): Powering down
2026-03-12T23:12:57.744Z,1773357177.744 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:12:58.748Z,1773357178.748 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2026-03-12T23:14:03.012Z,1773357243.012 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.783234
2026-03-12T23:23:24.209Z,1773357804.209 [keepstation:SurfaceComms] Running Loop=1
2026-03-12T23:23:24.209Z,1773357804.209 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-12T23:23:24.209Z,1773357804.209 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-12T23:23:24.210Z,1773357804.210 [keepstation:SurfaceComms:A] Stopped
2026-03-12T23:23:24.210Z,1773357804.210 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-12T23:23:24.210Z,1773357804.210 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-12T23:23:24.212Z,1773357804.212 [keepstation:NeedComms] Running Loop=1
2026-03-12T23:23:24.212Z,1773357804.212 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-12T23:23:24.212Z,1773357804.212 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-12T23:23:24.212Z,1773357804.212 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-12T23:23:24.212Z,1773357804.212 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-12T23:23:24.213Z,1773357804.213 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-12T23:23:24.213Z,1773357804.213 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-12T23:23:24.213Z,1773357804.213 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-12T23:23:24.214Z,1773357804.214 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-12T23:23:24.214Z,1773357804.214 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-12T23:23:24.214Z,1773357804.214 [keepstation:NeedComms:A] Running Loop=1
2026-03-12T23:23:24.216Z,1773357804.216 [keepstation:NeedComms:A](INFO): last time_fix was: 1773356903.000000 second since 1970/01/01T00:00:00Z
2026-03-12T23:23:24.216Z,1773357804.216 [keepstation:NeedComms:A] Stopped
2026-03-12T23:23:24.216Z,1773357804.216 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-12T23:23:24.216Z,1773357804.216 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-12T23:23:24.217Z,1773357804.217 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-12T23:23:24.603Z,1773357804.603 [keepstation:TransitToStation:Dive] Stopped
2026-03-12T23:23:24.603Z,1773357804.603 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2026-03-12T23:23:24.603Z,1773357804.603 [keepstation:TransitToStation:Dive:A] Stopped
2026-03-12T23:23:24.603Z,1773357804.603 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2026-03-12T23:23:24.604Z,1773357804.604 [keepstation:DiveCmd:StationKeep] Stopped
2026-03-12T23:23:24.604Z,1773357804.604 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2026-03-12T23:23:24.604Z,1773357804.604 [keepstation:DiveCmd:StationKeep:A] Stopped
2026-03-12T23:23:24.604Z,1773357804.604 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2026-03-12T23:23:24.604Z,1773357804.604 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2026-03-12T23:23:24.604Z,1773357804.604 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2026-03-12T23:23:24.623Z,1773357804.623 [keepstation:NeedComms:setActive:A] Stopped
2026-03-12T23:23:24.623Z,1773357804.623 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-12T23:23:25.013Z,1773357805.013 [keepstation:NeedComms:setActive:B] Stopped
2026-03-12T23:23:25.013Z,1773357805.013 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-12T23:23:25.013Z,1773357805.013 [keepstation:NeedComms:setActive] Stopped
2026-03-12T23:23:25.013Z,1773357805.013 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-12T23:24:38.952Z,1773357878.952 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.804259,-121.850833
2026-03-12T23:24:38.952Z,1773357878.952 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped
2026-03-12T23:24:38.952Z,1773357878.952 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2026-03-12T23:24:38.952Z,1773357878.952 [keepstation:TransitToStation:C] Running Loop=1
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:TransitToStation:C] Stopped
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:TransitToStation:D] Running Loop=1
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:24:39.365Z,1773357879.365 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-12T23:24:39.366Z,1773357879.366 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:24:39.366Z,1773357879.366 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-12T23:24:39.775Z,1773357879.775 [keepstation:TransitToStation:D] Stopped
2026-03-12T23:24:39.775Z,1773357879.775 [keepstation:TransitToStation:Dive] Running Loop=1
2026-03-12T23:24:39.775Z,1773357879.775 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2026-03-12T23:24:39.775Z,1773357879.775 [keepstation:TransitToStation:Dive:A] Running Loop=1
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation] Stopped
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation:Dive] Stopped
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation:Dive:A] Stopped
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:OnStation] Running Loop=1
2026-03-12T23:24:39.776Z,1773357879.776 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation
2026-03-12T23:25:16.071Z,1773357916.071 [keepstation:NeedComms:D] Running Loop=1
2026-03-12T23:25:16.627Z,1773357916.627 [Radio_Surface](INFO): Powering up
2026-03-12T23:25:22.829Z,1773357922.829 [DataOverHttps](INFO): Radio surface powered ON.
2026-03-12T23:25:35.429Z,1773357935.429 [NAL9602](INFO): SBD MO Status=1, MOMSN=32658, MT Status=0, MTMSN=0
2026-03-12T23:25:35.429Z,1773357935.429 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:25:36.650Z,1773357936.650 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232535.00,A,3648.28158,N,12151.10853,W,0.447,4.08,120326,,,A*75
2026-03-12T23:25:36.652Z,1773357936.652 [NAL9602](INFO): GPS fix at 20260312T232535: (36.804693, -121.851809)
2026-03-12T23:25:36.667Z,1773357936.667 [keepstation:NeedComms:D] Stopped
2026-03-12T23:25:36.667Z,1773357936.667 [keepstation:NeedComms:E] Running Loop=1
2026-03-12T23:25:52.956Z,1773357952.956 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:25:56.105Z,1773357956.105 [NAL9602](INFO): SBD MO Status=1, MOMSN=32659, MT Status=0, MTMSN=0
2026-03-12T23:25:56.156Z,1773357956.156 [NAL9602](INFO): Sent 74 bytes from file Logs/20260312T230054/Courier0012.lzma
2026-03-12T23:25:56.156Z,1773357956.156 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:26:04.753Z,1773357964.753 [NAL9602](INFO): SBD MO Status=1, MOMSN=32660, MT Status=0, MTMSN=0
2026-03-12T23:26:04.812Z,1773357964.812 [NAL9602](INFO): Sent 321 bytes from file Logs/20260312T230054/Express0013.lzma
2026-03-12T23:26:04.812Z,1773357964.812 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:26:16.816Z,1773357976.816 [NAL9602](INFO): SBD MO Status=0, MOMSN=32661, MT Status=0, MTMSN=0
2026-03-12T23:26:16.936Z,1773357976.936 [keepstation:NeedComms:E] Stopped
2026-03-12T23:26:16.936Z,1773357976.936 [keepstation:NeedComms:F] Running Loop=1
2026-03-12T23:26:19.238Z,1773357979.238 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232618.00,A,3648.28134,N,12151.11453,W,0.544,281.34,120326,,,A*7C
2026-03-12T23:26:19.241Z,1773357979.241 [NAL9602](INFO): GPS fix at 20260312T232618: (36.804689, -121.851909)
2026-03-12T23:26:19.256Z,1773357979.256 [keepstation:NeedComms:F] Stopped
2026-03-12T23:26:19.257Z,1773357979.257 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-12T23:26:19.257Z,1773357979.257 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:26:19.257Z,1773357979.257 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-12T23:26:19.672Z,1773357979.672 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-12T23:26:19.672Z,1773357979.672 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-12T23:26:19.672Z,1773357979.672 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-12T23:26:19.672Z,1773357979.672 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:26:19.672Z,1773357979.672 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-12T23:26:19.672Z,1773357979.672 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-12T23:26:19.673Z,1773357979.673 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-12T23:26:20.065Z,1773357980.065 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-12T23:26:20.065Z,1773357980.065 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-12T23:26:20.065Z,1773357980.065 [keepstation:NeedComms:setInactive] Stopped
2026-03-12T23:26:20.065Z,1773357980.065 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-12T23:26:20.066Z,1773357980.066 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-12T23:26:20.066Z,1773357980.066 [keepstation:NeedComms] Stopped
2026-03-12T23:26:20.066Z,1773357980.066 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-12T23:26:20.066Z,1773357980.066 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-12T23:26:20.066Z,1773357980.066 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:26:20.460Z,1773357980.460 [keepstation:OnStation](INFO): Completed keepstation:OnStation
2026-03-12T23:26:20.460Z,1773357980.460 [keepstation:OnStation] Stopped
2026-03-12T23:26:20.460Z,1773357980.460 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation
2026-03-12T23:26:20.460Z,1773357980.460 [keepstation:KeepStation] Running Loop=1
2026-03-12T23:26:20.460Z,1773357980.460 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation
2026-03-12T23:26:20.460Z,1773357980.460 [keepstation:KeepStation:Dive] Running Loop=1
2026-03-12T23:26:20.461Z,1773357980.461 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2026-03-12T23:26:20.461Z,1773357980.461 [keepstation:KeepStation:Dive:A] Running Loop=1
2026-03-12T23:26:20.461Z,1773357980.461 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2026-03-12T23:26:20.461Z,1773357980.461 [keepstation:KeepStation:B.Wait] Running Loop=1
2026-03-12T23:26:20.461Z,1773357980.461 [keepstation:KeepStation:B.Wait](DEBUG): Initialize Wait Component.
2026-03-12T23:26:20.463Z,1773357980.463 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-12T23:26:20.463Z,1773357980.463 [keepstation:SurfaceComms:B] Stopped
2026-03-12T23:26:20.463Z,1773357980.463 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-12T23:26:20.463Z,1773357980.463 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-12T23:26:20.463Z,1773357980.463 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:26:20.463Z,1773357980.463 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-12T23:26:20.464Z,1773357980.464 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:26:20.464Z,1773357980.464 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-12T23:26:20.869Z,1773357980.869 [keepstation:KeepStation:Dive] Running Loop=1
2026-03-12T23:26:20.871Z,1773357980.871 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-12T23:26:20.871Z,1773357980.871 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:26:20.871Z,1773357980.871 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-12T23:26:20.872Z,1773357980.872 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:26:20.872Z,1773357980.872 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-12T23:26:20.872Z,1773357980.872 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-12T23:26:20.872Z,1773357980.872 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-12T23:26:20.872Z,1773357980.872 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-12T23:26:21.272Z,1773357981.272 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-12T23:26:21.272Z,1773357981.272 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-12T23:26:21.272Z,1773357981.272 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-12T23:26:21.273Z,1773357981.273 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-12T23:26:21.273Z,1773357981.273 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-12T23:26:21.273Z,1773357981.273 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setStation] Stopped
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-12T23:26:21.698Z,1773357981.698 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-12T23:26:22.078Z,1773357982.078 [keepstation:SurfaceComms:setSink] Stopped
2026-03-12T23:26:22.078Z,1773357982.078 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-12T23:26:22.078Z,1773357982.078 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-12T23:26:22.078Z,1773357982.078 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-12T23:26:22.078Z,1773357982.078 [keepstation:SurfaceComms] Stopped
2026-03-12T23:26:22.078Z,1773357982.078 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-12T23:26:24.080Z,1773357984.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:26:51.618Z,1773358011.618 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:26:55.204Z,1773358015.204 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:27:04.132Z,1773358024.132 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2026-03-12T23:27:26.328Z,1773358046.328 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:27:57.452Z,1773358077.452 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:28:28.584Z,1773358108.584 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:28:59.708Z,1773358139.708 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:29:11.168Z,1773358151.168 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003085
2026-03-12T23:30:47.084Z,1773358247.084 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2026-03-12T23:33:04.940Z,1773358384.940 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:33:36.072Z,1773358416.072 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:33:55.879Z,1773358435.879 [Radio_Surface](INFO): Powering down
2026-03-12T23:34:07.196Z,1773358447.196 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:34:08.200Z,1773358448.200 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2026-03-12T23:35:12.476Z,1773358512.476 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.747345
2026-03-12T23:41:19.388Z,1773358879.388 [keepstation:SurfaceComms] Running Loop=1
2026-03-12T23:41:19.388Z,1773358879.388 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-12T23:41:19.388Z,1773358879.388 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-12T23:41:19.389Z,1773358879.389 [keepstation:SurfaceComms:A] Stopped
2026-03-12T23:41:19.389Z,1773358879.389 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-12T23:41:19.389Z,1773358879.389 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-12T23:41:19.391Z,1773358879.391 [keepstation:NeedComms] Running Loop=1
2026-03-12T23:41:19.391Z,1773358879.391 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-12T23:41:19.391Z,1773358879.391 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-12T23:41:19.391Z,1773358879.391 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-12T23:41:19.391Z,1773358879.391 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-12T23:41:19.392Z,1773358879.392 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-12T23:41:19.392Z,1773358879.392 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-12T23:41:19.393Z,1773358879.393 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-12T23:41:19.393Z,1773358879.393 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-12T23:41:19.393Z,1773358879.393 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-12T23:41:19.393Z,1773358879.393 [keepstation:NeedComms:A] Running Loop=1
2026-03-12T23:41:19.395Z,1773358879.395 [keepstation:NeedComms:A](INFO): last time_fix was: 1773357978.000000 second since 1970/01/01T00:00:00Z
2026-03-12T23:41:19.395Z,1773358879.395 [keepstation:NeedComms:A] Stopped
2026-03-12T23:41:19.395Z,1773358879.395 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-12T23:41:19.395Z,1773358879.395 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-12T23:41:19.396Z,1773358879.396 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-12T23:41:19.766Z,1773358879.766 [keepstation:KeepStation:Dive] Stopped
2026-03-12T23:41:19.767Z,1773358879.767 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2026-03-12T23:41:19.767Z,1773358879.767 [keepstation:KeepStation:Dive:A] Stopped
2026-03-12T23:41:19.767Z,1773358879.767 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2026-03-12T23:41:19.767Z,1773358879.767 [keepstation:DiveCmd:StationKeep] Stopped
2026-03-12T23:41:19.768Z,1773358879.768 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2026-03-12T23:41:19.768Z,1773358879.768 [keepstation:DiveCmd:StationKeep:A] Stopped
2026-03-12T23:41:19.768Z,1773358879.768 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2026-03-12T23:41:19.768Z,1773358879.768 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2026-03-12T23:41:19.768Z,1773358879.768 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2026-03-12T23:41:19.771Z,1773358879.771 [keepstation:NeedComms:setActive:A] Stopped
2026-03-12T23:41:19.771Z,1773358879.771 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-12T23:41:20.181Z,1773358880.181 [keepstation:NeedComms:setActive:B] Stopped
2026-03-12T23:41:20.181Z,1773358880.181 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-12T23:41:20.181Z,1773358880.181 [keepstation:NeedComms:setActive] Stopped
2026-03-12T23:41:20.181Z,1773358880.181 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-12T23:42:50.444Z,1773358970.444 [keepstation:NeedComms:D] Running Loop=1
2026-03-12T23:42:50.915Z,1773358970.915 [Radio_Surface](INFO): Powering up
2026-03-12T23:42:56.412Z,1773358976.412 [DataOverHttps](INFO): Radio surface powered ON.
2026-03-12T23:43:05.787Z,1773358985.787 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2026-03-12T23:43:05.788Z,1773358985.788 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.788Z,1773358985.788 [BPC1](FAULT): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2026-03-12T23:43:05.789Z,1773358985.789 [BPC1](FAULT): Battery stick #30 (s/n: 015F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.790Z,1773358985.790 [BPC1](ERROR): Battery stick #37 (s/n: 0181) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.791Z,1773358985.791 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.808Z,1773358985.808 [BPC1](ERROR): Battery stick #39 (s/n: 0189) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.808Z,1773358985.808 [BPC1](ERROR): Battery stick #40 (s/n: 01A4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.809Z,1773358985.809 [BPC1](ERROR): Battery stick #44 (s/n: 01BB) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.810Z,1773358985.810 [BPC1](ERROR): Battery stick #50 (s/n: 019C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.810Z,1773358985.810 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.815Z,1773358985.815 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.816Z,1773358985.816 [BPC1](ERROR): Battery stick #53 (s/n: 01EE) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.817Z,1773358985.817 [BPC1](FAULT): Battery stick #56 (s/n: 0183) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.818Z,1773358985.818 [BPC1](FAULT): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2026-03-12T23:43:05.818Z,1773358985.818 [BPC1](FAULT): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x5AD0.
2026-03-12T23:43:05.819Z,1773358985.819 [BPC1](INFO): Calculating totals. Valid battery stick count: 28. Valid reserve battery stick count: 2.
2026-03-12T23:43:05.827Z,1773358985.827 [BPC1](FAULT): Failed to receive data from 11 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 17, 24, 37, 38, 39, 40, 44, 50, 51, 52, 53.
2026-03-12T23:43:21.554Z,1773359001.554 [NAL9602](INFO): SBD MO Status=2, MOMSN=32662, MT Status=2, MTMSN=0
2026-03-12T23:43:21.554Z,1773359001.554 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:43:26.532Z,1773359006.532 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:43:36.091Z,1773359016.091 [NAL9602](INFO): SBD MO Status=0, MOMSN=32662, MT Status=0, MTMSN=0
2026-03-12T23:43:36.091Z,1773359016.091 [NAL9602](INFO): No messages in MT queue
2026-03-12T23:43:37.301Z,1773359017.301 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234336.00,A,3648.26969,N,12151.26543,W,0.952,248.26,120326,,,D*71
2026-03-12T23:43:37.304Z,1773359017.304 [NAL9602](INFO): GPS fix at 20260312T234336: (36.804495, -121.854424)
2026-03-12T23:43:37.318Z,1773359017.318 [keepstation:NeedComms:D] Stopped
2026-03-12T23:43:37.318Z,1773359017.318 [keepstation:NeedComms:E] Running Loop=1
2026-03-12T23:43:53.140Z,1773359033.140 [NAL9602](INFO): SBD MO Status=1, MOMSN=32663, MT Status=0, MTMSN=0
2026-03-12T23:43:53.188Z,1773359033.188 [NAL9602](INFO): Sent 201 bytes from file Logs/20260312T230054/Courier0015.lzma
2026-03-12T23:43:53.188Z,1773359033.188 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:43:57.660Z,1773359037.660 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:44:03.770Z,1773359043.770 [NAL9602](INFO): SBD MO Status=1, MOMSN=32664, MT Status=0, MTMSN=0
2026-03-12T23:44:03.820Z,1773359043.820 [NAL9602](INFO): Sent 332 bytes from file Logs/20260312T230054/Express0016.lzma
2026-03-12T23:44:03.820Z,1773359043.820 [NAL9602](INFO): Packets left to send: 1
2026-03-12T23:44:16.798Z,1773359056.798 [NAL9602](INFO): SBD MO Status=2, MOMSN=32665, MT Status=2, MTMSN=0
2026-03-12T23:44:16.799Z,1773359056.799 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:44:28.784Z,1773359068.784 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:44:41.130Z,1773359081.130 [NAL9602](INFO): SBD MO Status=1, MOMSN=32665, MT Status=0, MTMSN=0
2026-03-12T23:44:41.192Z,1773359081.192 [NAL9602](INFO): Sent 152 bytes from file Logs/20260312T230054/Express0016.lzma
2026-03-12T23:44:41.192Z,1773359081.192 [NAL9602](INFO): Packets left to send: 0
2026-03-12T23:44:59.709Z,1773359099.709 [NAL9602](INFO): SBD MO Status=2, MOMSN=32666, MT Status=2, MTMSN=0
2026-03-12T23:44:59.709Z,1773359099.709 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-12T23:44:59.908Z,1773359099.908 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:45:04.707Z,1773359104.707 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2026-03-12T23:45:07.129Z,1773359107.129 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2026-03-12T23:45:21.121Z,1773359121.121 [NAL9602](INFO): SBD MO Status=0, MOMSN=32666, MT Status=0, MTMSN=0
2026-03-12T23:45:21.205Z,1773359121.205 [keepstation:NeedComms:E] Stopped
2026-03-12T23:45:21.205Z,1773359121.205 [keepstation:NeedComms:F] Running Loop=1
2026-03-12T23:45:23.554Z,1773359123.554 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234522.00,A,3648.26512,N,12151.27644,W,0.933,219.11,120326,,,D*70
2026-03-12T23:45:23.556Z,1773359123.556 [NAL9602](INFO): GPS fix at 20260312T234522: (36.804419, -121.854607)
2026-03-12T23:45:23.570Z,1773359123.570 [keepstation:NeedComms:F] Stopped
2026-03-12T23:45:23.570Z,1773359123.570 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-12T23:45:23.570Z,1773359123.570 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:45:23.570Z,1773359123.570 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-12T23:45:23.979Z,1773359123.979 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-12T23:45:24.386Z,1773359124.386 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-12T23:45:24.386Z,1773359124.386 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-12T23:45:24.386Z,1773359124.386 [keepstation:NeedComms:setInactive] Stopped
2026-03-12T23:45:24.386Z,1773359124.386 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-12T23:45:24.387Z,1773359124.387 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-12T23:45:24.387Z,1773359124.387 [keepstation:NeedComms] Stopped
2026-03-12T23:45:24.387Z,1773359124.387 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-12T23:45:24.387Z,1773359124.387 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-12T23:45:24.387Z,1773359124.387 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:B] Stopped
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:45:24.778Z,1773359124.778 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-12T23:45:25.173Z,1773359125.173 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-12T23:45:25.173Z,1773359125.173 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-12T23:45:25.173Z,1773359125.173 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-12T23:45:25.173Z,1773359125.173 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-12T23:45:25.174Z,1773359125.174 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-12T23:45:25.174Z,1773359125.174 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-12T23:45:25.174Z,1773359125.174 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-12T23:45:25.174Z,1773359125.174 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-12T23:45:25.586Z,1773359125.586 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-12T23:45:25.587Z,1773359125.587 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-12T23:45:25.587Z,1773359125.587 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-12T23:45:25.587Z,1773359125.587 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-12T23:45:25.587Z,1773359125.587 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-12T23:45:25.587Z,1773359125.587 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-12T23:45:25.979Z,1773359125.979 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-12T23:45:25.979Z,1773359125.979 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-12T23:45:25.979Z,1773359125.979 [keepstation:SurfaceComms:setStation] Stopped
2026-03-12T23:45:25.980Z,1773359125.980 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-12T23:45:25.980Z,1773359125.980 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-12T23:45:25.980Z,1773359125.980 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-12T23:45:25.980Z,1773359125.980 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-12T23:45:26.382Z,1773359126.382 [keepstation:KeepStation:Dive] Running Loop=1
2026-03-12T23:45:26.382Z,1773359126.382 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2026-03-12T23:45:26.382Z,1773359126.382 [keepstation:KeepStation:Dive:A] Running Loop=1
2026-03-12T23:45:26.382Z,1773359126.382 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2026-03-12T23:45:26.383Z,1773359126.383 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-12T23:45:26.383Z,1773359126.383 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-12T23:45:26.383Z,1773359126.383 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-12T23:45:26.383Z,1773359126.383 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-12T23:45:26.383Z,1773359126.383 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-12T23:45:26.384Z,1773359126.384 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-12T23:45:26.384Z,1773359126.384 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-12T23:45:26.385Z,1773359126.385 [keepstation:DiveCmd:StationKeep:C.KeepStation](INFO): Rest->Waypoint
2026-03-12T23:45:26.386Z,1773359126.386 [keepstation:SurfaceComms:setSink] Stopped
2026-03-12T23:45:26.386Z,1773359126.386 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-12T23:45:26.387Z,1773359126.387 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-12T23:45:26.387Z,1773359126.387 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-12T23:45:26.387Z,1773359126.387 [keepstation:SurfaceComms] Stopped
2026-03-12T23:45:26.387Z,1773359126.387 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-12T23:45:31.044Z,1773359131.044 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:45:55.481Z,1773359155.481 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-12T23:46:02.168Z,1773359162.168 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:46:33.300Z,1773359193.300 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:47:04.424Z,1773359224.424 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:47:11.147Z,1773359231.147 [Radio_Surface](INFO): Powering down
2026-03-12T23:47:35.560Z,1773359255.560 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-12T23:47:36.564Z,1773359256.564 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2026-03-13T00:00:23.725Z,1773360023.725 [keepstation:SurfaceComms] Running Loop=1
2026-03-13T00:00:23.725Z,1773360023.725 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2026-03-13T00:00:23.725Z,1773360023.725 [keepstation:SurfaceComms:A] Running Loop=1
2026-03-13T00:00:23.725Z,1773360023.725 [keepstation:SurfaceComms:A] Stopped
2026-03-13T00:00:23.726Z,1773360023.726 [keepstation:SurfaceComms:B] Running Loop=1
2026-03-13T00:00:23.726Z,1773360023.726 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2026-03-13T00:00:23.728Z,1773360023.728 [keepstation:NeedComms] Running Loop=1
2026-03-13T00:00:23.728Z,1773360023.728 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2026-03-13T00:00:23.728Z,1773360023.728 [keepstation:NeedComms:C.GoToSurface] Running Loop=1
2026-03-13T00:00:23.728Z,1773360023.728 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2026-03-13T00:00:23.728Z,1773360023.728 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s.
2026-03-13T00:00:23.729Z,1773360023.729 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2026-03-13T00:00:23.729Z,1773360023.729 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2026-03-13T00:00:23.729Z,1773360023.729 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds.
2026-03-13T00:00:23.730Z,1773360023.730 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2026-03-13T00:00:23.730Z,1773360023.730 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2026-03-13T00:00:23.730Z,1773360023.730 [keepstation:NeedComms:A] Running Loop=1
2026-03-13T00:00:23.732Z,1773360023.732 [keepstation:NeedComms:A](INFO): last time_fix was: 1773359122.000000 second since 1970/01/01T00:00:00Z
2026-03-13T00:00:23.732Z,1773360023.732 [keepstation:NeedComms:A] Stopped
2026-03-13T00:00:23.732Z,1773360023.732 [keepstation:NeedComms:setActive] Running Loop=1
2026-03-13T00:00:23.732Z,1773360023.732 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive
2026-03-13T00:00:23.732Z,1773360023.732 [keepstation:NeedComms:setActive:A] Running Loop=1
2026-03-13T00:00:24.141Z,1773360024.141 [keepstation:KeepStation:Dive] Stopped
2026-03-13T00:00:24.141Z,1773360024.141 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2026-03-13T00:00:24.141Z,1773360024.141 [keepstation:KeepStation:Dive:A] Stopped
2026-03-13T00:00:24.141Z,1773360024.141 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2026-03-13T00:00:24.142Z,1773360024.142 [keepstation:DiveCmd:StationKeep] Stopped
2026-03-13T00:00:24.142Z,1773360024.142 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2026-03-13T00:00:24.142Z,1773360024.142 [keepstation:DiveCmd:StationKeep:A] Stopped
2026-03-13T00:00:24.142Z,1773360024.142 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2026-03-13T00:00:24.142Z,1773360024.142 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2026-03-13T00:00:24.142Z,1773360024.142 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2026-03-13T00:00:24.145Z,1773360024.145 [keepstation:NeedComms:setActive:A] Stopped
2026-03-13T00:00:24.145Z,1773360024.145 [keepstation:NeedComms:setActive:B] Running Loop=1
2026-03-13T00:00:24.614Z,1773360024.614 [keepstation:NeedComms:setActive:B] Stopped
2026-03-13T00:00:24.614Z,1773360024.614 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive
2026-03-13T00:00:24.614Z,1773360024.614 [keepstation:NeedComms:setActive] Stopped
2026-03-13T00:00:24.614Z,1773360024.614 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive
2026-03-13T00:02:15.493Z,1773360135.493 [keepstation:NeedComms:D] Running Loop=1
2026-03-13T00:02:16.259Z,1773360136.259 [Radio_Surface](INFO): Powering up
2026-03-13T00:02:22.312Z,1773360142.312 [DataOverHttps](INFO): Radio surface powered ON.
2026-03-13T00:02:42.154Z,1773360162.154 [NAL9602](INFO): SBD MO Status=2, MOMSN=32667, MT Status=2, MTMSN=0
2026-03-13T00:02:42.154Z,1773360162.154 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-13T00:02:51.452Z,1773360171.452 [NAL9602](INFO): SBD MO Status=0, MOMSN=32667, MT Status=0, MTMSN=0
2026-03-13T00:02:51.452Z,1773360171.452 [NAL9602](INFO): No messages in MT queue
2026-03-13T00:02:52.444Z,1773360172.444 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:02:52.652Z,1773360172.652 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000251.00,A,3648.25178,N,12150.94491,W,0.564,173.60,130326,,,A*7D
2026-03-13T00:02:52.659Z,1773360172.659 [NAL9602](INFO): GPS fix at 20260313T000251: (36.804196, -121.849082)
2026-03-13T00:02:52.692Z,1773360172.692 [UniversalFixResidualReporter](INFO): Fix residual: 10.2 %DT, over the last 606.0 m. Residual distance 61.5 m at bearing 99.5 degrees. Fix at (36.8042, -121.8491) with 492.6 m made good.
2026-03-13T00:02:52.695Z,1773360172.695 [keepstation:NeedComms:D] Stopped
2026-03-13T00:02:52.700Z,1773360172.700 [keepstation:NeedComms:E] Running Loop=1
2026-03-13T00:03:11.314Z,1773360191.314 [NAL9602](INFO): SBD MO Status=1, MOMSN=32668, MT Status=0, MTMSN=0
2026-03-13T00:03:11.364Z,1773360191.364 [NAL9602](INFO): Sent 207 bytes from file Logs/20260312T230054/Courier0018.lzma
2026-03-13T00:03:11.364Z,1773360191.364 [NAL9602](INFO): Packets left to send: 0
2026-03-13T00:03:23.522Z,1773360203.522 [NAL9602](INFO): SBD MO Status=2, MOMSN=32669, MT Status=2, MTMSN=0
2026-03-13T00:03:23.522Z,1773360203.522 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2026-03-13T00:03:23.584Z,1773360203.584 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:03:36.114Z,1773360216.114 [NAL9602](INFO): SBD MO Status=1, MOMSN=32669, MT Status=0, MTMSN=0
2026-03-13T00:03:36.166Z,1773360216.166 [NAL9602](INFO): Sent 281 bytes from file Logs/20260312T230054/Express0019.lzma
2026-03-13T00:03:36.166Z,1773360216.166 [NAL9602](INFO): Packets left to send: 0
2026-03-13T00:03:44.594Z,1773360224.594 [NAL9602](INFO): SBD MO Status=0, MOMSN=32670, MT Status=0, MTMSN=0
2026-03-13T00:03:44.714Z,1773360224.714 [keepstation:NeedComms:E] Stopped
2026-03-13T00:03:44.715Z,1773360224.715 [keepstation:NeedComms:F] Running Loop=1
2026-03-13T00:03:47.017Z,1773360227.017 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000346.00,A,3648.25082,N,12150.94605,W,1.089,294.72,130326,,,D*7A
2026-03-13T00:03:47.020Z,1773360227.020 [NAL9602](INFO): GPS fix at 20260313T000346: (36.804180, -121.849101)
2026-03-13T00:03:47.033Z,1773360227.033 [keepstation:NeedComms:F] Stopped
2026-03-13T00:03:47.033Z,1773360227.033 [keepstation:NeedComms:setRestoreMode] Running Loop=1
2026-03-13T00:03:47.033Z,1773360227.033 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode
2026-03-13T00:03:47.033Z,1773360227.033 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1
2026-03-13T00:03:47.474Z,1773360227.474 [keepstation:NeedComms:setRestoreMode:A] Stopped
2026-03-13T00:03:47.474Z,1773360227.474 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode
2026-03-13T00:03:47.474Z,1773360227.474 [keepstation:NeedComms:setRestoreMode] Stopped
2026-03-13T00:03:47.474Z,1773360227.474 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode
2026-03-13T00:03:47.475Z,1773360227.475 [keepstation:NeedComms:setInactive] Running Loop=1
2026-03-13T00:03:47.475Z,1773360227.475 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive
2026-03-13T00:03:47.475Z,1773360227.475 [keepstation:NeedComms:setInactive:A] Running Loop=1
2026-03-13T00:03:47.842Z,1773360227.842 [keepstation:NeedComms:setInactive:A] Stopped
2026-03-13T00:03:47.842Z,1773360227.842 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive
2026-03-13T00:03:47.843Z,1773360227.843 [keepstation:NeedComms:setInactive] Stopped
2026-03-13T00:03:47.843Z,1773360227.843 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive
2026-03-13T00:03:47.844Z,1773360227.844 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2026-03-13T00:03:47.844Z,1773360227.844 [keepstation:NeedComms] Stopped
2026-03-13T00:03:47.844Z,1773360227.844 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2026-03-13T00:03:47.844Z,1773360227.844 [keepstation:NeedComms:C.GoToSurface] Stopped
2026-03-13T00:03:47.844Z,1773360227.844 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:B] Stopped
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:HandleNan] Running Loop=1
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-13T00:03:48.252Z,1773360228.252 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1
2026-03-13T00:03:48.665Z,1773360228.665 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch -20.00 deg, mass-position -2.43 mm.
2026-03-13T00:03:48.666Z,1773360228.666 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position -2.43 mm.
2026-03-13T00:03:48.672Z,1773360228.672 [keepstation:SurfaceComms:HandleNan] Stopped
2026-03-13T00:03:48.672Z,1773360228.672 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan
2026-03-13T00:03:48.672Z,1773360228.672 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped
2026-03-13T00:03:48.672Z,1773360228.672 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation
2026-03-13T00:03:48.672Z,1773360228.672 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped
2026-03-13T00:03:48.673Z,1773360228.673 [keepstation:SurfaceComms:setTransit] Running Loop=1
2026-03-13T00:03:48.673Z,1773360228.673 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2026-03-13T00:03:48.673Z,1773360228.673 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2026-03-13T00:03:49.052Z,1773360229.052 [keepstation:SurfaceComms:setTransit] Stopped
2026-03-13T00:03:49.052Z,1773360229.052 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2026-03-13T00:03:49.052Z,1773360229.052 [keepstation:SurfaceComms:setTransit:A] Stopped
2026-03-13T00:03:49.053Z,1773360229.053 [keepstation:SurfaceComms:setStation] Running Loop=1
2026-03-13T00:03:49.053Z,1773360229.053 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2026-03-13T00:03:49.053Z,1773360229.053 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2026-03-13T00:03:49.461Z,1773360229.461 [keepstation:SurfaceComms:setStation:A] Stopped
2026-03-13T00:03:49.461Z,1773360229.461 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation
2026-03-13T00:03:49.461Z,1773360229.461 [keepstation:SurfaceComms:setStation] Stopped
2026-03-13T00:03:49.461Z,1773360229.461 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2026-03-13T00:03:49.461Z,1773360229.461 [keepstation:SurfaceComms:setSink] Running Loop=1
2026-03-13T00:03:49.461Z,1773360229.461 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2026-03-13T00:03:49.462Z,1773360229.462 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2026-03-13T00:03:49.866Z,1773360229.866 [keepstation:KeepStation:Dive] Running Loop=1
2026-03-13T00:03:49.866Z,1773360229.866 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2026-03-13T00:03:49.866Z,1773360229.866 [keepstation:KeepStation:Dive:A] Running Loop=1
2026-03-13T00:03:49.866Z,1773360229.866 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2026-03-13T00:03:49.867Z,1773360229.867 [keepstation:DiveCmd:StationKeep] Running Loop=1
2026-03-13T00:03:49.867Z,1773360229.867 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2026-03-13T00:03:49.867Z,1773360229.867 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2026-03-13T00:03:49.867Z,1773360229.867 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2026-03-13T00:03:49.867Z,1773360229.867 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2026-03-13T00:03:49.868Z,1773360229.868 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2026-03-13T00:03:49.868Z,1773360229.868 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2026-03-13T00:03:49.869Z,1773360229.869 [keepstation:SurfaceComms:setSink] Stopped
2026-03-13T00:03:49.869Z,1773360229.869 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2026-03-13T00:03:49.869Z,1773360229.869 [keepstation:SurfaceComms:setSink:A] Stopped
2026-03-13T00:03:49.870Z,1773360229.870 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2026-03-13T00:03:49.870Z,1773360229.870 [keepstation:SurfaceComms] Stopped
2026-03-13T00:03:49.870Z,1773360229.870 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2026-03-13T00:03:54.720Z,1773360234.720 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:03:59.191Z,1773360239.191 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2026-03-13T00:03:59.192Z,1773360239.192 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2026-03-13T00:03:59.192Z,1773360239.192 [BuoyancyServo] Communications Fault, FailCount= 1
2026-03-13T00:03:59.192Z,1773360239.192 [BuoyancyServo](ERROR): Communications Fault
2026-03-13T00:03:59.196Z,1773360239.196 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2026-03-13T00:04:00.858Z,1773360240.858 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2026-03-13T00:04:00.858Z,1773360240.858 [BuoyancyServo](INFO): Powering down
2026-03-13T00:04:01.658Z,1773360241.658 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2026-03-13T00:04:01.659Z,1773360241.659 [BuoyancyServo] No Fault, FailCount= 1
2026-03-13T00:04:02.060Z,1773360242.060 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2026-03-13T00:04:02.060Z,1773360242.060 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2026-03-13T00:04:19.415Z,1773360259.415 [NAL9602](INFO): Not Powering down - fast GPS
2026-03-13T00:04:25.844Z,1773360265.844 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:04:56.976Z,1773360296.976 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:05:28.108Z,1773360328.108 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:05:59.244Z,1773360359.244 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2026-03-13T00:06:07.900Z,1773360367.900 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003070
2026-03-13T00:09:11.745Z,1773360551.745 [DataOverHttps](IMPORTANT): SBD MTMSN=20260313T000910
2026-03-13T00:09:19.243Z,1773360559.243 [DataOverHttps](INFO): Received command: restart logs;schedule resume