2026-02-11T18:00:23.638Z,1770832823.638 [CommandExec](IMPORTANT): got command restart logs 2026-02-11T18:02:03.078Z,1770832923.078 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:02:03.079Z,1770832923.079 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:02:03.079Z,1770832923.079 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:02:03.080Z,1770832923.080 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:02:03.491Z,1770832923.491 [Default:CheckIn:D] Stopped 2026-02-11T18:02:03.491Z,1770832923.491 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:02:03.884Z,1770832923.884 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.116532 min 2026-02-11T18:02:03.884Z,1770832923.884 [Default:CheckIn:E] Stopped 2026-02-11T18:02:03.884Z,1770832923.884 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:02:03.885Z,1770832923.885 [Default:CheckIn] Stopped 2026-02-11T18:02:03.885Z,1770832923.885 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:02:03.885Z,1770832923.885 [Default:CheckIn](INFO): Running loop #2 2026-02-11T18:02:03.885Z,1770832923.885 [Default:CheckIn] Running Loop=2 2026-02-11T18:02:03.885Z,1770832923.885 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:02:03.885Z,1770832923.885 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:02:05.876Z,1770832925.876 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180206.00,A,3648.21223,N,12148.14057,W,7.970,99.83,110226,,,D*40 2026-02-11T18:02:05.878Z,1770832925.878 [NAL9602](INFO): GPS fix at 20260211T180206: (36.803537, -121.802343) 2026-02-11T18:02:05.937Z,1770832925.937 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:02:05.937Z,1770832925.937 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:02:15.652Z,1770832935.652 [NAL9602](INFO): SBD MO Status=0, MOMSN=894, MT Status=0, MTMSN=0 2026-02-11T18:02:15.652Z,1770832935.652 [NAL9602](INFO): No messages in MT queue 2026-02-11T18:02:16.992Z,1770832936.992 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20260210T205501/Courier0123.lzma 2026-02-11T18:02:17.995Z,1770832937.995 [DataOverHttps](INFO): Moved sent file to Logs/20260210T205501/Courier0123.lzma.bak 2026-02-11T18:02:17.995Z,1770832937.995 [DataOverHttps](INFO): SBD MOMSN=26649480 2026-02-11T18:02:34.033Z,1770832954.033 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20260211T180023/Courier0000.lzma 2026-02-11T18:02:35.034Z,1770832955.034 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0000.lzma.bak 2026-02-11T18:02:35.034Z,1770832955.034 [DataOverHttps](INFO): SBD MOMSN=26649483 2026-02-11T18:02:46.346Z,1770832966.346 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:02:51.473Z,1770832971.473 [DataOverHttps](INFO): Sending 364 bytes from file Logs/20260210T205501/Express0124.lzma 2026-02-11T18:02:52.475Z,1770832972.475 [DataOverHttps](INFO): Moved sent file to Logs/20260210T205501/Express0124.lzma.bak 2026-02-11T18:02:52.475Z,1770832972.475 [DataOverHttps](INFO): SBD MOMSN=26649487 2026-02-11T18:03:08.493Z,1770832988.493 [DataOverHttps](INFO): Sending 567 bytes from file Logs/20260211T180023/Express0001.lzma 2026-02-11T18:03:09.494Z,1770832989.494 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0001.lzma.bak 2026-02-11T18:03:09.495Z,1770832989.495 [DataOverHttps](INFO): SBD MOMSN=26649491 2026-02-11T18:03:25.512Z,1770833005.512 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20260211T180023/Express0004.lzma 2026-02-11T18:03:26.514Z,1770833006.514 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0004.lzma.bak 2026-02-11T18:03:26.515Z,1770833006.515 [DataOverHttps](INFO): SBD MOMSN=26649500 2026-02-11T18:03:27.964Z,1770833007.964 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:03:27.964Z,1770833007.964 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:03:27.964Z,1770833007.964 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:07:06.932Z,1770833226.932 [BPC1](INFO): Calculating totals. Valid battery stick count: 42. Valid reserve battery stick count: 6. 2026-02-11T18:07:06.936Z,1770833226.936 [BPC1](FAULT): Failed to receive data from 12 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 48, 50, 51, 52, 54, 56, 57, 58, 59, 60, 61, 62. 2026-02-11T18:07:08.426Z,1770833228.426 [DataOverHttps](IMPORTANT): SBD MTMSN=20260211T180709 2026-02-11T18:07:16.120Z,1770833236.120 [DataOverHttps](INFO): Received command: strobe off 2026-02-11T18:07:16.166Z,1770833236.166 [CommandExec](IMPORTANT): got command strobe off 2026-02-11T18:07:16.166Z,1770833236.166 [CommandExec](IMPORTANT): Deactivating strobe 2026-02-11T18:08:28.555Z,1770833308.555 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:08:28.555Z,1770833308.555 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:08:28.555Z,1770833308.555 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:08:28.555Z,1770833308.555 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:08:29.041Z,1770833309.041 [Default:CheckIn:D] Stopped 2026-02-11T18:08:29.042Z,1770833309.042 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.542352 min 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn:E] Stopped 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn] Stopped 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn](INFO): Running loop #3 2026-02-11T18:08:29.373Z,1770833309.373 [Default:CheckIn] Running Loop=3 2026-02-11T18:08:29.374Z,1770833309.374 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:08:29.374Z,1770833309.374 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:08:31.375Z,1770833311.375 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180831.00,A,3648.24730,N,12147.15117,W,5.326,196.15,110226,,,D*7D 2026-02-11T18:08:31.386Z,1770833311.386 [NAL9602](INFO): GPS fix at 20260211T180831: (36.804122, -121.785853) 2026-02-11T18:08:31.413Z,1770833311.413 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:08:31.413Z,1770833311.413 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:08:38.932Z,1770833318.932 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20260211T180023/Courier0006.lzma 2026-02-11T18:08:39.934Z,1770833319.934 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0006.lzma.bak 2026-02-11T18:08:39.935Z,1770833319.935 [DataOverHttps](INFO): SBD MOMSN=26649520 2026-02-11T18:08:55.741Z,1770833335.741 [DataOverHttps](INFO): Sending 411 bytes from file Logs/20260211T180023/Express0007.lzma 2026-02-11T18:08:56.742Z,1770833336.742 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0007.lzma.bak 2026-02-11T18:08:56.743Z,1770833336.743 [DataOverHttps](INFO): SBD MOMSN=26649523 2026-02-11T18:09:12.700Z,1770833352.700 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20260211T180023/Express0010.lzma 2026-02-11T18:09:13.703Z,1770833353.703 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0010.lzma.bak 2026-02-11T18:09:13.703Z,1770833353.703 [DataOverHttps](INFO): SBD MOMSN=26649530 2026-02-11T18:09:15.025Z,1770833355.025 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:09:15.025Z,1770833355.025 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:09:15.025Z,1770833355.025 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:09:30.767Z,1770833370.767 [NAL9602](INFO): SBD MO Status=0, MOMSN=895, MT Status=0, MTMSN=0 2026-02-11T18:09:30.767Z,1770833370.767 [NAL9602](INFO): No messages in MT queue 2026-02-11T18:10:01.470Z,1770833401.470 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:14:15.597Z,1770833655.597 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:14:15.597Z,1770833655.597 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:14:15.597Z,1770833655.597 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:14:15.598Z,1770833655.598 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:14:16.008Z,1770833656.008 [Default:CheckIn:D] Stopped 2026-02-11T18:14:16.008Z,1770833656.008 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:14:16.411Z,1770833656.411 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.325155 min 2026-02-11T18:14:16.411Z,1770833656.411 [Default:CheckIn:E] Stopped 2026-02-11T18:14:16.411Z,1770833656.411 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:14:16.411Z,1770833656.411 [Default:CheckIn] Stopped 2026-02-11T18:14:16.411Z,1770833656.411 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:14:16.411Z,1770833656.411 [Default:CheckIn](INFO): Running loop #4 2026-02-11T18:14:16.412Z,1770833656.412 [Default:CheckIn] Running Loop=4 2026-02-11T18:14:16.412Z,1770833656.412 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:14:16.412Z,1770833656.412 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:14:18.411Z,1770833658.411 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181419.00,A,3648.15115,N,12147.22326,W,0.039,207.80,110226,,,D*72 2026-02-11T18:14:18.414Z,1770833658.414 [NAL9602](INFO): GPS fix at 20260211T181419: (36.802519, -121.787054) 2026-02-11T18:14:18.450Z,1770833658.450 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:14:18.450Z,1770833658.450 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:14:25.352Z,1770833665.352 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0012.lzma 2026-02-11T18:14:26.355Z,1770833666.355 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0012.lzma.bak 2026-02-11T18:14:26.355Z,1770833666.355 [DataOverHttps](INFO): SBD MOMSN=26649540 2026-02-11T18:14:42.296Z,1770833682.296 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20260211T180023/Express0013.lzma 2026-02-11T18:14:43.298Z,1770833683.298 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0013.lzma.bak 2026-02-11T18:14:43.299Z,1770833683.299 [DataOverHttps](INFO): SBD MOMSN=26649543 2026-02-11T18:14:44.700Z,1770833684.700 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:14:44.700Z,1770833684.700 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:14:44.700Z,1770833684.700 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:14:45.491Z,1770833685.491 [NAL9602](INFO): SBD MO Status=2, MOMSN=896, MT Status=2, MTMSN=0 2026-02-11T18:14:45.491Z,1770833685.491 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:15:05.291Z,1770833705.291 [NAL9602](INFO): SBD MO Status=2, MOMSN=896, MT Status=2, MTMSN=0 2026-02-11T18:15:05.291Z,1770833705.291 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:15:58.211Z,1770833758.211 [NAL9602](INFO): SBD MO Status=0, MOMSN=896, MT Status=0, MTMSN=0 2026-02-11T18:15:58.211Z,1770833758.211 [NAL9602](INFO): No messages in MT queue 2026-02-11T18:16:28.953Z,1770833788.953 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:19:45.292Z,1770833985.292 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:19:45.292Z,1770833985.292 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:19:45.292Z,1770833985.292 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:19:45.302Z,1770833985.302 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:19:45.700Z,1770833985.700 [Default:CheckIn:D] Stopped 2026-02-11T18:19:45.700Z,1770833985.700 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:19:46.108Z,1770833986.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.820024 min 2026-02-11T18:19:46.108Z,1770833986.108 [Default:CheckIn:E] Stopped 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn] Stopped 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn](INFO): Running loop #5 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn] Running Loop=5 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:19:46.109Z,1770833986.109 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:19:48.123Z,1770833988.123 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181949.00,A,3648.14612,N,12147.22536,W,0.641,207.99,110226,,,D*7D 2026-02-11T18:19:48.126Z,1770833988.126 [NAL9602](INFO): GPS fix at 20260211T181949: (36.802435, -121.787089) 2026-02-11T18:19:48.137Z,1770833988.137 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:19:48.137Z,1770833988.137 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:19:55.664Z,1770833995.664 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0015.lzma 2026-02-11T18:19:56.666Z,1770833996.666 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0015.lzma.bak 2026-02-11T18:19:56.666Z,1770833996.666 [DataOverHttps](INFO): SBD MOMSN=26649561 2026-02-11T18:20:05.100Z,1770834005.100 [NAL9602](INFO): SBD MO Status=0, MOMSN=897, MT Status=0, MTMSN=0 2026-02-11T18:20:05.100Z,1770834005.100 [NAL9602](INFO): No messages in MT queue 2026-02-11T18:20:15.602Z,1770834015.602 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20260211T180023/Express0016.lzma 2026-02-11T18:20:16.603Z,1770834016.603 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0016.lzma.bak 2026-02-11T18:20:16.604Z,1770834016.604 [DataOverHttps](INFO): SBD MOMSN=26649564 2026-02-11T18:20:17.781Z,1770834017.781 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:20:17.781Z,1770834017.781 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:20:17.781Z,1770834017.781 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:20:35.854Z,1770834035.854 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:25:18.269Z,1770834318.269 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:25:18.269Z,1770834318.269 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:25:18.269Z,1770834318.269 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:25:18.270Z,1770834318.270 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:25:18.667Z,1770834318.667 [Default:CheckIn:D] Stopped 2026-02-11T18:25:18.668Z,1770834318.668 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:25:19.077Z,1770834319.077 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.369480 min 2026-02-11T18:25:19.077Z,1770834319.077 [Default:CheckIn:E] Stopped 2026-02-11T18:25:19.077Z,1770834319.077 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:25:19.077Z,1770834319.077 [Default:CheckIn] Stopped 2026-02-11T18:25:19.078Z,1770834319.078 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:25:19.078Z,1770834319.078 [Default:CheckIn](INFO): Running loop #6 2026-02-11T18:25:19.078Z,1770834319.078 [Default:CheckIn] Running Loop=6 2026-02-11T18:25:19.078Z,1770834319.078 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:25:19.078Z,1770834319.078 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:25:21.138Z,1770834321.138 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182522.00,A,3648.17276,N,12147.28089,W,0.058,224.76,110226,,,D*7F 2026-02-11T18:25:21.146Z,1770834321.146 [NAL9602](INFO): GPS fix at 20260211T182522: (36.802879, -121.788015) 2026-02-11T18:25:21.157Z,1770834321.157 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:25:21.157Z,1770834321.157 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:25:28.476Z,1770834328.476 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0018.lzma 2026-02-11T18:25:29.479Z,1770834329.479 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0018.lzma.bak 2026-02-11T18:25:29.479Z,1770834329.479 [DataOverHttps](INFO): SBD MOMSN=26649586 2026-02-11T18:25:45.568Z,1770834345.568 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20260211T180023/Express0019.lzma 2026-02-11T18:25:46.571Z,1770834346.571 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0019.lzma.bak 2026-02-11T18:25:46.571Z,1770834346.571 [DataOverHttps](INFO): SBD MOMSN=26649589 2026-02-11T18:25:47.347Z,1770834347.347 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:25:47.347Z,1770834347.347 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:25:47.783Z,1770834347.783 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:25:47.783Z,1770834347.783 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:25:47.783Z,1770834347.783 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:26:15.219Z,1770834375.219 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:26:15.219Z,1770834375.219 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:26:28.147Z,1770834388.147 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:26:28.148Z,1770834388.148 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:28:11.979Z,1770834491.979 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:28:11.980Z,1770834491.980 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:29:35.651Z,1770834575.651 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:29:35.651Z,1770834575.651 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:30:23.322Z,1770834623.322 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-02-11T18:30:48.396Z,1770834648.396 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:30:48.396Z,1770834648.396 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:30:48.396Z,1770834648.396 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:30:48.397Z,1770834648.397 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:30:48.791Z,1770834648.791 [Default:CheckIn:D] Stopped 2026-02-11T18:30:48.791Z,1770834648.791 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.871533 min 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn:E] Stopped 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn] Stopped 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn](INFO): Running loop #7 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn] Running Loop=7 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:30:49.189Z,1770834649.189 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:30:51.196Z,1770834651.196 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183052.00,A,3648.17132,N,12147.27945,W,0.136,224.76,110226,,,A*75 2026-02-11T18:30:51.198Z,1770834651.198 [NAL9602](INFO): GPS fix at 20260211T183052: (36.802855, -121.787991) 2026-02-11T18:30:51.216Z,1770834651.216 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:30:51.217Z,1770834651.217 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:30:53.733Z,1770834653.733 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2026-02-11T18:31:23.118Z,1770834683.118 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:31:35.508Z,1770834695.508 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20260211T180023/Courier0021.lzma 2026-02-11T18:31:56.617Z,1770834716.617 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2026-02-11T18:32:04.092Z,1770834724.092 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20260211T180023/Courier0021.lzma 2026-02-11T18:32:05.094Z,1770834725.094 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0021.lzma.bak 2026-02-11T18:32:05.095Z,1770834725.095 [DataOverHttps](INFO): SBD MOMSN=26649609 2026-02-11T18:32:23.837Z,1770834743.837 [DataOverHttps](INFO): Sending 262 bytes from file Logs/20260211T180023/Express0022.lzma 2026-02-11T18:32:24.838Z,1770834744.838 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0022.lzma.bak 2026-02-11T18:32:24.839Z,1770834744.839 [DataOverHttps](INFO): SBD MOMSN=26649612 2026-02-11T18:32:26.197Z,1770834746.197 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:32:26.198Z,1770834746.198 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:32:26.198Z,1770834746.198 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:37:26.768Z,1770835046.768 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:37:26.768Z,1770835046.768 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:37:26.768Z,1770835046.768 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:37:26.793Z,1770835046.793 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:37:27.168Z,1770835047.168 [Default:CheckIn:D] Stopped 2026-02-11T18:37:27.168Z,1770835047.168 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:37:27.573Z,1770835047.573 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.511149 min 2026-02-11T18:37:27.573Z,1770835047.573 [Default:CheckIn:E] Stopped 2026-02-11T18:37:27.573Z,1770835047.573 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:37:27.574Z,1770835047.574 [Default:CheckIn] Stopped 2026-02-11T18:37:27.574Z,1770835047.574 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:37:27.574Z,1770835047.574 [Default:CheckIn](INFO): Running loop #8 2026-02-11T18:37:27.574Z,1770835047.574 [Default:CheckIn] Running Loop=8 2026-02-11T18:37:27.574Z,1770835047.574 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:37:27.574Z,1770835047.574 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:37:29.583Z,1770835049.583 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183731.00,A,3648.17509,N,12147.28015,W,0.214,155.29,110226,,,A*74 2026-02-11T18:37:29.595Z,1770835049.595 [NAL9602](INFO): GPS fix at 20260211T183731: (36.802918, -121.788003) 2026-02-11T18:37:29.607Z,1770835049.607 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:37:29.607Z,1770835049.607 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:37:37.060Z,1770835057.060 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0024.lzma 2026-02-11T18:37:38.062Z,1770835058.062 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0024.lzma.bak 2026-02-11T18:37:38.063Z,1770835058.063 [DataOverHttps](INFO): SBD MOMSN=26649629 2026-02-11T18:37:54.024Z,1770835074.024 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20260211T180023/Express0025.lzma 2026-02-11T18:37:55.026Z,1770835075.026 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0025.lzma.bak 2026-02-11T18:37:55.027Z,1770835075.027 [DataOverHttps](INFO): SBD MOMSN=26649632 2026-02-11T18:37:56.269Z,1770835076.269 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:37:56.269Z,1770835076.269 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:37:56.269Z,1770835076.269 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:38:00.286Z,1770835080.286 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-02-11T18:38:00.361Z,1770835080.361 [NAL9602](ERROR): received: +CSQ:0 OK8, 2, 0, 0, 0 OK 2026-02-11T18:38:29.378Z,1770835109.378 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2026-02-11T18:38:29.378Z,1770835109.378 [DropWeight] Hardware Fault, FailCount= 1 2026-02-11T18:38:29.378Z,1770835109.378 [DropWeight](ERROR): Hardware Fault 2026-02-11T18:38:29.470Z,1770835109.470 [CommandExec](FAULT): Scheduling is paused 2026-02-11T18:38:29.471Z,1770835109.471 [CBIT](INFO): Critical error at 20260211T183829 2026-02-11T18:38:29.488Z,1770835109.488 [CBIT](ERROR): Hardware Fault in component: DropWeight 2026-02-11T18:38:29.488Z,1770835109.488 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2026-02-11T18:38:29.824Z,1770835109.824 [CBIT](INFO): Critical error at 20260211T183829 2026-02-11T18:41:37.258Z,1770835297.258 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:41:37.258Z,1770835297.258 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:42:08.381Z,1770835328.381 [NAL9602](INFO): SBD MO Status=2, MOMSN=898, MT Status=2, MTMSN=0 2026-02-11T18:42:08.381Z,1770835328.381 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2026-02-11T18:42:32.215Z,1770835352.215 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-02-11T18:42:56.867Z,1770835376.867 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:42:56.867Z,1770835376.867 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:42:56.867Z,1770835376.867 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:42:56.867Z,1770835376.867 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:42:57.272Z,1770835377.272 [Default:CheckIn:D] Stopped 2026-02-11T18:42:57.272Z,1770835377.272 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:42:57.687Z,1770835377.687 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.012887 min 2026-02-11T18:42:57.687Z,1770835377.687 [Default:CheckIn:E] Stopped 2026-02-11T18:42:57.687Z,1770835377.687 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:42:57.687Z,1770835377.687 [Default:CheckIn] Stopped 2026-02-11T18:42:57.688Z,1770835377.688 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:42:57.688Z,1770835377.688 [Default:CheckIn](INFO): Running loop #9 2026-02-11T18:42:57.688Z,1770835377.688 [Default:CheckIn] Running Loop=9 2026-02-11T18:42:57.688Z,1770835377.688 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:42:57.688Z,1770835377.688 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:42:59.691Z,1770835379.691 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184301.00,A,3648.17512,N,12147.28124,W,0.097,103.35,110226,,,A*7A 2026-02-11T18:42:59.694Z,1770835379.694 [NAL9602](INFO): GPS fix at 20260211T184301: (36.802919, -121.788021) 2026-02-11T18:42:59.724Z,1770835379.724 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:42:59.724Z,1770835379.724 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:43:07.320Z,1770835387.320 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20260211T180023/Courier0027.lzma 2026-02-11T18:43:08.322Z,1770835388.322 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0027.lzma.bak 2026-02-11T18:43:08.323Z,1770835388.323 [DataOverHttps](INFO): SBD MOMSN=26649659 2026-02-11T18:43:24.321Z,1770835404.321 [DataOverHttps](INFO): Sending 264 bytes from file Logs/20260211T180023/Express0028.lzma 2026-02-11T18:43:25.322Z,1770835405.322 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0028.lzma.bak 2026-02-11T18:43:25.323Z,1770835405.323 [DataOverHttps](INFO): SBD MOMSN=26649667 2026-02-11T18:43:26.772Z,1770835406.772 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:43:26.772Z,1770835406.772 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:43:26.772Z,1770835406.772 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:43:32.408Z,1770835412.408 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:48:08.752Z,1770835688.752 [BPC1](INFO): Calculating totals. Valid battery stick count: 43. Valid reserve battery stick count: 5. 2026-02-11T18:48:08.767Z,1770835688.767 [BPC1](FAULT): Failed to receive data from 12 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 48, 50, 51, 52, 54, 56, 57, 58, 59, 60, 61, 62. 2026-02-11T18:48:27.347Z,1770835707.347 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:48:27.347Z,1770835707.347 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:48:27.347Z,1770835707.347 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:48:27.348Z,1770835707.348 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:48:27.752Z,1770835707.752 [Default:CheckIn:D] Stopped 2026-02-11T18:48:27.752Z,1770835707.752 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.520886 min 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn:E] Stopped 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn] Stopped 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn](INFO): Running loop #10 2026-02-11T18:48:28.172Z,1770835708.172 [Default:CheckIn] Running Loop=10 2026-02-11T18:48:28.173Z,1770835708.173 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:48:28.173Z,1770835708.173 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:48:30.168Z,1770835710.168 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184831.00,A,3648.17896,N,12147.27942,W,0.311,141.25,110226,,,A*7E 2026-02-11T18:48:30.170Z,1770835710.170 [NAL9602](INFO): GPS fix at 20260211T184831: (36.802983, -121.787990) 2026-02-11T18:48:30.186Z,1770835710.186 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:48:30.186Z,1770835710.186 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:48:37.708Z,1770835717.708 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20260211T180023/Courier0030.lzma 2026-02-11T18:48:38.710Z,1770835718.710 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0030.lzma.bak 2026-02-11T18:48:38.711Z,1770835718.711 [DataOverHttps](INFO): SBD MOMSN=26649682 2026-02-11T18:48:54.797Z,1770835734.797 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20260211T180023/Express0031.lzma 2026-02-11T18:48:55.799Z,1770835735.799 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0031.lzma.bak 2026-02-11T18:48:55.799Z,1770835735.799 [DataOverHttps](INFO): SBD MOMSN=26649687 2026-02-11T18:48:57.253Z,1770835737.253 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:48:57.253Z,1770835737.253 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:48:57.253Z,1770835737.253 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:49:00.874Z,1770835740.874 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-02-11T18:49:00.953Z,1770835740.953 [NAL9602](ERROR): received: +CSQ:0 OK8, 2, 0, 0, 0 OK 2026-02-11T18:50:46.731Z,1770835846.731 [NAL9602](INFO): SBD MO Status=0, MOMSN=898, MT Status=0, MTMSN=0 2026-02-11T18:50:46.731Z,1770835846.731 [NAL9602](INFO): No messages in MT queue 2026-02-11T18:51:17.437Z,1770835877.437 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:53:29.585Z,1770836009.585 [CBIT](INFO): Clearing failed state for component DropWeight 2026-02-11T18:53:29.585Z,1770836009.585 [DropWeight] No Fault, FailCount= 1 2026-02-11T18:53:57.832Z,1770836037.832 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:53:57.833Z,1770836037.833 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:53:57.833Z,1770836037.833 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:53:57.833Z,1770836037.833 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:53:58.245Z,1770836038.245 [Default:CheckIn:D] Stopped 2026-02-11T18:53:58.245Z,1770836038.245 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:53:58.640Z,1770836038.640 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 59.029097 min 2026-02-11T18:53:58.640Z,1770836038.640 [Default:CheckIn:E] Stopped 2026-02-11T18:53:58.640Z,1770836038.640 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:53:58.640Z,1770836038.640 [Default:CheckIn] Stopped 2026-02-11T18:53:58.640Z,1770836038.640 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:53:58.640Z,1770836038.640 [Default:CheckIn](INFO): Running loop #11 2026-02-11T18:53:58.641Z,1770836038.641 [Default:CheckIn] Running Loop=11 2026-02-11T18:53:58.641Z,1770836038.641 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:53:58.641Z,1770836038.641 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:54:00.655Z,1770836040.655 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185402.00,A,3648.17374,N,12147.28015,W,0.058,167.04,110226,,,A*79 2026-02-11T18:54:00.658Z,1770836040.658 [NAL9602](INFO): GPS fix at 20260211T185402: (36.802896, -121.788003) 2026-02-11T18:54:00.668Z,1770836040.668 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:54:00.669Z,1770836040.669 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:54:09.592Z,1770836049.592 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0033.lzma 2026-02-11T18:54:15.639Z,1770836055.639 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0033.lzma.bak 2026-02-11T18:54:15.639Z,1770836055.639 [DataOverHttps](INFO): SBD MOMSN=26649725 2026-02-11T18:54:31.677Z,1770836071.677 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20260211T180023/Express0034.lzma 2026-02-11T18:54:32.678Z,1770836072.678 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0034.lzma.bak 2026-02-11T18:54:32.679Z,1770836072.679 [DataOverHttps](INFO): SBD MOMSN=26649728 2026-02-11T18:54:33.812Z,1770836073.812 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T18:54:33.812Z,1770836073.812 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T18:54:33.812Z,1770836073.812 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T18:59:03.405Z,1770836343.405 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-02-11T18:59:34.114Z,1770836374.114 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T18:59:34.549Z,1770836374.549 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T18:59:34.549Z,1770836374.549 [Default:CheckIn:C.Wait] Stopped 2026-02-11T18:59:34.549Z,1770836374.549 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T18:59:34.550Z,1770836374.550 [Default:CheckIn:D] Running Loop=1 2026-02-11T18:59:34.941Z,1770836374.941 [Default:CheckIn:D] Stopped 2026-02-11T18:59:34.941Z,1770836374.941 [Default:CheckIn:E] Running Loop=1 2026-02-11T18:59:35.336Z,1770836375.336 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.640710 min 2026-02-11T18:59:35.336Z,1770836375.336 [Default:CheckIn:E] Stopped 2026-02-11T18:59:35.336Z,1770836375.336 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T18:59:35.336Z,1770836375.336 [Default:CheckIn] Stopped 2026-02-11T18:59:35.357Z,1770836375.357 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T18:59:35.357Z,1770836375.357 [Default:CheckIn](INFO): Running loop #12 2026-02-11T18:59:35.357Z,1770836375.357 [Default:CheckIn] Running Loop=12 2026-02-11T18:59:35.357Z,1770836375.357 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T18:59:35.357Z,1770836375.357 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T18:59:37.343Z,1770836377.343 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185938.00,A,3648.17872,N,12147.27541,W,0.272,71.56,110226,,,A*40 2026-02-11T18:59:37.346Z,1770836377.346 [NAL9602](INFO): GPS fix at 20260211T185938: (36.802979, -121.787924) 2026-02-11T18:59:37.359Z,1770836377.359 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T18:59:37.359Z,1770836377.359 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T18:59:45.044Z,1770836385.044 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0036.lzma 2026-02-11T18:59:46.046Z,1770836386.046 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0036.lzma.bak 2026-02-11T18:59:46.047Z,1770836386.047 [DataOverHttps](INFO): SBD MOMSN=26649755 2026-02-11T19:00:02.093Z,1770836402.093 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20260211T180023/Express0037.lzma 2026-02-11T19:00:03.095Z,1770836403.095 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0037.lzma.bak 2026-02-11T19:00:03.095Z,1770836403.095 [DataOverHttps](INFO): SBD MOMSN=26649761 2026-02-11T19:00:04.435Z,1770836404.435 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T19:00:04.435Z,1770836404.435 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T19:00:04.435Z,1770836404.435 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T19:00:08.078Z,1770836408.078 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-02-11T19:00:08.161Z,1770836408.161 [NAL9602](ERROR): received: +CSQ:0 OK8, 0, 0, 0, 0 OK 2026-02-11T19:04:39.281Z,1770836679.281 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-02-11T19:05:05.152Z,1770836705.152 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T19:05:05.152Z,1770836705.152 [Default:CheckIn:C.Wait] Stopped 2026-02-11T19:05:05.152Z,1770836705.152 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T19:05:05.169Z,1770836705.169 [Default:CheckIn:D] Running Loop=1 2026-02-11T19:05:05.556Z,1770836705.556 [Default:CheckIn:D] Stopped 2026-02-11T19:05:05.558Z,1770836705.558 [Default:CheckIn:E] Running Loop=1 2026-02-11T19:05:05.962Z,1770836705.962 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 70.150960 min 2026-02-11T19:05:05.962Z,1770836705.962 [Default:CheckIn:E] Stopped 2026-02-11T19:05:05.962Z,1770836705.962 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T19:05:05.962Z,1770836705.962 [Default:CheckIn] Stopped 2026-02-11T19:05:05.962Z,1770836705.962 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T19:05:05.963Z,1770836705.963 [Default:CheckIn](INFO): Running loop #13 2026-02-11T19:05:05.963Z,1770836705.963 [Default:CheckIn] Running Loop=13 2026-02-11T19:05:05.963Z,1770836705.963 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T19:05:05.963Z,1770836705.963 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T19:05:07.991Z,1770836707.991 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190509.00,A,3648.15573,N,12147.30933,W,2.060,185.62,110226,,,A*75 2026-02-11T19:05:07.994Z,1770836707.994 [NAL9602](INFO): GPS fix at 20260211T190509: (36.802596, -121.788489) 2026-02-11T19:05:08.004Z,1770836708.004 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T19:05:08.004Z,1770836708.004 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T19:05:14.924Z,1770836714.924 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20260211T180023/Courier0039.lzma 2026-02-11T19:05:15.926Z,1770836715.926 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0039.lzma.bak 2026-02-11T19:05:15.927Z,1770836715.927 [DataOverHttps](INFO): SBD MOMSN=26649803 2026-02-11T19:05:31.717Z,1770836731.717 [DataOverHttps](INFO): Sending 254 bytes from file Logs/20260211T180023/Express0040.lzma 2026-02-11T19:05:32.719Z,1770836732.719 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0040.lzma.bak 2026-02-11T19:05:32.719Z,1770836732.719 [DataOverHttps](INFO): SBD MOMSN=26649806 2026-02-11T19:05:33.838Z,1770836733.838 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T19:05:33.838Z,1770836733.838 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T19:05:33.838Z,1770836733.838 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T19:05:40.290Z,1770836740.290 [NAL9602](INFO): Not Powering down - fast GPS 2026-02-11T19:10:34.560Z,1770837034.560 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2026-02-11T19:10:34.561Z,1770837034.561 [Default:CheckIn:C.Wait] Stopped 2026-02-11T19:10:34.561Z,1770837034.561 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T19:10:34.561Z,1770837034.561 [Default:CheckIn:D] Running Loop=1 2026-02-11T19:10:34.974Z,1770837034.974 [Default:CheckIn:D] Stopped 2026-02-11T19:10:34.974Z,1770837034.974 [Default:CheckIn:E] Running Loop=1 2026-02-11T19:10:35.365Z,1770837035.365 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 75.641260 min 2026-02-11T19:10:35.365Z,1770837035.365 [Default:CheckIn:E] Stopped 2026-02-11T19:10:35.365Z,1770837035.365 [Default:CheckIn](INFO): Completed Default:CheckIn 2026-02-11T19:10:35.365Z,1770837035.365 [Default:CheckIn] Stopped 2026-02-11T19:10:35.365Z,1770837035.365 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T19:10:35.366Z,1770837035.366 [Default:CheckIn](INFO): Running loop #14 2026-02-11T19:10:35.366Z,1770837035.366 [Default:CheckIn] Running Loop=14 2026-02-11T19:10:35.366Z,1770837035.366 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2026-02-11T19:10:35.366Z,1770837035.366 [Default:CheckIn:Read_GPS] Running Loop=1 2026-02-11T19:10:37.379Z,1770837037.379 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191038.00,A,3648.16738,N,12147.27961,W,1.866,219.12,110226,,,A*70 2026-02-11T19:10:37.382Z,1770837037.382 [NAL9602](INFO): GPS fix at 20260211T191038: (36.802790, -121.787993) 2026-02-11T19:10:37.393Z,1770837037.393 [Default:CheckIn:Read_GPS] Stopped 2026-02-11T19:10:37.393Z,1770837037.393 [Default:CheckIn:Read_Iridium] Running Loop=1 2026-02-11T19:10:44.924Z,1770837044.924 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20260211T180023/Courier0042.lzma 2026-02-11T19:10:45.926Z,1770837045.926 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Courier0042.lzma.bak 2026-02-11T19:10:45.927Z,1770837045.927 [DataOverHttps](INFO): SBD MOMSN=26649818 2026-02-11T19:11:01.940Z,1770837061.940 [DataOverHttps](INFO): Sending 170 bytes from file Logs/20260211T180023/Express0043.lzma 2026-02-11T19:11:02.942Z,1770837062.942 [DataOverHttps](INFO): Moved sent file to Logs/20260211T180023/Express0043.lzma.bak 2026-02-11T19:11:02.943Z,1770837062.943 [DataOverHttps](INFO): SBD MOMSN=26649821 2026-02-11T19:11:04.470Z,1770837064.470 [Default:CheckIn:Read_Iridium] Stopped 2026-02-11T19:11:04.470Z,1770837064.470 [Default:CheckIn:C.Wait] Running Loop=1 2026-02-11T19:11:04.470Z,1770837064.470 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2026-02-11T19:11:08.079Z,1770837068.079 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2026-02-11T19:11:08.153Z,1770837068.153 [NAL9602](ERROR): received: +CSQ:0 OK8, 0, 0, 0, 0 OK 2026-02-11T19:15:40.046Z,1770837340.046 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2026-02-11T19:15:43.169Z,1770837343.169 [CommandExec](IMPORTANT): got command quit 2026-02-11T19:15:44.173Z,1770837344.173 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:44.173Z,1770837344.173 [CommandExec](INFO): Uninitializing the command executive. 2026-02-11T19:15:44.173Z,1770837344.173 [CommandExec](INFO): Uninitializing the command scheduler. 2026-02-11T19:15:44.173Z,1770837344.173 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:44.277Z,1770837344.277 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2026-02-11T19:15:44.277Z,1770837344.277 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2026-02-11T19:15:44.277Z,1770837344.277 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:44.278Z,1770837344.278 [NavChartDb](INFO): Join timeout helper Thread ID is 2442 2026-02-11T19:15:44.289Z,1770837344.289 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:44.289Z,1770837344.289 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:44.305Z,1770837344.305 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2026-02-11T19:15:44.305Z,1770837344.305 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:44.305Z,1770837344.305 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2443 2026-02-11T19:15:44.665Z,1770837344.665 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:44.665Z,1770837344.665 [WetLabsBB2FL](INFO): Powering down 2026-02-11T19:15:44.666Z,1770837344.666 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:44.677Z,1770837344.677 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2026-02-11T19:15:44.677Z,1770837344.677 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:44.677Z,1770837344.677 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2444 2026-02-11T19:15:45.097Z,1770837345.097 [CTD_Seabird](INFO): Powering down 2026-02-11T19:15:45.109Z,1770837345.109 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:45.109Z,1770837345.109 [CTD_Seabird](INFO): Powering down 2026-02-11T19:15:45.122Z,1770837345.122 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:45.129Z,1770837345.129 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2026-02-11T19:15:45.129Z,1770837345.129 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:45.129Z,1770837345.129 [Radio_Surface](INFO): Join timeout helper Thread ID is 2445 2026-02-11T19:15:45.409Z,1770837345.409 [Radio_Surface](INFO): Powering down 2026-02-11T19:15:45.410Z,1770837345.410 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:45.410Z,1770837345.410 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:45.421Z,1770837345.421 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2026-02-11T19:15:45.421Z,1770837345.421 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:45.421Z,1770837345.421 [Onboard](INFO): Join timeout helper Thread ID is 2446 2026-02-11T19:15:48.545Z,1770837348.545 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:48.545Z,1770837348.545 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:48.547Z,1770837348.547 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2026-02-11T19:15:48.547Z,1770837348.547 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:48.547Z,1770837348.547 [DataOverHttps](INFO): Join timeout helper Thread ID is 2447 2026-02-11T19:15:49.457Z,1770837349.457 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:49.460Z,1770837349.460 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.461Z,1770837349.461 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2026-02-11T19:15:49.461Z,1770837349.461 [DAT ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.462Z,1770837349.462 [DAT](INFO): Join timeout helper Thread ID is 2448 2026-02-11T19:15:49.521Z,1770837349.521 [DAT](INFO): Powering down 2026-02-11T19:15:49.593Z,1770837349.593 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:49.593Z,1770837349.593 [DAT](INFO): Powering down 2026-02-11T19:15:49.594Z,1770837349.594 [DAT ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.601Z,1770837349.601 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2026-02-11T19:15:49.601Z,1770837349.601 [logger ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.602Z,1770837349.602 [logger](INFO): Join timeout helper Thread ID is 2449 2026-02-11T19:15:49.629Z,1770837349.629 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:49.629Z,1770837349.629 [logger ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.641Z,1770837349.641 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2026-02-11T19:15:49.641Z,1770837349.641 [CommandLine ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.642Z,1770837349.642 [CommandLine](INFO): Join timeout helper Thread ID is 2450 2026-02-11T19:15:49.697Z,1770837349.697 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:49.697Z,1770837349.697 [CommandLine ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.702Z,1770837349.702 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2026-02-11T19:15:49.702Z,1770837349.702 [CommandExec ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.702Z,1770837349.702 [CommandExec](INFO): Join timeout helper Thread ID is 2451 2026-02-11T19:15:49.703Z,1770837349.703 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2026-02-11T19:15:49.703Z,1770837349.703 [controlThread ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:49.704Z,1770837349.704 [controlThread](INFO): Join timeout helper Thread ID is 2452 2026-02-11T19:15:49.709Z,1770837349.709 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2026-02-11T19:15:49.709Z,1770837349.709 [controlThread](DEBUG): Uninitializing ControlThread 2026-02-11T19:15:49.710Z,1770837349.710 [AHRS_M2](INFO): Powering down 2026-02-11T19:15:49.789Z,1770837349.789 [NAL9602](INFO): Powering down 2026-02-11T19:15:49.790Z,1770837349.790 [Sonardyne_Nano](INFO): Powering down 2026-02-11T19:15:49.997Z,1770837349.997 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2026-02-11T19:15:49.998Z,1770837349.998 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2026-02-11T19:15:49.998Z,1770837349.998 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2026-02-11T19:15:49.999Z,1770837349.999 [MissionManager](INFO): Uninitializing Mission Default 2026-02-11T19:15:49.999Z,1770837349.999 [Default] Stopped 2026-02-11T19:15:49.999Z,1770837349.999 [Default](DEBUG): Aggregate::uninitialize Default 2026-02-11T19:15:49.999Z,1770837349.999 [Default:B.GoToSurface] Stopped 2026-02-11T19:15:49.999Z,1770837349.999 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2026-02-11T19:15:49.999Z,1770837349.999 [Default:CheckIn] Stopped 2026-02-11T19:15:49.999Z,1770837349.999 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2026-02-11T19:15:49.999Z,1770837349.999 [Default:CheckIn:C.Wait] Stopped 2026-02-11T19:15:49.999Z,1770837349.999 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2026-02-11T19:15:50.002Z,1770837350.002 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2026-02-11T19:15:50.003Z,1770837350.003 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2026-02-11T19:15:50.003Z,1770837350.003 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2026-02-11T19:15:50.003Z,1770837350.003 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2026-02-11T19:15:50.004Z,1770837350.004 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2026-02-11T19:15:50.004Z,1770837350.004 [BuoyancyServo](INFO): Powering down 2026-02-11T19:15:50.017Z,1770837350.017 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2026-02-11T19:15:50.017Z,1770837350.017 [ElevatorServo](INFO): Powering down 2026-02-11T19:15:50.018Z,1770837350.018 [MassServo](DEBUG): Uninitialize Mass Servo. 2026-02-11T19:15:50.018Z,1770837350.018 [MassServo](INFO): Powering down 2026-02-11T19:15:50.019Z,1770837350.019 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2026-02-11T19:15:50.019Z,1770837350.019 [RudderServo](INFO): Powering down 2026-02-11T19:15:50.019Z,1770837350.019 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2026-02-11T19:15:50.020Z,1770837350.020 [ThrusterHE](INFO): Powering down 2026-02-11T19:15:50.020Z,1770837350.020 [SBIT](DEBUG): Uninitialize SBIT Component. 2026-02-11T19:15:50.021Z,1770837350.021 [IBIT](DEBUG): Uninitialize IBIT Component. 2026-02-11T19:15:50.021Z,1770837350.021 [CBIT](DEBUG): Uninitialize CBIT Component. 2026-02-11T19:15:50.021Z,1770837350.021 [CBIT](DEBUG): Powering off loads. 2026-02-11T19:15:50.032Z,1770837350.032 [CBIT](DEBUG): Disabling WDT. 2026-02-11T19:15:50.045Z,1770837350.045 [GFScanner](DEBUG): Uninitialize GFScanner component. 2026-02-11T19:15:50.045Z,1770837350.045 [GFScanner](DEBUG): Opening all GF detection circuits. 2026-02-11T19:15:50.046Z,1770837350.046 [controlThread ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.107Z,1770837350.107 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.110Z,1770837350.110 [Onboard ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.116Z,1770837350.116 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.122Z,1770837350.122 [DAT ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.199Z,1770837350.199 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.203Z,1770837350.203 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.286Z,1770837350.286 [GFScanner](DEBUG): Uninitialize GFScanner component. 2026-02-11T19:15:50.286Z,1770837350.286 [GFScanner](DEBUG): Opening all GF detection circuits. 2026-02-11T19:15:50.326Z,1770837350.326 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2026-02-11T19:15:50.440Z,1770837350.440 [logger ThreadHandler](INFO): Thread cancelled.