2025-07-10T17:53:00.904Z,1752169980.904 [CommandExec](IMPORTANT): got command restart logs 2025-07-10T17:53:05.716Z,1752169985.716 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T17:53:11.879Z,1752169991.879 [DataOverHttps](INFO): Moved sent file to Logs/20250710T060057/Express0058.lzma.bak 2025-07-10T17:53:11.879Z,1752169991.879 [DataOverHttps](INFO): SBD MOMSN=25473132 2025-07-10T17:53:20.267Z,1752170000.267 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T17:53:21.877Z,1752170001.877 [BPC1](ERROR): Battery stick #16 (s/n: 00F8) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T17:53:21.878Z,1752170001.878 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T17:53:21.879Z,1752170001.879 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-07-10T17:53:21.880Z,1752170001.880 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T17:53:21.880Z,1752170001.880 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T17:53:21.881Z,1752170001.881 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T17:53:21.882Z,1752170001.882 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AC0. 2025-07-10T17:53:21.882Z,1752170001.882 [BPC1](INFO): Calculating totals. Valid battery stick count: 41. Valid reserve battery stick count: 4. 2025-07-10T17:53:21.888Z,1752170001.888 [BPC1](FAULT): Failed to receive data from 14 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 9, 10, 11, 12, 14, 16, 24, 29, 35, 51, 52, 53, 57, 59. 2025-07-10T17:53:37.944Z,1752170017.944 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250710T060057/Courier0060.lzma 2025-07-10T17:53:48.987Z,1752170028.987 [DataOverHttps](INFO): Moved sent file to Logs/20250710T060057/Courier0060.lzma.bak 2025-07-10T17:53:48.987Z,1752170028.987 [DataOverHttps](INFO): SBD MOMSN=25473256 2025-07-10T17:54:14.877Z,1752170054.877 [DataOverHttps](INFO): Sending 110 bytes from file Logs/20250710T060057/Express0061.lzma 2025-07-10T17:54:25.919Z,1752170065.919 [DataOverHttps](INFO): Moved sent file to Logs/20250710T060057/Express0061.lzma.bak 2025-07-10T17:54:25.919Z,1752170065.919 [DataOverHttps](INFO): SBD MOMSN=25473264 2025-07-10T17:54:27.340Z,1752170067.340 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T17:54:27.340Z,1752170067.340 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T17:54:27.340Z,1752170067.340 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T17:59:27.923Z,1752170367.923 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T17:59:27.923Z,1752170367.923 [Default:CheckIn:C.Wait] Stopped 2025-07-10T17:59:27.923Z,1752170367.923 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T17:59:27.924Z,1752170367.924 [Default:CheckIn:D] Running Loop=1 2025-07-10T17:59:28.316Z,1752170368.316 [Default:CheckIn:D] Stopped 2025-07-10T17:59:28.316Z,1752170368.316 [Default:CheckIn:E] Running Loop=1 2025-07-10T17:59:28.725Z,1752170368.725 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.265690 min 2025-07-10T17:59:28.725Z,1752170368.725 [Default:CheckIn:E] Stopped 2025-07-10T17:59:28.725Z,1752170368.725 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T17:59:28.726Z,1752170368.726 [Default:CheckIn] Stopped 2025-07-10T17:59:28.726Z,1752170368.726 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T17:59:28.726Z,1752170368.726 [Default:CheckIn](INFO): Running loop #9 2025-07-10T17:59:28.726Z,1752170368.726 [Default:CheckIn] Running Loop=9 2025-07-10T17:59:28.726Z,1752170368.726 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T17:59:28.726Z,1752170368.726 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T17:59:30.737Z,1752170370.737 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175929.00,A,3647.69746,N,12152.96343,W,15.104,274.82,100725,,,D*41 2025-07-10T17:59:30.739Z,1752170370.739 [NAL9602](INFO): GPS fix at 20250710T175929: (36.794958, -121.882724) 2025-07-10T17:59:30.750Z,1752170370.750 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T17:59:30.750Z,1752170370.750 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T17:59:38.281Z,1752170378.281 [DataOverHttps](INFO): Sending 308 bytes from file Logs/20250710T175300/Courier0003.lzma 2025-07-10T17:59:49.335Z,1752170389.335 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0003.lzma.bak 2025-07-10T17:59:49.335Z,1752170389.335 [DataOverHttps](INFO): SBD MOMSN=25473288 2025-07-10T17:59:51.743Z,1752170391.743 [NAL9602](INFO): SBD MO Status=0, MOMSN=25739, MT Status=0, MTMSN=0 2025-07-10T17:59:51.744Z,1752170391.744 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:00:15.304Z,1752170415.304 [DataOverHttps](INFO): Sending 629 bytes from file Logs/20250710T175300/Express0004.lzma 2025-07-10T18:00:22.442Z,1752170422.442 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:00:39.393Z,1752170439.393 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:00:48.330Z,1752170448.330 [DataOverHttps](INFO): Sending 629 bytes from file Logs/20250710T175300/Express0004.lzma 2025-07-10T18:00:59.375Z,1752170459.375 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0004.lzma.bak 2025-07-10T18:00:59.375Z,1752170459.375 [DataOverHttps](INFO): SBD MOMSN=25473293 2025-07-10T18:01:00.843Z,1752170460.843 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:01:00.843Z,1752170460.843 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:01:00.843Z,1752170460.843 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:03:33.213Z,1752170613.213 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:04:04.338Z,1752170644.338 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:04:35.461Z,1752170675.461 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:05:06.585Z,1752170706.585 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:05:37.709Z,1752170737.709 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:05:45.644Z,1752170745.644 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:05:53.774Z,1752170753.774 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.186981 2025-07-10T18:06:00.998Z,1752170760.998 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:06:01.438Z,1752170761.438 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:06:01.438Z,1752170761.438 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:06:01.438Z,1752170761.438 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:06:01.438Z,1752170761.438 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:06:01.856Z,1752170761.856 [Default:CheckIn:D] Stopped 2025-07-10T18:06:01.856Z,1752170761.856 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.824683 min 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn:E] Stopped 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn] Stopped 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn](INFO): Running loop #10 2025-07-10T18:06:02.229Z,1752170762.229 [Default:CheckIn] Running Loop=10 2025-07-10T18:06:02.230Z,1752170762.230 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:06:02.230Z,1752170762.230 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:06:04.244Z,1752170764.244 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180603.00,A,3647.64662,N,12153.13775,W,1.050,89.43,100725,,,A*46 2025-07-10T18:06:04.246Z,1752170764.246 [NAL9602](INFO): GPS fix at 20250710T180603: (36.794110, -121.885629) 2025-07-10T18:06:04.257Z,1752170764.257 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:06:04.257Z,1752170764.257 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:06:15.957Z,1752170775.957 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:06:31.033Z,1752170791.033 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:06:38.953Z,1752170798.953 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:06:42.748Z,1752170802.748 [NAL9602](INFO): SBD MO Status=2, MOMSN=25740, MT Status=2, MTMSN=0 2025-07-10T18:06:42.749Z,1752170802.749 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T18:06:45.989Z,1752170805.989 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:06:59.019Z,1752170819.019 [NAL9602](INFO): SBD MO Status=2, MOMSN=25740, MT Status=2, MTMSN=0 2025-07-10T18:06:59.019Z,1752170819.019 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T18:07:00.971Z,1752170820.971 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:07:10.081Z,1752170830.081 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:07:16.360Z,1752170836.360 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:07:27.676Z,1752170847.676 [NAL9602](INFO): SBD MO Status=2, MOMSN=25740, MT Status=2, MTMSN=0 2025-07-10T18:07:27.677Z,1752170847.677 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T18:07:31.712Z,1752170851.712 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:07:41.209Z,1752170861.209 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:07:46.700Z,1752170866.700 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:07:53.591Z,1752170873.591 [NAL9602](INFO): SBD MO Status=2, MOMSN=25740, MT Status=2, MTMSN=0 2025-07-10T18:07:53.591Z,1752170873.591 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T18:08:12.333Z,1752170892.333 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:08:20.312Z,1752170900.312 [NAL9602](INFO): SBD MO Status=1, MOMSN=25740, MT Status=0, MTMSN=0 2025-07-10T18:08:20.361Z,1752170900.361 [NAL9602](INFO): Sent 72 bytes from file Logs/20250710T175300/Courier0006.lzma 2025-07-10T18:08:20.361Z,1752170900.361 [NAL9602](INFO): Packets left to send: 0 2025-07-10T18:08:38.124Z,1752170918.124 [NAL9602](INFO): SBD MO Status=1, MOMSN=25741, MT Status=0, MTMSN=0 2025-07-10T18:08:38.177Z,1752170918.177 [NAL9602](INFO): Sent 174 bytes from file Logs/20250710T175300/Express0007.lzma 2025-07-10T18:08:38.177Z,1752170918.177 [NAL9602](INFO): Packets left to send: 0 2025-07-10T18:08:43.457Z,1752170923.457 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:08:46.204Z,1752170926.204 [NAL9602](INFO): SBD MO Status=0, MOMSN=25742, MT Status=0, MTMSN=0 2025-07-10T18:08:46.287Z,1752170926.287 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:08:46.287Z,1752170926.287 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:08:46.287Z,1752170926.287 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:09:14.589Z,1752170954.589 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:09:16.902Z,1752170956.902 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:09:45.721Z,1752170985.721 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:10:16.862Z,1752171016.862 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:10:23.962Z,1752171023.962 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:10:37.696Z,1752171037.696 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:10:47.985Z,1752171047.985 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:10:51.438Z,1752171051.438 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:11:05.572Z,1752171065.572 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:11:19.109Z,1752171079.109 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:11:19.778Z,1752171079.778 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:11:33.452Z,1752171093.452 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2025-07-10T18:11:33.458Z,1752171093.458 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:11:47.192Z,1752171107.192 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:11:50.257Z,1752171110.257 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:12:00.933Z,1752171120.933 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:12:14.669Z,1752171134.669 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:12:22.777Z,1752171142.777 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:12:28.001Z,1752171148.001 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:12:40.924Z,1752171160.924 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:12:47.338Z,1752171167.338 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003523 2025-07-10T18:13:46.789Z,1752171226.789 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:13:46.789Z,1752171226.789 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:13:46.790Z,1752171226.790 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:13:46.790Z,1752171226.790 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:13:47.193Z,1752171227.193 [Default:CheckIn:D] Stopped 2025-07-10T18:13:47.193Z,1752171227.193 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:13:47.599Z,1752171227.599 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 65.580306 min 2025-07-10T18:13:47.599Z,1752171227.599 [Default:CheckIn:E] Stopped 2025-07-10T18:13:47.599Z,1752171227.599 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:13:47.599Z,1752171227.599 [Default:CheckIn] Stopped 2025-07-10T18:13:47.599Z,1752171227.599 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:13:47.599Z,1752171227.599 [Default:CheckIn](INFO): Running loop #11 2025-07-10T18:13:47.600Z,1752171227.600 [Default:CheckIn] Running Loop=11 2025-07-10T18:13:47.600Z,1752171227.600 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:13:47.600Z,1752171227.600 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:13:49.618Z,1752171229.618 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181348.00,A,3647.65591,N,12153.02360,W,0.836,87.13,100725,,,D*44 2025-07-10T18:13:49.621Z,1752171229.621 [NAL9602](INFO): GPS fix at 20250710T181348: (36.794265, -121.883727) 2025-07-10T18:13:49.632Z,1752171229.632 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:13:49.632Z,1752171229.632 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:13:57.653Z,1752171237.653 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20250710T175300/Courier0009.lzma 2025-07-10T18:14:03.748Z,1752171243.748 [NAL9602](INFO): SBD MO Status=0, MOMSN=25743, MT Status=0, MTMSN=0 2025-07-10T18:14:03.748Z,1752171243.748 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:14:14.720Z,1752171254.720 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0009.lzma.bak 2025-07-10T18:14:14.720Z,1752171254.720 [DataOverHttps](INFO): SBD MOMSN=25473500 2025-07-10T18:14:34.452Z,1752171274.452 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:14:51.925Z,1752171291.925 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250710T175300/Express0010.lzma 2025-07-10T18:15:02.967Z,1752171302.967 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0010.lzma.bak 2025-07-10T18:15:02.967Z,1752171302.967 [DataOverHttps](INFO): SBD MOMSN=25473645 2025-07-10T18:15:04.119Z,1752171304.119 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:15:04.119Z,1752171304.119 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:15:04.119Z,1752171304.119 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:15:04.384Z,1752171304.384 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:15:11.256Z,1752171311.256 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:15:26.206Z,1752171326.206 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:15:32.272Z,1752171332.272 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2025-07-10T18:15:34.549Z,1752171334.549 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:15:41.556Z,1752171341.556 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:15:56.504Z,1752171356.504 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:16:11.858Z,1752171371.858 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:16:26.817Z,1752171386.817 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:16:36.893Z,1752171396.893 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:16:42.161Z,1752171402.161 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:16:57.918Z,1752171417.918 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:17:13.268Z,1752171433.268 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:19:41.829Z,1752171581.829 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:19:49.621Z,1752171589.621 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:20:03.761Z,1752171603.761 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:20:04.582Z,1752171604.582 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:20:04.583Z,1752171604.583 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:20:04.583Z,1752171604.583 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:20:04.583Z,1752171604.583 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:20:05.007Z,1752171605.007 [Default:CheckIn:D] Stopped 2025-07-10T18:20:05.007Z,1752171605.007 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.877205 min 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn:E] Stopped 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn] Stopped 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn](INFO): Running loop #12 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn] Running Loop=12 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:20:05.390Z,1752171605.390 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:20:07.457Z,1752171607.457 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182006.00,A,3648.13887,N,12150.44797,W,26.883,74.96,100725,,,D*7C 2025-07-10T18:20:07.459Z,1752171607.459 [NAL9602](INFO): GPS fix at 20250710T182006: (36.802315, -121.840800) 2025-07-10T18:20:07.470Z,1752171607.470 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:20:07.470Z,1752171607.470 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:20:14.968Z,1752171614.968 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0012.lzma 2025-07-10T18:20:17.498Z,1752171617.498 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:20:17.508Z,1752171617.508 [NAL9602](INFO): SBD MO Status=0, MOMSN=25744, MT Status=0, MTMSN=0 2025-07-10T18:20:17.508Z,1752171617.508 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:20:26.011Z,1752171626.011 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0012.lzma.bak 2025-07-10T18:20:26.011Z,1752171626.011 [DataOverHttps](INFO): SBD MOMSN=25473669 2025-07-10T18:20:30.828Z,1752171630.828 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:20:44.565Z,1752171644.565 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:20:48.222Z,1752171648.222 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:20:55.193Z,1752171655.193 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20250710T175300/Express0013.lzma 2025-07-10T18:20:58.362Z,1752171658.362 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:21:06.235Z,1752171666.235 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0013.lzma.bak 2025-07-10T18:21:06.235Z,1752171666.235 [DataOverHttps](INFO): SBD MOMSN=25473682 2025-07-10T18:21:07.398Z,1752171667.398 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:21:07.399Z,1752171667.399 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:21:07.399Z,1752171667.399 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:21:12.502Z,1752171672.502 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:21:25.833Z,1752171685.833 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:21:39.568Z,1752171699.568 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:21:53.304Z,1752171713.304 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:22:08.457Z,1752171728.457 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:22:40.013Z,1752171760.013 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:24:26.824Z,1752171866.824 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:24:42.984Z,1752171882.984 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:24:57.976Z,1752171897.976 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:25:14.126Z,1752171914.126 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:25:28.668Z,1752171928.668 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:25:43.618Z,1752171943.618 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:25:58.970Z,1752171958.970 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:26:07.876Z,1752171967.876 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:26:07.876Z,1752171967.876 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:26:07.876Z,1752171967.876 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:26:07.876Z,1752171967.876 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:26:08.274Z,1752171968.274 [Default:CheckIn:D] Stopped 2025-07-10T18:26:08.274Z,1752171968.274 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:26:08.681Z,1752171968.681 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.931657 min 2025-07-10T18:26:08.681Z,1752171968.681 [Default:CheckIn:E] Stopped 2025-07-10T18:26:08.681Z,1752171968.681 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:26:08.681Z,1752171968.681 [Default:CheckIn] Stopped 2025-07-10T18:26:08.681Z,1752171968.681 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:26:08.682Z,1752171968.682 [Default:CheckIn](INFO): Running loop #13 2025-07-10T18:26:08.682Z,1752171968.682 [Default:CheckIn] Running Loop=13 2025-07-10T18:26:08.682Z,1752171968.682 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:26:08.682Z,1752171968.682 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:26:10.696Z,1752171970.696 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182609.00,A,3648.44542,N,12149.11628,W,5.695,268.23,100725,,,D*77 2025-07-10T18:26:10.698Z,1752171970.698 [NAL9602](INFO): GPS fix at 20250710T182609: (36.807424, -121.818605) 2025-07-10T18:26:10.710Z,1752171970.710 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:26:10.711Z,1752171970.711 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:26:14.333Z,1752171974.333 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:26:14.339Z,1752171974.339 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-07-10T18:26:19.340Z,1752171979.340 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0015.lzma 2025-07-10T18:26:28.465Z,1752171988.465 [NAL9602](INFO): SBD MO Status=0, MOMSN=25745, MT Status=0, MTMSN=0 2025-07-10T18:26:28.466Z,1752171988.466 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:26:29.673Z,1752171989.673 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:26:30.383Z,1752171990.383 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0015.lzma.bak 2025-07-10T18:26:30.383Z,1752171990.383 [DataOverHttps](INFO): SBD MOMSN=25473851 2025-07-10T18:26:45.025Z,1752172005.025 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-07-10T18:26:59.202Z,1752172019.202 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:26:59.605Z,1752172019.605 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250710T175300/Express0016.lzma 2025-07-10T18:27:10.648Z,1752172030.648 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0016.lzma.bak 2025-07-10T18:27:10.649Z,1752172030.649 [DataOverHttps](INFO): SBD MOMSN=25473854 2025-07-10T18:27:11.751Z,1752172031.751 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:27:11.751Z,1752172031.751 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:27:11.751Z,1752172031.751 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:29:07.369Z,1752172147.369 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T18:29:13.754Z,1752172153.754 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:29:27.898Z,1752172167.898 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:29:41.633Z,1752172181.633 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:29:55.365Z,1752172195.365 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:30:09.113Z,1752172209.113 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:30:22.838Z,1752172222.838 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:30:36.572Z,1752172236.572 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:30:49.941Z,1752172249.941 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:31:03.305Z,1752172263.305 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:31:17.040Z,1752172277.040 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:31:46.465Z,1752172306.465 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:32:12.420Z,1752172332.420 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:32:12.421Z,1752172332.421 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:32:12.421Z,1752172332.421 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:32:12.421Z,1752172332.421 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:32:12.808Z,1752172332.808 [Default:CheckIn:D] Stopped 2025-07-10T18:32:12.808Z,1752172332.808 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:32:13.216Z,1752172333.216 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.007218 min 2025-07-10T18:32:13.216Z,1752172333.216 [Default:CheckIn:E] Stopped 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn] Stopped 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn](INFO): Running loop #14 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn] Running Loop=14 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:32:13.217Z,1752172333.217 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:32:15.223Z,1752172335.223 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183214.00,A,3648.44650,N,12149.28693,W,3.188,62.08,100725,,,D*48 2025-07-10T18:32:15.225Z,1752172335.225 [NAL9602](INFO): GPS fix at 20250710T183214: (36.807442, -121.821449) 2025-07-10T18:32:15.236Z,1752172335.236 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:32:15.236Z,1752172335.236 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:32:17.609Z,1752172337.609 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:32:38.156Z,1752172358.156 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0018.lzma 2025-07-10T18:32:39.459Z,1752172359.459 [NAL9602](INFO): SBD MO Status=0, MOMSN=25746, MT Status=0, MTMSN=0 2025-07-10T18:32:39.459Z,1752172359.459 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:32:49.205Z,1752172369.205 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:33:10.166Z,1752172390.166 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:33:46.965Z,1752172426.965 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0018.lzma 2025-07-10T18:33:51.772Z,1752172431.772 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:33:51.982Z,1752172431.982 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:33:59.453Z,1752172439.453 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0018.lzma 2025-07-10T18:34:06.481Z,1752172446.481 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.182907 2025-07-10T18:34:06.721Z,1752172446.721 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:34:21.708Z,1752172461.708 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:34:23.729Z,1752172463.729 [BPC1](ERROR): Battery stick #16 (s/n: 00F8) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T18:34:23.730Z,1752172463.730 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T18:34:23.730Z,1752172463.730 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-07-10T18:34:23.731Z,1752172463.731 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T18:34:23.732Z,1752172463.732 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T18:34:23.733Z,1752172463.733 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T18:34:23.734Z,1752172463.734 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AC0. 2025-07-10T18:34:23.734Z,1752172463.734 [BPC1](INFO): Calculating totals. Valid battery stick count: 41. Valid reserve battery stick count: 4. 2025-07-10T18:34:23.738Z,1752172463.738 [BPC1](FAULT): Failed to receive data from 14 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 9, 10, 11, 12, 14, 16, 24, 29, 35, 51, 52, 53, 57, 59. 2025-07-10T18:34:24.998Z,1752172464.998 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003482 2025-07-10T18:34:27.369Z,1752172467.369 [NAL9602](INFO): SBD MO Status=1, MOMSN=25747, MT Status=0, MTMSN=0 2025-07-10T18:34:27.421Z,1752172467.421 [NAL9602](INFO): Sent 72 bytes from file Logs/20250710T175300/Courier0018.lzma 2025-07-10T18:34:27.421Z,1752172467.421 [NAL9602](INFO): Packets left to send: 0 2025-07-10T18:34:32.649Z,1752172472.649 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20250710T175300/Express0019.lzma 2025-07-10T18:34:43.691Z,1752172483.691 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0019.lzma.bak 2025-07-10T18:34:43.691Z,1752172483.691 [DataOverHttps](INFO): SBD MOMSN=25473895 2025-07-10T18:34:45.163Z,1752172485.163 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:34:45.164Z,1752172485.164 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:34:45.164Z,1752172485.164 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:34:58.118Z,1752172498.118 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:37:48.217Z,1752172668.217 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:39:45.906Z,1752172785.906 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:39:45.906Z,1752172785.906 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:39:45.906Z,1752172785.906 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:39:45.906Z,1752172785.906 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:39:46.276Z,1752172786.276 [Default:CheckIn:D] Stopped 2025-07-10T18:39:46.276Z,1752172786.276 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.565023 min 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn:E] Stopped 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn] Stopped 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn](INFO): Running loop #15 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn] Running Loop=15 2025-07-10T18:39:46.680Z,1752172786.680 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:39:46.681Z,1752172786.681 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:39:48.683Z,1752172788.683 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183947.00,A,3648.37975,N,12148.78853,W,3.071,110.42,100725,,,D*72 2025-07-10T18:39:48.686Z,1752172788.686 [NAL9602](INFO): GPS fix at 20250710T183947: (36.806329, -121.813142) 2025-07-10T18:39:48.696Z,1752172788.696 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:39:48.717Z,1752172788.717 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:39:51.949Z,1752172791.949 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:40:21.824Z,1752172821.824 [NAL9602](INFO): SBD MO Status=0, MOMSN=25748, MT Status=0, MTMSN=0 2025-07-10T18:40:21.824Z,1752172821.824 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:40:23.089Z,1752172823.089 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:40:52.570Z,1752172852.570 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:40:54.341Z,1752172854.341 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20250710T175300/Courier0021.lzma 2025-07-10T18:40:55.341Z,1752172855.341 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:41:43.574Z,1752172903.574 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.319458 2025-07-10T18:41:59.658Z,1752172919.658 [NAL9602](INFO): SBD MO Status=1, MOMSN=25749, MT Status=0, MTMSN=0 2025-07-10T18:41:59.705Z,1752172919.705 [NAL9602](INFO): Sent 84 bytes from file Logs/20250710T175300/Courier0021.lzma 2025-07-10T18:41:59.705Z,1752172919.705 [NAL9602](INFO): Packets left to send: 0 2025-07-10T18:42:14.701Z,1752172934.701 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-07-10T18:42:21.540Z,1752172941.540 [NAL9602](INFO): SBD MO Status=1, MOMSN=25750, MT Status=0, MTMSN=0 2025-07-10T18:42:21.589Z,1752172941.589 [NAL9602](INFO): Sent 305 bytes from file Logs/20250710T175300/Express0022.lzma 2025-07-10T18:42:21.589Z,1752172941.589 [NAL9602](INFO): Packets left to send: 0 2025-07-10T18:42:39.324Z,1752172959.324 [NAL9602](INFO): SBD MO Status=0, MOMSN=25751, MT Status=0, MTMSN=0 2025-07-10T18:42:39.406Z,1752172959.406 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:42:39.406Z,1752172959.406 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:42:39.406Z,1752172959.406 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:43:10.067Z,1752172990.067 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:43:17.193Z,1752172997.193 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-07-10T18:43:35.687Z,1752173015.687 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004156 2025-07-10T18:47:39.972Z,1752173259.972 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:47:39.973Z,1752173259.973 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:47:39.973Z,1752173259.973 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:47:39.973Z,1752173259.973 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:47:40.483Z,1752173260.483 [Default:CheckIn:D] Stopped 2025-07-10T18:47:40.483Z,1752173260.483 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 99.468473 min 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn:E] Stopped 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn] Stopped 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn](INFO): Running loop #16 2025-07-10T18:47:40.810Z,1752173260.810 [Default:CheckIn] Running Loop=16 2025-07-10T18:47:40.811Z,1752173260.811 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:47:40.811Z,1752173260.811 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:47:42.792Z,1752173262.792 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184742.00,A,3648.25463,N,12148.18154,W,4.315,86.34,100725,,,D*46 2025-07-10T18:47:42.794Z,1752173262.794 [NAL9602](INFO): GPS fix at 20250710T184742: (36.804244, -121.803026) 2025-07-10T18:47:42.805Z,1752173262.805 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:47:42.805Z,1752173262.805 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:47:49.972Z,1752173269.972 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0024.lzma 2025-07-10T18:47:52.538Z,1752173272.538 [NAL9602](INFO): SBD MO Status=0, MOMSN=25752, MT Status=0, MTMSN=0 2025-07-10T18:47:52.538Z,1752173272.538 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:47:54.153Z,1752173274.153 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T18:48:00.559Z,1752173280.559 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:48:01.015Z,1752173281.015 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0024.lzma.bak 2025-07-10T18:48:01.015Z,1752173281.015 [DataOverHttps](INFO): SBD MOMSN=25474252 2025-07-10T18:48:14.292Z,1752173294.292 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:48:23.186Z,1752173303.186 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:48:27.101Z,1752173307.101 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20250710T175300/Express0025.lzma 2025-07-10T18:48:28.432Z,1752173308.432 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:48:38.155Z,1752173318.155 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0025.lzma.bak 2025-07-10T18:48:38.155Z,1752173318.155 [DataOverHttps](INFO): SBD MOMSN=25474256 2025-07-10T18:48:39.362Z,1752173319.362 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:48:39.362Z,1752173319.362 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:48:39.362Z,1752173319.362 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:48:42.265Z,1752173322.265 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:48:56.310Z,1752173336.310 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:49:10.046Z,1752173350.046 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:49:23.781Z,1752173363.781 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:49:37.113Z,1752173377.113 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:49:50.848Z,1752173390.848 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:50:04.991Z,1752173404.991 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:52:40.982Z,1752173560.982 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:52:55.560Z,1752173575.560 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:53:10.509Z,1752173590.509 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:53:25.458Z,1752173605.458 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:53:40.062Z,1752173620.062 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:53:40.062Z,1752173620.062 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:53:40.062Z,1752173620.062 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:53:40.062Z,1752173620.062 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:53:40.404Z,1752173620.404 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:53:40.451Z,1752173620.451 [Default:CheckIn:D] Stopped 2025-07-10T18:53:40.451Z,1752173620.451 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:53:40.847Z,1752173620.847 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.467928 min 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn:E] Stopped 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn] Stopped 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn](INFO): Running loop #17 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn] Running Loop=17 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:53:40.848Z,1752173620.848 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:53:42.834Z,1752173622.834 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185342.00,A,3648.24211,N,12147.71795,W,4.063,83.61,100725,,,D*4D 2025-07-10T18:53:42.837Z,1752173622.837 [NAL9602](INFO): GPS fix at 20250710T185342: (36.804035, -121.795299) 2025-07-10T18:53:42.848Z,1752173622.848 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:53:42.848Z,1752173622.848 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:53:50.620Z,1752173630.620 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0027.lzma 2025-07-10T18:53:55.758Z,1752173635.758 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:54:01.671Z,1752173641.671 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0027.lzma.bak 2025-07-10T18:54:01.671Z,1752173641.671 [DataOverHttps](INFO): SBD MOMSN=25474274 2025-07-10T18:54:03.032Z,1752173643.032 [NAL9602](INFO): SBD MO Status=0, MOMSN=25753, MT Status=0, MTMSN=0 2025-07-10T18:54:03.032Z,1752173643.032 [NAL9602](INFO): No messages in MT queue 2025-07-10T18:54:11.109Z,1752173651.109 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:54:26.865Z,1752173666.865 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:54:27.633Z,1752173667.633 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250710T175300/Express0028.lzma 2025-07-10T18:54:33.755Z,1752173673.755 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T18:54:38.675Z,1752173678.675 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0028.lzma.bak 2025-07-10T18:54:38.675Z,1752173678.675 [DataOverHttps](INFO): SBD MOMSN=25474277 2025-07-10T18:54:39.810Z,1752173679.810 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T18:54:39.810Z,1752173679.810 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T18:54:39.810Z,1752173679.810 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T18:54:41.814Z,1752173681.814 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:54:56.358Z,1752173696.358 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-07-10T18:55:27.067Z,1752173727.067 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2025-07-10T18:57:18.616Z,1752173838.616 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T18:57:25.028Z,1752173845.028 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:57:39.171Z,1752173859.171 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:57:53.321Z,1752173873.321 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:58:07.044Z,1752173887.044 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:58:21.184Z,1752173901.184 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:58:34.922Z,1752173914.922 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:58:48.656Z,1752173928.656 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:59:02.832Z,1752173942.832 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:59:16.569Z,1752173956.569 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:59:30.311Z,1752173970.311 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T18:59:40.446Z,1752173980.446 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T18:59:40.446Z,1752173980.446 [Default:CheckIn:C.Wait] Stopped 2025-07-10T18:59:40.446Z,1752173980.446 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T18:59:40.446Z,1752173980.446 [Default:CheckIn:D] Running Loop=1 2025-07-10T18:59:40.832Z,1752173980.832 [Default:CheckIn:D] Stopped 2025-07-10T18:59:40.832Z,1752173980.832 [Default:CheckIn:E] Running Loop=1 2025-07-10T18:59:41.232Z,1752173981.232 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 111.474292 min 2025-07-10T18:59:41.232Z,1752173981.232 [Default:CheckIn:E] Stopped 2025-07-10T18:59:41.232Z,1752173981.232 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T18:59:41.232Z,1752173981.232 [Default:CheckIn] Stopped 2025-07-10T18:59:41.232Z,1752173981.232 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T18:59:41.233Z,1752173981.233 [Default:CheckIn](INFO): Running loop #18 2025-07-10T18:59:41.233Z,1752173981.233 [Default:CheckIn] Running Loop=18 2025-07-10T18:59:41.233Z,1752173981.233 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T18:59:41.233Z,1752173981.233 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T18:59:43.248Z,1752173983.248 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185942.00,A,3648.40958,N,12147.35522,W,1.827,78.52,100725,,,D*44 2025-07-10T18:59:43.258Z,1752173983.258 [NAL9602](INFO): GPS fix at 20250710T185942: (36.806826, -121.789254) 2025-07-10T18:59:43.269Z,1752173983.269 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T18:59:43.269Z,1752173983.269 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T18:59:50.821Z,1752173990.821 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0030.lzma 2025-07-10T19:00:01.863Z,1752174001.863 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0030.lzma.bak 2025-07-10T19:00:01.864Z,1752174001.864 [DataOverHttps](INFO): SBD MOMSN=25474346 2025-07-10T19:00:09.900Z,1752174009.900 [NAL9602](INFO): SBD MO Status=0, MOMSN=25754, MT Status=0, MTMSN=0 2025-07-10T19:00:09.900Z,1752174009.900 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:00:28.105Z,1752174028.105 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20250710T175300/Express0031.lzma 2025-07-10T19:00:39.147Z,1752174039.147 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0031.lzma.bak 2025-07-10T19:00:39.147Z,1752174039.147 [DataOverHttps](INFO): SBD MOMSN=25474349 2025-07-10T19:00:40.610Z,1752174040.610 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:00:40.638Z,1752174040.638 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:00:40.638Z,1752174040.638 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:00:40.638Z,1752174040.638 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:01:59.040Z,1752174119.040 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T19:02:06.248Z,1752174126.248 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:02:22.007Z,1752174142.007 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:02:37.356Z,1752174157.356 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:02:52.729Z,1752174172.729 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:03:08.485Z,1752174188.485 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:03:23.837Z,1752174203.837 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:03:39.998Z,1752174219.998 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:03:55.752Z,1752174235.752 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:04:11.104Z,1752174251.104 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:05:41.274Z,1752174341.274 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:05:41.274Z,1752174341.274 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:05:41.274Z,1752174341.274 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:05:41.274Z,1752174341.274 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:05:41.674Z,1752174341.674 [Default:CheckIn:D] Stopped 2025-07-10T19:05:41.674Z,1752174341.674 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:05:42.098Z,1752174342.098 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 117.488322 min 2025-07-10T19:05:42.098Z,1752174342.098 [Default:CheckIn:E] Stopped 2025-07-10T19:05:42.098Z,1752174342.098 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:05:42.098Z,1752174342.098 [Default:CheckIn] Stopped 2025-07-10T19:05:42.099Z,1752174342.099 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:05:42.099Z,1752174342.099 [Default:CheckIn](INFO): Running loop #19 2025-07-10T19:05:42.099Z,1752174342.099 [Default:CheckIn] Running Loop=19 2025-07-10T19:05:42.099Z,1752174342.099 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:05:42.099Z,1752174342.099 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:05:44.088Z,1752174344.088 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190543.00,A,3648.34391,N,12147.12995,W,3.810,181.99,100725,,,D*72 2025-07-10T19:05:44.091Z,1752174344.091 [NAL9602](INFO): GPS fix at 20250710T190543: (36.805732, -121.785499) 2025-07-10T19:05:44.102Z,1752174344.102 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:05:44.102Z,1752174344.102 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:05:51.628Z,1752174351.628 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0033.lzma 2025-07-10T19:06:00.652Z,1752174360.652 [NAL9602](INFO): SBD MO Status=0, MOMSN=25755, MT Status=0, MTMSN=0 2025-07-10T19:06:00.652Z,1752174360.652 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:06:02.671Z,1752174362.671 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0033.lzma.bak 2025-07-10T19:06:02.671Z,1752174362.671 [DataOverHttps](INFO): SBD MOMSN=25474372 2025-07-10T19:06:18.021Z,1752174378.021 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-07-10T19:06:28.653Z,1752174388.653 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20250710T175300/Express0034.lzma 2025-07-10T19:06:31.354Z,1752174391.354 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:06:39.695Z,1752174399.695 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0034.lzma.bak 2025-07-10T19:06:39.695Z,1752174399.695 [DataOverHttps](INFO): SBD MOMSN=25474423 2025-07-10T19:06:41.080Z,1752174401.080 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:06:41.080Z,1752174401.080 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:06:41.080Z,1752174401.080 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:06:46.711Z,1752174406.711 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:07:00.852Z,1752174420.852 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:07:14.986Z,1752174434.986 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:07:29.127Z,1752174449.127 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:07:42.861Z,1752174462.861 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:07:57.001Z,1752174477.001 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:08:11.141Z,1752174491.141 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:08:24.877Z,1752174504.877 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:08:39.023Z,1752174519.023 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:08:53.193Z,1752174533.193 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:11:29.990Z,1752174689.990 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:11:41.720Z,1752174701.720 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:11:41.720Z,1752174701.720 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:11:41.720Z,1752174701.720 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:11:41.720Z,1752174701.720 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:11:42.126Z,1752174702.126 [Default:CheckIn:D] Stopped 2025-07-10T19:11:42.126Z,1752174702.126 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 123.495850 min 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn:E] Stopped 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn] Stopped 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn](INFO): Running loop #20 2025-07-10T19:11:42.527Z,1752174702.527 [Default:CheckIn] Running Loop=20 2025-07-10T19:11:42.528Z,1752174702.528 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:11:42.528Z,1752174702.528 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:11:44.536Z,1752174704.536 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191143.00,A,3648.14703,N,12147.22265,W,0.019,202.44,100725,,,D*77 2025-07-10T19:11:44.546Z,1752174704.546 [NAL9602](INFO): GPS fix at 20250710T191143: (36.802450, -121.787044) 2025-07-10T19:11:44.557Z,1752174704.557 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:11:44.557Z,1752174704.557 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:11:45.341Z,1752174705.341 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:11:52.548Z,1752174712.548 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0036.lzma 2025-07-10T19:12:01.096Z,1752174721.096 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:12:03.591Z,1752174723.591 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0036.lzma.bak 2025-07-10T19:12:03.591Z,1752174723.591 [DataOverHttps](INFO): SBD MOMSN=25474438 2025-07-10T19:12:05.949Z,1752174725.949 [NAL9602](INFO): SBD MO Status=2, MOMSN=25756, MT Status=2, MTMSN=0 2025-07-10T19:12:05.949Z,1752174725.949 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T19:12:16.044Z,1752174736.044 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:12:27.363Z,1752174747.363 [NAL9602](INFO): SBD MO Status=2, MOMSN=25756, MT Status=2, MTMSN=0 2025-07-10T19:12:27.364Z,1752174747.364 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T19:12:29.693Z,1752174749.693 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20250710T175300/Express0037.lzma 2025-07-10T19:12:31.399Z,1752174751.399 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:12:40.751Z,1752174760.751 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0037.lzma.bak 2025-07-10T19:12:40.751Z,1752174760.751 [DataOverHttps](INFO): SBD MOMSN=25474441 2025-07-10T19:12:41.926Z,1752174761.926 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:12:41.926Z,1752174761.926 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:12:41.926Z,1752174761.926 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:12:46.344Z,1752174766.344 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:12:49.200Z,1752174769.200 [NAL9602](INFO): SBD MO Status=0, MOMSN=25756, MT Status=0, MTMSN=0 2025-07-10T19:12:49.200Z,1752174769.200 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:13:01.708Z,1752174781.708 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:13:16.659Z,1752174796.659 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:13:19.892Z,1752174799.892 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:13:31.604Z,1752174811.604 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:13:46.149Z,1752174826.149 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-07-10T19:15:25.566Z,1752174925.566 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:15:25.567Z,1752174925.567 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-07-10T19:15:25.568Z,1752174925.568 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:15:25.568Z,1752174925.568 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:15:25.569Z,1752174925.569 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:15:25.570Z,1752174925.570 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AC0. 2025-07-10T19:15:25.571Z,1752174925.571 [BPC1](INFO): Calculating totals. Valid battery stick count: 41. Valid reserve battery stick count: 5. 2025-07-10T19:15:25.575Z,1752174925.575 [BPC1](FAULT): Failed to receive data from 15 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 9, 10, 11, 12, 14, 15, 16, 24, 29, 35, 51, 52, 53, 57, 59. 2025-07-10T19:17:42.595Z,1752175062.595 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:17:42.595Z,1752175062.595 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:17:42.596Z,1752175062.596 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:17:42.596Z,1752175062.596 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:17:42.988Z,1752175062.988 [Default:CheckIn:D] Stopped 2025-07-10T19:17:42.988Z,1752175062.988 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 129.510221 min 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn:E] Stopped 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn] Stopped 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn](INFO): Running loop #21 2025-07-10T19:17:43.387Z,1752175063.387 [Default:CheckIn] Running Loop=21 2025-07-10T19:17:43.388Z,1752175063.388 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:17:43.388Z,1752175063.388 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:17:45.396Z,1752175065.396 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191744.00,A,3648.14790,N,12147.22451,W,0.019,202.44,100725,,,D*7D 2025-07-10T19:17:45.398Z,1752175065.398 [NAL9602](INFO): GPS fix at 20250710T191744: (36.802465, -121.787075) 2025-07-10T19:17:45.421Z,1752175065.421 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:17:45.421Z,1752175065.421 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:17:52.380Z,1752175072.380 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20250710T175300/Courier0039.lzma 2025-07-10T19:18:03.423Z,1752175083.423 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0039.lzma.bak 2025-07-10T19:18:03.423Z,1752175083.423 [DataOverHttps](INFO): SBD MOMSN=25474510 2025-07-10T19:18:17.332Z,1752175097.332 [NAL9602](INFO): SBD MO Status=2, MOMSN=25757, MT Status=2, MTMSN=0 2025-07-10T19:18:17.332Z,1752175097.332 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T19:18:26.627Z,1752175106.627 [NAL9602](INFO): SBD MO Status=0, MOMSN=25757, MT Status=0, MTMSN=0 2025-07-10T19:18:26.628Z,1752175106.628 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:18:29.429Z,1752175109.429 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20250710T175300/Express0040.lzma 2025-07-10T19:18:40.471Z,1752175120.471 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0040.lzma.bak 2025-07-10T19:18:40.471Z,1752175120.471 [DataOverHttps](INFO): SBD MOMSN=25474513 2025-07-10T19:18:41.588Z,1752175121.588 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:18:41.589Z,1752175121.589 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:18:41.589Z,1752175121.589 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:18:57.326Z,1752175137.326 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:23:42.234Z,1752175422.234 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:23:42.234Z,1752175422.234 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:23:42.234Z,1752175422.234 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:23:42.234Z,1752175422.234 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:23:42.648Z,1752175422.648 [Default:CheckIn:D] Stopped 2025-07-10T19:23:42.648Z,1752175422.648 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:23:43.037Z,1752175423.037 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 135.504557 min 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn:E] Stopped 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn] Stopped 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn](INFO): Running loop #22 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn] Running Loop=22 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:23:43.038Z,1752175423.038 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:23:45.049Z,1752175425.049 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192344.00,A,3648.15329,N,12147.22117,W,0.019,327.35,100725,,,D*7A 2025-07-10T19:23:45.052Z,1752175425.052 [NAL9602](INFO): GPS fix at 20250710T192344: (36.802555, -121.787019) 2025-07-10T19:23:45.063Z,1752175425.063 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:23:45.063Z,1752175425.063 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:23:52.036Z,1752175432.036 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0042.lzma 2025-07-10T19:23:57.571Z,1752175437.571 [NAL9602](INFO): SBD MO Status=0, MOMSN=25758, MT Status=0, MTMSN=0 2025-07-10T19:23:57.571Z,1752175437.571 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:24:03.079Z,1752175443.079 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0042.lzma.bak 2025-07-10T19:24:03.079Z,1752175443.079 [DataOverHttps](INFO): SBD MOMSN=25474536 2025-07-10T19:24:28.274Z,1752175468.274 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:24:28.977Z,1752175468.977 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250710T175300/Express0043.lzma 2025-07-10T19:24:40.019Z,1752175480.019 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0043.lzma.bak 2025-07-10T19:24:40.019Z,1752175480.019 [DataOverHttps](INFO): SBD MOMSN=25474549 2025-07-10T19:24:41.223Z,1752175481.223 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:24:41.224Z,1752175481.224 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:24:41.224Z,1752175481.224 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:26:33.528Z,1752175593.528 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:26:46.857Z,1752175606.857 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:27:00.604Z,1752175620.604 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:27:14.744Z,1752175634.744 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:27:28.076Z,1752175648.076 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:27:41.812Z,1752175661.812 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:29:41.866Z,1752175781.866 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:29:41.866Z,1752175781.866 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:29:41.866Z,1752175781.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:29:41.867Z,1752175781.867 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:29:42.277Z,1752175782.277 [Default:CheckIn:D] Stopped 2025-07-10T19:29:42.278Z,1752175782.278 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:29:42.691Z,1752175782.691 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 141.498372 min 2025-07-10T19:29:42.691Z,1752175782.691 [Default:CheckIn:E] Stopped 2025-07-10T19:29:42.691Z,1752175782.691 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:29:42.691Z,1752175782.691 [Default:CheckIn] Stopped 2025-07-10T19:29:42.692Z,1752175782.692 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:29:42.692Z,1752175782.692 [Default:CheckIn](INFO): Running loop #23 2025-07-10T19:29:42.692Z,1752175782.692 [Default:CheckIn] Running Loop=23 2025-07-10T19:29:42.692Z,1752175782.692 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:29:42.692Z,1752175782.692 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:29:44.693Z,1752175784.693 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192944.00,A,3648.15058,N,12147.22574,W,0.039,193.53,100725,,,D*7B 2025-07-10T19:29:44.696Z,1752175784.696 [NAL9602](INFO): GPS fix at 20250710T192944: (36.802510, -121.787096) 2025-07-10T19:29:44.707Z,1752175784.707 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:29:44.707Z,1752175784.707 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:29:52.169Z,1752175792.169 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0045.lzma 2025-07-10T19:30:03.211Z,1752175803.211 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0045.lzma.bak 2025-07-10T19:30:03.211Z,1752175803.211 [DataOverHttps](INFO): SBD MOMSN=25474614 2025-07-10T19:30:10.547Z,1752175810.547 [NAL9602](INFO): SBD MO Status=0, MOMSN=25759, MT Status=0, MTMSN=0 2025-07-10T19:30:10.547Z,1752175810.547 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:30:18.616Z,1752175818.616 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:30:29.245Z,1752175829.245 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20250710T175300/Express0046.lzma 2025-07-10T19:30:33.588Z,1752175833.588 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:30:40.290Z,1752175840.290 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0046.lzma.bak 2025-07-10T19:30:40.290Z,1752175840.290 [DataOverHttps](INFO): SBD MOMSN=25474620 2025-07-10T19:30:41.246Z,1752175841.246 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:30:41.662Z,1752175841.662 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:30:41.662Z,1752175841.662 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:30:41.662Z,1752175841.662 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:30:48.512Z,1752175848.512 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:31:03.864Z,1752175863.864 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:31:18.815Z,1752175878.815 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:31:33.760Z,1752175893.760 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:31:48.708Z,1752175908.708 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:32:04.062Z,1752175924.062 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:32:19.008Z,1752175939.008 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:32:33.553Z,1752175953.553 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-07-10T19:35:00.718Z,1752176100.718 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:35:14.452Z,1752176114.452 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:35:28.592Z,1752176128.592 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:35:42.390Z,1752176142.390 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:35:42.390Z,1752176142.390 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:35:42.390Z,1752176142.390 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:35:42.391Z,1752176142.391 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:35:42.734Z,1752176142.734 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:35:42.752Z,1752176142.752 [Default:CheckIn:D] Stopped 2025-07-10T19:35:42.752Z,1752176142.752 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:35:43.168Z,1752176143.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 147.506283 min 2025-07-10T19:35:43.168Z,1752176143.168 [Default:CheckIn:E] Stopped 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn] Stopped 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn](INFO): Running loop #24 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn] Running Loop=24 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:35:43.169Z,1752176143.169 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:35:45.161Z,1752176145.161 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193544.00,A,3648.14054,N,12147.24696,W,1.886,300.10,100725,,,D*70 2025-07-10T19:35:45.163Z,1752176145.163 [NAL9602](INFO): GPS fix at 20250710T193544: (36.802342, -121.787449) 2025-07-10T19:35:45.186Z,1752176145.186 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:35:45.187Z,1752176145.187 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:35:53.012Z,1752176153.012 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0048.lzma 2025-07-10T19:35:56.468Z,1752176156.468 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:36:04.055Z,1752176164.055 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0048.lzma.bak 2025-07-10T19:36:04.055Z,1752176164.055 [DataOverHttps](INFO): SBD MOMSN=25474640 2025-07-10T19:36:07.788Z,1752176167.788 [NAL9602](INFO): SBD MO Status=2, MOMSN=25760, MT Status=2, MTMSN=0 2025-07-10T19:36:07.788Z,1752176167.788 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T19:36:10.204Z,1752176170.204 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:36:24.344Z,1752176184.344 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:36:30.245Z,1752176190.245 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20250710T175300/Express0049.lzma 2025-07-10T19:36:38.080Z,1752176198.080 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:36:38.507Z,1752176198.507 [NAL9602](INFO): SBD MO Status=2, MOMSN=25760, MT Status=2, MTMSN=0 2025-07-10T19:36:38.508Z,1752176198.508 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T19:36:41.291Z,1752176201.291 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0049.lzma.bak 2025-07-10T19:36:41.291Z,1752176201.291 [DataOverHttps](INFO): SBD MOMSN=25474645 2025-07-10T19:36:42.541Z,1752176202.541 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:36:42.542Z,1752176202.542 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:36:42.542Z,1752176202.542 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:36:45.767Z,1752176205.767 [NAL9602](INFO): SBD MO Status=0, MOMSN=25760, MT Status=0, MTMSN=0 2025-07-10T19:36:45.767Z,1752176205.767 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:36:52.221Z,1752176212.221 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:37:05.963Z,1752176225.963 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:37:16.476Z,1752176236.476 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:37:19.692Z,1752176239.692 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:39:43.156Z,1752176383.156 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:39:49.621Z,1752176389.621 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:40:04.569Z,1752176404.569 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:40:19.517Z,1752176419.517 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:40:34.868Z,1752176434.868 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:40:50.233Z,1752176450.233 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:41:05.228Z,1752176465.228 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:41:20.185Z,1752176480.185 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:41:35.536Z,1752176495.536 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:41:43.221Z,1752176503.221 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:41:43.221Z,1752176503.221 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:41:43.221Z,1752176503.221 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:41:43.221Z,1752176503.221 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:41:43.632Z,1752176503.632 [Default:CheckIn:D] Stopped 2025-07-10T19:41:43.632Z,1752176503.632 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:41:44.041Z,1752176504.041 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 153.520947 min 2025-07-10T19:41:44.041Z,1752176504.041 [Default:CheckIn:E] Stopped 2025-07-10T19:41:44.041Z,1752176504.041 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:41:44.041Z,1752176504.041 [Default:CheckIn] Stopped 2025-07-10T19:41:44.042Z,1752176504.042 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:41:44.042Z,1752176504.042 [Default:CheckIn](INFO): Running loop #25 2025-07-10T19:41:44.042Z,1752176504.042 [Default:CheckIn] Running Loop=25 2025-07-10T19:41:44.042Z,1752176504.042 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:41:44.042Z,1752176504.042 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:41:46.040Z,1752176506.040 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194145.00,A,3648.17175,N,12147.27956,W,0.117,276.91,100725,,,D*7A 2025-07-10T19:41:46.043Z,1752176506.043 [NAL9602](INFO): GPS fix at 20250710T194145: (36.802863, -121.787993) 2025-07-10T19:41:46.054Z,1752176506.054 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:41:46.054Z,1752176506.054 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:41:50.481Z,1752176510.481 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:41:53.333Z,1752176513.333 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0051.lzma 2025-07-10T19:42:04.375Z,1752176524.375 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0051.lzma.bak 2025-07-10T19:42:04.375Z,1752176524.375 [DataOverHttps](INFO): SBD MOMSN=25474674 2025-07-10T19:42:11.499Z,1752176531.499 [NAL9602](INFO): SBD MO Status=0, MOMSN=25761, MT Status=0, MTMSN=0 2025-07-10T19:42:11.500Z,1752176531.500 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:42:30.529Z,1752176550.529 [DataOverHttps](INFO): Sending 176 bytes from file Logs/20250710T175300/Express0052.lzma 2025-07-10T19:42:41.571Z,1752176561.571 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0052.lzma.bak 2025-07-10T19:42:41.571Z,1752176561.571 [DataOverHttps](INFO): SBD MOMSN=25474677 2025-07-10T19:42:42.202Z,1752176562.202 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:42:43.036Z,1752176563.036 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:42:43.036Z,1752176563.036 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:42:43.036Z,1752176563.036 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:44:26.841Z,1752176666.841 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:44:40.172Z,1752176680.172 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:44:53.957Z,1752176693.957 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:45:07.694Z,1752176707.694 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:45:21.833Z,1752176721.833 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:45:35.568Z,1752176735.568 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:45:49.306Z,1752176749.306 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:46:03.457Z,1752176763.457 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:46:17.584Z,1752176777.584 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:46:31.724Z,1752176791.724 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:47:43.711Z,1752176863.711 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:47:43.711Z,1752176863.711 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:47:43.711Z,1752176863.711 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:47:43.711Z,1752176863.711 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:47:44.125Z,1752176864.125 [Default:CheckIn:D] Stopped 2025-07-10T19:47:44.125Z,1752176864.125 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:47:44.542Z,1752176864.542 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 159.529167 min 2025-07-10T19:47:44.543Z,1752176864.543 [Default:CheckIn:E] Stopped 2025-07-10T19:47:44.543Z,1752176864.543 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:47:44.544Z,1752176864.544 [Default:CheckIn] Stopped 2025-07-10T19:47:44.544Z,1752176864.544 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:47:44.549Z,1752176864.549 [Default:CheckIn](INFO): Running loop #26 2025-07-10T19:47:44.549Z,1752176864.549 [Default:CheckIn] Running Loop=26 2025-07-10T19:47:44.549Z,1752176864.549 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:47:44.549Z,1752176864.549 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:47:46.528Z,1752176866.528 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194745.00,A,3648.17283,N,12147.28125,W,0.019,203.28,100725,,,A*7F 2025-07-10T19:47:46.530Z,1752176866.530 [NAL9602](INFO): GPS fix at 20250710T194745: (36.802881, -121.788021) 2025-07-10T19:47:46.543Z,1752176866.543 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:47:46.543Z,1752176866.543 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:47:54.008Z,1752176874.008 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0054.lzma 2025-07-10T19:47:59.056Z,1752176879.056 [NAL9602](INFO): SBD MO Status=0, MOMSN=25762, MT Status=0, MTMSN=0 2025-07-10T19:47:59.056Z,1752176879.056 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:48:05.051Z,1752176885.051 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0054.lzma.bak 2025-07-10T19:48:05.051Z,1752176885.051 [DataOverHttps](INFO): SBD MOMSN=25474803 2025-07-10T19:48:29.758Z,1752176909.758 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:48:34.125Z,1752176914.125 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20250710T175300/Express0055.lzma 2025-07-10T19:48:45.179Z,1752176925.179 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0055.lzma.bak 2025-07-10T19:48:45.179Z,1752176925.179 [DataOverHttps](INFO): SBD MOMSN=25474807 2025-07-10T19:48:46.340Z,1752176926.340 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:48:46.340Z,1752176926.340 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:48:46.340Z,1752176926.340 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:49:08.186Z,1752176948.186 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:49:23.133Z,1752176963.133 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:49:38.080Z,1752176978.080 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:49:53.029Z,1752176993.029 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:50:07.977Z,1752177007.977 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:50:23.328Z,1752177023.328 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:50:38.276Z,1752177038.276 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:50:53.270Z,1752177053.270 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:51:08.644Z,1752177068.644 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:51:23.592Z,1752177083.592 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:53:47.064Z,1752177227.064 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:53:47.064Z,1752177227.064 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:53:47.066Z,1752177227.066 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:53:47.067Z,1752177227.067 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:53:47.465Z,1752177227.465 [Default:CheckIn:D] Stopped 2025-07-10T19:53:47.465Z,1752177227.465 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 165.584831 min 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn:E] Stopped 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn] Stopped 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn](INFO): Running loop #27 2025-07-10T19:53:47.870Z,1752177227.870 [Default:CheckIn] Running Loop=27 2025-07-10T19:53:47.871Z,1752177227.871 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:53:47.871Z,1752177227.871 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:53:49.887Z,1752177229.887 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195349.00,A,3648.18028,N,12147.27980,W,0.097,203.28,100725,,,A*74 2025-07-10T19:53:49.890Z,1752177229.890 [NAL9602](INFO): GPS fix at 20250710T195349: (36.803005, -121.787997) 2025-07-10T19:53:49.901Z,1752177229.901 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:53:49.901Z,1752177229.901 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:53:57.112Z,1752177237.112 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0057.lzma 2025-07-10T19:54:01.996Z,1752177241.996 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:54:08.155Z,1752177248.155 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0057.lzma.bak 2025-07-10T19:54:08.155Z,1752177248.155 [DataOverHttps](INFO): SBD MOMSN=25474824 2025-07-10T19:54:16.136Z,1752177256.136 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:54:19.372Z,1752177259.372 [NAL9602](INFO): SBD MO Status=2, MOMSN=25763, MT Status=2, MTMSN=0 2025-07-10T19:54:19.372Z,1752177259.372 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T19:54:30.276Z,1752177270.276 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:54:34.225Z,1752177274.225 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20250710T175300/Express0058.lzma 2025-07-10T19:54:43.609Z,1752177283.609 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:54:45.267Z,1752177285.267 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0058.lzma.bak 2025-07-10T19:54:45.267Z,1752177285.267 [DataOverHttps](INFO): SBD MOMSN=25474827 2025-07-10T19:54:46.469Z,1752177286.469 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T19:54:46.469Z,1752177286.469 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T19:54:46.469Z,1752177286.469 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T19:54:57.395Z,1752177297.395 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:55:11.534Z,1752177311.534 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:55:25.673Z,1752177325.673 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:55:39.812Z,1752177339.812 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:55:53.967Z,1752177353.967 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:56:08.095Z,1752177368.095 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T19:56:27.103Z,1752177387.103 [BPC1](ERROR): Battery stick #24 (s/n: 01D3) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:56:27.104Z,1752177387.104 [BPC1](ERROR): Battery stick #29 (s/n: 00A7) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-07-10T19:56:27.104Z,1752177387.104 [BPC1](ERROR): Battery stick #51 (s/n: 01D6) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:56:27.105Z,1752177387.105 [BPC1](ERROR): Battery stick #52 (s/n: 0160) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:56:27.106Z,1752177387.106 [BPC1](ERROR): Battery stick #57 (s/n: 019F) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-07-10T19:56:27.107Z,1752177387.107 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AC0. 2025-07-10T19:56:27.107Z,1752177387.107 [BPC1](INFO): Calculating totals. Valid battery stick count: 41. Valid reserve battery stick count: 4. 2025-07-10T19:56:27.111Z,1752177387.111 [BPC1](FAULT): Failed to receive data from 14 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 9, 10, 11, 12, 14, 15, 24, 29, 35, 51, 52, 53, 57, 59. 2025-07-10T19:56:55.440Z,1752177415.440 [NAL9602](INFO): SBD MO Status=0, MOMSN=25763, MT Status=0, MTMSN=0 2025-07-10T19:56:55.440Z,1752177415.440 [NAL9602](INFO): No messages in MT queue 2025-07-10T19:57:26.146Z,1752177446.146 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T19:59:02.731Z,1752177542.731 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2025-07-10T19:59:02.731Z,1752177542.731 [DropWeight] Hardware Fault, FailCount= 1 2025-07-10T19:59:02.731Z,1752177542.731 [DropWeight](ERROR): Hardware Fault 2025-07-10T19:59:02.748Z,1752177542.748 [CommandExec](FAULT): Scheduling is paused 2025-07-10T19:59:02.749Z,1752177542.749 [CBIT](INFO): Critical error at 20250710T195902 2025-07-10T19:59:02.752Z,1752177542.752 [CBIT](ERROR): Hardware Fault in component: DropWeight 2025-07-10T19:59:02.752Z,1752177542.752 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2025-07-10T19:59:03.160Z,1752177543.160 [CBIT](INFO): Critical error at 20250710T195902 2025-07-10T19:59:47.180Z,1752177587.180 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T19:59:47.180Z,1752177587.180 [Default:CheckIn:C.Wait] Stopped 2025-07-10T19:59:47.180Z,1752177587.180 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T19:59:47.180Z,1752177587.180 [Default:CheckIn:D] Running Loop=1 2025-07-10T19:59:47.588Z,1752177587.588 [Default:CheckIn:D] Stopped 2025-07-10T19:59:47.588Z,1752177587.588 [Default:CheckIn:E] Running Loop=1 2025-07-10T19:59:47.990Z,1752177587.990 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 171.586882 min 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn:E] Stopped 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn] Stopped 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn](INFO): Running loop #28 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn] Running Loop=28 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T19:59:47.991Z,1752177587.991 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T19:59:49.000Z,1752177590.000 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195949.00,A,3648.17878,N,12147.28007,W,0.467,203.28,100725,,,A*7E 2025-07-10T19:59:50.002Z,1752177590.002 [NAL9602](INFO): GPS fix at 20250710T195949: (36.802980, -121.788001) 2025-07-10T19:59:50.023Z,1752177590.023 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T19:59:50.023Z,1752177590.023 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T19:59:57.753Z,1752177597.753 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20250710T175300/Courier0060.lzma 2025-07-10T19:59:58.080Z,1752177598.080 [NAL9602](INFO): SBD MO Status=0, MOMSN=25764, MT Status=0, MTMSN=0 2025-07-10T19:59:58.080Z,1752177598.080 [NAL9602](INFO): No messages in MT queue 2025-07-10T20:00:08.795Z,1752177608.795 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0060.lzma.bak 2025-07-10T20:00:08.795Z,1752177608.795 [DataOverHttps](INFO): SBD MOMSN=25474896 2025-07-10T20:00:28.790Z,1752177628.790 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T20:00:34.781Z,1752177634.781 [DataOverHttps](INFO): Sending 309 bytes from file Logs/20250710T175300/Express0061.lzma 2025-07-10T20:00:45.823Z,1752177645.823 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0061.lzma.bak 2025-07-10T20:00:45.823Z,1752177645.823 [DataOverHttps](INFO): SBD MOMSN=25474901 2025-07-10T20:00:47.022Z,1752177647.022 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T20:00:47.022Z,1752177647.022 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T20:00:47.022Z,1752177647.022 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T20:05:47.682Z,1752177947.682 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T20:05:47.682Z,1752177947.682 [Default:CheckIn:C.Wait] Stopped 2025-07-10T20:05:47.682Z,1752177947.682 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T20:05:47.683Z,1752177947.683 [Default:CheckIn:D] Running Loop=1 2025-07-10T20:05:48.092Z,1752177948.092 [Default:CheckIn:D] Stopped 2025-07-10T20:05:48.092Z,1752177948.092 [Default:CheckIn:E] Running Loop=1 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 177.595280 min 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn:E] Stopped 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn] Stopped 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn](INFO): Running loop #29 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn] Running Loop=29 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T20:05:48.491Z,1752177948.491 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T20:05:50.504Z,1752177950.504 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200549.00,A,3648.18097,N,12147.28549,W,0.350,201.64,100725,,,A*7D 2025-07-10T20:05:50.515Z,1752177950.515 [NAL9602](INFO): GPS fix at 20250710T200549: (36.803016, -121.788091) 2025-07-10T20:05:50.526Z,1752177950.526 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T20:05:50.526Z,1752177950.526 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T20:05:58.216Z,1752177958.216 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0063.lzma 2025-07-10T20:06:09.267Z,1752177969.267 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0063.lzma.bak 2025-07-10T20:06:09.267Z,1752177969.267 [DataOverHttps](INFO): SBD MOMSN=25474928 2025-07-10T20:06:32.519Z,1752177992.519 [NAL9602](INFO): SBD MO Status=2, MOMSN=25765, MT Status=2, MTMSN=0 2025-07-10T20:06:32.519Z,1752177992.519 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T20:06:35.293Z,1752177995.293 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250710T175300/Express0064.lzma 2025-07-10T20:06:46.335Z,1752178006.335 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0064.lzma.bak 2025-07-10T20:06:46.335Z,1752178006.335 [DataOverHttps](INFO): SBD MOMSN=25474931 2025-07-10T20:06:47.502Z,1752178007.502 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T20:06:47.502Z,1752178007.502 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T20:06:47.502Z,1752178007.502 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T20:06:49.933Z,1752178009.933 [NAL9602](INFO): SBD MO Status=2, MOMSN=25765, MT Status=2, MTMSN=0 2025-07-10T20:06:49.933Z,1752178009.933 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-07-10T20:07:16.622Z,1752178036.622 [NAL9602](INFO): SBD MO Status=0, MOMSN=25765, MT Status=0, MTMSN=0 2025-07-10T20:07:16.622Z,1752178036.622 [NAL9602](INFO): No messages in MT queue 2025-07-10T20:07:47.324Z,1752178067.324 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T20:08:03.085Z,1752178083.085 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:08:18.024Z,1752178098.024 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:08:32.973Z,1752178112.973 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:08:47.921Z,1752178127.921 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:09:03.332Z,1752178143.332 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:09:18.685Z,1752178158.685 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:09:33.633Z,1752178173.633 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:09:48.589Z,1752178188.589 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:10:04.354Z,1752178204.354 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:10:18.897Z,1752178218.897 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-07-10T20:11:48.202Z,1752178308.202 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T20:11:48.202Z,1752178308.202 [Default:CheckIn:C.Wait] Stopped 2025-07-10T20:11:48.202Z,1752178308.202 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T20:11:48.203Z,1752178308.203 [Default:CheckIn:D] Running Loop=1 2025-07-10T20:11:48.671Z,1752178308.671 [Default:CheckIn:D] Stopped 2025-07-10T20:11:48.671Z,1752178308.671 [Default:CheckIn:E] Running Loop=1 2025-07-10T20:11:49.041Z,1752178309.041 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 183.604948 min 2025-07-10T20:11:49.041Z,1752178309.041 [Default:CheckIn:E] Stopped 2025-07-10T20:11:49.041Z,1752178309.041 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T20:11:49.042Z,1752178309.042 [Default:CheckIn] Stopped 2025-07-10T20:11:49.042Z,1752178309.042 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T20:11:49.042Z,1752178309.042 [Default:CheckIn](INFO): Running loop #30 2025-07-10T20:11:49.042Z,1752178309.042 [Default:CheckIn] Running Loop=30 2025-07-10T20:11:49.042Z,1752178309.042 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T20:11:49.042Z,1752178309.042 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T20:11:51.040Z,1752178311.040 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201150.00,A,3648.17276,N,12147.27407,W,0.428,175.72,100725,,,A*79 2025-07-10T20:11:51.043Z,1752178311.043 [NAL9602](INFO): GPS fix at 20250710T201150: (36.802879, -121.787901) 2025-07-10T20:11:51.059Z,1752178311.059 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T20:11:51.059Z,1752178311.059 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T20:11:59.068Z,1752178319.068 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250710T175300/Courier0066.lzma 2025-07-10T20:12:10.099Z,1752178330.099 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0066.lzma.bak 2025-07-10T20:12:10.099Z,1752178330.099 [DataOverHttps](INFO): SBD MOMSN=25474954 2025-07-10T20:12:36.901Z,1752178356.901 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20250710T175300/Express0067.lzma 2025-07-10T20:12:46.372Z,1752178366.372 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:12:47.943Z,1752178367.943 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0067.lzma.bak 2025-07-10T20:12:47.943Z,1752178367.943 [DataOverHttps](INFO): SBD MOMSN=25474963 2025-07-10T20:12:49.229Z,1752178369.229 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T20:12:49.229Z,1752178369.229 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T20:12:49.229Z,1752178369.229 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T20:13:00.186Z,1752178380.186 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:13:14.321Z,1752178394.321 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:13:28.460Z,1752178408.460 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:13:41.794Z,1752178421.794 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:13:55.127Z,1752178435.127 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:14:02.855Z,1752178442.855 [CBIT](INFO): Clearing failed state for component DropWeight 2025-07-10T20:14:02.855Z,1752178442.855 [DropWeight] No Fault, FailCount= 1 2025-07-10T20:14:08.462Z,1752178448.462 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:14:14.926Z,1752178454.926 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-07-10T20:14:22.209Z,1752178462.209 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:14:35.525Z,1752178475.525 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:14:48.885Z,1752178488.885 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:15:02.421Z,1752178502.421 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:16:53.060Z,1752178613.060 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-07-10T20:17:23.762Z,1752178643.762 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T20:17:24.570Z,1752178644.570 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:17:31.038Z,1752178651.038 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:17:46.386Z,1752178666.386 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:17:50.034Z,1752178670.034 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T20:17:50.035Z,1752178670.035 [Default:CheckIn:C.Wait] Stopped 2025-07-10T20:17:50.035Z,1752178670.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T20:17:50.035Z,1752178670.035 [Default:CheckIn:D] Running Loop=1 2025-07-10T20:17:50.450Z,1752178670.450 [Default:CheckIn:D] Stopped 2025-07-10T20:17:50.450Z,1752178670.450 [Default:CheckIn:E] Running Loop=1 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 189.634587 min 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn:E] Stopped 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn] Stopped 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn](INFO): Running loop #31 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn] Running Loop=31 2025-07-10T20:17:50.842Z,1752178670.842 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T20:17:50.843Z,1752178670.843 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T20:17:52.856Z,1752178672.856 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201752.00,A,3648.16846,N,12147.27594,W,1.361,253.23,100725,,,A*76 2025-07-10T20:17:52.859Z,1752178672.859 [NAL9602](INFO): GPS fix at 20250710T201752: (36.802808, -121.787932) 2025-07-10T20:17:52.870Z,1752178672.870 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T20:17:52.870Z,1752178672.870 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T20:18:00.468Z,1752178680.468 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0069.lzma 2025-07-10T20:18:01.332Z,1752178681.332 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:18:11.511Z,1752178691.511 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0069.lzma.bak 2025-07-10T20:18:11.511Z,1752178691.511 [DataOverHttps](INFO): SBD MOMSN=25474987 2025-07-10T20:18:16.688Z,1752178696.688 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:18:23.567Z,1752178703.567 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-07-10T20:18:23.649Z,1752178703.649 [NAL9602](ERROR): received: +CSQ:0 OK765, 0, 0, 0, 0 OK 2025-07-10T20:18:32.036Z,1752178712.036 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:18:32.042Z,1752178712.042 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2025-07-10T20:18:37.741Z,1752178717.741 [DataOverHttps](INFO): Sending 258 bytes from file Logs/20250710T175300/Express0070.lzma 2025-07-10T20:18:47.389Z,1752178727.389 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:18:48.787Z,1752178728.787 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0070.lzma.bak 2025-07-10T20:18:48.787Z,1752178728.787 [DataOverHttps](INFO): SBD MOMSN=25474990 2025-07-10T20:18:50.261Z,1752178730.261 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T20:18:50.262Z,1752178730.262 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T20:18:50.262Z,1752178730.262 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T20:19:02.050Z,1752178742.050 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:19:17.334Z,1752178757.334 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:19:32.281Z,1752178772.281 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:22:17.932Z,1752178937.932 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:22:32.072Z,1752178952.072 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:22:45.404Z,1752178965.404 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:22:55.510Z,1752178975.510 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-07-10T20:22:59.143Z,1752178979.143 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:23:12.877Z,1752178992.877 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:23:26.222Z,1752179006.222 [NAL9602](INFO): Not Powering down - fast GPS 2025-07-10T20:23:27.016Z,1752179007.016 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:23:40.755Z,1752179020.755 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:23:50.878Z,1752179030.878 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T20:23:50.878Z,1752179030.878 [Default:CheckIn:C.Wait] Stopped 2025-07-10T20:23:50.878Z,1752179030.878 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T20:23:50.878Z,1752179030.878 [Default:CheckIn:D] Running Loop=1 2025-07-10T20:23:51.272Z,1752179031.272 [Default:CheckIn:D] Stopped 2025-07-10T20:23:51.272Z,1752179031.272 [Default:CheckIn:E] Running Loop=1 2025-07-10T20:23:51.678Z,1752179031.678 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 195.648291 min 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn:E] Stopped 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn] Stopped 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn](INFO): Running loop #32 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn] Running Loop=32 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T20:23:51.679Z,1752179031.679 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T20:23:53.684Z,1752179033.684 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202352.00,A,3648.16693,N,12147.27113,W,0.447,253.23,100725,,,A*7E 2025-07-10T20:23:53.694Z,1752179033.694 [NAL9602](INFO): GPS fix at 20250710T202352: (36.802782, -121.787852) 2025-07-10T20:23:53.706Z,1752179033.706 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T20:23:53.706Z,1752179033.706 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-07-10T20:23:54.488Z,1752179034.488 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:23:55.357Z,1752179035.357 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-07-10T20:24:01.276Z,1752179041.276 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250710T175300/Courier0072.lzma 2025-07-10T20:24:02.279Z,1752179042.279 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Courier0072.lzma.bak 2025-07-10T20:24:02.279Z,1752179042.279 [DataOverHttps](INFO): SBD MOMSN=25475007 2025-07-10T20:24:08.226Z,1752179048.226 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:24:18.393Z,1752179058.393 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20250710T175300/Express0073.lzma 2025-07-10T20:24:19.395Z,1752179059.395 [DataOverHttps](INFO): Moved sent file to Logs/20250710T175300/Express0073.lzma.bak 2025-07-10T20:24:19.395Z,1752179059.395 [DataOverHttps](INFO): SBD MOMSN=25475010 2025-07-10T20:24:20.773Z,1752179060.773 [Default:CheckIn:Read_Iridium] Stopped 2025-07-10T20:24:20.774Z,1752179060.774 [Default:CheckIn:C.Wait] Running Loop=1 2025-07-10T20:24:20.774Z,1752179060.774 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-07-10T20:24:21.962Z,1752179061.962 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-07-10T20:26:51.095Z,1752179211.095 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:27:03.209Z,1752179223.209 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:27:14.923Z,1752179234.923 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:27:27.885Z,1752179247.885 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:27:40.402Z,1752179260.402 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:27:53.776Z,1752179273.776 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:28:06.234Z,1752179286.234 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:28:18.763Z,1752179298.763 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:28:31.281Z,1752179311.281 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:28:43.811Z,1752179323.811 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:28:55.927Z,1752179335.927 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:28:56.302Z,1752179336.302 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-07-10T20:29:08.449Z,1752179348.449 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2025-07-10T20:29:14.682Z,1752179354.682 [CommandExec](IMPORTANT): got command quit 2025-07-10T20:29:15.689Z,1752179355.689 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:15.689Z,1752179355.689 [CommandExec](INFO): Uninitializing the command executive. 2025-07-10T20:29:15.689Z,1752179355.689 [CommandExec](INFO): Uninitializing the command scheduler. 2025-07-10T20:29:15.689Z,1752179355.689 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:15.873Z,1752179355.873 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-07-10T20:29:15.873Z,1752179355.873 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-07-10T20:29:15.873Z,1752179355.873 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:15.874Z,1752179355.874 [NavChartDb](INFO): Join timeout helper Thread ID is 8665 2025-07-10T20:29:16.225Z,1752179356.225 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:16.225Z,1752179356.225 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:16.241Z,1752179356.241 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-07-10T20:29:16.241Z,1752179356.241 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:16.241Z,1752179356.241 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8666 2025-07-10T20:29:16.529Z,1752179356.529 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:16.529Z,1752179356.529 [WetLabsBB2FL](INFO): Powering down 2025-07-10T20:29:16.530Z,1752179356.530 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:16.541Z,1752179356.541 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-07-10T20:29:16.541Z,1752179356.541 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:16.541Z,1752179356.541 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8667 2025-07-10T20:29:16.737Z,1752179356.737 [CTD_Seabird](INFO): Powering down 2025-07-10T20:29:16.749Z,1752179356.749 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:16.749Z,1752179356.749 [CTD_Seabird](INFO): Powering down 2025-07-10T20:29:16.761Z,1752179356.761 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:16.765Z,1752179356.765 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-07-10T20:29:16.765Z,1752179356.765 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:16.765Z,1752179356.765 [Radio_Surface](INFO): Join timeout helper Thread ID is 8668 2025-07-10T20:29:17.089Z,1752179357.089 [Radio_Surface](INFO): Powering down 2025-07-10T20:29:17.090Z,1752179357.090 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:17.091Z,1752179357.091 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:17.105Z,1752179357.105 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-07-10T20:29:17.105Z,1752179357.105 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:17.105Z,1752179357.105 [Onboard](INFO): Join timeout helper Thread ID is 8669 2025-07-10T20:29:17.497Z,1752179357.497 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-07-10T20:29:21.336Z,1752179361.336 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-07-10T20:29:21.336Z,1752179361.336 [Default:CheckIn:C.Wait] Stopped 2025-07-10T20:29:21.336Z,1752179361.336 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-07-10T20:29:21.337Z,1752179361.337 [Default:CheckIn:D] Running Loop=1 2025-07-10T20:29:21.577Z,1752179361.577 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:21.577Z,1752179361.577 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:21.586Z,1752179361.586 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-07-10T20:29:21.586Z,1752179361.586 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:21.586Z,1752179361.586 [DataOverHttps](INFO): Join timeout helper Thread ID is 8670 2025-07-10T20:29:21.748Z,1752179361.748 [Default:CheckIn:D] Stopped 2025-07-10T20:29:21.748Z,1752179361.748 [Default:CheckIn:E] Running Loop=1 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 201.156217 min 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn:E] Stopped 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn] Stopped 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn](INFO): Running loop #33 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn] Running Loop=33 2025-07-10T20:29:22.160Z,1752179362.160 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-07-10T20:29:22.161Z,1752179362.161 [Default:CheckIn:Read_GPS] Running Loop=1 2025-07-10T20:29:22.517Z,1752179362.517 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:22.517Z,1752179362.517 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.522Z,1752179362.522 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-07-10T20:29:22.522Z,1752179362.522 [DAT ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.522Z,1752179362.522 [DAT](INFO): Join timeout helper Thread ID is 8671 2025-07-10T20:29:22.733Z,1752179362.733 [DAT](INFO): Powering down 2025-07-10T20:29:22.806Z,1752179362.806 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:22.806Z,1752179362.806 [DAT](INFO): Powering down 2025-07-10T20:29:22.807Z,1752179362.807 [DAT ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.818Z,1752179362.818 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-07-10T20:29:22.818Z,1752179362.818 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.818Z,1752179362.818 [BackseatComponent](INFO): Join timeout helper Thread ID is 8672 2025-07-10T20:29:22.833Z,1752179362.833 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:22.834Z,1752179362.834 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.838Z,1752179362.838 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-07-10T20:29:22.838Z,1752179362.838 [logger ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.838Z,1752179362.838 [logger](INFO): Join timeout helper Thread ID is 8673 2025-07-10T20:29:22.869Z,1752179362.869 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:22.870Z,1752179362.870 [logger ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.874Z,1752179362.874 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-07-10T20:29:22.874Z,1752179362.874 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.874Z,1752179362.874 [CommandLine](INFO): Join timeout helper Thread ID is 8674 2025-07-10T20:29:22.937Z,1752179362.937 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:22.937Z,1752179362.937 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.942Z,1752179362.942 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-07-10T20:29:22.942Z,1752179362.942 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.942Z,1752179362.942 [CommandExec](INFO): Join timeout helper Thread ID is 8675 2025-07-10T20:29:22.946Z,1752179362.946 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-07-10T20:29:22.946Z,1752179362.946 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:22.946Z,1752179362.946 [controlThread](INFO): Join timeout helper Thread ID is 8676 2025-07-10T20:29:22.973Z,1752179362.973 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-07-10T20:29:22.973Z,1752179362.973 [controlThread](DEBUG): Uninitializing ControlThread 2025-07-10T20:29:22.974Z,1752179362.974 [AHRS_M2](INFO): Powering down 2025-07-10T20:29:23.062Z,1752179363.062 [NAL9602](INFO): Powering down 2025-07-10T20:29:23.063Z,1752179363.063 [Sonardyne_Nano](INFO): Powering down 2025-07-10T20:29:23.269Z,1752179363.269 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-07-10T20:29:23.270Z,1752179363.270 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-07-10T20:29:23.270Z,1752179363.270 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-07-10T20:29:23.271Z,1752179363.271 [MissionManager](INFO): Uninitializing Mission Default 2025-07-10T20:29:23.271Z,1752179363.271 [Default] Stopped 2025-07-10T20:29:23.271Z,1752179363.271 [Default](DEBUG): Aggregate::uninitialize Default 2025-07-10T20:29:23.271Z,1752179363.271 [Default:B.GoToSurface] Stopped 2025-07-10T20:29:23.271Z,1752179363.271 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-07-10T20:29:23.271Z,1752179363.271 [Default:CheckIn] Stopped 2025-07-10T20:29:23.271Z,1752179363.271 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-07-10T20:29:23.272Z,1752179363.272 [Default:CheckIn:Read_GPS] Stopped 2025-07-10T20:29:23.275Z,1752179363.275 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-07-10T20:29:23.275Z,1752179363.275 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-07-10T20:29:23.275Z,1752179363.275 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-07-10T20:29:23.275Z,1752179363.275 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-07-10T20:29:23.276Z,1752179363.276 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-07-10T20:29:23.276Z,1752179363.276 [BuoyancyServo](INFO): Powering down 2025-07-10T20:29:23.289Z,1752179363.289 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-07-10T20:29:23.289Z,1752179363.289 [ElevatorServo](INFO): Powering down 2025-07-10T20:29:23.290Z,1752179363.290 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-07-10T20:29:23.290Z,1752179363.290 [MassServo](INFO): Powering down 2025-07-10T20:29:23.291Z,1752179363.291 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-07-10T20:29:23.291Z,1752179363.291 [RudderServo](INFO): Powering down 2025-07-10T20:29:23.292Z,1752179363.292 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-07-10T20:29:23.292Z,1752179363.292 [ThrusterHE](INFO): Powering down 2025-07-10T20:29:23.293Z,1752179363.293 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-07-10T20:29:23.293Z,1752179363.293 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-07-10T20:29:23.293Z,1752179363.293 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-07-10T20:29:23.293Z,1752179363.293 [CBIT](DEBUG): Powering off loads. 2025-07-10T20:29:23.305Z,1752179363.305 [CBIT](DEBUG): Disabling WDT. 2025-07-10T20:29:23.317Z,1752179363.317 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-07-10T20:29:23.317Z,1752179363.317 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-07-10T20:29:23.318Z,1752179363.318 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.363Z,1752179363.363 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.366Z,1752179363.366 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.372Z,1752179363.372 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.378Z,1752179363.378 [DAT ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.417Z,1752179363.417 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.451Z,1752179363.451 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-07-10T20:29:23.451Z,1752179363.451 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-07-10T20:29:23.508Z,1752179363.508 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.514Z,1752179363.514 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.522Z,1752179363.522 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-07-10T20:29:23.611Z,1752179363.611 [logger ThreadHandler](INFO): Thread cancelled.