2026-03-11T21:37:39.470Z,1773265059.470 [keepstation:NeedComms:setActive:B] Stopped 2026-03-11T21:37:39.471Z,1773265059.471 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-03-11T21:37:39.471Z,1773265059.471 [keepstation:NeedComms:setActive] Stopped 2026-03-11T21:37:39.471Z,1773265059.471 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-03-11T21:37:39.490Z,1773265059.490 [CommandExec](IMPORTANT): got command restart logs 2026-03-11T21:37:39.888Z,1773265059.888 [keepstation:NeedComms:D] Running Loop=1 2026-03-11T21:37:40.292Z,1773265060.292 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-11T21:37:41.888Z,1773265061.888 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213741.00,A,3647.49142,N,12151.91916,W,1.127,148.20,110326,,,D*7A 2026-03-11T21:37:41.890Z,1773265061.890 [NAL9602](INFO): GPS fix at 20260311T213741: (36.791524, -121.865319) 2026-03-11T21:37:41.919Z,1773265061.919 [keepstation:NeedComms:D] Stopped 2026-03-11T21:37:41.920Z,1773265061.920 [keepstation:NeedComms:E] Running Loop=1 2026-03-11T21:37:42.332Z,1773265062.332 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-03-11T21:37:55.096Z,1773265075.096 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260311T201213/Courier0024.lzma 2026-03-11T21:37:57.103Z,1773265077.103 [DataOverHttps](INFO): Moved sent file to Logs/20260311T201213/Courier0024.lzma.bak 2026-03-11T21:37:57.103Z,1773265077.103 [DataOverHttps](INFO): SBD MOMSN=26716663 2026-03-11T21:38:04.504Z,1773265084.504 [NAL9602](INFO): SBD MO Status=2, MOMSN=32354, MT Status=2, MTMSN=0 2026-03-11T21:38:04.504Z,1773265084.504 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-03-11T21:38:13.241Z,1773265093.241 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20260311T201213/Express0025.lzma 2026-03-11T21:38:14.243Z,1773265094.243 [DataOverHttps](INFO): Moved sent file to Logs/20260311T201213/Express0025.lzma.bak 2026-03-11T21:38:14.243Z,1773265094.243 [DataOverHttps](INFO): SBD MOMSN=26716665 2026-03-11T21:38:15.438Z,1773265095.438 [keepstation:NeedComms:E] Stopped 2026-03-11T21:38:15.439Z,1773265095.439 [keepstation:NeedComms:F] Running Loop=1 2026-03-11T21:38:15.835Z,1773265095.835 [keepstation:NeedComms:F](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-03-11T21:38:29.148Z,1773265109.148 [NAL9602](INFO): SBD MO Status=0, MOMSN=32354, MT Status=0, MTMSN=0 2026-03-11T21:38:29.148Z,1773265109.148 [NAL9602](INFO): No messages in MT queue 2026-03-11T21:38:30.364Z,1773265110.364 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213829.00,A,3647.48575,N,12151.91267,W,0.292,134.26,110326,,,D*76 2026-03-11T21:38:30.366Z,1773265110.366 [NAL9602](INFO): GPS fix at 20260311T213829: (36.791429, -121.865211) 2026-03-11T21:38:30.379Z,1773265110.379 [keepstation:NeedComms:F] Stopped 2026-03-11T21:38:30.379Z,1773265110.379 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-03-11T21:38:30.379Z,1773265110.379 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-03-11T21:38:30.379Z,1773265110.379 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-03-11T21:38:30.796Z,1773265110.796 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-03-11T21:38:30.796Z,1773265110.796 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-03-11T21:38:30.796Z,1773265110.796 [keepstation:NeedComms:setRestoreMode] Stopped 2026-03-11T21:38:30.796Z,1773265110.796 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-03-11T21:38:30.797Z,1773265110.797 [keepstation:NeedComms:setInactive] Running Loop=1 2026-03-11T21:38:30.797Z,1773265110.797 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-03-11T21:38:30.797Z,1773265110.797 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-03-11T21:38:31.188Z,1773265111.188 [keepstation:NeedComms:setInactive:A] Stopped 2026-03-11T21:38:31.188Z,1773265111.188 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-03-11T21:38:31.188Z,1773265111.188 [keepstation:NeedComms:setInactive] Stopped 2026-03-11T21:38:31.188Z,1773265111.188 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-03-11T21:38:31.189Z,1773265111.189 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-03-11T21:38:31.189Z,1773265111.189 [keepstation:NeedComms] Stopped 2026-03-11T21:38:31.189Z,1773265111.189 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-03-11T21:38:31.189Z,1773265111.189 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-03-11T21:38:31.189Z,1773265111.189 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:B] Stopped 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-03-11T21:38:31.600Z,1773265111.600 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-03-11T21:38:31.601Z,1773265111.601 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-03-11T21:38:31.999Z,1773265111.999 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-03-11T21:38:31.999Z,1773265111.999 [keepstation:SurfaceComms:HandleNan:SetOnStation](INFO): Completed keepstation:SurfaceComms:HandleNan:SetOnStation 2026-03-11T21:38:31.999Z,1773265111.999 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-03-11T21:38:31.999Z,1773265111.999 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-03-11T21:38:31.000Z,1773265112.000 [keepstation:SurfaceComms:HandleNan:SetLat] Running Loop=1 2026-03-11T21:38:31.000Z,1773265112.000 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLat 2026-03-11T21:38:31.000Z,1773265112.000 [keepstation:SurfaceComms:HandleNan:SetLat:A] Running Loop=1 2026-03-11T21:38:32.390Z,1773265112.390 [keepstation:SurfaceComms:HandleNan:SetLat:A] Stopped 2026-03-11T21:38:32.390Z,1773265112.390 [keepstation:SurfaceComms:HandleNan:SetLat](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLat 2026-03-11T21:38:32.390Z,1773265112.390 [keepstation:SurfaceComms:HandleNan:SetLat] Stopped 2026-03-11T21:38:32.390Z,1773265112.390 [keepstation:SurfaceComms:HandleNan:SetLat](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLat 2026-03-11T21:38:32.390Z,1773265112.390 [keepstation:SurfaceComms:HandleNan:SetLon] Running Loop=1 2026-03-11T21:38:32.391Z,1773265112.391 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetLon 2026-03-11T21:38:32.391Z,1773265112.391 [keepstation:SurfaceComms:HandleNan:SetLon:A] Running Loop=1 2026-03-11T21:38:32.802Z,1773265112.802 [keepstation:SurfaceComms:HandleNan:SetLon:A] Stopped 2026-03-11T21:38:32.802Z,1773265112.802 [keepstation:SurfaceComms:HandleNan:SetLon](INFO): Completed keepstation:SurfaceComms:HandleNan:SetLon 2026-03-11T21:38:32.802Z,1773265112.802 [keepstation:SurfaceComms:HandleNan:SetLon] Stopped 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:HandleNan:SetLon](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetLon 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:HandleNan](INFO): Completed keepstation:SurfaceComms:HandleNan 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:HandleNan] Stopped 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-03-11T21:38:32.803Z,1773265112.803 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-03-11T21:38:33.200Z,1773265113.200 [keepstation:SurfaceComms:setTransit] Stopped 2026-03-11T21:38:33.217Z,1773265113.217 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-03-11T21:38:33.217Z,1773265113.217 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-03-11T21:38:33.217Z,1773265113.217 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-03-11T21:38:33.217Z,1773265113.217 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-03-11T21:38:33.217Z,1773265113.217 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-03-11T21:38:33.600Z,1773265113.600 [keepstation:SurfaceComms:setStation:A] Stopped 2026-03-11T21:38:33.601Z,1773265113.601 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-03-11T21:38:33.601Z,1773265113.601 [keepstation:SurfaceComms:setStation] Stopped 2026-03-11T21:38:33.601Z,1773265113.601 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-03-11T21:38:33.601Z,1773265113.601 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-03-11T21:38:33.601Z,1773265113.601 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-03-11T21:38:33.601Z,1773265113.601 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-03-11T21:38:34.006Z,1773265114.006 [keepstation:SurfaceComms:setSink] Stopped 2026-03-11T21:38:34.007Z,1773265114.007 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-03-11T21:38:34.007Z,1773265114.007 [keepstation:SurfaceComms:setSink:A] Stopped 2026-03-11T21:38:34.007Z,1773265114.007 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-03-11T21:38:34.007Z,1773265114.007 [keepstation:SurfaceComms] Stopped 2026-03-11T21:38:34.007Z,1773265114.007 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-03-11T21:38:34.421Z,1773265114.421 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2026-03-11T21:38:34.421Z,1773265114.421 [keepstation:StartingMission] Stopped 2026-03-11T21:38:34.421Z,1773265114.421 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2026-03-11T21:38:34.421Z,1773265114.421 [keepstation:TransitToStation] Running Loop=1 2026-03-11T21:38:34.421Z,1773265114.421 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2026-03-11T21:38:34.421Z,1773265114.421 [keepstation:TransitToStation:Dive] Running Loop=1 2026-03-11T21:38:34.422Z,1773265114.422 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive 2026-03-11T21:38:34.422Z,1773265114.422 [keepstation:TransitToStation:Dive:A] Running Loop=1 2026-03-11T21:38:34.422Z,1773265114.422 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A 2026-03-11T21:38:34.422Z,1773265114.422 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2026-03-11T21:38:34.422Z,1773265114.422 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2026-03-11T21:38:34.423Z,1773265114.423 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.791429,-121.865211 2026-03-11T21:38:34.814Z,1773265114.814 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.791429,-121.865211 2026-03-11T21:38:34.815Z,1773265114.815 [keepstation:TransitToStation:Dive] Running Loop=1 2026-03-11T21:38:34.815Z,1773265114.815 [keepstation:DiveCmd] Running Loop=1 2026-03-11T21:38:34.815Z,1773265114.815 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd 2026-03-11T21:38:34.815Z,1773265114.815 [keepstation:DiveCmd:SurfaceSink] Running Loop=1 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize. 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:TransitToStation] Running Loop=1 2026-03-11T21:38:34.816Z,1773265114.816 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize. 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1 2026-03-11T21:38:34.817Z,1773265114.817 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize. 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-03-11T21:38:34.818Z,1773265114.818 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-03-11T21:38:34.819Z,1773265114.819 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-03-11T21:38:34.819Z,1773265114.819 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-03-11T21:38:34.819Z,1773265114.819 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-03-11T21:38:34.820Z,1773265114.820 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-03-11T21:38:34.820Z,1773265114.820 [keepstation:DiveCmd:TransitToStation] Stopped 2026-03-11T21:38:34.820Z,1773265114.820 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation 2026-03-11T21:38:34.820Z,1773265114.820 [keepstation:DiveCmd:TransitToStation:dive] Stopped 2026-03-11T21:38:34.820Z,1773265114.820 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize. 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:SurfaceSink] Stopped 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:SurfaceSink:sink] Stopped 2026-03-11T21:38:34.837Z,1773265114.837 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink 2026-03-11T21:38:34.838Z,1773265114.838 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped 2026-03-11T21:38:34.838Z,1773265114.838 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2026-03-11T21:38:34.838Z,1773265114.838 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped 2026-03-11T21:38:34.838Z,1773265114.838 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize. 2026-03-11T21:38:34.838Z,1773265114.838 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped 2026-03-11T21:39:02.446Z,1773265142.446 [NAL9602](INFO): Not Powering down - fast GPS 2026-03-11T21:40:42.450Z,1773265242.450 [DAT](INFO): DAT read: Rx Time:21:40:41.3501 2026-03-11T21:40:42.450Z,1773265242.450 [DAT](INFO): Rx dataTimestamp_ set to:1773265242.450026 2026-03-11T21:40:42.451Z,1773265242.451 [DAT](INFO): DAT read: 2026-03-11T21:40:42.451Z,1773265242.451 [DAT](INFO): DAT read: $Packet for address 0 2026-03-11T21:40:42.451Z,1773265242.451 [DAT](INFO): received a packet notification 2026-03-11T21:41:46.994Z,1773265306.994 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-03-11T21:41:51.463Z,1773265311.463 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000136 CHAN A1 (24V): 0.000495 CHAN A2 (12V): 0.000410 CHAN A3 (5V): -0.001622 CHAN B0 (3.3V): 0.000025 CHAN B1 (3.15aV): 0.000130 CHAN B2 (3.15bV): -0.000255 CHAN B3 (GND): 0.000037 OPEN: 0.006834 Full Scale: +/- 1 mA 2026-03-11T21:43:20.945Z,1773265400.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:43:52.069Z,1773265432.069 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:44:18.997Z,1773265458.997 [Radio_Surface](INFO): Powering down 2026-03-11T21:44:23.193Z,1773265463.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:44:24.197Z,1773265464.197 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-03-11T21:45:28.453Z,1773265528.453 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.727386 2026-03-11T21:48:30.580Z,1773265710.580 [keepstation:SurfaceComms] Running Loop=1 2026-03-11T21:48:30.580Z,1773265710.580 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-03-11T21:48:30.581Z,1773265710.581 [keepstation:SurfaceComms:A] Running Loop=1 2026-03-11T21:48:30.581Z,1773265710.581 [keepstation:SurfaceComms:A] Stopped 2026-03-11T21:48:30.581Z,1773265710.581 [keepstation:SurfaceComms:B] Running Loop=1 2026-03-11T21:48:30.581Z,1773265710.581 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-03-11T21:48:30.583Z,1773265710.583 [keepstation:NeedComms] Running Loop=1 2026-03-11T21:48:30.583Z,1773265710.583 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-03-11T21:48:30.583Z,1773265710.583 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-03-11T21:48:30.583Z,1773265710.583 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-11T21:48:30.584Z,1773265710.584 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-03-11T21:48:30.584Z,1773265710.584 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-03-11T21:48:30.584Z,1773265710.584 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-03-11T21:48:30.585Z,1773265710.585 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-03-11T21:48:30.585Z,1773265710.585 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-11T21:48:30.586Z,1773265710.586 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-11T21:48:30.586Z,1773265710.586 [keepstation:NeedComms:A] Running Loop=1 2026-03-11T21:48:30.587Z,1773265710.587 [keepstation:NeedComms:A](INFO): last time_fix was: 1773265109.000000 second since 1970/01/01T00:00:00Z 2026-03-11T21:48:30.587Z,1773265710.587 [keepstation:NeedComms:A] Stopped 2026-03-11T21:48:30.588Z,1773265710.588 [keepstation:NeedComms:setActive] Running Loop=1 2026-03-11T21:48:30.588Z,1773265710.588 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-03-11T21:48:30.588Z,1773265710.588 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-03-11T21:48:30.991Z,1773265710.991 [keepstation:TransitToStation:Dive] Stopped 2026-03-11T21:48:30.991Z,1773265710.991 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive 2026-03-11T21:48:30.991Z,1773265710.991 [keepstation:TransitToStation:Dive:A] Stopped 2026-03-11T21:48:30.991Z,1773265710.991 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A 2026-03-11T21:48:30.992Z,1773265710.992 [keepstation:DiveCmd:StationKeep] Stopped 2026-03-11T21:48:30.992Z,1773265710.992 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-03-11T21:48:30.992Z,1773265710.992 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-03-11T21:48:30.992Z,1773265710.992 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-03-11T21:48:30.992Z,1773265710.992 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-03-11T21:48:30.992Z,1773265710.992 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-03-11T21:48:30.995Z,1773265710.995 [keepstation:NeedComms:setActive:A] Stopped 2026-03-11T21:48:30.995Z,1773265710.995 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-03-11T21:48:31.403Z,1773265711.403 [keepstation:NeedComms:setActive:B] Stopped 2026-03-11T21:48:31.403Z,1773265711.403 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-03-11T21:48:31.403Z,1773265711.403 [keepstation:NeedComms:setActive] Stopped 2026-03-11T21:48:31.404Z,1773265711.404 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-03-11T21:49:43.284Z,1773265783.284 [keepstation:NeedComms:D] Running Loop=1 2026-03-11T21:49:43.846Z,1773265783.846 [Radio_Surface](INFO): Powering up 2026-03-11T21:49:49.565Z,1773265789.565 [DataOverHttps](INFO): Radio surface powered ON. 2026-03-11T21:49:58.425Z,1773265798.425 [NAL9602](INFO): SBD MO Status=0, MOMSN=32355, MT Status=0, MTMSN=0 2026-03-11T21:49:58.425Z,1773265798.425 [NAL9602](INFO): No messages in MT queue 2026-03-11T21:49:59.622Z,1773265799.622 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214958.00,A,3647.45779,N,12151.87433,W,0.136,89.93,110326,,,D*41 2026-03-11T21:49:59.624Z,1773265799.624 [NAL9602](INFO): GPS fix at 20260311T214958: (36.790963, -121.864572) 2026-03-11T21:49:59.636Z,1773265799.636 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.791429,-121.865211 2026-03-11T21:49:59.637Z,1773265799.637 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2026-03-11T21:49:59.637Z,1773265799.637 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2026-03-11T21:49:59.637Z,1773265799.637 [keepstation:TransitToStation:C] Running Loop=1 2026-03-11T21:49:59.639Z,1773265799.639 [keepstation:NeedComms:D] Stopped 2026-03-11T21:49:59.639Z,1773265799.639 [keepstation:NeedComms:E] Running Loop=1 2026-03-11T21:50:00.058Z,1773265800.058 [keepstation:TransitToStation:C] Stopped 2026-03-11T21:50:00.058Z,1773265800.058 [keepstation:TransitToStation:D] Running Loop=1 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-03-11T21:50:00.059Z,1773265800.059 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-03-11T21:50:00.503Z,1773265800.503 [keepstation:TransitToStation:D] Stopped 2026-03-11T21:50:00.503Z,1773265800.503 [keepstation:TransitToStation:Dive] Running Loop=1 2026-03-11T21:50:00.503Z,1773265800.503 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation:Dive:A] Running Loop=1 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation] Stopped 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation:Dive] Stopped 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation:Dive:A] Stopped 2026-03-11T21:50:00.504Z,1773265800.504 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A 2026-03-11T21:50:00.505Z,1773265800.505 [keepstation:OnStation] Running Loop=1 2026-03-11T21:50:00.505Z,1773265800.505 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation 2026-03-11T21:50:19.694Z,1773265819.694 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:50:19.939Z,1773265819.939 [NAL9602](INFO): SBD MO Status=1, MOMSN=32356, MT Status=0, MTMSN=0 2026-03-11T21:50:19.997Z,1773265819.997 [NAL9602](INFO): Sent 269 bytes from file Logs/20260311T213739/Courier0003.lzma 2026-03-11T21:50:19.997Z,1773265819.997 [NAL9602](INFO): Packets left to send: 0 2026-03-11T21:50:48.299Z,1773265848.299 [NAL9602](INFO): SBD MO Status=1, MOMSN=32357, MT Status=0, MTMSN=0 2026-03-11T21:50:48.349Z,1773265848.349 [NAL9602](INFO): Sent 332 bytes from file Logs/20260311T213739/Express0005.lzma 2026-03-11T21:50:48.349Z,1773265848.349 [NAL9602](INFO): Packets left to send: 2 2026-03-11T21:50:50.817Z,1773265850.817 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:51:06.634Z,1773265866.634 [NAL9602](INFO): SBD MO Status=1, MOMSN=32358, MT Status=0, MTMSN=0 2026-03-11T21:51:06.681Z,1773265866.681 [NAL9602](INFO): Sent 332 bytes from file Logs/20260311T213739/Express0005.lzma 2026-03-11T21:51:06.681Z,1773265866.681 [NAL9602](INFO): Packets left to send: 1 2026-03-11T21:51:21.941Z,1773265881.941 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:51:24.871Z,1773265884.871 [NAL9602](INFO): SBD MO Status=2, MOMSN=32359, MT Status=2, MTMSN=0 2026-03-11T21:51:24.871Z,1773265884.871 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-03-11T21:51:41.111Z,1773265901.111 [NAL9602](INFO): SBD MO Status=1, MOMSN=32359, MT Status=0, MTMSN=0 2026-03-11T21:51:41.161Z,1773265901.161 [NAL9602](INFO): Sent 183 bytes from file Logs/20260311T213739/Express0005.lzma 2026-03-11T21:51:41.161Z,1773265901.161 [NAL9602](INFO): Packets left to send: 0 2026-03-11T21:51:53.065Z,1773265913.065 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:52:05.351Z,1773265925.351 [NAL9602](INFO): SBD MO Status=0, MOMSN=32360, MT Status=0, MTMSN=0 2026-03-11T21:52:05.436Z,1773265925.436 [keepstation:NeedComms:E] Stopped 2026-03-11T21:52:05.437Z,1773265925.437 [keepstation:NeedComms:F] Running Loop=1 2026-03-11T21:52:07.778Z,1773265927.778 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215207.00,A,3647.44579,N,12151.85952,W,0.836,138.18,110326,,,D*7B 2026-03-11T21:52:07.780Z,1773265927.780 [NAL9602](INFO): GPS fix at 20260311T215207: (36.790763, -121.864325) 2026-03-11T21:52:07.794Z,1773265927.794 [keepstation:NeedComms:F] Stopped 2026-03-11T21:52:07.795Z,1773265927.795 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-03-11T21:52:07.795Z,1773265927.795 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-03-11T21:52:07.795Z,1773265927.795 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-03-11T21:52:08.224Z,1773265928.224 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-03-11T21:52:08.224Z,1773265928.224 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-03-11T21:52:08.224Z,1773265928.224 [keepstation:NeedComms:setRestoreMode] Stopped 2026-03-11T21:52:08.224Z,1773265928.224 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-03-11T21:52:08.224Z,1773265928.224 [keepstation:NeedComms:setInactive] Running Loop=1 2026-03-11T21:52:08.225Z,1773265928.225 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-03-11T21:52:08.225Z,1773265928.225 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-03-11T21:52:08.596Z,1773265928.596 [keepstation:NeedComms:setInactive:A] Stopped 2026-03-11T21:52:08.596Z,1773265928.596 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-03-11T21:52:08.596Z,1773265928.596 [keepstation:NeedComms:setInactive] Stopped 2026-03-11T21:52:08.596Z,1773265928.596 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-03-11T21:52:08.613Z,1773265928.613 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-03-11T21:52:08.613Z,1773265928.613 [keepstation:NeedComms] Stopped 2026-03-11T21:52:08.613Z,1773265928.613 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-03-11T21:52:08.614Z,1773265928.614 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-03-11T21:52:08.614Z,1773265928.614 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-03-11T21:52:09.002Z,1773265929.002 [keepstation:OnStation](INFO): Completed keepstation:OnStation 2026-03-11T21:52:09.002Z,1773265929.002 [keepstation:OnStation] Stopped 2026-03-11T21:52:09.002Z,1773265929.002 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation 2026-03-11T21:52:09.002Z,1773265929.002 [keepstation:KeepStation] Running Loop=1 2026-03-11T21:52:09.002Z,1773265929.002 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation 2026-03-11T21:52:09.003Z,1773265929.003 [keepstation:KeepStation:Dive] Running Loop=1 2026-03-11T21:52:09.003Z,1773265929.003 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-03-11T21:52:09.003Z,1773265929.003 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-03-11T21:52:09.003Z,1773265929.003 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-03-11T21:52:09.003Z,1773265929.003 [keepstation:KeepStation:B.Wait] Running Loop=1 2026-03-11T21:52:09.003Z,1773265929.003 [keepstation:KeepStation:B.Wait](DEBUG): Initialize Wait Component. 2026-03-11T21:52:09.005Z,1773265929.005 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-03-11T21:52:09.005Z,1773265929.005 [keepstation:SurfaceComms:B] Stopped 2026-03-11T21:52:09.005Z,1773265929.005 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-03-11T21:52:09.005Z,1773265929.005 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-03-11T21:52:09.005Z,1773265929.005 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-03-11T21:52:09.006Z,1773265929.006 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-03-11T21:52:09.006Z,1773265929.006 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-03-11T21:52:09.006Z,1773265929.006 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-03-11T21:52:09.409Z,1773265929.409 [keepstation:KeepStation:Dive] Running Loop=1 2026-03-11T21:52:09.411Z,1773265929.411 [keepstation:SurfaceComms:HandleNan] Stopped 2026-03-11T21:52:09.411Z,1773265929.411 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-03-11T21:52:09.411Z,1773265929.411 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-03-11T21:52:09.411Z,1773265929.411 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-03-11T21:52:09.411Z,1773265929.411 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-03-11T21:52:09.412Z,1773265929.412 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-03-11T21:52:09.412Z,1773265929.412 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-03-11T21:52:09.412Z,1773265929.412 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-03-11T21:52:09.822Z,1773265929.822 [keepstation:SurfaceComms:setTransit] Stopped 2026-03-11T21:52:09.823Z,1773265929.823 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-03-11T21:52:09.823Z,1773265929.823 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-03-11T21:52:09.823Z,1773265929.823 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-03-11T21:52:09.823Z,1773265929.823 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-03-11T21:52:09.823Z,1773265929.823 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-03-11T21:52:10.211Z,1773265930.211 [keepstation:SurfaceComms:setStation:A] Stopped 2026-03-11T21:52:10.211Z,1773265930.211 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-03-11T21:52:10.211Z,1773265930.211 [keepstation:SurfaceComms:setStation] Stopped 2026-03-11T21:52:10.212Z,1773265930.212 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-03-11T21:52:10.212Z,1773265930.212 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-03-11T21:52:10.212Z,1773265930.212 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-03-11T21:52:10.212Z,1773265930.212 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-03-11T21:52:10.615Z,1773265930.615 [keepstation:SurfaceComms:setSink] Stopped 2026-03-11T21:52:10.615Z,1773265930.615 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-03-11T21:52:10.615Z,1773265930.615 [keepstation:SurfaceComms:setSink:A] Stopped 2026-03-11T21:52:10.615Z,1773265930.615 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-03-11T21:52:10.615Z,1773265930.615 [keepstation:SurfaceComms] Stopped 2026-03-11T21:52:10.616Z,1773265930.616 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-03-11T21:52:24.190Z,1773265944.190 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:52:28.025Z,1773265948.025 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-03-11T21:52:40.502Z,1773265960.502 [NAL9602](INFO): Not Powering down - fast GPS 2026-03-11T21:52:55.313Z,1773265975.313 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:53:26.437Z,1773266006.437 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:53:34.982Z,1773266014.982 [DataOverHttps](IMPORTANT): SBD MTMSN=20260311T215334 2026-03-11T21:53:34.985Z,1773266014.985 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003461 2026-03-11T21:53:43.436Z,1773266023.436 [DataOverHttps](INFO): Received command: stop 2026-03-11T21:53:43.518Z,1773266023.518 [CommandExec](IMPORTANT): got command stop 2026-03-11T21:53:43.518Z,1773266023.518 [CommandExec](IMPORTANT): Scheduling is paused 2026-03-11T21:53:43.518Z,1773266023.518 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-03-11T21:53:43.564Z,1773266023.564 [MissionManager](INFO): MissionManager is completed. 2026-03-11T21:53:43.569Z,1773266023.569 [MissionManager](INFO): Uninitializing Mission keepstation 2026-03-11T21:53:43.569Z,1773266023.569 [keepstation] Stopped 2026-03-11T21:53:43.569Z,1773266023.569 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2026-03-11T21:53:43.569Z,1773266023.569 [keepstation:StandardEnvelopes] Stopped 2026-03-11T21:53:43.569Z,1773266023.569 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2026-03-11T21:53:43.569Z,1773266023.569 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:BackseatDriver] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:PowerOnly] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:PowerOnly:E.Wait] Stopped 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-03-11T21:53:43.570Z,1773266023.570 [keepstation:H.Pitch] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd](DEBUG): Aggregate::uninitialize keepstation:DiveCmd 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd:StationKeep] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:KeepStation] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:KeepStation:Dive] Stopped 2026-03-11T21:53:43.571Z,1773266023.571 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-03-11T21:53:43.572Z,1773266023.572 [keepstation:KeepStation:Dive:A] Stopped 2026-03-11T21:53:43.572Z,1773266023.572 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-03-11T21:53:43.572Z,1773266023.572 [keepstation:KeepStation:B.Wait] Stopped 2026-03-11T21:53:43.572Z,1773266023.572 [keepstation:KeepStation:B.Wait](DEBUG): Uninitialize Wait Component. 2026-03-11T21:53:43.953Z,1773266023.953 [MissionManager](IMPORTANT): Started mission Default 2026-03-11T21:53:43.954Z,1773266023.954 [Default] Running Loop=1 2026-03-11T21:53:43.954Z,1773266023.954 [Default](DEBUG): Aggregate::initialize Default 2026-03-11T21:53:43.954Z,1773266023.954 [Default:B.GoToSurface] Running Loop=1 2026-03-11T21:53:43.954Z,1773266023.954 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-03-11T21:53:43.954Z,1773266023.954 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-03-11T21:53:43.954Z,1773266023.954 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-03-11T21:53:43.955Z,1773266023.955 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-03-11T21:53:43.955Z,1773266023.955 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-03-11T21:53:43.955Z,1773266023.955 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-03-11T21:53:43.956Z,1773266023.956 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-03-11T21:53:43.956Z,1773266023.956 [Default:A.Wait] Running Loop=1 2026-03-11T21:53:43.956Z,1773266023.956 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-03-11T21:53:57.336Z,1773266037.336 [Default:A.Wait](INFO): Done Waiting. 2026-03-11T21:53:57.336Z,1773266037.336 [Default:A.Wait] Stopped 2026-03-11T21:53:57.336Z,1773266037.336 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-03-11T21:53:57.705Z,1773266037.705 [Default:CheckIn] Running Loop=1 2026-03-11T21:53:57.705Z,1773266037.705 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-03-11T21:53:57.705Z,1773266037.705 [Default:CheckIn:Read_GPS] Running Loop=1 2026-03-11T21:53:59.708Z,1773266039.708 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215358.00,A,3647.43062,N,12151.85025,W,0.505,133.62,110326,,,D*7A 2026-03-11T21:53:59.711Z,1773266039.711 [NAL9602](INFO): GPS fix at 20260311T215358: (36.790510, -121.864171) 2026-03-11T21:53:59.722Z,1773266039.722 [Default:CheckIn:Read_GPS] Stopped 2026-03-11T21:53:59.722Z,1773266039.722 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-03-11T21:54:21.500Z,1773266061.500 [NAL9602](INFO): SBD MO Status=2, MOMSN=32361, MT Status=2, MTMSN=0 2026-03-11T21:54:21.500Z,1773266061.500 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-03-11T21:54:43.316Z,1773266083.316 [NAL9602](INFO): SBD MO Status=0, MOMSN=32361, MT Status=0, MTMSN=0 2026-03-11T21:54:43.316Z,1773266083.316 [NAL9602](INFO): No messages in MT queue 2026-03-11T21:54:54.245Z,1773266094.245 [BPC1](ERROR): Battery stick #2 (s/n: 00CE) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.246Z,1773266094.246 [BPC1](ERROR): Battery stick #8 (s/n: 01E7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.246Z,1773266094.246 [BPC1](ERROR): Battery stick #16 (s/n: 00F8) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.247Z,1773266094.247 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-03-11T21:54:54.248Z,1773266094.248 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.249Z,1773266094.249 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-03-11T21:54:54.249Z,1773266094.249 [BPC1](ERROR): Battery stick #30 (s/n: 015F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.250Z,1773266094.250 [BPC1](ERROR): Battery stick #37 (s/n: 0181) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.251Z,1773266094.251 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.252Z,1773266094.252 [BPC1](ERROR): Battery stick #39 (s/n: 0189) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.252Z,1773266094.252 [BPC1](ERROR): Battery stick #40 (s/n: 01A4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.253Z,1773266094.253 [BPC1](ERROR): Battery stick #44 (s/n: 01BB) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.254Z,1773266094.254 [BPC1](ERROR): Battery stick #50 (s/n: 019C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.255Z,1773266094.255 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.255Z,1773266094.255 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.256Z,1773266094.256 [BPC1](ERROR): Battery stick #53 (s/n: 01EE) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.257Z,1773266094.257 [BPC1](ERROR): Battery stick #56 (s/n: 0183) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.258Z,1773266094.258 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-03-11T21:54:54.258Z,1773266094.258 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x5AD0. 2026-03-11T21:54:54.259Z,1773266094.259 [BPC1](INFO): Calculating totals. Valid battery stick count: 29. Valid reserve battery stick count: 2. 2026-03-11T21:54:54.265Z,1773266094.265 [BPC1](FAULT): Failed to receive data from 31 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 24, 29, 30, 37, 38, 39, 40, 44, 50, 51, 52, 53, 56, 57, 59. 2026-03-11T21:55:02.377Z,1773266102.377 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:55:14.022Z,1773266114.022 [NAL9602](INFO): Not Powering down - fast GPS 2026-03-11T21:55:33.513Z,1773266133.513 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:56:04.646Z,1773266164.646 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:56:35.769Z,1773266195.769 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:56:44.807Z,1773266204.807 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.369247 2026-03-11T21:57:11.619Z,1773266231.619 [NAL9602](INFO): SBD MO Status=2, MOMSN=32362, MT Status=2, MTMSN=0 2026-03-11T21:57:11.619Z,1773266231.619 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-03-11T21:57:15.930Z,1773266235.930 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:57:29.852Z,1773266249.852 [NAL9602](INFO): SBD MO Status=2, MOMSN=32362, MT Status=2, MTMSN=0 2026-03-11T21:57:29.852Z,1773266249.852 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-03-11T21:57:47.063Z,1773266267.063 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:57:57.771Z,1773266277.771 [NAL9602](INFO): SBD MO Status=2, MOMSN=32362, MT Status=2, MTMSN=0 2026-03-11T21:57:57.771Z,1773266277.771 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-03-11T21:58:12.779Z,1773266292.779 [NAL9602](INFO): SBD MO Status=1, MOMSN=32362, MT Status=0, MTMSN=0 2026-03-11T21:58:12.845Z,1773266292.845 [NAL9602](INFO): Sent 73 bytes from file Logs/20260311T213739/Courier0009.lzma 2026-03-11T21:58:12.845Z,1773266292.845 [NAL9602](INFO): Packets left to send: 0 2026-03-11T21:58:18.185Z,1773266298.185 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:58:39.087Z,1773266319.087 [NAL9602](INFO): SBD MO Status=1, MOMSN=32363, MT Status=0, MTMSN=0 2026-03-11T21:58:39.158Z,1773266319.158 [NAL9602](INFO): Sent 305 bytes from file Logs/20260311T213739/Express0010.lzma 2026-03-11T21:58:39.158Z,1773266319.158 [NAL9602](INFO): Packets left to send: 0 2026-03-11T21:58:49.309Z,1773266329.309 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:58:52.820Z,1773266332.820 [NAL9602](INFO): SBD MO Status=0, MOMSN=32364, MT Status=0, MTMSN=0 2026-03-11T21:58:52.923Z,1773266332.923 [Default:CheckIn:Read_Iridium] Stopped 2026-03-11T21:58:52.923Z,1773266332.923 [Default:CheckIn:C.Wait] Running Loop=1 2026-03-11T21:58:52.923Z,1773266332.923 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-03-11T21:59:20.449Z,1773266360.449 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T21:59:23.520Z,1773266363.520 [NAL9602](INFO): Not Powering down - fast GPS 2026-03-11T21:59:51.573Z,1773266391.573 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T22:00:22.697Z,1773266422.697 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T22:00:53.833Z,1773266453.833 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T22:01:24.959Z,1773266484.959 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T22:01:56.089Z,1773266516.089 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-03-11T22:02:04.502Z,1773266524.502 [DataOverHttps](IMPORTANT): SBD MTMSN=20260311T220203 2026-03-11T22:02:04.506Z,1773266524.506 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003823