2025-05-23T19:35:40.124Z,1748028940.124 [CommandExec](IMPORTANT): got command restart logs 2025-05-23T19:37:55.736Z,1748029075.736 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.659878 2025-05-23T19:38:38.654Z,1748029118.654 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T19:38:38.654Z,1748029118.654 [Default:CheckIn:C.Wait] Stopped 2025-05-23T19:38:38.666Z,1748029118.666 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T19:38:38.667Z,1748029118.667 [Default:CheckIn:D] Running Loop=1 2025-05-23T19:38:39.058Z,1748029119.058 [Default:CheckIn:D] Stopped 2025-05-23T19:38:39.058Z,1748029119.058 [Default:CheckIn:E] Running Loop=1 2025-05-23T19:38:39.470Z,1748029119.470 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.165621 min 2025-05-23T19:38:39.470Z,1748029119.470 [Default:CheckIn:E] Stopped 2025-05-23T19:38:39.470Z,1748029119.470 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T19:38:39.470Z,1748029119.470 [Default:CheckIn] Stopped 2025-05-23T19:38:39.471Z,1748029119.471 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T19:38:39.471Z,1748029119.471 [Default:CheckIn](INFO): Running loop #5 2025-05-23T19:38:39.471Z,1748029119.471 [Default:CheckIn] Running Loop=5 2025-05-23T19:38:39.471Z,1748029119.471 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T19:38:39.471Z,1748029119.471 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T19:38:41.476Z,1748029121.476 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193840.00,A,3648.12706,N,12149.11586,W,16.289,85.38,230525,,,D*70 2025-05-23T19:38:41.479Z,1748029121.479 [NAL9602](INFO): GPS fix at 20250523T193840: (36.802118, -121.818598) 2025-05-23T19:38:41.489Z,1748029121.489 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T19:38:41.489Z,1748029121.489 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T19:39:00.995Z,1748029140.995 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-05-23T19:39:05.781Z,1748029145.781 [NAL9602](INFO): SBD MO Status=1, MOMSN=9457, MT Status=0, MTMSN=0 2025-05-23T19:39:05.835Z,1748029145.835 [NAL9602](INFO): Sent 39 bytes from file Logs/20250523T184440/Courier0027.lzma 2025-05-23T19:39:05.835Z,1748029145.835 [NAL9602](INFO): Packets left to send: 0 2025-05-23T19:39:16.372Z,1748029156.372 [NAL9602](INFO): SBD MO Status=1, MOMSN=9458, MT Status=0, MTMSN=0 2025-05-23T19:39:16.423Z,1748029156.423 [NAL9602](INFO): Sent 267 bytes from file Logs/20250523T193540/Courier0000.lzma 2025-05-23T19:39:16.423Z,1748029156.423 [NAL9602](INFO): Packets left to send: 0 2025-05-23T19:39:34.178Z,1748029174.178 [NAL9602](INFO): SBD MO Status=2, MOMSN=9459, MT Status=2, MTMSN=0 2025-05-23T19:39:34.178Z,1748029174.178 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-23T19:39:50.389Z,1748029190.389 [NAL9602](INFO): SBD MO Status=1, MOMSN=9459, MT Status=0, MTMSN=0 2025-05-23T19:39:50.439Z,1748029190.439 [NAL9602](INFO): Sent 105 bytes from file Logs/20250523T184440/Express0028.lzma 2025-05-23T19:39:50.439Z,1748029190.439 [NAL9602](INFO): Packets left to send: 0 2025-05-23T19:39:55.448Z,1748029195.448 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003795 2025-05-23T19:40:02.958Z,1748029202.958 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250523T193540/Courier0003.lzma 2025-05-23T19:40:03.960Z,1748029203.960 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0003.lzma.bak 2025-05-23T19:40:03.961Z,1748029203.961 [DataOverHttps](INFO): SBD MOMSN=24968187 2025-05-23T19:40:05.057Z,1748029205.057 [NAL9602](INFO): SBD MO Status=1, MOMSN=9460, MT Status=0, MTMSN=0 2025-05-23T19:40:05.107Z,1748029205.107 [NAL9602](INFO): Sent 332 bytes from file Logs/20250523T193540/Express0001.lzma 2025-05-23T19:40:05.107Z,1748029205.107 [NAL9602](INFO): Packets left to send: 1 2025-05-23T19:40:19.687Z,1748029219.687 [DataOverHttps](INFO): Sending 491 bytes from file Logs/20250523T193540/Express0001.lzma 2025-05-23T19:40:20.688Z,1748029220.688 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0001.lzma.bak 2025-05-23T19:40:20.689Z,1748029220.689 [DataOverHttps](INFO): SBD MOMSN=24968189 2025-05-23T19:40:35.756Z,1748029235.756 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T19:40:36.970Z,1748029236.970 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20250523T193540/Express0004.lzma 2025-05-23T19:40:37.973Z,1748029237.973 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0004.lzma.bak 2025-05-23T19:40:37.973Z,1748029237.973 [DataOverHttps](INFO): SBD MOMSN=24968197 2025-05-23T19:40:39.406Z,1748029239.406 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T19:40:39.407Z,1748029239.407 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T19:40:39.407Z,1748029239.407 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T19:45:39.973Z,1748029539.973 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T19:45:39.973Z,1748029539.973 [Default:CheckIn:C.Wait] Stopped 2025-05-23T19:45:39.973Z,1748029539.973 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T19:45:39.974Z,1748029539.974 [Default:CheckIn:D] Running Loop=1 2025-05-23T19:45:40.380Z,1748029540.380 [Default:CheckIn:D] Stopped 2025-05-23T19:45:40.381Z,1748029540.381 [Default:CheckIn:E] Running Loop=1 2025-05-23T19:45:40.817Z,1748029540.817 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.187663 min 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn:E] Stopped 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn] Stopped 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn](INFO): Running loop #6 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn] Running Loop=6 2025-05-23T19:45:40.818Z,1748029540.818 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T19:45:40.823Z,1748029540.823 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T19:45:42.794Z,1748029542.794 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194542.00,A,3648.46895,N,12147.11045,W,4.937,170.98,230525,,,D*74 2025-05-23T19:45:42.796Z,1748029542.796 [NAL9602](INFO): GPS fix at 20250523T194542: (36.807816, -121.785174) 2025-05-23T19:45:42.819Z,1748029542.819 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T19:45:42.819Z,1748029542.819 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T19:45:50.561Z,1748029550.561 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0006.lzma 2025-05-23T19:45:51.560Z,1748029551.560 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0006.lzma.bak 2025-05-23T19:45:51.560Z,1748029551.560 [DataOverHttps](INFO): SBD MOMSN=24968264 2025-05-23T19:45:52.489Z,1748029552.489 [NAL9602](INFO): SBD MO Status=0, MOMSN=9461, MT Status=0, MTMSN=0 2025-05-23T19:45:52.489Z,1748029552.489 [NAL9602](INFO): No messages in MT queue 2025-05-23T19:46:07.539Z,1748029567.539 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20250523T193540/Express0007.lzma 2025-05-23T19:46:08.540Z,1748029568.540 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0007.lzma.bak 2025-05-23T19:46:08.541Z,1748029568.541 [DataOverHttps](INFO): SBD MOMSN=24968267 2025-05-23T19:46:09.898Z,1748029569.898 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T19:46:09.898Z,1748029569.898 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T19:46:09.898Z,1748029569.898 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T19:46:23.208Z,1748029583.208 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T19:51:10.456Z,1748029870.456 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T19:51:10.456Z,1748029870.456 [Default:CheckIn:C.Wait] Stopped 2025-05-23T19:51:10.456Z,1748029870.456 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T19:51:10.456Z,1748029870.456 [Default:CheckIn:D] Running Loop=1 2025-05-23T19:51:10.865Z,1748029870.865 [Default:CheckIn:D] Stopped 2025-05-23T19:51:10.865Z,1748029870.865 [Default:CheckIn:E] Running Loop=1 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 37.695732 min 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn:E] Stopped 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn] Stopped 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn](INFO): Running loop #7 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn] Running Loop=7 2025-05-23T19:51:11.263Z,1748029871.263 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T19:51:11.264Z,1748029871.264 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T19:51:13.274Z,1748029873.274 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195112.00,A,3648.15721,N,12147.21725,W,0.700,213.95,230525,,,D*75 2025-05-23T19:51:13.276Z,1748029873.276 [NAL9602](INFO): GPS fix at 20250523T195112: (36.802620, -121.786954) 2025-05-23T19:51:13.286Z,1748029873.286 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T19:51:13.286Z,1748029873.286 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T19:51:20.786Z,1748029880.786 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20250523T193540/Courier0009.lzma 2025-05-23T19:51:21.788Z,1748029881.788 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0009.lzma.bak 2025-05-23T19:51:21.789Z,1748029881.789 [DataOverHttps](INFO): SBD MOMSN=24968283 2025-05-23T19:51:27.021Z,1748029887.021 [NAL9602](INFO): SBD MO Status=0, MOMSN=9462, MT Status=0, MTMSN=0 2025-05-23T19:51:27.021Z,1748029887.021 [NAL9602](INFO): No messages in MT queue 2025-05-23T19:51:38.039Z,1748029898.039 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250523T193540/Express0010.lzma 2025-05-23T19:51:39.040Z,1748029899.040 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0010.lzma.bak 2025-05-23T19:51:39.040Z,1748029899.040 [DataOverHttps](INFO): SBD MOMSN=24968286 2025-05-23T19:51:40.362Z,1748029900.362 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T19:51:40.362Z,1748029900.362 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T19:51:40.362Z,1748029900.362 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T19:51:57.725Z,1748029917.725 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T19:56:40.946Z,1748030200.946 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T19:56:40.946Z,1748030200.946 [Default:CheckIn:C.Wait] Stopped 2025-05-23T19:56:40.946Z,1748030200.946 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T19:56:40.947Z,1748030200.947 [Default:CheckIn:D] Running Loop=1 2025-05-23T19:56:41.373Z,1748030201.373 [Default:CheckIn:D] Stopped 2025-05-23T19:56:41.373Z,1748030201.373 [Default:CheckIn:E] Running Loop=1 2025-05-23T19:56:41.760Z,1748030201.760 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.204203 min 2025-05-23T19:56:41.760Z,1748030201.760 [Default:CheckIn:E] Stopped 2025-05-23T19:56:41.760Z,1748030201.760 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T19:56:41.760Z,1748030201.760 [Default:CheckIn] Stopped 2025-05-23T19:56:41.760Z,1748030201.760 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T19:56:41.760Z,1748030201.760 [Default:CheckIn](INFO): Running loop #8 2025-05-23T19:56:41.761Z,1748030201.761 [Default:CheckIn] Running Loop=8 2025-05-23T19:56:41.761Z,1748030201.761 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T19:56:41.761Z,1748030201.761 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T19:56:43.762Z,1748030203.762 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195643.00,A,3648.15262,N,12147.22079,W,0.058,203.18,230525,,,D*77 2025-05-23T19:56:43.764Z,1748030203.764 [NAL9602](INFO): GPS fix at 20250523T195643: (36.802544, -121.787013) 2025-05-23T19:56:43.774Z,1748030203.774 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T19:56:43.774Z,1748030203.774 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T19:56:51.166Z,1748030211.166 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0012.lzma 2025-05-23T19:56:52.168Z,1748030212.168 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0012.lzma.bak 2025-05-23T19:56:52.169Z,1748030212.169 [DataOverHttps](INFO): SBD MOMSN=24968352 2025-05-23T19:57:08.319Z,1748030228.319 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250523T193540/Express0013.lzma 2025-05-23T19:57:09.320Z,1748030229.320 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0013.lzma.bak 2025-05-23T19:57:09.321Z,1748030229.321 [DataOverHttps](INFO): SBD MOMSN=24968355 2025-05-23T19:57:10.845Z,1748030230.845 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T19:57:10.845Z,1748030230.845 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T19:57:10.846Z,1748030230.846 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T19:57:31.030Z,1748030251.030 [NAL9602](INFO): SBD MO Status=0, MOMSN=9463, MT Status=0, MTMSN=0 2025-05-23T19:57:31.030Z,1748030251.030 [NAL9602](INFO): No messages in MT queue 2025-05-23T19:58:01.732Z,1748030281.732 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:02:11.418Z,1748030531.418 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:02:11.418Z,1748030531.418 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:02:11.418Z,1748030531.418 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:02:11.418Z,1748030531.418 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:02:11.823Z,1748030531.823 [Default:CheckIn:D] Stopped 2025-05-23T20:02:11.823Z,1748030531.823 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.711711 min 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn:E] Stopped 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn] Stopped 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn](INFO): Running loop #9 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn] Running Loop=9 2025-05-23T20:02:12.240Z,1748030532.240 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:02:12.241Z,1748030532.241 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:02:14.241Z,1748030534.241 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200213.00,A,3648.15480,N,12147.22341,W,0.505,252.22,230525,,,D*7B 2025-05-23T20:02:14.245Z,1748030534.245 [NAL9602](INFO): GPS fix at 20250523T200213: (36.802580, -121.787057) 2025-05-23T20:02:14.274Z,1748030534.274 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:02:14.274Z,1748030534.274 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:02:21.542Z,1748030541.542 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0015.lzma 2025-05-23T20:02:22.544Z,1748030542.544 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0015.lzma.bak 2025-05-23T20:02:22.544Z,1748030542.544 [DataOverHttps](INFO): SBD MOMSN=24968372 2025-05-23T20:02:32.045Z,1748030552.045 [NAL9602](INFO): SBD MO Status=0, MOMSN=9464, MT Status=0, MTMSN=0 2025-05-23T20:02:32.045Z,1748030552.045 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:02:40.591Z,1748030560.591 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250523T193540/Express0016.lzma 2025-05-23T20:02:41.592Z,1748030561.592 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0016.lzma.bak 2025-05-23T20:02:41.593Z,1748030561.593 [DataOverHttps](INFO): SBD MOMSN=24968375 2025-05-23T20:02:42.965Z,1748030562.965 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:02:42.965Z,1748030562.965 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:02:42.965Z,1748030562.965 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:03:02.740Z,1748030582.740 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:07:43.544Z,1748030863.544 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:07:43.544Z,1748030863.544 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:07:43.544Z,1748030863.544 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:07:43.544Z,1748030863.544 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:07:43.941Z,1748030863.941 [Default:CheckIn:D] Stopped 2025-05-23T20:07:43.941Z,1748030863.941 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:07:44.342Z,1748030864.342 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.247009 min 2025-05-23T20:07:44.342Z,1748030864.342 [Default:CheckIn:E] Stopped 2025-05-23T20:07:44.342Z,1748030864.342 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:07:44.342Z,1748030864.342 [Default:CheckIn] Stopped 2025-05-23T20:07:44.343Z,1748030864.343 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:07:44.343Z,1748030864.343 [Default:CheckIn](INFO): Running loop #10 2025-05-23T20:07:44.343Z,1748030864.343 [Default:CheckIn] Running Loop=10 2025-05-23T20:07:44.343Z,1748030864.343 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:07:44.343Z,1748030864.343 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:07:46.358Z,1748030866.358 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200745.00,A,3648.14631,N,12147.25223,W,1.438,328.97,230525,,,D*7A 2025-05-23T20:07:46.360Z,1748030866.360 [NAL9602](INFO): GPS fix at 20250523T200745: (36.802439, -121.787537) 2025-05-23T20:07:46.370Z,1748030866.370 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:07:46.370Z,1748030866.370 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:07:54.042Z,1748030874.042 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0018.lzma 2025-05-23T20:07:55.045Z,1748030875.045 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0018.lzma.bak 2025-05-23T20:07:55.045Z,1748030875.045 [DataOverHttps](INFO): SBD MOMSN=24968439 2025-05-23T20:07:58.109Z,1748030878.109 [NAL9602](INFO): SBD MO Status=0, MOMSN=9465, MT Status=0, MTMSN=0 2025-05-23T20:07:58.109Z,1748030878.109 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:08:10.915Z,1748030890.915 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20250523T193540/Express0019.lzma 2025-05-23T20:08:11.918Z,1748030891.918 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0019.lzma.bak 2025-05-23T20:08:11.919Z,1748030891.918 [DataOverHttps](INFO): SBD MOMSN=24968443 2025-05-23T20:08:13.430Z,1748030893.430 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:08:13.430Z,1748030893.430 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:08:13.430Z,1748030893.430 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:08:28.772Z,1748030908.772 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:13:14.015Z,1748031194.015 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:13:14.015Z,1748031194.015 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:13:14.016Z,1748031194.016 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:13:14.016Z,1748031194.016 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:13:14.426Z,1748031194.426 [Default:CheckIn:D] Stopped 2025-05-23T20:13:14.426Z,1748031194.426 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:13:14.841Z,1748031194.841 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 59.755086 min 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn:E] Stopped 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn] Stopped 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn](INFO): Running loop #11 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn] Running Loop=11 2025-05-23T20:13:14.842Z,1748031194.842 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:13:14.843Z,1748031194.843 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:13:16.841Z,1748031196.841 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201316.00,A,3648.17471,N,12147.27887,W,0.039,297.11,230525,,,D*75 2025-05-23T20:13:16.846Z,1748031196.846 [NAL9602](INFO): GPS fix at 20250523T201316: (36.802912, -121.787981) 2025-05-23T20:13:16.859Z,1748031196.859 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:13:16.859Z,1748031196.859 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:13:24.098Z,1748031204.098 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20250523T193540/Courier0021.lzma 2025-05-23T20:13:25.100Z,1748031205.100 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0021.lzma.bak 2025-05-23T20:13:25.101Z,1748031205.101 [DataOverHttps](INFO): SBD MOMSN=24968458 2025-05-23T20:13:41.035Z,1748031221.035 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20250523T193540/Express0022.lzma 2025-05-23T20:13:41.885Z,1748031221.885 [NAL9602](INFO): SBD MO Status=2, MOMSN=9466, MT Status=2, MTMSN=0 2025-05-23T20:13:41.885Z,1748031221.885 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-23T20:13:42.037Z,1748031222.037 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0022.lzma.bak 2025-05-23T20:13:42.037Z,1748031222.037 [DataOverHttps](INFO): SBD MOMSN=24968467 2025-05-23T20:13:43.511Z,1748031223.511 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:13:43.511Z,1748031223.511 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:13:43.511Z,1748031223.511 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:14:44.507Z,1748031284.507 [NAL9602](INFO): SBD MO Status=2, MOMSN=9466, MT Status=2, MTMSN=0 2025-05-23T20:14:44.507Z,1748031284.507 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-23T20:14:57.441Z,1748031297.441 [NAL9602](INFO): SBD MO Status=2, MOMSN=9466, MT Status=2, MTMSN=0 2025-05-23T20:14:57.441Z,1748031297.441 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-23T20:15:20.459Z,1748031320.459 [NAL9602](INFO): SBD MO Status=0, MOMSN=9466, MT Status=0, MTMSN=0 2025-05-23T20:15:20.459Z,1748031320.459 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:15:51.163Z,1748031351.163 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:18:44.100Z,1748031524.100 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:18:44.100Z,1748031524.100 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:18:44.100Z,1748031524.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:18:44.100Z,1748031524.100 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:18:44.493Z,1748031524.493 [Default:CheckIn:D] Stopped 2025-05-23T20:18:44.493Z,1748031524.493 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:18:44.893Z,1748031524.893 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 65.256205 min 2025-05-23T20:18:44.893Z,1748031524.893 [Default:CheckIn:E] Stopped 2025-05-23T20:18:44.893Z,1748031524.893 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:18:44.893Z,1748031524.893 [Default:CheckIn] Stopped 2025-05-23T20:18:44.894Z,1748031524.894 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:18:44.894Z,1748031524.894 [Default:CheckIn](INFO): Running loop #12 2025-05-23T20:18:44.894Z,1748031524.894 [Default:CheckIn] Running Loop=12 2025-05-23T20:18:44.894Z,1748031524.894 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:18:44.894Z,1748031524.894 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:18:46.916Z,1748031526.916 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201846.00,A,3648.17662,N,12147.27956,W,0.019,297.11,230525,,,D*74 2025-05-23T20:18:46.918Z,1748031526.918 [NAL9602](INFO): GPS fix at 20250523T201846: (36.802944, -121.787993) 2025-05-23T20:18:46.928Z,1748031526.928 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:18:46.928Z,1748031526.928 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:18:54.578Z,1748031534.578 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0024.lzma 2025-05-23T20:18:55.581Z,1748031535.581 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0024.lzma.bak 2025-05-23T20:18:55.581Z,1748031535.581 [DataOverHttps](INFO): SBD MOMSN=24968531 2025-05-23T20:18:56.649Z,1748031536.649 [NAL9602](INFO): SBD MO Status=0, MOMSN=9467, MT Status=0, MTMSN=0 2025-05-23T20:18:56.649Z,1748031536.649 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:19:11.966Z,1748031551.966 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250523T193540/Express0025.lzma 2025-05-23T20:19:12.968Z,1748031552.968 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0025.lzma.bak 2025-05-23T20:19:12.969Z,1748031552.969 [DataOverHttps](INFO): SBD MOMSN=24968537 2025-05-23T20:19:14.414Z,1748031554.414 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:19:14.414Z,1748031554.414 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:19:14.414Z,1748031554.414 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:19:27.332Z,1748031567.332 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:24:14.989Z,1748031854.989 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:24:14.989Z,1748031854.989 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:24:14.989Z,1748031854.989 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:24:14.989Z,1748031854.989 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:24:15.389Z,1748031855.389 [Default:CheckIn:D] Stopped 2025-05-23T20:24:15.389Z,1748031855.389 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:24:15.786Z,1748031855.786 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 70.771143 min 2025-05-23T20:24:15.786Z,1748031855.786 [Default:CheckIn:E] Stopped 2025-05-23T20:24:15.786Z,1748031855.786 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:24:15.786Z,1748031855.786 [Default:CheckIn] Stopped 2025-05-23T20:24:15.786Z,1748031855.786 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:24:15.787Z,1748031855.787 [Default:CheckIn](INFO): Running loop #13 2025-05-23T20:24:15.787Z,1748031855.787 [Default:CheckIn] Running Loop=13 2025-05-23T20:24:15.787Z,1748031855.787 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:24:15.787Z,1748031855.787 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:24:17.802Z,1748031857.802 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202417.00,A,3648.17686,N,12147.27832,W,0.039,297.11,230525,,,D*74 2025-05-23T20:24:17.804Z,1748031857.804 [NAL9602](INFO): GPS fix at 20250523T202417: (36.802948, -121.787972) 2025-05-23T20:24:17.814Z,1748031857.814 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:24:17.814Z,1748031857.814 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:24:25.446Z,1748031865.446 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0027.lzma 2025-05-23T20:24:26.449Z,1748031866.449 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0027.lzma.bak 2025-05-23T20:24:26.449Z,1748031866.449 [DataOverHttps](INFO): SBD MOMSN=24968573 2025-05-23T20:24:32.345Z,1748031872.345 [NAL9602](INFO): SBD MO Status=0, MOMSN=9468, MT Status=0, MTMSN=0 2025-05-23T20:24:32.345Z,1748031872.345 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:24:42.314Z,1748031882.314 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250523T193540/Express0028.lzma 2025-05-23T20:24:43.316Z,1748031883.316 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0028.lzma.bak 2025-05-23T20:24:43.317Z,1748031883.317 [DataOverHttps](INFO): SBD MOMSN=24968626 2025-05-23T20:24:44.889Z,1748031884.889 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:24:44.889Z,1748031884.889 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:24:44.889Z,1748031884.889 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:25:03.048Z,1748031903.048 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:25:34.152Z,1748031934.152 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:25:46.677Z,1748031946.677 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:25:58.796Z,1748031958.796 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:26:10.917Z,1748031970.917 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:26:23.439Z,1748031983.439 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:26:35.563Z,1748031995.563 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:26:48.086Z,1748032008.086 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:29:23.629Z,1748032163.629 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:29:35.343Z,1748032175.343 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:29:38.979Z,1748032178.979 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:29:45.472Z,1748032185.472 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:29:45.472Z,1748032185.472 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:29:45.472Z,1748032185.472 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:29:45.473Z,1748032185.473 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:29:45.859Z,1748032185.859 [Default:CheckIn:D] Stopped 2025-05-23T20:29:45.859Z,1748032185.859 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:29:46.270Z,1748032186.270 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 76.278971 min 2025-05-23T20:29:46.270Z,1748032186.270 [Default:CheckIn:E] Stopped 2025-05-23T20:29:46.270Z,1748032186.270 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:29:46.270Z,1748032186.270 [Default:CheckIn] Stopped 2025-05-23T20:29:46.270Z,1748032186.270 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:29:46.271Z,1748032186.271 [Default:CheckIn](INFO): Running loop #14 2025-05-23T20:29:46.271Z,1748032186.271 [Default:CheckIn] Running Loop=14 2025-05-23T20:29:46.271Z,1748032186.271 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:29:46.271Z,1748032186.271 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:29:48.274Z,1748032188.274 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202947.00,A,3648.17847,N,12147.27854,W,0.019,297.11,230525,,,D*7D 2025-05-23T20:29:48.277Z,1748032188.277 [NAL9602](INFO): GPS fix at 20250523T202947: (36.802974, -121.787976) 2025-05-23T20:29:48.302Z,1748032188.302 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:29:48.302Z,1748032188.302 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:29:50.696Z,1748032190.696 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:29:53.928Z,1748032193.928 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:29:55.746Z,1748032195.746 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0030.lzma 2025-05-23T20:29:56.748Z,1748032196.748 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0030.lzma.bak 2025-05-23T20:29:56.748Z,1748032196.748 [DataOverHttps](INFO): SBD MOMSN=24968695 2025-05-23T20:30:05.249Z,1748032205.249 [NAL9602](INFO): SBD MO Status=2, MOMSN=9469, MT Status=2, MTMSN=0 2025-05-23T20:30:05.249Z,1748032205.249 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-23T20:30:06.049Z,1748032206.049 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:08.874Z,1748032208.874 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:12.587Z,1748032212.587 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20250523T193540/Express0031.lzma 2025-05-23T20:30:13.588Z,1748032213.588 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0031.lzma.bak 2025-05-23T20:30:13.589Z,1748032213.589 [DataOverHttps](INFO): SBD MOMSN=24968731 2025-05-23T20:30:13.733Z,1748032213.733 [NAL9602](INFO): SBD MO Status=0, MOMSN=9469, MT Status=0, MTMSN=0 2025-05-23T20:30:13.733Z,1748032213.733 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:30:14.966Z,1748032214.966 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:30:14.966Z,1748032214.966 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:30:14.966Z,1748032214.966 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:30:21.399Z,1748032221.399 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:24.232Z,1748032224.232 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:36.751Z,1748032236.751 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:39.579Z,1748032239.579 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:44.428Z,1748032244.428 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:30:52.108Z,1748032252.108 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:30:54.930Z,1748032254.930 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:07.455Z,1748032267.455 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:09.880Z,1748032269.880 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:22.808Z,1748032282.808 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:25.230Z,1748032285.230 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:38.159Z,1748032298.159 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:40.182Z,1748032300.182 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-05-23T20:31:51.510Z,1748032311.510 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5. 2025-05-23T20:31:51.512Z,1748032311.512 [BPC1](INFO): Received data from all battery sticks. 2025-05-23T20:35:15.566Z,1748032515.566 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:35:15.566Z,1748032515.566 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:35:15.566Z,1748032515.566 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:35:15.567Z,1748032515.567 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:35:15.973Z,1748032515.973 [Default:CheckIn:D] Stopped 2025-05-23T20:35:15.973Z,1748032515.973 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:35:16.373Z,1748032516.373 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 81.780868 min 2025-05-23T20:35:16.373Z,1748032516.373 [Default:CheckIn:E] Stopped 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn] Stopped 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn](INFO): Running loop #15 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn] Running Loop=15 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:35:16.374Z,1748032516.374 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:35:18.385Z,1748032518.385 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203517.00,A,3648.17765,N,12147.27935,W,0.078,297.11,230525,,,D*7B 2025-05-23T20:35:18.388Z,1748032518.388 [NAL9602](INFO): GPS fix at 20250523T203517: (36.802961, -121.787989) 2025-05-23T20:35:18.398Z,1748032518.398 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:35:18.398Z,1748032518.398 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:35:25.647Z,1748032525.647 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20250523T193540/Courier0033.lzma 2025-05-23T20:35:26.648Z,1748032526.648 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0033.lzma.bak 2025-05-23T20:35:26.649Z,1748032526.649 [DataOverHttps](INFO): SBD MOMSN=24968741 2025-05-23T20:35:34.162Z,1748032534.162 [NAL9602](INFO): SBD MO Status=0, MOMSN=9470, MT Status=0, MTMSN=0 2025-05-23T20:35:34.162Z,1748032534.162 [NAL9602](INFO): No messages in MT queue 2025-05-23T20:35:42.607Z,1748032542.607 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250523T193540/Express0034.lzma 2025-05-23T20:35:43.610Z,1748032543.610 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0034.lzma.bak 2025-05-23T20:35:43.610Z,1748032543.610 [DataOverHttps](INFO): SBD MOMSN=24968744 2025-05-23T20:35:45.083Z,1748032545.083 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:35:45.083Z,1748032545.083 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:35:45.083Z,1748032545.083 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:36:04.856Z,1748032564.856 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:40:45.653Z,1748032845.653 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:40:45.653Z,1748032845.653 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:40:45.653Z,1748032845.653 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:40:45.653Z,1748032845.653 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:40:46.065Z,1748032846.065 [Default:CheckIn:D] Stopped 2025-05-23T20:40:46.065Z,1748032846.065 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:40:46.461Z,1748032846.461 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 87.282406 min 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn:E] Stopped 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn] Stopped 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn](INFO): Running loop #16 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn] Running Loop=16 2025-05-23T20:40:46.462Z,1748032846.462 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:40:46.463Z,1748032846.463 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:40:48.475Z,1748032848.475 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204047.00,A,3648.16457,N,12147.28199,W,0.369,126.34,230525,,,D*73 2025-05-23T20:40:48.477Z,1748032848.477 [NAL9602](INFO): GPS fix at 20250523T204047: (36.802743, -121.788033) 2025-05-23T20:40:48.487Z,1748032848.487 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:40:48.487Z,1748032848.487 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:40:56.054Z,1748032856.054 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250523T193540/Courier0036.lzma 2025-05-23T20:40:57.056Z,1748032857.056 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0036.lzma.bak 2025-05-23T20:40:57.057Z,1748032857.057 [DataOverHttps](INFO): SBD MOMSN=24968815 2025-05-23T20:41:14.770Z,1748032874.770 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20250523T193540/Express0037.lzma 2025-05-23T20:41:15.772Z,1748032875.772 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0037.lzma.bak 2025-05-23T20:41:15.773Z,1748032875.773 [DataOverHttps](INFO): SBD MOMSN=24968818 2025-05-23T20:41:17.201Z,1748032877.201 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:41:17.202Z,1748032877.202 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:41:17.202Z,1748032877.202 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:45:50.297Z,1748033150.297 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-23T20:46:17.788Z,1748033177.788 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:46:17.788Z,1748033177.788 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:46:17.788Z,1748033177.788 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:46:17.788Z,1748033177.788 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:46:18.201Z,1748033178.201 [Default:CheckIn:D] Stopped 2025-05-23T20:46:18.201Z,1748033178.201 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:46:18.593Z,1748033178.593 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 92.818001 min 2025-05-23T20:46:18.593Z,1748033178.593 [Default:CheckIn:E] Stopped 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn] Stopped 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn](INFO): Running loop #17 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn] Running Loop=17 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:46:18.594Z,1748033178.594 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:46:20.603Z,1748033180.603 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204619.00,A,3648.17652,N,12147.26796,W,3.032,60.01,230525,,,A*41 2025-05-23T20:46:20.605Z,1748033180.605 [NAL9602](INFO): GPS fix at 20250523T204619: (36.802942, -121.787799) 2025-05-23T20:46:20.616Z,1748033180.616 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:46:20.616Z,1748033180.616 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:46:29.118Z,1748033189.118 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250523T193540/Courier0039.lzma 2025-05-23T20:46:30.120Z,1748033190.120 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Courier0039.lzma.bak 2025-05-23T20:46:30.121Z,1748033190.121 [DataOverHttps](INFO): SBD MOMSN=24968827 2025-05-23T20:46:46.003Z,1748033206.003 [DataOverHttps](INFO): Sending 263 bytes from file Logs/20250523T193540/Express0040.lzma 2025-05-23T20:46:47.007Z,1748033207.007 [DataOverHttps](INFO): Moved sent file to Logs/20250523T193540/Express0040.lzma.bak 2025-05-23T20:46:47.008Z,1748033207.008 [DataOverHttps](INFO): SBD MOMSN=24968840 2025-05-23T20:46:48.509Z,1748033208.509 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:46:48.509Z,1748033208.509 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-23T20:46:48.509Z,1748033208.509 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-23T20:46:53.344Z,1748033213.344 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-23T20:51:47.471Z,1748033507.471 [CommandExec](IMPORTANT): got command quit 2025-05-23T20:51:48.475Z,1748033508.475 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:48.475Z,1748033508.475 [CommandExec](INFO): Uninitializing the command executive. 2025-05-23T20:51:48.475Z,1748033508.475 [CommandExec](INFO): Uninitializing the command scheduler. 2025-05-23T20:51:48.475Z,1748033508.475 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:48.611Z,1748033508.611 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-05-23T20:51:48.611Z,1748033508.611 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-05-23T20:51:48.611Z,1748033508.611 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:48.612Z,1748033508.612 [NavChartDb](INFO): Join timeout helper Thread ID is 6833 2025-05-23T20:51:48.783Z,1748033508.783 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:48.783Z,1748033508.783 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:48.795Z,1748033508.795 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-05-23T20:51:48.795Z,1748033508.795 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:48.795Z,1748033508.795 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6834 2025-05-23T20:51:49.073Z,1748033509.073 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-23T20:51:49.073Z,1748033509.073 [Default:CheckIn:C.Wait] Stopped 2025-05-23T20:51:49.074Z,1748033509.074 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-23T20:51:49.074Z,1748033509.074 [Default:CheckIn:D] Running Loop=1 2025-05-23T20:51:49.110Z,1748033509.110 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:49.116Z,1748033509.116 [WetLabsBB2FL](INFO): Powering down 2025-05-23T20:51:49.117Z,1748033509.117 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:49.135Z,1748033509.135 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-05-23T20:51:49.136Z,1748033509.136 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:49.136Z,1748033509.136 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6835 2025-05-23T20:51:49.482Z,1748033509.482 [Default:CheckIn:D] Stopped 2025-05-23T20:51:49.482Z,1748033509.482 [Default:CheckIn:E] Running Loop=1 2025-05-23T20:51:49.583Z,1748033509.583 [CTD_Seabird](INFO): Powering down 2025-05-23T20:51:49.595Z,1748033509.595 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:49.596Z,1748033509.596 [CTD_Seabird](INFO): Powering down 2025-05-23T20:51:49.606Z,1748033509.606 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:49.615Z,1748033509.615 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-05-23T20:51:49.615Z,1748033509.615 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:49.615Z,1748033509.615 [Radio_Surface](INFO): Join timeout helper Thread ID is 6836 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 98.339355 min 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn:E] Stopped 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn] Stopped 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn](INFO): Running loop #18 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn] Running Loop=18 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-23T20:51:49.899Z,1748033509.899 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-23T20:51:49.999Z,1748033509.999 [Radio_Surface](INFO): Powering down 2025-05-23T20:51:49.000Z,1748033510.000 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:50.000Z,1748033510.000 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:50.003Z,1748033510.003 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-05-23T20:51:50.003Z,1748033510.003 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:50.003Z,1748033510.003 [Onboard](INFO): Join timeout helper Thread ID is 6837 2025-05-23T20:51:50.967Z,1748033510.967 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-05-23T20:51:51.897Z,1748033511.897 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205151.00,A,3648.17254,N,12147.26763,W,0.330,60.01,230525,,,A*41 2025-05-23T20:51:51.900Z,1748033511.900 [NAL9602](INFO): GPS fix at 20250523T205151: (36.802876, -121.787794) 2025-05-23T20:51:51.910Z,1748033511.910 [Default:CheckIn:Read_GPS] Stopped 2025-05-23T20:51:51.910Z,1748033511.910 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-23T20:51:54.103Z,1748033514.103 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:54.103Z,1748033514.103 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:54.113Z,1748033514.113 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-05-23T20:51:54.113Z,1748033514.113 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:54.114Z,1748033514.114 [DataOverHttps](INFO): Join timeout helper Thread ID is 6838 2025-05-23T20:51:54.983Z,1748033514.983 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:54.983Z,1748033514.983 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.001Z,1748033515.001 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-05-23T20:51:55.001Z,1748033515.001 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.001Z,1748033515.001 [DAT](INFO): Join timeout helper Thread ID is 6839 2025-05-23T20:51:55.007Z,1748033515.007 [DAT](INFO): Powering down 2025-05-23T20:51:55.079Z,1748033515.079 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:55.079Z,1748033515.079 [DAT](INFO): Powering down 2025-05-23T20:51:55.080Z,1748033515.080 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.095Z,1748033515.095 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-05-23T20:51:55.095Z,1748033515.095 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.096Z,1748033515.096 [BackseatComponent](INFO): Join timeout helper Thread ID is 6840 2025-05-23T20:51:55.215Z,1748033515.215 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:55.215Z,1748033515.215 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.232Z,1748033515.232 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-05-23T20:51:55.232Z,1748033515.232 [logger ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.232Z,1748033515.232 [logger](INFO): Join timeout helper Thread ID is 6841 2025-05-23T20:51:55.265Z,1748033515.265 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:55.265Z,1748033515.265 [logger ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.271Z,1748033515.271 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-05-23T20:51:55.272Z,1748033515.272 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.272Z,1748033515.272 [CommandLine](INFO): Join timeout helper Thread ID is 6842 2025-05-23T20:51:55.287Z,1748033515.287 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:55.287Z,1748033515.287 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.291Z,1748033515.291 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-05-23T20:51:55.292Z,1748033515.292 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.292Z,1748033515.292 [CommandExec](INFO): Join timeout helper Thread ID is 6843 2025-05-23T20:51:55.293Z,1748033515.293 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-05-23T20:51:55.293Z,1748033515.293 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.294Z,1748033515.294 [controlThread](INFO): Join timeout helper Thread ID is 6844 2025-05-23T20:51:55.507Z,1748033515.507 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-23T20:51:55.507Z,1748033515.507 [controlThread](DEBUG): Uninitializing ControlThread 2025-05-23T20:51:55.508Z,1748033515.508 [AHRS_M2](INFO): Powering down 2025-05-23T20:51:55.587Z,1748033515.587 [NAL9602](INFO): Powering down 2025-05-23T20:51:55.588Z,1748033515.588 [Sonardyne_Nano](INFO): Powering down 2025-05-23T20:51:55.707Z,1748033515.707 [Waterlinked](INFO): Powering down 2025-05-23T20:51:55.795Z,1748033515.795 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-05-23T20:51:55.796Z,1748033515.796 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-05-23T20:51:55.796Z,1748033515.796 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-05-23T20:51:55.797Z,1748033515.797 [MissionManager](INFO): Uninitializing Mission Default 2025-05-23T20:51:55.797Z,1748033515.797 [Default] Stopped 2025-05-23T20:51:55.797Z,1748033515.797 [Default](DEBUG): Aggregate::uninitialize Default 2025-05-23T20:51:55.797Z,1748033515.797 [Default:B.GoToSurface] Stopped 2025-05-23T20:51:55.797Z,1748033515.797 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-05-23T20:51:55.797Z,1748033515.797 [Default:CheckIn] Stopped 2025-05-23T20:51:55.797Z,1748033515.797 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-23T20:51:55.797Z,1748033515.797 [Default:CheckIn:Read_Iridium] Stopped 2025-05-23T20:51:55.800Z,1748033515.800 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-05-23T20:51:55.801Z,1748033515.801 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-05-23T20:51:55.801Z,1748033515.801 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-05-23T20:51:55.801Z,1748033515.801 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-05-23T20:51:55.801Z,1748033515.801 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-05-23T20:51:55.802Z,1748033515.802 [BuoyancyServo](INFO): Powering down 2025-05-23T20:51:55.815Z,1748033515.815 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-05-23T20:51:55.815Z,1748033515.815 [ElevatorServo](INFO): Powering down 2025-05-23T20:51:55.816Z,1748033515.816 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-05-23T20:51:55.816Z,1748033515.816 [MassServo](INFO): Powering down 2025-05-23T20:51:55.817Z,1748033515.817 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-05-23T20:51:55.817Z,1748033515.817 [RudderServo](INFO): Powering down 2025-05-23T20:51:55.818Z,1748033515.818 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-05-23T20:51:55.818Z,1748033515.818 [ThrusterHE](INFO): Powering down 2025-05-23T20:51:55.819Z,1748033515.819 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-05-23T20:51:55.819Z,1748033515.819 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-05-23T20:51:55.819Z,1748033515.819 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-05-23T20:51:55.819Z,1748033515.819 [CBIT](DEBUG): Powering off loads. 2025-05-23T20:51:55.830Z,1748033515.830 [CBIT](DEBUG): Disabling WDT. 2025-05-23T20:51:55.843Z,1748033515.843 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-05-23T20:51:55.843Z,1748033515.843 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-05-23T20:51:55.844Z,1748033515.844 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.899Z,1748033515.899 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.902Z,1748033515.902 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.908Z,1748033515.908 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.915Z,1748033515.915 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.957Z,1748033515.957 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:55.997Z,1748033515.997 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:56.002Z,1748033516.002 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:56.021Z,1748033516.021 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-05-23T20:51:56.021Z,1748033516.021 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-05-23T20:51:56.036Z,1748033516.036 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-23T20:51:56.087Z,1748033516.087 [logger ThreadHandler](INFO): Thread cancelled.