2025-08-26T03:12:52.959Z,1756177972.959 [CommandExec](IMPORTANT): got command restart logs
2025-08-26T03:12:58.480Z,1756177978.480 [CommandExec](IMPORTANT): got command configSet CBIT.runNavErrorCritical 0 bool persist
2025-08-26T03:13:04.465Z,1756177984.465 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22660, MT Status=1, MTMSN=4452
2025-08-26T03:13:04.512Z,1756177984.512 [NAL9602](INFO): Sent 170 bytes from file Logs/20250826T025609/Courier0007.lzma
2025-08-26T03:13:04.512Z,1756177984.512 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:13:05.036Z,1756177985.036 [NAL9602](INFO): Received command: sched 20250826T13 "restart logs;configSet CBIT.runNavErrorCritical 1 bool persist"
2025-08-26T03:13:05.040Z,1756177985.040 [CommandExec](IMPORTANT): got command schedule 20250826T130000 "restart logs;configSet CBIT.runNavErrorCritical 1 bool persist"
2025-08-26T03:13:05.041Z,1756177985.041 [CommandExec](IMPORTANT): Scheduled #1: "restart logs;configSet CBIT.runNavErrorCritical 1 bool persist", AT TIME: 2025-08-26T13:00:00Z
2025-08-26T03:13:36.635Z,1756178016.635 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22661, MT Status=1, MTMSN=4453
2025-08-26T03:13:36.685Z,1756178016.685 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T025609/Express0001.lzma
2025-08-26T03:13:36.685Z,1756178016.685 [NAL9602](INFO): Packets left to send: 1
2025-08-26T03:13:37.368Z,1756178017.368 [NAL9602](INFO): Received command: sched 20250826T13 "load Science/sci2_vtyoyo.tl;set sci2_vtyoyo.MissionTimeout 16 h;set sci2_vtyoyo.NeedCommsTime 90 min;set sci2_vtyoyo.Lat1 36.91257 degree;set sci2_vtyoyo.Lon1 -122.63214 degree;set sci2_vtyoyo.Lat2 36.7686 degree" 1ce7i 1 4
2025-08-26T03:13:37.433Z,1756178017.433 [CommandExec](IMPORTANT): got command schedule 20250826T130000 "load Science/sci2_vtyoyo.tl;set sci2_vtyoyo.MissionTimeout 16 h;set sci2_vtyoyo.NeedCommsTime 90 min;set sci2_vtyoyo.Lat1 36.91257 degree;set sci2_vtyoyo.Lon1 -122.63214 degree;set sci2_vtyoyo.Lat2 36.7686 degree" 1ce7i 1 4.000000
2025-08-26T03:13:37.433Z,1756178017.433 [CommandExec](IMPORTANT): Scheduling command #1 of 4 with id=1ce7i
2025-08-26T03:13:37.435Z,1756178017.435 [CommandExec](IMPORTANT): Scheduled #2 (#1 of 4 with id='1ce7i'): "load Science/sci2_vtyoyo.tl;set sci2_vtyoyo.MissionTimeout 16 h;set sci2_vtyoyo.NeedCommsTime 90 min;set sci2_vtyoyo.Lat1 36.91257 degree;set sci2_vtyoyo.Lon1 -122.63214 degree;set sci2_vtyoyo.Lat2 36.7686 degree", AT TIME: 2025-08-26T13:00:00Z
2025-08-26T03:13:57.695Z,1756178037.695 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22662, MT Status=1, MTMSN=4454
2025-08-26T03:13:57.746Z,1756178037.746 [NAL9602](INFO): Sent 293 bytes from file Logs/20250826T025609/Express0001.lzma
2025-08-26T03:13:57.747Z,1756178037.747 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:13:58.416Z,1756178038.416 [NAL9602](INFO): Received command: sched 20250826T13 "set sci2_vtyoyo.Lon2 -122.45636 degree;set sci2_vtyoyo.Lat3 36.797 degree;set sci2_vtyoyo.Lon3 -121.847 degree;set sci2_vtyoyo.Speed .7 m/s;set sci2_vtyoyo.YoYoMinDepth 3 m;set sci2_vtyoyo.YoYoMaxDepth 150 m" 1ce7i 2 4
2025-08-26T03:13:58.477Z,1756178038.477 [CommandExec](IMPORTANT): got command schedule 20250826T130000 "set sci2_vtyoyo.Lon2 -122.45636 degree;set sci2_vtyoyo.Lat3 36.797 degree;set sci2_vtyoyo.Lon3 -121.847 degree;set sci2_vtyoyo.Speed .7 m/s;set sci2_vtyoyo.YoYoMinDepth 3 m;set sci2_vtyoyo.YoYoMaxDepth 150 m" 1ce7i 2 4.000000
2025-08-26T03:13:58.477Z,1756178038.477 [CommandExec](IMPORTANT): Scheduling command #2 of 4 with id=1ce7i
2025-08-26T03:13:58.479Z,1756178038.479 [CommandExec](IMPORTANT): Scheduled #3 (#2 of 4 with id='1ce7i'): "set sci2_vtyoyo.Lon2 -122.45636 degree;set sci2_vtyoyo.Lat3 36.797 degree;set sci2_vtyoyo.Lon3 -121.847 degree;set sci2_vtyoyo.Speed .7 m/s;set sci2_vtyoyo.YoYoMinDepth 3 m;set sci2_vtyoyo.YoYoMaxDepth 150 m", AT TIME: 2025-08-26T13:00:00Z
2025-08-26T03:14:17.465Z,1756178057.465 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22663, MT Status=1, MTMSN=4455
2025-08-26T03:14:17.521Z,1756178057.521 [NAL9602](INFO): Sent 143 bytes from file Logs/20250826T025609/Express0005.lzma
2025-08-26T03:14:17.522Z,1756178057.522 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:14:18.180Z,1756178058.180 [NAL9602](INFO): Received command: sched 20250826T13 "set sci2_vtyoyo.YoYoMinAltitude 15 m;set sci2_vtyoyo.MaxDepth 170 m;set sci2_vtyoyo.SinkOffSurface 1 bool;set sci2_vtyoyo.SinkDepthTimeout 3 min;set sci2_vtyoyo:NeedComms.SurfaceSpeed .8 m/s" 1ce7i 3 4
2025-08-26T03:14:18.261Z,1756178058.261 [CommandExec](IMPORTANT): got command schedule 20250826T130000 "set sci2_vtyoyo.YoYoMinAltitude 15 m;set sci2_vtyoyo.MaxDepth 170 m;set sci2_vtyoyo.SinkOffSurface 1 bool;set sci2_vtyoyo.SinkDepthTimeout 3 min;set sci2_vtyoyo:NeedComms.SurfaceSpeed .8 m/s" 1ce7i 3 4.000000
2025-08-26T03:14:18.262Z,1756178058.262 [CommandExec](IMPORTANT): Scheduling command #3 of 4 with id=1ce7i
2025-08-26T03:14:18.263Z,1756178058.263 [CommandExec](IMPORTANT): Scheduled #4 (#3 of 4 with id='1ce7i'): "set sci2_vtyoyo.YoYoMinAltitude 15 m;set sci2_vtyoyo.MaxDepth 170 m;set sci2_vtyoyo.SinkOffSurface 1 bool;set sci2_vtyoyo.SinkDepthTimeout 3 min;set sci2_vtyoyo:NeedComms.SurfaceSpeed .8 m/s", AT TIME: 2025-08-26T13:00:00Z
2025-08-26T03:14:36.814Z,1756178076.814 [NAL9602](INFO): SBD MO Status=1, MOMSN=22664, MT Status=0, MTMSN=0
2025-08-26T03:14:36.876Z,1756178076.876 [NAL9602](INFO): Sent 315 bytes from file Logs/20250826T025609/Express0008.lzma
2025-08-26T03:14:36.876Z,1756178076.876 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:14:46.935Z,1756178086.935 [NAL9602](INFO): SBD MO Status=0, MOMSN=22665, MT Status=0, MTMSN=0
2025-08-26T03:14:57.926Z,1756178097.926 [NAL9602](INFO): SBD MO Status=1, MOMSN=22666, MT Status=0, MTMSN=0
2025-08-26T03:14:57.988Z,1756178097.988 [NAL9602](INFO): Sent 152 bytes from file Logs/20250826T031252/Courier0000.lzma
2025-08-26T03:14:57.988Z,1756178097.988 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:15:22.409Z,1756178122.409 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22667, MT Status=1, MTMSN=4456
2025-08-26T03:15:22.456Z,1756178122.456 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0001.lzma
2025-08-26T03:15:22.456Z,1756178122.456 [NAL9602](INFO): Packets left to send: 2
2025-08-26T03:15:23.028Z,1756178123.028 [NAL9602](INFO): Received command: sched 20250826T13 "set sci2_vtyoyo:NeedComms.CommsTimeout 10 min;set sci2_vtyoyo:BackseatDriver.EnableBackseat 1 bool;run" 1ce7i 4 4
2025-08-26T03:15:23.052Z,1756178123.052 [CommandExec](IMPORTANT): got command schedule 20250826T130000 "set sci2_vtyoyo:NeedComms.CommsTimeout 10 min;set sci2_vtyoyo:BackseatDriver.EnableBackseat 1 bool;run" 1ce7i 4 4.000000
2025-08-26T03:15:23.053Z,1756178123.053 [CommandExec](IMPORTANT): Scheduling command #4 of 4 with id=1ce7i
2025-08-26T03:15:23.054Z,1756178123.054 [CommandExec](IMPORTANT): Scheduled #5 (#4 of 4 with id='1ce7i'): "set sci2_vtyoyo:NeedComms.CommsTimeout 10 min;set sci2_vtyoyo:BackseatDriver.EnableBackseat 1 bool;run", AT TIME: 2025-08-26T13:00:00Z
2025-08-26T03:15:48.921Z,1756178148.921 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22668, MT Status=1, MTMSN=4457
2025-08-26T03:15:48.976Z,1756178148.976 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0001.lzma
2025-08-26T03:15:48.976Z,1756178148.976 [NAL9602](INFO): Packets left to send: 1
2025-08-26T03:15:49.628Z,1756178149.628 [NAL9602](INFO): Received command: sched asap "load Transport/keepstation.tl;set keepstation.MissionTimeout 11 h;set keepstation.NeedCommsTime 60 min;set keepstation.Depth 60 m;set keepstation.Speed 1 m/s;set keepstation.SinkOffSurface 1 bool" 1cecm 1 2
2025-08-26T03:15:49.732Z,1756178149.732 [CommandExec](IMPORTANT): got command schedule asap "load Transport/keepstation.tl;set keepstation.MissionTimeout 11 h;set keepstation.NeedCommsTime 60 min;set keepstation.Depth 60 m;set keepstation.Speed 1 m/s;set keepstation.SinkOffSurface 1 bool" 1cecm 1 2.000000
2025-08-26T03:15:49.733Z,1756178149.733 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=1cecm
2025-08-26T03:15:49.733Z,1756178149.733 [CommandExec](IMPORTANT): Scheduled #6 (#1 of 2 with id='1cecm'): "load Transport/keepstation.tl;set keepstation.MissionTimeout 11 h;set keepstation.NeedCommsTime 60 min;set keepstation.Depth 60 m;set keepstation.Speed 1 m/s;set keepstation.SinkOffSurface 1 bool", ASAP
2025-08-26T03:16:19.149Z,1756178179.149 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=22669, MT Status=1, MTMSN=4458
2025-08-26T03:16:19.204Z,1756178179.204 [NAL9602](INFO): Sent 264 bytes from file Logs/20250826T031252/Express0001.lzma
2025-08-26T03:16:19.204Z,1756178179.204 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:16:19.824Z,1756178179.824 [NAL9602](INFO): Received command: sched asap "set keepstation.SinkDepthTimeout 3 min;set keepstation.MaxDepth 80 m;set keepstation:NeedComms.SurfaceSpeed 1 m/s;set keepstation:NeedComms.CommsTimeout 10 min;run" 1cecm 2 2
2025-08-26T03:16:19.841Z,1756178179.841 [CommandExec](IMPORTANT): got command schedule asap "set keepstation.SinkDepthTimeout 3 min;set keepstation.MaxDepth 80 m;set keepstation:NeedComms.SurfaceSpeed 1 m/s;set keepstation:NeedComms.CommsTimeout 10 min;run" 1cecm 2 2.000000
2025-08-26T03:16:19.842Z,1756178179.842 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=1cecm
2025-08-26T03:16:19.843Z,1756178179.843 [CommandExec](IMPORTANT): Scheduled #7 (#2 of 2 with id='1cecm'): "set keepstation.SinkDepthTimeout 3 min;set keepstation.MaxDepth 80 m;set keepstation:NeedComms.SurfaceSpeed 1 m/s;set keepstation:NeedComms.CommsTimeout 10 min;run", ASAP
2025-08-26T03:16:19.957Z,1756178179.957 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl
2025-08-26T03:16:19.957Z,1756178179.957 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl
2025-08-26T03:16:19.957Z,1756178179.957 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl
2025-08-26T03:16:19.961Z,1756178179.961 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl
2025-08-26T03:16:21.132Z,1756178181.132 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Mission Id="keepstation">
    <DefineArg Name="MissionTimeout">
        <Units:hour />
        <Value>4</Value>
    </DefineArg>
    <DefineArg Name="NeedCommsTime">
        <Units:minute />
        <Value>45</Value>
    </DefineArg>
    <DefineArg Name="Latitude">
        <Units:degree />
        <Value>NaN</Value>
    </DefineArg>
    <DefineArg Name="Longitude">
        <Units:degree />
        <Value>NaN</Value>
    </DefineArg>
    <DefineArg Name="Depth">
        <Units:meter />
        <Value>30</Value>
    </DefineArg>
    <DefineArg Name="ApproachDepth">
        <Units:meter />
        <Value>15</Value>
    </DefineArg>
    <DefineArg Name="DepthDeadband">
        <Units:meter />
        <Value>4</Value>
    </DefineArg>
    <DefineArg Name="Speed">
        <Units:meter_per_second />
        <Value>0.75</Value>
    </DefineArg>
    <DefineArg Name="Radius">
        <Units:meter />
        <Value>200</Value>
    </DefineArg>
    <DefineArg Name="SinkOffSurface">
        <False />
    </DefineArg>
    <DefineArg Name="SinkDepth">
        <Units:meter />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="SinkDepthTimeout">
        <Units:minute />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="MaxDepth">
        <Units:meter />
        <Value>45</Value>
    </DefineArg>
    <DefineArg Name="MinOffshore">
        <Units:kilometer />
        <Value>2</Value>
    </DefineArg>
    <DefineOutput Name="DiveMode">
        <Units:count />
        <Value>0</Value>
    </DefineOutput>
    <DefineOutput Name="DoingComms">
        <Units:count />
        <Value>0</Value>
    </DefineOutput>
    <DefineOutput Name="SurfaceSink">
        <Units:count />
        <Value>1</Value>
    </DefineOutput>
    <DefineOutput Name="TransitToStation">
        <Units:count />
        <Value>2</Value>
    </DefineOutput>
    <DefineOutput Name="StationKeep">
        <Units:count />
        <Value>3</Value>
    </DefineOutput>
    <DefineOutput Name="OnStation">
        <False />
    </DefineOutput>
    <Timeout Duration="MissionTimeout" />
    <Insert Id="NeedComms" Filename="Insert/NeedComms.tl" />
    <Assign>
        <Sequence />
        <Arg Name="NeedComms:DiveInterval" />
        <Arg Name="NeedCommsTime" />
    </Assign>
    <Insert Filename="Insert/StandardEnvelopes.tl" />
    <Assign>
        <Sequence />
        <Arg Name="StandardEnvelopes:MaxDepth" />
        <Arg Name="MaxDepth" />
    </Assign>
    <Assign>
        <Sequence />
        <Arg Name="StandardEnvelopes:MinOffshore" />
        <Arg Name="MinOffshore" />
    </Assign>
    <Insert Filename="Insert/BackseatDriver.tl" />
    <Insert Filename="Insert/PowerOnly.tl" />
    <Guidance:Pitch>
        <Parallel />
        <Setting>
            <Guidance:Pitch.massPosition />
            <Control:VerticalControl.massDefault />
        </Setting>
    </Guidance:Pitch>
    <Aggregate Id="SurfaceComms">
        <When>
            <Called />
            <Or>
                <Elapsed>
                    <Universal:time_fix />
                </Elapsed>
                <Gt>
                    <Arg Name="NeedCommsTime" />
                </Gt>
            </Or>
        </When>
        <Assign>
            <Sequence />
            <Arg Name="DiveMode" />
            <Arg Name="DoingComms" />
        </Assign>
        <Call RefId="NeedComms" PriorityHere="false" />
        <Aggregate Id="setTransit">
            <Sequence />
            <Break>
                <Arg Name="SinkOffSurface" />
                <Or>
                    <Arg Name="OnStation" />
                </Or>
            </Break>
            <Assign>
                <Sequence />
                <Arg Name="DiveMode" />
                <Arg Name="TransitToStation" />
            </Assign>
        </Aggregate>
        <Aggregate Id="setStation">
            <Sequence />
            <Break>
                <Arg Name="SinkOffSurface" />
                <Or>
                    <Not>
                        <Arg Name="OnStation" />
                    </Not>
                </Or>
            </Break>
            <Assign>
                <Sequence />
                <Arg Name="DiveMode" />
                <Arg Name="StationKeep" />
            </Assign>
        </Aggregate>
        <Aggregate Id="setSink">
            <Sequence />
            <Break>
                <Not>
                    <Arg Name="SinkOffSurface" />
                </Not>
            </Break>
            <Assign>
                <Sequence />
                <Arg Name="DiveMode" />
                <Arg Name="SurfaceSink" />
            </Assign>
        </Aggregate>
    </Aggregate>
    <Call RefId="SurfaceComms" Id="StartingMission" PriorityHere="false" />
    <Aggregate Id="DiveCmd">
        <When>
            <Called />
        </When>
        <Aggregate Id="SurfaceSink">
            <While>
                <Arg Name="DiveMode" />
                <Eq>
                    <Arg Name="SurfaceSink" />
                </Eq>
            </While>
            <Aggregate Id="sink">
                <Sequence />
                <Guidance:Buoyancy Id="BuoyancyHold">
                    <Parallel />
                    <Setting>
                        <Guidance:Buoyancy.position />
                        <Units:cubic_centimeter />
                        <Value>NaN</Value>
                    </Setting>
                </Guidance:Buoyancy>
                <Guidance:SetSpeed>
                    <Parallel />
                    <Setting>
                        <Guidance:SetSpeed.speed />
                        <Units:meter_per_second />
                        <Value>0</Value>
                    </Setting>
                </Guidance:SetSpeed>
                <Syslog Severity="Info">
                    Sinking to 
                    <Arg Name="SinkDepth" />
                    <Units:meter />
                </Syslog>
                <Guidance:Pitch>
                    <Sequence />
                    <Timeout Duration="SinkDepthTimeout">
                        <Syslog Severity="Important">
                            Timed out while trying to reach target sink depth at current depth of 
                            <Universal:depth />
                            <Units:meter />
                        </Syslog>
                    </Timeout>
                    <Setting>
                        <Guidance:Pitch.depth />
                        <Arg Name="SinkDepth" />
                    </Setting>
                </Guidance:Pitch>
                <Aggregate Id="sinkToTransit">
                    <Sequence />
                    <Break>
                        <Arg Name="OnStation" />
                    </Break>
                    <Assign>
                        <Sequence />
                        <Arg Name="DiveMode" />
                        <Arg Name="TransitToStation" />
                    </Assign>
                </Aggregate>
                <Aggregate Id="sinkToStation">
                    <Sequence />
                    <Break>
                        <Not>
                            <Arg Name="OnStation" />
                        </Not>
                    </Break>
                    <Assign>
                        <Sequence />
                        <Arg Name="DiveMode" />
                        <Arg Name="StationKeep" />
                    </Assign>
                </Aggregate>
            </Aggregate>
        </Aggregate>
        <Aggregate Id="TransitToStation">
            <While>
                <Arg Name="DiveMode" />
                <Eq>
                    <Arg Name="TransitToStation" />
                </Eq>
            </While>
            <Aggregate Id="dive">
                <Sequence />
                <Guidance:Buoyancy>
                    <Parallel />
                    <Setting>
                        <Guidance:Buoyancy.position />
                        <Control:VerticalControl.buoyancyNeutral />
                    </Setting>
                </Guidance:Buoyancy>
                <Guidance:Pitch>
                    <Parallel />
                    <Setting>
                        <Guidance:Pitch.depth />
                        <Arg Name="ApproachDepth" />
                    </Setting>
                </Guidance:Pitch>
                <Guidance:SetSpeed>
                    <Parallel />
                    <Setting>
                        <Guidance:SetSpeed.speed />
                        <Arg Name="Speed" />
                    </Setting>
                </Guidance:SetSpeed>
            </Aggregate>
        </Aggregate>
        <Aggregate Id="StationKeep">
            <While>
                <Arg Name="DiveMode" />
                <Eq>
                    <Arg Name="StationKeep" />
                </Eq>
            </While>
            <Assign>
                <Parallel />
                <Control:VerticalControl.depthDeadband />
                <Arg Name="DepthDeadband" />
            </Assign>
            <Guidance:Pitch>
                <Parallel />
                <Setting>
                    <Guidance:Pitch.depth />
                    <Arg Name="Depth" />
                </Setting>
            </Guidance:Pitch>
            <Guidance:KeepStation>
                <Parallel />
                <Setting>
                    <Guidance:KeepStation.latitude />
                    <Arg Name="Latitude" />
                </Setting>
                <Setting>
                    <Guidance:KeepStation.longitude />
                    <Arg Name="Longitude" />
                </Setting>
                <Setting>
                    <Guidance:KeepStation.radius />
                    <Arg Name="Radius" />
                </Setting>
                <Setting>
                    <Guidance:KeepStation.speed />
                    <Arg Name="Speed" />
                </Setting>
            </Guidance:KeepStation>
        </Aggregate>
    </Aggregate>
    <Aggregate Id="TransitToStation">
        <Sequence />
        <Aggregate Id="Dive">
            <While>
                <Not>
                    <Arg Name="DiveMode" />
                    <Eq>
                        <Arg Name="DoingComms" />
                    </Eq>
                </Not>
            </While>
            <Call RefId="DiveCmd" PriorityHere="false" />
        </Aggregate>
        <Guidance:Waypoint Id="Wpt1">
            <Sequence />
            <Setting>
                <Guidance:Waypoint.latitude />
                <Arg Name="Latitude" />
            </Setting>
            <Setting>
                <Guidance:Waypoint.longitude />
                <Arg Name="Longitude" />
            </Setting>
        </Guidance:Waypoint>
        <Assign>
            <Sequence />
            <Arg Name="DiveMode" />
            <Arg Name="StationKeep" />
        </Assign>
        <Assign>
            <Sequence />
            <Arg Name="OnStation" />
            <True />
        </Assign>
    </Aggregate>
    <Call RefId="NeedComms" Id="OnStation" PriorityHere="false" />
    <Aggregate Id="KeepStation">
        <Sequence />
        <Aggregate Id="Dive">
            <While>
                <Not>
                    <Arg Name="DiveMode" />
                    <Eq>
                        <Arg Name="DoingComms" />
                    </Eq>
                </Not>
            </While>
            <Call RefId="DiveCmd" PriorityHere="false" />
        </Aggregate>
        <Guidance:Wait>
            <Sequence />
            <Setting>
                <Guidance:Wait.duration />
                <Arg Name="MissionTimeout" />
            </Setting>
        </Guidance:Wait>
    </Aggregate>
</Mission>

2025-08-26T03:16:21.141Z,1756178181.141 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h
2025-08-26T03:16:21.144Z,1756178181.144 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min
2025-08-26T03:16:21.147Z,1756178181.147 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg
2025-08-26T03:16:21.150Z,1756178181.150 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg
2025-08-26T03:16:21.153Z,1756178181.153 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m
2025-08-26T03:16:21.156Z,1756178181.156 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m
2025-08-26T03:16:21.158Z,1756178181.158 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m
2025-08-26T03:16:21.161Z,1756178181.161 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s
2025-08-26T03:16:21.165Z,1756178181.165 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m
2025-08-26T03:16:21.167Z,1756178181.167 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool
2025-08-26T03:16:21.170Z,1756178181.170 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m
2025-08-26T03:16:21.173Z,1756178181.173 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min
2025-08-26T03:16:21.177Z,1756178181.177 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m
2025-08-26T03:16:21.180Z,1756178181.180 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km
2025-08-26T03:16:21.208Z,1756178181.208 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count
2025-08-26T03:16:21.211Z,1756178181.211 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count
2025-08-26T03:16:21.218Z,1756178181.218 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count
2025-08-26T03:16:21.269Z,1756178181.269 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count
2025-08-26T03:16:21.281Z,1756178181.281 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count
2025-08-26T03:16:21.292Z,1756178181.292 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool
2025-08-26T03:16:21.292Z,1756178181.292 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-08-26T03:16:21.292Z,1756178181.292 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-08-26T03:16:21.293Z,1756178181.293 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-08-26T03:16:21.723Z,1756178181.723 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="NeedComms">
    <DefineArg Name="DiveInterval">
        <Units:hour />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="WaitForPitchUp">
        <Units:minute />
        <Value>10</Value>
    </DefineArg>
    <DefineArg Name="SurfacePitch">
        <Units:degree />
        <Value>20</Value>
    </DefineArg>
    <DefineArg Name="SurfaceDepthRate">
        <Units:meter_per_second />
        <Value>NaN</Value>
    </DefineArg>
    <DefineArg Name="SurfaceSpeed">
        <Units:meter_per_second />
        <Value>1</Value>
    </DefineArg>
    <DefineArg Name="SurfacingTimeout">
        <Units:second />
        <Value>1000</Value>
    </DefineArg>
    <DefineArg Name="GPSTimeout">
        <Units:minute />
        <Value>7</Value>
    </DefineArg>
    <DefineArg Name="CommsTimeout">
        <Units:minute />
        <Value>30</Value>
    </DefineArg>
    <When>
        <Called />
        <Or>
            <Elapsed>
                <Universal:time_fix />
            </Elapsed>
            <Gt>
                <Arg Name="DiveInterval" />
                <Add>
                    <Arg Name="WaitForPitchUp" />
                </Add>
            </Gt>
        </Or>
        <Or>
            <Elapsed>
                <Universal:time_fix />
            </Elapsed>
            <Gt>
                <Arg Name="DiveInterval" />
            </Gt>
            <And>
                <Universal:platform_pitch_angle />
                <Gt>
                    <Units:degree />
                    <Value>0</Value>
                </Gt>
            </And>
        </Or>
    </When>
    <Syslog Severity="Info">
        last time_fix was: 
        <Universal:time_fix />
        <Units:epoch_second />
    </Syslog>
    <Guidance:GoToSurface>
        <Progression />
        <Setting>
            <Guidance:GoToSurface.pitch />
            <Arg Name="SurfacePitch" />
        </Setting>
        <Setting>
            <Guidance:GoToSurface.depthRate />
            <Arg Name="SurfaceDepthRate" />
        </Setting>
        <Setting>
            <Guidance:GoToSurface.speed />
            <Arg Name="SurfaceSpeed" />
        </Setting>
        <Setting>
            <Guidance:GoToSurface.surfaceTimeout />
            <Arg Name="SurfacingTimeout" />
        </Setting>
    </Guidance:GoToSurface>
    <ReadDatum>
        <Timeout Duration="GPSTimeout">
            <Syslog Severity="Important">first GPS update timeout</Syslog>
        </Timeout>
        <Universal:time_fix />
    </ReadDatum>
    <ReadDatum>
        <Timeout Duration="CommsTimeout">
            <Syslog Severity="Important">
                Comms timed out after 
                <Arg Name="CommsTimeout" />
                <Units:minute />
                minutes
            </Syslog>
        </Timeout>
        <Universal:platform_communications />
    </ReadDatum>
    <ReadDatum>
        <Timeout Duration="GPSTimeout">
            <Syslog Severity="Important">second GPS update timeout</Syslog>
        </Timeout>
        <Universal:time_fix />
    </ReadDatum>
</Aggregate>

2025-08-26T03:16:21.729Z,1756178181.729 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h
2025-08-26T03:16:21.732Z,1756178181.732 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min
2025-08-26T03:16:21.735Z,1756178181.735 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-08-26T03:16:21.739Z,1756178181.739 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s
2025-08-26T03:16:21.742Z,1756178181.742 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-08-26T03:16:21.745Z,1756178181.745 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1000.000000 s
2025-08-26T03:16:21.764Z,1756178181.764 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min
2025-08-26T03:16:21.776Z,1756178181.776 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min
2025-08-26T03:16:21.796Z,1756178181.796 [keepstation:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-26T03:16:21.859Z,1756178181.859 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-08-26T03:16:21.863Z,1756178181.863 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-08-26T03:16:21.876Z,1756178181.876 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-08-26T03:16:21.997Z,1756178181.997 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="StandardEnvelopes">
    <DefineArg Name="MinAltitude">
        <Units:meter />
        <Value>5</Value>
    </DefineArg>
    <DefineArg Name="MaxDepthIgnore">
        <Units:meter />
        <Value>1.5</Value>
    </DefineArg>
    <DefineArg Name="MaxDepth">
        <Units:meter />
        <Value>200</Value>
    </DefineArg>
    <DefineArg Name="MinOffshore">
        <Units:meter />
        <Value>2000</Value>
    </DefineArg>
    <Parallel />
    <Guidance:AltitudeEnvelope>
        <Parallel />
        <Setting>
            <Guidance:AltitudeEnvelope.minAltitude />
            <Arg Name="MinAltitude" />
        </Setting>
        <Setting>
            <Guidance:AltitudeEnvelope.maxDepthIgnore />
            <Arg Name="MaxDepthIgnore" />
        </Setting>
    </Guidance:AltitudeEnvelope>
    <Guidance:DepthEnvelope>
        <Parallel />
        <Setting>
            <Guidance:DepthEnvelope.maxDepth />
            <Arg Name="MaxDepth" />
        </Setting>
    </Guidance:DepthEnvelope>
    <Guidance:OffshoreEnvelope>
        <Parallel />
        <Setting>
            <Guidance:OffshoreEnvelope.minOffshore />
            <Arg Name="MinOffshore" />
        </Setting>
    </Guidance:OffshoreEnvelope>
</Aggregate>

2025-08-26T03:16:22.002Z,1756178182.002 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m
2025-08-26T03:16:22.005Z,1756178182.005 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2025-08-26T03:16:22.008Z,1756178182.008 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m
2025-08-26T03:16:22.011Z,1756178182.011 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-08-26T03:16:22.025Z,1756178182.025 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-08-26T03:16:22.074Z,1756178182.074 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-08-26T03:16:22.108Z,1756178182.108 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-08-26T03:16:22.140Z,1756178182.140 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-08-26T03:16:22.140Z,1756178182.140 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-08-26T03:16:22.141Z,1756178182.141 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-08-26T03:16:22.182Z,1756178182.182 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="BackseatDriver">
    <DefineArg Name="EnableBackseat">
        <False />
    </DefineArg>
    <Parallel />
    <Guidance:BackseatDriver>
        <Sequence />
        <Setting>
            <Guidance:BackseatDriver.powerBackseat />
            <Arg Name="EnableBackseat" />
        </Setting>
    </Guidance:BackseatDriver>
</Aggregate>

2025-08-26T03:16:22.228Z,1756178182.228 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool
2025-08-26T03:16:22.240Z,1756178182.240 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-08-26T03:16:22.243Z,1756178182.243 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-08-26T03:16:22.243Z,1756178182.243 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-08-26T03:16:22.248Z,1756178182.248 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-08-26T03:16:22.474Z,1756178182.474 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
<?xml version="1.0" encoding="UTF-8" ?>
<!--generated by tl2xml-->
<Aggregate Id="PowerOnly">
    <DefineArg Name="SampleAll">
        <False />
    </DefineArg>
    <DefineArg Name="SampleLoad1">
        <False />
    </DefineArg>
    <DefineArg Name="SampleLoad2">
        <False />
    </DefineArg>
    <DefineArg Name="SampleLoad3">
        <False />
    </DefineArg>
    <DefineArg Name="EnabledPowerOnly">
        <Sensor:PowerOnly.loadAtStartup />
    </DefineArg>
    <Parallel />
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleAll" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.samplePowerOnly />
    </ReadData>
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleLoad1" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.sampleLoad1 />
    </ReadData>
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleLoad2" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.sampleLoad2 />
    </ReadData>
    <ReadData Strategy="MinError">
        <While>
            <Arg Name="SampleLoad3" />
            <And>
                <Arg Name="EnabledPowerOnly" />
            </And>
        </While>
        <Sensor:PowerOnly.sampleLoad3 />
    </ReadData>
    <Guidance:Wait>
        <Sequence />
        <Setting>
            <Guidance:Wait.duration />
            <Units:hour />
            <Value>99999</Value>
        </Setting>
    </Guidance:Wait>
</Aggregate>

2025-08-26T03:16:22.483Z,1756178182.483 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool
2025-08-26T03:16:22.505Z,1756178182.505 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool
2025-08-26T03:16:22.509Z,1756178182.509 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool
2025-08-26T03:16:22.522Z,1756178182.522 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool
2025-08-26T03:16:22.526Z,1756178182.526 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 1 bool
2025-08-26T03:16:22.550Z,1756178182.550 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-08-26T03:16:22.556Z,1756178182.556 [keepstation:H.Pitch](DEBUG): Construct.
2025-08-26T03:16:22.626Z,1756178182.626 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy.
2025-08-26T03:16:22.633Z,1756178182.633 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct.
2025-08-26T03:16:22.642Z,1756178182.642 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct.
2025-08-26T03:16:22.680Z,1756178182.680 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-08-26T03:16:22.688Z,1756178182.688 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct.
2025-08-26T03:16:22.708Z,1756178182.708 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct.
2025-08-26T03:16:22.724Z,1756178182.724 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct.
2025-08-26T03:16:22.730Z,1756178182.730 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation.
2025-08-26T03:16:22.757Z,1756178182.757 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint.
2025-08-26T03:16:22.788Z,1756178182.788 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait.
2025-08-26T03:16:22.814Z,1756178182.814 [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 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
    }
  }
}


2025-08-26T03:16:22.815Z,1756178182.815 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation
2025-08-26T03:16:24.488Z,1756178184.488 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2025-08-26T03:16:38.582Z,1756178198.582 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 11 hour
2025-08-26T03:16:38.583Z,1756178198.583 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 60 minute
2025-08-26T03:16:38.584Z,1756178198.584 [CommandExec](IMPORTANT): got command set keepstation.Depth 60 meter
2025-08-26T03:16:38.584Z,1756178198.584 [CommandExec](IMPORTANT): got command set keepstation.Speed 1 meter_per_second
2025-08-26T03:16:38.585Z,1756178198.585 [CommandExec](IMPORTANT): got command set keepstation.SinkOffSurface 1 bool
2025-08-26T03:16:40.670Z,1756178200.670 [NAL9602](INFO): SBD MO Status=0, MOMSN=22670, MT Status=0, MTMSN=0
2025-08-26T03:16:55.077Z,1756178215.077 [CommandExec](IMPORTANT): got command set keepstation.SinkDepthTimeout 3 minute
2025-08-26T03:16:55.078Z,1756178215.078 [CommandExec](IMPORTANT): got command set keepstation.MaxDepth 80 meter
2025-08-26T03:16:55.079Z,1756178215.079 [CommandExec](IMPORTANT): got command set keepstation:NeedComms.SurfaceSpeed 1 meter_per_second
2025-08-26T03:16:55.079Z,1756178215.079 [CommandExec](IMPORTANT): got command set keepstation:NeedComms.CommsTimeout 10 minute
2025-08-26T03:16:55.080Z,1756178215.080 [CommandExec](IMPORTANT): got command run
2025-08-26T03:16:55.082Z,1756178215.082 [CommandExec](IMPORTANT): Running 
2025-08-26T03:16:55.169Z,1756178215.169 [Default] Stopped
2025-08-26T03:16:55.169Z,1756178215.169 [Default](DEBUG): Aggregate::uninitialize Default
2025-08-26T03:16:55.169Z,1756178215.169 [Default:B.GoToSurface] Stopped
2025-08-26T03:16:55.169Z,1756178215.169 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T03:16:55.169Z,1756178215.169 [Default:CheckIn] Stopped
2025-08-26T03:16:55.169Z,1756178215.169 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-08-26T03:16:55.169Z,1756178215.169 [Default:CheckIn:Read_Iridium] Stopped
2025-08-26T03:16:55.170Z,1756178215.170 [MissionManager](IMPORTANT): Started mission keepstation
2025-08-26T03:16:55.170Z,1756178215.170 [keepstation] Running Loop=1
2025-08-26T03:16:55.170Z,1756178215.170 [keepstation](DEBUG): Aggregate::initialize keepstation
2025-08-26T03:16:55.170Z,1756178215.170 [keepstation:StandardEnvelopes] Running Loop=1
2025-08-26T03:16:55.170Z,1756178215.170 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes
2025-08-26T03:16:55.170Z,1756178215.170 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-08-26T03:16:55.170Z,1756178215.170 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-08-26T03:16:55.171Z,1756178215.171 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-08-26T03:16:55.171Z,1756178215.171 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-08-26T03:16:55.171Z,1756178215.171 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-08-26T03:16:55.171Z,1756178215.171 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-08-26T03:16:55.171Z,1756178215.171 [keepstation:BackseatDriver] Running Loop=1
2025-08-26T03:16:55.171Z,1756178215.171 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly:A] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly:B] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly:C] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly:D] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly:E.Wait] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:H.Pitch] Running Loop=1
2025-08-26T03:16:55.172Z,1756178215.172 [keepstation:H.Pitch](DEBUG): Initialize.
2025-08-26T03:16:55.173Z,1756178215.173 [keepstation:B] Running Loop=1
2025-08-26T03:16:55.173Z,1756178215.173 [keepstation:H.Pitch] Running Loop=1
2025-08-26T03:16:55.174Z,1756178215.174 [keepstation:PowerOnly] Running Loop=1
2025-08-26T03:16:55.174Z,1756178215.174 [keepstation:PowerOnly:D] Stopped
2025-08-26T03:16:55.174Z,1756178215.174 [keepstation:PowerOnly:C] Stopped
2025-08-26T03:16:55.174Z,1756178215.174 [keepstation:PowerOnly:B] Stopped
2025-08-26T03:16:55.174Z,1756178215.174 [keepstation:PowerOnly:A] Stopped
2025-08-26T03:16:55.174Z,1756178215.174 [keepstation:BackseatDriver] Running Loop=1
2025-08-26T03:16:55.175Z,1756178215.175 [keepstation:StandardEnvelopes] Running Loop=1
2025-08-26T03:16:55.175Z,1756178215.175 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-08-26T03:16:55.175Z,1756178215.175 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-08-26T03:16:55.176Z,1756178215.176 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-08-26T03:16:55.177Z,1756178215.177 [keepstation:B] Stopped
2025-08-26T03:16:55.177Z,1756178215.177 [keepstation:D] Running Loop=1
2025-08-26T03:16:55.577Z,1756178215.577 [keepstation:D] Stopped
2025-08-26T03:16:55.577Z,1756178215.577 [keepstation:E] Running Loop=1
2025-08-26T03:16:55.975Z,1756178215.975 [keepstation:E] Stopped
2025-08-26T03:16:55.975Z,1756178215.975 [keepstation:StartingMission] Running Loop=1
2025-08-26T03:16:55.975Z,1756178215.975 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission
2025-08-26T03:16:56.377Z,1756178216.377 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T03:16:56.377Z,1756178216.377 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T03:16:56.378Z,1756178216.378 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T03:16:56.378Z,1756178216.378 [keepstation:SurfaceComms:A] Stopped
2025-08-26T03:16:56.378Z,1756178216.378 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T03:16:56.378Z,1756178216.378 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T03:16:56.788Z,1756178216.788 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2025-08-26T03:16:56.789Z,1756178216.789 [keepstation:NeedComms] Running Loop=1
2025-08-26T03:16:56.789Z,1756178216.789 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T03:16:56.790Z,1756178216.790 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T03:16:56.790Z,1756178216.790 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T03:16:56.791Z,1756178216.791 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T03:16:56.791Z,1756178216.791 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T03:16:56.792Z,1756178216.792 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T03:16:56.792Z,1756178216.792 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T03:16:56.792Z,1756178216.792 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T03:16:56.793Z,1756178216.793 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T03:16:56.793Z,1756178216.793 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T03:16:56.794Z,1756178216.794 [keepstation:NeedComms:A](INFO): last time_fix was:  1756177256.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T03:16:56.794Z,1756178216.794 [keepstation:NeedComms:A] Stopped
2025-08-26T03:16:57.202Z,1756178217.202 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T03:16:57.613Z,1756178217.613 [keepstation:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-26T03:16:59.201Z,1756178219.201 [NAL9602](INFO): SBD MO Status=1, MOMSN=22671, MT Status=0, MTMSN=0
2025-08-26T03:16:59.264Z,1756178219.264 [NAL9602](INFO): Sent 40 bytes from file Logs/20250826T031252/Courier0003.lzma
2025-08-26T03:16:59.264Z,1756178219.264 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:17:00.416Z,1756178220.416 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,031700.00,A,3655.85924,N,12245.71752,W,0.583,76.12,260825,,,A*4F
2025-08-26T03:17:00.418Z,1756178220.418 [NAL9602](INFO): GPS fix at 20250826T031700: (36.930987, -122.761959)
2025-08-26T03:17:00.430Z,1756178220.430 [keepstation:NeedComms:C] Stopped
2025-08-26T03:17:00.430Z,1756178220.430 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T03:17:00.850Z,1756178220.850 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-26T03:17:29.681Z,1756178249.681 [NAL9602](INFO): SBD MO Status=1, MOMSN=22672, MT Status=0, MTMSN=0
2025-08-26T03:17:29.728Z,1756178249.728 [NAL9602](INFO): Sent 227 bytes from file Logs/20250826T031252/Courier0006.lzma
2025-08-26T03:17:29.728Z,1756178249.728 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:17:47.686Z,1756178267.686 [NAL9602](INFO): SBD MO Status=2, MOMSN=22673, MT Status=2, MTMSN=0
2025-08-26T03:17:47.686Z,1756178267.686 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:18:09.379Z,1756178289.379 [NAL9602](INFO): SBD MO Status=2, MOMSN=22673, MT Status=2, MTMSN=0
2025-08-26T03:18:09.379Z,1756178289.379 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:19:31.689Z,1756178371.689 [NAL9602](INFO): SBD MO Status=2, MOMSN=22673, MT Status=2, MTMSN=0
2025-08-26T03:19:31.690Z,1756178371.690 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:19:57.407Z,1756178397.407 [NAL9602](INFO): SBD MO Status=2, MOMSN=22673, MT Status=2, MTMSN=0
2025-08-26T03:19:57.408Z,1756178397.408 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:20:36.465Z,1756178436.465 [NAL9602](INFO): SBD MO Status=2, MOMSN=22673, MT Status=2, MTMSN=0
2025-08-26T03:20:36.465Z,1756178436.465 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:21:17.597Z,1756178477.597 [NAL9602](INFO): SBD MO Status=1, MOMSN=22673, MT Status=0, MTMSN=0
2025-08-26T03:21:17.652Z,1756178477.652 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0004.lzma
2025-08-26T03:21:17.652Z,1756178477.652 [NAL9602](INFO): Packets left to send: 1
2025-08-26T03:21:27.117Z,1756178487.117 [NAL9602](INFO): SBD MO Status=1, MOMSN=22674, MT Status=0, MTMSN=0
2025-08-26T03:21:27.164Z,1756178487.164 [NAL9602](INFO): Sent 326 bytes from file Logs/20250826T031252/Express0004.lzma
2025-08-26T03:21:27.164Z,1756178487.164 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:21:47.185Z,1756178507.185 [NAL9602](INFO): SBD MO Status=1, MOMSN=22675, MT Status=0, MTMSN=0
2025-08-26T03:21:47.241Z,1756178507.241 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0007.lzma
2025-08-26T03:21:47.242Z,1756178507.242 [NAL9602](INFO): Packets left to send: 1
2025-08-26T03:22:07.627Z,1756178527.627 [NAL9602](INFO): SBD MO Status=1, MOMSN=22676, MT Status=0, MTMSN=0
2025-08-26T03:22:07.681Z,1756178527.681 [NAL9602](INFO): Sent 109 bytes from file Logs/20250826T031252/Express0007.lzma
2025-08-26T03:22:07.681Z,1756178527.681 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:22:18.529Z,1756178538.529 [NAL9602](INFO): SBD MO Status=0, MOMSN=22677, MT Status=0, MTMSN=0
2025-08-26T03:22:18.623Z,1756178538.623 [keepstation:NeedComms:D] Stopped
2025-08-26T03:22:18.624Z,1756178538.624 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T03:22:18.951Z,1756178538.951 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-26T03:22:20.964Z,1756178540.964 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,032220.00,A,3655.85402,N,12245.67631,W,0.719,120.79,260825,,,A*7F
2025-08-26T03:22:20.966Z,1756178540.966 [NAL9602](INFO): GPS fix at 20250826T032220: (36.930900, -122.761272)
2025-08-26T03:22:20.978Z,1756178540.978 [keepstation:NeedComms:E] Stopped
2025-08-26T03:22:20.979Z,1756178540.979 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T03:22:20.979Z,1756178540.979 [keepstation:NeedComms] Stopped
2025-08-26T03:22:20.979Z,1756178540.979 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T03:22:20.979Z,1756178540.979 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T03:22:20.979Z,1756178540.979 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T03:22:21.392Z,1756178541.392 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T03:22:21.392Z,1756178541.392 [keepstation:SurfaceComms:B] Stopped
2025-08-26T03:22:21.392Z,1756178541.392 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T03:22:21.392Z,1756178541.392 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T03:22:21.392Z,1756178541.392 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T03:22:21.392Z,1756178541.392 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T03:22:21.780Z,1756178541.780 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T03:22:21.781Z,1756178541.781 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T03:22:21.781Z,1756178541.781 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T03:22:21.781Z,1756178541.781 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T03:22:21.781Z,1756178541.781 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T03:22:21.781Z,1756178541.781 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T03:22:22.189Z,1756178542.189 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T03:22:22.189Z,1756178542.189 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T03:22:22.189Z,1756178542.189 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T03:22:22.189Z,1756178542.189 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T03:22:22.189Z,1756178542.189 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T03:22:22.189Z,1756178542.189 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms] Stopped
2025-08-26T03:22:22.585Z,1756178542.585 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T03:22:23.001Z,1756178543.001 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission
2025-08-26T03:22:23.001Z,1756178543.001 [keepstation:StartingMission] Stopped
2025-08-26T03:22:23.001Z,1756178543.001 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission
2025-08-26T03:22:23.001Z,1756178543.001 [keepstation:TransitToStation] Running Loop=1
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation:Dive] Running Loop=1
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation:Dive:A] Running Loop=1
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1
2025-08-26T03:22:23.002Z,1756178543.002 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-08-26T03:22:23.390Z,1756178543.390 [keepstation:TransitToStation:Dive] Running Loop=1
2025-08-26T03:22:23.390Z,1756178543.390 [keepstation:DiveCmd] Running Loop=1
2025-08-26T03:22:23.390Z,1756178543.390 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd
2025-08-26T03:22:23.390Z,1756178543.390 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T03:22:23.390Z,1756178543.390 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T03:22:23.391Z,1756178543.391 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-08-26T03:22:23.392Z,1756178543.392 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T03:22:23.393Z,1756178543.393 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:TransitToStation] Stopped
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2025-08-26T03:22:23.394Z,1756178543.394 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2025-08-26T03:22:23.395Z,1756178543.395 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T03:22:23.396Z,1756178543.396 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T03:22:23.396Z,1756178543.396 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T03:22:23.396Z,1756178543.396 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T03:22:23.396Z,1756178543.396 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T03:22:23.396Z,1756178543.396 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T03:22:23.396Z,1756178543.396 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T03:22:23.427Z,1756178543.427 [HorizontalControl](DEBUG): kpHeading = 0.400000
2025-08-26T03:22:23.428Z,1756178543.428 [HorizontalControl](DEBUG): kiHeading = 0.001000
2025-08-26T03:22:23.428Z,1756178543.428 [HorizontalControl](DEBUG): kdHeading = 0.050000
2025-08-26T03:22:52.871Z,1756178572.871 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T03:24:43.244Z,1756178683.244 [Radio_Surface](INFO): Powering down
2025-08-26T03:24:53.288Z,1756178693.288 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T03:25:23.578Z,1756178723.578 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T03:22:23.4Z
2025-08-26T03:25:23.578Z,1756178723.578 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T03:25:23.579Z,1756178723.579 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T03:25:23.579Z,1756178723.579 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  8.635966 m 
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T03:25:23.580Z,1756178723.580 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T03:25:23.994Z,1756178723.994 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T03:25:23.995Z,1756178723.995 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T03:25:23.995Z,1756178723.995 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T03:25:23.995Z,1756178723.995 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T03:25:23.995Z,1756178723.995 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T03:25:23.995Z,1756178723.995 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T03:25:23.995Z,1756178723.995 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T03:25:24.382Z,1756178724.382 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-08-26T03:25:24.383Z,1756178724.383 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation
2025-08-26T03:25:24.383Z,1756178724.383 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1
2025-08-26T03:25:24.383Z,1756178724.383 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive
2025-08-26T03:25:24.383Z,1756178724.383 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-08-26T03:25:24.383Z,1756178724.383 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T03:25:24.383Z,1756178724.383 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-08-26T03:25:24.385Z,1756178724.385 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize.
2025-08-26T03:25:24.385Z,1756178724.385 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-08-26T03:25:24.385Z,1756178724.385 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize.
2025-08-26T03:25:24.385Z,1756178724.385 [keepstation:DiveCmd:TransitToStation] Running Loop=1
2025-08-26T03:25:24.385Z,1756178724.385 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1
2025-08-26T03:25:24.385Z,1756178724.385 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink] Stopped
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T03:25:24.386Z,1756178724.386 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T03:25:24.387Z,1756178724.387 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T03:25:24.387Z,1756178724.387 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T03:25:24.387Z,1756178724.387 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T03:25:24.387Z,1756178724.387 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T03:28:50.718Z,1756178930.718 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped
2025-08-26T03:28:50.718Z,1756178930.718 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-08-26T03:28:50.719Z,1756178930.719 [keepstation:TransitToStation:C] Running Loop=1
2025-08-26T03:28:51.128Z,1756178931.128 [keepstation:TransitToStation:C] Stopped
2025-08-26T03:28:51.128Z,1756178931.128 [keepstation:TransitToStation:D] Running Loop=1
2025-08-26T03:28:51.128Z,1756178931.128 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T03:28:51.128Z,1756178931.128 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T03:28:51.128Z,1756178931.128 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T03:28:51.128Z,1756178931.128 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T03:28:51.129Z,1756178931.129 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T03:28:51.129Z,1756178931.129 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T03:28:51.129Z,1756178931.129 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T03:28:51.129Z,1756178931.129 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T03:28:51.129Z,1756178931.129 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T03:28:51.130Z,1756178931.130 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T03:28:51.130Z,1756178931.130 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation] Stopped
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive] Stopped
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped
2025-08-26T03:28:51.131Z,1756178931.131 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize.
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation:D] Stopped
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation] Stopped
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation:Dive] Stopped
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation:Dive:A] Stopped
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A
2025-08-26T03:28:51.532Z,1756178931.532 [keepstation:OnStation] Running Loop=1
2025-08-26T03:28:51.533Z,1756178931.533 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation
2025-08-26T03:28:51.943Z,1756178931.943 [keepstation:NeedComms] Running Loop=1
2025-08-26T03:28:51.943Z,1756178931.943 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T03:28:51.943Z,1756178931.943 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T03:28:51.943Z,1756178931.943 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T03:28:51.943Z,1756178931.943 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T03:28:51.944Z,1756178931.944 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T03:28:51.944Z,1756178931.944 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T03:28:51.945Z,1756178931.945 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T03:28:51.945Z,1756178931.945 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T03:28:51.945Z,1756178931.945 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T03:28:51.945Z,1756178931.945 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T03:28:51.949Z,1756178931.949 [keepstation:NeedComms:A](INFO): last time_fix was:  1756178540.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T03:28:51.949Z,1756178931.949 [keepstation:NeedComms:A] Stopped
2025-08-26T03:29:52.072Z,1756178992.072 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T03:29:52.752Z,1756178992.752 [Radio_Surface](INFO): Powering up
2025-08-26T03:29:58.544Z,1756178998.544 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T03:30:57.938Z,1756179057.938 [NAL9602](INFO): SBD MO Status=0, MOMSN=22678, MT Status=0, MTMSN=0
2025-08-26T03:30:57.938Z,1756179057.938 [NAL9602](INFO): No messages in MT queue
2025-08-26T03:30:59.135Z,1756179059.135 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,033059.00,A,3655.92147,N,12245.61775,W,0.350,167.33,260825,,,A*73
2025-08-26T03:30:59.137Z,1756179059.137 [NAL9602](INFO): GPS fix at 20250826T033059: (36.932024, -122.760296)
2025-08-26T03:30:59.150Z,1756179059.150 [keepstation:NeedComms:C] Stopped
2025-08-26T03:30:59.151Z,1756179059.151 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T03:31:14.789Z,1756179074.789 [NAL9602](INFO): SBD MO Status=2, MOMSN=22679, MT Status=2, MTMSN=0
2025-08-26T03:31:14.789Z,1756179074.789 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:31:36.861Z,1756179096.861 [NAL9602](INFO): SBD MO Status=2, MOMSN=22679, MT Status=2, MTMSN=0
2025-08-26T03:31:36.861Z,1756179096.861 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T03:31:57.277Z,1756179117.277 [NAL9602](INFO): SBD MO Status=1, MOMSN=22679, MT Status=0, MTMSN=0
2025-08-26T03:31:57.344Z,1756179117.344 [NAL9602](INFO): Sent 76 bytes from file Logs/20250826T031252/Courier0009.lzma
2025-08-26T03:31:57.344Z,1756179117.344 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:32:08.933Z,1756179128.933 [NAL9602](INFO): SBD MO Status=1, MOMSN=22680, MT Status=0, MTMSN=0
2025-08-26T03:32:08.980Z,1756179128.980 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0010.lzma
2025-08-26T03:32:08.980Z,1756179128.980 [NAL9602](INFO): Packets left to send: 1
2025-08-26T03:32:30.280Z,1756179150.280 [NAL9602](INFO): SBD MO Status=1, MOMSN=22681, MT Status=0, MTMSN=0
2025-08-26T03:32:30.338Z,1756179150.338 [NAL9602](INFO): Sent 98 bytes from file Logs/20250826T031252/Express0010.lzma
2025-08-26T03:32:30.338Z,1756179150.338 [NAL9602](INFO): Packets left to send: 0
2025-08-26T03:32:40.395Z,1756179160.395 [NAL9602](INFO): SBD MO Status=0, MOMSN=22682, MT Status=0, MTMSN=0
2025-08-26T03:32:40.479Z,1756179160.479 [keepstation:NeedComms:D] Stopped
2025-08-26T03:32:40.480Z,1756179160.480 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T03:32:42.817Z,1756179162.817 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,033242.00,A,3655.91605,N,12245.60321,W,0.311,126.09,260825,,,D*71
2025-08-26T03:32:42.820Z,1756179162.820 [NAL9602](INFO): GPS fix at 20250826T033242: (36.931934, -122.760053)
2025-08-26T03:32:42.834Z,1756179162.834 [keepstation:NeedComms:E] Stopped
2025-08-26T03:32:42.835Z,1756179162.835 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T03:32:42.835Z,1756179162.835 [keepstation:NeedComms] Stopped
2025-08-26T03:32:42.835Z,1756179162.835 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T03:32:42.835Z,1756179162.835 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T03:32:42.835Z,1756179162.835 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:OnStation](INFO): Completed keepstation:OnStation
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:OnStation] Stopped
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:KeepStation] Running Loop=1
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T03:32:43.252Z,1756179163.252 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T03:32:43.253Z,1756179163.253 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T03:32:43.253Z,1756179163.253 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T03:32:43.253Z,1756179163.253 [keepstation:KeepStation:B.Wait] Running Loop=1
2025-08-26T03:32:43.253Z,1756179163.253 [keepstation:KeepStation:B.Wait](DEBUG): Initialize Wait Component.
2025-08-26T03:32:43.642Z,1756179163.642 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T03:33:14.731Z,1756179194.731 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T03:35:03.100Z,1756179303.100 [Radio_Surface](INFO): Powering down
2025-08-26T03:35:09.820Z,1756179309.820 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T04:11:35.525Z,1756181495.525 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T04:11:35.526Z,1756181495.526 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T04:11:35.527Z,1756181495.527 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T04:11:35.530Z,1756181495.530 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T04:32:42.879Z,1756182762.879 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T04:32:42.879Z,1756182762.879 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T04:32:42.879Z,1756182762.879 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T04:32:42.880Z,1756182762.880 [keepstation:SurfaceComms:A] Stopped
2025-08-26T04:32:42.880Z,1756182762.880 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T04:32:42.880Z,1756182762.880 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T04:32:42.882Z,1756182762.882 [keepstation:NeedComms] Running Loop=1
2025-08-26T04:32:42.882Z,1756182762.882 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T04:32:42.882Z,1756182762.882 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T04:32:42.882Z,1756182762.882 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T04:32:42.882Z,1756182762.882 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T04:32:42.883Z,1756182762.883 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T04:32:42.883Z,1756182762.883 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T04:32:42.883Z,1756182762.883 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T04:32:42.884Z,1756182762.884 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T04:32:42.884Z,1756182762.884 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T04:32:42.884Z,1756182762.884 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T04:32:42.886Z,1756182762.886 [keepstation:NeedComms:A](INFO): last time_fix was:  1756179162.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T04:32:42.886Z,1756182762.886 [keepstation:NeedComms:A] Stopped
2025-08-26T04:32:43.293Z,1756182763.293 [keepstation:KeepStation:Dive] Stopped
2025-08-26T04:32:43.293Z,1756182763.293 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T04:32:43.293Z,1756182763.293 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T04:32:43.293Z,1756182763.293 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T04:32:43.294Z,1756182763.294 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T04:32:43.294Z,1756182763.294 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T04:32:43.294Z,1756182763.294 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T04:32:43.294Z,1756182763.294 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T04:32:43.294Z,1756182763.294 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T04:32:43.294Z,1756182763.294 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T04:36:11.912Z,1756182971.912 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T04:36:12.688Z,1756182972.688 [Radio_Surface](INFO): Powering up
2025-08-26T04:36:18.840Z,1756182978.840 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T04:36:29.274Z,1756182989.274 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging
2025-08-26T04:38:49.057Z,1756183129.057 [NAL9602](INFO): SBD MO Status=2, MOMSN=22683, MT Status=2, MTMSN=0
2025-08-26T04:38:49.057Z,1756183129.057 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T04:39:37.537Z,1756183177.537 [NAL9602](INFO): SBD MO Status=2, MOMSN=22683, MT Status=2, MTMSN=0
2025-08-26T04:39:37.537Z,1756183177.537 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T04:40:11.477Z,1756183211.477 [NAL9602](INFO): SBD MO Status=0, MOMSN=22683, MT Status=0, MTMSN=0
2025-08-26T04:40:11.477Z,1756183211.477 [NAL9602](INFO): No messages in MT queue
2025-08-26T04:40:12.685Z,1756183212.685 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,044012.00,A,3655.88425,N,12245.40578,W,1.011,80.70,260825,,,A*42
2025-08-26T04:40:12.687Z,1756183212.687 [NAL9602](INFO): GPS fix at 20250826T044012: (36.931404, -122.756763)
2025-08-26T04:40:12.720Z,1756183212.720 [keepstation:NeedComms:C] Stopped
2025-08-26T04:40:12.720Z,1756183212.720 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T04:40:37.516Z,1756183237.516 [NAL9602](INFO): SBD MO Status=2, MOMSN=22684, MT Status=2, MTMSN=0
2025-08-26T04:40:37.516Z,1756183237.516 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T04:41:02.757Z,1756183262.757 [NAL9602](INFO): SBD MO Status=2, MOMSN=22684, MT Status=2, MTMSN=0
2025-08-26T04:41:02.757Z,1756183262.757 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T04:41:23.133Z,1756183283.133 [NAL9602](INFO): SBD MO Status=1, MOMSN=22684, MT Status=0, MTMSN=0
2025-08-26T04:41:23.188Z,1756183283.188 [NAL9602](INFO): Sent 207 bytes from file Logs/20250826T031252/Courier0012.lzma
2025-08-26T04:41:23.188Z,1756183283.188 [NAL9602](INFO): Packets left to send: 0
2025-08-26T04:41:50.068Z,1756183310.068 [NAL9602](INFO): SBD MO Status=1, MOMSN=22685, MT Status=0, MTMSN=0
2025-08-26T04:41:50.124Z,1756183310.124 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0013.lzma
2025-08-26T04:41:50.124Z,1756183310.124 [NAL9602](INFO): Packets left to send: 1
2025-08-26T04:42:04.072Z,1756183324.072 [NAL9602](INFO): SBD MO Status=2, MOMSN=22686, MT Status=2, MTMSN=0
2025-08-26T04:42:04.072Z,1756183324.072 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T04:42:25.747Z,1756183345.747 [NAL9602](INFO): SBD MO Status=2, MOMSN=22686, MT Status=2, MTMSN=0
2025-08-26T04:42:25.747Z,1756183345.747 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T04:43:37.615Z,1756183417.615 [NAL9602](INFO): SBD MO Status=1, MOMSN=22686, MT Status=0, MTMSN=0
2025-08-26T04:43:37.680Z,1756183417.680 [NAL9602](INFO): Sent 27 bytes from file Logs/20250826T031252/Express0013.lzma
2025-08-26T04:43:37.680Z,1756183417.680 [NAL9602](INFO): Packets left to send: 0
2025-08-26T04:43:47.761Z,1756183427.761 [NAL9602](INFO): SBD MO Status=0, MOMSN=22687, MT Status=0, MTMSN=0
2025-08-26T04:43:47.848Z,1756183427.848 [keepstation:NeedComms:D] Stopped
2025-08-26T04:43:47.848Z,1756183427.848 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T04:43:50.259Z,1756183430.259 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,044350.00,A,3655.86794,N,12245.38003,W,0.253,114.44,260825,,,A*78
2025-08-26T04:43:50.269Z,1756183430.269 [NAL9602](INFO): GPS fix at 20250826T044350: (36.931132, -122.756334)
2025-08-26T04:43:50.321Z,1756183430.321 [keepstation:NeedComms:E] Stopped
2025-08-26T04:43:50.322Z,1756183430.322 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T04:43:50.322Z,1756183430.322 [keepstation:NeedComms] Stopped
2025-08-26T04:43:50.322Z,1756183430.322 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T04:43:50.322Z,1756183430.322 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T04:43:50.322Z,1756183430.322 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T04:43:50.687Z,1756183430.687 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T04:43:50.687Z,1756183430.687 [keepstation:SurfaceComms:B] Stopped
2025-08-26T04:43:50.687Z,1756183430.687 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T04:43:50.687Z,1756183430.687 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T04:43:50.687Z,1756183430.687 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T04:43:50.701Z,1756183430.701 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T04:43:51.116Z,1756183431.116 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T04:43:51.116Z,1756183431.116 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T04:43:51.116Z,1756183431.116 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T04:43:51.116Z,1756183431.116 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T04:43:51.116Z,1756183431.116 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T04:43:51.116Z,1756183431.116 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T04:43:51.416Z,1756183431.416 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T04:43:51.418Z,1756183431.418 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T04:43:51.418Z,1756183431.418 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T04:43:51.418Z,1756183431.418 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T04:43:51.420Z,1756183431.420 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T04:43:51.422Z,1756183431.422 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T04:43:51.822Z,1756183431.822 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T04:43:51.822Z,1756183431.822 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T04:43:51.822Z,1756183431.822 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T04:43:51.822Z,1756183431.822 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T04:43:51.823Z,1756183431.823 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T04:43:51.823Z,1756183431.823 [keepstation:SurfaceComms] Stopped
2025-08-26T04:43:51.823Z,1756183431.823 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T04:43:52.240Z,1756183432.240 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T04:43:52.240Z,1756183432.240 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T04:43:52.240Z,1756183432.240 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T04:43:52.240Z,1756183432.240 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T04:43:52.240Z,1756183432.240 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T04:43:52.241Z,1756183432.241 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T04:43:52.242Z,1756183432.242 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T04:43:52.242Z,1756183432.242 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T04:43:52.242Z,1756183432.242 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T04:43:52.242Z,1756183432.242 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T04:44:22.907Z,1756183462.907 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T04:46:35.264Z,1756183595.264 [Radio_Surface](INFO): Powering down
2025-08-26T04:46:41.428Z,1756183601.428 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T04:46:52.400Z,1756183612.400 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T04:43:52.2Z
2025-08-26T04:46:52.400Z,1756183612.400 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T04:46:52.400Z,1756183612.400 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T04:46:52.400Z,1756183612.400 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  7.022288 m 
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T04:46:52.401Z,1756183612.401 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T04:46:52.800Z,1756183612.800 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T04:46:52.800Z,1756183612.800 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T04:46:52.800Z,1756183612.800 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T04:46:52.800Z,1756183612.800 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T04:46:52.800Z,1756183612.800 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T04:46:52.800Z,1756183612.800 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T04:46:53.209Z,1756183613.209 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T04:46:53.210Z,1756183613.210 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T04:46:53.210Z,1756183613.210 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T04:46:53.210Z,1756183613.210 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T04:46:53.210Z,1756183613.210 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T04:46:53.210Z,1756183613.210 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T04:46:53.211Z,1756183613.211 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T04:46:53.211Z,1756183613.211 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T04:46:53.211Z,1756183613.211 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T04:46:53.211Z,1756183613.211 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T04:46:53.211Z,1756183613.211 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T04:46:53.211Z,1756183613.211 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T04:46:53.606Z,1756183613.606 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T04:46:53.606Z,1756183613.606 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T04:46:53.606Z,1756183613.606 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T04:46:53.606Z,1756183613.606 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T04:46:53.606Z,1756183613.606 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T04:46:53.607Z,1756183613.607 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T04:46:53.607Z,1756183613.607 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T05:19:11.198Z,1756185551.198 [BPC1](FAULT): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T05:19:11.199Z,1756185551.199 [BPC1](FAULT): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T05:19:11.200Z,1756185551.200 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T05:19:11.202Z,1756185551.202 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T05:43:50.264Z,1756187030.264 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T05:43:50.264Z,1756187030.264 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T05:43:50.264Z,1756187030.264 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T05:43:50.264Z,1756187030.264 [keepstation:SurfaceComms:A] Stopped
2025-08-26T05:43:50.264Z,1756187030.264 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T05:43:50.265Z,1756187030.265 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T05:43:50.669Z,1756187030.669 [keepstation:KeepStation:Dive] Stopped
2025-08-26T05:43:50.669Z,1756187030.669 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T05:43:50.669Z,1756187030.669 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T05:43:50.669Z,1756187030.669 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T05:43:50.670Z,1756187030.670 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T05:43:50.670Z,1756187030.670 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T05:43:50.670Z,1756187030.670 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T05:43:50.670Z,1756187030.670 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T05:43:50.670Z,1756187030.670 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T05:43:50.670Z,1756187030.670 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T05:43:50.672Z,1756187030.672 [keepstation:NeedComms] Running Loop=1
2025-08-26T05:43:50.672Z,1756187030.672 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T05:43:50.672Z,1756187030.672 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T05:43:50.672Z,1756187030.672 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T05:43:50.672Z,1756187030.672 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T05:43:50.673Z,1756187030.673 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T05:43:50.673Z,1756187030.673 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T05:43:50.673Z,1756187030.673 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T05:43:50.674Z,1756187030.674 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T05:43:50.674Z,1756187030.674 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T05:43:50.674Z,1756187030.674 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T05:43:50.676Z,1756187030.676 [keepstation:NeedComms:A](INFO): last time_fix was:  1756183430.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T05:43:50.676Z,1756187030.676 [keepstation:NeedComms:A] Stopped
2025-08-26T05:47:18.262Z,1756187238.262 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T05:47:18.976Z,1756187238.976 [Radio_Surface](INFO): Powering up
2025-08-26T05:47:24.352Z,1756187244.352 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T05:47:52.593Z,1756187272.593 [NAL9602](INFO): SBD MO Status=0, MOMSN=22688, MT Status=0, MTMSN=0
2025-08-26T05:47:52.593Z,1756187272.593 [NAL9602](INFO): No messages in MT queue
2025-08-26T05:47:53.799Z,1756187273.799 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,054753.00,A,3655.75133,N,12245.27543,W,0.680,153.87,260825,,,A*70
2025-08-26T05:47:53.803Z,1756187273.803 [NAL9602](INFO): GPS fix at 20250826T054753: (36.929189, -122.754591)
2025-08-26T05:47:53.816Z,1756187273.816 [keepstation:NeedComms:C] Stopped
2025-08-26T05:47:53.816Z,1756187273.816 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T05:48:11.822Z,1756187291.822 [NAL9602](INFO): SBD MO Status=2, MOMSN=22689, MT Status=2, MTMSN=0
2025-08-26T05:48:11.823Z,1756187291.823 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:48:28.968Z,1756187308.968 [NAL9602](INFO): SBD MO Status=2, MOMSN=22689, MT Status=2, MTMSN=0
2025-08-26T05:48:28.968Z,1756187308.968 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:48:54.597Z,1756187334.597 [NAL9602](INFO): SBD MO Status=2, MOMSN=22689, MT Status=2, MTMSN=0
2025-08-26T05:48:54.597Z,1756187334.597 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:50:36.614Z,1756187436.614 [NAL9602](INFO): SBD MO Status=2, MOMSN=22689, MT Status=2, MTMSN=0
2025-08-26T05:50:36.615Z,1756187436.615 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:51:08.757Z,1756187468.757 [NAL9602](INFO): SBD MO Status=2, MOMSN=22689, MT Status=2, MTMSN=0
2025-08-26T05:51:08.757Z,1756187468.757 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:51:27.128Z,1756187487.128 [NAL9602](INFO): SBD MO Status=1, MOMSN=22689, MT Status=0, MTMSN=0
2025-08-26T05:51:27.184Z,1756187487.184 [NAL9602](INFO): Sent 90 bytes from file Logs/20250826T031252/Courier0015.lzma
2025-08-26T05:51:27.184Z,1756187487.184 [NAL9602](INFO): Packets left to send: 0
2025-08-26T05:51:45.939Z,1756187505.939 [NAL9602](INFO): SBD MO Status=2, MOMSN=22690, MT Status=2, MTMSN=0
2025-08-26T05:51:45.939Z,1756187505.939 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:52:26.392Z,1756187546.392 [NAL9602](INFO): SBD MO Status=2, MOMSN=22690, MT Status=2, MTMSN=0
2025-08-26T05:52:26.393Z,1756187546.393 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:52:50.925Z,1756187570.925 [NAL9602](INFO): SBD MO Status=2, MOMSN=22690, MT Status=2, MTMSN=0
2025-08-26T05:52:50.925Z,1756187570.925 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T05:53:08.105Z,1756187588.105 [NAL9602](INFO): SBD MO Status=1, MOMSN=22690, MT Status=0, MTMSN=0
2025-08-26T05:53:08.164Z,1756187588.164 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0016.lzma
2025-08-26T05:53:08.164Z,1756187588.164 [NAL9602](INFO): Packets left to send: 1
2025-08-26T05:53:16.037Z,1756187596.037 [NAL9602](INFO): SBD MO Status=1, MOMSN=22691, MT Status=0, MTMSN=0
2025-08-26T05:53:16.092Z,1756187596.092 [NAL9602](INFO): Sent 252 bytes from file Logs/20250826T031252/Express0016.lzma
2025-08-26T05:53:16.092Z,1756187596.092 [NAL9602](INFO): Packets left to send: 0
2025-08-26T05:53:27.753Z,1756187607.753 [NAL9602](INFO): SBD MO Status=0, MOMSN=22692, MT Status=0, MTMSN=0
2025-08-26T05:53:27.837Z,1756187607.837 [keepstation:NeedComms:D] Stopped
2025-08-26T05:53:27.838Z,1756187607.838 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T05:53:30.181Z,1756187610.181 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,055330.00,A,3655.70293,N,12245.25007,W,0.330,178.46,260825,,,D*74
2025-08-26T05:53:30.183Z,1756187610.183 [NAL9602](INFO): GPS fix at 20250826T055330: (36.928382, -122.754168)
2025-08-26T05:53:30.196Z,1756187610.196 [keepstation:NeedComms:E] Stopped
2025-08-26T05:53:30.196Z,1756187610.196 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T05:53:30.197Z,1756187610.197 [keepstation:NeedComms] Stopped
2025-08-26T05:53:30.197Z,1756187610.197 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T05:53:30.197Z,1756187610.197 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T05:53:30.197Z,1756187610.197 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T05:53:30.612Z,1756187610.612 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T05:53:30.612Z,1756187610.612 [keepstation:SurfaceComms:B] Stopped
2025-08-26T05:53:30.612Z,1756187610.612 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T05:53:30.613Z,1756187610.613 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T05:53:30.613Z,1756187610.613 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T05:53:30.613Z,1756187610.613 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T05:53:31.008Z,1756187611.008 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T05:53:31.008Z,1756187611.008 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T05:53:31.008Z,1756187611.008 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T05:53:31.008Z,1756187611.008 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T05:53:31.008Z,1756187611.008 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T05:53:31.009Z,1756187611.009 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T05:53:31.398Z,1756187611.398 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T05:53:31.398Z,1756187611.398 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T05:53:31.398Z,1756187611.398 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T05:53:31.398Z,1756187611.398 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T05:53:31.398Z,1756187611.398 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T05:53:31.398Z,1756187611.398 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms] Stopped
2025-08-26T05:53:31.803Z,1756187611.803 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T05:53:32.218Z,1756187612.218 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T05:53:32.218Z,1756187612.218 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T05:53:32.218Z,1756187612.218 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T05:53:32.218Z,1756187612.218 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T05:53:32.218Z,1756187612.218 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T05:53:32.219Z,1756187612.219 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T05:53:32.220Z,1756187612.220 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T05:53:32.220Z,1756187612.220 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T05:53:32.220Z,1756187612.220 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T05:53:32.220Z,1756187612.220 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T05:54:02.899Z,1756187642.899 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T05:55:43.612Z,1756187743.612 [Radio_Surface](INFO): Powering down
2025-08-26T05:56:13.608Z,1756187773.608 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T05:56:32.390Z,1756187792.390 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T05:53:32.2Z
2025-08-26T05:56:32.390Z,1756187792.390 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T05:56:32.390Z,1756187792.390 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T05:56:32.391Z,1756187792.391 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T05:56:32.391Z,1756187792.391 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  8.954575 m 
2025-08-26T05:56:32.391Z,1756187792.391 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T05:56:32.392Z,1756187792.392 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T05:56:32.392Z,1756187792.392 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T05:56:32.392Z,1756187792.392 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T05:56:32.392Z,1756187792.392 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T05:56:32.392Z,1756187792.392 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T05:56:32.794Z,1756187792.794 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T05:56:32.794Z,1756187792.795 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T05:56:32.795Z,1756187792.795 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T05:56:32.795Z,1756187792.795 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T05:56:32.795Z,1756187792.795 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T05:56:32.795Z,1756187792.795 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T05:56:33.201Z,1756187793.201 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T05:56:33.201Z,1756187793.201 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T05:56:33.201Z,1756187793.201 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T05:56:33.201Z,1756187793.201 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T05:56:33.202Z,1756187793.202 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T05:56:33.618Z,1756187793.618 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T06:26:48.781Z,1756189608.781 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T06:26:48.782Z,1756189608.782 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T06:26:48.783Z,1756189608.783 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T06:26:48.802Z,1756189608.802 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T06:53:30.249Z,1756191210.249 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T06:53:30.249Z,1756191210.249 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T06:53:30.249Z,1756191210.249 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T06:53:30.250Z,1756191210.250 [keepstation:SurfaceComms:A] Stopped
2025-08-26T06:53:30.250Z,1756191210.250 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T06:53:30.250Z,1756191210.250 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T06:53:30.252Z,1756191210.252 [keepstation:NeedComms] Running Loop=1
2025-08-26T06:53:30.252Z,1756191210.252 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T06:53:30.252Z,1756191210.252 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T06:53:30.252Z,1756191210.252 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T06:53:30.252Z,1756191210.252 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T06:53:30.253Z,1756191210.253 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T06:53:30.253Z,1756191210.253 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T06:53:30.253Z,1756191210.253 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T06:53:30.254Z,1756191210.254 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T06:53:30.254Z,1756191210.254 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T06:53:30.254Z,1756191210.254 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T06:53:30.256Z,1756191210.256 [keepstation:NeedComms:A](INFO): last time_fix was:  1756187610.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T06:53:30.256Z,1756191210.256 [keepstation:NeedComms:A] Stopped
2025-08-26T06:53:30.645Z,1756191210.645 [keepstation:KeepStation:Dive] Stopped
2025-08-26T06:53:30.645Z,1756191210.645 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T06:53:30.645Z,1756191210.645 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T06:53:30.646Z,1756191210.646 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T06:57:35.518Z,1756191455.518 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T06:57:36.080Z,1756191456.080 [Radio_Surface](INFO): Powering up
2025-08-26T06:57:41.769Z,1756191461.769 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T07:00:06.805Z,1756191606.805 [NAL9602](INFO): SBD MO Status=2, MOMSN=22693, MT Status=2, MTMSN=0
2025-08-26T07:00:06.805Z,1756191606.805 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:01:41.339Z,1756191701.339 [NAL9602](INFO): SBD MO Status=2, MOMSN=22693, MT Status=2, MTMSN=0
2025-08-26T07:01:41.339Z,1756191701.339 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:02:06.793Z,1756191726.793 [NAL9602](INFO): SBD MO Status=2, MOMSN=22693, MT Status=2, MTMSN=0
2025-08-26T07:02:06.794Z,1756191726.794 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:02:33.051Z,1756191753.051 [NAL9602](INFO): SBD MO Status=2, MOMSN=22693, MT Status=2, MTMSN=0
2025-08-26T07:02:33.051Z,1756191753.051 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:02:39.917Z,1756191759.917 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-26T07:02:41.149Z,1756191761.149 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,070241.00,A,3655.54627,N,12245.33001,W,0.311,135.34,260825,,,D*77
2025-08-26T07:02:41.158Z,1756191761.158 [NAL9602](INFO): GPS fix at 20250826T070241: (36.925771, -122.755500)
2025-08-26T07:02:41.171Z,1756191761.171 [keepstation:NeedComms:C] Stopped
2025-08-26T07:02:41.171Z,1756191761.171 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T07:03:11.879Z,1756191791.879 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 
2025-08-26T07:03:11.955Z,1756191791.955 [NAL9602](ERROR): received: 
+CSQ:0

OK693, 2, 0, 0, 0

OK
2025-08-26T07:03:52.891Z,1756191832.891 [NAL9602](INFO): SBD MO Status=2, MOMSN=22693, MT Status=2, MTMSN=0
2025-08-26T07:03:52.891Z,1756191832.891 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:04:03.173Z,1756191843.173 [NAL9602](INFO): SBD MO Status=1, MOMSN=22693, MT Status=0, MTMSN=0
2025-08-26T07:04:03.224Z,1756191843.224 [NAL9602](INFO): Sent 90 bytes from file Logs/20250826T031252/Courier0018.lzma
2025-08-26T07:04:03.224Z,1756191843.224 [NAL9602](INFO): Packets left to send: 0
2025-08-26T07:04:22.019Z,1756191862.019 [NAL9602](INFO): SBD MO Status=2, MOMSN=22694, MT Status=2, MTMSN=0
2025-08-26T07:04:22.019Z,1756191862.019 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:04:38.413Z,1756191878.413 [NAL9602](INFO): SBD MO Status=1, MOMSN=22694, MT Status=0, MTMSN=0
2025-08-26T07:04:38.460Z,1756191878.460 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0019.lzma
2025-08-26T07:04:38.460Z,1756191878.460 [NAL9602](INFO): Packets left to send: 1
2025-08-26T07:04:46.727Z,1756191886.727 [NAL9602](INFO): SBD MO Status=1, MOMSN=22695, MT Status=0, MTMSN=0
2025-08-26T07:04:46.788Z,1756191886.788 [NAL9602](INFO): Sent 232 bytes from file Logs/20250826T031252/Express0019.lzma
2025-08-26T07:04:46.788Z,1756191886.788 [NAL9602](INFO): Packets left to send: 0
2025-08-26T07:05:01.693Z,1756191901.693 [NAL9602](INFO): SBD MO Status=2, MOMSN=22696, MT Status=2, MTMSN=0
2025-08-26T07:05:01.693Z,1756191901.693 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:05:19.101Z,1756191919.101 [NAL9602](INFO): SBD MO Status=2, MOMSN=22696, MT Status=2, MTMSN=0
2025-08-26T07:05:19.102Z,1756191919.102 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:05:24.158Z,1756191924.158 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2025-08-26T07:05:26.175Z,1756191926.175 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2025-08-26T07:05:30.213Z,1756191930.213 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2025-08-26T07:05:34.658Z,1756191934.658 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2025-08-26T07:05:56.269Z,1756191956.269 [NAL9602](INFO): SBD MO Status=2, MOMSN=22696, MT Status=2, MTMSN=0
2025-08-26T07:05:56.269Z,1756191956.269 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T07:06:12.465Z,1756191972.465 [NAL9602](INFO): SBD MO Status=0, MOMSN=22696, MT Status=0, MTMSN=0
2025-08-26T07:06:12.544Z,1756191972.544 [keepstation:NeedComms:D] Stopped
2025-08-26T07:06:12.544Z,1756191972.544 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T07:06:14.855Z,1756191974.855 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,070614.00,A,3655.51360,N,12245.32398,W,1.089,194.49,260825,,,D*70
2025-08-26T07:06:14.857Z,1756191974.857 [NAL9602](INFO): GPS fix at 20250826T070614: (36.925227, -122.755400)
2025-08-26T07:06:14.871Z,1756191974.871 [keepstation:NeedComms:E] Stopped
2025-08-26T07:06:14.872Z,1756191974.872 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T07:06:14.872Z,1756191974.872 [keepstation:NeedComms] Stopped
2025-08-26T07:06:14.872Z,1756191974.872 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T07:06:14.872Z,1756191974.872 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T07:06:14.872Z,1756191974.872 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T07:06:15.288Z,1756191975.288 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T07:06:15.288Z,1756191975.288 [keepstation:SurfaceComms:B] Stopped
2025-08-26T07:06:15.288Z,1756191975.288 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T07:06:15.289Z,1756191975.289 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T07:06:15.289Z,1756191975.289 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T07:06:15.289Z,1756191975.289 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T07:06:15.723Z,1756191975.723 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T07:06:15.724Z,1756191975.724 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T07:06:15.724Z,1756191975.724 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T07:06:15.724Z,1756191975.724 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T07:06:15.724Z,1756191975.724 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T07:06:15.724Z,1756191975.724 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T07:06:16.097Z,1756191976.097 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T07:06:16.097Z,1756191976.097 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T07:06:16.097Z,1756191976.097 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T07:06:16.097Z,1756191976.097 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T07:06:16.097Z,1756191976.097 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T07:06:16.097Z,1756191976.097 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T07:06:16.479Z,1756191976.479 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T07:06:16.479Z,1756191976.479 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T07:06:16.479Z,1756191976.479 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T07:06:16.479Z,1756191976.479 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T07:06:16.480Z,1756191976.480 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T07:06:16.480Z,1756191976.480 [keepstation:SurfaceComms] Stopped
2025-08-26T07:06:16.480Z,1756191976.480 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T07:06:16.886Z,1756191976.886 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T07:06:16.886Z,1756191976.886 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T07:06:16.886Z,1756191976.886 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T07:06:16.887Z,1756191976.887 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T07:06:16.887Z,1756191976.887 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T07:06:16.887Z,1756191976.887 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T07:06:16.887Z,1756191976.887 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T07:06:16.888Z,1756191976.888 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T07:06:16.888Z,1756191976.888 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T07:06:16.888Z,1756191976.888 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T07:06:16.888Z,1756191976.888 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T07:06:16.888Z,1756191976.888 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T07:06:16.888Z,1756191976.888 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T07:06:16.889Z,1756191976.889 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T07:06:16.889Z,1756191976.889 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T07:06:16.889Z,1756191976.889 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T07:06:16.889Z,1756191976.889 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T07:06:46.769Z,1756192006.769 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T07:08:25.736Z,1756192105.736 [Radio_Surface](INFO): Powering down
2025-08-26T07:08:35.444Z,1756192115.444 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T07:09:17.067Z,1756192157.067 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T07:06:16.9Z
2025-08-26T07:09:17.067Z,1756192157.067 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T07:09:17.067Z,1756192157.067 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T07:09:17.068Z,1756192157.068 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T07:09:17.068Z,1756192157.068 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  9.677497 m 
2025-08-26T07:09:17.068Z,1756192157.068 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T07:09:17.068Z,1756192157.068 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T07:09:17.068Z,1756192157.068 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T07:09:17.068Z,1756192157.068 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T07:09:17.069Z,1756192157.069 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T07:09:17.069Z,1756192157.069 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T07:09:17.473Z,1756192157.473 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T07:09:17.473Z,1756192157.473 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T07:09:17.473Z,1756192157.473 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T07:09:17.473Z,1756192157.473 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T07:09:17.473Z,1756192157.473 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T07:09:17.473Z,1756192157.473 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T07:09:17.891Z,1756192157.891 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T07:09:17.891Z,1756192157.891 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T07:09:17.891Z,1756192157.891 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T07:09:17.891Z,1756192157.891 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T07:09:17.896Z,1756192157.896 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T07:09:18.274Z,1756192158.274 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T07:09:18.275Z,1756192158.275 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T07:09:18.275Z,1756192158.275 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T07:09:18.275Z,1756192158.275 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T07:09:18.275Z,1756192158.275 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T07:09:18.275Z,1756192158.275 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T07:09:18.275Z,1756192158.275 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T07:27:56.136Z,1756193276.136 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file).
2025-08-26T07:34:26.402Z,1756193666.402 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T07:34:26.403Z,1756193666.403 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T07:34:26.404Z,1756193666.404 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T07:34:26.406Z,1756193666.406 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T08:06:14.905Z,1756195574.905 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T08:06:14.905Z,1756195574.905 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T08:06:14.905Z,1756195574.905 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T08:06:14.906Z,1756195574.906 [keepstation:SurfaceComms:A] Stopped
2025-08-26T08:06:14.906Z,1756195574.906 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T08:06:14.906Z,1756195574.906 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T08:06:14.908Z,1756195574.908 [keepstation:NeedComms] Running Loop=1
2025-08-26T08:06:14.908Z,1756195574.908 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T08:06:14.908Z,1756195574.908 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T08:06:14.908Z,1756195574.908 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T08:06:14.908Z,1756195574.908 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T08:06:14.909Z,1756195574.909 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T08:06:14.909Z,1756195574.909 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T08:06:14.909Z,1756195574.909 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T08:06:14.910Z,1756195574.910 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T08:06:14.910Z,1756195574.910 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T08:06:14.910Z,1756195574.910 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T08:06:14.912Z,1756195574.912 [keepstation:NeedComms:A](INFO): last time_fix was:  1756191974.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T08:06:14.912Z,1756195574.912 [keepstation:NeedComms:A] Stopped
2025-08-26T08:06:15.308Z,1756195575.308 [keepstation:KeepStation:Dive] Stopped
2025-08-26T08:06:15.308Z,1756195575.308 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T08:06:15.308Z,1756195575.308 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T08:06:15.309Z,1756195575.309 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T08:10:07.080Z,1756195807.080 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T08:10:07.648Z,1756195807.648 [Radio_Surface](INFO): Powering up
2025-08-26T08:10:13.736Z,1756195813.736 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T08:10:34.354Z,1756195834.354 [NAL9602](INFO): SBD MO Status=2, MOMSN=22697, MT Status=2, MTMSN=0
2025-08-26T08:10:34.354Z,1756195834.354 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T08:11:00.210Z,1756195860.210 [NAL9602](INFO): SBD MO Status=2, MOMSN=22697, MT Status=2, MTMSN=0
2025-08-26T08:11:00.210Z,1756195860.210 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T08:14:06.461Z,1756196046.461 [NAL9602](INFO): SBD MO Status=2, MOMSN=22697, MT Status=2, MTMSN=0
2025-08-26T08:14:06.461Z,1756196046.461 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T08:15:01.801Z,1756196101.801 [NAL9602](INFO): SBD MO Status=2, MOMSN=22697, MT Status=2, MTMSN=0
2025-08-26T08:15:01.802Z,1756196101.802 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T08:15:11.900Z,1756196111.900 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-26T08:15:20.394Z,1756196120.394 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,081520.00,A,3655.41695,N,12245.54262,W,0.447,231.61,260825,,,D*71
2025-08-26T08:15:20.397Z,1756196120.397 [NAL9602](INFO): GPS fix at 20250826T081520: (36.923616, -122.759044)
2025-08-26T08:15:20.410Z,1756196120.410 [keepstation:NeedComms:C] Stopped
2025-08-26T08:15:20.410Z,1756196120.410 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T08:15:51.096Z,1756196151.096 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 
2025-08-26T08:15:51.175Z,1756196151.175 [NAL9602](ERROR): received: 
+CSQ:0

OK697, 2, 0, 0, 0

OK
2025-08-26T08:16:40.165Z,1756196200.165 [NAL9602](INFO): SBD MO Status=2, MOMSN=22697, MT Status=2, MTMSN=0
2025-08-26T08:16:40.165Z,1756196200.165 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T08:16:51.265Z,1756196211.265 [NAL9602](INFO): SBD MO Status=1, MOMSN=22697, MT Status=0, MTMSN=0
2025-08-26T08:16:51.320Z,1756196211.320 [NAL9602](INFO): Sent 90 bytes from file Logs/20250826T031252/Courier0021.lzma
2025-08-26T08:16:51.320Z,1756196211.320 [NAL9602](INFO): Packets left to send: 0
2025-08-26T08:17:01.649Z,1756196221.649 [NAL9602](INFO): SBD MO Status=1, MOMSN=22698, MT Status=0, MTMSN=0
2025-08-26T08:17:01.700Z,1756196221.700 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0022.lzma
2025-08-26T08:17:01.700Z,1756196221.700 [NAL9602](INFO): Packets left to send: 1
2025-08-26T08:17:19.265Z,1756196239.265 [NAL9602](INFO): SBD MO Status=2, MOMSN=22699, MT Status=2, MTMSN=0
2025-08-26T08:17:19.265Z,1756196239.265 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T08:17:47.518Z,1756196267.518 [NAL9602](INFO): SBD MO Status=1, MOMSN=22699, MT Status=0, MTMSN=0
2025-08-26T08:17:47.572Z,1756196267.572 [NAL9602](INFO): Sent 241 bytes from file Logs/20250826T031252/Express0022.lzma
2025-08-26T08:17:47.572Z,1756196267.572 [NAL9602](INFO): Packets left to send: 0
2025-08-26T08:17:57.210Z,1756196277.210 [NAL9602](INFO): SBD MO Status=0, MOMSN=22700, MT Status=0, MTMSN=0
2025-08-26T08:17:57.314Z,1756196277.314 [keepstation:NeedComms:D] Stopped
2025-08-26T08:17:57.314Z,1756196277.314 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T08:17:59.643Z,1756196279.643 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,081759.00,A,3655.39972,N,12245.56383,W,1.108,180.55,260825,,,D*79
2025-08-26T08:17:59.645Z,1756196279.645 [NAL9602](INFO): GPS fix at 20250826T081759: (36.923329, -122.759397)
2025-08-26T08:17:59.658Z,1756196279.658 [keepstation:NeedComms:E] Stopped
2025-08-26T08:17:59.659Z,1756196279.659 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T08:17:59.659Z,1756196279.659 [keepstation:NeedComms] Stopped
2025-08-26T08:17:59.659Z,1756196279.659 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T08:17:59.659Z,1756196279.659 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T08:17:59.659Z,1756196279.659 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T08:18:00.076Z,1756196280.076 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T08:18:00.076Z,1756196280.076 [keepstation:SurfaceComms:B] Stopped
2025-08-26T08:18:00.076Z,1756196280.076 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T08:18:00.077Z,1756196280.077 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T08:18:00.077Z,1756196280.077 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T08:18:00.077Z,1756196280.077 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T08:18:00.456Z,1756196280.456 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T08:18:00.456Z,1756196280.456 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T08:18:00.456Z,1756196280.456 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T08:18:00.457Z,1756196280.457 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T08:18:00.457Z,1756196280.457 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T08:18:00.457Z,1756196280.457 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T08:18:00.864Z,1756196280.864 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T08:18:00.864Z,1756196280.864 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T08:18:00.864Z,1756196280.864 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T08:18:00.864Z,1756196280.864 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T08:18:00.864Z,1756196280.864 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T08:18:00.864Z,1756196280.864 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T08:18:01.274Z,1756196281.274 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T08:18:01.274Z,1756196281.274 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T08:18:01.274Z,1756196281.274 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T08:18:01.274Z,1756196281.274 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T08:18:01.275Z,1756196281.275 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T08:18:01.275Z,1756196281.275 [keepstation:SurfaceComms] Stopped
2025-08-26T08:18:01.275Z,1756196281.275 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T08:18:01.681Z,1756196281.681 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T08:18:01.682Z,1756196281.682 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T08:18:01.682Z,1756196281.682 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T08:18:01.682Z,1756196281.682 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T08:18:01.682Z,1756196281.682 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T08:18:01.682Z,1756196281.682 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T08:18:01.682Z,1756196281.682 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T08:18:01.683Z,1756196281.683 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T08:18:01.683Z,1756196281.683 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T08:18:01.683Z,1756196281.683 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T08:18:01.683Z,1756196281.683 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T08:18:01.683Z,1756196281.683 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T08:18:01.683Z,1756196281.683 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T08:18:01.688Z,1756196281.688 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T08:18:01.688Z,1756196281.688 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T08:18:01.688Z,1756196281.688 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T08:18:01.688Z,1756196281.688 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T08:18:32.050Z,1756196312.050 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T08:20:10.856Z,1756196410.856 [Radio_Surface](INFO): Powering down
2025-08-26T08:20:36.322Z,1756196436.322 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T08:21:01.910Z,1756196461.910 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T08:18:01.7Z
2025-08-26T08:21:01.911Z,1756196461.911 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T08:21:01.911Z,1756196461.911 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T08:21:01.912Z,1756196461.912 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T08:21:01.912Z,1756196461.912 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  9.610187 m 
2025-08-26T08:21:01.915Z,1756196461.915 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T08:21:01.915Z,1756196461.915 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T08:21:01.915Z,1756196461.915 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T08:21:01.915Z,1756196461.915 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T08:21:01.915Z,1756196461.915 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T08:21:01.915Z,1756196461.915 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T08:21:02.328Z,1756196462.328 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T08:21:02.328Z,1756196462.328 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T08:21:02.328Z,1756196462.328 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T08:21:02.328Z,1756196462.328 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T08:21:02.328Z,1756196462.328 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T08:21:02.328Z,1756196462.328 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T08:21:02.721Z,1756196462.721 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T08:21:02.721Z,1756196462.721 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T08:21:02.721Z,1756196462.721 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T08:21:02.721Z,1756196462.721 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T08:21:02.721Z,1756196462.721 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T08:21:02.721Z,1756196462.721 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T08:21:02.722Z,1756196462.722 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T08:21:02.722Z,1756196462.722 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T08:21:02.722Z,1756196462.722 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T08:21:02.722Z,1756196462.722 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T08:21:02.722Z,1756196462.722 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T08:21:02.722Z,1756196462.722 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T08:21:03.141Z,1756196463.141 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T08:42:04.451Z,1756197724.451 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T08:42:04.452Z,1756197724.452 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T08:42:04.453Z,1756197724.453 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T08:42:04.455Z,1756197724.455 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T08:56:21.204Z,1756198581.204 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-08-26T08:56:25.687Z,1756198585.687 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.002046
CHAN A1 (24V): 0.022494
CHAN A2 (12V): -0.008236
CHAN A3 (5V): -0.013607
CHAN B0 (3.3V): -0.012899
CHAN B1 (3.15aV): -0.010445
CHAN B2 (3.15bV): -0.009787
CHAN B3 (GND): -0.012789
OPEN: 0.007395
Full Scale: +/- 1 mA
2025-08-26T09:17:59.824Z,1756199879.824 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T09:17:59.824Z,1756199879.824 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T09:17:59.824Z,1756199879.824 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T09:17:59.824Z,1756199879.824 [keepstation:SurfaceComms:A] Stopped
2025-08-26T09:17:59.824Z,1756199879.824 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T09:17:59.825Z,1756199879.825 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T09:17:59.826Z,1756199879.826 [keepstation:NeedComms] Running Loop=1
2025-08-26T09:17:59.826Z,1756199879.826 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T09:17:59.826Z,1756199879.826 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T09:17:59.826Z,1756199879.826 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T09:17:59.827Z,1756199879.827 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T09:17:59.831Z,1756199879.831 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T09:17:59.832Z,1756199879.832 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T09:17:59.832Z,1756199879.832 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T09:17:59.832Z,1756199879.832 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T09:17:59.833Z,1756199879.833 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T09:17:59.833Z,1756199879.833 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T09:17:59.834Z,1756199879.834 [keepstation:NeedComms:A](INFO): last time_fix was:  1756196279.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T09:17:59.835Z,1756199879.835 [keepstation:NeedComms:A] Stopped
2025-08-26T09:18:00.206Z,1756199880.206 [keepstation:KeepStation:Dive] Stopped
2025-08-26T09:18:00.206Z,1756199880.206 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T09:18:00.206Z,1756199880.206 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T09:18:00.206Z,1756199880.206 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T09:18:00.207Z,1756199880.207 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T09:18:00.207Z,1756199880.207 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T09:18:00.207Z,1756199880.207 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T09:18:00.207Z,1756199880.207 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T09:18:00.207Z,1756199880.207 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T09:18:00.207Z,1756199880.207 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T09:21:47.337Z,1756200107.337 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T09:21:47.960Z,1756200107.960 [Radio_Surface](INFO): Powering up
2025-08-26T09:21:53.532Z,1756200113.532 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T09:22:14.001Z,1756200134.001 [NAL9602](INFO): SBD MO Status=2, MOMSN=22701, MT Status=2, MTMSN=0
2025-08-26T09:22:14.001Z,1756200134.001 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T09:22:51.574Z,1756200171.574 [NAL9602](INFO): SBD MO Status=0, MOMSN=22701, MT Status=0, MTMSN=0
2025-08-26T09:22:51.574Z,1756200171.574 [NAL9602](INFO): No messages in MT queue
2025-08-26T09:22:52.786Z,1756200172.786 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,092252.00,A,3655.48087,N,12245.76261,W,0.680,65.59,260825,,,D*4F
2025-08-26T09:22:52.789Z,1756200172.789 [NAL9602](INFO): GPS fix at 20250826T092252: (36.924681, -122.762710)
2025-08-26T09:22:52.802Z,1756200172.802 [keepstation:NeedComms:C] Stopped
2025-08-26T09:22:52.802Z,1756200172.802 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T09:23:11.194Z,1756200191.194 [NAL9602](INFO): SBD MO Status=1, MOMSN=22702, MT Status=0, MTMSN=0
2025-08-26T09:23:11.244Z,1756200191.244 [NAL9602](INFO): Sent 89 bytes from file Logs/20250826T031252/Courier0024.lzma
2025-08-26T09:23:11.244Z,1756200191.244 [NAL9602](INFO): Packets left to send: 0
2025-08-26T09:23:27.993Z,1756200207.993 [NAL9602](INFO): SBD MO Status=2, MOMSN=22703, MT Status=2, MTMSN=0
2025-08-26T09:23:27.993Z,1756200207.993 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T09:23:51.723Z,1756200231.723 [NAL9602](INFO): SBD MO Status=2, MOMSN=22703, MT Status=2, MTMSN=0
2025-08-26T09:23:51.723Z,1756200231.723 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T09:24:17.435Z,1756200257.435 [NAL9602](INFO): SBD MO Status=2, MOMSN=22703, MT Status=2, MTMSN=0
2025-08-26T09:24:17.435Z,1756200257.435 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T09:24:43.965Z,1756200283.965 [NAL9602](INFO): SBD MO Status=2, MOMSN=22703, MT Status=2, MTMSN=0
2025-08-26T09:24:43.965Z,1756200283.965 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T09:25:07.245Z,1756200307.245 [NAL9602](INFO): SBD MO Status=1, MOMSN=22703, MT Status=0, MTMSN=0
2025-08-26T09:25:07.305Z,1756200307.305 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0025.lzma
2025-08-26T09:25:07.305Z,1756200307.305 [NAL9602](INFO): Packets left to send: 1
2025-08-26T09:25:32.141Z,1756200332.141 [NAL9602](INFO): SBD MO Status=1, MOMSN=22704, MT Status=0, MTMSN=0
2025-08-26T09:25:32.192Z,1756200332.192 [NAL9602](INFO): Sent 331 bytes from file Logs/20250826T031252/Express0025.lzma
2025-08-26T09:25:32.192Z,1756200332.192 [NAL9602](INFO): Packets left to send: 0
2025-08-26T09:25:39.016Z,1756200339.016 [NAL9602](INFO): SBD MO Status=0, MOMSN=22705, MT Status=0, MTMSN=0
2025-08-26T09:25:39.095Z,1756200339.095 [keepstation:NeedComms:D] Stopped
2025-08-26T09:25:39.096Z,1756200339.096 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T09:25:41.434Z,1756200341.434 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,092541.00,A,3655.47947,N,12245.77038,W,0.525,264.17,260825,,,D*7A
2025-08-26T09:25:41.436Z,1756200341.436 [NAL9602](INFO): GPS fix at 20250826T092541: (36.924658, -122.762840)
2025-08-26T09:25:41.449Z,1756200341.449 [keepstation:NeedComms:E] Stopped
2025-08-26T09:25:41.450Z,1756200341.450 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T09:25:41.450Z,1756200341.450 [keepstation:NeedComms] Stopped
2025-08-26T09:25:41.450Z,1756200341.450 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T09:25:41.450Z,1756200341.450 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T09:25:41.450Z,1756200341.450 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T09:25:41.869Z,1756200341.869 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T09:25:41.869Z,1756200341.869 [keepstation:SurfaceComms:B] Stopped
2025-08-26T09:25:41.869Z,1756200341.869 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T09:25:41.870Z,1756200341.870 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T09:25:41.870Z,1756200341.870 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T09:25:41.870Z,1756200341.870 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T09:25:42.258Z,1756200342.258 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T09:25:42.259Z,1756200342.259 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T09:25:42.259Z,1756200342.259 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T09:25:42.259Z,1756200342.259 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T09:25:42.259Z,1756200342.259 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T09:25:42.259Z,1756200342.259 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T09:25:42.654Z,1756200342.654 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T09:25:42.654Z,1756200342.654 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T09:25:42.654Z,1756200342.654 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T09:25:42.654Z,1756200342.654 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T09:25:42.654Z,1756200342.654 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T09:25:42.654Z,1756200342.654 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T09:25:43.067Z,1756200343.067 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T09:25:43.067Z,1756200343.067 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T09:25:43.067Z,1756200343.067 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T09:25:43.068Z,1756200343.068 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T09:25:43.068Z,1756200343.068 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T09:25:43.068Z,1756200343.068 [keepstation:SurfaceComms] Stopped
2025-08-26T09:25:43.068Z,1756200343.068 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T09:25:43.464Z,1756200343.464 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T09:25:43.464Z,1756200343.464 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T09:25:43.464Z,1756200343.464 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T09:25:43.464Z,1756200343.464 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T09:25:43.465Z,1756200343.465 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T09:25:43.466Z,1756200343.466 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T09:25:43.466Z,1756200343.466 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T09:25:43.466Z,1756200343.466 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T09:25:43.466Z,1756200343.466 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T09:25:43.466Z,1756200343.466 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T09:26:13.748Z,1756200373.748 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T09:27:51.200Z,1756200471.200 [Radio_Surface](INFO): Powering down
2025-08-26T09:28:07.044Z,1756200487.044 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T09:28:43.647Z,1756200523.647 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T09:25:43.5Z
2025-08-26T09:28:43.647Z,1756200523.647 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T09:28:43.647Z,1756200523.647 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T09:28:43.664Z,1756200523.664 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T09:28:43.665Z,1756200523.665 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  9.739871 m 
2025-08-26T09:28:43.665Z,1756200523.665 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T09:28:43.665Z,1756200523.665 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T09:28:43.665Z,1756200523.665 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T09:28:43.665Z,1756200523.665 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T09:28:43.665Z,1756200523.665 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T09:28:43.666Z,1756200523.666 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T09:28:44.050Z,1756200524.050 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T09:28:44.050Z,1756200524.050 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T09:28:44.050Z,1756200524.050 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T09:28:44.051Z,1756200524.051 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T09:28:44.051Z,1756200524.051 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T09:28:44.051Z,1756200524.051 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T09:28:44.456Z,1756200524.456 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T09:28:44.456Z,1756200524.456 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T09:28:44.456Z,1756200524.456 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T09:28:44.456Z,1756200524.456 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T09:28:44.457Z,1756200524.457 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T09:28:44.866Z,1756200524.866 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T09:49:42.501Z,1756201782.501 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T09:49:42.502Z,1756201782.502 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T09:49:42.502Z,1756201782.502 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T09:49:42.525Z,1756201782.525 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T10:25:41.484Z,1756203941.484 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T10:25:41.484Z,1756203941.484 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T10:25:41.484Z,1756203941.484 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T10:25:41.484Z,1756203941.484 [keepstation:SurfaceComms:A] Stopped
2025-08-26T10:25:41.484Z,1756203941.484 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T10:25:41.484Z,1756203941.484 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T10:25:41.486Z,1756203941.486 [keepstation:NeedComms] Running Loop=1
2025-08-26T10:25:41.486Z,1756203941.486 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T10:25:41.486Z,1756203941.486 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T10:25:41.486Z,1756203941.486 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T10:25:41.487Z,1756203941.487 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T10:25:41.487Z,1756203941.487 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T10:25:41.488Z,1756203941.488 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T10:25:41.488Z,1756203941.488 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T10:25:41.488Z,1756203941.488 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T10:25:41.489Z,1756203941.489 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T10:25:41.489Z,1756203941.489 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T10:25:41.490Z,1756203941.490 [keepstation:NeedComms:A](INFO): last time_fix was:  1756200341.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T10:25:41.490Z,1756203941.490 [keepstation:NeedComms:A] Stopped
2025-08-26T10:25:41.887Z,1756203941.887 [keepstation:KeepStation:Dive] Stopped
2025-08-26T10:25:41.887Z,1756203941.887 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T10:25:41.887Z,1756203941.887 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T10:25:41.887Z,1756203941.887 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T10:25:41.888Z,1756203941.888 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T10:25:41.888Z,1756203941.888 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T10:25:41.888Z,1756203941.888 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T10:25:41.888Z,1756203941.888 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T10:25:41.888Z,1756203941.888 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T10:25:41.888Z,1756203941.888 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T10:29:38.760Z,1756204178.760 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T10:29:39.268Z,1756204179.268 [Radio_Surface](INFO): Powering up
2025-08-26T10:29:45.192Z,1756204185.192 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T10:30:54.417Z,1756204254.417 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:30:54.418Z,1756204254.418 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:34:42.675Z,1756204482.675 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-08-26T10:34:49.545Z,1756204489.545 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,103449.00,A,3655.58821,N,12245.91823,W,0.194,269.53,260825,,,D*7C
2025-08-26T10:34:49.548Z,1756204489.548 [NAL9602](INFO): GPS fix at 20250826T103449: (36.926470, -122.765304)
2025-08-26T10:34:49.560Z,1756204489.560 [keepstation:NeedComms:C] Stopped
2025-08-26T10:34:49.561Z,1756204489.561 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T10:35:20.277Z,1756204520.277 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 
2025-08-26T10:35:20.355Z,1756204520.355 [NAL9602](ERROR): received: 
+CSQ:0

OK706, 2, 0, 0, 0

OK
2025-08-26T10:36:35.209Z,1756204595.209 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:36:35.209Z,1756204595.209 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:37:59.013Z,1756204679.013 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:37:59.013Z,1756204679.013 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:41:35.501Z,1756204895.501 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:41:35.501Z,1756204895.501 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:42:33.861Z,1756204953.861 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:42:33.861Z,1756204953.861 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:43:56.485Z,1756205036.485 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:43:56.485Z,1756205036.485 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:44:18.082Z,1756205058.082 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:44:18.082Z,1756205058.082 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:44:49.604Z,1756205089.604 [keepstation:NeedComms:D](INFO): Timed out from 2025-08-26T10:34:49.6Z
2025-08-26T10:44:49.604Z,1756205089.604 [keepstation:NeedComms:D:A_Timeout] Running Loop=1
2025-08-26T10:44:49.604Z,1756205089.604 [keepstation:NeedComms:D:A_Timeout](DEBUG): Aggregate::initialize keepstation:NeedComms:D:A_Timeout
2025-08-26T10:44:49.604Z,1756205089.604 [keepstation:NeedComms:D:A_Timeout:A] Running Loop=1
2025-08-26T10:44:49.605Z,1756205089.605 [keepstation:NeedComms:D:A_Timeout:A](IMPORTANT): Comms timed out after  10.000000 min minutes
2025-08-26T10:44:49.605Z,1756205089.605 [keepstation:NeedComms:D:A_Timeout:A] Stopped
2025-08-26T10:44:49.605Z,1756205089.605 [keepstation:NeedComms:D:A_Timeout](INFO): Completed keepstation:NeedComms:D:A_Timeout
2025-08-26T10:44:49.605Z,1756205089.605 [keepstation:NeedComms:D] Stopped
2025-08-26T10:44:49.605Z,1756205089.605 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T10:45:13.621Z,1756205113.621 [NAL9602](INFO): SBD MO Status=2, MOMSN=22706, MT Status=2, MTMSN=0
2025-08-26T10:45:13.621Z,1756205113.621 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T10:45:14.833Z,1756205114.833 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,104514.00,A,3655.58737,N,12245.95196,W,0.583,219.05,260825,,,D*7F
2025-08-26T10:45:14.835Z,1756205114.835 [NAL9602](INFO): GPS fix at 20250826T104514: (36.926456, -122.765866)
2025-08-26T10:45:14.863Z,1756205114.863 [keepstation:NeedComms:E] Stopped
2025-08-26T10:45:14.864Z,1756205114.864 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T10:45:14.864Z,1756205114.864 [keepstation:NeedComms] Stopped
2025-08-26T10:45:14.864Z,1756205114.864 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T10:45:14.864Z,1756205114.864 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T10:45:14.864Z,1756205114.864 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T10:45:15.276Z,1756205115.276 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T10:45:15.276Z,1756205115.276 [keepstation:SurfaceComms:B] Stopped
2025-08-26T10:45:15.276Z,1756205115.276 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T10:45:15.276Z,1756205115.276 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T10:45:15.276Z,1756205115.276 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T10:45:15.276Z,1756205115.276 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T10:45:15.652Z,1756205115.652 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T10:45:15.652Z,1756205115.652 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T10:45:15.652Z,1756205115.652 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T10:45:15.652Z,1756205115.652 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T10:45:15.652Z,1756205115.652 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T10:45:15.652Z,1756205115.652 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T10:45:16.060Z,1756205116.060 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T10:45:16.061Z,1756205116.061 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T10:45:16.061Z,1756205116.061 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T10:45:16.061Z,1756205116.061 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T10:45:16.061Z,1756205116.061 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T10:45:16.061Z,1756205116.061 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T10:45:16.464Z,1756205116.464 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T10:45:16.464Z,1756205116.464 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T10:45:16.465Z,1756205116.465 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T10:45:16.465Z,1756205116.465 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T10:45:16.465Z,1756205116.465 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T10:45:16.465Z,1756205116.465 [keepstation:SurfaceComms] Stopped
2025-08-26T10:45:16.465Z,1756205116.465 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T10:45:16.862Z,1756205116.862 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T10:45:16.862Z,1756205116.862 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T10:45:16.863Z,1756205116.863 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T10:45:16.863Z,1756205116.863 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T10:45:16.863Z,1756205116.863 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T10:45:16.883Z,1756205116.883 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T10:45:16.884Z,1756205116.884 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T10:45:16.885Z,1756205116.885 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T10:45:16.885Z,1756205116.885 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T10:45:16.885Z,1756205116.885 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T10:45:16.885Z,1756205116.885 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T10:45:46.749Z,1756205146.749 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T10:47:26.416Z,1756205246.416 [Radio_Surface](INFO): Powering down
2025-08-26T10:47:54.668Z,1756205274.668 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T10:48:17.050Z,1756205297.050 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T10:45:16.9Z
2025-08-26T10:48:17.050Z,1756205297.050 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T10:48:17.051Z,1756205297.051 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T10:48:17.051Z,1756205297.051 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  9.287990 m 
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T10:48:17.052Z,1756205297.052 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T10:48:17.452Z,1756205297.452 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T10:48:17.453Z,1756205297.453 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T10:48:17.453Z,1756205297.453 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T10:48:17.453Z,1756205297.453 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T10:48:17.453Z,1756205297.453 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T10:48:17.453Z,1756205297.453 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T10:48:17.863Z,1756205297.863 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T10:48:17.864Z,1756205297.864 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T10:48:17.865Z,1756205297.865 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T10:48:17.865Z,1756205297.865 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T10:48:17.865Z,1756205297.865 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T10:48:17.865Z,1756205297.865 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T10:48:18.259Z,1756205298.259 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T10:57:17.997Z,1756205837.997 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T10:57:17.998Z,1756205837.998 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T10:57:17.999Z,1756205837.999 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 6.
2025-08-26T10:57:18.001Z,1756205838.001 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T11:45:14.885Z,1756208714.885 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T11:45:14.885Z,1756208714.885 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T11:45:14.885Z,1756208714.885 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T11:45:14.886Z,1756208714.886 [keepstation:SurfaceComms:A] Stopped
2025-08-26T11:45:14.886Z,1756208714.886 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T11:45:14.886Z,1756208714.886 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T11:45:15.285Z,1756208715.285 [keepstation:KeepStation:Dive] Stopped
2025-08-26T11:45:15.285Z,1756208715.285 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T11:45:15.285Z,1756208715.285 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T11:45:15.285Z,1756208715.285 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T11:45:15.286Z,1756208715.286 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T11:45:15.286Z,1756208715.286 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T11:45:15.286Z,1756208715.286 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T11:45:15.286Z,1756208715.286 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T11:45:15.286Z,1756208715.286 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T11:45:15.286Z,1756208715.286 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T11:45:15.288Z,1756208715.288 [keepstation:NeedComms] Running Loop=1
2025-08-26T11:45:15.288Z,1756208715.288 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T11:45:15.288Z,1756208715.288 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T11:45:15.288Z,1756208715.288 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T11:45:15.289Z,1756208715.289 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T11:45:15.289Z,1756208715.289 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T11:45:15.289Z,1756208715.289 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T11:45:15.290Z,1756208715.290 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T11:45:15.290Z,1756208715.290 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T11:45:15.290Z,1756208715.290 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T11:45:15.290Z,1756208715.290 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T11:45:15.292Z,1756208715.292 [keepstation:NeedComms:A](INFO): last time_fix was:  1756205114.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T11:45:15.292Z,1756208715.292 [keepstation:NeedComms:A] Stopped
2025-08-26T11:48:56.551Z,1756208936.551 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T11:48:57.012Z,1756208937.012 [Radio_Surface](INFO): Powering up
2025-08-26T11:49:02.828Z,1756208942.828 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T11:49:22.962Z,1756208962.962 [NAL9602](INFO): SBD MO Status=1, MOMSN=22706, MT Status=0, MTMSN=0
2025-08-26T11:49:22.962Z,1756208962.962 [NAL9602](INFO): No messages in MT queue
2025-08-26T11:49:24.179Z,1756208964.179 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,114924.00,A,3655.73941,N,12245.99332,W,1.905,94.82,260825,,,A*49
2025-08-26T11:49:24.181Z,1756208964.181 [NAL9602](INFO): GPS fix at 20250826T114924: (36.928990, -122.766555)
2025-08-26T11:49:24.194Z,1756208964.194 [keepstation:NeedComms:C] Stopped
2025-08-26T11:49:24.194Z,1756208964.194 [keepstation:NeedComms:D] Running Loop=1
2025-08-26T11:49:40.525Z,1756208980.525 [NAL9602](INFO): SBD MO Status=2, MOMSN=22707, MT Status=2, MTMSN=0
2025-08-26T11:49:40.526Z,1756208980.526 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T11:50:23.625Z,1756209023.625 [NAL9602](INFO): SBD MO Status=2, MOMSN=22707, MT Status=2, MTMSN=0
2025-08-26T11:50:23.625Z,1756209023.625 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T11:50:37.142Z,1756209037.142 [NAL9602](INFO): SBD MO Status=2, MOMSN=22707, MT Status=2, MTMSN=0
2025-08-26T11:50:37.142Z,1756209037.142 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T11:51:15.780Z,1756209075.780 [NAL9602](INFO): SBD MO Status=2, MOMSN=22707, MT Status=2, MTMSN=0
2025-08-26T11:51:15.780Z,1756209075.780 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T11:51:51.112Z,1756209111.112 [NAL9602](INFO): SBD MO Status=2, MOMSN=22707, MT Status=2, MTMSN=0
2025-08-26T11:51:51.112Z,1756209111.112 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-08-26T11:52:09.173Z,1756209129.173 [NAL9602](INFO): SBD MO Status=1, MOMSN=22707, MT Status=0, MTMSN=0
2025-08-26T11:52:09.228Z,1756209129.228 [NAL9602](INFO): Sent 90 bytes from file Logs/20250826T031252/Courier0027.lzma
2025-08-26T11:52:09.228Z,1756209129.228 [NAL9602](INFO): Packets left to send: 0
2025-08-26T11:52:17.045Z,1756209137.045 [NAL9602](INFO): SBD MO Status=1, MOMSN=22708, MT Status=0, MTMSN=0
2025-08-26T11:52:17.096Z,1756209137.096 [NAL9602](INFO): Sent 90 bytes from file Logs/20250826T031252/Courier0030.lzma
2025-08-26T11:52:17.096Z,1756209137.096 [NAL9602](INFO): Packets left to send: 0
2025-08-26T11:52:29.029Z,1756209149.029 [NAL9602](INFO): SBD MO Status=1, MOMSN=22709, MT Status=0, MTMSN=0
2025-08-26T11:52:29.085Z,1756209149.085 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0028.lzma
2025-08-26T11:52:29.086Z,1756209149.086 [NAL9602](INFO): Packets left to send: 1
2025-08-26T11:52:40.237Z,1756209160.237 [NAL9602](INFO): SBD MO Status=1, MOMSN=22710, MT Status=0, MTMSN=0
2025-08-26T11:52:40.296Z,1756209160.296 [NAL9602](INFO): Sent 213 bytes from file Logs/20250826T031252/Express0028.lzma
2025-08-26T11:52:40.296Z,1756209160.296 [NAL9602](INFO): Packets left to send: 0
2025-08-26T11:52:48.925Z,1756209168.925 [NAL9602](INFO): SBD MO Status=1, MOMSN=22711, MT Status=0, MTMSN=0
2025-08-26T11:52:48.984Z,1756209168.984 [NAL9602](INFO): Sent 332 bytes from file Logs/20250826T031252/Express0031.lzma
2025-08-26T11:52:48.984Z,1756209168.984 [NAL9602](INFO): Packets left to send: 1
2025-08-26T11:52:57.259Z,1756209177.259 [NAL9602](INFO): SBD MO Status=1, MOMSN=22712, MT Status=0, MTMSN=0
2025-08-26T11:52:57.320Z,1756209177.320 [NAL9602](INFO): Sent 215 bytes from file Logs/20250826T031252/Express0031.lzma
2025-08-26T11:52:57.320Z,1756209177.320 [NAL9602](INFO): Packets left to send: 0
2025-08-26T11:53:05.380Z,1756209185.380 [NAL9602](INFO): SBD MO Status=0, MOMSN=22713, MT Status=0, MTMSN=0
2025-08-26T11:53:05.457Z,1756209185.457 [keepstation:NeedComms:D] Stopped
2025-08-26T11:53:05.457Z,1756209185.457 [keepstation:NeedComms:E] Running Loop=1
2025-08-26T11:53:07.793Z,1756209187.793 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,115307.00,A,3655.75338,N,12245.98019,W,0.272,19.90,260825,,,D*43
2025-08-26T11:53:07.796Z,1756209187.796 [NAL9602](INFO): GPS fix at 20250826T115307: (36.929223, -122.766336)
2025-08-26T11:53:07.808Z,1756209187.808 [keepstation:NeedComms:E] Stopped
2025-08-26T11:53:07.809Z,1756209187.809 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms
2025-08-26T11:53:07.809Z,1756209187.809 [keepstation:NeedComms] Stopped
2025-08-26T11:53:07.809Z,1756209187.809 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms
2025-08-26T11:53:07.809Z,1756209187.809 [keepstation:NeedComms:B.GoToSurface] Stopped
2025-08-26T11:53:07.809Z,1756209187.809 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-26T11:53:08.232Z,1756209188.232 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B
2025-08-26T11:53:08.232Z,1756209188.232 [keepstation:SurfaceComms:B] Stopped
2025-08-26T11:53:08.232Z,1756209188.232 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B
2025-08-26T11:53:08.233Z,1756209188.233 [keepstation:SurfaceComms:setTransit] Running Loop=1
2025-08-26T11:53:08.233Z,1756209188.233 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit
2025-08-26T11:53:08.233Z,1756209188.233 [keepstation:SurfaceComms:setTransit:A] Running Loop=1
2025-08-26T11:53:08.621Z,1756209188.621 [keepstation:SurfaceComms:setTransit] Stopped
2025-08-26T11:53:08.621Z,1756209188.621 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit
2025-08-26T11:53:08.621Z,1756209188.621 [keepstation:SurfaceComms:setTransit:A] Stopped
2025-08-26T11:53:08.621Z,1756209188.621 [keepstation:SurfaceComms:setStation] Running Loop=1
2025-08-26T11:53:08.621Z,1756209188.621 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation
2025-08-26T11:53:08.622Z,1756209188.622 [keepstation:SurfaceComms:setStation:A] Running Loop=1
2025-08-26T11:53:09.040Z,1756209189.040 [keepstation:SurfaceComms:setStation] Stopped
2025-08-26T11:53:09.040Z,1756209189.040 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation
2025-08-26T11:53:09.040Z,1756209189.040 [keepstation:SurfaceComms:setStation:A] Stopped
2025-08-26T11:53:09.040Z,1756209189.040 [keepstation:SurfaceComms:setSink] Running Loop=1
2025-08-26T11:53:09.040Z,1756209189.040 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink
2025-08-26T11:53:09.041Z,1756209189.041 [keepstation:SurfaceComms:setSink:A] Running Loop=1
2025-08-26T11:53:09.422Z,1756209189.422 [keepstation:SurfaceComms:setSink:A] Stopped
2025-08-26T11:53:09.422Z,1756209189.422 [keepstation:SurfaceComms:setSink](INFO): Completed keepstation:SurfaceComms:setSink
2025-08-26T11:53:09.422Z,1756209189.422 [keepstation:SurfaceComms:setSink] Stopped
2025-08-26T11:53:09.423Z,1756209189.423 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink
2025-08-26T11:53:09.423Z,1756209189.423 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms
2025-08-26T11:53:09.423Z,1756209189.423 [keepstation:SurfaceComms] Stopped
2025-08-26T11:53:09.423Z,1756209189.423 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms
2025-08-26T11:53:09.824Z,1756209189.824 [keepstation:KeepStation:Dive] Running Loop=1
2025-08-26T11:53:09.824Z,1756209189.824 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive
2025-08-26T11:53:09.824Z,1756209189.824 [keepstation:KeepStation:Dive:A] Running Loop=1
2025-08-26T11:53:09.824Z,1756209189.824 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink] Running Loop=1
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize.
2025-08-26T11:53:09.825Z,1756209189.825 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1
2025-08-26T11:53:09.826Z,1756209189.826 [keepstation:DiveCmd:SurfaceSink:sink:C](INFO): Sinking to  10.000000 m 
2025-08-26T11:53:09.826Z,1756209189.826 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped
2025-08-26T11:53:09.826Z,1756209189.826 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Running Loop=1
2025-08-26T11:53:09.826Z,1756209189.826 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Initialize.
2025-08-26T11:53:39.711Z,1756209219.711 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-26T11:55:19.284Z,1756209319.284 [Radio_Surface](INFO): Powering down
2025-08-26T11:55:47.500Z,1756209347.500 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-08-26T11:56:10.016Z,1756209370.016 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](INFO): Timed out from 2025-08-26T11:53:09.8Z
2025-08-26T11:56:10.016Z,1756209370.016 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout] Running Loop=1
2025-08-26T11:56:10.016Z,1756209370.016 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T11:56:10.016Z,1756209370.016 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Running Loop=1
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A](IMPORTANT): Timed out while trying to reach target sink depth at current depth of  9.208111 m 
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout:A] Stopped
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:D.Pitch:A_Timeout
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch] Stopped
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Running Loop=1
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T11:56:10.017Z,1756209370.017 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Running Loop=1
2025-08-26T11:56:10.415Z,1756209370.415 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit] Stopped
2025-08-26T11:56:10.415Z,1756209370.415 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit
2025-08-26T11:56:10.415Z,1756209370.415 [keepstation:DiveCmd:SurfaceSink:sink:sinkToTransit:A] Stopped
2025-08-26T11:56:10.415Z,1756209370.415 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Running Loop=1
2025-08-26T11:56:10.415Z,1756209370.415 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T11:56:10.415Z,1756209370.415 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Running Loop=1
2025-08-26T11:56:10.820Z,1756209370.820 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation:A] Stopped
2025-08-26T11:56:10.820Z,1756209370.820 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation] Stopped
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink:sinkToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink:sinkToStation
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink](INFO): Completed keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink] Stopped
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped
2025-08-26T11:56:10.821Z,1756209370.821 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-08-26T11:56:10.822Z,1756209370.822 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped
2025-08-26T11:56:10.822Z,1756209370.822 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize.
2025-08-26T11:56:10.822Z,1756209370.822 [keepstation:DiveCmd:SurfaceSink](INFO): Completed keepstation:DiveCmd:SurfaceSink
2025-08-26T11:56:11.218Z,1756209371.218 [keepstation:DiveCmd:StationKeep] Running Loop=1
2025-08-26T11:56:11.218Z,1756209371.218 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep
2025-08-26T11:56:11.218Z,1756209371.218 [keepstation:DiveCmd:StationKeep:A] Running Loop=1
2025-08-26T11:56:11.219Z,1756209371.219 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1
2025-08-26T11:56:11.219Z,1756209371.219 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize.
2025-08-26T11:56:11.219Z,1756209371.219 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1
2025-08-26T11:56:11.219Z,1756209371.219 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent.
2025-08-26T12:04:51.985Z,1756209891.985 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T12:04:51.986Z,1756209891.986 [BPC1](ERROR): Battery stick #3 (s/n: 0162) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-08-26T12:04:51.987Z,1756209891.987 [BPC1](INFO): Calculating totals. Valid battery stick count: 52. Valid reserve battery stick count: 6.
2025-08-26T12:04:51.990Z,1756209891.990 [BPC1](INFO): Received data from all battery sticks.
2025-08-26T12:53:07.864Z,1756212787.864 [keepstation:SurfaceComms] Running Loop=1
2025-08-26T12:53:07.864Z,1756212787.864 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms
2025-08-26T12:53:07.865Z,1756212787.865 [keepstation:SurfaceComms:A] Running Loop=1
2025-08-26T12:53:07.865Z,1756212787.865 [keepstation:SurfaceComms:A] Stopped
2025-08-26T12:53:07.865Z,1756212787.865 [keepstation:SurfaceComms:B] Running Loop=1
2025-08-26T12:53:07.865Z,1756212787.865 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:KeepStation:Dive] Stopped
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:KeepStation:Dive:A] Stopped
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:DiveCmd:StationKeep] Stopped
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep
2025-08-26T12:53:08.268Z,1756212788.268 [keepstation:DiveCmd:StationKeep:A] Stopped
2025-08-26T12:53:08.269Z,1756212788.269 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped
2025-08-26T12:53:08.269Z,1756212788.269 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped
2025-08-26T12:53:08.269Z,1756212788.269 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent.
2025-08-26T12:53:08.270Z,1756212788.270 [keepstation:NeedComms] Running Loop=1
2025-08-26T12:53:08.270Z,1756212788.270 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms
2025-08-26T12:53:08.270Z,1756212788.270 [keepstation:NeedComms:B.GoToSurface] Running Loop=1
2025-08-26T12:53:08.270Z,1756212788.270 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-26T12:53:08.271Z,1756212788.271 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-26T12:53:08.272Z,1756212788.272 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-26T12:53:08.272Z,1756212788.272 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-26T12:53:08.272Z,1756212788.272 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-26T12:53:08.273Z,1756212788.273 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-26T12:53:08.273Z,1756212788.273 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-26T12:53:08.273Z,1756212788.273 [keepstation:NeedComms:A] Running Loop=1
2025-08-26T12:53:08.275Z,1756212788.275 [keepstation:NeedComms:A](INFO): last time_fix was:  1756209187.000000 second since 1970/01/01T00:00:00Z 
2025-08-26T12:53:08.275Z,1756212788.275 [keepstation:NeedComms:A] Stopped
2025-08-26T12:56:41.676Z,1756213001.676 [keepstation:NeedComms:C] Running Loop=1
2025-08-26T12:56:42.248Z,1756213002.248 [Radio_Surface](INFO): Powering up
2025-08-26T12:56:47.632Z,1756213007.632 [DataOverHttps](INFO): Radio surface powered ON.
2025-08-26T12:58:57.002Z,1756213137.002 [NAL9602](INFO): SBD MO Status=2, MOMSN=22714, MT Status=2, MTMSN=0
2025-08-26T12:58:57.002Z,1756213137.002 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2