2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:BackseatDriver] Stopped 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2025-02-22T05:16:30.069Z,1740201390.069 [keepstation:PowerOnly] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:PowerOnly:E.Wait] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:H.Pitch] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation:A] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation:B.Pitch] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation:C.KeepStation] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation:D.Wait] Stopped 2025-02-22T05:16:30.070Z,1740201390.070 [keepstation:KeepStation:D.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:16:30.131Z,1740201390.131 [CommandExec](IMPORTANT): got command restart logs 2025-02-22T05:16:30.476Z,1740201390.476 [MissionManager](IMPORTANT): Started mission Default 2025-02-22T05:16:30.476Z,1740201390.476 [Default] Running Loop=1 2025-02-22T05:16:30.476Z,1740201390.476 [Default](DEBUG): Aggregate::initialize Default 2025-02-22T05:16:30.476Z,1740201390.476 [Default:B.GoToSurface] Running Loop=1 2025-02-22T05:16:30.477Z,1740201390.477 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-22T05:16:30.477Z,1740201390.477 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-22T05:16:30.477Z,1740201390.477 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-22T05:16:30.477Z,1740201390.477 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-22T05:16:30.478Z,1740201390.478 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-22T05:16:30.478Z,1740201390.478 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-22T05:16:30.478Z,1740201390.478 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-22T05:16:30.479Z,1740201390.479 [Default:A.Wait] Running Loop=1 2025-02-22T05:16:30.491Z,1740201390.491 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:16:30.700Z,1740201390.700 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-22T05:16:30.701Z,1740201390.701 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-22T05:16:31.187Z,1740201391.187 [Radio_Surface](INFO): Powering up 2025-02-22T05:16:36.617Z,1740201396.617 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-22T05:16:43.913Z,1740201403.913 [Default:A.Wait](INFO): Done Waiting. 2025-02-22T05:16:43.913Z,1740201403.913 [Default:A.Wait] Stopped 2025-02-22T05:16:43.913Z,1740201403.913 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:16:45.727Z,1740201405.727 [CommandExec](IMPORTANT): got command configSet VerticalControl.kdPitchMass 1.25 second persist 2025-02-22T05:16:45.730Z,1740201405.730 [CommandExec](IMPORTANT): got command configSet VerticalControl.kiPitchMass 1.25 reciprocal_second persist 2025-02-22T05:16:45.734Z,1740201405.734 [CommandExec](IMPORTANT): got command configSet VerticalControl.kpPitchMass 1.25 none persist 2025-02-22T05:16:45.739Z,1740201405.739 [CommandExec](IMPORTANT): got command configSet VerticalControl.massOnlyForceInt 0 bool persist 2025-02-22T05:16:46.688Z,1740201406.688 [CommandExec](IMPORTANT): got command configSet VerticalControl.massDeadband 0.05 centimeter persist 2025-02-22T05:16:46.691Z,1740201406.691 [CommandExec](IMPORTANT): got command configSet VerticalControl.kpDepthBuoy 120 ratio persist 2025-02-22T05:16:48.864Z,1740201408.864 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-22T05:16:48.864Z,1740201408.864 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-22T05:16:48.864Z,1740201408.864 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-22T05:17:06.736Z,1740201426.736 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T05:17:37.887Z,1740201457.887 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T05:17:42.279Z,1740201462.279 [Default:CheckIn] Running Loop=1 2025-02-22T05:17:42.279Z,1740201462.279 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:17:42.279Z,1740201462.279 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:18:09.011Z,1740201489.011 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T05:18:11.348Z,1740201491.348 [NAL9602](INFO): SBD MO Status=2, MOMSN=13140, MT Status=2, MTMSN=0 2025-02-22T05:18:11.349Z,1740201491.349 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-22T05:18:34.975Z,1740201514.975 [NAL9602](INFO): SBD MO Status=0, MOMSN=13140, MT Status=0, MTMSN=0 2025-02-22T05:18:34.975Z,1740201514.975 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:18:36.191Z,1740201516.191 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,051835.00,A,3647.72630,N,12150.73462,W,0.467,171.81,220225,,,A*7D 2025-02-22T05:18:36.193Z,1740201516.193 [NAL9602](INFO): GPS fix at 20250222T051835: (36.795438, -121.845577) 2025-02-22T05:18:36.301Z,1740201516.301 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:18:36.301Z,1740201516.301 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:18:40.172Z,1740201520.172 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T05:18:47.998Z,1740201527.998 [NAL9602](INFO): SBD MO Status=1, MOMSN=13141, MT Status=0, MTMSN=0 2025-02-22T05:18:48.056Z,1740201528.056 [NAL9602](INFO): Sent 86 bytes from file Logs/20250222T025917/Courier0018.lzma 2025-02-22T05:18:48.056Z,1740201528.056 [NAL9602](INFO): Packets left to send: 0 2025-02-22T05:18:53.346Z,1740201533.346 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003919 2025-02-22T05:19:04.844Z,1740201544.844 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20250222T051630/Courier0000.lzma 2025-02-22T05:19:04.907Z,1740201544.907 [NAL9602](INFO): SBD MO Status=1, MOMSN=13142, MT Status=0, MTMSN=0 2025-02-22T05:19:04.960Z,1740201544.960 [NAL9602](INFO): Sent 267 bytes from file Logs/20250222T051630/Courier0000.lzma 2025-02-22T05:19:04.960Z,1740201544.960 [NAL9602](INFO): Packets left to send: 0 2025-02-22T05:19:06.694Z,1740201546.694 [DataOverHttps](FAULT): Server acknowledged file Logs/20250222T051630/Courier0000.lzma, notLogs/20250222T025917/Express0019.lzma 2025-02-22T05:19:06.694Z,1740201546.694 [DataOverHttps](INFO): SBD MOMSN=23972042 2025-02-22T05:19:25.889Z,1740201565.889 [DataOverHttps](INFO): Sending 257 bytes from file Logs/20250222T025917/Express0019.lzma 2025-02-22T05:19:26.889Z,1740201566.889 [DataOverHttps](INFO): Moved sent file to Logs/20250222T025917/Express0019.lzma.bak 2025-02-22T05:19:26.889Z,1740201566.889 [DataOverHttps](INFO): SBD MOMSN=23972047 2025-02-22T05:19:35.640Z,1740201575.640 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:19:47.348Z,1740201587.348 [DataOverHttps](INFO): Sending 536 bytes from file Logs/20250222T051630/Express0001.lzma 2025-02-22T05:19:48.349Z,1740201588.349 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0001.lzma.bak 2025-02-22T05:19:48.349Z,1740201588.349 [DataOverHttps](INFO): SBD MOMSN=23972052 2025-02-22T05:19:50.201Z,1740201590.201 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:19:50.201Z,1740201590.201 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:19:50.202Z,1740201590.202 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:24:50.786Z,1740201890.786 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:24:50.786Z,1740201890.786 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:24:50.786Z,1740201890.786 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:24:50.786Z,1740201890.786 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:24:51.195Z,1740201891.195 [Default:CheckIn:D] Stopped 2025-02-22T05:24:51.195Z,1740201891.195 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:24:51.605Z,1740201891.605 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.345306 min 2025-02-22T05:24:51.605Z,1740201891.605 [Default:CheckIn:E] Stopped 2025-02-22T05:24:51.605Z,1740201891.605 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:24:51.605Z,1740201891.605 [Default:CheckIn] Stopped 2025-02-22T05:24:51.605Z,1740201891.605 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:24:51.605Z,1740201891.605 [Default:CheckIn](INFO): Running loop #2 2025-02-22T05:24:51.606Z,1740201891.606 [Default:CheckIn] Running Loop=2 2025-02-22T05:24:51.606Z,1740201891.606 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:24:51.606Z,1740201891.606 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:24:53.610Z,1740201893.610 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,052452.00,A,3647.70353,N,12150.73320,W,0.233,262.69,220225,,,A*70 2025-02-22T05:24:53.612Z,1740201893.612 [NAL9602](INFO): GPS fix at 20250222T052452: (36.795059, -121.845553) 2025-02-22T05:24:53.640Z,1740201893.640 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:24:53.640Z,1740201893.640 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:25:01.459Z,1740201901.459 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250222T051630/Courier0003.lzma 2025-02-22T05:25:02.461Z,1740201902.461 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0003.lzma.bak 2025-02-22T05:25:02.461Z,1740201902.461 [DataOverHttps](INFO): SBD MOMSN=23972062 2025-02-22T05:25:13.548Z,1740201913.548 [CBIT](IMPORTANT): Beginning ground fault scan 2025-02-22T05:25:24.374Z,1740201924.374 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.000627 CHAN A1 (24V): -0.000334 CHAN A2 (12V): 0.000424 CHAN A3 (5V): -0.002162 CHAN B0 (3.3V): -0.000895 CHAN B1 (3.15aV): -0.000831 CHAN B2 (3.15bV): -0.001250 CHAN B3 (GND): -0.002269 OPEN: 0.004662 Full Scale: +/- 1 mA 2025-02-22T05:25:25.255Z,1740201925.255 [DataOverHttps](INFO): Sending 260 bytes from file Logs/20250222T051630/Express0004.lzma 2025-02-22T05:25:26.257Z,1740201926.257 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0004.lzma.bak 2025-02-22T05:25:26.257Z,1740201926.257 [DataOverHttps](INFO): SBD MOMSN=23972065 2025-02-22T05:25:27.000Z,1740201928.000 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:25:28.000Z,1740201928.000 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:25:28.000Z,1740201928.000 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:25:32.428Z,1740201932.428 [NAL9602](INFO): SBD MO Status=2, MOMSN=13143, MT Status=2, MTMSN=0 2025-02-22T05:25:32.429Z,1740201932.429 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-22T05:25:41.718Z,1740201941.718 [NAL9602](INFO): SBD MO Status=0, MOMSN=13143, MT Status=0, MTMSN=0 2025-02-22T05:25:41.718Z,1740201941.718 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:26:12.421Z,1740201972.421 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:30:28.631Z,1740202228.631 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:30:28.631Z,1740202228.631 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:30:28.632Z,1740202228.632 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:30:28.632Z,1740202228.632 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:30:29.038Z,1740202229.038 [Default:CheckIn:D] Stopped 2025-02-22T05:30:29.038Z,1740202229.038 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:30:29.432Z,1740202229.432 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.976027 min 2025-02-22T05:30:29.432Z,1740202229.432 [Default:CheckIn:E] Stopped 2025-02-22T05:30:29.432Z,1740202229.432 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:30:29.432Z,1740202229.432 [Default:CheckIn] Stopped 2025-02-22T05:30:29.433Z,1740202229.433 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:30:29.433Z,1740202229.433 [Default:CheckIn](INFO): Running loop #3 2025-02-22T05:30:29.433Z,1740202229.433 [Default:CheckIn] Running Loop=3 2025-02-22T05:30:29.433Z,1740202229.433 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:30:29.433Z,1740202229.433 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:30:31.446Z,1740202231.446 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,053030.00,A,3647.68201,N,12150.72179,W,0.369,138.23,220225,,,A*7D 2025-02-22T05:30:31.449Z,1740202231.449 [NAL9602](INFO): GPS fix at 20250222T053030: (36.794700, -121.845363) 2025-02-22T05:30:31.461Z,1740202231.461 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:30:31.461Z,1740202231.461 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:30:39.011Z,1740202239.011 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250222T051630/Courier0006.lzma 2025-02-22T05:30:40.013Z,1740202240.013 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0006.lzma.bak 2025-02-22T05:30:40.013Z,1740202240.013 [DataOverHttps](INFO): SBD MOMSN=23972070 2025-02-22T05:30:45.990Z,1740202245.990 [NAL9602](INFO): SBD MO Status=0, MOMSN=13144, MT Status=0, MTMSN=0 2025-02-22T05:30:45.990Z,1740202245.990 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:30:56.247Z,1740202256.247 [DataOverHttps](INFO): Sending 329 bytes from file Logs/20250222T051630/Express0007.lzma 2025-02-22T05:30:57.249Z,1740202257.249 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0007.lzma.bak 2025-02-22T05:30:57.249Z,1740202257.249 [DataOverHttps](INFO): SBD MOMSN=23972073 2025-02-22T05:31:02.664Z,1740202262.664 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:31:02.664Z,1740202262.664 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:31:02.664Z,1740202262.664 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:31:16.740Z,1740202276.740 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:36:03.199Z,1740202563.199 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:36:03.199Z,1740202563.199 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:36:03.221Z,1740202563.221 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:36:03.222Z,1740202563.222 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:36:03.598Z,1740202563.598 [Default:CheckIn:D] Stopped 2025-02-22T05:36:03.599Z,1740202563.599 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.552037 min 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn:E] Stopped 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn] Stopped 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn](INFO): Running loop #4 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn] Running Loop=4 2025-02-22T05:36:04.008Z,1740202564.008 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:36:04.009Z,1740202564.009 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:36:06.014Z,1740202566.014 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,053605.00,A,3647.66606,N,12150.70854,W,0.175,126.94,220225,,,A*78 2025-02-22T05:36:06.016Z,1740202566.016 [NAL9602](INFO): GPS fix at 20250222T053605: (36.794434, -121.845142) 2025-02-22T05:36:06.028Z,1740202566.028 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:36:06.028Z,1740202566.028 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:36:13.620Z,1740202573.620 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250222T051630/Courier0009.lzma 2025-02-22T05:36:14.621Z,1740202574.621 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0009.lzma.bak 2025-02-22T05:36:14.621Z,1740202574.621 [DataOverHttps](INFO): SBD MOMSN=23972079 2025-02-22T05:36:22.582Z,1740202582.582 [NAL9602](INFO): SBD MO Status=0, MOMSN=13145, MT Status=0, MTMSN=0 2025-02-22T05:36:22.582Z,1740202582.582 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:36:30.739Z,1740202590.739 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20250222T051630/Express0010.lzma 2025-02-22T05:36:31.741Z,1740202591.741 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0010.lzma.bak 2025-02-22T05:36:31.741Z,1740202591.741 [DataOverHttps](INFO): SBD MOMSN=23972082 2025-02-22T05:36:33.516Z,1740202593.516 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:36:33.516Z,1740202593.516 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:36:33.516Z,1740202593.516 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:36:53.300Z,1740202613.300 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:41:34.186Z,1740202894.186 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:41:34.186Z,1740202894.186 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:41:34.186Z,1740202894.186 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:41:34.187Z,1740202894.187 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:41:34.578Z,1740202894.578 [Default:CheckIn:D] Stopped 2025-02-22T05:41:34.578Z,1740202894.578 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:41:34.982Z,1740202894.982 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.068365 min 2025-02-22T05:41:34.982Z,1740202894.982 [Default:CheckIn:E] Stopped 2025-02-22T05:41:34.982Z,1740202894.982 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:41:34.982Z,1740202894.982 [Default:CheckIn] Stopped 2025-02-22T05:41:34.982Z,1740202894.982 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:41:34.983Z,1740202894.983 [Default:CheckIn](INFO): Running loop #5 2025-02-22T05:41:34.983Z,1740202894.983 [Default:CheckIn] Running Loop=5 2025-02-22T05:41:34.983Z,1740202894.983 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:41:34.983Z,1740202894.983 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:41:36.998Z,1740202896.998 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,054136.00,A,3647.65178,N,12150.69458,W,0.408,117.16,220225,,,D*7F 2025-02-22T05:41:37.000Z,1740202897.000 [NAL9602](INFO): GPS fix at 20250222T054136: (36.794196, -121.844910) 2025-02-22T05:41:37.012Z,1740202897.012 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:41:37.012Z,1740202897.012 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:41:44.892Z,1740202904.892 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250222T051630/Courier0012.lzma 2025-02-22T05:41:45.321Z,1740202905.321 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0012.lzma.bak 2025-02-22T05:41:45.321Z,1740202905.321 [DataOverHttps](INFO): SBD MOMSN=23972086 2025-02-22T05:41:47.906Z,1740202907.906 [NAL9602](INFO): SBD MO Status=0, MOMSN=13146, MT Status=0, MTMSN=0 2025-02-22T05:41:47.906Z,1740202907.906 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:42:01.375Z,1740202921.375 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250222T051630/Express0013.lzma 2025-02-22T05:42:02.380Z,1740202922.380 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0013.lzma.bak 2025-02-22T05:42:02.380Z,1740202922.380 [DataOverHttps](INFO): SBD MOMSN=23972089 2025-02-22T05:42:04.076Z,1740202924.076 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:42:04.076Z,1740202924.076 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:42:04.076Z,1740202924.076 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:42:18.608Z,1740202938.608 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:47:04.709Z,1740203224.709 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:47:04.709Z,1740203224.709 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:47:04.709Z,1740203224.709 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:47:04.710Z,1740203224.710 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:47:05.111Z,1740203225.111 [Default:CheckIn:D] Stopped 2025-02-22T05:47:05.111Z,1740203225.111 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.577244 min 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn:E] Stopped 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn] Stopped 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn](INFO): Running loop #6 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn] Running Loop=6 2025-02-22T05:47:05.516Z,1740203225.516 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:47:05.517Z,1740203225.517 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:47:07.513Z,1740203227.513 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,054706.00,A,3647.63980,N,12150.68321,W,0.136,171.72,220225,,,D*71 2025-02-22T05:47:07.516Z,1740203227.516 [NAL9602](INFO): GPS fix at 20250222T054706: (36.793997, -121.844720) 2025-02-22T05:47:07.557Z,1740203227.557 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:47:07.557Z,1740203227.557 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:47:16.015Z,1740203236.015 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250222T051630/Courier0015.lzma 2025-02-22T05:47:17.017Z,1740203237.017 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0015.lzma.bak 2025-02-22T05:47:17.017Z,1740203237.017 [DataOverHttps](INFO): SBD MOMSN=23972093 2025-02-22T05:47:32.562Z,1740203252.562 [NAL9602](INFO): SBD MO Status=2, MOMSN=13147, MT Status=2, MTMSN=0 2025-02-22T05:47:32.562Z,1740203252.562 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-22T05:47:33.323Z,1740203253.323 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250222T051630/Express0016.lzma 2025-02-22T05:47:34.325Z,1740203254.325 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0016.lzma.bak 2025-02-22T05:47:34.325Z,1740203254.325 [DataOverHttps](INFO): SBD MOMSN=23972096 2025-02-22T05:47:35.811Z,1740203255.811 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:47:35.811Z,1740203255.811 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:47:35.811Z,1740203255.811 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:48:10.134Z,1740203290.134 [NAL9602](INFO): SBD MO Status=2, MOMSN=13147, MT Status=2, MTMSN=0 2025-02-22T05:48:10.134Z,1740203290.134 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-22T05:48:29.534Z,1740203309.534 [NAL9602](INFO): SBD MO Status=2, MOMSN=13147, MT Status=2, MTMSN=0 2025-02-22T05:48:29.534Z,1740203309.534 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-22T05:48:49.730Z,1740203329.730 [NAL9602](INFO): SBD MO Status=0, MOMSN=13147, MT Status=0, MTMSN=0 2025-02-22T05:48:49.730Z,1740203329.730 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:49:20.436Z,1740203360.436 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:52:36.414Z,1740203556.414 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:52:36.414Z,1740203556.414 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:52:36.414Z,1740203556.414 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:52:36.414Z,1740203556.414 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:52:36.812Z,1740203556.812 [Default:CheckIn:D] Stopped 2025-02-22T05:52:36.812Z,1740203556.812 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:52:37.211Z,1740203557.211 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.105599 min 2025-02-22T05:52:37.211Z,1740203557.211 [Default:CheckIn:E] Stopped 2025-02-22T05:52:37.211Z,1740203557.211 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:52:37.211Z,1740203557.211 [Default:CheckIn] Stopped 2025-02-22T05:52:37.211Z,1740203557.211 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:52:37.212Z,1740203557.212 [Default:CheckIn](INFO): Running loop #7 2025-02-22T05:52:37.212Z,1740203557.212 [Default:CheckIn] Running Loop=7 2025-02-22T05:52:37.212Z,1740203557.212 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:52:37.212Z,1740203557.212 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:52:39.230Z,1740203559.230 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,055238.00,A,3647.62709,N,12150.66903,W,0.622,83.82,220225,,,D*43 2025-02-22T05:52:39.233Z,1740203559.233 [NAL9602](INFO): GPS fix at 20250222T055238: (36.793785, -121.844484) 2025-02-22T05:52:39.244Z,1740203559.244 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:52:39.244Z,1740203559.244 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:52:46.475Z,1740203566.475 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250222T051630/Courier0018.lzma 2025-02-22T05:52:47.477Z,1740203567.477 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0018.lzma.bak 2025-02-22T05:52:47.477Z,1740203567.477 [DataOverHttps](INFO): SBD MOMSN=23972100 2025-02-22T05:52:57.454Z,1740203577.454 [NAL9602](INFO): SBD MO Status=0, MOMSN=13148, MT Status=0, MTMSN=0 2025-02-22T05:52:57.454Z,1740203577.454 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:53:05.135Z,1740203585.135 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20250222T051630/Express0019.lzma 2025-02-22T05:53:06.137Z,1740203586.137 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0019.lzma.bak 2025-02-22T05:53:06.137Z,1740203586.137 [DataOverHttps](INFO): SBD MOMSN=23972103 2025-02-22T05:53:08.016Z,1740203588.016 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:53:08.016Z,1740203588.016 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:53:08.017Z,1740203588.017 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:53:28.181Z,1740203608.181 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T05:58:08.574Z,1740203888.574 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-22T05:58:08.574Z,1740203888.574 [Default:CheckIn:C.Wait] Stopped 2025-02-22T05:58:08.574Z,1740203888.574 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T05:58:08.575Z,1740203888.575 [Default:CheckIn:D] Running Loop=1 2025-02-22T05:58:09.004Z,1740203889.004 [Default:CheckIn:D] Stopped 2025-02-22T05:58:09.004Z,1740203889.004 [Default:CheckIn:E] Running Loop=1 2025-02-22T05:58:09.382Z,1740203889.382 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.642131 min 2025-02-22T05:58:09.382Z,1740203889.382 [Default:CheckIn:E] Stopped 2025-02-22T05:58:09.383Z,1740203889.383 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-22T05:58:09.383Z,1740203889.383 [Default:CheckIn] Stopped 2025-02-22T05:58:09.383Z,1740203889.383 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-22T05:58:09.395Z,1740203889.395 [Default:CheckIn](INFO): Running loop #8 2025-02-22T05:58:09.395Z,1740203889.395 [Default:CheckIn] Running Loop=8 2025-02-22T05:58:09.395Z,1740203889.395 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T05:58:09.395Z,1740203889.395 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T05:58:11.398Z,1740203891.398 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,055810.00,A,3647.61634,N,12150.65483,W,0.855,170.41,220225,,,D*75 2025-02-22T05:58:11.400Z,1740203891.400 [NAL9602](INFO): GPS fix at 20250222T055810: (36.793606, -121.844247) 2025-02-22T05:58:11.432Z,1740203891.432 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T05:58:11.432Z,1740203891.432 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T05:58:21.795Z,1740203901.795 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250222T051630/Courier0021.lzma 2025-02-22T05:58:22.801Z,1740203902.801 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Courier0021.lzma.bak 2025-02-22T05:58:22.801Z,1740203902.801 [DataOverHttps](INFO): SBD MOMSN=23972108 2025-02-22T05:58:39.272Z,1740203919.272 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20250222T051630/Express0022.lzma 2025-02-22T05:58:40.269Z,1740203920.269 [DataOverHttps](INFO): Moved sent file to Logs/20250222T051630/Express0022.lzma.bak 2025-02-22T05:58:40.269Z,1740203920.269 [DataOverHttps](INFO): SBD MOMSN=23972111 2025-02-22T05:58:42.141Z,1740203922.141 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T05:58:42.141Z,1740203922.141 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T05:58:42.141Z,1740203922.141 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T05:59:04.737Z,1740203944.737 [NAL9602](INFO): SBD MO Status=0, MOMSN=13149, MT Status=0, MTMSN=0 2025-02-22T05:59:04.737Z,1740203944.737 [NAL9602](INFO): No messages in MT queue 2025-02-22T05:59:35.452Z,1740203975.452 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-22T06:02:24.237Z,1740204144.237 [DataOverHttps](IMPORTANT): SBD MTMSN=20250222T060223