2025-11-21T19:32:08.994Z,1763753528.994 [CommandExec](IMPORTANT): got command restart logs 2025-11-21T19:35:44.143Z,1763753744.143 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T19:35:44.143Z,1763753744.143 [Default:CheckIn:C.Wait] Stopped 2025-11-21T19:35:44.143Z,1763753744.143 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T19:35:44.143Z,1763753744.143 [Default:CheckIn:D] Running Loop=1 2025-11-21T19:35:44.583Z,1763753744.583 [Default:CheckIn:D] Stopped 2025-11-21T19:35:44.583Z,1763753744.583 [Default:CheckIn:E] Running Loop=1 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.300254 min 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn:E] Stopped 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn] Stopped 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn](INFO): Running loop #2 2025-11-21T19:35:44.951Z,1763753744.951 [Default:CheckIn] Running Loop=2 2025-11-21T19:35:44.952Z,1763753744.952 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T19:35:44.952Z,1763753744.952 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T19:35:46.967Z,1763753746.967 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193546.00,A,3648.37960,N,12149.59641,W,1.419,245.95,211125,,,D*71 2025-11-21T19:35:46.969Z,1763753746.969 [NAL9602](INFO): GPS fix at 20251121T193546: (36.806327, -121.826607) 2025-11-21T19:35:46.979Z,1763753746.979 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T19:35:46.979Z,1763753746.979 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T19:35:53.783Z,1763753753.783 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20251121T042623/Courier0100.lzma 2025-11-21T19:35:54.786Z,1763753754.786 [DataOverHttps](INFO): Moved sent file to Logs/20251121T042623/Courier0100.lzma.bak 2025-11-21T19:35:54.786Z,1763753754.786 [DataOverHttps](INFO): SBD MOMSN=26335751 2025-11-21T19:36:01.915Z,1763753761.915 [NAL9602](INFO): SBD MO Status=0, MOMSN=12210, MT Status=0, MTMSN=0 2025-11-21T19:36:01.915Z,1763753761.915 [NAL9602](INFO): No messages in MT queue 2025-11-21T19:36:32.617Z,1763753792.617 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T19:36:33.924Z,1763753793.924 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20251121T193208/Courier0000.lzma 2025-11-21T19:36:34.926Z,1763753794.926 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0000.lzma.bak 2025-11-21T19:36:34.926Z,1763753794.926 [DataOverHttps](INFO): SBD MOMSN=26335755 2025-11-21T19:36:57.748Z,1763753817.748 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20251121T042623/Express0101.lzma 2025-11-21T19:36:58.750Z,1763753818.750 [DataOverHttps](INFO): Moved sent file to Logs/20251121T042623/Express0101.lzma.bak 2025-11-21T19:36:58.750Z,1763753818.750 [DataOverHttps](INFO): SBD MOMSN=26335761 2025-11-21T19:37:14.492Z,1763753834.492 [DataOverHttps](INFO): Sending 493 bytes from file Logs/20251121T193208/Express0001.lzma 2025-11-21T19:37:15.494Z,1763753835.494 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0001.lzma.bak 2025-11-21T19:37:15.494Z,1763753835.494 [DataOverHttps](INFO): SBD MOMSN=26335766 2025-11-21T19:37:16.662Z,1763753836.662 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T19:37:16.663Z,1763753836.663 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T19:37:16.663Z,1763753836.663 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T19:42:17.249Z,1763754137.249 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T19:42:17.249Z,1763754137.249 [Default:CheckIn:C.Wait] Stopped 2025-11-21T19:42:17.249Z,1763754137.249 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T19:42:17.250Z,1763754137.250 [Default:CheckIn:D] Running Loop=1 2025-11-21T19:42:17.646Z,1763754137.646 [Default:CheckIn:D] Stopped 2025-11-21T19:42:17.646Z,1763754137.646 [Default:CheckIn:E] Running Loop=1 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.851312 min 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn:E] Stopped 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn] Stopped 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn](INFO): Running loop #3 2025-11-21T19:42:18.047Z,1763754138.047 [Default:CheckIn] Running Loop=3 2025-11-21T19:42:18.048Z,1763754138.048 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T19:42:18.048Z,1763754138.048 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T19:42:20.067Z,1763754140.067 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194219.00,A,3648.47213,N,12147.25369,W,7.659,48.80,211125,,,D*42 2025-11-21T19:42:20.070Z,1763754140.070 [NAL9602](INFO): GPS fix at 20251121T194219: (36.807869, -121.787561) 2025-11-21T19:42:20.080Z,1763754140.080 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T19:42:20.080Z,1763754140.080 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T19:42:29.272Z,1763754149.272 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20251121T193208/Courier0003.lzma 2025-11-21T19:42:30.178Z,1763754150.178 [NAL9602](INFO): SBD MO Status=0, MOMSN=12211, MT Status=0, MTMSN=0 2025-11-21T19:42:30.179Z,1763754150.179 [NAL9602](INFO): No messages in MT queue 2025-11-21T19:42:30.274Z,1763754150.274 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0003.lzma.bak 2025-11-21T19:42:30.274Z,1763754150.274 [DataOverHttps](INFO): SBD MOMSN=26335799 2025-11-21T19:42:46.236Z,1763754166.236 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20251121T193208/Express0005.lzma 2025-11-21T19:42:47.238Z,1763754167.238 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0005.lzma.bak 2025-11-21T19:42:47.238Z,1763754167.238 [DataOverHttps](INFO): SBD MOMSN=26335802 2025-11-21T19:42:48.777Z,1763754168.777 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T19:42:48.777Z,1763754168.777 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T19:42:48.777Z,1763754168.777 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T19:43:00.881Z,1763754180.881 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T19:47:49.365Z,1763754469.365 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T19:47:49.365Z,1763754469.365 [Default:CheckIn:C.Wait] Stopped 2025-11-21T19:47:49.366Z,1763754469.366 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T19:47:49.366Z,1763754469.366 [Default:CheckIn:D] Running Loop=1 2025-11-21T19:47:49.772Z,1763754469.772 [Default:CheckIn:D] Stopped 2025-11-21T19:47:49.772Z,1763754469.772 [Default:CheckIn:E] Running Loop=1 2025-11-21T19:47:50.181Z,1763754470.181 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.386739 min 2025-11-21T19:47:50.181Z,1763754470.181 [Default:CheckIn:E] Stopped 2025-11-21T19:47:50.181Z,1763754470.181 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T19:47:50.181Z,1763754470.181 [Default:CheckIn] Stopped 2025-11-21T19:47:50.181Z,1763754470.181 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T19:47:50.182Z,1763754470.182 [Default:CheckIn](INFO): Running loop #4 2025-11-21T19:47:50.182Z,1763754470.182 [Default:CheckIn] Running Loop=4 2025-11-21T19:47:50.182Z,1763754470.182 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T19:47:50.182Z,1763754470.182 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T19:47:52.187Z,1763754472.187 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194751.00,A,3648.15068,N,12147.21911,W,0.039,198.81,211125,,,D*79 2025-11-21T19:47:52.189Z,1763754472.189 [NAL9602](INFO): GPS fix at 20251121T194751: (36.802511, -121.786985) 2025-11-21T19:47:52.214Z,1763754472.214 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T19:47:52.215Z,1763754472.215 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T19:47:59.803Z,1763754479.803 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0009.lzma 2025-11-21T19:48:00.806Z,1763754480.806 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0009.lzma.bak 2025-11-21T19:48:00.806Z,1763754480.806 [DataOverHttps](INFO): SBD MOMSN=26335824 2025-11-21T19:48:09.158Z,1763754489.158 [NAL9602](INFO): SBD MO Status=0, MOMSN=12212, MT Status=0, MTMSN=0 2025-11-21T19:48:09.159Z,1763754489.159 [NAL9602](INFO): No messages in MT queue 2025-11-21T19:48:16.572Z,1763754496.572 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20251121T193208/Express0010.lzma 2025-11-21T19:48:17.574Z,1763754497.574 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0010.lzma.bak 2025-11-21T19:48:17.574Z,1763754497.574 [DataOverHttps](INFO): SBD MOMSN=26335827 2025-11-21T19:48:18.869Z,1763754498.869 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T19:48:18.869Z,1763754498.869 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T19:48:18.869Z,1763754498.869 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T19:48:39.857Z,1763754519.857 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T19:53:19.433Z,1763754799.433 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T19:53:19.434Z,1763754799.434 [Default:CheckIn:C.Wait] Stopped 2025-11-21T19:53:19.434Z,1763754799.434 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T19:53:19.434Z,1763754799.434 [Default:CheckIn:D] Running Loop=1 2025-11-21T19:53:19.840Z,1763754799.840 [Default:CheckIn:D] Stopped 2025-11-21T19:53:19.840Z,1763754799.840 [Default:CheckIn:E] Running Loop=1 2025-11-21T19:53:20.251Z,1763754800.251 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.887880 min 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn:E] Stopped 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn] Stopped 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn](INFO): Running loop #5 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn] Running Loop=5 2025-11-21T19:53:20.252Z,1763754800.252 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T19:53:20.253Z,1763754800.253 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T19:53:22.259Z,1763754802.259 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195321.00,A,3648.14342,N,12147.22716,W,1.594,209.64,211125,,,D*78 2025-11-21T19:53:22.261Z,1763754802.261 [NAL9602](INFO): GPS fix at 20251121T195321: (36.802390, -121.787119) 2025-11-21T19:53:22.289Z,1763754802.289 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T19:53:22.289Z,1763754802.289 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T19:53:29.480Z,1763754809.480 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0012.lzma 2025-11-21T19:53:30.478Z,1763754810.478 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0012.lzma.bak 2025-11-21T19:53:30.478Z,1763754810.478 [DataOverHttps](INFO): SBD MOMSN=26335853 2025-11-21T19:53:34.399Z,1763754814.399 [NAL9602](INFO): SBD MO Status=0, MOMSN=12213, MT Status=0, MTMSN=0 2025-11-21T19:53:34.399Z,1763754814.399 [NAL9602](INFO): No messages in MT queue 2025-11-21T19:53:46.484Z,1763754826.484 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20251121T193208/Express0013.lzma 2025-11-21T19:53:47.486Z,1763754827.486 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0013.lzma.bak 2025-11-21T19:53:47.486Z,1763754827.486 [DataOverHttps](INFO): SBD MOMSN=26335856 2025-11-21T19:53:48.960Z,1763754828.960 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T19:53:48.960Z,1763754828.960 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T19:53:48.960Z,1763754828.960 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T19:54:05.101Z,1763754845.101 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T19:58:49.526Z,1763755129.526 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T19:58:49.526Z,1763755129.526 [Default:CheckIn:C.Wait] Stopped 2025-11-21T19:58:49.526Z,1763755129.526 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T19:58:49.526Z,1763755129.526 [Default:CheckIn:D] Running Loop=1 2025-11-21T19:58:49.930Z,1763755129.930 [Default:CheckIn:D] Stopped 2025-11-21T19:58:49.930Z,1763755129.930 [Default:CheckIn:E] Running Loop=1 2025-11-21T19:58:50.337Z,1763755130.337 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.389378 min 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn:E] Stopped 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn] Stopped 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn](INFO): Running loop #6 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn] Running Loop=6 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T19:58:50.338Z,1763755130.338 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T19:58:52.346Z,1763755132.346 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195851.00,A,3648.17176,N,12147.28117,W,0.019,286.69,211125,,,D*74 2025-11-21T19:58:52.350Z,1763755132.350 [NAL9602](INFO): GPS fix at 20251121T195851: (36.802863, -121.788020) 2025-11-21T19:58:52.375Z,1763755132.375 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T19:58:52.375Z,1763755132.375 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T19:58:59.895Z,1763755139.895 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0015.lzma 2025-11-21T19:59:00.898Z,1763755140.898 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0015.lzma.bak 2025-11-21T19:59:00.898Z,1763755140.898 [DataOverHttps](INFO): SBD MOMSN=26335878 2025-11-21T19:59:16.620Z,1763755156.620 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20251121T193208/Express0016.lzma 2025-11-21T19:59:17.623Z,1763755157.623 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0016.lzma.bak 2025-11-21T19:59:17.623Z,1763755157.623 [DataOverHttps](INFO): SBD MOMSN=26335881 2025-11-21T19:59:19.024Z,1763755159.024 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T19:59:19.024Z,1763755159.024 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T19:59:19.024Z,1763755159.024 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:00:21.631Z,1763755221.631 [NAL9602](INFO): SBD MO Status=0, MOMSN=12214, MT Status=0, MTMSN=0 2025-11-21T20:00:21.631Z,1763755221.631 [NAL9602](INFO): No messages in MT queue 2025-11-21T20:00:52.335Z,1763755252.335 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:04:19.603Z,1763755459.603 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:04:19.603Z,1763755459.603 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:04:19.603Z,1763755459.603 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:04:19.604Z,1763755459.604 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:04:20.003Z,1763755460.003 [Default:CheckIn:D] Stopped 2025-11-21T20:04:20.003Z,1763755460.003 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.890588 min 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn:E] Stopped 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn] Stopped 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn](INFO): Running loop #7 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn] Running Loop=7 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:04:20.407Z,1763755460.407 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:04:22.423Z,1763755462.423 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200422.00,A,3648.17357,N,12147.27869,W,0.194,286.69,211125,,,A*7C 2025-11-21T20:04:22.425Z,1763755462.425 [NAL9602](INFO): GPS fix at 20251121T200422: (36.802893, -121.787978) 2025-11-21T20:04:22.436Z,1763755462.436 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:04:22.436Z,1763755462.436 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:04:31.040Z,1763755471.040 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0018.lzma 2025-11-21T20:04:32.042Z,1763755472.042 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0018.lzma.bak 2025-11-21T20:04:32.042Z,1763755472.042 [DataOverHttps](INFO): SBD MOMSN=26335907 2025-11-21T20:04:35.350Z,1763755475.350 [NAL9602](INFO): SBD MO Status=0, MOMSN=12215, MT Status=0, MTMSN=0 2025-11-21T20:04:35.350Z,1763755475.350 [NAL9602](INFO): No messages in MT queue 2025-11-21T20:05:06.053Z,1763755506.053 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:05:14.520Z,1763755514.520 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-11-21T20:05:43.637Z,1763755543.637 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239384 2025-11-21T20:05:51.980Z,1763755551.980 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003286 2025-11-21T20:05:58.627Z,1763755558.627 [NAL9602](INFO): SBD MO Status=1, MOMSN=12216, MT Status=0, MTMSN=0 2025-11-21T20:05:58.676Z,1763755558.676 [NAL9602](INFO): Sent 149 bytes from file Logs/20251121T193208/Express0019.lzma 2025-11-21T20:05:58.676Z,1763755558.676 [NAL9602](INFO): Packets left to send: 0 2025-11-21T20:05:59.858Z,1763755559.858 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:05:59.859Z,1763755559.859 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:05:59.859Z,1763755559.859 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:06:29.330Z,1763755589.330 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:11:00.438Z,1763755860.438 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:11:00.438Z,1763755860.438 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:11:00.439Z,1763755860.439 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:11:00.439Z,1763755860.439 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:11:00.846Z,1763755860.846 [Default:CheckIn:D] Stopped 2025-11-21T20:11:00.846Z,1763755860.846 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.571305 min 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn:E] Stopped 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn] Stopped 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn](INFO): Running loop #8 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn] Running Loop=8 2025-11-21T20:11:01.243Z,1763755861.243 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:11:01.244Z,1763755861.244 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:11:03.251Z,1763755863.251 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201102.00,A,3648.17234,N,12147.27886,W,0.097,215.68,211125,,,A*76 2025-11-21T20:11:03.254Z,1763755863.254 [NAL9602](INFO): GPS fix at 20251121T201102: (36.802872, -121.787981) 2025-11-21T20:11:03.263Z,1763755863.263 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:11:03.263Z,1763755863.263 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:11:10.563Z,1763755870.563 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0021.lzma 2025-11-21T20:11:11.566Z,1763755871.566 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0021.lzma.bak 2025-11-21T20:11:11.566Z,1763755871.566 [DataOverHttps](INFO): SBD MOMSN=26335952 2025-11-21T20:11:27.377Z,1763755887.377 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20251121T193208/Express0022.lzma 2025-11-21T20:11:28.378Z,1763755888.378 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0022.lzma.bak 2025-11-21T20:11:28.378Z,1763755888.378 [DataOverHttps](INFO): SBD MOMSN=26335957 2025-11-21T20:11:29.935Z,1763755889.935 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:11:29.936Z,1763755889.936 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:11:29.936Z,1763755889.936 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:11:37.599Z,1763755897.599 [NAL9602](INFO): SBD MO Status=2, MOMSN=12217, MT Status=2, MTMSN=0 2025-11-21T20:11:37.599Z,1763755897.599 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:11:52.538Z,1763755912.538 [NAL9602](INFO): SBD MO Status=2, MOMSN=12217, MT Status=2, MTMSN=0 2025-11-21T20:11:52.538Z,1763755912.538 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:12:17.991Z,1763755937.991 [NAL9602](INFO): SBD MO Status=2, MOMSN=12217, MT Status=2, MTMSN=0 2025-11-21T20:12:17.991Z,1763755937.991 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:13:07.683Z,1763755987.683 [NAL9602](INFO): SBD MO Status=2, MOMSN=12217, MT Status=2, MTMSN=0 2025-11-21T20:13:07.683Z,1763755987.683 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:13:17.381Z,1763755997.381 [NAL9602](INFO): SBD MO Status=0, MOMSN=12217, MT Status=0, MTMSN=0 2025-11-21T20:13:17.381Z,1763755997.381 [NAL9602](INFO): No messages in MT queue 2025-11-21T20:13:48.081Z,1763756028.081 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:14:03.434Z,1763756043.434 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:04.643Z,1763756044.643 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:11.863Z,1763756051.863 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:19.132Z,1763756059.132 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:26.810Z,1763756066.810 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:34.486Z,1763756074.486 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:41.756Z,1763756081.756 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:49.836Z,1763756089.836 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:14:56.704Z,1763756096.704 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:05.189Z,1763756105.189 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:11.654Z,1763756111.654 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:20.540Z,1763756120.540 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:27.004Z,1763756127.004 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:35.895Z,1763756135.895 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:41.981Z,1763756141.981 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:51.244Z,1763756151.244 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:15:57.305Z,1763756157.305 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:16:06.597Z,1763756166.597 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:16:12.253Z,1763756172.253 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-11-21T20:16:21.548Z,1763756181.548 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-11-21T20:16:26.797Z,1763756186.797 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-11-21T20:16:26.803Z,1763756186.803 [BPC1](INFO): Calculating totals. Valid battery stick count: 43. Valid reserve battery stick count: 5. 2025-11-21T20:16:26.805Z,1763756186.805 [BPC1](INFO): Received data from all battery sticks. 2025-11-21T20:16:30.445Z,1763756190.445 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:16:30.445Z,1763756190.445 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:16:30.445Z,1763756190.445 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:16:30.445Z,1763756190.445 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:16:30.849Z,1763756190.849 [Default:CheckIn:D] Stopped 2025-11-21T20:16:30.849Z,1763756190.849 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:16:31.268Z,1763756191.268 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.071350 min 2025-11-21T20:16:31.268Z,1763756191.268 [Default:CheckIn:E] Stopped 2025-11-21T20:16:31.268Z,1763756191.268 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:16:31.268Z,1763756191.268 [Default:CheckIn] Stopped 2025-11-21T20:16:31.268Z,1763756191.268 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:16:31.269Z,1763756191.269 [Default:CheckIn](INFO): Running loop #9 2025-11-21T20:16:31.269Z,1763756191.269 [Default:CheckIn] Running Loop=9 2025-11-21T20:16:31.269Z,1763756191.269 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:16:31.269Z,1763756191.269 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:16:33.269Z,1763756193.269 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201632.00,A,3648.17366,N,12147.27876,W,0.039,215.68,211125,,,A*7F 2025-11-21T20:16:33.271Z,1763756193.271 [NAL9602](INFO): GPS fix at 20251121T201632: (36.802894, -121.787979) 2025-11-21T20:16:33.301Z,1763756193.301 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:16:33.301Z,1763756193.301 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:16:40.137Z,1763756200.137 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20251121T193208/Courier0024.lzma 2025-11-21T20:16:41.140Z,1763756201.140 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0024.lzma.bak 2025-11-21T20:16:41.140Z,1763756201.140 [DataOverHttps](INFO): SBD MOMSN=26335971 2025-11-21T20:16:51.075Z,1763756211.075 [NAL9602](INFO): SBD MO Status=0, MOMSN=12218, MT Status=0, MTMSN=0 2025-11-21T20:16:51.075Z,1763756211.075 [NAL9602](INFO): No messages in MT queue 2025-11-21T20:16:56.889Z,1763756216.889 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20251121T193208/Express0025.lzma 2025-11-21T20:16:57.891Z,1763756217.891 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0025.lzma.bak 2025-11-21T20:16:57.892Z,1763756217.892 [DataOverHttps](INFO): SBD MOMSN=26335975 2025-11-21T20:16:59.178Z,1763756219.178 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:16:59.179Z,1763756219.179 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:16:59.179Z,1763756219.179 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:17:21.787Z,1763756241.787 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:21:59.754Z,1763756519.754 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:21:59.754Z,1763756519.754 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:21:59.754Z,1763756519.754 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:21:59.756Z,1763756519.756 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:22:00.152Z,1763756520.152 [Default:CheckIn:D] Stopped 2025-11-21T20:22:00.152Z,1763756520.152 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.559737 min 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn:E] Stopped 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn] Stopped 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn](INFO): Running loop #10 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn] Running Loop=10 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:22:00.552Z,1763756520.552 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:22:02.567Z,1763756522.567 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202201.00,A,3648.18595,N,12147.26231,W,0.544,337.35,211125,,,D*76 2025-11-21T20:22:02.569Z,1763756522.569 [NAL9602](INFO): GPS fix at 20251121T202201: (36.803099, -121.787705) 2025-11-21T20:22:02.579Z,1763756522.579 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:22:02.579Z,1763756522.579 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:22:09.821Z,1763756529.821 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0027.lzma 2025-11-21T20:22:10.823Z,1763756530.823 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0027.lzma.bak 2025-11-21T20:22:10.824Z,1763756530.824 [DataOverHttps](INFO): SBD MOMSN=26336003 2025-11-21T20:22:27.633Z,1763756547.633 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20251121T193208/Express0028.lzma 2025-11-21T20:22:28.636Z,1763756548.636 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0028.lzma.bak 2025-11-21T20:22:28.636Z,1763756548.636 [DataOverHttps](INFO): SBD MOMSN=26336007 2025-11-21T20:22:30.055Z,1763756550.055 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:22:30.055Z,1763756550.055 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:22:30.055Z,1763756550.055 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:22:34.492Z,1763756554.492 [NAL9602](INFO): SBD MO Status=2, MOMSN=12219, MT Status=2, MTMSN=0 2025-11-21T20:22:34.492Z,1763756554.492 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:22:51.860Z,1763756571.860 [NAL9602](INFO): SBD MO Status=2, MOMSN=12219, MT Status=2, MTMSN=0 2025-11-21T20:22:51.860Z,1763756571.860 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:27:04.357Z,1763756824.357 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-11-21T20:27:22.131Z,1763756842.131 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-11-21T20:27:22.131Z,1763756842.131 [DropWeight] Hardware Fault, FailCount= 1 2025-11-21T20:27:22.131Z,1763756842.131 [DropWeight](ERROR): Hardware Fault 2025-11-21T20:27:22.152Z,1763756842.152 [CommandExec](FAULT): Scheduling is paused 2025-11-21T20:27:22.152Z,1763756842.152 [CBIT](INFO): Critical error at 20251121T202722 2025-11-21T20:27:22.155Z,1763756842.155 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-11-21T20:27:22.155Z,1763756842.155 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-11-21T20:27:22.596Z,1763756842.596 [CBIT](INFO): Critical error at 20251121T202722 2025-11-21T20:27:30.635Z,1763756850.635 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:27:30.635Z,1763756850.635 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:27:30.635Z,1763756850.635 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:27:30.635Z,1763756850.635 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:27:31.027Z,1763756851.027 [Default:CheckIn:D] Stopped 2025-11-21T20:27:31.027Z,1763756851.027 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:27:31.436Z,1763756851.436 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.074329 min 2025-11-21T20:27:31.436Z,1763756851.436 [Default:CheckIn:E] Stopped 2025-11-21T20:27:31.436Z,1763756851.436 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:27:31.437Z,1763756851.437 [Default:CheckIn] Stopped 2025-11-21T20:27:31.437Z,1763756851.437 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:27:31.437Z,1763756851.437 [Default:CheckIn](INFO): Running loop #11 2025-11-21T20:27:31.437Z,1763756851.437 [Default:CheckIn] Running Loop=11 2025-11-21T20:27:31.437Z,1763756851.437 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:27:31.437Z,1763756851.437 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:27:33.451Z,1763756853.451 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202732.00,A,3648.18686,N,12147.26881,W,0.408,337.35,211125,,,D*7A 2025-11-21T20:27:33.453Z,1763756853.453 [NAL9602](INFO): GPS fix at 20251121T202732: (36.803114, -121.787813) 2025-11-21T20:27:33.465Z,1763756853.465 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:27:33.466Z,1763756853.466 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:27:40.874Z,1763756860.874 [DataOverHttps](INFO): Sending 178 bytes from file Logs/20251121T193208/Courier0030.lzma 2025-11-21T20:27:41.872Z,1763756861.872 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0030.lzma.bak 2025-11-21T20:27:41.873Z,1763756861.873 [DataOverHttps](INFO): SBD MOMSN=26336019 2025-11-21T20:27:57.605Z,1763756877.605 [DataOverHttps](INFO): Sending 272 bytes from file Logs/20251121T193208/Express0031.lzma 2025-11-21T20:27:58.604Z,1763756878.604 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0031.lzma.bak 2025-11-21T20:27:58.604Z,1763756878.604 [DataOverHttps](INFO): SBD MOMSN=26336026 2025-11-21T20:28:00.129Z,1763756880.129 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:28:00.129Z,1763756880.129 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:28:00.129Z,1763756880.129 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:28:05.358Z,1763756885.358 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:33:00.701Z,1763757180.701 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:33:00.701Z,1763757180.701 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:33:00.702Z,1763757180.702 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:33:00.702Z,1763757180.702 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:33:01.113Z,1763757181.113 [Default:CheckIn:D] Stopped 2025-11-21T20:33:01.113Z,1763757181.113 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:33:01.512Z,1763757181.512 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 65.575757 min 2025-11-21T20:33:01.512Z,1763757181.512 [Default:CheckIn:E] Stopped 2025-11-21T20:33:01.512Z,1763757181.512 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:33:01.512Z,1763757181.512 [Default:CheckIn] Stopped 2025-11-21T20:33:01.512Z,1763757181.512 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:33:01.513Z,1763757181.513 [Default:CheckIn](INFO): Running loop #12 2025-11-21T20:33:01.513Z,1763757181.513 [Default:CheckIn] Running Loop=12 2025-11-21T20:33:01.513Z,1763757181.513 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:33:01.513Z,1763757181.513 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:33:03.526Z,1763757183.526 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203302.00,A,3648.16271,N,12147.28389,W,0.156,337.35,211125,,,A*78 2025-11-21T20:33:03.528Z,1763757183.528 [NAL9602](INFO): GPS fix at 20251121T203302: (36.802712, -121.788065) 2025-11-21T20:33:03.539Z,1763757183.539 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:33:03.539Z,1763757183.539 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:33:10.903Z,1763757190.903 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0033.lzma 2025-11-21T20:33:11.904Z,1763757191.904 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0033.lzma.bak 2025-11-21T20:33:11.904Z,1763757191.904 [DataOverHttps](INFO): SBD MOMSN=26336045 2025-11-21T20:33:27.686Z,1763757207.686 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20251121T193208/Express0034.lzma 2025-11-21T20:33:28.688Z,1763757208.688 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0034.lzma.bak 2025-11-21T20:33:28.688Z,1763757208.688 [DataOverHttps](INFO): SBD MOMSN=26336054 2025-11-21T20:33:30.208Z,1763757210.208 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:33:30.208Z,1763757210.208 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:33:30.208Z,1763757210.208 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:33:34.223Z,1763757214.223 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-11-21T20:33:34.298Z,1763757214.298 [NAL9602](ERROR): received: +CSQ:0 OK219, 2, 0, 0, 0 OK 2025-11-21T20:38:19.852Z,1763757499.852 [NAL9602](INFO): SBD MO Status=2, MOMSN=12219, MT Status=2, MTMSN=0 2025-11-21T20:38:19.852Z,1763757499.852 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T20:38:20.255Z,1763757500.255 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-11-21T20:38:30.768Z,1763757510.768 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:38:30.768Z,1763757510.768 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:38:30.768Z,1763757510.768 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:38:30.768Z,1763757510.768 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:38:31.176Z,1763757511.176 [Default:CheckIn:D] Stopped 2025-11-21T20:38:31.176Z,1763757511.176 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.076815 min 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn:E] Stopped 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn] Stopped 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn](INFO): Running loop #13 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn] Running Loop=13 2025-11-21T20:38:31.576Z,1763757511.576 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:38:31.577Z,1763757511.577 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:38:33.588Z,1763757513.588 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203832.00,A,3648.16303,N,12147.27798,W,0.408,0.00,211125,,,A*70 2025-11-21T20:38:33.591Z,1763757513.591 [NAL9602](INFO): GPS fix at 20251121T203832: (36.802717, -121.787966) 2025-11-21T20:38:33.600Z,1763757513.600 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:38:33.600Z,1763757513.600 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:38:40.401Z,1763757520.401 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20251121T193208/Courier0036.lzma 2025-11-21T20:38:41.404Z,1763757521.404 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0036.lzma.bak 2025-11-21T20:38:41.404Z,1763757521.404 [DataOverHttps](INFO): SBD MOMSN=26336092 2025-11-21T20:38:57.065Z,1763757537.065 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20251121T193208/Express0037.lzma 2025-11-21T20:38:58.068Z,1763757538.068 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0037.lzma.bak 2025-11-21T20:38:58.068Z,1763757538.068 [DataOverHttps](INFO): SBD MOMSN=26336097 2025-11-21T20:38:59.478Z,1763757539.478 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:38:59.479Z,1763757539.479 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:38:59.479Z,1763757539.479 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:39:05.527Z,1763757545.527 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:42:22.289Z,1763757742.289 [CBIT](INFO): Clearing failed state for component DropWeight 2025-11-21T20:42:22.289Z,1763757742.289 [DropWeight] No Fault, FailCount= 1 2025-11-21T20:44:00.051Z,1763757840.051 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:44:00.051Z,1763757840.051 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:44:00.051Z,1763757840.051 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:44:00.051Z,1763757840.051 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:44:00.461Z,1763757840.461 [Default:CheckIn:D] Stopped 2025-11-21T20:44:00.461Z,1763757840.461 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 76.564884 min 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn:E] Stopped 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn] Stopped 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn](INFO): Running loop #14 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn] Running Loop=14 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:44:00.879Z,1763757840.879 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:44:02.868Z,1763757842.868 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204402.00,A,3648.15820,N,12147.28006,W,0.428,0.00,211125,,,D*79 2025-11-21T20:44:02.871Z,1763757842.871 [NAL9602](INFO): GPS fix at 20251121T204402: (36.802637, -121.788001) 2025-11-21T20:44:02.881Z,1763757842.881 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:44:02.881Z,1763757842.881 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:44:09.767Z,1763757849.767 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0039.lzma 2025-11-21T20:44:10.768Z,1763757850.768 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0039.lzma.bak 2025-11-21T20:44:10.769Z,1763757850.769 [DataOverHttps](INFO): SBD MOMSN=26336149 2025-11-21T20:44:26.618Z,1763757866.618 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20251121T193208/Express0040.lzma 2025-11-21T20:44:27.620Z,1763757867.620 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0040.lzma.bak 2025-11-21T20:44:27.620Z,1763757867.620 [DataOverHttps](INFO): SBD MOMSN=26336154 2025-11-21T20:44:28.799Z,1763757868.799 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:44:28.799Z,1763757868.799 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:44:28.799Z,1763757868.799 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:49:05.518Z,1763758145.518 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-11-21T20:49:29.364Z,1763758169.364 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:49:29.364Z,1763758169.364 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:49:29.364Z,1763758169.364 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:49:29.365Z,1763758169.365 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:49:29.811Z,1763758169.811 [Default:CheckIn:D] Stopped 2025-11-21T20:49:29.811Z,1763758169.811 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.054053 min 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn:E] Stopped 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn] Stopped 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn](INFO): Running loop #15 2025-11-21T20:49:30.175Z,1763758170.175 [Default:CheckIn] Running Loop=15 2025-11-21T20:49:30.176Z,1763758170.176 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:49:30.176Z,1763758170.176 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:49:32.194Z,1763758172.194 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204931.00,A,3648.14920,N,12147.28089,W,2.585,0.00,211125,,,D*77 2025-11-21T20:49:32.196Z,1763758172.196 [NAL9602](INFO): GPS fix at 20251121T204931: (36.802487, -121.788015) 2025-11-21T20:49:32.206Z,1763758172.206 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:49:32.206Z,1763758172.206 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:49:39.453Z,1763758179.453 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20251121T193208/Courier0042.lzma 2025-11-21T20:49:40.456Z,1763758180.456 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0042.lzma.bak 2025-11-21T20:49:40.456Z,1763758180.456 [DataOverHttps](INFO): SBD MOMSN=26336178 2025-11-21T20:49:56.201Z,1763758196.201 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20251121T193208/Express0043.lzma 2025-11-21T20:49:57.204Z,1763758197.204 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0043.lzma.bak 2025-11-21T20:49:57.205Z,1763758197.205 [DataOverHttps](INFO): SBD MOMSN=26336182 2025-11-21T20:49:58.489Z,1763758198.489 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:49:58.489Z,1763758198.489 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:49:58.489Z,1763758198.489 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:50:04.535Z,1763758204.535 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T20:54:59.055Z,1763758499.055 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T20:54:59.055Z,1763758499.055 [Default:CheckIn:C.Wait] Stopped 2025-11-21T20:54:59.055Z,1763758499.055 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T20:54:59.056Z,1763758499.056 [Default:CheckIn:D] Running Loop=1 2025-11-21T20:54:59.469Z,1763758499.469 [Default:CheckIn:D] Stopped 2025-11-21T20:54:59.469Z,1763758499.469 [Default:CheckIn:E] Running Loop=1 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 87.548356 min 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn:E] Stopped 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn] Stopped 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn](INFO): Running loop #16 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn] Running Loop=16 2025-11-21T20:54:59.876Z,1763758499.876 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T20:54:59.877Z,1763758499.877 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T20:55:01.880Z,1763758501.880 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205501.00,A,3648.15268,N,12147.27703,W,0.641,276.34,211125,,,A*7D 2025-11-21T20:55:01.883Z,1763758501.883 [NAL9602](INFO): GPS fix at 20251121T205501: (36.802545, -121.787950) 2025-11-21T20:55:01.913Z,1763758501.913 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T20:55:01.913Z,1763758501.913 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T20:55:09.361Z,1763758509.361 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0045.lzma 2025-11-21T20:55:10.364Z,1763758510.364 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0045.lzma.bak 2025-11-21T20:55:10.364Z,1763758510.364 [DataOverHttps](INFO): SBD MOMSN=26336211 2025-11-21T20:55:26.093Z,1763758526.093 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20251121T193208/Express0046.lzma 2025-11-21T20:55:27.096Z,1763758527.096 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0046.lzma.bak 2025-11-21T20:55:27.096Z,1763758527.096 [DataOverHttps](INFO): SBD MOMSN=26336214 2025-11-21T20:55:28.562Z,1763758528.562 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T20:55:28.562Z,1763758528.562 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T20:55:28.562Z,1763758528.562 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T20:55:32.579Z,1763758532.579 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-11-21T20:55:32.658Z,1763758532.658 [NAL9602](ERROR): received: +CSQ:0 OK219, 2, 0, 0, 0 OK 2025-11-21T21:00:04.475Z,1763758804.475 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-11-21T21:00:29.135Z,1763758829.135 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T21:00:29.135Z,1763758829.135 [Default:CheckIn:C.Wait] Stopped 2025-11-21T21:00:29.135Z,1763758829.135 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T21:00:29.136Z,1763758829.136 [Default:CheckIn:D] Running Loop=1 2025-11-21T21:00:29.548Z,1763758829.548 [Default:CheckIn:D] Stopped 2025-11-21T21:00:29.548Z,1763758829.548 [Default:CheckIn:E] Running Loop=1 2025-11-21T21:00:29.944Z,1763758829.944 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 93.049674 min 2025-11-21T21:00:29.944Z,1763758829.944 [Default:CheckIn:E] Stopped 2025-11-21T21:00:29.944Z,1763758829.944 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T21:00:29.944Z,1763758829.944 [Default:CheckIn] Stopped 2025-11-21T21:00:29.945Z,1763758829.945 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T21:00:29.945Z,1763758829.945 [Default:CheckIn](INFO): Running loop #17 2025-11-21T21:00:29.945Z,1763758829.945 [Default:CheckIn] Running Loop=17 2025-11-21T21:00:29.945Z,1763758829.945 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T21:00:29.945Z,1763758829.945 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T21:00:31.952Z,1763758831.952 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210031.00,A,3648.15775,N,12147.27850,W,0.836,276.34,211125,,,A*71 2025-11-21T21:00:31.955Z,1763758831.955 [NAL9602](INFO): GPS fix at 20251121T210031: (36.802629, -121.787975) 2025-11-21T21:00:31.965Z,1763758831.965 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T21:00:31.965Z,1763758831.965 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T21:00:39.201Z,1763758839.201 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0048.lzma 2025-11-21T21:00:40.204Z,1763758840.204 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0048.lzma.bak 2025-11-21T21:00:40.204Z,1763758840.204 [DataOverHttps](INFO): SBD MOMSN=26336245 2025-11-21T21:00:56.141Z,1763758856.141 [DataOverHttps](INFO): Sending 229 bytes from file Logs/20251121T193208/Express0049.lzma 2025-11-21T21:00:57.144Z,1763758857.144 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0049.lzma.bak 2025-11-21T21:00:57.144Z,1763758857.144 [DataOverHttps](INFO): SBD MOMSN=26336248 2025-11-21T21:00:58.634Z,1763758858.634 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T21:00:58.634Z,1763758858.634 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T21:00:58.634Z,1763758858.634 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T21:01:04.679Z,1763758864.679 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T21:05:59.200Z,1763759159.200 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T21:05:59.200Z,1763759159.200 [Default:CheckIn:C.Wait] Stopped 2025-11-21T21:05:59.200Z,1763759159.200 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T21:05:59.201Z,1763759159.201 [Default:CheckIn:D] Running Loop=1 2025-11-21T21:05:59.612Z,1763759159.612 [Default:CheckIn:D] Stopped 2025-11-21T21:05:59.612Z,1763759159.612 [Default:CheckIn:E] Running Loop=1 2025-11-21T21:06:00.021Z,1763759160.021 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 98.550741 min 2025-11-21T21:06:00.021Z,1763759160.021 [Default:CheckIn:E] Stopped 2025-11-21T21:06:00.021Z,1763759160.021 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T21:06:00.021Z,1763759160.021 [Default:CheckIn] Stopped 2025-11-21T21:06:00.021Z,1763759160.021 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T21:06:00.022Z,1763759160.022 [Default:CheckIn](INFO): Running loop #18 2025-11-21T21:06:00.022Z,1763759160.022 [Default:CheckIn] Running Loop=18 2025-11-21T21:06:00.022Z,1763759160.022 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T21:06:00.022Z,1763759160.022 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T21:06:02.021Z,1763759162.021 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210601.00,A,3648.15452,N,12147.27516,W,0.739,0.00,211125,,,A*79 2025-11-21T21:06:02.023Z,1763759162.023 [NAL9602](INFO): GPS fix at 20251121T210601: (36.802575, -121.787919) 2025-11-21T21:06:02.033Z,1763759162.033 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T21:06:02.033Z,1763759162.033 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T21:06:08.865Z,1763759168.865 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20251121T193208/Courier0051.lzma 2025-11-21T21:06:09.868Z,1763759169.868 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0051.lzma.bak 2025-11-21T21:06:09.868Z,1763759169.868 [DataOverHttps](INFO): SBD MOMSN=26336277 2025-11-21T21:06:25.634Z,1763759185.634 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20251121T193208/Express0052.lzma 2025-11-21T21:06:26.636Z,1763759186.636 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0052.lzma.bak 2025-11-21T21:06:26.636Z,1763759186.636 [DataOverHttps](INFO): SBD MOMSN=26336280 2025-11-21T21:06:27.916Z,1763759187.916 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T21:06:27.916Z,1763759187.916 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T21:06:27.917Z,1763759187.917 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T21:06:32.747Z,1763759192.747 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-11-21T21:06:32.822Z,1763759192.822 [NAL9602](ERROR): received: +CSQ:0 OK219, 2, 0, 0, 0 OK 2025-11-21T21:09:02.228Z,1763759342.228 [NAL9602](INFO): SBD MO Status=2, MOMSN=12219, MT Status=2, MTMSN=0 2025-11-21T21:09:02.228Z,1763759342.228 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-11-21T21:09:20.008Z,1763759360.008 [NAL9602](INFO): SBD MO Status=0, MOMSN=12219, MT Status=0, MTMSN=0 2025-11-21T21:09:20.008Z,1763759360.008 [NAL9602](INFO): No messages in MT queue 2025-11-21T21:09:50.706Z,1763759390.706 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T21:11:28.489Z,1763759488.489 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T21:11:28.489Z,1763759488.489 [Default:CheckIn:C.Wait] Stopped 2025-11-21T21:11:28.489Z,1763759488.489 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T21:11:28.489Z,1763759488.489 [Default:CheckIn:D] Running Loop=1 2025-11-21T21:11:28.896Z,1763759488.896 [Default:CheckIn:D] Stopped 2025-11-21T21:11:28.896Z,1763759488.896 [Default:CheckIn:E] Running Loop=1 2025-11-21T21:11:29.287Z,1763759489.287 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 104.038810 min 2025-11-21T21:11:29.287Z,1763759489.287 [Default:CheckIn:E] Stopped 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn] Stopped 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn](INFO): Running loop #19 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn] Running Loop=19 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T21:11:29.288Z,1763759489.288 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T21:11:31.300Z,1763759491.300 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211130.00,A,3648.15120,N,12147.28218,W,0.175,109.51,211125,,,A*79 2025-11-21T21:11:31.302Z,1763759491.302 [NAL9602](INFO): GPS fix at 20251121T211130: (36.802520, -121.788036) 2025-11-21T21:11:31.312Z,1763759491.312 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T21:11:31.312Z,1763759491.312 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T21:11:38.573Z,1763759498.573 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20251121T193208/Courier0054.lzma 2025-11-21T21:11:39.576Z,1763759499.576 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0054.lzma.bak 2025-11-21T21:11:39.576Z,1763759499.576 [DataOverHttps](INFO): SBD MOMSN=26336313 2025-11-21T21:12:23.819Z,1763759543.819 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-11-21T21:12:23.819Z,1763759543.819 [DropWeight] Hardware Fault, FailCount= 1 2025-11-21T21:12:23.819Z,1763759543.819 [DropWeight](ERROR): Hardware Fault 2025-11-21T21:12:23.903Z,1763759543.903 [CBIT](INFO): Critical error at 20251121T211223 2025-11-21T21:12:23.910Z,1763759543.910 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-11-21T21:12:23.910Z,1763759543.910 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-11-21T21:12:24.268Z,1763759544.268 [CBIT](INFO): Critical error at 20251121T211223 2025-11-21T21:12:26.961Z,1763759546.961 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20251121T193208/Express0055.lzma 2025-11-21T21:12:27.964Z,1763759547.964 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0055.lzma.bak 2025-11-21T21:12:27.964Z,1763759547.964 [DataOverHttps](INFO): SBD MOMSN=26336318 2025-11-21T21:12:29.489Z,1763759549.489 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T21:12:29.489Z,1763759549.489 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T21:12:29.489Z,1763759549.489 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T21:16:33.511Z,1763759793.511 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-11-21T21:17:04.210Z,1763759824.210 [NAL9602](INFO): Not Powering down - fast GPS 2025-11-21T21:17:05.833Z,1763759825.833 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-11-21T21:17:30.085Z,1763759850.085 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-11-21T21:17:30.085Z,1763759850.085 [Default:CheckIn:C.Wait] Stopped 2025-11-21T21:17:30.085Z,1763759850.085 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T21:17:30.096Z,1763759850.096 [Default:CheckIn:D] Running Loop=1 2025-11-21T21:17:30.503Z,1763759850.503 [Default:CheckIn:D] Stopped 2025-11-21T21:17:30.503Z,1763759850.503 [Default:CheckIn:E] Running Loop=1 2025-11-21T21:17:30.919Z,1763759850.919 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 110.065584 min 2025-11-21T21:17:30.919Z,1763759850.919 [Default:CheckIn:E] Stopped 2025-11-21T21:17:30.919Z,1763759850.919 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-11-21T21:17:30.920Z,1763759850.920 [Default:CheckIn] Stopped 2025-11-21T21:17:30.920Z,1763759850.920 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T21:17:30.920Z,1763759850.920 [Default:CheckIn](INFO): Running loop #20 2025-11-21T21:17:30.920Z,1763759850.920 [Default:CheckIn] Running Loop=20 2025-11-21T21:17:30.920Z,1763759850.920 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-11-21T21:17:30.920Z,1763759850.920 [Default:CheckIn:Read_GPS] Running Loop=1 2025-11-21T21:17:32.897Z,1763759852.897 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211732.00,A,3648.14594,N,12147.28095,W,0.855,109.51,211125,,,A*7B 2025-11-21T21:17:32.899Z,1763759852.899 [NAL9602](INFO): GPS fix at 20251121T211732: (36.802432, -121.788016) 2025-11-21T21:17:32.927Z,1763759852.927 [Default:CheckIn:Read_GPS] Stopped 2025-11-21T21:17:32.927Z,1763759852.927 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-11-21T21:17:33.310Z,1763759853.310 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:17:35.131Z,1763759855.131 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:17:44.762Z,1763759864.762 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20251121T193208/Courier0057.lzma 2025-11-21T21:17:45.308Z,1763759865.308 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:17:45.764Z,1763759865.764 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Courier0057.lzma.bak 2025-11-21T21:17:45.764Z,1763759865.764 [DataOverHttps](INFO): SBD MOMSN=26336379 2025-11-21T21:17:51.694Z,1763759871.694 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:17:56.659Z,1763759876.659 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:03.415Z,1763759883.415 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-11-21T21:18:03.490Z,1763759883.490 [NAL9602](ERROR): received: +CSQ:0 OK219, 0, 0, 0, 0 OK 2025-11-21T21:18:08.386Z,1763759888.386 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:08.387Z,1763759888.387 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:09.734Z,1763759889.734 [DataOverHttps](INFO): Sending 225 bytes from file Logs/20251121T193208/Express0058.lzma 2025-11-21T21:18:10.736Z,1763759890.736 [DataOverHttps](INFO): Moved sent file to Logs/20251121T193208/Express0058.lzma.bak 2025-11-21T21:18:10.736Z,1763759890.736 [DataOverHttps](INFO): SBD MOMSN=26336388 2025-11-21T21:18:12.330Z,1763759892.330 [Default:CheckIn:Read_Iridium] Stopped 2025-11-21T21:18:12.330Z,1763759892.330 [Default:CheckIn:C.Wait] Running Loop=1 2025-11-21T21:18:12.331Z,1763759892.331 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-11-21T21:18:20.098Z,1763759900.098 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:25.631Z,1763759905.631 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:32.185Z,1763759912.185 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:32.190Z,1763759912.190 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:43.943Z,1763759923.943 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:43.944Z,1763759923.944 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:52.702Z,1763759932.702 [CommandExec](IMPORTANT): got command quit 2025-11-21T21:18:53.706Z,1763759933.706 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:53.706Z,1763759933.706 [CommandExec](INFO): Uninitializing the command executive. 2025-11-21T21:18:53.706Z,1763759933.706 [CommandExec](INFO): Uninitializing the command scheduler. 2025-11-21T21:18:53.707Z,1763759933.707 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:53.746Z,1763759933.746 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-11-21T21:18:53.746Z,1763759933.746 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-11-21T21:18:53.746Z,1763759933.746 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:53.747Z,1763759933.747 [NavChartDb](INFO): Join timeout helper Thread ID is 8376 2025-11-21T21:18:53.850Z,1763759933.850 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:53.851Z,1763759933.851 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:53.866Z,1763759933.866 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-11-21T21:18:53.866Z,1763759933.866 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:53.866Z,1763759933.866 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8377 2025-11-21T21:18:54.326Z,1763759934.326 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:54.326Z,1763759934.326 [WetLabsBB2FL](INFO): Powering down 2025-11-21T21:18:54.327Z,1763759934.327 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:54.338Z,1763759934.338 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-11-21T21:18:54.338Z,1763759934.338 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:54.338Z,1763759934.338 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8378 2025-11-21T21:18:54.778Z,1763759934.778 [CTD_Seabird](INFO): Powering down 2025-11-21T21:18:54.790Z,1763759934.790 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:54.790Z,1763759934.790 [CTD_Seabird](INFO): Powering down 2025-11-21T21:18:54.802Z,1763759934.802 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:54.802Z,1763759934.802 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-11-21T21:18:54.802Z,1763759934.802 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:54.803Z,1763759934.803 [Radio_Surface](INFO): Join timeout helper Thread ID is 8379 2025-11-21T21:18:55.058Z,1763759935.058 [Radio_Surface](INFO): Powering down 2025-11-21T21:18:55.059Z,1763759935.059 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:55.059Z,1763759935.059 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:55.078Z,1763759935.078 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-11-21T21:18:55.078Z,1763759935.078 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:55.078Z,1763759935.078 [Onboard](INFO): Join timeout helper Thread ID is 8380 2025-11-21T21:18:55.154Z,1763759935.154 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:55.154Z,1763759935.154 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:55.159Z,1763759935.159 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-11-21T21:18:55.159Z,1763759935.159 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:55.159Z,1763759935.159 [DataOverHttps](INFO): Join timeout helper Thread ID is 8381 2025-11-21T21:18:55.525Z,1763759935.525 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-11-21T21:18:57.476Z,1763759937.476 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:57.479Z,1763759937.479 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.482Z,1763759937.482 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-11-21T21:18:57.482Z,1763759937.482 [DAT ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.483Z,1763759937.483 [DAT](INFO): Join timeout helper Thread ID is 8382 2025-11-21T21:18:57.670Z,1763759937.670 [DAT](INFO): Powering down 2025-11-21T21:18:57.742Z,1763759937.742 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:57.742Z,1763759937.742 [DAT](INFO): Powering down 2025-11-21T21:18:57.743Z,1763759937.743 [DAT ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.746Z,1763759937.746 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-11-21T21:18:57.746Z,1763759937.746 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.747Z,1763759937.747 [BackseatComponent](INFO): Join timeout helper Thread ID is 8383 2025-11-21T21:18:57.826Z,1763759937.826 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:57.826Z,1763759937.826 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.846Z,1763759937.846 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-11-21T21:18:57.847Z,1763759937.847 [logger ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.847Z,1763759937.847 [logger](INFO): Join timeout helper Thread ID is 8384 2025-11-21T21:18:57.882Z,1763759937.882 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:57.882Z,1763759937.882 [logger ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.886Z,1763759937.886 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-11-21T21:18:57.887Z,1763759937.887 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.887Z,1763759937.887 [CommandLine](INFO): Join timeout helper Thread ID is 8385 2025-11-21T21:18:57.950Z,1763759937.950 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:57.950Z,1763759937.950 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.952Z,1763759937.952 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-11-21T21:18:57.952Z,1763759937.952 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.952Z,1763759937.952 [CommandExec](INFO): Join timeout helper Thread ID is 8386 2025-11-21T21:18:57.958Z,1763759937.958 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-11-21T21:18:57.959Z,1763759937.959 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:57.959Z,1763759937.959 [controlThread](INFO): Join timeout helper Thread ID is 8387 2025-11-21T21:18:57.980Z,1763759937.980 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-11-21T21:18:57.980Z,1763759937.980 [controlThread](DEBUG): Uninitializing ControlThread 2025-11-21T21:18:57.980Z,1763759937.980 [AHRS_M2](INFO): Powering down 2025-11-21T21:18:58.058Z,1763759938.058 [NAL9602](INFO): Powering down 2025-11-21T21:18:58.059Z,1763759938.059 [Sonardyne_Nano](INFO): Powering down 2025-11-21T21:18:58.266Z,1763759938.266 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-11-21T21:18:58.267Z,1763759938.267 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-11-21T21:18:58.267Z,1763759938.267 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-11-21T21:18:58.268Z,1763759938.268 [MissionManager](INFO): Uninitializing Mission Default 2025-11-21T21:18:58.268Z,1763759938.268 [Default] Stopped 2025-11-21T21:18:58.268Z,1763759938.268 [Default](DEBUG): Aggregate::uninitialize Default 2025-11-21T21:18:58.268Z,1763759938.268 [Default:B.GoToSurface] Stopped 2025-11-21T21:18:58.268Z,1763759938.268 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-11-21T21:18:58.268Z,1763759938.268 [Default:CheckIn] Stopped 2025-11-21T21:18:58.268Z,1763759938.268 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-11-21T21:18:58.268Z,1763759938.268 [Default:CheckIn:C.Wait] Stopped 2025-11-21T21:18:58.268Z,1763759938.268 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-11-21T21:18:58.271Z,1763759938.271 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-11-21T21:18:58.272Z,1763759938.272 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-11-21T21:18:58.272Z,1763759938.272 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-11-21T21:18:58.272Z,1763759938.272 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-11-21T21:18:58.272Z,1763759938.272 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-11-21T21:18:58.273Z,1763759938.273 [BuoyancyServo](INFO): Powering down 2025-11-21T21:18:58.286Z,1763759938.286 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-11-21T21:18:58.286Z,1763759938.286 [ElevatorServo](INFO): Powering down 2025-11-21T21:18:58.287Z,1763759938.287 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-11-21T21:18:58.287Z,1763759938.287 [MassServo](INFO): Powering down 2025-11-21T21:18:58.288Z,1763759938.288 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-11-21T21:18:58.288Z,1763759938.288 [RudderServo](INFO): Powering down 2025-11-21T21:18:58.289Z,1763759938.289 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-11-21T21:18:58.289Z,1763759938.289 [ThrusterHE](INFO): Powering down 2025-11-21T21:18:58.290Z,1763759938.290 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-11-21T21:18:58.290Z,1763759938.290 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-11-21T21:18:58.290Z,1763759938.290 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-11-21T21:18:58.291Z,1763759938.291 [CBIT](DEBUG): Powering off loads. 2025-11-21T21:18:58.301Z,1763759938.301 [CBIT](DEBUG): Disabling WDT. 2025-11-21T21:18:58.314Z,1763759938.314 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-11-21T21:18:58.314Z,1763759938.314 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-11-21T21:18:58.315Z,1763759938.315 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.371Z,1763759938.371 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.374Z,1763759938.374 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.380Z,1763759938.380 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.387Z,1763759938.387 [DAT ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.430Z,1763759938.430 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.481Z,1763759938.481 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.486Z,1763759938.486 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.506Z,1763759938.506 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-11-21T21:18:58.506Z,1763759938.506 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-11-21T21:18:58.520Z,1763759938.520 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-11-21T21:18:58.588Z,1763759938.588 [logger ThreadHandler](INFO): Thread cancelled.