2026-01-22T21:20:05.011Z,1769116805.011 [DataOverHttps](INFO): Received command: restart logs 2026-01-22T21:20:05.021Z,1769116805.021 [CommandExec](IMPORTANT): got command restart logs 2026-01-22T21:20:46.526Z,1769116846.526 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:20:46.526Z,1769116846.526 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:20:46.526Z,1769116846.526 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:20:46.526Z,1769116846.526 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:20:46.931Z,1769116846.931 [Default:CheckIn:D] Stopped 2026-01-22T21:20:46.931Z,1769116846.931 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.773464 min 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn:E] Stopped 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn] Stopped 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn](INFO): Running loop #4 2026-01-22T21:20:47.331Z,1769116847.331 [Default:CheckIn] Running Loop=4 2026-01-22T21:20:47.332Z,1769116847.332 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:20:47.332Z,1769116847.332 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:20:49.367Z,1769116849.367 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212046.00,A,3647.51618,N,12150.97947,W,0.214,135.32,220126,,,D*70 2026-01-22T21:20:49.369Z,1769116849.369 [NAL9602](INFO): GPS fix at 20260122T212046: (36.791936, -121.849658) 2026-01-22T21:20:49.379Z,1769116849.379 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:20:49.379Z,1769116849.379 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:20:56.999Z,1769116856.999 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20260122T183820/Courier0045.lzma 2026-01-22T21:20:58.002Z,1769116858.002 [DataOverHttps](INFO): Moved sent file to Logs/20260122T183820/Courier0045.lzma.bak 2026-01-22T21:20:58.002Z,1769116858.002 [DataOverHttps](INFO): SBD MOMSN=26586393 2026-01-22T21:21:09.949Z,1769116869.949 [NAL9602](INFO): SBD MO Status=2, MOMSN=25376, MT Status=2, MTMSN=0 2026-01-22T21:21:09.950Z,1769116869.950 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T21:21:17.149Z,1769116877.149 [DataOverHttps](INFO): Sending 273 bytes from file Logs/20260122T212005/Courier0000.lzma 2026-01-22T21:21:18.150Z,1769116878.150 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0000.lzma.bak 2026-01-22T21:21:18.150Z,1769116878.150 [DataOverHttps](INFO): SBD MOMSN=26586395 2026-01-22T21:21:35.923Z,1769116895.923 [DataOverHttps](INFO): Sending 124 bytes from file Logs/20260122T183820/Express0046.lzma 2026-01-22T21:21:36.922Z,1769116896.922 [DataOverHttps](INFO): Moved sent file to Logs/20260122T183820/Express0046.lzma.bak 2026-01-22T21:21:36.922Z,1769116896.922 [DataOverHttps](INFO): SBD MOMSN=26586399 2026-01-22T21:21:52.981Z,1769116912.981 [DataOverHttps](INFO): Sending 580 bytes from file Logs/20260122T212005/Express0001.lzma 2026-01-22T21:21:53.981Z,1769116913.981 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0001.lzma.bak 2026-01-22T21:21:53.982Z,1769116913.982 [DataOverHttps](INFO): SBD MOMSN=26586402 2026-01-22T21:22:09.831Z,1769116929.831 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20260122T212005/Express0004.lzma 2026-01-22T21:22:10.834Z,1769116930.834 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0004.lzma.bak 2026-01-22T21:22:10.834Z,1769116930.834 [DataOverHttps](INFO): SBD MOMSN=26586406 2026-01-22T21:22:12.185Z,1769116932.185 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:22:12.185Z,1769116932.185 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:22:12.185Z,1769116932.185 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:22:17.827Z,1769116937.827 [NAL9602](INFO): SBD MO Status=2, MOMSN=25376, MT Status=2, MTMSN=0 2026-01-22T21:22:17.827Z,1769116937.827 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T21:22:29.566Z,1769116949.566 [NAL9602](INFO): SBD MO Status=0, MOMSN=25376, MT Status=0, MTMSN=0 2026-01-22T21:22:29.567Z,1769116949.567 [NAL9602](INFO): No messages in MT queue 2026-01-22T21:23:00.239Z,1769116980.239 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T21:26:18.236Z,1769117178.236 [GFScanner](IMPORTANT): Beginning ground fault scan 2026-01-22T21:26:22.697Z,1769117182.697 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.026464 CHAN A1 (24V): 0.023981 CHAN A2 (12V): -0.036275 CHAN A3 (5V): -0.071208 CHAN B0 (3.3V): -0.018484 CHAN B1 (3.15aV): -0.007514 CHAN B2 (3.15bV): -0.002974 CHAN B3 (GND): -0.020877 OPEN: 0.010664 Full Scale: +/- 1 mA 2026-01-22T21:27:12.753Z,1769117232.753 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:27:12.753Z,1769117232.753 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:27:12.753Z,1769117232.753 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:27:12.754Z,1769117232.754 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:27:13.158Z,1769117233.158 [Default:CheckIn:D] Stopped 2026-01-22T21:27:13.158Z,1769117233.158 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:27:13.567Z,1769117233.567 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.210581 min 2026-01-22T21:27:13.567Z,1769117233.567 [Default:CheckIn:E] Stopped 2026-01-22T21:27:13.567Z,1769117233.567 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:27:13.568Z,1769117233.568 [Default:CheckIn] Stopped 2026-01-22T21:27:13.568Z,1769117233.568 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:27:13.568Z,1769117233.568 [Default:CheckIn](INFO): Running loop #5 2026-01-22T21:27:13.568Z,1769117233.568 [Default:CheckIn] Running Loop=5 2026-01-22T21:27:13.568Z,1769117233.568 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:27:13.568Z,1769117233.568 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:27:15.579Z,1769117235.579 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212712.00,A,3648.25042,N,12147.95416,W,21.616,83.64,220126,,,D*74 2026-01-22T21:27:15.582Z,1769117235.582 [NAL9602](INFO): GPS fix at 20260122T212712: (36.804174, -121.799236) 2026-01-22T21:27:15.593Z,1769117235.593 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:27:15.594Z,1769117235.594 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:27:23.167Z,1769117243.167 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20260122T212005/Courier0006.lzma 2026-01-22T21:27:24.170Z,1769117244.170 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0006.lzma.bak 2026-01-22T21:27:24.170Z,1769117244.170 [DataOverHttps](INFO): SBD MOMSN=26586408 2026-01-22T21:27:40.784Z,1769117260.784 [DataOverHttps](INFO): Sending 396 bytes from file Logs/20260122T212005/Express0007.lzma 2026-01-22T21:27:41.786Z,1769117261.786 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0007.lzma.bak 2026-01-22T21:27:41.786Z,1769117261.786 [DataOverHttps](INFO): SBD MOMSN=26586411 2026-01-22T21:27:43.067Z,1769117263.067 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:27:43.067Z,1769117263.067 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:27:43.067Z,1769117263.067 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:29:57.610Z,1769117397.610 [NAL9602](INFO): SBD MO Status=0, MOMSN=25377, MT Status=0, MTMSN=0 2026-01-22T21:29:57.610Z,1769117397.610 [NAL9602](INFO): No messages in MT queue 2026-01-22T21:30:28.307Z,1769117428.307 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T21:32:43.663Z,1769117563.663 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:32:43.663Z,1769117563.663 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:32:43.663Z,1769117563.663 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:32:43.663Z,1769117563.663 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:32:44.130Z,1769117564.130 [Default:CheckIn:D] Stopped 2026-01-22T21:32:44.130Z,1769117564.130 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:32:44.551Z,1769117564.551 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 28.726780 min 2026-01-22T21:32:44.551Z,1769117564.551 [Default:CheckIn:E] Stopped 2026-01-22T21:32:44.551Z,1769117564.551 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:32:44.551Z,1769117564.551 [Default:CheckIn] Stopped 2026-01-22T21:32:44.556Z,1769117564.556 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:32:44.556Z,1769117564.556 [Default:CheckIn](INFO): Running loop #6 2026-01-22T21:32:44.556Z,1769117564.556 [Default:CheckIn] Running Loop=6 2026-01-22T21:32:44.556Z,1769117564.556 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:32:44.556Z,1769117564.556 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:32:46.483Z,1769117566.483 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213243.00,A,3648.30451,N,12147.13576,W,4.374,189.59,220126,,,D*7C 2026-01-22T21:32:46.486Z,1769117566.486 [NAL9602](INFO): GPS fix at 20260122T213243: (36.805075, -121.785596) 2026-01-22T21:32:46.496Z,1769117566.496 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:32:46.496Z,1769117566.496 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:32:53.868Z,1769117573.868 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0009.lzma 2026-01-22T21:32:55.008Z,1769117575.008 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0009.lzma.bak 2026-01-22T21:32:55.009Z,1769117575.009 [DataOverHttps](INFO): SBD MOMSN=26586416 2026-01-22T21:33:10.772Z,1769117590.772 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20260122T212005/Express0010.lzma 2026-01-22T21:33:11.774Z,1769117591.774 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0010.lzma.bak 2026-01-22T21:33:11.774Z,1769117591.774 [DataOverHttps](INFO): SBD MOMSN=26586419 2026-01-22T21:33:13.154Z,1769117593.154 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:33:13.154Z,1769117593.154 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:33:13.154Z,1769117593.154 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:35:00.665Z,1769117700.665 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-01-22T21:37:34.136Z,1769117854.136 [NAL9602](INFO): SBD MO Status=2, MOMSN=25378, MT Status=2, MTMSN=0 2026-01-22T21:37:34.137Z,1769117854.137 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T21:37:55.147Z,1769117875.147 [NAL9602](INFO): SBD MO Status=0, MOMSN=25378, MT Status=0, MTMSN=0 2026-01-22T21:37:55.147Z,1769117875.147 [NAL9602](INFO): No messages in MT queue 2026-01-22T21:38:13.738Z,1769117893.738 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:38:13.738Z,1769117893.738 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:38:13.739Z,1769117893.739 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:38:13.739Z,1769117893.739 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:38:14.138Z,1769117894.138 [Default:CheckIn:D] Stopped 2026-01-22T21:38:14.138Z,1769117894.138 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.226917 min 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn:E] Stopped 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn] Stopped 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn](INFO): Running loop #7 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn] Running Loop=7 2026-01-22T21:38:14.542Z,1769117894.542 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:38:14.543Z,1769117894.543 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:38:16.567Z,1769117896.567 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213813.00,A,3648.15488,N,12147.22039,W,0.175,194.80,220126,,,D*73 2026-01-22T21:38:16.569Z,1769117896.569 [NAL9602](INFO): GPS fix at 20260122T213813: (36.802581, -121.787007) 2026-01-22T21:38:16.587Z,1769117896.587 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:38:16.587Z,1769117896.587 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:38:24.119Z,1769117904.119 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0012.lzma 2026-01-22T21:38:25.122Z,1769117905.122 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0012.lzma.bak 2026-01-22T21:38:25.122Z,1769117905.122 [DataOverHttps](INFO): SBD MOMSN=26586422 2026-01-22T21:38:41.508Z,1769117921.508 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20260122T212005/Express0013.lzma 2026-01-22T21:38:42.510Z,1769117922.510 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0013.lzma.bak 2026-01-22T21:38:42.510Z,1769117922.510 [DataOverHttps](INFO): SBD MOMSN=26586425 2026-01-22T21:38:44.059Z,1769117924.059 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:38:44.059Z,1769117924.059 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:38:44.059Z,1769117924.059 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:38:48.465Z,1769117928.465 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T21:43:44.683Z,1769118224.683 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:43:44.683Z,1769118224.683 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:43:44.683Z,1769118224.683 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:43:44.683Z,1769118224.683 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:43:45.091Z,1769118225.091 [Default:CheckIn:D] Stopped 2026-01-22T21:43:45.091Z,1769118225.091 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.742810 min 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn:E] Stopped 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn] Stopped 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn](INFO): Running loop #8 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn] Running Loop=8 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:43:45.490Z,1769118225.490 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:43:47.506Z,1769118227.506 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214344.00,A,3648.15212,N,12147.22113,W,0.019,191.64,220126,,,D*75 2026-01-22T21:43:47.508Z,1769118227.508 [NAL9602](INFO): GPS fix at 20260122T214344: (36.802535, -121.787019) 2026-01-22T21:43:47.518Z,1769118227.518 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:43:47.518Z,1769118227.518 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:43:55.511Z,1769118235.511 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0015.lzma 2026-01-22T21:43:56.514Z,1769118236.514 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0015.lzma.bak 2026-01-22T21:43:56.514Z,1769118236.514 [DataOverHttps](INFO): SBD MOMSN=26586428 2026-01-22T21:44:12.420Z,1769118252.420 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20260122T212005/Express0016.lzma 2026-01-22T21:44:13.357Z,1769118253.357 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2026-01-22T21:44:13.361Z,1769118253.361 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2026-01-22T21:44:13.422Z,1769118253.422 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0016.lzma.bak 2026-01-22T21:44:13.422Z,1769118253.422 [DataOverHttps](INFO): SBD MOMSN=26586431 2026-01-22T21:44:14.991Z,1769118254.991 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:44:14.991Z,1769118254.991 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:44:14.992Z,1769118254.992 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:47:19.213Z,1769118439.213 [NAL9602](INFO): SBD MO Status=2, MOMSN=25379, MT Status=2, MTMSN=0 2026-01-22T21:47:19.213Z,1769118439.213 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T21:48:22.643Z,1769118502.643 [NAL9602](INFO): SBD MO Status=2, MOMSN=25379, MT Status=2, MTMSN=0 2026-01-22T21:48:22.643Z,1769118502.643 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T21:48:44.457Z,1769118524.457 [NAL9602](INFO): SBD MO Status=0, MOMSN=25379, MT Status=0, MTMSN=0 2026-01-22T21:48:44.457Z,1769118524.457 [NAL9602](INFO): No messages in MT queue 2026-01-22T21:49:15.164Z,1769118555.164 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T21:49:15.575Z,1769118555.575 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:49:15.575Z,1769118555.575 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:49:15.575Z,1769118555.575 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:49:15.575Z,1769118555.575 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:49:15.990Z,1769118555.990 [Default:CheckIn:D] Stopped 2026-01-22T21:49:15.990Z,1769118555.990 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:49:16.381Z,1769118556.381 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 45.257792 min 2026-01-22T21:49:16.381Z,1769118556.381 [Default:CheckIn:E] Stopped 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn] Stopped 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn](INFO): Running loop #9 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn] Running Loop=9 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:49:16.382Z,1769118556.382 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:49:18.397Z,1769118558.397 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214915.00,A,3648.15206,N,12147.21962,W,0.058,191.64,220126,,,D*76 2026-01-22T21:49:18.399Z,1769118558.399 [NAL9602](INFO): GPS fix at 20260122T214915: (36.802534, -121.786994) 2026-01-22T21:49:18.410Z,1769118558.410 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:49:18.410Z,1769118558.410 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:49:26.684Z,1769118566.684 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20260122T212005/Courier0018.lzma 2026-01-22T21:49:27.286Z,1769118567.286 [NAL9602](INFO): SBD MO Status=0, MOMSN=25380, MT Status=0, MTMSN=0 2026-01-22T21:49:27.286Z,1769118567.286 [NAL9602](INFO): No messages in MT queue 2026-01-22T21:49:27.686Z,1769118567.686 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0018.lzma.bak 2026-01-22T21:49:27.686Z,1769118567.686 [DataOverHttps](INFO): SBD MOMSN=26586434 2026-01-22T21:49:43.884Z,1769118583.884 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20260122T212005/Express0019.lzma 2026-01-22T21:49:44.886Z,1769118584.886 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0019.lzma.bak 2026-01-22T21:49:44.886Z,1769118584.886 [DataOverHttps](INFO): SBD MOMSN=26586437 2026-01-22T21:49:46.288Z,1769118586.288 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:49:46.288Z,1769118586.288 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:49:46.288Z,1769118586.288 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:49:57.984Z,1769118597.984 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T21:54:46.853Z,1769118886.853 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T21:54:46.853Z,1769118886.853 [Default:CheckIn:C.Wait] Stopped 2026-01-22T21:54:46.853Z,1769118886.853 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T21:54:46.854Z,1769118886.854 [Default:CheckIn:D] Running Loop=1 2026-01-22T21:54:47.257Z,1769118887.257 [Default:CheckIn:D] Stopped 2026-01-22T21:54:47.257Z,1769118887.257 [Default:CheckIn:E] Running Loop=1 2026-01-22T21:54:47.679Z,1769118887.679 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.778906 min 2026-01-22T21:54:47.680Z,1769118887.680 [Default:CheckIn:E] Stopped 2026-01-22T21:54:47.680Z,1769118887.680 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T21:54:47.680Z,1769118887.680 [Default:CheckIn] Stopped 2026-01-22T21:54:47.680Z,1769118887.680 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T21:54:47.680Z,1769118887.680 [Default:CheckIn](INFO): Running loop #10 2026-01-22T21:54:47.681Z,1769118887.681 [Default:CheckIn] Running Loop=10 2026-01-22T21:54:47.681Z,1769118887.681 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T21:54:47.681Z,1769118887.681 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T21:54:49.683Z,1769118889.683 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215446.00,A,3648.15322,N,12147.22179,W,0.097,191.38,220126,,,D*70 2026-01-22T21:54:49.686Z,1769118889.686 [NAL9602](INFO): GPS fix at 20260122T215446: (36.802554, -121.787030) 2026-01-22T21:54:49.697Z,1769118889.697 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T21:54:49.697Z,1769118889.697 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T21:54:57.243Z,1769118897.243 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0021.lzma 2026-01-22T21:54:58.246Z,1769118898.246 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0021.lzma.bak 2026-01-22T21:54:58.246Z,1769118898.246 [DataOverHttps](INFO): SBD MOMSN=26586441 2026-01-22T21:55:14.220Z,1769118914.220 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0022.lzma 2026-01-22T21:55:15.222Z,1769118915.222 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0022.lzma.bak 2026-01-22T21:55:15.222Z,1769118915.222 [DataOverHttps](INFO): SBD MOMSN=26586444 2026-01-22T21:55:16.758Z,1769118916.758 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T21:55:16.758Z,1769118916.758 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T21:55:16.759Z,1769118916.759 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T21:56:17.348Z,1769118977.348 [NAL9602](INFO): SBD MO Status=0, MOMSN=25381, MT Status=0, MTMSN=0 2026-01-22T21:56:17.348Z,1769118977.348 [NAL9602](INFO): No messages in MT queue 2026-01-22T21:56:48.047Z,1769119008.047 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T21:57:17.544Z,1769119037.544 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-01-22T22:00:17.331Z,1769119217.331 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:00:17.331Z,1769119217.331 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:00:17.331Z,1769119217.331 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:00:17.332Z,1769119217.332 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:00:17.742Z,1769119217.742 [Default:CheckIn:D] Stopped 2026-01-22T22:00:17.742Z,1769119217.742 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.286991 min 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn:E] Stopped 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn] Stopped 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn](INFO): Running loop #11 2026-01-22T22:00:18.135Z,1769119218.135 [Default:CheckIn] Running Loop=11 2026-01-22T22:00:18.136Z,1769119218.136 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:00:18.136Z,1769119218.136 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:00:20.163Z,1769119220.163 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220017.00,A,3648.15367,N,12147.22297,W,0.000,236.30,220126,,,D*7C 2026-01-22T22:00:20.165Z,1769119220.165 [NAL9602](INFO): GPS fix at 20260122T220017: (36.802561, -121.787049) 2026-01-22T22:00:20.195Z,1769119220.195 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:00:20.195Z,1769119220.195 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:00:27.539Z,1769119227.539 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0024.lzma 2026-01-22T22:00:28.542Z,1769119228.542 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0024.lzma.bak 2026-01-22T22:00:28.542Z,1769119228.542 [DataOverHttps](INFO): SBD MOMSN=26586447 2026-01-22T22:00:44.035Z,1769119244.035 [NAL9602](INFO): SBD MO Status=0, MOMSN=25382, MT Status=0, MTMSN=0 2026-01-22T22:00:44.035Z,1769119244.035 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:00:46.185Z,1769119246.185 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20260122T212005/Express0025.lzma 2026-01-22T22:00:47.186Z,1769119247.186 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0025.lzma.bak 2026-01-22T22:00:47.186Z,1769119247.186 [DataOverHttps](INFO): SBD MOMSN=26586450 2026-01-22T22:00:48.453Z,1769119248.453 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:00:48.453Z,1769119248.453 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:00:48.453Z,1769119248.453 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:01:14.699Z,1769119274.699 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:05:49.091Z,1769119549.091 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:05:49.091Z,1769119549.091 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:05:49.091Z,1769119549.091 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:05:49.091Z,1769119549.091 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:05:49.433Z,1769119549.433 [Default:CheckIn:D] Stopped 2026-01-22T22:05:49.433Z,1769119549.433 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.815169 min 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn:E] Stopped 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn] Stopped 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn](INFO): Running loop #12 2026-01-22T22:05:49.851Z,1769119549.851 [Default:CheckIn] Running Loop=12 2026-01-22T22:05:49.852Z,1769119549.852 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:05:49.852Z,1769119549.852 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:05:51.847Z,1769119551.847 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220549.00,A,3648.15395,N,12147.22314,W,0.039,346.55,220126,,,D*7A 2026-01-22T22:05:51.857Z,1769119551.857 [NAL9602](INFO): GPS fix at 20260122T220549: (36.802566, -121.787052) 2026-01-22T22:05:51.867Z,1769119551.867 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:05:51.867Z,1769119551.867 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:05:59.119Z,1769119559.119 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0027.lzma 2026-01-22T22:06:00.122Z,1769119560.122 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0027.lzma.bak 2026-01-22T22:06:00.122Z,1769119560.122 [DataOverHttps](INFO): SBD MOMSN=26586453 2026-01-22T22:06:15.770Z,1769119575.770 [NAL9602](INFO): SBD MO Status=2, MOMSN=25383, MT Status=2, MTMSN=0 2026-01-22T22:06:15.770Z,1769119575.770 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:06:16.085Z,1769119576.085 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20260122T212005/Express0028.lzma 2026-01-22T22:06:17.082Z,1769119577.082 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0028.lzma.bak 2026-01-22T22:06:17.082Z,1769119577.082 [DataOverHttps](INFO): SBD MOMSN=26586456 2026-01-22T22:06:18.553Z,1769119578.553 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:06:18.553Z,1769119578.553 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:06:18.553Z,1769119578.553 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:06:46.002Z,1769119606.002 [NAL9602](INFO): SBD MO Status=2, MOMSN=25383, MT Status=2, MTMSN=0 2026-01-22T22:06:46.003Z,1769119606.003 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:07:20.343Z,1769119640.343 [NAL9602](INFO): SBD MO Status=0, MOMSN=25383, MT Status=0, MTMSN=0 2026-01-22T22:07:20.343Z,1769119640.343 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:07:51.045Z,1769119671.045 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:11:19.142Z,1769119879.142 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:11:19.142Z,1769119879.142 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:11:19.142Z,1769119879.142 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:11:19.142Z,1769119879.142 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:11:19.546Z,1769119879.546 [Default:CheckIn:D] Stopped 2026-01-22T22:11:19.546Z,1769119879.546 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:11:19.947Z,1769119879.947 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.317057 min 2026-01-22T22:11:19.948Z,1769119879.948 [Default:CheckIn:E] Stopped 2026-01-22T22:11:19.948Z,1769119879.948 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:11:19.948Z,1769119879.948 [Default:CheckIn] Stopped 2026-01-22T22:11:19.948Z,1769119879.948 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:11:19.948Z,1769119879.948 [Default:CheckIn](INFO): Running loop #13 2026-01-22T22:11:19.948Z,1769119879.948 [Default:CheckIn] Running Loop=13 2026-01-22T22:11:19.949Z,1769119879.949 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:11:19.949Z,1769119879.949 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:11:21.964Z,1769119881.964 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221119.00,A,3648.15403,N,12147.22246,W,0.272,346.55,220126,,,D*79 2026-01-22T22:11:21.967Z,1769119881.967 [NAL9602](INFO): GPS fix at 20260122T221119: (36.802567, -121.787041) 2026-01-22T22:11:21.977Z,1769119881.977 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:11:21.977Z,1769119881.977 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:11:29.767Z,1769119889.767 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0030.lzma 2026-01-22T22:11:30.770Z,1769119890.770 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0030.lzma.bak 2026-01-22T22:11:30.770Z,1769119890.770 [DataOverHttps](INFO): SBD MOMSN=26586459 2026-01-22T22:11:46.956Z,1769119906.956 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0031.lzma 2026-01-22T22:11:47.960Z,1769119907.960 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0031.lzma.bak 2026-01-22T22:11:47.960Z,1769119907.960 [DataOverHttps](INFO): SBD MOMSN=26586462 2026-01-22T22:11:49.494Z,1769119909.494 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:11:49.494Z,1769119909.494 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:11:49.494Z,1769119909.494 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:11:50.663Z,1769119910.663 [NAL9602](INFO): SBD MO Status=0, MOMSN=25384, MT Status=0, MTMSN=0 2026-01-22T22:11:50.663Z,1769119910.663 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:12:21.347Z,1769119941.347 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:16:07.582Z,1769120167.582 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-01-22T22:16:50.020Z,1769120210.020 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:16:50.020Z,1769120210.020 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:16:50.020Z,1769120210.020 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:16:50.020Z,1769120210.020 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:16:50.438Z,1769120210.438 [Default:CheckIn:D] Stopped 2026-01-22T22:16:50.438Z,1769120210.438 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:16:50.823Z,1769120210.823 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.831917 min 2026-01-22T22:16:50.823Z,1769120210.823 [Default:CheckIn:E] Stopped 2026-01-22T22:16:50.823Z,1769120210.823 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:16:50.823Z,1769120210.823 [Default:CheckIn] Stopped 2026-01-22T22:16:50.823Z,1769120210.823 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:16:50.825Z,1769120210.825 [Default:CheckIn](INFO): Running loop #14 2026-01-22T22:16:50.825Z,1769120210.825 [Default:CheckIn] Running Loop=14 2026-01-22T22:16:50.825Z,1769120210.825 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:16:50.825Z,1769120210.825 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:16:52.840Z,1769120212.840 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221650.00,A,3648.15583,N,12147.22249,W,0.117,188.58,220126,,,D*78 2026-01-22T22:16:52.843Z,1769120212.843 [NAL9602](INFO): GPS fix at 20260122T221650: (36.802597, -121.787042) 2026-01-22T22:16:52.853Z,1769120212.853 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:16:52.853Z,1769120212.853 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:17:00.503Z,1769120220.503 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0033.lzma 2026-01-22T22:17:01.506Z,1769120221.506 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0033.lzma.bak 2026-01-22T22:17:01.507Z,1769120221.507 [DataOverHttps](INFO): SBD MOMSN=26586465 2026-01-22T22:17:03.361Z,1769120223.361 [NAL9602](INFO): SBD MO Status=0, MOMSN=25385, MT Status=0, MTMSN=0 2026-01-22T22:17:03.361Z,1769120223.361 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:17:17.441Z,1769120237.441 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20260122T212005/Express0034.lzma 2026-01-22T22:17:18.442Z,1769120238.442 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0034.lzma.bak 2026-01-22T22:17:18.442Z,1769120238.442 [DataOverHttps](INFO): SBD MOMSN=26586468 2026-01-22T22:17:19.944Z,1769120239.944 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:17:19.944Z,1769120239.944 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:17:19.944Z,1769120239.944 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:17:34.064Z,1769120254.064 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:22:20.522Z,1769120540.522 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:22:20.522Z,1769120540.522 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:22:20.522Z,1769120540.522 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:22:20.523Z,1769120540.523 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:22:20.984Z,1769120540.984 [Default:CheckIn:D] Stopped 2026-01-22T22:22:20.984Z,1769120540.984 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:22:21.353Z,1769120541.353 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 78.341024 min 2026-01-22T22:22:21.353Z,1769120541.353 [Default:CheckIn:E] Stopped 2026-01-22T22:22:21.353Z,1769120541.353 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:22:21.353Z,1769120541.353 [Default:CheckIn] Stopped 2026-01-22T22:22:21.353Z,1769120541.353 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:22:21.353Z,1769120541.353 [Default:CheckIn](INFO): Running loop #15 2026-01-22T22:22:21.354Z,1769120541.354 [Default:CheckIn] Running Loop=15 2026-01-22T22:22:21.354Z,1769120541.354 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:22:21.354Z,1769120541.354 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:22:23.342Z,1769120543.342 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222220.00,A,3648.15707,N,12147.22137,W,0.058,116.81,220126,,,A*70 2026-01-22T22:22:23.344Z,1769120543.344 [NAL9602](INFO): GPS fix at 20260122T222220: (36.802618, -121.787023) 2026-01-22T22:22:23.377Z,1769120543.377 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:22:23.378Z,1769120543.378 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:22:31.112Z,1769120551.112 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0036.lzma 2026-01-22T22:22:32.114Z,1769120552.114 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0036.lzma.bak 2026-01-22T22:22:32.114Z,1769120552.114 [DataOverHttps](INFO): SBD MOMSN=26586473 2026-01-22T22:22:48.000Z,1769120569.000 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20260122T212005/Express0037.lzma 2026-01-22T22:22:50.002Z,1769120570.002 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0037.lzma.bak 2026-01-22T22:22:50.002Z,1769120570.002 [DataOverHttps](INFO): SBD MOMSN=26586476 2026-01-22T22:22:51.651Z,1769120571.651 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:22:51.651Z,1769120571.651 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:22:51.651Z,1769120571.651 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:22:59.388Z,1769120579.388 [NAL9602](INFO): SBD MO Status=2, MOMSN=25386, MT Status=2, MTMSN=0 2026-01-22T22:22:59.389Z,1769120579.389 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:23:16.739Z,1769120596.739 [NAL9602](INFO): SBD MO Status=2, MOMSN=25386, MT Status=2, MTMSN=0 2026-01-22T22:23:16.739Z,1769120596.739 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:23:26.415Z,1769120606.415 [NAL9602](INFO): SBD MO Status=0, MOMSN=25386, MT Status=0, MTMSN=0 2026-01-22T22:23:26.415Z,1769120606.415 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:23:57.117Z,1769120637.117 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:25:15.498Z,1769120715.498 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2026-01-22T22:25:15.502Z,1769120715.502 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2026-01-22T22:27:52.274Z,1769120872.274 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:27:52.274Z,1769120872.274 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:27:52.274Z,1769120872.274 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:27:52.275Z,1769120872.275 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:27:52.665Z,1769120872.665 [Default:CheckIn:D] Stopped 2026-01-22T22:27:52.665Z,1769120872.665 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:27:53.070Z,1769120873.070 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 83.869043 min 2026-01-22T22:27:53.070Z,1769120873.070 [Default:CheckIn:E] Stopped 2026-01-22T22:27:53.070Z,1769120873.070 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:27:53.070Z,1769120873.070 [Default:CheckIn] Stopped 2026-01-22T22:27:53.071Z,1769120873.071 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:27:53.071Z,1769120873.071 [Default:CheckIn](INFO): Running loop #16 2026-01-22T22:27:53.071Z,1769120873.071 [Default:CheckIn] Running Loop=16 2026-01-22T22:27:53.071Z,1769120873.071 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:27:53.071Z,1769120873.071 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:27:55.087Z,1769120875.087 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222752.00,A,3648.15683,N,12147.21855,W,0.078,144.12,220126,,,A*7C 2026-01-22T22:27:55.090Z,1769120875.090 [NAL9602](INFO): GPS fix at 20260122T222752: (36.802614, -121.786976) 2026-01-22T22:27:55.100Z,1769120875.100 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:27:55.100Z,1769120875.100 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:28:02.071Z,1769120882.071 [DataOverHttps](INFO): Sending 90 bytes from file Logs/20260122T212005/Courier0039.lzma 2026-01-22T22:28:03.074Z,1769120883.074 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0039.lzma.bak 2026-01-22T22:28:03.074Z,1769120883.074 [DataOverHttps](INFO): SBD MOMSN=26586479 2026-01-22T22:28:18.876Z,1769120898.876 [DataOverHttps](INFO): Sending 290 bytes from file Logs/20260122T212005/Express0040.lzma 2026-01-22T22:28:19.878Z,1769120899.878 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0040.lzma.bak 2026-01-22T22:28:19.878Z,1769120899.878 [DataOverHttps](INFO): SBD MOMSN=26586482 2026-01-22T22:28:21.364Z,1769120901.364 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:28:21.364Z,1769120901.364 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:28:21.364Z,1769120901.364 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:28:30.227Z,1769120910.227 [NAL9602](INFO): SBD MO Status=2, MOMSN=25387, MT Status=2, MTMSN=0 2026-01-22T22:28:30.227Z,1769120910.227 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:29:32.049Z,1769120972.049 [NAL9602](INFO): SBD MO Status=2, MOMSN=25387, MT Status=2, MTMSN=0 2026-01-22T22:29:32.049Z,1769120972.049 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:29:56.283Z,1769120996.283 [NAL9602](INFO): SBD MO Status=2, MOMSN=25387, MT Status=2, MTMSN=0 2026-01-22T22:29:56.283Z,1769120996.283 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:30:18.507Z,1769121018.507 [NAL9602](INFO): SBD MO Status=0, MOMSN=25387, MT Status=0, MTMSN=0 2026-01-22T22:30:18.507Z,1769121018.507 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:30:49.207Z,1769121049.207 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:33:21.921Z,1769121201.921 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:33:21.921Z,1769121201.921 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:33:21.921Z,1769121201.921 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:33:21.921Z,1769121201.921 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:33:22.331Z,1769121202.331 [Default:CheckIn:D] Stopped 2026-01-22T22:33:22.331Z,1769121202.331 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:33:22.738Z,1769121202.738 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 89.363468 min 2026-01-22T22:33:22.738Z,1769121202.738 [Default:CheckIn:E] Stopped 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn] Stopped 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn](INFO): Running loop #17 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn] Running Loop=17 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:33:22.739Z,1769121202.739 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:33:24.741Z,1769121204.741 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223321.00,A,3648.15732,N,12147.22220,W,0.039,24.15,220126,,,A*48 2026-01-22T22:33:24.743Z,1769121204.743 [NAL9602](INFO): GPS fix at 20260122T223321: (36.802622, -121.787037) 2026-01-22T22:33:24.754Z,1769121204.754 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:33:24.754Z,1769121204.754 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:33:32.007Z,1769121212.007 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0042.lzma 2026-01-22T22:33:33.010Z,1769121213.010 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0042.lzma.bak 2026-01-22T22:33:33.010Z,1769121213.010 [DataOverHttps](INFO): SBD MOMSN=26586491 2026-01-22T22:33:48.940Z,1769121228.940 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20260122T212005/Express0043.lzma 2026-01-22T22:33:49.942Z,1769121229.942 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0043.lzma.bak 2026-01-22T22:33:49.942Z,1769121229.942 [DataOverHttps](INFO): SBD MOMSN=26586494 2026-01-22T22:33:51.446Z,1769121231.446 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:33:51.446Z,1769121231.446 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:33:51.446Z,1769121231.446 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:34:19.691Z,1769121259.691 [NAL9602](INFO): SBD MO Status=2, MOMSN=25388, MT Status=2, MTMSN=0 2026-01-22T22:34:19.691Z,1769121259.691 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:34:35.447Z,1769121275.447 [NAL9602](INFO): SBD MO Status=2, MOMSN=25388, MT Status=2, MTMSN=0 2026-01-22T22:34:35.447Z,1769121275.447 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:34:45.945Z,1769121285.945 [NAL9602](INFO): SBD MO Status=0, MOMSN=25388, MT Status=0, MTMSN=0 2026-01-22T22:34:45.945Z,1769121285.945 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:35:16.649Z,1769121316.649 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:38:52.066Z,1769121532.066 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:38:52.066Z,1769121532.066 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:38:52.066Z,1769121532.066 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:38:52.066Z,1769121532.066 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:38:52.435Z,1769121532.435 [Default:CheckIn:D] Stopped 2026-01-22T22:38:52.435Z,1769121532.435 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:38:52.838Z,1769121532.838 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.865202 min 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn:E] Stopped 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn] Stopped 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn](INFO): Running loop #18 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn] Running Loop=18 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:38:52.839Z,1769121532.839 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:38:54.827Z,1769121534.827 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223852.00,A,3648.15549,N,12147.22221,W,0.019,24.15,220126,,,A*4A 2026-01-22T22:38:54.829Z,1769121534.829 [NAL9602](INFO): GPS fix at 20260122T223852: (36.802591, -121.787037) 2026-01-22T22:38:54.839Z,1769121534.839 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:38:54.840Z,1769121534.840 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:39:01.859Z,1769121541.859 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0045.lzma 2026-01-22T22:39:02.862Z,1769121542.862 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0045.lzma.bak 2026-01-22T22:39:02.862Z,1769121542.862 [DataOverHttps](INFO): SBD MOMSN=26586504 2026-01-22T22:39:19.112Z,1769121559.112 [DataOverHttps](INFO): Sending 174 bytes from file Logs/20260122T212005/Express0046.lzma 2026-01-22T22:39:20.114Z,1769121560.114 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0046.lzma.bak 2026-01-22T22:39:20.114Z,1769121560.114 [DataOverHttps](INFO): SBD MOMSN=26586508 2026-01-22T22:39:21.511Z,1769121561.511 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:39:21.511Z,1769121561.511 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:39:21.511Z,1769121561.511 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:39:45.729Z,1769121585.729 [NAL9602](INFO): SBD MO Status=2, MOMSN=25389, MT Status=2, MTMSN=0 2026-01-22T22:39:45.729Z,1769121585.729 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:40:31.381Z,1769121631.381 [NAL9602](INFO): SBD MO Status=2, MOMSN=25389, MT Status=2, MTMSN=0 2026-01-22T22:40:31.381Z,1769121631.381 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:43:48.154Z,1769121828.154 [NAL9602](INFO): SBD MO Status=2, MOMSN=25389, MT Status=2, MTMSN=0 2026-01-22T22:43:48.154Z,1769121828.154 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:43:55.847Z,1769121835.847 [NAL9602](INFO): SBD MO Status=0, MOMSN=25389, MT Status=0, MTMSN=0 2026-01-22T22:43:55.847Z,1769121835.847 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:44:22.103Z,1769121862.103 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:44:22.103Z,1769121862.103 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:44:22.103Z,1769121862.103 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:44:22.103Z,1769121862.103 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:44:22.498Z,1769121862.498 [Default:CheckIn:D] Stopped 2026-01-22T22:44:22.498Z,1769121862.498 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:44:22.904Z,1769121862.904 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 100.366252 min 2026-01-22T22:44:22.904Z,1769121862.904 [Default:CheckIn:E] Stopped 2026-01-22T22:44:22.904Z,1769121862.904 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:44:22.905Z,1769121862.905 [Default:CheckIn] Stopped 2026-01-22T22:44:22.905Z,1769121862.905 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:44:22.905Z,1769121862.905 [Default:CheckIn](INFO): Running loop #19 2026-01-22T22:44:22.905Z,1769121862.905 [Default:CheckIn] Running Loop=19 2026-01-22T22:44:22.905Z,1769121862.905 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:44:22.905Z,1769121862.905 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:44:24.925Z,1769121864.925 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224422.00,A,3648.15451,N,12147.22414,W,0.039,24.15,220126,,,D*49 2026-01-22T22:44:24.927Z,1769121864.927 [NAL9602](INFO): GPS fix at 20260122T224422: (36.802575, -121.787069) 2026-01-22T22:44:24.938Z,1769121864.938 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:44:24.938Z,1769121864.938 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:44:32.267Z,1769121872.267 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0048.lzma 2026-01-22T22:44:33.270Z,1769121873.270 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0048.lzma.bak 2026-01-22T22:44:33.270Z,1769121873.270 [DataOverHttps](INFO): SBD MOMSN=26586520 2026-01-22T22:44:49.595Z,1769121889.595 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20260122T212005/Express0049.lzma 2026-01-22T22:44:50.506Z,1769121890.506 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0049.lzma.bak 2026-01-22T22:44:50.506Z,1769121890.506 [DataOverHttps](INFO): SBD MOMSN=26586523 2026-01-22T22:44:51.999Z,1769121891.999 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:44:51.999Z,1769121891.999 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:44:51.999Z,1769121891.999 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:44:57.653Z,1769121897.653 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:48:41.050Z,1769122121.050 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2026-01-22T22:49:52.565Z,1769122192.565 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:49:52.565Z,1769122192.565 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:49:52.565Z,1769122192.565 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:49:52.566Z,1769122192.566 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:49:52.971Z,1769122192.971 [Default:CheckIn:D] Stopped 2026-01-22T22:49:52.972Z,1769122192.972 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:49:53.388Z,1769122193.388 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.874146 min 2026-01-22T22:49:53.388Z,1769122193.388 [Default:CheckIn:E] Stopped 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn] Stopped 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn](INFO): Running loop #20 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn] Running Loop=20 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:49:53.389Z,1769122193.389 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:49:55.390Z,1769122195.390 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224952.00,A,3648.15562,N,12147.22196,W,0.058,24.15,220126,,,D*4A 2026-01-22T22:49:55.392Z,1769122195.392 [NAL9602](INFO): GPS fix at 20260122T224952: (36.802594, -121.787033) 2026-01-22T22:49:55.423Z,1769122195.423 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:49:55.423Z,1769122195.423 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:50:02.739Z,1769122202.739 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0051.lzma 2026-01-22T22:50:03.742Z,1769122203.742 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0051.lzma.bak 2026-01-22T22:50:03.742Z,1769122203.742 [DataOverHttps](INFO): SBD MOMSN=26586532 2026-01-22T22:50:19.648Z,1769122219.648 [DataOverHttps](INFO): Sending 173 bytes from file Logs/20260122T212005/Express0052.lzma 2026-01-22T22:50:20.650Z,1769122220.650 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0052.lzma.bak 2026-01-22T22:50:20.650Z,1769122220.650 [DataOverHttps](INFO): SBD MOMSN=26586535 2026-01-22T22:50:22.068Z,1769122222.068 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:50:22.068Z,1769122222.068 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:50:22.068Z,1769122222.068 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:50:30.151Z,1769122230.151 [NAL9602](INFO): SBD MO Status=0, MOMSN=25390, MT Status=0, MTMSN=0 2026-01-22T22:50:30.151Z,1769122230.151 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:51:00.831Z,1769122260.831 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T22:55:22.633Z,1769122522.633 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T22:55:22.633Z,1769122522.633 [Default:CheckIn:C.Wait] Stopped 2026-01-22T22:55:22.633Z,1769122522.633 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T22:55:22.634Z,1769122522.634 [Default:CheckIn:D] Running Loop=1 2026-01-22T22:55:23.040Z,1769122523.040 [Default:CheckIn:D] Stopped 2026-01-22T22:55:23.040Z,1769122523.040 [Default:CheckIn:E] Running Loop=1 2026-01-22T22:55:23.444Z,1769122523.444 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 111.375285 min 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn:E] Stopped 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn] Stopped 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn](INFO): Running loop #21 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn] Running Loop=21 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T22:55:23.445Z,1769122523.445 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T22:55:25.459Z,1769122525.459 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225522.00,A,3648.15605,N,12147.22476,W,0.039,24.15,220126,,,D*4E 2026-01-22T22:55:25.462Z,1769122525.462 [NAL9602](INFO): GPS fix at 20260122T225522: (36.802601, -121.787079) 2026-01-22T22:55:25.472Z,1769122525.472 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T22:55:25.473Z,1769122525.473 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T22:55:33.599Z,1769122533.599 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0054.lzma 2026-01-22T22:55:34.602Z,1769122534.602 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0054.lzma.bak 2026-01-22T22:55:34.602Z,1769122534.602 [DataOverHttps](INFO): SBD MOMSN=26586544 2026-01-22T22:55:50.576Z,1769122550.576 [DataOverHttps](INFO): Sending 178 bytes from file Logs/20260122T212005/Express0055.lzma 2026-01-22T22:55:51.578Z,1769122551.578 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0055.lzma.bak 2026-01-22T22:55:51.578Z,1769122551.578 [DataOverHttps](INFO): SBD MOMSN=26586548 2026-01-22T22:55:52.945Z,1769122552.945 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T22:55:52.945Z,1769122552.945 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T22:55:52.945Z,1769122552.945 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T22:57:12.938Z,1769122632.938 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-01-22T22:57:25.480Z,1769122645.480 [NAL9602](INFO): SBD MO Status=2, MOMSN=25391, MT Status=2, MTMSN=0 2026-01-22T22:57:25.480Z,1769122645.480 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:57:45.666Z,1769122665.666 [NAL9602](INFO): SBD MO Status=2, MOMSN=25391, MT Status=2, MTMSN=0 2026-01-22T22:57:45.666Z,1769122665.666 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:58:48.690Z,1769122728.690 [NAL9602](INFO): SBD MO Status=2, MOMSN=25391, MT Status=2, MTMSN=0 2026-01-22T22:58:48.690Z,1769122728.690 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T22:59:28.690Z,1769122768.690 [NAL9602](INFO): SBD MO Status=0, MOMSN=25391, MT Status=0, MTMSN=0 2026-01-22T22:59:28.690Z,1769122768.690 [NAL9602](INFO): No messages in MT queue 2026-01-22T22:59:59.393Z,1769122799.393 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:00:53.539Z,1769122853.539 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:00:53.540Z,1769122853.540 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:00:53.540Z,1769122853.540 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:00:53.540Z,1769122853.540 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:00:53.938Z,1769122853.938 [Default:CheckIn:D] Stopped 2026-01-22T23:00:53.938Z,1769122853.938 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:00:54.407Z,1769122854.407 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 116.890251 min 2026-01-22T23:00:54.407Z,1769122854.407 [Default:CheckIn:E] Stopped 2026-01-22T23:00:54.407Z,1769122854.407 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:00:54.407Z,1769122854.407 [Default:CheckIn] Stopped 2026-01-22T23:00:54.407Z,1769122854.407 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:00:54.407Z,1769122854.407 [Default:CheckIn](INFO): Running loop #22 2026-01-22T23:00:54.428Z,1769122854.428 [Default:CheckIn] Running Loop=22 2026-01-22T23:00:54.428Z,1769122854.428 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:00:54.428Z,1769122854.428 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:00:56.353Z,1769122856.353 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230053.00,A,3648.17392,N,12147.28370,W,0.058,265.27,220126,,,A*7F 2026-01-22T23:00:56.356Z,1769122856.356 [NAL9602](INFO): GPS fix at 20260122T230053: (36.802899, -121.788062) 2026-01-22T23:00:56.366Z,1769122856.366 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:00:56.366Z,1769122856.366 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:01:03.499Z,1769122863.499 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0057.lzma 2026-01-22T23:01:04.502Z,1769122864.502 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0057.lzma.bak 2026-01-22T23:01:04.502Z,1769122864.502 [DataOverHttps](INFO): SBD MOMSN=26586556 2026-01-22T23:01:20.641Z,1769122880.641 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20260122T212005/Express0058.lzma 2026-01-22T23:01:21.642Z,1769122881.642 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0058.lzma.bak 2026-01-22T23:01:21.642Z,1769122881.642 [DataOverHttps](INFO): SBD MOMSN=26586560 2026-01-22T23:01:23.079Z,1769122883.079 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:01:23.080Z,1769122883.080 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:01:23.080Z,1769122883.080 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:03:24.218Z,1769123004.218 [NAL9602](INFO): SBD MO Status=2, MOMSN=25392, MT Status=2, MTMSN=0 2026-01-22T23:03:24.218Z,1769123004.218 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T23:03:38.358Z,1769123018.358 [NAL9602](INFO): SBD MO Status=2, MOMSN=25392, MT Status=2, MTMSN=0 2026-01-22T23:03:38.359Z,1769123018.359 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T23:04:51.887Z,1769123091.887 [NAL9602](INFO): SBD MO Status=0, MOMSN=25392, MT Status=0, MTMSN=0 2026-01-22T23:04:51.887Z,1769123091.887 [NAL9602](INFO): No messages in MT queue 2026-01-22T23:05:22.587Z,1769123122.587 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:06:17.531Z,1769123177.531 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2026-01-22T23:06:17.534Z,1769123177.534 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2026-01-22T23:06:23.602Z,1769123183.602 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:06:23.603Z,1769123183.603 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:06:23.603Z,1769123183.603 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:06:23.603Z,1769123183.603 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:06:24.016Z,1769123184.016 [Default:CheckIn:D] Stopped 2026-01-22T23:06:24.016Z,1769123184.016 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:06:24.409Z,1769123184.409 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 122.391545 min 2026-01-22T23:06:24.409Z,1769123184.409 [Default:CheckIn:E] Stopped 2026-01-22T23:06:24.409Z,1769123184.409 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:06:24.409Z,1769123184.409 [Default:CheckIn] Stopped 2026-01-22T23:06:24.409Z,1769123184.409 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:06:24.410Z,1769123184.410 [Default:CheckIn](INFO): Running loop #23 2026-01-22T23:06:24.410Z,1769123184.410 [Default:CheckIn] Running Loop=23 2026-01-22T23:06:24.410Z,1769123184.410 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:06:24.410Z,1769123184.410 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:06:26.421Z,1769123186.421 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230623.00,A,3648.17357,N,12147.28067,W,0.078,293.72,220126,,,A*79 2026-01-22T23:06:26.423Z,1769123186.423 [NAL9602](INFO): GPS fix at 20260122T230623: (36.802893, -121.788011) 2026-01-22T23:06:26.434Z,1769123186.434 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:06:26.434Z,1769123186.434 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:06:34.059Z,1769123194.059 [DataOverHttps](INFO): Sending 89 bytes from file Logs/20260122T212005/Courier0060.lzma 2026-01-22T23:06:35.062Z,1769123195.062 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0060.lzma.bak 2026-01-22T23:06:35.062Z,1769123195.062 [DataOverHttps](INFO): SBD MOMSN=26586572 2026-01-22T23:06:42.587Z,1769123202.587 [NAL9602](INFO): SBD MO Status=0, MOMSN=25393, MT Status=0, MTMSN=0 2026-01-22T23:06:42.587Z,1769123202.587 [NAL9602](INFO): No messages in MT queue 2026-01-22T23:06:51.953Z,1769123211.953 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20260122T212005/Express0061.lzma 2026-01-22T23:06:52.954Z,1769123212.954 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0061.lzma.bak 2026-01-22T23:06:52.954Z,1769123212.954 [DataOverHttps](INFO): SBD MOMSN=26586575 2026-01-22T23:06:54.403Z,1769123214.403 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:06:54.403Z,1769123214.403 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:06:54.403Z,1769123214.403 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:07:13.289Z,1769123233.289 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:11:54.911Z,1769123514.911 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:11:54.911Z,1769123514.911 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:11:54.911Z,1769123514.911 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:11:54.912Z,1769123514.912 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:11:55.309Z,1769123515.309 [Default:CheckIn:D] Stopped 2026-01-22T23:11:55.309Z,1769123515.309 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:11:55.713Z,1769123515.713 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 127.913102 min 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn:E] Stopped 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn] Stopped 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn](INFO): Running loop #24 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn] Running Loop=24 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:11:55.714Z,1769123515.714 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:11:57.727Z,1769123517.727 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231154.00,A,3648.17755,N,12147.27990,W,0.058,293.72,220126,,,A*75 2026-01-22T23:11:57.730Z,1769123517.730 [NAL9602](INFO): GPS fix at 20260122T231154: (36.802959, -121.787998) 2026-01-22T23:11:57.740Z,1769123517.740 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:11:57.740Z,1769123517.740 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:12:05.551Z,1769123525.551 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0063.lzma 2026-01-22T23:12:06.583Z,1769123526.583 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0063.lzma.bak 2026-01-22T23:12:06.583Z,1769123526.583 [DataOverHttps](INFO): SBD MOMSN=26586586 2026-01-22T23:12:16.313Z,1769123536.313 [NAL9602](INFO): SBD MO Status=0, MOMSN=25394, MT Status=0, MTMSN=0 2026-01-22T23:12:16.313Z,1769123536.313 [NAL9602](INFO): No messages in MT queue 2026-01-22T23:12:22.696Z,1769123542.696 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0064.lzma 2026-01-22T23:12:23.698Z,1769123543.698 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0064.lzma.bak 2026-01-22T23:12:23.698Z,1769123543.698 [DataOverHttps](INFO): SBD MOMSN=26586590 2026-01-22T23:12:25.215Z,1769123545.215 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:12:25.215Z,1769123545.215 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:12:25.215Z,1769123545.215 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:12:47.017Z,1769123567.017 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:17:25.819Z,1769123845.819 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:17:25.819Z,1769123845.819 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:17:25.819Z,1769123845.819 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:17:25.819Z,1769123845.819 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:17:26.203Z,1769123846.203 [Default:CheckIn:D] Stopped 2026-01-22T23:17:26.203Z,1769123846.203 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:17:26.616Z,1769123846.616 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.428011 min 2026-01-22T23:17:26.616Z,1769123846.616 [Default:CheckIn:E] Stopped 2026-01-22T23:17:26.616Z,1769123846.616 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:17:26.616Z,1769123846.616 [Default:CheckIn] Stopped 2026-01-22T23:17:26.616Z,1769123846.616 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:17:26.617Z,1769123846.617 [Default:CheckIn](INFO): Running loop #25 2026-01-22T23:17:26.617Z,1769123846.617 [Default:CheckIn] Running Loop=25 2026-01-22T23:17:26.617Z,1769123846.617 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:17:26.617Z,1769123846.617 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:17:28.611Z,1769123848.611 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231725.00,A,3648.17474,N,12147.28027,W,0.117,293.72,220126,,,A*75 2026-01-22T23:17:28.613Z,1769123848.613 [NAL9602](INFO): GPS fix at 20260122T231725: (36.802912, -121.788004) 2026-01-22T23:17:28.638Z,1769123848.638 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:17:28.639Z,1769123848.639 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:17:36.643Z,1769123856.643 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0066.lzma 2026-01-22T23:17:37.646Z,1769123857.646 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0066.lzma.bak 2026-01-22T23:17:37.646Z,1769123857.646 [DataOverHttps](INFO): SBD MOMSN=26586598 2026-01-22T23:17:53.992Z,1769123873.992 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0067.lzma 2026-01-22T23:17:54.994Z,1769123874.994 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0067.lzma.bak 2026-01-22T23:17:54.994Z,1769123874.994 [DataOverHttps](INFO): SBD MOMSN=26586602 2026-01-22T23:17:56.518Z,1769123876.518 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:17:56.519Z,1769123876.519 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:17:56.519Z,1769123876.519 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:19:12.473Z,1769123952.473 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2026-01-22T23:21:06.009Z,1769124066.009 [NAL9602](INFO): SBD MO Status=2, MOMSN=25395, MT Status=2, MTMSN=0 2026-01-22T23:21:06.009Z,1769124066.009 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T23:21:25.402Z,1769124085.402 [NAL9602](INFO): SBD MO Status=0, MOMSN=25395, MT Status=0, MTMSN=0 2026-01-22T23:21:25.402Z,1769124085.402 [NAL9602](INFO): No messages in MT queue 2026-01-22T23:21:56.110Z,1769124116.110 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:22:57.178Z,1769124177.178 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:22:57.178Z,1769124177.178 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:22:57.178Z,1769124177.178 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:22:57.178Z,1769124177.178 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:22:57.578Z,1769124177.578 [Default:CheckIn:D] Stopped 2026-01-22T23:22:57.578Z,1769124177.578 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:22:57.982Z,1769124177.982 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 138.950911 min 2026-01-22T23:22:57.982Z,1769124177.982 [Default:CheckIn:E] Stopped 2026-01-22T23:22:57.982Z,1769124177.982 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:22:57.982Z,1769124177.982 [Default:CheckIn] Stopped 2026-01-22T23:22:57.982Z,1769124177.982 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:22:57.983Z,1769124177.983 [Default:CheckIn](INFO): Running loop #26 2026-01-22T23:22:57.983Z,1769124177.983 [Default:CheckIn] Running Loop=26 2026-01-22T23:22:57.983Z,1769124177.983 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:22:57.983Z,1769124177.983 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:23:00.060Z,1769124180.060 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232257.00,A,3648.17699,N,12147.28262,W,0.389,200.05,220126,,,A*7B 2026-01-22T23:23:00.062Z,1769124180.062 [NAL9602](INFO): GPS fix at 20260122T232257: (36.802950, -121.788044) 2026-01-22T23:23:00.073Z,1769124180.073 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:23:00.073Z,1769124180.073 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:23:07.939Z,1769124187.939 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0069.lzma 2026-01-22T23:23:08.942Z,1769124188.942 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0069.lzma.bak 2026-01-22T23:23:08.942Z,1769124188.942 [DataOverHttps](INFO): SBD MOMSN=26586614 2026-01-22T23:23:16.154Z,1769124196.154 [NAL9602](INFO): SBD MO Status=0, MOMSN=25396, MT Status=0, MTMSN=0 2026-01-22T23:23:16.154Z,1769124196.154 [NAL9602](INFO): No messages in MT queue 2026-01-22T23:23:25.036Z,1769124205.036 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0070.lzma 2026-01-22T23:23:26.038Z,1769124206.038 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0070.lzma.bak 2026-01-22T23:23:26.038Z,1769124206.038 [DataOverHttps](INFO): SBD MOMSN=26586617 2026-01-22T23:23:27.477Z,1769124207.477 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:23:27.477Z,1769124207.477 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:23:27.477Z,1769124207.477 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:23:46.856Z,1769124226.856 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:28:28.074Z,1769124508.074 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:28:28.074Z,1769124508.074 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:28:28.075Z,1769124508.075 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:28:28.075Z,1769124508.075 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:28:28.473Z,1769124508.473 [Default:CheckIn:D] Stopped 2026-01-22T23:28:28.473Z,1769124508.473 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:28:28.874Z,1769124508.874 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.465837 min 2026-01-22T23:28:28.874Z,1769124508.874 [Default:CheckIn:E] Stopped 2026-01-22T23:28:28.874Z,1769124508.874 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:28:28.875Z,1769124508.875 [Default:CheckIn] Stopped 2026-01-22T23:28:28.875Z,1769124508.875 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:28:28.875Z,1769124508.875 [Default:CheckIn](INFO): Running loop #27 2026-01-22T23:28:28.875Z,1769124508.875 [Default:CheckIn] Running Loop=27 2026-01-22T23:28:28.875Z,1769124508.875 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:28:28.875Z,1769124508.875 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:28:30.891Z,1769124510.891 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232828.00,A,3648.17469,N,12147.28206,W,0.350,200.05,220126,,,A*72 2026-01-22T23:28:30.894Z,1769124510.894 [NAL9602](INFO): GPS fix at 20260122T232828: (36.802912, -121.788034) 2026-01-22T23:28:30.910Z,1769124510.910 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:28:30.910Z,1769124510.910 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:28:42.887Z,1769124522.887 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0072.lzma 2026-01-22T23:28:43.902Z,1769124523.902 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0072.lzma.bak 2026-01-22T23:28:43.902Z,1769124523.902 [DataOverHttps](INFO): SBD MOMSN=26586630 2026-01-22T23:29:00.008Z,1769124540.008 [DataOverHttps](INFO): Sending 178 bytes from file Logs/20260122T212005/Express0073.lzma 2026-01-22T23:29:01.010Z,1769124541.010 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0073.lzma.bak 2026-01-22T23:29:01.010Z,1769124541.010 [DataOverHttps](INFO): SBD MOMSN=26586633 2026-01-22T23:29:02.442Z,1769124542.442 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:29:02.442Z,1769124542.442 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:29:02.442Z,1769124542.442 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:30:19.580Z,1769124619.580 [NAL9602](INFO): SBD MO Status=0, MOMSN=25397, MT Status=0, MTMSN=0 2026-01-22T23:30:19.580Z,1769124619.580 [NAL9602](INFO): No messages in MT queue 2026-01-22T23:30:50.273Z,1769124650.273 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:34:02.990Z,1769124842.990 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:34:02.990Z,1769124842.990 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:34:02.990Z,1769124842.990 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:34:02.990Z,1769124842.990 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:34:03.397Z,1769124843.397 [Default:CheckIn:D] Stopped 2026-01-22T23:34:03.397Z,1769124843.397 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:34:03.799Z,1769124843.799 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 150.047917 min 2026-01-22T23:34:03.799Z,1769124843.799 [Default:CheckIn:E] Stopped 2026-01-22T23:34:03.799Z,1769124843.799 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:34:03.799Z,1769124843.799 [Default:CheckIn] Stopped 2026-01-22T23:34:03.799Z,1769124843.799 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:34:03.799Z,1769124843.799 [Default:CheckIn](INFO): Running loop #28 2026-01-22T23:34:03.800Z,1769124843.800 [Default:CheckIn] Running Loop=28 2026-01-22T23:34:03.800Z,1769124843.800 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:34:03.800Z,1769124843.800 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:34:05.836Z,1769124845.836 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233403.00,A,3648.17817,N,12147.27422,W,0.233,292.13,220126,,,A*74 2026-01-22T23:34:05.838Z,1769124845.838 [NAL9602](INFO): GPS fix at 20260122T233403: (36.802970, -121.787904) 2026-01-22T23:34:05.849Z,1769124845.849 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:34:05.849Z,1769124845.849 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:34:13.219Z,1769124853.219 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0075.lzma 2026-01-22T23:34:14.222Z,1769124854.222 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0075.lzma.bak 2026-01-22T23:34:14.222Z,1769124854.222 [DataOverHttps](INFO): SBD MOMSN=26586643 2026-01-22T23:34:30.132Z,1769124870.132 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20260122T212005/Express0076.lzma 2026-01-22T23:34:31.135Z,1769124871.135 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0076.lzma.bak 2026-01-22T23:34:31.135Z,1769124871.135 [DataOverHttps](INFO): SBD MOMSN=26586646 2026-01-22T23:34:32.487Z,1769124872.487 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:34:32.487Z,1769124872.487 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:34:32.487Z,1769124872.487 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:36:21.580Z,1769124981.580 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2026-01-22T23:38:15.508Z,1769125095.508 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-01-22T23:39:08.427Z,1769125148.427 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-22T23:39:33.095Z,1769125173.095 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:39:33.096Z,1769125173.096 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:39:33.096Z,1769125173.096 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:39:33.096Z,1769125173.096 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:39:33.486Z,1769125173.486 [Default:CheckIn:D] Stopped 2026-01-22T23:39:33.486Z,1769125173.486 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 155.549382 min 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn:E] Stopped 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn] Stopped 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn](INFO): Running loop #29 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn] Running Loop=29 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:39:33.890Z,1769125173.890 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:39:35.900Z,1769125175.900 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233933.00,A,3648.18432,N,12147.27606,W,0.019,292.13,220126,,,A*70 2026-01-22T23:39:35.903Z,1769125175.903 [NAL9602](INFO): GPS fix at 20260122T233933: (36.803072, -121.787934) 2026-01-22T23:39:35.913Z,1769125175.913 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:39:35.913Z,1769125175.913 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:39:43.303Z,1769125183.303 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0078.lzma 2026-01-22T23:39:44.306Z,1769125184.306 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0078.lzma.bak 2026-01-22T23:39:44.306Z,1769125184.306 [DataOverHttps](INFO): SBD MOMSN=26586660 2026-01-22T23:40:00.256Z,1769125200.256 [DataOverHttps](INFO): Sending 274 bytes from file Logs/20260122T212005/Express0079.lzma 2026-01-22T23:40:01.258Z,1769125201.258 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0079.lzma.bak 2026-01-22T23:40:01.258Z,1769125201.258 [DataOverHttps](INFO): SBD MOMSN=26586664 2026-01-22T23:40:02.569Z,1769125202.569 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:40:02.569Z,1769125202.569 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:40:02.570Z,1769125202.570 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:40:08.630Z,1769125208.630 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:42:09.893Z,1769125329.893 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2026-01-22T23:45:03.235Z,1769125503.235 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:45:03.235Z,1769125503.235 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:45:03.235Z,1769125503.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:45:03.235Z,1769125503.235 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:45:03.653Z,1769125503.653 [Default:CheckIn:D] Stopped 2026-01-22T23:45:03.653Z,1769125503.653 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:45:04.041Z,1769125504.041 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 161.052165 min 2026-01-22T23:45:04.041Z,1769125504.041 [Default:CheckIn:E] Stopped 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn] Stopped 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn](INFO): Running loop #30 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn] Running Loop=30 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:45:04.042Z,1769125504.042 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:45:06.054Z,1769125506.054 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234503.00,A,3648.18188,N,12147.27897,W,0.039,345.71,220126,,,A*77 2026-01-22T23:45:06.057Z,1769125506.057 [NAL9602](INFO): GPS fix at 20260122T234503: (36.803031, -121.787983) 2026-01-22T23:45:06.067Z,1769125506.067 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:45:06.067Z,1769125506.067 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:45:14.083Z,1769125514.083 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0081.lzma 2026-01-22T23:45:15.087Z,1769125515.087 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0081.lzma.bak 2026-01-22T23:45:15.087Z,1769125515.087 [DataOverHttps](INFO): SBD MOMSN=26586675 2026-01-22T23:45:31.240Z,1769125531.240 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20260122T212005/Express0082.lzma 2026-01-22T23:45:32.242Z,1769125532.242 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0082.lzma.bak 2026-01-22T23:45:32.242Z,1769125532.242 [DataOverHttps](INFO): SBD MOMSN=26586679 2026-01-22T23:45:33.540Z,1769125533.540 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:45:33.540Z,1769125533.540 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:45:33.540Z,1769125533.540 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:45:36.878Z,1769125536.878 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-01-22T23:45:36.960Z,1769125536.960 [NAL9602](ERROR): received: +CSQ:0 OK397, 0, 0, 0, 0 OK 2026-01-22T23:47:19.377Z,1769125639.377 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2026-01-22T23:47:19.381Z,1769125639.381 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2026-01-22T23:48:54.723Z,1769125734.723 [NAL9602](INFO): SBD MO Status=2, MOMSN=25398, MT Status=2, MTMSN=0 2026-01-22T23:48:54.723Z,1769125734.723 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T23:49:11.690Z,1769125751.690 [NAL9602](INFO): SBD MO Status=2, MOMSN=25398, MT Status=2, MTMSN=0 2026-01-22T23:49:11.691Z,1769125751.691 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-22T23:50:08.253Z,1769125808.253 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-22T23:50:34.111Z,1769125834.111 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:50:34.111Z,1769125834.111 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:50:34.111Z,1769125834.111 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:50:34.111Z,1769125834.111 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:50:34.525Z,1769125834.525 [Default:CheckIn:D] Stopped 2026-01-22T23:50:34.525Z,1769125834.525 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 166.566699 min 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn:E] Stopped 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn] Stopped 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn](INFO): Running loop #31 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn] Running Loop=31 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:50:34.946Z,1769125834.946 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:50:36.948Z,1769125836.948 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235034.00,A,3648.17483,N,12147.26953,W,0.078,345.71,220126,,,A*7B 2026-01-22T23:50:36.951Z,1769125836.951 [NAL9602](INFO): GPS fix at 20260122T235034: (36.802914, -121.787825) 2026-01-22T23:50:36.981Z,1769125836.981 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:50:36.981Z,1769125836.981 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:50:44.651Z,1769125844.651 [DataOverHttps](INFO): Sending 90 bytes from file Logs/20260122T212005/Courier0084.lzma 2026-01-22T23:50:45.654Z,1769125845.654 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0084.lzma.bak 2026-01-22T23:50:45.654Z,1769125845.654 [DataOverHttps](INFO): SBD MOMSN=26586693 2026-01-22T23:51:01.568Z,1769125861.568 [DataOverHttps](INFO): Sending 338 bytes from file Logs/20260122T212005/Express0085.lzma 2026-01-22T23:51:02.570Z,1769125862.570 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0085.lzma.bak 2026-01-22T23:51:02.570Z,1769125862.570 [DataOverHttps](INFO): SBD MOMSN=26586697 2026-01-22T23:51:04.010Z,1769125864.010 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:51:04.011Z,1769125864.011 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:51:04.011Z,1769125864.011 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:51:09.687Z,1769125869.687 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-22T23:56:04.587Z,1769126164.587 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-22T23:56:04.587Z,1769126164.587 [Default:CheckIn:C.Wait] Stopped 2026-01-22T23:56:04.587Z,1769126164.587 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-22T23:56:04.587Z,1769126164.587 [Default:CheckIn:D] Running Loop=1 2026-01-22T23:56:04.996Z,1769126164.996 [Default:CheckIn:D] Stopped 2026-01-22T23:56:04.996Z,1769126164.996 [Default:CheckIn:E] Running Loop=1 2026-01-22T23:56:05.389Z,1769126165.389 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 172.074544 min 2026-01-22T23:56:05.389Z,1769126165.389 [Default:CheckIn:E] Stopped 2026-01-22T23:56:05.389Z,1769126165.389 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-22T23:56:05.389Z,1769126165.389 [Default:CheckIn] Stopped 2026-01-22T23:56:05.389Z,1769126165.389 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-22T23:56:05.390Z,1769126165.390 [Default:CheckIn](INFO): Running loop #32 2026-01-22T23:56:05.390Z,1769126165.390 [Default:CheckIn] Running Loop=32 2026-01-22T23:56:05.390Z,1769126165.390 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-22T23:56:05.390Z,1769126165.390 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-22T23:56:07.405Z,1769126167.405 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235604.00,A,3648.17545,N,12147.26756,W,0.136,345.71,220126,,,A*75 2026-01-22T23:56:07.407Z,1769126167.407 [NAL9602](INFO): GPS fix at 20260122T235604: (36.802924, -121.787793) 2026-01-22T23:56:07.418Z,1769126167.418 [Default:CheckIn:Read_GPS] Stopped 2026-01-22T23:56:07.418Z,1769126167.418 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-22T23:56:14.768Z,1769126174.768 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0087.lzma 2026-01-22T23:56:15.770Z,1769126175.770 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0087.lzma.bak 2026-01-22T23:56:15.770Z,1769126175.770 [DataOverHttps](INFO): SBD MOMSN=26586714 2026-01-22T23:56:34.588Z,1769126194.588 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0088.lzma 2026-01-22T23:56:35.594Z,1769126195.594 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0088.lzma.bak 2026-01-22T23:56:35.594Z,1769126195.594 [DataOverHttps](INFO): SBD MOMSN=26586717 2026-01-22T23:56:37.314Z,1769126197.314 [Default:CheckIn:Read_Iridium] Stopped 2026-01-22T23:56:37.314Z,1769126197.314 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-22T23:56:37.314Z,1769126197.314 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-22T23:56:38.109Z,1769126198.109 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-01-22T23:56:38.188Z,1769126198.188 [NAL9602](ERROR): received: +CSQ:0 OK398, 2, 0, 0, 0 OK 2026-01-22T23:58:59.106Z,1769126339.106 [NAL9602](INFO): SBD MO Status=2, MOMSN=25398, MT Status=2, MTMSN=0 2026-01-22T23:58:59.106Z,1769126339.106 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-23T00:01:09.601Z,1769126469.601 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-23T00:01:37.906Z,1769126497.906 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:01:37.906Z,1769126497.906 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:01:37.906Z,1769126497.906 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:01:37.906Z,1769126497.906 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:01:38.323Z,1769126498.323 [Default:CheckIn:D] Stopped 2026-01-23T00:01:38.323Z,1769126498.323 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:01:38.743Z,1769126498.743 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 177.630013 min 2026-01-23T00:01:38.743Z,1769126498.743 [Default:CheckIn:E] Stopped 2026-01-23T00:01:38.743Z,1769126498.743 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:01:38.743Z,1769126498.743 [Default:CheckIn] Stopped 2026-01-23T00:01:38.743Z,1769126498.743 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:01:38.744Z,1769126498.744 [Default:CheckIn](INFO): Running loop #33 2026-01-23T00:01:38.744Z,1769126498.744 [Default:CheckIn] Running Loop=33 2026-01-23T00:01:38.744Z,1769126498.744 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:01:38.744Z,1769126498.744 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:01:40.714Z,1769126500.714 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000137.00,A,3648.17738,N,12147.28095,W,0.058,345.71,230126,,,A*70 2026-01-23T00:01:40.717Z,1769126500.717 [NAL9602](INFO): GPS fix at 20260123T000137: (36.802956, -121.788016) 2026-01-23T00:01:40.727Z,1769126500.727 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:01:40.727Z,1769126500.727 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:01:47.811Z,1769126507.811 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0090.lzma 2026-01-23T00:01:48.834Z,1769126508.834 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0090.lzma.bak 2026-01-23T00:01:48.834Z,1769126508.834 [DataOverHttps](INFO): SBD MOMSN=26586731 2026-01-23T00:02:04.612Z,1769126524.612 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20260122T212005/Express0091.lzma 2026-01-23T00:02:05.614Z,1769126525.614 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0091.lzma.bak 2026-01-23T00:02:05.614Z,1769126525.614 [DataOverHttps](INFO): SBD MOMSN=26586734 2026-01-23T00:02:06.978Z,1769126526.978 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:02:06.978Z,1769126526.978 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:02:06.978Z,1769126526.978 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:02:13.433Z,1769126533.433 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-23T00:07:07.554Z,1769126827.554 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:07:07.554Z,1769126827.554 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:07:07.554Z,1769126827.554 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:07:07.554Z,1769126827.554 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:07:07.955Z,1769126827.955 [Default:CheckIn:D] Stopped 2026-01-23T00:07:07.955Z,1769126827.955 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 183.123861 min 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn:E] Stopped 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn] Stopped 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn](INFO): Running loop #34 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn] Running Loop=34 2026-01-23T00:07:08.365Z,1769126828.365 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:07:08.366Z,1769126828.366 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:07:10.371Z,1769126830.371 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000707.00,A,3648.18853,N,12147.28227,W,0.019,0.00,230126,,,A*72 2026-01-23T00:07:10.373Z,1769126830.373 [NAL9602](INFO): GPS fix at 20260123T000707: (36.803142, -121.788038) 2026-01-23T00:07:10.403Z,1769126830.403 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:07:10.403Z,1769126830.403 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:07:18.139Z,1769126838.139 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0093.lzma 2026-01-23T00:07:19.142Z,1769126839.142 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0093.lzma.bak 2026-01-23T00:07:19.142Z,1769126839.142 [DataOverHttps](INFO): SBD MOMSN=26586743 2026-01-23T00:07:34.976Z,1769126854.976 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20260122T212005/Express0094.lzma 2026-01-23T00:07:35.978Z,1769126855.978 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0094.lzma.bak 2026-01-23T00:07:35.978Z,1769126855.978 [DataOverHttps](INFO): SBD MOMSN=26586746 2026-01-23T00:07:37.515Z,1769126857.515 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:07:37.515Z,1769126857.515 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:07:37.515Z,1769126857.515 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:07:41.086Z,1769126861.086 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-01-23T00:07:41.168Z,1769126861.168 [NAL9602](ERROR): received: +CSQ:0 OK398, 2, 0, 0, 0 OK 2026-01-23T00:09:37.044Z,1769126977.044 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2026-01-23T00:12:11.363Z,1769127131.363 [BPC1](ERROR): BPC1A: No match for serial number FFFF in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2026-01-23T00:12:12.576Z,1769127132.576 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-23T00:12:38.050Z,1769127158.050 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:12:38.050Z,1769127158.050 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:12:38.050Z,1769127158.050 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:12:38.050Z,1769127158.050 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:12:38.464Z,1769127158.464 [Default:CheckIn:D] Stopped 2026-01-23T00:12:38.464Z,1769127158.464 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:12:38.868Z,1769127158.868 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 188.632357 min 2026-01-23T00:12:38.868Z,1769127158.868 [Default:CheckIn:E] Stopped 2026-01-23T00:12:38.868Z,1769127158.868 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:12:38.868Z,1769127158.868 [Default:CheckIn] Stopped 2026-01-23T00:12:38.869Z,1769127158.869 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:12:38.869Z,1769127158.869 [Default:CheckIn](INFO): Running loop #35 2026-01-23T00:12:38.869Z,1769127158.869 [Default:CheckIn] Running Loop=35 2026-01-23T00:12:38.869Z,1769127158.869 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:12:38.869Z,1769127158.869 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:12:40.863Z,1769127160.863 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001238.00,A,3648.18333,N,12147.28126,W,0.253,152.69,230126,,,A*70 2026-01-23T00:12:40.865Z,1769127160.865 [NAL9602](INFO): GPS fix at 20260123T001238: (36.803055, -121.788021) 2026-01-23T00:12:40.892Z,1769127160.892 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:12:40.892Z,1769127160.892 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:12:48.044Z,1769127168.044 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0096.lzma 2026-01-23T00:12:49.047Z,1769127169.047 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0096.lzma.bak 2026-01-23T00:12:49.047Z,1769127169.047 [DataOverHttps](INFO): SBD MOMSN=26586751 2026-01-23T00:13:04.873Z,1769127184.873 [DataOverHttps](INFO): Sending 252 bytes from file Logs/20260122T212005/Express0097.lzma 2026-01-23T00:13:05.870Z,1769127185.870 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0097.lzma.bak 2026-01-23T00:13:05.870Z,1769127185.870 [DataOverHttps](INFO): SBD MOMSN=26586754 2026-01-23T00:13:07.179Z,1769127187.179 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:13:07.179Z,1769127187.179 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:13:07.179Z,1769127187.179 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:13:13.625Z,1769127193.625 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-23T00:18:07.787Z,1769127487.787 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:18:07.787Z,1769127487.787 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:18:07.787Z,1769127487.787 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:18:07.788Z,1769127487.788 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:18:08.204Z,1769127488.204 [Default:CheckIn:D] Stopped 2026-01-23T00:18:08.205Z,1769127488.205 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:18:08.591Z,1769127488.591 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 194.128027 min 2026-01-23T00:18:08.591Z,1769127488.591 [Default:CheckIn:E] Stopped 2026-01-23T00:18:08.591Z,1769127488.591 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:18:08.591Z,1769127488.591 [Default:CheckIn] Stopped 2026-01-23T00:18:08.591Z,1769127488.591 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:18:08.592Z,1769127488.592 [Default:CheckIn](INFO): Running loop #36 2026-01-23T00:18:08.592Z,1769127488.592 [Default:CheckIn] Running Loop=36 2026-01-23T00:18:08.592Z,1769127488.592 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:18:08.592Z,1769127488.592 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:18:10.603Z,1769127490.603 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001807.00,A,3648.17549,N,12147.28395,W,0.058,162.27,230126,,,A*78 2026-01-23T00:18:10.605Z,1769127490.605 [NAL9602](INFO): GPS fix at 20260123T001807: (36.802925, -121.788066) 2026-01-23T00:18:10.616Z,1769127490.616 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:18:10.616Z,1769127490.616 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:18:18.663Z,1769127498.663 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0099.lzma 2026-01-23T00:18:19.666Z,1769127499.666 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0099.lzma.bak 2026-01-23T00:18:19.666Z,1769127499.666 [DataOverHttps](INFO): SBD MOMSN=26586770 2026-01-23T00:18:36.124Z,1769127516.124 [DataOverHttps](INFO): Sending 165 bytes from file Logs/20260122T212005/Express0100.lzma 2026-01-23T00:18:37.126Z,1769127517.126 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0100.lzma.bak 2026-01-23T00:18:37.126Z,1769127517.126 [DataOverHttps](INFO): SBD MOMSN=26586774 2026-01-23T00:18:38.490Z,1769127518.490 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:18:38.490Z,1769127518.490 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:18:38.490Z,1769127518.490 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:18:41.416Z,1769127521.416 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-01-23T00:18:41.496Z,1769127521.496 [NAL9602](ERROR): received: +CSQ:0 OK398, 2, 0, 0, 0 OK 2026-01-23T00:19:35.463Z,1769127575.463 [NAL9602](INFO): SBD MO Status=2, MOMSN=25398, MT Status=2, MTMSN=0 2026-01-23T00:19:35.463Z,1769127575.463 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-01-23T00:20:07.762Z,1769127607.762 [NAL9602](INFO): SBD MO Status=0, MOMSN=25398, MT Status=0, MTMSN=0 2026-01-23T00:20:07.762Z,1769127607.762 [NAL9602](INFO): No messages in MT queue 2026-01-23T00:20:38.460Z,1769127638.460 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-23T00:23:39.062Z,1769127819.062 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:23:39.063Z,1769127819.063 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:23:39.063Z,1769127819.063 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:23:39.063Z,1769127819.063 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:23:39.465Z,1769127819.465 [Default:CheckIn:D] Stopped 2026-01-23T00:23:39.465Z,1769127819.465 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 199.649040 min 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn:E] Stopped 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn] Stopped 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn](INFO): Running loop #37 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn] Running Loop=37 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:23:39.871Z,1769127819.871 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:23:41.888Z,1769127821.888 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002339.00,A,3648.17600,N,12147.28179,W,0.039,162.27,230126,,,A*74 2026-01-23T00:23:41.890Z,1769127821.890 [NAL9602](INFO): GPS fix at 20260123T002339: (36.802933, -121.788030) 2026-01-23T00:23:41.900Z,1769127821.900 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:23:41.900Z,1769127821.900 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:23:49.916Z,1769127829.916 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0102.lzma 2026-01-23T00:23:50.550Z,1769127830.550 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0102.lzma.bak 2026-01-23T00:23:50.550Z,1769127830.550 [DataOverHttps](INFO): SBD MOMSN=26586784 2026-01-23T00:24:06.548Z,1769127846.548 [DataOverHttps](INFO): Sending 166 bytes from file Logs/20260122T212005/Express0103.lzma 2026-01-23T00:24:07.550Z,1769127847.550 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0103.lzma.bak 2026-01-23T00:24:07.550Z,1769127847.550 [DataOverHttps](INFO): SBD MOMSN=26586789 2026-01-23T00:24:08.959Z,1769127848.959 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:24:08.959Z,1769127848.959 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:24:08.959Z,1769127848.959 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:28:21.452Z,1769128101.452 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2026-01-23T00:28:21.456Z,1769128101.456 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 1, 2, 3, 4, 5, 6, 7, 8. 2026-01-23T00:28:44.478Z,1769128124.478 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-23T00:28:45.283Z,1769128125.283 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2026-01-23T00:28:45.283Z,1769128125.283 [DropWeight] Hardware Fault, FailCount= 1 2026-01-23T00:28:45.283Z,1769128125.283 [DropWeight](ERROR): Hardware Fault 2026-01-23T00:28:45.322Z,1769128125.322 [CommandExec](FAULT): Scheduling is paused for 2 commands 2026-01-23T00:28:45.322Z,1769128125.322 [CBIT](INFO): Critical error at 20260123T002845 2026-01-23T00:28:45.329Z,1769128125.329 [CBIT](ERROR): Hardware Fault in component: DropWeight 2026-01-23T00:28:45.329Z,1769128125.329 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2026-01-23T00:28:45.715Z,1769128125.715 [CBIT](INFO): Critical error at 20260123T002845 2026-01-23T00:29:09.547Z,1769128149.547 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:29:09.547Z,1769128149.547 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:29:09.547Z,1769128149.547 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:29:09.547Z,1769128149.547 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:29:09.933Z,1769128149.933 [Default:CheckIn:D] Stopped 2026-01-23T00:29:09.933Z,1769128149.933 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 205.156836 min 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn:E] Stopped 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn] Stopped 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn](INFO): Running loop #38 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn] Running Loop=38 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:29:10.359Z,1769128150.359 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:29:12.349Z,1769128152.349 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002909.00,A,3648.18187,N,12147.27549,W,0.583,113.24,230126,,,A*73 2026-01-23T00:29:12.351Z,1769128152.351 [NAL9602](INFO): GPS fix at 20260123T002909: (36.803031, -121.787925) 2026-01-23T00:29:12.376Z,1769128152.376 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:29:12.376Z,1769128152.376 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:29:19.648Z,1769128159.648 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20260122T212005/Courier0105.lzma 2026-01-23T00:29:20.650Z,1769128160.650 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0105.lzma.bak 2026-01-23T00:29:20.650Z,1769128160.650 [DataOverHttps](INFO): SBD MOMSN=26586796 2026-01-23T00:29:36.512Z,1769128176.512 [DataOverHttps](INFO): Sending 358 bytes from file Logs/20260122T212005/Express0106.lzma 2026-01-23T00:29:37.514Z,1769128177.514 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0106.lzma.bak 2026-01-23T00:29:37.515Z,1769128177.515 [DataOverHttps](INFO): SBD MOMSN=26586805 2026-01-23T00:29:39.039Z,1769128179.039 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:29:39.039Z,1769128179.039 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:29:39.039Z,1769128179.039 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:29:44.667Z,1769128184.667 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-23T00:34:39.602Z,1769128479.602 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:34:39.602Z,1769128479.602 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:34:39.603Z,1769128479.603 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:34:39.603Z,1769128479.603 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:34:40.011Z,1769128480.011 [Default:CheckIn:D] Stopped 2026-01-23T00:34:40.011Z,1769128480.011 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:34:40.425Z,1769128480.425 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 210.658138 min 2026-01-23T00:34:40.425Z,1769128480.425 [Default:CheckIn:E] Stopped 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn] Stopped 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn](INFO): Running loop #39 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn] Running Loop=39 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:34:40.426Z,1769128480.426 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:34:42.421Z,1769128482.421 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,003439.00,A,3648.16633,N,12147.28468,W,0.136,64.14,230126,,,D*4A 2026-01-23T00:34:42.423Z,1769128482.423 [NAL9602](INFO): GPS fix at 20260123T003439: (36.802772, -121.788078) 2026-01-23T00:34:42.434Z,1769128482.434 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:34:42.434Z,1769128482.434 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:34:49.971Z,1769128489.971 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0108.lzma 2026-01-23T00:34:50.974Z,1769128490.974 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0108.lzma.bak 2026-01-23T00:34:50.974Z,1769128490.974 [DataOverHttps](INFO): SBD MOMSN=26586825 2026-01-23T00:35:06.824Z,1769128506.824 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20260122T212005/Express0109.lzma 2026-01-23T00:35:07.826Z,1769128507.826 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0109.lzma.bak 2026-01-23T00:35:07.826Z,1769128507.826 [DataOverHttps](INFO): SBD MOMSN=26586828 2026-01-23T00:35:09.117Z,1769128509.117 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:35:09.117Z,1769128509.117 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:35:09.117Z,1769128509.117 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:35:13.125Z,1769128513.125 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-01-23T00:35:13.200Z,1769128513.200 [NAL9602](ERROR): received: +CSQ:0 OK398, 0, 0, 0, 0 OK 2026-01-23T00:39:44.621Z,1769128784.621 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-23T00:40:09.688Z,1769128809.688 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:40:09.688Z,1769128809.688 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:40:09.688Z,1769128809.688 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:40:09.688Z,1769128809.688 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:40:10.086Z,1769128810.086 [Default:CheckIn:D] Stopped 2026-01-23T00:40:10.086Z,1769128810.086 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 216.159391 min 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn:E] Stopped 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn] Stopped 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn](INFO): Running loop #40 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn] Running Loop=40 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:40:10.550Z,1769128810.550 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:40:12.502Z,1769128812.502 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,004009.00,A,3648.15863,N,12147.27435,W,0.428,22.54,230126,,,A*4C 2026-01-23T00:40:12.505Z,1769128812.505 [NAL9602](INFO): GPS fix at 20260123T004009: (36.802644, -121.787906) 2026-01-23T00:40:12.515Z,1769128812.515 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:40:12.515Z,1769128812.515 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:40:20.031Z,1769128820.031 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0111.lzma 2026-01-23T00:40:21.034Z,1769128821.034 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0111.lzma.bak 2026-01-23T00:40:21.034Z,1769128821.034 [DataOverHttps](INFO): SBD MOMSN=26586847 2026-01-23T00:40:39.572Z,1769128839.572 [DataOverHttps](INFO): Sending 244 bytes from file Logs/20260122T212005/Express0112.lzma 2026-01-23T00:40:40.574Z,1769128840.574 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0112.lzma.bak 2026-01-23T00:40:40.574Z,1769128840.574 [DataOverHttps](INFO): SBD MOMSN=26586853 2026-01-23T00:40:42.011Z,1769128842.011 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:40:42.011Z,1769128842.011 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:40:42.011Z,1769128842.011 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:40:44.433Z,1769128844.433 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-23T00:43:45.439Z,1769129025.439 [CBIT](INFO): Clearing failed state for component DropWeight 2026-01-23T00:43:45.439Z,1769129025.439 [DropWeight] No Fault, FailCount= 1 2026-01-23T00:45:42.591Z,1769129142.591 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:45:42.591Z,1769129142.591 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:45:42.591Z,1769129142.591 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:45:42.591Z,1769129142.591 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:45:42.991Z,1769129142.991 [Default:CheckIn:D] Stopped 2026-01-23T00:45:42.991Z,1769129142.991 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 221.707796 min 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn:E] Stopped 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn] Stopped 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn](INFO): Running loop #41 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn] Running Loop=41 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:45:43.401Z,1769129143.401 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:45:45.465Z,1769129145.465 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,004542.00,A,3648.15524,N,12147.28341,W,0.136,22.54,230126,,,A*49 2026-01-23T00:45:45.467Z,1769129145.467 [NAL9602](INFO): GPS fix at 20260123T004542: (36.802587, -121.788057) 2026-01-23T00:45:45.477Z,1769129145.477 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:45:45.477Z,1769129145.477 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:45:52.723Z,1769129152.723 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20260122T212005/Courier0114.lzma 2026-01-23T00:45:53.726Z,1769129153.726 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0114.lzma.bak 2026-01-23T00:45:53.726Z,1769129153.726 [DataOverHttps](INFO): SBD MOMSN=26586878 2026-01-23T00:46:09.703Z,1769129169.703 [DataOverHttps](INFO): Sending 165 bytes from file Logs/20260122T212005/Express0115.lzma 2026-01-23T00:46:10.706Z,1769129170.706 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0115.lzma.bak 2026-01-23T00:46:10.706Z,1769129170.706 [DataOverHttps](INFO): SBD MOMSN=26586881 2026-01-23T00:46:12.080Z,1769129172.080 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:46:12.080Z,1769129172.080 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:46:12.080Z,1769129172.080 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:46:16.111Z,1769129176.111 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-01-23T00:46:16.188Z,1769129176.188 [NAL9602](ERROR): received: +CSQ:0 OK398, 0, 0, 0, 0 OK 2026-01-23T00:50:47.649Z,1769129447.649 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-01-23T00:51:00.002Z,1769129460.002 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-01-23T00:51:12.852Z,1769129472.852 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-01-23T00:51:12.852Z,1769129472.852 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:51:12.852Z,1769129472.852 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:51:12.852Z,1769129472.852 [Default:CheckIn:D] Running Loop=1 2026-01-23T00:51:13.171Z,1769129473.171 [Default:CheckIn:D] Stopped 2026-01-23T00:51:13.171Z,1769129473.171 [Default:CheckIn:E] Running Loop=1 2026-01-23T00:51:13.529Z,1769129473.529 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 227.210807 min 2026-01-23T00:51:13.529Z,1769129473.529 [Default:CheckIn:E] Stopped 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn] Stopped 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn](INFO): Running loop #42 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn] Running Loop=42 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-01-23T00:51:13.530Z,1769129473.530 [Default:CheckIn:Read_GPS] Running Loop=1 2026-01-23T00:51:15.523Z,1769129475.523 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,005112.00,A,3648.15455,N,12147.27418,W,0.544,0.00,230126,,,A*7A 2026-01-23T00:51:15.534Z,1769129475.534 [NAL9602](INFO): GPS fix at 20260123T005112: (36.802576, -121.787903) 2026-01-23T00:51:15.557Z,1769129475.557 [Default:CheckIn:Read_GPS] Stopped 2026-01-23T00:51:15.557Z,1769129475.557 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-01-23T00:51:26.029Z,1769129486.029 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2026-01-23T00:51:27.944Z,1769129487.944 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20260122T212005/Courier0117.lzma 2026-01-23T00:51:28.946Z,1769129488.946 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Courier0117.lzma.bak 2026-01-23T00:51:28.946Z,1769129488.946 [DataOverHttps](INFO): SBD MOMSN=26586892 2026-01-23T00:51:47.450Z,1769129507.450 [NAL9602](INFO): Not Powering down - fast GPS 2026-01-23T00:51:56.041Z,1769129516.041 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20260122T212005/Express0118.lzma 2026-01-23T00:51:57.038Z,1769129517.038 [DataOverHttps](INFO): Moved sent file to Logs/20260122T212005/Express0118.lzma.bak 2026-01-23T00:51:57.038Z,1769129517.038 [DataOverHttps](INFO): SBD MOMSN=26586909 2026-01-23T00:51:58.776Z,1769129518.776 [Default:CheckIn:Read_Iridium] Stopped 2026-01-23T00:51:58.776Z,1769129518.776 [Default:CheckIn:C.Wait] Running Loop=1 2026-01-23T00:51:58.776Z,1769129518.776 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-01-23T00:52:12.423Z,1769129532.423 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent 2026-01-23T00:52:12.424Z,1769129532.424 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 95.000000 % 2026-01-23T00:52:17.677Z,1769129537.677 [CommandExec](IMPORTANT): got command quit 2026-01-23T00:52:18.680Z,1769129538.680 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:18.680Z,1769129538.680 [CommandExec](INFO): Uninitializing the command executive. 2026-01-23T00:52:18.680Z,1769129538.680 [CommandExec](INFO): Uninitializing the command scheduler. 2026-01-23T00:52:18.681Z,1769129538.681 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:18.720Z,1769129538.720 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2026-01-23T00:52:18.720Z,1769129538.720 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2026-01-23T00:52:18.721Z,1769129538.721 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:18.721Z,1769129538.721 [NavChartDb](INFO): Join timeout helper Thread ID is 6315 2026-01-23T00:52:18.736Z,1769129538.736 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:18.736Z,1769129538.736 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:18.768Z,1769129538.768 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2026-01-23T00:52:18.768Z,1769129538.768 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:18.768Z,1769129538.768 [Radio_Surface](INFO): Join timeout helper Thread ID is 6316 2026-01-23T00:52:18.905Z,1769129538.905 [Radio_Surface](INFO): Powering down 2026-01-23T00:52:18.906Z,1769129538.906 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:18.906Z,1769129538.906 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:18.920Z,1769129538.920 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2026-01-23T00:52:18.920Z,1769129538.920 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:18.920Z,1769129538.920 [Onboard](INFO): Join timeout helper Thread ID is 6317 2026-01-23T00:52:19.740Z,1769129539.740 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2026-01-23T00:52:21.228Z,1769129541.228 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:21.229Z,1769129541.229 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:21.244Z,1769129541.244 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2026-01-23T00:52:21.244Z,1769129541.244 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:21.244Z,1769129541.244 [DataOverHttps](INFO): Join timeout helper Thread ID is 6318 2026-01-23T00:52:21.748Z,1769129541.748 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:21.748Z,1769129541.748 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:21.757Z,1769129541.757 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2026-01-23T00:52:21.757Z,1769129541.757 [DAT ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:21.757Z,1769129541.757 [DAT](INFO): Join timeout helper Thread ID is 6319 2026-01-23T00:52:21.960Z,1769129541.960 [DAT](INFO): Powering down 2026-01-23T00:52:22.032Z,1769129542.032 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:22.033Z,1769129542.033 [DAT](INFO): Powering down 2026-01-23T00:52:22.034Z,1769129542.034 [DAT ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.049Z,1769129542.049 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2026-01-23T00:52:22.049Z,1769129542.049 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.049Z,1769129542.049 [BackseatComponent](INFO): Join timeout helper Thread ID is 6320 2026-01-23T00:52:22.216Z,1769129542.216 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:22.216Z,1769129542.216 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.229Z,1769129542.229 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2026-01-23T00:52:22.229Z,1769129542.229 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.229Z,1769129542.229 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6321 2026-01-23T00:52:22.708Z,1769129542.708 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:22.708Z,1769129542.708 [WetLabsBB2FL](INFO): Powering down 2026-01-23T00:52:22.709Z,1769129542.709 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.713Z,1769129542.713 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2026-01-23T00:52:22.713Z,1769129542.713 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.713Z,1769129542.713 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6322 2026-01-23T00:52:22.856Z,1769129542.856 [CTD_Seabird](INFO): Powering down 2026-01-23T00:52:22.868Z,1769129542.868 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:22.868Z,1769129542.868 [CTD_Seabird](INFO): Powering down 2026-01-23T00:52:22.880Z,1769129542.880 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.893Z,1769129542.893 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2026-01-23T00:52:22.893Z,1769129542.893 [logger ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.893Z,1769129542.893 [logger](INFO): Join timeout helper Thread ID is 6323 2026-01-23T00:52:22.896Z,1769129542.896 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:22.896Z,1769129542.896 [logger ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.917Z,1769129542.917 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2026-01-23T00:52:22.918Z,1769129542.918 [CommandLine ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:22.918Z,1769129542.918 [CommandLine](INFO): Join timeout helper Thread ID is 6324 2026-01-23T00:52:22.988Z,1769129542.988 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:22.988Z,1769129542.988 [CommandLine ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.009Z,1769129543.009 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2026-01-23T00:52:23.009Z,1769129543.009 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.009Z,1769129543.009 [CommandExec](INFO): Join timeout helper Thread ID is 6325 2026-01-23T00:52:23.017Z,1769129543.017 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2026-01-23T00:52:23.017Z,1769129543.017 [controlThread ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.017Z,1769129543.017 [controlThread](INFO): Join timeout helper Thread ID is 6326 2026-01-23T00:52:23.042Z,1769129543.042 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2026-01-23T00:52:23.042Z,1769129543.042 [controlThread](DEBUG): Uninitializing ControlThread 2026-01-23T00:52:23.043Z,1769129543.043 [AHRS_M2](INFO): Powering down 2026-01-23T00:52:23.120Z,1769129543.120 [NAL9602](INFO): Powering down 2026-01-23T00:52:23.122Z,1769129543.122 [Sonardyne_Nano](INFO): Powering down 2026-01-23T00:52:23.328Z,1769129543.328 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2026-01-23T00:52:23.329Z,1769129543.329 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2026-01-23T00:52:23.329Z,1769129543.329 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2026-01-23T00:52:23.330Z,1769129543.330 [MissionManager](INFO): Uninitializing Mission Default 2026-01-23T00:52:23.330Z,1769129543.330 [Default] Stopped 2026-01-23T00:52:23.330Z,1769129543.330 [Default](DEBUG): Aggregate::uninitialize Default 2026-01-23T00:52:23.330Z,1769129543.330 [Default:B.GoToSurface] Stopped 2026-01-23T00:52:23.330Z,1769129543.330 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-01-23T00:52:23.330Z,1769129543.330 [Default:CheckIn] Stopped 2026-01-23T00:52:23.330Z,1769129543.330 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-01-23T00:52:23.330Z,1769129543.330 [Default:CheckIn:C.Wait] Stopped 2026-01-23T00:52:23.330Z,1769129543.330 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-01-23T00:52:23.333Z,1769129543.333 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2026-01-23T00:52:23.334Z,1769129543.334 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2026-01-23T00:52:23.334Z,1769129543.334 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2026-01-23T00:52:23.334Z,1769129543.334 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2026-01-23T00:52:23.335Z,1769129543.335 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2026-01-23T00:52:23.335Z,1769129543.335 [BuoyancyServo](INFO): Powering down 2026-01-23T00:52:23.348Z,1769129543.348 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2026-01-23T00:52:23.348Z,1769129543.348 [ElevatorServo](INFO): Powering down 2026-01-23T00:52:23.349Z,1769129543.349 [MassServo](DEBUG): Uninitialize Mass Servo. 2026-01-23T00:52:23.349Z,1769129543.349 [MassServo](INFO): Powering down 2026-01-23T00:52:23.350Z,1769129543.350 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2026-01-23T00:52:23.350Z,1769129543.350 [RudderServo](INFO): Powering down 2026-01-23T00:52:23.351Z,1769129543.351 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2026-01-23T00:52:23.351Z,1769129543.351 [ThrusterHE](INFO): Powering down 2026-01-23T00:52:23.352Z,1769129543.352 [SBIT](DEBUG): Uninitialize SBIT Component. 2026-01-23T00:52:23.352Z,1769129543.352 [IBIT](DEBUG): Uninitialize IBIT Component. 2026-01-23T00:52:23.352Z,1769129543.352 [CBIT](DEBUG): Uninitialize CBIT Component. 2026-01-23T00:52:23.352Z,1769129543.352 [CBIT](DEBUG): Powering off loads. 2026-01-23T00:52:23.364Z,1769129543.364 [CBIT](DEBUG): Disabling WDT. 2026-01-23T00:52:23.376Z,1769129543.376 [GFScanner](DEBUG): Uninitialize GFScanner component. 2026-01-23T00:52:23.376Z,1769129543.376 [GFScanner](DEBUG): Opening all GF detection circuits. 2026-01-23T00:52:23.377Z,1769129543.377 [controlThread ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.415Z,1769129543.415 [GFScanner](DEBUG): Uninitialize GFScanner component. 2026-01-23T00:52:23.415Z,1769129543.415 [GFScanner](DEBUG): Opening all GF detection circuits. 2026-01-23T00:52:23.431Z,1769129543.431 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.437Z,1769129543.437 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.474Z,1769129543.474 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.477Z,1769129543.477 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.484Z,1769129543.484 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.490Z,1769129543.490 [DAT ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.534Z,1769129543.534 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.594Z,1769129543.594 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-01-23T00:52:23.693Z,1769129543.693 [logger ThreadHandler](INFO): Thread cancelled.