2026-02-12T17:04:15.655Z,1770915855.655 [CommandExec](IMPORTANT): got command schedule resume 2026-02-12T17:04:15.655Z,1770915855.655 [CommandExec](IMPORTANT): got command restart logs 2026-02-12T17:04:16.495Z,1770915856.495 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170420.00,A,3647.78200,N,12150.77422,W,0.467,43.82,120226,,,D*4C 2026-02-12T17:04:16.497Z,1770915856.497 [NAL9602](INFO): GPS fix at 20260212T170420: (36.796367, -121.846237) 2026-02-12T17:04:16.530Z,1770915856.530 [keepstation:NeedComms:D] Stopped 2026-02-12T17:04:16.530Z,1770915856.530 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T17:04:21.400Z,1770915861.400 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:04:27.118Z,1770915867.118 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=31237, MT Status=1, MTMSN=1137 2026-02-12T17:04:27.168Z,1770915867.168 [NAL9602](INFO): Sent 86 bytes from file Logs/20260212T020442/Courier0114.lzma 2026-02-12T17:04:27.168Z,1770915867.168 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:04:27.672Z,1770915867.672 [NAL9602](INFO): Received command: stop 2026-02-12T17:04:27.773Z,1770915867.773 [CommandExec](IMPORTANT): got command stop 2026-02-12T17:04:27.773Z,1770915867.773 [CommandExec](IMPORTANT): Scheduling is paused 2026-02-12T17:04:27.773Z,1770915867.773 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-02-12T17:04:27.938Z,1770915867.938 [MissionManager](INFO): MissionManager is completed. 2026-02-12T17:04:27.939Z,1770915867.939 [MissionManager](INFO): Uninitializing Mission keepstation 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation] Stopped 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:NeedComms] Stopped 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:NeedComms:E] Stopped 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:StandardEnvelopes] Stopped 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2026-02-12T17:04:27.939Z,1770915867.939 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:BackseatDriver] Stopped 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:PowerOnly] Stopped 2026-02-12T17:04:27.940Z,1770915867.940 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:PowerOnly:E.Wait] Stopped 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:H.Pitch] Stopped 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:SurfaceComms] Stopped 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:SurfaceComms:B] Stopped 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:DiveCmd] Stopped 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:DiveCmd](DEBUG): Aggregate::uninitialize keepstation:DiveCmd 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:KeepStation] Stopped 2026-02-12T17:04:27.941Z,1770915867.941 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2026-02-12T17:04:27.942Z,1770915867.942 [keepstation:KeepStation:B.Wait] Stopped 2026-02-12T17:04:27.942Z,1770915867.942 [keepstation:KeepStation:B.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T17:04:28.343Z,1770915868.343 [MissionManager](IMPORTANT): Started mission Default 2026-02-12T17:04:28.344Z,1770915868.344 [Default] Running Loop=1 2026-02-12T17:04:28.344Z,1770915868.344 [Default](DEBUG): Aggregate::initialize Default 2026-02-12T17:04:28.344Z,1770915868.344 [Default:B.GoToSurface] Running Loop=1 2026-02-12T17:04:28.344Z,1770915868.344 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T17:04:28.344Z,1770915868.344 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-02-12T17:04:28.345Z,1770915868.345 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-02-12T17:04:28.345Z,1770915868.345 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-02-12T17:04:28.345Z,1770915868.345 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-02-12T17:04:28.346Z,1770915868.346 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T17:04:28.346Z,1770915868.346 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T17:04:28.346Z,1770915868.346 [Default:A.Wait] Running Loop=1 2026-02-12T17:04:28.346Z,1770915868.346 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-02-12T17:04:41.681Z,1770915881.681 [Default:A.Wait](INFO): Done Waiting. 2026-02-12T17:04:41.681Z,1770915881.681 [Default:A.Wait] Stopped 2026-02-12T17:04:41.681Z,1770915881.681 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T17:04:42.099Z,1770915882.099 [Default:CheckIn] Running Loop=1 2026-02-12T17:04:42.099Z,1770915882.099 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-12T17:04:42.099Z,1770915882.099 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-12T17:04:44.087Z,1770915884.087 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170448.00,A,3647.78465,N,12150.77305,W,0.778,1.18,120226,,,A*78 2026-02-12T17:04:44.089Z,1770915884.089 [NAL9602](INFO): GPS fix at 20260212T170448: (36.796411, -121.846217) 2026-02-12T17:04:44.100Z,1770915884.100 [Default:CheckIn:Read_GPS] Stopped 2026-02-12T17:04:44.100Z,1770915884.100 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-12T17:04:52.568Z,1770915892.568 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:05:00.706Z,1770915900.706 [NAL9602](INFO): SBD MO Status=1, MOMSN=31238, MT Status=0, MTMSN=0 2026-02-12T17:05:00.752Z,1770915900.752 [NAL9602](INFO): Sent 268 bytes from file Logs/20260212T170415/Courier0003.lzma 2026-02-12T17:05:00.752Z,1770915900.752 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:05:13.458Z,1770915913.458 [NAL9602](INFO): SBD MO Status=1, MOMSN=31239, MT Status=0, MTMSN=0 2026-02-12T17:05:13.508Z,1770915913.508 [NAL9602](INFO): Sent 332 bytes from file Logs/20260212T020442/Express0115.lzma 2026-02-12T17:05:13.508Z,1770915913.508 [NAL9602](INFO): Packets left to send: 1 2026-02-12T17:05:22.479Z,1770915922.479 [NAL9602](INFO): SBD MO Status=1, MOMSN=31240, MT Status=0, MTMSN=0 2026-02-12T17:05:22.532Z,1770915922.532 [NAL9602](INFO): Sent 203 bytes from file Logs/20260212T020442/Express0115.lzma 2026-02-12T17:05:22.532Z,1770915922.532 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:05:23.692Z,1770915923.692 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:05:31.410Z,1770915931.410 [NAL9602](INFO): SBD MO Status=1, MOMSN=31241, MT Status=0, MTMSN=0 2026-02-12T17:05:31.464Z,1770915931.464 [NAL9602](INFO): Sent 332 bytes from file Logs/20260212T170415/Express0004.lzma 2026-02-12T17:05:31.464Z,1770915931.464 [NAL9602](INFO): Packets left to send: 1 2026-02-12T17:05:39.658Z,1770915939.658 [NAL9602](INFO): SBD MO Status=1, MOMSN=31242, MT Status=0, MTMSN=0 2026-02-12T17:05:39.708Z,1770915939.708 [NAL9602](INFO): Sent 205 bytes from file Logs/20260212T170415/Express0004.lzma 2026-02-12T17:05:39.708Z,1770915939.708 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:05:47.755Z,1770915947.755 [NAL9602](INFO): SBD MO Status=0, MOMSN=31243, MT Status=0, MTMSN=0 2026-02-12T17:05:54.816Z,1770915954.816 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:06:03.277Z,1770915963.277 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003443 2026-02-12T17:06:04.358Z,1770915964.358 [NAL9602](INFO): SBD MO Status=1, MOMSN=31244, MT Status=0, MTMSN=0 2026-02-12T17:06:04.416Z,1770915964.416 [NAL9602](INFO): Sent 39 bytes from file Logs/20260212T170415/Courier0006.lzma 2026-02-12T17:06:04.416Z,1770915964.416 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:06:10.884Z,1770915970.884 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20260212T170415/Express0007.lzma 2026-02-12T17:06:11.886Z,1770915971.886 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0007.lzma.bak 2026-02-12T17:06:11.886Z,1770915971.886 [DataOverHttps](INFO): SBD MOMSN=26653842 2026-02-12T17:06:13.266Z,1770915973.266 [Default:CheckIn:Read_Iridium] Stopped 2026-02-12T17:06:13.266Z,1770915973.266 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-12T17:06:13.266Z,1770915973.266 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-12T17:06:35.053Z,1770915995.053 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:11:13.885Z,1770916273.885 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-12T17:11:13.885Z,1770916273.885 [Default:CheckIn:C.Wait] Stopped 2026-02-12T17:11:13.885Z,1770916273.885 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T17:11:13.885Z,1770916273.885 [Default:CheckIn:D] Running Loop=1 2026-02-12T17:11:14.296Z,1770916274.296 [Default:CheckIn:D] Stopped 2026-02-12T17:11:14.296Z,1770916274.296 [Default:CheckIn:E] Running Loop=1 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.765874 min 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn:E] Stopped 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn] Stopped 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn](INFO): Running loop #2 2026-02-12T17:11:14.708Z,1770916274.708 [Default:CheckIn] Running Loop=2 2026-02-12T17:11:14.709Z,1770916274.709 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-12T17:11:14.709Z,1770916274.709 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-12T17:11:16.695Z,1770916276.695 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171121.00,A,3647.82067,N,12150.75771,W,0.330,14.30,120226,,,D*46 2026-02-12T17:11:16.697Z,1770916276.697 [NAL9602](INFO): GPS fix at 20260212T171121: (36.797011, -121.845962) 2026-02-12T17:11:16.745Z,1770916276.745 [Default:CheckIn:Read_GPS] Stopped 2026-02-12T17:11:16.745Z,1770916276.745 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-12T17:11:25.715Z,1770916285.715 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260212T170415/Courier0009.lzma 2026-02-12T17:11:26.717Z,1770916286.717 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0009.lzma.bak 2026-02-12T17:11:26.718Z,1770916286.718 [DataOverHttps](INFO): SBD MOMSN=26653871 2026-02-12T17:11:31.310Z,1770916291.310 [NAL9602](INFO): SBD MO Status=0, MOMSN=31245, MT Status=0, MTMSN=0 2026-02-12T17:11:31.310Z,1770916291.310 [NAL9602](INFO): No messages in MT queue 2026-02-12T17:11:45.788Z,1770916305.788 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20260212T170415/Express0010.lzma 2026-02-12T17:11:46.790Z,1770916306.790 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0010.lzma.bak 2026-02-12T17:11:46.790Z,1770916306.790 [DataOverHttps](INFO): SBD MOMSN=26653874 2026-02-12T17:11:48.295Z,1770916308.295 [Default:CheckIn:Read_Iridium] Stopped 2026-02-12T17:11:48.296Z,1770916308.296 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-12T17:11:48.296Z,1770916308.296 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-12T17:12:02.025Z,1770916322.025 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:13:20.454Z,1770916400.454 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-02-12T17:16:48.892Z,1770916608.892 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-12T17:16:48.892Z,1770916608.892 [Default:CheckIn:C.Wait] Stopped 2026-02-12T17:16:48.892Z,1770916608.892 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T17:16:48.892Z,1770916608.892 [Default:CheckIn:D] Running Loop=1 2026-02-12T17:16:49.308Z,1770916609.308 [Default:CheckIn:D] Stopped 2026-02-12T17:16:49.309Z,1770916609.309 [Default:CheckIn:E] Running Loop=1 2026-02-12T17:16:49.687Z,1770916609.687 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.349413 min 2026-02-12T17:16:49.687Z,1770916609.687 [Default:CheckIn:E] Stopped 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn] Stopped 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn](INFO): Running loop #3 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn] Running Loop=3 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-12T17:16:49.688Z,1770916609.688 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-12T17:16:51.708Z,1770916611.708 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171656.00,A,3647.85041,N,12150.74242,W,0.778,26.08,120226,,,D*44 2026-02-12T17:16:51.710Z,1770916611.710 [NAL9602](INFO): GPS fix at 20260212T171656: (36.797507, -121.845707) 2026-02-12T17:16:51.723Z,1770916611.723 [Default:CheckIn:Read_GPS] Stopped 2026-02-12T17:16:51.723Z,1770916611.723 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-12T17:16:59.035Z,1770916619.035 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260212T170415/Courier0012.lzma 2026-02-12T17:17:00.038Z,1770916620.038 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0012.lzma.bak 2026-02-12T17:17:00.039Z,1770916620.039 [DataOverHttps](IMPORTANT): SBD MOMSN=26653886, MTMSN=20260212T171704 2026-02-12T17:17:07.424Z,1770916627.424 [DataOverHttps](INFO): Received command: load Transport/keepstation.tl;set keepstation.NeedCommsTime 10 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;run 2026-02-12T17:17:07.468Z,1770916627.468 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl 2026-02-12T17:17:07.469Z,1770916627.469 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl 2026-02-12T17:17:07.469Z,1770916627.469 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl 2026-02-12T17:17:07.471Z,1770916627.471 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl 2026-02-12T17:17:07.874Z,1770916627.874 [NAL9602](INFO): SBD MO Status=0, MOMSN=31246, MT Status=0, MTMSN=0 2026-02-12T17:17:07.875Z,1770916627.875 [NAL9602](INFO): No messages in MT queue 2026-02-12T17:17:09.125Z,1770916629.125 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into: 4 45 NaN NaN 30 15 4 0.75 200 10 10 45 2 0 0 1 2 3 NaN 0 Sinking to Timed out while trying to reach target sink depth at current depth of 2026-02-12T17:17:09.155Z,1770916629.155 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h 2026-02-12T17:17:09.157Z,1770916629.157 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min 2026-02-12T17:17:09.159Z,1770916629.159 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg 2026-02-12T17:17:09.162Z,1770916629.162 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg 2026-02-12T17:17:09.165Z,1770916629.165 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m 2026-02-12T17:17:09.167Z,1770916629.167 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m 2026-02-12T17:17:09.169Z,1770916629.169 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m 2026-02-12T17:17:09.172Z,1770916629.172 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s 2026-02-12T17:17:09.174Z,1770916629.174 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m 2026-02-12T17:17:09.176Z,1770916629.176 [MissionManager](INFO): DefineArg keepstation.SinkOffSurface = 0 bool 2026-02-12T17:17:09.178Z,1770916629.178 [MissionManager](INFO): DefineArg keepstation.SinkDepth = 10.000000 m 2026-02-12T17:17:09.209Z,1770916629.209 [MissionManager](INFO): DefineArg keepstation.SinkDepthTimeout = 10.000000 min 2026-02-12T17:17:09.211Z,1770916629.211 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m 2026-02-12T17:17:09.218Z,1770916629.218 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km 2026-02-12T17:17:09.224Z,1770916629.224 [MissionManager](INFO): DefineOutput keepstation.DiveMode = 0.000000 count 2026-02-12T17:17:09.227Z,1770916629.227 [MissionManager](INFO): DefineOutput keepstation.DoingComms = 0.000000 count 2026-02-12T17:17:09.234Z,1770916629.234 [MissionManager](INFO): DefineOutput keepstation.SurfaceSink = 1.000000 count 2026-02-12T17:17:09.240Z,1770916629.240 [MissionManager](INFO): DefineOutput keepstation.TransitToStation = 2.000000 count 2026-02-12T17:17:09.243Z,1770916629.243 [MissionManager](INFO): DefineOutput keepstation.StationKeep = 3.000000 count 2026-02-12T17:17:09.249Z,1770916629.249 [MissionManager](INFO): DefineOutput keepstation.OnStation = 0 bool 2026-02-12T17:17:09.250Z,1770916629.250 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2026-02-12T17:17:09.250Z,1770916629.250 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2026-02-12T17:17:09.251Z,1770916629.251 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2026-02-12T17:17:09.658Z,1770916629.658 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into: 1 10 20 NaN 1 1500 7 30 0 0 0 0 last time_fix was: first GPS update timeout Comms timed out after minutes second GPS update timeout 2026-02-12T17:17:09.667Z,1770916629.667 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h 2026-02-12T17:17:09.669Z,1770916629.669 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min 2026-02-12T17:17:09.671Z,1770916629.671 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg 2026-02-12T17:17:09.674Z,1770916629.674 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s 2026-02-12T17:17:09.676Z,1770916629.676 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s 2026-02-12T17:17:09.679Z,1770916629.679 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1500.000000 s 2026-02-12T17:17:09.681Z,1770916629.681 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min 2026-02-12T17:17:09.683Z,1770916629.683 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min 2026-02-12T17:17:09.686Z,1770916629.686 [MissionManager](INFO): DefineArg keepstation:NeedComms.DoingCommsMode = 0.000000 count 2026-02-12T17:17:09.689Z,1770916629.689 [MissionManager](INFO): DefineArg keepstation:NeedComms.RestoreMode = 0.000000 count 2026-02-12T17:17:09.691Z,1770916629.691 [MissionManager](INFO): DefineOutput keepstation:NeedComms.IsActive = 0 bool 2026-02-12T17:17:09.693Z,1770916629.693 [MissionManager](INFO): DefineOutput keepstation:NeedComms.RequiredDiveMode = 0.000000 count 2026-02-12T17:17:09.702Z,1770916629.702 [keepstation:NeedComms:C.GoToSurface](DEBUG): Construct GoToSurface. 2026-02-12T17:17:09.769Z,1770916629.769 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2026-02-12T17:17:09.769Z,1770916629.769 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2026-02-12T17:17:09.770Z,1770916629.770 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2026-02-12T17:17:09.971Z,1770916629.971 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 1.5 200 2000 2026-02-12T17:17:09.975Z,1770916629.975 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m 2026-02-12T17:17:09.977Z,1770916629.977 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 1.500000 m 2026-02-12T17:17:09.979Z,1770916629.979 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m 2026-02-12T17:17:09.982Z,1770916629.982 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m 2026-02-12T17:17:09.983Z,1770916629.983 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2026-02-12T17:17:10.014Z,1770916630.014 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2026-02-12T17:17:10.021Z,1770916630.021 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2026-02-12T17:17:10.028Z,1770916630.028 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2026-02-12T17:17:10.028Z,1770916630.028 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2026-02-12T17:17:10.029Z,1770916630.029 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2026-02-12T17:17:10.060Z,1770916630.060 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2026-02-12T17:17:10.063Z,1770916630.063 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool 2026-02-12T17:17:10.065Z,1770916630.065 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2026-02-12T17:17:10.068Z,1770916630.068 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2026-02-12T17:17:10.068Z,1770916630.068 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2026-02-12T17:17:10.069Z,1770916630.069 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2026-02-12T17:17:10.194Z,1770916630.194 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2026-02-12T17:17:10.198Z,1770916630.198 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool 2026-02-12T17:17:10.200Z,1770916630.200 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool 2026-02-12T17:17:10.202Z,1770916630.202 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool 2026-02-12T17:17:10.204Z,1770916630.204 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool 2026-02-12T17:17:10.206Z,1770916630.206 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool 2026-02-12T17:17:10.213Z,1770916630.213 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait. 2026-02-12T17:17:10.215Z,1770916630.215 [keepstation:H.Pitch](DEBUG): Construct. 2026-02-12T17:17:10.267Z,1770916630.267 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Construct Buoyancy. 2026-02-12T17:17:10.294Z,1770916630.294 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Construct. 2026-02-12T17:17:10.310Z,1770916630.310 [keepstation:DiveCmd:SurfaceSink:sink:D.Pitch](DEBUG): Construct. 2026-02-12T17:17:10.345Z,1770916630.345 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Construct Buoyancy. 2026-02-12T17:17:10.356Z,1770916630.356 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Construct. 2026-02-12T17:17:10.365Z,1770916630.365 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Construct. 2026-02-12T17:17:10.370Z,1770916630.370 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Construct. 2026-02-12T17:17:10.379Z,1770916630.379 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Construct KeepStation. 2026-02-12T17:17:10.387Z,1770916630.387 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2026-02-12T17:17:10.399Z,1770916630.399 [keepstation:KeepStation:B.Wait](DEBUG): Construct Wait. 2026-02-12T17:17:10.427Z,1770916630.427 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission keepstation { """ Vehicle transits to desired waypoint (or stays put if none is commanded) and stays within the specified radius. """ arguments { MissionTimeout = 4 hour """ Maximum duration of mission """ NeedCommsTime = 45 minute """ How often to surface for communications """ Latitude = NaN degree """ Latitude of waypoint to hold. If NaN, hold the latitude at start of mission. """ Longitude = NaN degree """ Longitude of waypoint to hold. If NaN, hold the longitude at start of mission. """ Depth = 30 meter """ Depth held during drift mode """ ApproachDepth = 15 meter """ Depth for initial approach to station. """ DepthDeadband = 4 meter """ How much vertical drift from the specified depth is allowed in drift mode """ Speed = 0.75 meter_per_second """ Vehicle transit speed. """ Radius = 200 meter """ Radius of circle around waypoint to hold. """ SinkOffSurface = false """ If true, use buoyancy only to decend to SinkDepth before driving to first target depth """ SinkDepth = 10 meter """ Initial depth to decend using only buoyancy before driving """ SinkDepthTimeout = 10 minute """ Max wait time for the vehicle to reach the target depth """ MaxDepth = 45 meter """ Maximum allowable depth during the mission. """ MinOffshore = 2 kilometer """ Minimum distance from the shoreline to maintain """ } output { DiveMode = 0 count """ Mission variable (don't change). The mission sets this variable to switch between dive modes. Initialized to DoingComms. """ DoingComms = 0 count """ Mission variable (don't change). The mission will run in this mode when doing surface comms. """ SurfaceSink = 1 count """ Mission variable (don't change). The mission will run in this mode when sinking from the surface using only buoyancy. """ TransitToStation = 2 count """ Mission variable (don't change). The mission will run in this mode when performing the transit to station """ StationKeep = 3 count """ Mission variable (don't change). The mission will run in this mode when keeping station """ OnStation = false """ Mission variable (don't change). Determines last mode (Transit or StationKeep) to resume after needcomms """ } timeout duration=MissionTimeout insert id="NeedComms" Insert/NeedComms.tl assign in sequence NeedComms:DiveInterval = NeedCommsTime insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl behavior Guidance:Pitch { run in parallel set massPosition = Control:VerticalControl.massDefault } aggregate SurfaceComms { run when ( called or ( elapsed ( Universal:time_fix ) > NeedCommsTime ) ) assign in sequence DiveMode = DoingComms call priorityHere=false refId="NeedComms" aggregate HandleNan { run in sequence break if ( not isNaN ( Latitude ) and not isNaN ( Longitude ) ) # If both lat and lon are nan, we are implicitly on station and should skip initial transit, so force OnStation to true aggregate SetOnStation { run in sequence break if ( not isNaN ( Latitude ) or not isNaN ( Longitude ) ) assign in sequence OnStation = true } # The "assigns" here mean we should only ever run these aggregates once # An initial NaN lat/lon should be set here during the initial surface NeedComms call # Use the most recent fix -- if there isn't one, the keepstation behavior will use Universal:lat/lon aggregate SetLat { run in sequence break if ( not isNaN ( Latitude ) ) assign in sequence Latitude = Universal:latitude_fix } aggregate SetLon { run in sequence break if ( not isNaN ( Longitude ) ) assign in sequence Longitude = Universal:longitude_fix } } aggregate setTransit { run in sequence break if ( SinkOffSurface or OnStation ) assign in sequence DiveMode = TransitToStation } aggregate setStation { run in sequence break if ( SinkOffSurface or not OnStation ) assign in sequence DiveMode = StationKeep } aggregate setSink { run in sequence break if ( not SinkOffSurface ) assign in sequence DiveMode = SurfaceSink } } call id="StartingMission" priorityHere=false refId="SurfaceComms" aggregate DiveCmd { run when ( called ) aggregate SurfaceSink { run while ( DiveMode == SurfaceSink ) aggregate sink { run in sequence behavior Guidance:Buoyancy id="BuoyancyHold" { run in parallel set position = NaN cc } behavior Guidance:SetSpeed { run in parallel set speed = 0 m/s } syslog info "Sinking to " + SinkDepth~meter behavior Guidance:Pitch { run in sequence timeout duration=SinkDepthTimeout { syslog important "Timed out while trying to reach target sink depth at current depth of " + Universal:depth~meter } set depth = SinkDepth } # Once we've sunk, either resume transit or station keeping depths and speeds aggregate sinkToTransit { run in sequence break if ( OnStation ) assign in sequence DiveMode = TransitToStation } aggregate sinkToStation { run in sequence break if ( not OnStation ) assign in sequence DiveMode = StationKeep } } } aggregate TransitToStation { run while ( DiveMode == TransitToStation ) aggregate dive { run in sequence behavior Guidance:Buoyancy { run in parallel set position = Control:VerticalControl.buoyancyNeutral } behavior Guidance:Pitch { run in parallel set depth = ApproachDepth } behavior Guidance:SetSpeed { run in parallel set speed = Speed } } } aggregate StationKeep { run while ( DiveMode == StationKeep ) assign in parallel Control:VerticalControl.depthDeadband = DepthDeadband behavior Guidance:Pitch { run in parallel set depth = Depth } behavior Guidance:KeepStation { run in parallel set latitude = Latitude set longitude = Longitude set radius = Radius set speed = Speed } } } aggregate TransitToStation { """ Need a separate aggregate for transit if we want to specify a different depth for the approach. """ run in sequence aggregate Dive { run while ( not ( DiveMode == DoingComms ) ) call priorityHere=false refId="DiveCmd" } behavior Guidance:Waypoint id="Wpt1" { run in sequence set latitude = Latitude set longitude = Longitude } assign in sequence DiveMode = StationKeep assign in sequence OnStation = true } call id="OnStation" priorityHere=false refId="NeedComms" aggregate KeepStation { run in sequence aggregate Dive { run while ( not ( DiveMode == DoingComms ) ) call priorityHere=false refId="DiveCmd" } behavior Guidance:Wait { """ Due to the way the KeepStation behavior is currently implemented, we must run it in parallel and use a Wait to keep from completing the mission before the timeout expires. However, this new version of the mission uses a top-level timeout so that the entire mission will not run for longer then MissionTimeout. """ run in sequence set duration = MissionTimeout } } } 2026-02-12T17:17:10.427Z,1770916630.427 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation 2026-02-12T17:17:19.468Z,1770916639.468 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20260212T170415/Express0013.lzma 2026-02-12T17:17:20.470Z,1770916640.470 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0013.lzma.bak 2026-02-12T17:17:20.470Z,1770916640.470 [DataOverHttps](INFO): SBD MOMSN=26653894 2026-02-12T17:17:25.364Z,1770916645.364 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 10 minute 2026-02-12T17:17:25.365Z,1770916645.365 [CommandExec](IMPORTANT): got command set keepstation.Latitude 36.797 degree 2026-02-12T17:17:25.366Z,1770916645.366 [CommandExec](IMPORTANT): got command set keepstation.Longitude -121.847 degree 2026-02-12T17:17:25.366Z,1770916645.366 [CommandExec](IMPORTANT): got command run 2026-02-12T17:17:25.372Z,1770916645.372 [CommandExec](IMPORTANT): Running 2026-02-12T17:17:25.764Z,1770916645.764 [Default] Stopped 2026-02-12T17:17:25.764Z,1770916645.764 [Default](DEBUG): Aggregate::uninitialize Default 2026-02-12T17:17:25.764Z,1770916645.764 [Default:B.GoToSurface] Stopped 2026-02-12T17:17:25.765Z,1770916645.765 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T17:17:25.765Z,1770916645.765 [Default:CheckIn] Stopped 2026-02-12T17:17:25.765Z,1770916645.765 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-12T17:17:25.765Z,1770916645.765 [Default:CheckIn:Read_Iridium] Stopped 2026-02-12T17:17:25.765Z,1770916645.765 [MissionManager](IMPORTANT): Started mission keepstation 2026-02-12T17:17:25.765Z,1770916645.765 [keepstation] Running Loop=1 2026-02-12T17:17:25.765Z,1770916645.765 [keepstation](DEBUG): Aggregate::initialize keepstation 2026-02-12T17:17:25.765Z,1770916645.765 [keepstation:StandardEnvelopes] Running Loop=1 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:BackseatDriver] Running Loop=1 2026-02-12T17:17:25.766Z,1770916645.766 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly:A] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly:B] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly:C] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly:D] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly:E.Wait] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:H.Pitch] Running Loop=1 2026-02-12T17:17:25.767Z,1770916645.767 [keepstation:H.Pitch](DEBUG): Initialize. 2026-02-12T17:17:25.788Z,1770916645.788 [keepstation:B] Running Loop=1 2026-02-12T17:17:25.789Z,1770916645.789 [keepstation:H.Pitch] Running Loop=1 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:PowerOnly] Running Loop=1 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:PowerOnly:D] Stopped 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:PowerOnly:C] Stopped 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:PowerOnly:B] Stopped 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:PowerOnly:A] Stopped 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:BackseatDriver] Running Loop=1 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:StandardEnvelopes] Running Loop=1 2026-02-12T17:17:25.790Z,1770916645.790 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2026-02-12T17:17:25.791Z,1770916645.791 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2026-02-12T17:17:25.791Z,1770916645.791 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2026-02-12T17:17:25.800Z,1770916645.800 [keepstation:B] Stopped 2026-02-12T17:17:25.800Z,1770916645.800 [keepstation:D] Running Loop=1 2026-02-12T17:17:26.113Z,1770916646.113 [keepstation:D] Stopped 2026-02-12T17:17:26.113Z,1770916646.113 [keepstation:E] Running Loop=1 2026-02-12T17:17:26.494Z,1770916646.494 [keepstation:E] Stopped 2026-02-12T17:17:26.494Z,1770916646.494 [keepstation:StartingMission] Running Loop=1 2026-02-12T17:17:26.494Z,1770916646.494 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission 2026-02-12T17:17:26.876Z,1770916646.876 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T17:17:26.876Z,1770916646.876 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T17:17:26.876Z,1770916646.876 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T17:17:26.877Z,1770916646.877 [keepstation:SurfaceComms:A] Stopped 2026-02-12T17:17:26.877Z,1770916646.877 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T17:17:26.877Z,1770916646.877 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T17:17:27.298Z,1770916647.298 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2026-02-12T17:17:27.298Z,1770916647.298 [keepstation:NeedComms] Running Loop=1 2026-02-12T17:17:27.299Z,1770916647.299 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T17:17:27.299Z,1770916647.299 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T17:17:27.299Z,1770916647.299 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T17:17:27.299Z,1770916647.299 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T17:17:27.299Z,1770916647.299 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T17:17:27.324Z,1770916647.324 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T17:17:27.325Z,1770916647.325 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T17:17:27.325Z,1770916647.325 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T17:17:27.325Z,1770916647.325 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T17:17:27.325Z,1770916647.325 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T17:17:27.327Z,1770916647.327 [keepstation:NeedComms:A](INFO): last time_fix was: 1770916616.000000 second since 1970/01/01T00:00:00Z 2026-02-12T17:17:27.327Z,1770916647.327 [keepstation:NeedComms:A] Stopped 2026-02-12T17:17:27.327Z,1770916647.327 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T17:17:27.327Z,1770916647.327 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T17:17:27.327Z,1770916647.327 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T17:17:27.686Z,1770916647.686 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T17:17:27.686Z,1770916647.686 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T17:17:28.106Z,1770916648.106 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T17:17:28.106Z,1770916648.106 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T17:17:28.107Z,1770916648.107 [keepstation:NeedComms:setActive] Stopped 2026-02-12T17:17:28.107Z,1770916648.107 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T17:17:28.544Z,1770916648.544 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T17:17:28.889Z,1770916648.889 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-02-12T17:17:30.489Z,1770916650.489 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171735.00,A,3647.85439,N,12150.74048,W,0.641,41.62,120226,,,D*45 2026-02-12T17:17:30.491Z,1770916650.491 [NAL9602](INFO): GPS fix at 20260212T171735: (36.797573, -121.845675) 2026-02-12T17:17:30.505Z,1770916650.505 [keepstation:NeedComms:D] Stopped 2026-02-12T17:17:30.505Z,1770916650.505 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T17:17:30.931Z,1770916650.931 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense platform_communications 2026-02-12T17:17:37.783Z,1770916657.783 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260212T170415/Courier0015.lzma 2026-02-12T17:17:38.787Z,1770916658.787 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0015.lzma.bak 2026-02-12T17:17:38.787Z,1770916658.787 [DataOverHttps](INFO): SBD MOMSN=26653904 2026-02-12T17:17:54.867Z,1770916674.867 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260212T170415/Courier0018.lzma 2026-02-12T17:17:55.870Z,1770916675.870 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0018.lzma.bak 2026-02-12T17:17:55.870Z,1770916675.870 [DataOverHttps](INFO): SBD MOMSN=26653906 2026-02-12T17:18:03.213Z,1770916683.213 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:18:13.384Z,1770916693.384 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20260212T170415/Express0016.lzma 2026-02-12T17:18:14.386Z,1770916694.386 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0016.lzma.bak 2026-02-12T17:18:14.386Z,1770916694.386 [DataOverHttps](INFO): SBD MOMSN=26653909 2026-02-12T17:18:30.324Z,1770916710.324 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20260212T170415/Express0019.lzma 2026-02-12T17:18:31.326Z,1770916711.326 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0019.lzma.bak 2026-02-12T17:18:31.326Z,1770916711.326 [DataOverHttps](INFO): SBD MOMSN=26653913 2026-02-12T17:18:32.808Z,1770916712.808 [keepstation:NeedComms:E] Stopped 2026-02-12T17:18:32.809Z,1770916712.809 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T17:18:33.169Z,1770916713.169 [keepstation:NeedComms:F](DEBUG): Initialize ReadDataComponent to sense time_fix 2026-02-12T17:18:34.755Z,1770916714.755 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171839.00,A,3647.85930,N,12150.73773,W,0.428,48.94,120226,,,D*47 2026-02-12T17:18:34.757Z,1770916714.757 [NAL9602](INFO): GPS fix at 20260212T171839: (36.797655, -121.845629) 2026-02-12T17:18:34.845Z,1770916714.845 [keepstation:NeedComms:F] Stopped 2026-02-12T17:18:34.845Z,1770916714.845 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T17:18:34.845Z,1770916714.845 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:18:34.845Z,1770916714.845 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T17:18:35.223Z,1770916715.223 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T17:18:35.223Z,1770916715.223 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T17:18:35.223Z,1770916715.223 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T17:18:35.223Z,1770916715.223 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:18:35.252Z,1770916715.252 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T17:18:35.252Z,1770916715.252 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T17:18:35.252Z,1770916715.252 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T17:18:35.775Z,1770916715.775 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T17:18:35.775Z,1770916715.775 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T17:18:35.775Z,1770916715.775 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T17:18:35.775Z,1770916715.775 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T17:18:35.805Z,1770916715.805 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T17:18:35.805Z,1770916715.805 [keepstation:NeedComms] Stopped 2026-02-12T17:18:35.805Z,1770916715.805 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T17:18:35.805Z,1770916715.805 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T17:18:35.805Z,1770916715.805 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T17:18:36.063Z,1770916716.063 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T17:18:36.063Z,1770916716.063 [keepstation:SurfaceComms:B] Stopped 2026-02-12T17:18:36.072Z,1770916716.072 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T17:18:36.072Z,1770916716.072 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T17:18:36.072Z,1770916716.072 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T17:18:36.072Z,1770916716.072 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T17:18:36.072Z,1770916716.072 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T17:18:36.072Z,1770916716.072 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T17:18:36.430Z,1770916716.430 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setTransit](INFO): Completed keepstation:SurfaceComms:setTransit 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T17:18:36.855Z,1770916716.855 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T17:18:37.261Z,1770916717.261 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T17:18:37.261Z,1770916717.261 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T17:18:37.261Z,1770916717.261 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T17:18:37.261Z,1770916717.261 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T17:18:37.261Z,1770916717.261 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T17:18:37.261Z,1770916717.261 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T17:18:37.647Z,1770916717.647 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T17:18:37.647Z,1770916717.647 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T17:18:37.647Z,1770916717.647 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T17:18:37.647Z,1770916717.647 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T17:18:37.647Z,1770916717.647 [keepstation:SurfaceComms] Stopped 2026-02-12T17:18:37.647Z,1770916717.647 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T17:18:38.057Z,1770916718.057 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:StartingMission] Stopped 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:TransitToStation] Running Loop=1 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:TransitToStation:Dive] Running Loop=1 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:TransitToStation:Dive:A] Running Loop=1 2026-02-12T17:18:38.058Z,1770916718.058 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::initialize keepstation:TransitToStation:Dive:A 2026-02-12T17:18:38.059Z,1770916718.059 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2026-02-12T17:18:38.059Z,1770916718.059 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2026-02-12T17:18:38.059Z,1770916718.059 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000 2026-02-12T17:18:38.490Z,1770916718.490 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000 2026-02-12T17:18:38.490Z,1770916718.490 [keepstation:TransitToStation:Dive] Running Loop=1 2026-02-12T17:18:38.490Z,1770916718.490 [keepstation:DiveCmd] Running Loop=1 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd](DEBUG): Aggregate::initialize keepstation:DiveCmd 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink] Running Loop=1 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink:sink] Running Loop=1 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::initialize keepstation:DiveCmd:SurfaceSink:sink 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Running Loop=1 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component. 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Running Loop=1 2026-02-12T17:18:38.491Z,1770916718.491 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Initialize. 2026-02-12T17:18:38.496Z,1770916718.496 [keepstation:DiveCmd:SurfaceSink:sink:C] Running Loop=1 2026-02-12T17:18:38.496Z,1770916718.496 [keepstation:DiveCmd:TransitToStation] Running Loop=1 2026-02-12T17:18:38.496Z,1770916718.496 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation 2026-02-12T17:18:38.496Z,1770916718.496 [keepstation:DiveCmd:TransitToStation:dive] Running Loop=1 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::initialize keepstation:DiveCmd:TransitToStation:dive 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch](DEBUG): Initialize. 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Initialize. 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T17:18:38.497Z,1770916718.497 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T17:18:38.498Z,1770916718.498 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T17:18:38.498Z,1770916718.498 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T17:18:38.498Z,1770916718.498 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T17:18:38.498Z,1770916718.498 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T17:18:38.498Z,1770916718.498 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:TransitToStation] Running Loop=1 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Running Loop=1 2026-02-12T17:18:38.499Z,1770916718.499 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Running Loop=1 2026-02-12T17:18:38.512Z,1770916718.512 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Running Loop=1 2026-02-12T17:18:38.512Z,1770916718.512 [keepstation:DiveCmd:SurfaceSink] Stopped 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink] Stopped 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:SurfaceSink:sink 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy] Stopped 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed] Stopped 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink:B.SetSpeed](DEBUG): Uninitialize. 2026-02-12T17:18:38.513Z,1770916718.513 [keepstation:DiveCmd:SurfaceSink:sink:C] Stopped 2026-02-12T17:18:53.530Z,1770916733.530 [NAL9602](INFO): SBD MO Status=0, MOMSN=31247, MT Status=0, MTMSN=0 2026-02-12T17:18:53.530Z,1770916733.530 [NAL9602](INFO): No messages in MT queue 2026-02-12T17:19:24.316Z,1770916764.316 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:22:07.496Z,1770916927.496 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:22:13.372Z,1770916933.372 [Radio_Surface](INFO): Powering down 2026-02-12T17:22:38.620Z,1770916958.620 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:22:39.624Z,1770916959.624 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-02-12T17:23:46.916Z,1770917026.916 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.598465 2026-02-12T17:25:07.326Z,1770917107.326 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000 2026-02-12T17:25:07.326Z,1770917107.326 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2026-02-12T17:25:07.326Z,1770917107.326 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2026-02-12T17:25:07.327Z,1770917107.327 [keepstation:TransitToStation:C] Running Loop=1 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:TransitToStation:C] Stopped 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:TransitToStation:D] Running Loop=1 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T17:25:07.737Z,1770917107.737 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T17:25:07.738Z,1770917107.738 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T17:25:07.738Z,1770917107.738 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T17:25:07.738Z,1770917107.738 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T17:25:07.738Z,1770917107.738 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T17:25:07.739Z,1770917107.739 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T17:25:07.739Z,1770917107.739 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T17:25:07.739Z,1770917107.739 [keepstation:DiveCmd:TransitToStation] Stopped 2026-02-12T17:25:07.739Z,1770917107.739 [keepstation:DiveCmd:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation 2026-02-12T17:25:07.739Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive] Stopped 2026-02-12T17:25:07.740Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:TransitToStation:dive 2026-02-12T17:25:07.740Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy] Stopped 2026-02-12T17:25:07.740Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2026-02-12T17:25:07.740Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive:B.Pitch] Stopped 2026-02-12T17:25:07.740Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed] Stopped 2026-02-12T17:25:07.740Z,1770917107.740 [keepstation:DiveCmd:TransitToStation:dive:C.SetSpeed](DEBUG): Uninitialize. 2026-02-12T17:25:08.156Z,1770917108.156 [keepstation:TransitToStation:D] Stopped 2026-02-12T17:25:08.156Z,1770917108.156 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation 2026-02-12T17:25:08.156Z,1770917108.156 [keepstation:TransitToStation] Stopped 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:TransitToStation:Dive] Stopped 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:TransitToStation:Dive](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:TransitToStation:Dive:A] Stopped 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:TransitToStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:TransitToStation:Dive:A 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:OnStation] Running Loop=1 2026-02-12T17:25:08.157Z,1770917108.157 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation 2026-02-12T17:25:08.523Z,1770917108.523 [keepstation:NeedComms] Running Loop=1 2026-02-12T17:25:08.523Z,1770917108.523 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T17:25:08.523Z,1770917108.523 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T17:25:08.523Z,1770917108.523 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T17:25:08.524Z,1770917108.524 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T17:25:08.524Z,1770917108.524 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T17:25:08.525Z,1770917108.525 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T17:25:08.525Z,1770917108.525 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T17:25:08.525Z,1770917108.525 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T17:25:08.526Z,1770917108.526 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T17:25:08.526Z,1770917108.526 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T17:25:08.527Z,1770917108.527 [keepstation:NeedComms:A](INFO): last time_fix was: 1770916719.000000 second since 1970/01/01T00:00:00Z 2026-02-12T17:25:08.527Z,1770917108.527 [keepstation:NeedComms:A] Stopped 2026-02-12T17:25:08.528Z,1770917108.528 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T17:25:08.528Z,1770917108.528 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T17:25:08.528Z,1770917108.528 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T17:25:08.919Z,1770917108.919 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T17:25:08.919Z,1770917108.919 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T17:25:09.323Z,1770917109.323 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T17:25:09.323Z,1770917109.323 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T17:25:09.323Z,1770917109.323 [keepstation:NeedComms:setActive] Stopped 2026-02-12T17:25:09.323Z,1770917109.323 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T17:26:06.583Z,1770917166.583 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T17:26:07.296Z,1770917167.296 [Radio_Surface](INFO): Powering up 2026-02-12T17:26:13.500Z,1770917173.500 [DataOverHttps](INFO): Radio surface powered ON. 2026-02-12T17:26:23.146Z,1770917183.146 [NAL9602](INFO): SBD MO Status=0, MOMSN=31248, MT Status=0, MTMSN=0 2026-02-12T17:26:23.146Z,1770917183.146 [NAL9602](INFO): No messages in MT queue 2026-02-12T17:26:24.358Z,1770917184.358 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172628.00,A,3647.84586,N,12150.81979,W,0.389,282.28,120226,,,D*7C 2026-02-12T17:26:24.360Z,1770917184.360 [NAL9602](INFO): GPS fix at 20260212T172628: (36.797431, -121.846997) 2026-02-12T17:26:24.389Z,1770917184.389 [keepstation:NeedComms:D] Stopped 2026-02-12T17:26:24.390Z,1770917184.390 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T17:26:40.207Z,1770917200.207 [NAL9602](INFO): SBD MO Status=1, MOMSN=31249, MT Status=0, MTMSN=0 2026-02-12T17:26:40.258Z,1770917200.258 [NAL9602](INFO): Sent 73 bytes from file Logs/20260212T170415/Courier0021.lzma 2026-02-12T17:26:40.259Z,1770917200.259 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:26:43.620Z,1770917203.620 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:26:54.510Z,1770917214.510 [NAL9602](INFO): SBD MO Status=1, MOMSN=31250, MT Status=0, MTMSN=0 2026-02-12T17:26:54.564Z,1770917214.564 [NAL9602](INFO): Sent 332 bytes from file Logs/20260212T170415/Express0022.lzma 2026-02-12T17:26:54.564Z,1770917214.564 [NAL9602](INFO): Packets left to send: 1 2026-02-12T17:27:04.350Z,1770917224.350 [NAL9602](INFO): SBD MO Status=1, MOMSN=31251, MT Status=0, MTMSN=0 2026-02-12T17:27:04.408Z,1770917224.408 [NAL9602](INFO): Sent 28 bytes from file Logs/20260212T170415/Express0022.lzma 2026-02-12T17:27:04.408Z,1770917224.408 [NAL9602](INFO): Packets left to send: 0 2026-02-12T17:27:12.831Z,1770917232.831 [NAL9602](INFO): SBD MO Status=0, MOMSN=31252, MT Status=0, MTMSN=0 2026-02-12T17:27:12.938Z,1770917232.938 [keepstation:NeedComms:E] Stopped 2026-02-12T17:27:12.938Z,1770917232.938 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T17:27:14.744Z,1770917234.744 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:27:15.262Z,1770917235.262 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172719.00,A,3647.84970,N,12150.82028,W,0.641,41.52,120226,,,D*45 2026-02-12T17:27:15.265Z,1770917235.265 [NAL9602](INFO): GPS fix at 20260212T172719: (36.797495, -121.847005) 2026-02-12T17:27:15.295Z,1770917235.295 [keepstation:NeedComms:F] Stopped 2026-02-12T17:27:15.300Z,1770917235.300 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T17:27:15.300Z,1770917235.300 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:27:15.300Z,1770917235.300 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T17:27:15.717Z,1770917235.717 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T17:27:15.717Z,1770917235.717 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T17:27:15.717Z,1770917235.717 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T17:27:15.717Z,1770917235.717 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:27:15.717Z,1770917235.717 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T17:27:15.717Z,1770917235.717 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T17:27:15.718Z,1770917235.718 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T17:27:16.095Z,1770917236.095 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T17:27:16.095Z,1770917236.095 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T17:27:16.095Z,1770917236.095 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T17:27:16.095Z,1770917236.095 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T17:27:16.096Z,1770917236.096 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T17:27:16.096Z,1770917236.096 [keepstation:NeedComms] Stopped 2026-02-12T17:27:16.096Z,1770917236.096 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T17:27:16.096Z,1770917236.096 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T17:27:16.097Z,1770917236.097 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T17:27:16.490Z,1770917236.490 [keepstation:OnStation](INFO): Completed keepstation:OnStation 2026-02-12T17:27:16.490Z,1770917236.490 [keepstation:OnStation] Stopped 2026-02-12T17:27:16.490Z,1770917236.490 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation 2026-02-12T17:27:16.490Z,1770917236.490 [keepstation:KeepStation] Running Loop=1 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation:B.Wait] Running Loop=1 2026-02-12T17:27:16.491Z,1770917236.491 [keepstation:KeepStation:B.Wait](DEBUG): Initialize Wait Component. 2026-02-12T17:27:16.901Z,1770917236.901 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T17:27:45.884Z,1770917265.884 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:27:47.173Z,1770917267.173 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:28:17.008Z,1770917297.008 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:28:48.136Z,1770917328.136 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:29:19.260Z,1770917359.260 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:29:47.559Z,1770917387.559 [BPC1](ERROR): Battery stick #8 (s/n: 01E7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.560Z,1770917387.560 [BPC1](ERROR): Battery stick #16 (s/n: 00F8) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.561Z,1770917387.561 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-12T17:29:47.562Z,1770917387.562 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.563Z,1770917387.563 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-12T17:29:47.563Z,1770917387.563 [BPC1](ERROR): Battery stick #37 (s/n: 0181) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.564Z,1770917387.564 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.565Z,1770917387.565 [BPC1](ERROR): Battery stick #39 (s/n: 0189) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.566Z,1770917387.566 [BPC1](ERROR): Battery stick #40 (s/n: 01A4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.566Z,1770917387.566 [BPC1](ERROR): Battery stick #44 (s/n: 01BB) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.567Z,1770917387.567 [BPC1](ERROR): Battery stick #50 (s/n: 019C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.568Z,1770917387.568 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.569Z,1770917387.569 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.569Z,1770917387.569 [BPC1](ERROR): Battery stick #53 (s/n: 01EE) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.570Z,1770917387.570 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T17:29:47.571Z,1770917387.571 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x5AD0. 2026-02-12T17:29:47.571Z,1770917387.571 [BPC1](INFO): Calculating totals. Valid battery stick count: 37. Valid reserve battery stick count: 2. 2026-02-12T17:29:47.576Z,1770917387.576 [BPC1](FAULT): Failed to receive data from 20 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 8, 9, 10, 11, 14, 16, 17, 24, 29, 37, 38, 39, 40, 44, 50, 51, 52, 53, 57, 59. 2026-02-12T17:29:50.397Z,1770917390.397 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:29:59.054Z,1770917399.054 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003468 2026-02-12T17:32:49.777Z,1770917569.777 [DAT](INFO): DAT read: Rx Time:17:32:50.4984 2026-02-12T17:32:49.778Z,1770917569.778 [DAT](INFO): Rx dataTimestamp_ set to:1770917569.777585 2026-02-12T17:32:50.785Z,1770917570.785 [DAT](INFO): DAT read: $Error in header 2026-02-12T17:32:50.785Z,1770917570.785 [DAT](INFO): Received a bad header 2026-02-12T17:37:15.613Z,1770917835.613 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T17:37:15.613Z,1770917835.613 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T17:37:15.613Z,1770917835.613 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T17:37:15.614Z,1770917835.614 [keepstation:SurfaceComms:A] Stopped 2026-02-12T17:37:15.614Z,1770917835.614 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T17:37:15.614Z,1770917835.614 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T17:37:16.015Z,1770917836.015 [keepstation:KeepStation:Dive] Stopped 2026-02-12T17:37:16.015Z,1770917836.015 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T17:37:16.016Z,1770917836.016 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T17:37:16.016Z,1770917836.016 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T17:37:16.016Z,1770917836.016 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T17:37:16.016Z,1770917836.016 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T17:37:16.017Z,1770917836.017 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T17:37:16.017Z,1770917836.017 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T17:37:16.017Z,1770917836.017 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T17:37:16.017Z,1770917836.017 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T17:37:16.018Z,1770917836.018 [keepstation:NeedComms] Running Loop=1 2026-02-12T17:37:16.018Z,1770917836.018 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T17:37:16.019Z,1770917836.019 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T17:37:16.019Z,1770917836.019 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T17:37:16.019Z,1770917836.019 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T17:37:16.019Z,1770917836.019 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T17:37:16.020Z,1770917836.020 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T17:37:16.020Z,1770917836.020 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T17:37:16.021Z,1770917836.021 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T17:37:16.021Z,1770917836.021 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T17:37:16.021Z,1770917836.021 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T17:37:16.022Z,1770917836.022 [keepstation:NeedComms:A](INFO): last time_fix was: 1770917239.000000 second since 1970/01/01T00:00:00Z 2026-02-12T17:37:16.022Z,1770917836.022 [keepstation:NeedComms:A] Stopped 2026-02-12T17:37:16.023Z,1770917836.023 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T17:37:16.023Z,1770917836.023 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T17:37:16.023Z,1770917836.023 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T17:37:16.433Z,1770917836.433 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T17:37:16.433Z,1770917836.433 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T17:37:16.842Z,1770917836.842 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T17:37:16.842Z,1770917836.842 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T17:37:16.842Z,1770917836.842 [keepstation:NeedComms:setActive] Stopped 2026-02-12T17:37:16.842Z,1770917836.842 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T17:37:17.229Z,1770917837.229 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T17:37:19.239Z,1770917839.239 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173723.00,A,3647.91320,N,12150.79381,W,0.292,18.63,120226,,,D*46 2026-02-12T17:37:19.242Z,1770917839.242 [NAL9602](INFO): GPS fix at 20260212T173723: (36.798553, -121.846564) 2026-02-12T17:37:19.255Z,1770917839.255 [keepstation:NeedComms:D] Stopped 2026-02-12T17:37:19.255Z,1770917839.255 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T17:37:26.667Z,1770917846.667 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20260212T170415/Courier0024.lzma 2026-02-12T17:37:27.670Z,1770917847.670 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0024.lzma.bak 2026-02-12T17:37:27.670Z,1770917847.670 [DataOverHttps](INFO): SBD MOMSN=26653962 2026-02-12T17:37:29.342Z,1770917849.342 [NAL9602](INFO): SBD MO Status=0, MOMSN=31253, MT Status=0, MTMSN=0 2026-02-12T17:37:29.342Z,1770917849.342 [NAL9602](INFO): No messages in MT queue 2026-02-12T17:37:43.600Z,1770917863.600 [DataOverHttps](INFO): Sending 316 bytes from file Logs/20260212T170415/Express0025.lzma 2026-02-12T17:37:44.602Z,1770917864.602 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0025.lzma.bak 2026-02-12T17:37:44.602Z,1770917864.602 [DataOverHttps](INFO): SBD MOMSN=26653965 2026-02-12T17:37:45.921Z,1770917865.921 [keepstation:NeedComms:E] Stopped 2026-02-12T17:37:45.921Z,1770917865.921 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T17:37:47.923Z,1770917867.923 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173752.00,A,3647.91603,N,12150.79204,W,0.525,43.56,120226,,,D*4B 2026-02-12T17:37:47.926Z,1770917867.926 [NAL9602](INFO): GPS fix at 20260212T173752: (36.798600, -121.846534) 2026-02-12T17:37:47.958Z,1770917867.958 [keepstation:NeedComms:F] Stopped 2026-02-12T17:37:47.958Z,1770917867.958 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T17:37:47.958Z,1770917867.958 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:37:47.959Z,1770917867.959 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T17:37:48.402Z,1770917868.402 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T17:37:48.403Z,1770917868.403 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T17:37:48.403Z,1770917868.403 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T17:37:48.403Z,1770917868.403 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:37:48.403Z,1770917868.403 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T17:37:48.403Z,1770917868.403 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T17:37:48.403Z,1770917868.403 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T17:37:48.816Z,1770917868.816 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T17:37:48.816Z,1770917868.816 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T17:37:48.816Z,1770917868.816 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T17:37:48.816Z,1770917868.816 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T17:37:48.817Z,1770917868.817 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T17:37:48.817Z,1770917868.817 [keepstation:NeedComms] Stopped 2026-02-12T17:37:48.817Z,1770917868.817 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T17:37:48.817Z,1770917868.817 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T17:37:48.817Z,1770917868.817 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:B] Stopped 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T17:37:49.166Z,1770917869.166 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T17:37:49.571Z,1770917869.571 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T17:37:49.571Z,1770917869.571 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T17:37:49.571Z,1770917869.571 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T17:37:49.572Z,1770917869.572 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T17:37:49.572Z,1770917869.572 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T17:37:49.572Z,1770917869.572 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T17:37:49.572Z,1770917869.572 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T17:37:49.572Z,1770917869.572 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T17:37:49.981Z,1770917869.981 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T17:37:49.981Z,1770917869.981 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T17:37:49.981Z,1770917869.981 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T17:37:49.981Z,1770917869.981 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T17:37:49.981Z,1770917869.981 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T17:37:49.981Z,1770917869.981 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T17:37:50.373Z,1770917870.373 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T17:37:50.373Z,1770917870.373 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-02-12T17:37:50.373Z,1770917870.373 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T17:37:50.373Z,1770917870.373 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T17:37:50.374Z,1770917870.374 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T17:37:50.374Z,1770917870.374 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T17:37:50.374Z,1770917870.374 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T17:37:50.784Z,1770917870.784 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T17:37:50.784Z,1770917870.784 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T17:37:50.784Z,1770917870.784 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T17:37:50.784Z,1770917870.784 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T17:37:50.785Z,1770917870.785 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T17:37:50.787Z,1770917870.787 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T17:37:50.787Z,1770917870.787 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T17:37:50.787Z,1770917870.787 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T17:37:50.787Z,1770917870.787 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T17:37:50.787Z,1770917870.787 [keepstation:SurfaceComms] Stopped 2026-02-12T17:37:50.792Z,1770917870.792 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T17:38:20.266Z,1770917900.266 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:47:48.133Z,1770918468.133 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T17:47:48.133Z,1770918468.133 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T17:47:48.134Z,1770918468.134 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T17:47:48.134Z,1770918468.134 [keepstation:SurfaceComms:A] Stopped 2026-02-12T17:47:48.134Z,1770918468.134 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T17:47:48.134Z,1770918468.134 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T17:47:48.541Z,1770918468.541 [keepstation:KeepStation:Dive] Stopped 2026-02-12T17:47:48.541Z,1770918468.541 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T17:47:48.541Z,1770918468.541 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T17:47:48.541Z,1770918468.541 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T17:47:48.542Z,1770918468.542 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T17:47:48.542Z,1770918468.542 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T17:47:48.542Z,1770918468.542 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T17:47:48.542Z,1770918468.542 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T17:47:48.542Z,1770918468.542 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T17:47:48.542Z,1770918468.542 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T17:47:48.544Z,1770918468.544 [keepstation:NeedComms] Running Loop=1 2026-02-12T17:47:48.544Z,1770918468.544 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T17:47:48.544Z,1770918468.544 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T17:47:48.544Z,1770918468.544 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T17:47:48.544Z,1770918468.544 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T17:47:48.545Z,1770918468.545 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T17:47:48.545Z,1770918468.545 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T17:47:48.545Z,1770918468.545 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T17:47:48.546Z,1770918468.546 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T17:47:48.546Z,1770918468.546 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T17:47:48.546Z,1770918468.546 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T17:47:48.547Z,1770918468.547 [keepstation:NeedComms:A](INFO): last time_fix was: 1770917872.000000 second since 1970/01/01T00:00:00Z 2026-02-12T17:47:48.548Z,1770918468.548 [keepstation:NeedComms:A] Stopped 2026-02-12T17:47:48.548Z,1770918468.548 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T17:47:48.548Z,1770918468.548 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T17:47:48.548Z,1770918468.548 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T17:47:48.957Z,1770918468.957 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T17:47:48.957Z,1770918468.957 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T17:47:49.375Z,1770918469.375 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T17:47:49.375Z,1770918469.375 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T17:47:49.375Z,1770918469.375 [keepstation:NeedComms:setActive] Stopped 2026-02-12T17:47:49.375Z,1770918469.375 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T17:47:49.750Z,1770918469.750 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T17:47:51.767Z,1770918471.767 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174756.00,A,3647.98314,N,12150.77172,W,0.972,56.49,120226,,,D*4A 2026-02-12T17:47:51.769Z,1770918471.769 [NAL9602](INFO): GPS fix at 20260212T174756: (36.799719, -121.846195) 2026-02-12T17:47:51.782Z,1770918471.782 [keepstation:NeedComms:D] Stopped 2026-02-12T17:47:51.783Z,1770918471.783 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T17:47:59.631Z,1770918479.631 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260212T170415/Courier0027.lzma 2026-02-12T17:48:00.633Z,1770918480.633 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0027.lzma.bak 2026-02-12T17:48:00.634Z,1770918480.634 [DataOverHttps](INFO): SBD MOMSN=26653992 2026-02-12T17:48:01.054Z,1770918481.054 [NAL9602](INFO): SBD MO Status=0, MOMSN=31254, MT Status=0, MTMSN=0 2026-02-12T17:48:01.054Z,1770918481.054 [NAL9602](INFO): No messages in MT queue 2026-02-12T17:48:16.711Z,1770918496.711 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20260212T170415/Express0028.lzma 2026-02-12T17:48:17.714Z,1770918497.714 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0028.lzma.bak 2026-02-12T17:48:17.714Z,1770918497.714 [DataOverHttps](INFO): SBD MOMSN=26653995 2026-02-12T17:48:19.243Z,1770918499.243 [keepstation:NeedComms:E] Stopped 2026-02-12T17:48:19.243Z,1770918499.243 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T17:48:21.271Z,1770918501.271 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174825.00,A,3647.98591,N,12150.77019,W,0.564,36.28,120226,,,D*4C 2026-02-12T17:48:21.286Z,1770918501.286 [NAL9602](INFO): GPS fix at 20260212T174825: (36.799765, -121.846170) 2026-02-12T17:48:21.323Z,1770918501.323 [keepstation:NeedComms:F] Stopped 2026-02-12T17:48:21.363Z,1770918501.363 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T17:48:21.368Z,1770918501.368 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:48:21.368Z,1770918501.368 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T17:48:21.752Z,1770918501.752 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T17:48:22.139Z,1770918502.139 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T17:48:22.139Z,1770918502.139 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T17:48:22.139Z,1770918502.139 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T17:48:22.139Z,1770918502.139 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T17:48:22.180Z,1770918502.180 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T17:48:22.180Z,1770918502.180 [keepstation:NeedComms] Stopped 2026-02-12T17:48:22.180Z,1770918502.180 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T17:48:22.180Z,1770918502.180 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T17:48:22.180Z,1770918502.180 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T17:48:22.565Z,1770918502.565 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T17:48:22.565Z,1770918502.565 [keepstation:SurfaceComms:B] Stopped 2026-02-12T17:48:22.565Z,1770918502.565 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T17:48:22.565Z,1770918502.565 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T17:48:22.566Z,1770918502.566 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T17:48:22.566Z,1770918502.566 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T17:48:22.566Z,1770918502.566 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T17:48:22.566Z,1770918502.566 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T17:48:22.947Z,1770918502.947 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T17:48:23.387Z,1770918503.387 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T17:48:23.400Z,1770918503.400 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T17:48:23.400Z,1770918503.400 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T17:48:23.400Z,1770918503.400 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T17:48:23.400Z,1770918503.400 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T17:48:23.400Z,1770918503.400 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T17:48:23.783Z,1770918503.783 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T17:48:24.177Z,1770918504.177 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T17:48:24.177Z,1770918504.177 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T17:48:24.177Z,1770918504.177 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T17:48:24.177Z,1770918504.177 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T17:48:24.177Z,1770918504.177 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T17:48:24.178Z,1770918504.178 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T17:48:24.178Z,1770918504.178 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T17:48:24.178Z,1770918504.178 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T17:48:24.178Z,1770918504.178 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T17:48:24.178Z,1770918504.178 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T17:48:24.178Z,1770918504.178 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T17:48:24.179Z,1770918504.179 [keepstation:DiveCmd:StationKeep:C.KeepStation](INFO): Rest->Waypoint 2026-02-12T17:48:24.217Z,1770918504.217 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T17:48:24.217Z,1770918504.217 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T17:48:24.217Z,1770918504.217 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T17:48:24.218Z,1770918504.218 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T17:48:24.218Z,1770918504.218 [keepstation:SurfaceComms] Stopped 2026-02-12T17:48:24.218Z,1770918504.218 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T17:48:53.281Z,1770918533.281 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T17:50:20.424Z,1770918620.424 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:50:25.150Z,1770918625.150 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-02-12T17:50:38.248Z,1770918638.248 [Radio_Surface](INFO): Powering down 2026-02-12T17:50:51.548Z,1770918651.548 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T17:50:52.552Z,1770918652.552 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-02-12T17:52:27.932Z,1770918747.932 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.719345 2026-02-12T17:58:21.442Z,1770919101.442 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T17:58:21.442Z,1770919101.442 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T17:58:21.443Z,1770919101.443 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T17:58:21.443Z,1770919101.443 [keepstation:SurfaceComms:A] Stopped 2026-02-12T17:58:21.443Z,1770919101.443 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T17:58:21.443Z,1770919101.443 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T17:58:21.845Z,1770919101.845 [keepstation:KeepStation:Dive] Stopped 2026-02-12T17:58:21.845Z,1770919101.845 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T17:58:21.845Z,1770919101.845 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T17:58:21.845Z,1770919101.845 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T17:58:21.846Z,1770919101.846 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T17:58:21.846Z,1770919101.846 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T17:58:21.846Z,1770919101.846 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T17:58:21.846Z,1770919101.846 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T17:58:21.846Z,1770919101.846 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T17:58:21.846Z,1770919101.846 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T17:58:21.848Z,1770919101.848 [keepstation:NeedComms] Running Loop=1 2026-02-12T17:58:21.848Z,1770919101.848 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T17:58:21.848Z,1770919101.848 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T17:58:21.848Z,1770919101.848 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T17:58:21.849Z,1770919101.849 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T17:58:21.849Z,1770919101.849 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T17:58:21.849Z,1770919101.849 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T17:58:21.850Z,1770919101.850 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T17:58:21.850Z,1770919101.850 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T17:58:21.850Z,1770919101.850 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T17:58:21.850Z,1770919101.850 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T17:58:21.852Z,1770919101.852 [keepstation:NeedComms:A](INFO): last time_fix was: 1770918505.000000 second since 1970/01/01T00:00:00Z 2026-02-12T17:58:21.852Z,1770919101.852 [keepstation:NeedComms:A] Stopped 2026-02-12T17:58:21.852Z,1770919101.852 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T17:58:21.853Z,1770919101.853 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T17:58:21.853Z,1770919101.853 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T17:58:22.259Z,1770919102.259 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T17:58:22.259Z,1770919102.259 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T17:58:22.666Z,1770919102.666 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T17:58:22.666Z,1770919102.666 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T17:58:22.667Z,1770919102.667 [keepstation:NeedComms:setActive] Stopped 2026-02-12T17:58:22.667Z,1770919102.667 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T18:00:14.499Z,1770919214.499 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T18:00:15.204Z,1770919215.204 [Radio_Surface](INFO): Powering up 2026-02-12T18:00:20.877Z,1770919220.877 [DataOverHttps](INFO): Radio surface powered ON. 2026-02-12T18:00:29.906Z,1770919229.906 [NAL9602](INFO): SBD MO Status=0, MOMSN=31255, MT Status=0, MTMSN=0 2026-02-12T18:00:29.907Z,1770919229.907 [NAL9602](INFO): No messages in MT queue 2026-02-12T18:00:31.102Z,1770919231.102 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180035.00,A,3647.79907,N,12150.82722,W,0.467,147.51,120226,,,A*79 2026-02-12T18:00:31.105Z,1770919231.105 [NAL9602](INFO): GPS fix at 20260212T180035: (36.796651, -121.847120) 2026-02-12T18:00:31.118Z,1770919231.118 [keepstation:NeedComms:D] Stopped 2026-02-12T18:00:31.118Z,1770919231.118 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T18:00:47.882Z,1770919247.882 [NAL9602](INFO): SBD MO Status=1, MOMSN=31256, MT Status=0, MTMSN=0 2026-02-12T18:00:47.948Z,1770919247.948 [NAL9602](INFO): Sent 74 bytes from file Logs/20260212T170415/Courier0030.lzma 2026-02-12T18:00:47.948Z,1770919247.948 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:00:50.996Z,1770919250.996 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:00:57.743Z,1770919257.743 [NAL9602](INFO): SBD MO Status=1, MOMSN=31257, MT Status=0, MTMSN=0 2026-02-12T18:00:57.792Z,1770919257.792 [NAL9602](INFO): Sent 244 bytes from file Logs/20260212T170415/Express0031.lzma 2026-02-12T18:00:57.792Z,1770919257.792 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:01:07.846Z,1770919267.846 [NAL9602](INFO): SBD MO Status=0, MOMSN=31258, MT Status=0, MTMSN=0 2026-02-12T18:01:07.946Z,1770919267.946 [keepstation:NeedComms:E] Stopped 2026-02-12T18:01:07.947Z,1770919267.947 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T18:01:10.267Z,1770919270.267 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180114.00,A,3647.80006,N,12150.82337,W,0.603,121.34,120226,,,A*76 2026-02-12T18:01:10.270Z,1770919270.270 [NAL9602](INFO): GPS fix at 20260212T180114: (36.796668, -121.847056) 2026-02-12T18:01:10.283Z,1770919270.283 [keepstation:NeedComms:F] Stopped 2026-02-12T18:01:10.283Z,1770919270.283 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T18:01:10.283Z,1770919270.283 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:01:10.283Z,1770919270.283 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T18:01:10.711Z,1770919270.711 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T18:01:10.711Z,1770919270.711 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T18:01:10.711Z,1770919270.711 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T18:01:10.711Z,1770919270.711 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:01:10.712Z,1770919270.712 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T18:01:10.712Z,1770919270.712 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T18:01:10.712Z,1770919270.712 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T18:01:11.106Z,1770919271.106 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T18:01:11.106Z,1770919271.106 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T18:01:11.106Z,1770919271.106 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T18:01:11.106Z,1770919271.106 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T18:01:11.107Z,1770919271.107 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T18:01:11.107Z,1770919271.107 [keepstation:NeedComms] Stopped 2026-02-12T18:01:11.107Z,1770919271.107 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T18:01:11.107Z,1770919271.107 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T18:01:11.107Z,1770919271.107 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T18:01:11.497Z,1770919271.497 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T18:01:11.497Z,1770919271.497 [keepstation:SurfaceComms:B] Stopped 2026-02-12T18:01:11.498Z,1770919271.498 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T18:01:11.498Z,1770919271.498 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T18:01:11.498Z,1770919271.498 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:01:11.498Z,1770919271.498 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T18:01:11.498Z,1770919271.498 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:01:11.498Z,1770919271.498 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T18:01:11.896Z,1770919271.896 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.20 m/s, pitch 20.00 deg, mass-position -4.06 mm. 2026-02-12T18:01:11.897Z,1770919271.897 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -18.00 mm. 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T18:01:11.903Z,1770919271.903 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T18:01:12.305Z,1770919272.305 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T18:01:12.305Z,1770919272.305 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T18:01:12.305Z,1770919272.305 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T18:01:12.306Z,1770919272.306 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T18:01:12.306Z,1770919272.306 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T18:01:12.306Z,1770919272.306 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T18:01:12.721Z,1770919272.721 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T18:01:13.112Z,1770919273.112 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T18:01:13.113Z,1770919273.113 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T18:01:13.113Z,1770919273.113 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T18:01:13.113Z,1770919273.113 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T18:01:13.113Z,1770919273.113 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T18:01:13.113Z,1770919273.113 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T18:01:13.113Z,1770919273.114 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T18:01:13.114Z,1770919273.114 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T18:01:13.114Z,1770919273.114 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T18:01:13.114Z,1770919273.114 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T18:01:13.114Z,1770919273.114 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T18:01:13.115Z,1770919273.115 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T18:01:13.116Z,1770919273.116 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T18:01:13.116Z,1770919273.116 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T18:01:13.116Z,1770919273.116 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T18:01:13.116Z,1770919273.116 [keepstation:SurfaceComms] Stopped 2026-02-12T18:01:13.116Z,1770919273.116 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T18:01:22.140Z,1770919282.140 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:01:26.423Z,1770919286.423 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2026-02-12T18:01:42.187Z,1770919302.187 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T18:01:53.265Z,1770919313.265 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:02:24.388Z,1770919344.388 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:02:55.512Z,1770919375.512 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:03:26.636Z,1770919406.636 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:03:57.760Z,1770919437.760 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:04:06.269Z,1770919446.269 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003454 2026-02-12T18:08:38.969Z,1770919718.969 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-02-12T18:10:49.736Z,1770919849.736 [BPC1](ERROR): Battery stick #8 (s/n: 01E7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.737Z,1770919849.737 [BPC1](ERROR): Battery stick #16 (s/n: 00F8) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.738Z,1770919849.738 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-12T18:10:49.739Z,1770919849.739 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C7. 2026-02-12T18:10:49.739Z,1770919849.739 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-12T18:10:49.740Z,1770919849.740 [BPC1](ERROR): Battery stick #37 (s/n: 0181) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.741Z,1770919849.741 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.742Z,1770919849.742 [BPC1](ERROR): Battery stick #39 (s/n: 0189) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.742Z,1770919849.742 [BPC1](ERROR): Battery stick #40 (s/n: 01A4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.743Z,1770919849.743 [BPC1](ERROR): Battery stick #44 (s/n: 01BB) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.745Z,1770919849.745 [BPC1](ERROR): Battery stick #50 (s/n: 019C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.745Z,1770919849.745 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.746Z,1770919849.746 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.747Z,1770919849.747 [BPC1](ERROR): Battery stick #53 (s/n: 01EE) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.747Z,1770919849.747 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:10:49.748Z,1770919849.748 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x5AD0. 2026-02-12T18:10:49.749Z,1770919849.749 [BPC1](INFO): Calculating totals. Valid battery stick count: 37. Valid reserve battery stick count: 2. 2026-02-12T18:10:49.753Z,1770919849.753 [BPC1](FAULT): Failed to receive data from 20 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 8, 9, 10, 11, 14, 16, 17, 24, 29, 37, 38, 39, 40, 44, 50, 51, 52, 53, 57, 59. 2026-02-12T18:11:10.353Z,1770919870.353 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T18:11:10.353Z,1770919870.353 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T18:11:10.354Z,1770919870.354 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T18:11:10.355Z,1770919870.355 [keepstation:SurfaceComms:A] Stopped 2026-02-12T18:11:10.355Z,1770919870.355 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T18:11:10.357Z,1770919870.357 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T18:11:10.358Z,1770919870.358 [keepstation:NeedComms] Running Loop=1 2026-02-12T18:11:10.358Z,1770919870.358 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T18:11:10.358Z,1770919870.358 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T18:11:10.361Z,1770919870.361 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T18:11:10.361Z,1770919870.361 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T18:11:10.361Z,1770919870.361 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T18:11:10.362Z,1770919870.362 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T18:11:10.362Z,1770919870.362 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T18:11:10.362Z,1770919870.362 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T18:11:10.363Z,1770919870.363 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T18:11:10.363Z,1770919870.363 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T18:11:10.365Z,1770919870.365 [keepstation:NeedComms:A](INFO): last time_fix was: 1770919274.000000 second since 1970/01/01T00:00:00Z 2026-02-12T18:11:10.365Z,1770919870.365 [keepstation:NeedComms:A] Stopped 2026-02-12T18:11:10.365Z,1770919870.365 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T18:11:10.365Z,1770919870.365 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T18:11:10.365Z,1770919870.365 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T18:11:10.765Z,1770919870.765 [keepstation:KeepStation:Dive] Stopped 2026-02-12T18:11:10.765Z,1770919870.765 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T18:11:10.765Z,1770919870.765 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T18:11:10.765Z,1770919870.765 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T18:11:10.766Z,1770919870.766 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T18:11:10.766Z,1770919870.766 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T18:11:10.766Z,1770919870.766 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T18:11:10.766Z,1770919870.766 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T18:11:10.766Z,1770919870.766 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T18:11:10.766Z,1770919870.766 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T18:11:10.769Z,1770919870.769 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T18:11:10.769Z,1770919870.769 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T18:11:11.178Z,1770919871.178 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T18:11:11.178Z,1770919871.178 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T18:11:11.178Z,1770919871.178 [keepstation:NeedComms:setActive] Stopped 2026-02-12T18:11:11.178Z,1770919871.178 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T18:11:11.572Z,1770919871.572 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T18:11:37.324Z,1770919897.324 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:12:05.690Z,1770919925.690 [NAL9602](INFO): SBD MO Status=0, MOMSN=31259, MT Status=0, MTMSN=0 2026-02-12T18:12:05.690Z,1770919925.690 [NAL9602](INFO): No messages in MT queue 2026-02-12T18:12:06.902Z,1770919926.902 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181211.00,A,3647.86161,N,12150.78411,W,1.302,61.02,120226,,,D*41 2026-02-12T18:12:06.904Z,1770919926.904 [NAL9602](INFO): GPS fix at 20260212T181211: (36.797694, -121.846402) 2026-02-12T18:12:06.918Z,1770919926.918 [keepstation:NeedComms:D] Stopped 2026-02-12T18:12:06.918Z,1770919926.918 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T18:12:08.448Z,1770919928.448 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:12:28.099Z,1770919948.099 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20260212T170415/Courier0033.lzma 2026-02-12T18:12:29.102Z,1770919949.102 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0033.lzma.bak 2026-02-12T18:12:29.102Z,1770919949.102 [DataOverHttps](INFO): SBD MOMSN=26654056 2026-02-12T18:12:39.353Z,1770919959.353 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T18:12:48.272Z,1770919968.272 [DataOverHttps](INFO): Sending 302 bytes from file Logs/20260212T170415/Express0034.lzma 2026-02-12T18:12:49.274Z,1770919969.274 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0034.lzma.bak 2026-02-12T18:12:49.274Z,1770919969.274 [DataOverHttps](INFO): SBD MOMSN=26654060 2026-02-12T18:12:50.705Z,1770919970.705 [keepstation:NeedComms:E] Stopped 2026-02-12T18:12:50.706Z,1770919970.706 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T18:12:52.695Z,1770919972.695 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181257.00,A,3647.86499,N,12150.78162,W,1.127,28.10,120226,,,D*4B 2026-02-12T18:12:52.697Z,1770919972.697 [NAL9602](INFO): GPS fix at 20260212T181257: (36.797750, -121.846360) 2026-02-12T18:12:52.719Z,1770919972.719 [keepstation:NeedComms:F] Stopped 2026-02-12T18:12:52.719Z,1770919972.719 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T18:12:52.719Z,1770919972.719 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:12:52.719Z,1770919972.719 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T18:12:53.143Z,1770919973.143 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T18:12:53.536Z,1770919973.536 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T18:12:53.537Z,1770919973.537 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T18:12:53.537Z,1770919973.537 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T18:12:53.537Z,1770919973.537 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T18:12:53.537Z,1770919973.537 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T18:12:53.538Z,1770919973.538 [keepstation:NeedComms] Stopped 2026-02-12T18:12:53.538Z,1770919973.538 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T18:12:53.538Z,1770919973.538 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T18:12:53.538Z,1770919973.538 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T18:12:53.946Z,1770919973.946 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T18:12:53.946Z,1770919973.946 [keepstation:SurfaceComms:B] Stopped 2026-02-12T18:12:53.946Z,1770919973.946 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T18:12:53.946Z,1770919973.946 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T18:12:53.946Z,1770919973.946 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:12:53.946Z,1770919973.946 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T18:12:53.947Z,1770919973.947 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:12:53.947Z,1770919973.947 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T18:12:54.337Z,1770919974.337 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T18:12:54.337Z,1770919974.337 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:12:54.337Z,1770919974.337 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T18:12:54.337Z,1770919974.337 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:12:54.337Z,1770919974.337 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T18:12:54.337Z,1770919974.337 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T18:12:54.338Z,1770919974.338 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T18:12:54.338Z,1770919974.338 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T18:12:54.754Z,1770919974.754 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T18:12:54.754Z,1770919974.754 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T18:12:54.754Z,1770919974.754 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T18:12:54.754Z,1770919974.754 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T18:12:54.754Z,1770919974.754 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T18:12:54.754Z,1770919974.754 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T18:12:55.150Z,1770919975.150 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T18:12:55.560Z,1770919975.560 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T18:12:55.561Z,1770919975.561 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T18:12:55.561Z,1770919975.561 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T18:12:55.561Z,1770919975.561 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T18:12:55.561Z,1770919975.561 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T18:12:55.561Z,1770919975.561 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T18:12:55.561Z,1770919975.561 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T18:12:55.562Z,1770919975.562 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T18:12:55.562Z,1770919975.562 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T18:12:55.562Z,1770919975.562 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T18:12:55.562Z,1770919975.562 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T18:12:55.563Z,1770919975.563 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T18:12:55.568Z,1770919975.568 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T18:12:55.568Z,1770919975.568 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T18:12:55.568Z,1770919975.568 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T18:12:55.568Z,1770919975.568 [keepstation:SurfaceComms] Stopped 2026-02-12T18:12:55.568Z,1770919975.568 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T18:13:16.938Z,1770919996.938 [NAL9602](INFO): SBD MO Status=0, MOMSN=31260, MT Status=0, MTMSN=0 2026-02-12T18:13:16.938Z,1770919996.938 [NAL9602](INFO): No messages in MT queue 2026-02-12T18:13:47.637Z,1770920027.637 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T18:18:57.332Z,1770920337.332 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:19:28.457Z,1770920368.457 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:19:33.696Z,1770920373.696 [Radio_Surface](INFO): Powering down 2026-02-12T18:19:59.584Z,1770920399.584 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:20:00.588Z,1770920400.588 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-02-12T18:21:04.860Z,1770920464.860 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.739288 2026-02-12T18:22:53.067Z,1770920573.067 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T18:22:53.067Z,1770920573.067 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T18:22:53.080Z,1770920573.080 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T18:22:53.080Z,1770920573.080 [keepstation:SurfaceComms:A] Stopped 2026-02-12T18:22:53.080Z,1770920573.080 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T18:22:53.081Z,1770920573.081 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T18:22:53.455Z,1770920573.455 [keepstation:KeepStation:Dive] Stopped 2026-02-12T18:22:53.456Z,1770920573.456 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T18:22:53.456Z,1770920573.456 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T18:22:53.456Z,1770920573.456 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T18:22:53.456Z,1770920573.456 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T18:22:53.457Z,1770920573.457 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T18:22:53.457Z,1770920573.457 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T18:22:53.457Z,1770920573.457 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T18:22:53.457Z,1770920573.457 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T18:22:53.457Z,1770920573.457 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T18:22:53.458Z,1770920573.458 [keepstation:NeedComms] Running Loop=1 2026-02-12T18:22:53.459Z,1770920573.459 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T18:22:53.459Z,1770920573.459 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T18:22:53.459Z,1770920573.459 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T18:22:53.459Z,1770920573.459 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T18:22:53.459Z,1770920573.459 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T18:22:53.460Z,1770920573.460 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T18:22:53.460Z,1770920573.460 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T18:22:53.461Z,1770920573.461 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T18:22:53.461Z,1770920573.461 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T18:22:53.461Z,1770920573.461 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T18:22:53.463Z,1770920573.463 [keepstation:NeedComms:A](INFO): last time_fix was: 1770919977.000000 second since 1970/01/01T00:00:00Z 2026-02-12T18:22:53.463Z,1770920573.463 [keepstation:NeedComms:A] Stopped 2026-02-12T18:22:53.463Z,1770920573.463 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T18:22:53.463Z,1770920573.463 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T18:22:53.463Z,1770920573.463 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T18:22:53.866Z,1770920573.866 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T18:22:53.866Z,1770920573.866 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T18:22:54.258Z,1770920574.258 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T18:22:54.258Z,1770920574.258 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T18:22:54.259Z,1770920574.259 [keepstation:NeedComms:setActive] Stopped 2026-02-12T18:22:54.259Z,1770920574.259 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T18:23:51.338Z,1770920631.338 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T18:23:51.856Z,1770920631.856 [Radio_Surface](INFO): Powering up 2026-02-12T18:23:57.565Z,1770920637.565 [DataOverHttps](INFO): Radio surface powered ON. 2026-02-12T18:24:20.494Z,1770920660.494 [NAL9602](INFO): SBD MO Status=0, MOMSN=31261, MT Status=0, MTMSN=0 2026-02-12T18:24:20.494Z,1770920660.494 [NAL9602](INFO): No messages in MT queue 2026-02-12T18:24:21.700Z,1770920661.700 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182426.00,A,3647.90922,N,12150.72360,W,0.292,88.96,120226,,,D*40 2026-02-12T18:24:21.703Z,1770920661.703 [NAL9602](INFO): GPS fix at 20260212T182426: (36.798487, -121.845393) 2026-02-12T18:24:21.716Z,1770920661.716 [keepstation:NeedComms:D] Stopped 2026-02-12T18:24:21.716Z,1770920661.716 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T18:24:27.716Z,1770920667.716 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:24:33.934Z,1770920673.934 [NAL9602](INFO): SBD MO Status=1, MOMSN=31262, MT Status=0, MTMSN=0 2026-02-12T18:24:33.984Z,1770920673.984 [NAL9602](INFO): Sent 74 bytes from file Logs/20260212T170415/Courier0036.lzma 2026-02-12T18:24:33.984Z,1770920673.984 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:24:44.251Z,1770920684.251 [NAL9602](INFO): SBD MO Status=1, MOMSN=31263, MT Status=0, MTMSN=0 2026-02-12T18:24:44.301Z,1770920684.301 [NAL9602](INFO): Sent 205 bytes from file Logs/20260212T170415/Express0037.lzma 2026-02-12T18:24:44.301Z,1770920684.301 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:24:54.691Z,1770920694.691 [NAL9602](INFO): SBD MO Status=0, MOMSN=31264, MT Status=0, MTMSN=0 2026-02-12T18:24:54.771Z,1770920694.771 [keepstation:NeedComms:E] Stopped 2026-02-12T18:24:54.788Z,1770920694.788 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T18:24:57.123Z,1770920697.123 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182501.00,A,3647.91056,N,12150.72075,W,0.330,32.73,120226,,,D*4B 2026-02-12T18:24:57.126Z,1770920697.126 [NAL9602](INFO): GPS fix at 20260212T182501: (36.798509, -121.845346) 2026-02-12T18:24:57.139Z,1770920697.139 [keepstation:NeedComms:F] Stopped 2026-02-12T18:24:57.139Z,1770920697.139 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T18:24:57.139Z,1770920697.139 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:24:57.139Z,1770920697.139 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T18:24:57.558Z,1770920697.558 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T18:24:57.558Z,1770920697.558 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T18:24:57.558Z,1770920697.558 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T18:24:57.558Z,1770920697.558 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:24:57.559Z,1770920697.559 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T18:24:57.559Z,1770920697.559 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T18:24:57.559Z,1770920697.559 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T18:24:57.000Z,1770920698.000 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T18:24:58.000Z,1770920698.000 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T18:24:58.000Z,1770920698.000 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T18:24:58.000Z,1770920698.000 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T18:24:58.001Z,1770920698.001 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T18:24:58.001Z,1770920698.001 [keepstation:NeedComms] Stopped 2026-02-12T18:24:58.001Z,1770920698.001 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T18:24:58.001Z,1770920698.001 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T18:24:58.001Z,1770920698.001 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T18:24:58.345Z,1770920698.345 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T18:24:58.345Z,1770920698.345 [keepstation:SurfaceComms:B] Stopped 2026-02-12T18:24:58.345Z,1770920698.345 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T18:24:58.345Z,1770920698.345 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T18:24:58.346Z,1770920698.346 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:24:58.346Z,1770920698.346 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T18:24:58.346Z,1770920698.346 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:24:58.346Z,1770920698.346 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T18:24:58.770Z,1770920698.770 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T18:24:58.841Z,1770920698.841 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:24:59.169Z,1770920699.169 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T18:24:59.169Z,1770920699.169 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T18:24:59.169Z,1770920699.169 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T18:24:59.169Z,1770920699.169 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T18:24:59.169Z,1770920699.169 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T18:24:59.170Z,1770920699.170 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T18:24:59.553Z,1770920699.553 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T18:24:59.553Z,1770920699.553 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-02-12T18:24:59.553Z,1770920699.553 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T18:24:59.553Z,1770920699.553 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T18:24:59.554Z,1770920699.554 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T18:24:59.554Z,1770920699.554 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T18:24:59.554Z,1770920699.554 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T18:24:59.955Z,1770920699.955 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T18:24:59.955Z,1770920699.955 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T18:24:59.955Z,1770920699.955 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T18:24:59.955Z,1770920699.955 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T18:24:59.955Z,1770920699.955 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T18:24:59.956Z,1770920699.956 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T18:24:59.956Z,1770920699.956 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T18:24:59.956Z,1770920699.956 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T18:24:59.956Z,1770920699.956 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T18:24:59.956Z,1770920699.956 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T18:24:59.956Z,1770920699.956 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T18:24:59.957Z,1770920699.957 [keepstation:DiveCmd:StationKeep:C.KeepStation](INFO): Rest->Waypoint 2026-02-12T18:24:59.959Z,1770920699.959 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T18:24:59.959Z,1770920699.959 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T18:24:59.959Z,1770920699.959 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T18:24:59.959Z,1770920699.959 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T18:24:59.959Z,1770920699.959 [keepstation:SurfaceComms] Stopped 2026-02-12T18:24:59.959Z,1770920699.959 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T18:25:29.229Z,1770920729.229 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T18:25:29.972Z,1770920729.972 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:26:01.096Z,1770920761.096 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:26:12.084Z,1770920772.084 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.75 m/s, pitch 20.00 deg, mass-position -4.06 mm (1 active estimators). 2026-02-12T18:26:32.250Z,1770920792.250 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:27:03.372Z,1770920823.372 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:27:12.344Z,1770920832.344 [Radio_Surface](INFO): Powering down 2026-02-12T18:27:34.497Z,1770920854.497 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:27:35.500Z,1770920855.500 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-02-12T18:30:17.711Z,1770921017.711 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2026-02-12T18:34:57.293Z,1770921297.293 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T18:34:57.294Z,1770921297.294 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T18:34:57.294Z,1770921297.294 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T18:34:57.294Z,1770921297.294 [keepstation:SurfaceComms:A] Stopped 2026-02-12T18:34:57.294Z,1770921297.294 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T18:34:57.295Z,1770921297.295 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T18:34:57.698Z,1770921297.698 [keepstation:KeepStation:Dive] Stopped 2026-02-12T18:34:57.698Z,1770921297.698 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T18:34:57.698Z,1770921297.698 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T18:34:57.698Z,1770921297.698 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T18:34:57.698Z,1770921297.698 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T18:34:57.699Z,1770921297.699 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T18:34:57.699Z,1770921297.699 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T18:34:57.699Z,1770921297.699 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T18:34:57.699Z,1770921297.699 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T18:34:57.699Z,1770921297.699 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T18:34:57.701Z,1770921297.701 [keepstation:NeedComms] Running Loop=1 2026-02-12T18:34:57.701Z,1770921297.701 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T18:34:57.701Z,1770921297.701 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T18:34:57.701Z,1770921297.701 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T18:34:57.701Z,1770921297.701 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T18:34:57.702Z,1770921297.702 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T18:34:57.702Z,1770921297.702 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T18:34:57.702Z,1770921297.702 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T18:34:57.703Z,1770921297.703 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T18:34:57.703Z,1770921297.703 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T18:34:57.703Z,1770921297.703 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T18:34:57.705Z,1770921297.705 [keepstation:NeedComms:A](INFO): last time_fix was: 1770920701.000000 second since 1970/01/01T00:00:00Z 2026-02-12T18:34:57.705Z,1770921297.705 [keepstation:NeedComms:A] Stopped 2026-02-12T18:34:57.705Z,1770921297.705 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T18:34:57.705Z,1770921297.705 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T18:34:57.705Z,1770921297.705 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T18:34:58.120Z,1770921298.120 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T18:34:58.120Z,1770921298.120 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T18:34:58.507Z,1770921298.507 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T18:34:58.507Z,1770921298.507 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T18:34:58.507Z,1770921298.507 [keepstation:NeedComms:setActive] Stopped 2026-02-12T18:34:58.507Z,1770921298.507 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T18:36:49.942Z,1770921409.942 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T18:36:50.569Z,1770921410.569 [Radio_Surface](INFO): Powering up 2026-02-12T18:36:56.816Z,1770921416.816 [DataOverHttps](INFO): Radio surface powered ON. 2026-02-12T18:37:26.374Z,1770921446.374 [NAL9602](INFO): SBD MO Status=2, MOMSN=31265, MT Status=2, MTMSN=0 2026-02-12T18:37:26.374Z,1770921446.374 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-12T18:37:26.944Z,1770921446.944 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:37:44.154Z,1770921464.154 [NAL9602](INFO): SBD MO Status=0, MOMSN=31265, MT Status=0, MTMSN=0 2026-02-12T18:37:44.154Z,1770921464.154 [NAL9602](INFO): No messages in MT queue 2026-02-12T18:37:45.365Z,1770921465.365 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183749.00,A,3647.77791,N,12150.89168,W,0.408,321.83,120226,,,A*7E 2026-02-12T18:37:45.367Z,1770921465.367 [NAL9602](INFO): GPS fix at 20260212T183749: (36.796298, -121.848195) 2026-02-12T18:37:45.381Z,1770921465.381 [keepstation:NeedComms:D] Stopped 2026-02-12T18:37:45.381Z,1770921465.381 [keepstation:NeedComms:E] Running Loop=1 2026-02-12T18:37:58.068Z,1770921478.068 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:38:01.634Z,1770921481.634 [NAL9602](INFO): SBD MO Status=1, MOMSN=31266, MT Status=0, MTMSN=0 2026-02-12T18:38:01.684Z,1770921481.684 [NAL9602](INFO): Sent 73 bytes from file Logs/20260212T170415/Courier0039.lzma 2026-02-12T18:38:01.684Z,1770921481.684 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:38:13.431Z,1770921493.431 [NAL9602](INFO): SBD MO Status=1, MOMSN=31267, MT Status=0, MTMSN=0 2026-02-12T18:38:13.480Z,1770921493.480 [NAL9602](INFO): Sent 248 bytes from file Logs/20260212T170415/Express0040.lzma 2026-02-12T18:38:13.480Z,1770921493.480 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:38:21.929Z,1770921501.929 [NAL9602](INFO): SBD MO Status=0, MOMSN=31268, MT Status=0, MTMSN=0 2026-02-12T18:38:22.018Z,1770921502.018 [keepstation:NeedComms:E] Stopped 2026-02-12T18:38:22.018Z,1770921502.018 [keepstation:NeedComms:F] Running Loop=1 2026-02-12T18:38:24.339Z,1770921504.339 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183829.00,A,3647.78051,N,12150.89115,W,0.525,336.45,120226,,,D*7E 2026-02-12T18:38:24.342Z,1770921504.342 [NAL9602](INFO): GPS fix at 20260212T183829: (36.796342, -121.848186) 2026-02-12T18:38:24.356Z,1770921504.356 [keepstation:NeedComms:F] Stopped 2026-02-12T18:38:24.357Z,1770921504.357 [keepstation:NeedComms:setRestoreMode] Running Loop=1 2026-02-12T18:38:24.357Z,1770921504.357 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::initialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:38:24.357Z,1770921504.357 [keepstation:NeedComms:setRestoreMode:A] Running Loop=1 2026-02-12T18:38:24.768Z,1770921504.768 [keepstation:NeedComms:setRestoreMode:A] Stopped 2026-02-12T18:38:24.768Z,1770921504.768 [keepstation:NeedComms:setRestoreMode](INFO): Completed keepstation:NeedComms:setRestoreMode 2026-02-12T18:38:24.768Z,1770921504.768 [keepstation:NeedComms:setRestoreMode] Stopped 2026-02-12T18:38:24.768Z,1770921504.768 [keepstation:NeedComms:setRestoreMode](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setRestoreMode 2026-02-12T18:38:24.768Z,1770921504.768 [keepstation:NeedComms:setInactive] Running Loop=1 2026-02-12T18:38:24.768Z,1770921504.768 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::initialize keepstation:NeedComms:setInactive 2026-02-12T18:38:24.769Z,1770921504.769 [keepstation:NeedComms:setInactive:A] Running Loop=1 2026-02-12T18:38:25.158Z,1770921505.158 [keepstation:NeedComms:setInactive:A] Stopped 2026-02-12T18:38:25.158Z,1770921505.158 [keepstation:NeedComms:setInactive](INFO): Completed keepstation:NeedComms:setInactive 2026-02-12T18:38:25.158Z,1770921505.158 [keepstation:NeedComms:setInactive] Stopped 2026-02-12T18:38:25.158Z,1770921505.158 [keepstation:NeedComms:setInactive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setInactive 2026-02-12T18:38:25.159Z,1770921505.159 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2026-02-12T18:38:25.159Z,1770921505.159 [keepstation:NeedComms] Stopped 2026-02-12T18:38:25.159Z,1770921505.159 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T18:38:25.159Z,1770921505.159 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T18:38:25.159Z,1770921505.159 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T18:38:25.585Z,1770921505.585 [keepstation:SurfaceComms:B](INFO): Completed keepstation:SurfaceComms:B 2026-02-12T18:38:25.585Z,1770921505.585 [keepstation:SurfaceComms:B] Stopped 2026-02-12T18:38:25.585Z,1770921505.585 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T18:38:25.585Z,1770921505.585 [keepstation:SurfaceComms:HandleNan] Running Loop=1 2026-02-12T18:38:25.586Z,1770921505.586 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:38:25.586Z,1770921505.586 [keepstation:SurfaceComms:HandleNan:SetOnStation] Running Loop=1 2026-02-12T18:38:25.586Z,1770921505.586 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:38:25.586Z,1770921505.586 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Running Loop=1 2026-02-12T18:38:25.961Z,1770921505.961 [keepstation:SurfaceComms:HandleNan] Stopped 2026-02-12T18:38:25.961Z,1770921505.961 [keepstation:SurfaceComms:HandleNan](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan 2026-02-12T18:38:25.961Z,1770921505.961 [keepstation:SurfaceComms:HandleNan:SetOnStation] Stopped 2026-02-12T18:38:25.961Z,1770921505.961 [keepstation:SurfaceComms:HandleNan:SetOnStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:HandleNan:SetOnStation 2026-02-12T18:38:25.961Z,1770921505.961 [keepstation:SurfaceComms:HandleNan:SetOnStation:A] Stopped 2026-02-12T18:38:25.961Z,1770921505.961 [keepstation:SurfaceComms:setTransit] Running Loop=1 2026-02-12T18:38:25.962Z,1770921505.962 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setTransit 2026-02-12T18:38:25.962Z,1770921505.962 [keepstation:SurfaceComms:setTransit:A] Running Loop=1 2026-02-12T18:38:26.366Z,1770921506.366 [keepstation:SurfaceComms:setTransit] Stopped 2026-02-12T18:38:26.366Z,1770921506.366 [keepstation:SurfaceComms:setTransit](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setTransit 2026-02-12T18:38:26.366Z,1770921506.366 [keepstation:SurfaceComms:setTransit:A] Stopped 2026-02-12T18:38:26.366Z,1770921506.366 [keepstation:SurfaceComms:setStation] Running Loop=1 2026-02-12T18:38:26.366Z,1770921506.366 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setStation 2026-02-12T18:38:26.366Z,1770921506.366 [keepstation:SurfaceComms:setStation:A] Running Loop=1 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setStation:A] Stopped 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setStation](INFO): Completed keepstation:SurfaceComms:setStation 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setStation] Stopped 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setStation](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setStation 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setSink] Running Loop=1 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::initialize keepstation:SurfaceComms:setSink 2026-02-12T18:38:26.777Z,1770921506.777 [keepstation:SurfaceComms:setSink:A] Running Loop=1 2026-02-12T18:38:27.189Z,1770921507.189 [keepstation:KeepStation:Dive] Running Loop=1 2026-02-12T18:38:27.189Z,1770921507.189 [keepstation:KeepStation:Dive](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive 2026-02-12T18:38:27.189Z,1770921507.189 [keepstation:KeepStation:Dive:A] Running Loop=1 2026-02-12T18:38:27.189Z,1770921507.189 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::initialize keepstation:KeepStation:Dive:A 2026-02-12T18:38:27.190Z,1770921507.190 [keepstation:DiveCmd:StationKeep] Running Loop=1 2026-02-12T18:38:27.190Z,1770921507.190 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::initialize keepstation:DiveCmd:StationKeep 2026-02-12T18:38:27.190Z,1770921507.190 [keepstation:DiveCmd:StationKeep:A] Running Loop=1 2026-02-12T18:38:27.190Z,1770921507.190 [keepstation:DiveCmd:StationKeep:B.Pitch] Running Loop=1 2026-02-12T18:38:27.190Z,1770921507.190 [keepstation:DiveCmd:StationKeep:B.Pitch](DEBUG): Initialize. 2026-02-12T18:38:27.190Z,1770921507.190 [keepstation:DiveCmd:StationKeep:C.KeepStation] Running Loop=1 2026-02-12T18:38:27.191Z,1770921507.191 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2026-02-12T18:38:27.192Z,1770921507.192 [keepstation:SurfaceComms:setSink] Stopped 2026-02-12T18:38:27.193Z,1770921507.193 [keepstation:SurfaceComms:setSink](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:setSink 2026-02-12T18:38:27.193Z,1770921507.193 [keepstation:SurfaceComms:setSink:A] Stopped 2026-02-12T18:38:27.193Z,1770921507.193 [keepstation:SurfaceComms](INFO): Completed keepstation:SurfaceComms 2026-02-12T18:38:27.193Z,1770921507.193 [keepstation:SurfaceComms] Stopped 2026-02-12T18:38:27.193Z,1770921507.193 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T18:38:29.196Z,1770921509.196 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:38:56.269Z,1770921536.269 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T18:39:00.320Z,1770921540.320 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:39:31.444Z,1770921571.444 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:40:02.568Z,1770921602.568 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:40:33.692Z,1770921633.692 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:41:04.833Z,1770921664.833 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:41:28.536Z,1770921688.536 [Radio_Surface](INFO): Powering down 2026-02-12T18:41:35.956Z,1770921695.956 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:41:36.960Z,1770921696.960 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-02-12T18:43:18.478Z,1770921798.478 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2026-02-12T18:45:45.948Z,1770921945.948 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-02-12T18:45:50.388Z,1770921950.388 [GFScanner](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.004590 CHAN A1 (24V): 0.009594 CHAN A2 (12V): 0.003973 CHAN A3 (5V): -0.000120 CHAN B0 (3.3V): 0.001015 CHAN B1 (3.15aV): 0.000770 CHAN B2 (3.15bV): 0.000728 CHAN B3 (GND): -0.000504 OPEN: 0.006760 Full Scale: +/- 1 mA 2026-02-12T18:48:24.754Z,1770922104.754 [keepstation:SurfaceComms] Running Loop=1 2026-02-12T18:48:24.754Z,1770922104.754 [keepstation:SurfaceComms](DEBUG): Aggregate::initialize keepstation:SurfaceComms 2026-02-12T18:48:24.755Z,1770922104.755 [keepstation:SurfaceComms:A] Running Loop=1 2026-02-12T18:48:24.755Z,1770922104.755 [keepstation:SurfaceComms:A] Stopped 2026-02-12T18:48:24.755Z,1770922104.755 [keepstation:SurfaceComms:B] Running Loop=1 2026-02-12T18:48:24.755Z,1770922104.755 [keepstation:SurfaceComms:B](DEBUG): Aggregate::initialize keepstation:SurfaceComms:B 2026-02-12T18:48:24.757Z,1770922104.757 [keepstation:NeedComms] Running Loop=1 2026-02-12T18:48:24.757Z,1770922104.757 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2026-02-12T18:48:24.757Z,1770922104.757 [keepstation:NeedComms:C.GoToSurface] Running Loop=1 2026-02-12T18:48:24.757Z,1770922104.757 [keepstation:NeedComms:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T18:48:24.758Z,1770922104.758 [keepstation:NeedComms:C.GoToSurface](INFO): Received depth rate setting nan m/s. 2026-02-12T18:48:24.758Z,1770922104.758 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2026-02-12T18:48:24.759Z,1770922104.759 [keepstation:NeedComms:C.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2026-02-12T18:48:24.759Z,1770922104.759 [keepstation:NeedComms:C.GoToSurface](INFO): Received surface timeout setting 1500.000000 seconds. 2026-02-12T18:48:24.759Z,1770922104.759 [keepstation:NeedComms:C.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T18:48:24.760Z,1770922104.760 [keepstation:NeedComms:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T18:48:24.760Z,1770922104.760 [keepstation:NeedComms:A] Running Loop=1 2026-02-12T18:48:24.762Z,1770922104.762 [keepstation:NeedComms:A](INFO): last time_fix was: 1770921509.000000 second since 1970/01/01T00:00:00Z 2026-02-12T18:48:24.762Z,1770922104.762 [keepstation:NeedComms:A] Stopped 2026-02-12T18:48:24.762Z,1770922104.762 [keepstation:NeedComms:setActive] Running Loop=1 2026-02-12T18:48:24.762Z,1770922104.762 [keepstation:NeedComms:setActive](DEBUG): Aggregate::initialize keepstation:NeedComms:setActive 2026-02-12T18:48:24.762Z,1770922104.762 [keepstation:NeedComms:setActive:A] Running Loop=1 2026-02-12T18:48:25.116Z,1770922105.116 [keepstation:KeepStation:Dive] Stopped 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:KeepStation:Dive](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:KeepStation:Dive:A] Stopped 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:KeepStation:Dive:A](DEBUG): Aggregate::uninitialize keepstation:KeepStation:Dive:A 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:DiveCmd:StationKeep] Stopped 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:DiveCmd:StationKeep](DEBUG): Aggregate::uninitialize keepstation:DiveCmd:StationKeep 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:DiveCmd:StationKeep:A] Stopped 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:DiveCmd:StationKeep:B.Pitch] Stopped 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:DiveCmd:StationKeep:C.KeepStation] Stopped 2026-02-12T18:48:25.117Z,1770922105.117 [keepstation:DiveCmd:StationKeep:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2026-02-12T18:48:25.126Z,1770922105.126 [keepstation:NeedComms:setActive:A] Stopped 2026-02-12T18:48:25.126Z,1770922105.126 [keepstation:NeedComms:setActive:B] Running Loop=1 2026-02-12T18:48:25.520Z,1770922105.520 [keepstation:NeedComms:setActive:B] Stopped 2026-02-12T18:48:25.520Z,1770922105.520 [keepstation:NeedComms:setActive](INFO): Completed keepstation:NeedComms:setActive 2026-02-12T18:48:25.520Z,1770922105.520 [keepstation:NeedComms:setActive] Stopped 2026-02-12T18:48:25.520Z,1770922105.520 [keepstation:NeedComms:setActive](DEBUG): Aggregate::uninitialize keepstation:NeedComms:setActive 2026-02-12T18:50:01.334Z,1770922201.334 [keepstation:NeedComms:D] Running Loop=1 2026-02-12T18:50:02.020Z,1770922202.020 [Radio_Surface](INFO): Powering up 2026-02-12T18:50:08.140Z,1770922208.140 [DataOverHttps](INFO): Radio surface powered ON. 2026-02-12T18:50:23.144Z,1770922223.144 [NAL9602](INFO): SBD MO Status=2, MOMSN=31269, MT Status=2, MTMSN=0 2026-02-12T18:50:23.144Z,1770922223.144 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-12T18:50:38.272Z,1770922238.272 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:50:50.206Z,1770922250.206 [NAL9602](INFO): SBD MO Status=2, MOMSN=31269, MT Status=2, MTMSN=0 2026-02-12T18:50:50.207Z,1770922250.207 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-12T18:51:08.391Z,1770922268.391 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=31269, MT Status=1, MTMSN=1138 2026-02-12T18:51:08.391Z,1770922268.391 [NAL9602](INFO): Data available in MT queue 2026-02-12T18:51:09.049Z,1770922269.049 [NAL9602](INFO): Received command: stop 2026-02-12T18:51:09.129Z,1770922269.129 [CommandExec](IMPORTANT): got command stop 2026-02-12T18:51:09.129Z,1770922269.129 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2026-02-12T18:51:09.220Z,1770922269.220 [MissionManager](INFO): MissionManager is completed. 2026-02-12T18:51:09.220Z,1770922269.220 [MissionManager](INFO): Uninitializing Mission keepstation 2026-02-12T18:51:09.220Z,1770922269.220 [keepstation] Stopped 2026-02-12T18:51:09.220Z,1770922269.220 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2026-02-12T18:51:09.220Z,1770922269.220 [keepstation:NeedComms] Stopped 2026-02-12T18:51:09.220Z,1770922269.220 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2026-02-12T18:51:09.220Z,1770922269.220 [keepstation:NeedComms:C.GoToSurface] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:NeedComms:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:NeedComms:D] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:BackseatDriver] Stopped 2026-02-12T18:51:09.221Z,1770922269.221 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:PowerOnly] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:PowerOnly:E.Wait] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:H.Pitch] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:SurfaceComms] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:SurfaceComms](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:SurfaceComms:B] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:SurfaceComms:B](DEBUG): Aggregate::uninitialize keepstation:SurfaceComms:B 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:DiveCmd] Stopped 2026-02-12T18:51:09.222Z,1770922269.222 [keepstation:DiveCmd](DEBUG): Aggregate::uninitialize keepstation:DiveCmd 2026-02-12T18:51:09.223Z,1770922269.223 [keepstation:KeepStation] Stopped 2026-02-12T18:51:09.223Z,1770922269.223 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2026-02-12T18:51:09.223Z,1770922269.223 [keepstation:KeepStation:B.Wait] Stopped 2026-02-12T18:51:09.223Z,1770922269.223 [keepstation:KeepStation:B.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T18:51:09.397Z,1770922269.397 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:51:09.634Z,1770922269.634 [MissionManager](IMPORTANT): Started mission Default 2026-02-12T18:51:09.635Z,1770922269.635 [Default] Running Loop=1 2026-02-12T18:51:09.635Z,1770922269.635 [Default](DEBUG): Aggregate::initialize Default 2026-02-12T18:51:09.635Z,1770922269.635 [Default:B.GoToSurface] Running Loop=1 2026-02-12T18:51:09.635Z,1770922269.635 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2026-02-12T18:51:09.635Z,1770922269.635 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2026-02-12T18:51:09.635Z,1770922269.635 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2026-02-12T18:51:09.636Z,1770922269.636 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2026-02-12T18:51:09.636Z,1770922269.636 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2026-02-12T18:51:09.637Z,1770922269.637 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2026-02-12T18:51:09.637Z,1770922269.637 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2026-02-12T18:51:09.637Z,1770922269.637 [Default:A.Wait] Running Loop=1 2026-02-12T18:51:09.638Z,1770922269.638 [Default:A.Wait](DEBUG): Initialize Wait Component. 2026-02-12T18:51:10.007Z,1770922270.007 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185114.00,A,3647.78984,N,12150.84762,W,0.467,4.90,120226,,,D*78 2026-02-12T18:51:10.009Z,1770922270.009 [NAL9602](INFO): GPS fix at 20260212T185114: (36.796497, -121.847460) 2026-02-12T18:51:22.941Z,1770922282.941 [Default:A.Wait](INFO): Done Waiting. 2026-02-12T18:51:22.941Z,1770922282.941 [Default:A.Wait] Stopped 2026-02-12T18:51:22.941Z,1770922282.941 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T18:51:23.349Z,1770922283.349 [Default:CheckIn] Running Loop=1 2026-02-12T18:51:23.349Z,1770922283.349 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-12T18:51:23.349Z,1770922283.349 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-12T18:51:25.354Z,1770922285.354 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185129.00,A,3647.79085,N,12150.84697,W,0.661,56.83,120226,,,D*45 2026-02-12T18:51:25.357Z,1770922285.357 [NAL9602](INFO): GPS fix at 20260212T185129: (36.796514, -121.847449) 2026-02-12T18:51:25.388Z,1770922285.388 [Default:CheckIn:Read_GPS] Stopped 2026-02-12T18:51:25.388Z,1770922285.388 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-12T18:51:40.540Z,1770922300.540 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:51:50.480Z,1770922310.480 [NAL9602](INFO): SBD MO Status=2, MOMSN=31270, MT Status=2, MTMSN=0 2026-02-12T18:51:50.480Z,1770922310.480 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-12T18:51:51.283Z,1770922311.283 [BPC1](ERROR): Battery stick #8 (s/n: 01E7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.284Z,1770922311.284 [BPC1](ERROR): Battery stick #16 (s/n: 00F8) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.285Z,1770922311.285 [BPC1](ERROR): Battery stick #17 (s/n: 0084) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-12T18:51:51.286Z,1770922311.286 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.287Z,1770922311.287 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2026-02-12T18:51:51.287Z,1770922311.287 [BPC1](ERROR): Battery stick #37 (s/n: 0181) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.288Z,1770922311.288 [BPC1](ERROR): Battery stick #38 (s/n: 01BC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.289Z,1770922311.289 [BPC1](ERROR): Battery stick #39 (s/n: 0189) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.290Z,1770922311.290 [BPC1](ERROR): Battery stick #40 (s/n: 01A4) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.290Z,1770922311.290 [BPC1](ERROR): Battery stick #44 (s/n: 01BB) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.291Z,1770922311.291 [BPC1](ERROR): Battery stick #50 (s/n: 019C) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.292Z,1770922311.292 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.293Z,1770922311.293 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.294Z,1770922311.294 [BPC1](ERROR): Battery stick #53 (s/n: 01EE) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.294Z,1770922311.294 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2026-02-12T18:51:51.295Z,1770922311.295 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x5AD0. 2026-02-12T18:51:51.296Z,1770922311.296 [BPC1](INFO): Calculating totals. Valid battery stick count: 37. Valid reserve battery stick count: 2. 2026-02-12T18:51:51.301Z,1770922311.301 [BPC1](FAULT): Failed to receive data from 21 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 8, 9, 10, 11, 13, 14, 16, 17, 24, 29, 37, 38, 39, 40, 44, 50, 51, 52, 53, 57, 59. 2026-02-12T18:52:11.664Z,1770922331.664 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:52:15.605Z,1770922335.605 [NAL9602](INFO): SBD MO Status=2, MOMSN=31270, MT Status=2, MTMSN=0 2026-02-12T18:52:15.605Z,1770922335.605 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-12T18:52:42.788Z,1770922362.788 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:52:53.659Z,1770922373.659 [NAL9602](INFO): SBD MO Status=1, MOMSN=31270, MT Status=0, MTMSN=0 2026-02-12T18:52:53.716Z,1770922373.716 [NAL9602](INFO): Sent 74 bytes from file Logs/20260212T170415/Courier0042.lzma 2026-02-12T18:52:53.716Z,1770922373.716 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:53:07.122Z,1770922387.122 [NAL9602](INFO): SBD MO Status=1, MOMSN=31271, MT Status=0, MTMSN=0 2026-02-12T18:53:07.172Z,1770922387.172 [NAL9602](INFO): Sent 332 bytes from file Logs/20260212T170415/Express0043.lzma 2026-02-12T18:53:07.172Z,1770922387.172 [NAL9602](INFO): Packets left to send: 1 2026-02-12T18:53:13.917Z,1770922393.917 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:53:20.505Z,1770922400.505 [NAL9602](INFO): SBD MO Status=1, MOMSN=31272, MT Status=0, MTMSN=0 2026-02-12T18:53:20.564Z,1770922400.564 [NAL9602](INFO): Sent 217 bytes from file Logs/20260212T170415/Express0043.lzma 2026-02-12T18:53:20.564Z,1770922400.564 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:53:27.779Z,1770922407.779 [NAL9602](INFO): SBD MO Status=0, MOMSN=31273, MT Status=0, MTMSN=0 2026-02-12T18:53:45.040Z,1770922425.040 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-12T18:53:46.413Z,1770922426.413 [NAL9602](INFO): SBD MO Status=1, MOMSN=31274, MT Status=0, MTMSN=0 2026-02-12T18:53:46.460Z,1770922426.460 [NAL9602](INFO): Sent 50 bytes from file Logs/20260212T170415/Courier0045.lzma 2026-02-12T18:53:46.460Z,1770922426.460 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:53:53.193Z,1770922433.193 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003380 2026-02-12T18:53:55.798Z,1770922435.798 [NAL9602](INFO): SBD MO Status=1, MOMSN=31275, MT Status=0, MTMSN=0 2026-02-12T18:53:55.856Z,1770922435.856 [NAL9602](INFO): Sent 227 bytes from file Logs/20260212T170415/Express0046.lzma 2026-02-12T18:53:55.856Z,1770922435.856 [NAL9602](INFO): Packets left to send: 0 2026-02-12T18:53:56.615Z,1770922436.615 [Default:CheckIn:Read_Iridium] Stopped 2026-02-12T18:53:56.620Z,1770922436.620 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-12T18:53:56.620Z,1770922436.620 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-12T18:54:26.492Z,1770922466.492 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T18:58:57.278Z,1770922737.278 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-12T18:58:57.278Z,1770922737.278 [Default:CheckIn:C.Wait] Stopped 2026-02-12T18:58:57.278Z,1770922737.278 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T18:58:57.278Z,1770922737.278 [Default:CheckIn:D] Running Loop=1 2026-02-12T18:58:57.687Z,1770922737.687 [Default:CheckIn:D] Stopped 2026-02-12T18:58:57.687Z,1770922737.687 [Default:CheckIn:E] Running Loop=1 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.800872 min 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn:E] Stopped 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn] Stopped 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn](INFO): Running loop #2 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn] Running Loop=2 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-12T18:58:58.093Z,1770922738.093 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-12T18:59:00.099Z,1770922740.099 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185904.00,A,3647.84005,N,12150.82321,W,0.661,7.08,120226,,,D*71 2026-02-12T18:59:00.109Z,1770922740.109 [NAL9602](INFO): GPS fix at 20260212T185904: (36.797334, -121.847054) 2026-02-12T18:59:00.120Z,1770922740.120 [Default:CheckIn:Read_GPS] Stopped 2026-02-12T18:59:00.120Z,1770922740.120 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-12T18:59:07.771Z,1770922747.771 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260212T170415/Courier0048.lzma 2026-02-12T18:59:08.774Z,1770922748.774 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0048.lzma.bak 2026-02-12T18:59:08.774Z,1770922748.774 [DataOverHttps](INFO): SBD MOMSN=26654188 2026-02-12T18:59:19.500Z,1770922759.500 [NAL9602](INFO): SBD MO Status=0, MOMSN=31276, MT Status=0, MTMSN=0 2026-02-12T18:59:19.500Z,1770922759.500 [NAL9602](INFO): No messages in MT queue 2026-02-12T18:59:24.665Z,1770922764.665 [DataOverHttps](INFO): Sending 172 bytes from file Logs/20260212T170415/Express0049.lzma 2026-02-12T18:59:25.666Z,1770922765.666 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0049.lzma.bak 2026-02-12T18:59:25.666Z,1770922765.666 [DataOverHttps](INFO): SBD MOMSN=26654191 2026-02-12T18:59:27.179Z,1770922767.179 [Default:CheckIn:Read_Iridium] Stopped 2026-02-12T18:59:27.179Z,1770922767.179 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-12T18:59:27.179Z,1770922767.179 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-12T18:59:50.197Z,1770922790.197 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T19:04:27.845Z,1770923067.845 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-12T19:04:27.845Z,1770923067.845 [Default:CheckIn:C.Wait] Stopped 2026-02-12T19:04:27.845Z,1770923067.845 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-12T19:04:27.845Z,1770923067.845 [Default:CheckIn:D] Running Loop=1 2026-02-12T19:04:28.283Z,1770923068.283 [Default:CheckIn:D] Stopped 2026-02-12T19:04:28.283Z,1770923068.283 [Default:CheckIn:E] Running Loop=1 2026-02-12T19:04:28.631Z,1770923068.631 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.310803 min 2026-02-12T19:04:28.631Z,1770923068.631 [Default:CheckIn:E] Stopped 2026-02-12T19:04:28.631Z,1770923068.631 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-12T19:04:28.631Z,1770923068.631 [Default:CheckIn] Stopped 2026-02-12T19:04:28.631Z,1770923068.631 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-12T19:04:28.632Z,1770923068.632 [Default:CheckIn](INFO): Running loop #3 2026-02-12T19:04:28.632Z,1770923068.632 [Default:CheckIn] Running Loop=3 2026-02-12T19:04:28.632Z,1770923068.632 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-12T19:04:28.632Z,1770923068.632 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-12T19:04:30.642Z,1770923070.642 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190435.00,A,3647.88030,N,12150.80451,W,0.292,4.98,120226,,,D*70 2026-02-12T19:04:30.644Z,1770923070.644 [NAL9602](INFO): GPS fix at 20260212T190435: (36.798005, -121.846742) 2026-02-12T19:04:30.656Z,1770923070.656 [Default:CheckIn:Read_GPS] Stopped 2026-02-12T19:04:30.656Z,1770923070.656 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-12T19:04:40.543Z,1770923080.543 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20260212T170415/Courier0051.lzma 2026-02-12T19:04:41.546Z,1770923081.546 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Courier0051.lzma.bak 2026-02-12T19:04:41.546Z,1770923081.546 [DataOverHttps](INFO): SBD MOMSN=26654213 2026-02-12T19:04:52.518Z,1770923092.518 [NAL9602](INFO): SBD MO Status=2, MOMSN=31277, MT Status=2, MTMSN=0 2026-02-12T19:04:52.518Z,1770923092.518 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-12T19:04:57.419Z,1770923097.419 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20260212T170415/Express0052.lzma 2026-02-12T19:04:58.422Z,1770923098.422 [DataOverHttps](INFO): Moved sent file to Logs/20260212T170415/Express0052.lzma.bak 2026-02-12T19:04:58.422Z,1770923098.422 [DataOverHttps](INFO): SBD MOMSN=26654216 2026-02-12T19:04:59.809Z,1770923099.809 [Default:CheckIn:Read_Iridium] Stopped 2026-02-12T19:04:59.809Z,1770923099.809 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-12T19:04:59.809Z,1770923099.809 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-12T19:05:05.858Z,1770923105.858 [NAL9602](INFO): SBD MO Status=0, MOMSN=31277, MT Status=0, MTMSN=0 2026-02-12T19:05:05.858Z,1770923105.858 [NAL9602](INFO): No messages in MT queue 2026-02-12T19:05:36.554Z,1770923136.554 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-12T19:07:39.265Z,1770923259.265 [DataOverHttps](IMPORTANT): SBD MTMSN=20260212T190743 2026-02-12T19:07:46.811Z,1770923266.811 [DataOverHttps](INFO): Received command: restart sys 2026-02-12T19:07:46.877Z,1770923266.877 [CommandExec](IMPORTANT): got command restart system 2026-02-12T19:07:48.988Z,1770923268.988 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:48.988Z,1770923268.988 [CommandExec](INFO): Uninitializing the command executive. 2026-02-12T19:07:48.988Z,1770923268.988 [CommandExec](INFO): Uninitializing the command scheduler. 2026-02-12T19:07:48.989Z,1770923268.989 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:49.100Z,1770923269.100 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2026-02-12T19:07:49.100Z,1770923269.100 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2026-02-12T19:07:49.100Z,1770923269.100 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:49.101Z,1770923269.101 [NavChartDb](INFO): Join timeout helper Thread ID is 9420 2026-02-12T19:07:49.352Z,1770923269.352 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:49.352Z,1770923269.352 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:49.370Z,1770923269.370 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2026-02-12T19:07:49.370Z,1770923269.370 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:49.371Z,1770923269.371 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9421 2026-02-12T19:07:49.837Z,1770923269.837 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:49.837Z,1770923269.837 [WetLabsBB2FL](INFO): Powering down 2026-02-12T19:07:49.838Z,1770923269.838 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:49.852Z,1770923269.852 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2026-02-12T19:07:49.852Z,1770923269.852 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:49.852Z,1770923269.852 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9422 2026-02-12T19:07:50.724Z,1770923270.724 [CTD_Seabird](INFO): Powering down 2026-02-12T19:07:50.736Z,1770923270.736 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:50.736Z,1770923270.736 [CTD_Seabird](INFO): Powering down 2026-02-12T19:07:50.748Z,1770923270.748 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:50.752Z,1770923270.752 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2026-02-12T19:07:50.752Z,1770923270.752 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:50.752Z,1770923270.752 [Radio_Surface](INFO): Join timeout helper Thread ID is 9423 2026-02-12T19:07:50.000Z,1770923271.000 [Radio_Surface](INFO): Powering down 2026-02-12T19:07:51.001Z,1770923271.001 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:51.001Z,1770923271.001 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:51.020Z,1770923271.020 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2026-02-12T19:07:51.020Z,1770923271.020 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:51.020Z,1770923271.020 [Onboard](INFO): Join timeout helper Thread ID is 9424 2026-02-12T19:07:51.828Z,1770923271.828 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-02-12T19:07:53.397Z,1770923273.397 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:53.397Z,1770923273.397 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:53.417Z,1770923273.417 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2026-02-12T19:07:53.418Z,1770923273.418 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:53.418Z,1770923273.418 [DataOverHttps](INFO): Join timeout helper Thread ID is 9425 2026-02-12T19:07:53.836Z,1770923273.836 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-12T19:07:53.836Z,1770923273.836 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:53.851Z,1770923273.851 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2026-02-12T19:07:53.851Z,1770923273.851 [DAT ThreadHandler](INFO): Thread cancelled. 2026-02-12T19:07:53.864Z,1770923273.864 [DAT](INFO): Join timeout helper Thread ID is 9426 2026-02-12T19:07:53.916Z