2025-01-31T17:58:15.487Z,1738346295.487 [CommandExec](IMPORTANT): got command restart logs
2025-01-31T18:00:36.448Z,1738346436.448 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:00:50.565Z,1738346450.565 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:01:00.284Z,1738346460.284 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:01:00.284Z,1738346460.284 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:01:00.284Z,1738346460.284 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:01:00.284Z,1738346460.284 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:01:00.681Z,1738346460.681 [Default:CheckIn:D] Stopped
2025-01-31T18:01:00.681Z,1738346460.681 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:01:01.086Z,1738346461.086 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  8.710379 min 
2025-01-31T18:01:01.086Z,1738346461.086 [Default:CheckIn:E] Stopped
2025-01-31T18:01:01.086Z,1738346461.086 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:01:01.086Z,1738346461.086 [Default:CheckIn] Stopped
2025-01-31T18:01:01.086Z,1738346461.086 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:01:01.086Z,1738346461.086 [Default:CheckIn](INFO): Running loop #2
2025-01-31T18:01:01.087Z,1738346461.087 [Default:CheckIn] Running Loop=2
2025-01-31T18:01:01.087Z,1738346461.087 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:01:01.087Z,1738346461.087 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:01:03.140Z,1738346463.140 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180107.00,A,3648.10409,N,12150.91980,W,1.166,343.89,310125,,,D*7C
2025-01-31T18:01:03.143Z,1738346463.143 [NAL9602](INFO): GPS fix at 20250131T180107: (36.801735, -121.848663)
2025-01-31T18:01:03.154Z,1738346463.154 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:01:03.154Z,1738346463.154 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:01:03.556Z,1738346463.556 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:01:10.080Z,1738346470.080 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250131T053624/Courier0100.lzma
2025-01-31T18:01:11.083Z,1738346471.083 [DataOverHttps](INFO): Moved sent file to Logs/20250131T053624/Courier0100.lzma.bak
2025-01-31T18:01:11.083Z,1738346471.083 [DataOverHttps](INFO): SBD MOMSN=23951776
2025-01-31T18:01:16.922Z,1738346476.922 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:01:26.861Z,1738346486.861 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20250131T175815/Courier0000.lzma
2025-01-31T18:01:27.863Z,1738346487.863 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0000.lzma.bak
2025-01-31T18:01:27.863Z,1738346487.863 [DataOverHttps](INFO): SBD MOMSN=23951778
2025-01-31T18:01:28.551Z,1738346488.551 [NAL9602](INFO): SBD MO Status=2, MOMSN=21662, MT Status=2, MTMSN=0
2025-01-31T18:01:28.552Z,1738346488.552 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T18:01:30.157Z,1738346490.157 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:01:43.576Z,1738346503.576 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20250131T053624/Express0101.lzma
2025-01-31T18:01:43.891Z,1738346503.891 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:01:44.579Z,1738346504.579 [DataOverHttps](INFO): Moved sent file to Logs/20250131T053624/Express0101.lzma.bak
2025-01-31T18:01:44.579Z,1738346504.579 [DataOverHttps](INFO): SBD MOMSN=23951782
2025-01-31T18:01:47.536Z,1738346507.536 [NAL9602](INFO): SBD MO Status=0, MOMSN=21662, MT Status=0, MTMSN=0
2025-01-31T18:01:47.537Z,1738346507.537 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:01:57.225Z,1738346517.225 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:02:00.434Z,1738346520.434 [DataOverHttps](INFO): Sending 412 bytes from file Logs/20250131T175815/Express0001.lzma
2025-01-31T18:02:01.435Z,1738346521.435 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0001.lzma.bak
2025-01-31T18:02:01.435Z,1738346521.435 [DataOverHttps](INFO): SBD MOMSN=23951785
2025-01-31T18:02:02.936Z,1738346522.936 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:02:02.936Z,1738346522.936 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:02:02.936Z,1738346522.936 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:02:10.959Z,1738346530.959 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:02:18.238Z,1738346538.238 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:02:25.100Z,1738346545.100 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:02:39.241Z,1738346559.241 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:02:53.379Z,1738346573.379 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:05:16.005Z,1738346716.005 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:05:22.861Z,1738346722.861 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:05:39.021Z,1738346739.021 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:05:54.372Z,1738346754.372 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:06:10.127Z,1738346770.127 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:06:25.480Z,1738346785.480 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:06:40.850Z,1738346800.850 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:06:56.186Z,1738346816.186 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:07:03.483Z,1738346823.483 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:07:03.483Z,1738346823.483 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:07:03.483Z,1738346823.483 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:07:03.484Z,1738346823.484 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:07:03.877Z,1738346823.877 [Default:CheckIn:D] Stopped
2025-01-31T18:07:03.878Z,1738346823.878 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:07:04.331Z,1738346824.331 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  14.763649 min 
2025-01-31T18:07:04.331Z,1738346824.331 [Default:CheckIn:E] Stopped
2025-01-31T18:07:04.331Z,1738346824.331 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:07:04.331Z,1738346824.331 [Default:CheckIn] Stopped
2025-01-31T18:07:04.331Z,1738346824.331 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:07:04.331Z,1738346824.331 [Default:CheckIn](INFO): Running loop #3
2025-01-31T18:07:04.332Z,1738346824.332 [Default:CheckIn] Running Loop=3
2025-01-31T18:07:04.332Z,1738346824.332 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:07:04.332Z,1738346824.332 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:07:06.297Z,1738346826.297 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180710.00,A,3648.38161,N,12150.42281,W,10.030,70.49,310125,,,D*74
2025-01-31T18:07:06.299Z,1738346826.299 [NAL9602](INFO): GPS fix at 20250131T180710: (36.806360, -121.840380)
2025-01-31T18:07:06.310Z,1738346826.310 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:07:06.310Z,1738346826.310 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:07:11.941Z,1738346831.941 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:07:14.012Z,1738346834.012 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0003.lzma
2025-01-31T18:07:15.015Z,1738346835.015 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0003.lzma.bak
2025-01-31T18:07:15.015Z,1738346835.015 [DataOverHttps](INFO): SBD MOMSN=23951790
2025-01-31T18:07:20.024Z,1738346840.024 [NAL9602](INFO): SBD MO Status=0, MOMSN=21663, MT Status=0, MTMSN=0
2025-01-31T18:07:20.024Z,1738346840.024 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:07:27.292Z,1738346847.292 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:07:30.900Z,1738346850.900 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20250131T175815/Express0005.lzma
2025-01-31T18:07:31.903Z,1738346851.903 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0005.lzma.bak
2025-01-31T18:07:31.903Z,1738346851.903 [DataOverHttps](INFO): SBD MOMSN=23951794
2025-01-31T18:07:33.375Z,1738346853.375 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:07:33.375Z,1738346853.375 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:07:33.376Z,1738346853.376 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:07:50.734Z,1738346870.734 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:09:28.089Z,1738346968.089 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-01-31T18:09:28.089Z,1738346968.089 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5.
2025-01-31T18:09:28.093Z,1738346968.093 [BPC1](FAULT): Failed to receive data from 9 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 9, 10, 11, 14, 34, 35, 52, 53, 59.
2025-01-31T18:12:33.961Z,1738347153.961 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:12:33.961Z,1738347153.961 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:12:33.961Z,1738347153.961 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:12:33.961Z,1738347153.961 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:12:34.344Z,1738347154.344 [Default:CheckIn:D] Stopped
2025-01-31T18:12:34.344Z,1738347154.344 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:12:34.757Z,1738347154.757 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  20.271419 min 
2025-01-31T18:12:34.757Z,1738347154.757 [Default:CheckIn:E] Stopped
2025-01-31T18:12:34.757Z,1738347154.757 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:12:34.757Z,1738347154.757 [Default:CheckIn] Stopped
2025-01-31T18:12:34.757Z,1738347154.757 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:12:34.758Z,1738347154.758 [Default:CheckIn](INFO): Running loop #4
2025-01-31T18:12:34.758Z,1738347154.758 [Default:CheckIn] Running Loop=4
2025-01-31T18:12:34.758Z,1738347154.758 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:12:34.758Z,1738347154.758 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:12:36.764Z,1738347156.764 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181241.00,A,3648.89493,N,12149.36468,W,3.168,45.65,310125,,,D*4A
2025-01-31T18:12:36.774Z,1738347156.774 [NAL9602](INFO): GPS fix at 20250131T181241: (36.814915, -121.822745)
2025-01-31T18:12:36.786Z,1738347156.786 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:12:36.786Z,1738347156.786 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:12:47.253Z,1738347167.253 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20250131T175815/Courier0009.lzma
2025-01-31T18:12:48.255Z,1738347168.255 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0009.lzma.bak
2025-01-31T18:12:48.255Z,1738347168.255 [DataOverHttps](INFO): SBD MOMSN=23951797
2025-01-31T18:12:57.807Z,1738347177.807 [NAL9602](INFO): SBD MO Status=0, MOMSN=21664, MT Status=0, MTMSN=0
2025-01-31T18:12:57.807Z,1738347177.807 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:13:06.025Z,1738347186.025 [DataOverHttps](INFO): Sending 288 bytes from file Logs/20250131T175815/Express0010.lzma
2025-01-31T18:13:07.027Z,1738347187.027 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0010.lzma.bak
2025-01-31T18:13:07.027Z,1738347187.027 [DataOverHttps](INFO): SBD MOMSN=23951800
2025-01-31T18:13:08.318Z,1738347188.318 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:13:08.318Z,1738347188.318 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:13:08.318Z,1738347188.318 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:13:28.506Z,1738347208.506 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:18:08.985Z,1738347488.985 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:18:08.985Z,1738347488.985 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:18:08.985Z,1738347488.985 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:18:08.985Z,1738347488.985 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:18:09.392Z,1738347489.392 [Default:CheckIn:D] Stopped
2025-01-31T18:18:09.392Z,1738347489.392 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:18:09.809Z,1738347489.809 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  25.855558 min 
2025-01-31T18:18:09.809Z,1738347489.809 [Default:CheckIn:E] Stopped
2025-01-31T18:18:09.809Z,1738347489.809 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:18:09.809Z,1738347489.809 [Default:CheckIn] Stopped
2025-01-31T18:18:09.809Z,1738347489.809 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:18:09.810Z,1738347489.810 [Default:CheckIn](INFO): Running loop #5
2025-01-31T18:18:09.810Z,1738347489.810 [Default:CheckIn] Running Loop=5
2025-01-31T18:18:09.810Z,1738347489.810 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:18:09.810Z,1738347489.810 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:18:11.804Z,1738347491.804 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181815.00,A,3648.89855,N,12149.40303,W,7.367,167.38,310125,,,D*7C
2025-01-31T18:18:11.806Z,1738347491.806 [NAL9602](INFO): GPS fix at 20250131T181815: (36.814976, -121.823384)
2025-01-31T18:18:11.818Z,1738347491.818 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:18:11.818Z,1738347491.818 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:18:18.556Z,1738347498.556 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0012.lzma
2025-01-31T18:18:19.559Z,1738347499.559 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0012.lzma.bak
2025-01-31T18:18:19.559Z,1738347499.559 [DataOverHttps](INFO): SBD MOMSN=23951805
2025-01-31T18:18:30.382Z,1738347510.382 [NAL9602](INFO): SBD MO Status=0, MOMSN=21665, MT Status=0, MTMSN=0
2025-01-31T18:18:30.383Z,1738347510.383 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:18:35.149Z,1738347515.149 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20250131T175815/Express0013.lzma
2025-01-31T18:18:36.151Z,1738347516.151 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0013.lzma.bak
2025-01-31T18:18:36.151Z,1738347516.151 [DataOverHttps](INFO): SBD MOMSN=23951808
2025-01-31T18:18:37.671Z,1738347517.671 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:18:37.672Z,1738347517.672 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:18:37.672Z,1738347517.672 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:19:01.086Z,1738347541.086 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:20:36.436Z,1738347636.436 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:20:50.220Z,1738347650.220 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:21:03.551Z,1738347663.551 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:21:16.885Z,1738347676.885 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:21:30.216Z,1738347690.216 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:23:38.392Z,1738347818.392 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:23:38.392Z,1738347818.392 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:23:38.392Z,1738347818.392 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:23:38.392Z,1738347818.392 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:23:38.805Z,1738347818.805 [Default:CheckIn:D] Stopped
2025-01-31T18:23:38.805Z,1738347818.805 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:23:39.212Z,1738347819.212 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  31.345782 min 
2025-01-31T18:23:39.212Z,1738347819.212 [Default:CheckIn:E] Stopped
2025-01-31T18:23:39.213Z,1738347819.213 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:23:39.213Z,1738347819.213 [Default:CheckIn] Stopped
2025-01-31T18:23:39.213Z,1738347819.213 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:23:39.213Z,1738347819.213 [Default:CheckIn](INFO): Running loop #6
2025-01-31T18:23:39.213Z,1738347819.213 [Default:CheckIn] Running Loop=6
2025-01-31T18:23:39.213Z,1738347819.213 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:23:39.214Z,1738347819.214 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:23:41.216Z,1738347821.216 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182345.00,A,3648.47667,N,12149.41727,W,0.700,296.12,310125,,,D*78
2025-01-31T18:23:41.219Z,1738347821.219 [NAL9602](INFO): GPS fix at 20250131T182345: (36.807944, -121.823621)
2025-01-31T18:23:41.250Z,1738347821.250 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:23:41.250Z,1738347821.250 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:23:48.421Z,1738347828.421 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0015.lzma
2025-01-31T18:23:49.423Z,1738347829.423 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0015.lzma.bak
2025-01-31T18:23:49.423Z,1738347829.423 [DataOverHttps](INFO): SBD MOMSN=23951813
2025-01-31T18:24:05.132Z,1738347845.132 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20250131T175815/Express0016.lzma
2025-01-31T18:24:06.135Z,1738347846.135 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0016.lzma.bak
2025-01-31T18:24:06.135Z,1738347846.135 [DataOverHttps](INFO): SBD MOMSN=23951816
2025-01-31T18:24:07.092Z,1738347847.092 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:24:07.108Z,1738347847.108 [NAL9602](INFO): SBD MO Status=0, MOMSN=21666, MT Status=0, MTMSN=0
2025-01-31T18:24:07.108Z,1738347847.108 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:24:07.529Z,1738347847.529 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:24:07.530Z,1738347847.530 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:24:07.530Z,1738347847.530 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:24:22.041Z,1738347862.041 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:24:37.391Z,1738347877.391 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:24:37.818Z,1738347877.818 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:24:52.347Z,1738347892.347 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:25:07.700Z,1738347907.700 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:25:22.656Z,1738347922.656 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:25:37.999Z,1738347937.999 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:25:52.947Z,1738347952.947 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:26:08.299Z,1738347968.299 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:26:22.843Z,1738347982.843 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-01-31T18:28:43.087Z,1738348123.087 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T18:28:43.094Z,1738348123.094 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-01-31T18:28:43.094Z,1738348123.094 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5.
2025-01-31T18:28:43.117Z,1738348123.117 [BPC1](INFO): Received data from all battery sticks.
2025-01-31T18:29:08.191Z,1738348148.191 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:29:08.191Z,1738348148.191 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:29:08.191Z,1738348148.191 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:29:08.192Z,1738348148.192 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:29:08.601Z,1738348148.601 [Default:CheckIn:D] Stopped
2025-01-31T18:29:08.601Z,1738348148.601 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:29:09.005Z,1738348149.005 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  36.842371 min 
2025-01-31T18:29:09.005Z,1738348149.005 [Default:CheckIn:E] Stopped
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn] Stopped
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn](INFO): Running loop #7
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn] Running Loop=7
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:29:09.006Z,1738348149.006 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:29:11.016Z,1738348151.016 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182915.00,A,3648.52962,N,12149.39012,W,0.758,330.97,310125,,,D*7A
2025-01-31T18:29:11.026Z,1738348151.026 [NAL9602](INFO): GPS fix at 20250131T182915: (36.808827, -121.823169)
2025-01-31T18:29:11.037Z,1738348151.037 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:29:11.038Z,1738348151.038 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:29:19.388Z,1738348159.388 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20250131T175815/Courier0018.lzma
2025-01-31T18:29:20.391Z,1738348160.391 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0018.lzma.bak
2025-01-31T18:29:20.391Z,1738348160.391 [DataOverHttps](INFO): SBD MOMSN=23951820
2025-01-31T18:29:41.740Z,1738348181.740 [NAL9602](INFO): SBD MO Status=2, MOMSN=21667, MT Status=2, MTMSN=0
2025-01-31T18:29:41.740Z,1738348181.740 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T18:29:41.857Z,1738348181.857 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20250131T175815/Express0019.lzma
2025-01-31T18:29:42.859Z,1738348182.859 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0019.lzma.bak
2025-01-31T18:29:42.859Z,1738348182.859 [DataOverHttps](INFO): SBD MOMSN=23951823
2025-01-31T18:29:44.181Z,1738348184.181 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:29:44.181Z,1738348184.181 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:29:44.181Z,1738348184.181 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:30:32.240Z,1738348232.240 [NAL9602](INFO): SBD MO Status=2, MOMSN=21667, MT Status=2, MTMSN=0
2025-01-31T18:30:32.240Z,1738348232.240 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T18:30:54.140Z,1738348254.140 [NAL9602](INFO): SBD MO Status=0, MOMSN=21667, MT Status=0, MTMSN=0
2025-01-31T18:30:54.140Z,1738348254.140 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:31:24.825Z,1738348284.825 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:34:44.848Z,1738348484.848 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:34:44.848Z,1738348484.848 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:34:44.848Z,1738348484.848 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:34:44.848Z,1738348484.848 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:34:45.258Z,1738348485.258 [Default:CheckIn:D] Stopped
2025-01-31T18:34:45.258Z,1738348485.258 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:34:45.675Z,1738348485.675 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  42.453324 min 
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn:E] Stopped
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn] Stopped
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn](INFO): Running loop #8
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn] Running Loop=8
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:34:45.676Z,1738348485.676 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:34:47.668Z,1738348487.668 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183451.00,A,3648.58284,N,12149.38394,W,0.583,320.25,310125,,,D*7F
2025-01-31T18:34:47.670Z,1738348487.670 [NAL9602](INFO): GPS fix at 20250131T183451: (36.809714, -121.823066)
2025-01-31T18:34:47.690Z,1738348487.690 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:34:47.690Z,1738348487.690 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:34:55.296Z,1738348495.296 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0021.lzma
2025-01-31T18:34:56.299Z,1738348496.299 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0021.lzma.bak
2025-01-31T18:34:56.299Z,1738348496.299 [DataOverHttps](INFO): SBD MOMSN=23951827
2025-01-31T18:35:02.215Z,1738348502.215 [NAL9602](INFO): SBD MO Status=0, MOMSN=21668, MT Status=0, MTMSN=0
2025-01-31T18:35:02.216Z,1738348502.216 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:35:12.076Z,1738348512.076 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20250131T175815/Express0022.lzma
2025-01-31T18:35:13.079Z,1738348513.079 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0022.lzma.bak
2025-01-31T18:35:13.079Z,1738348513.079 [DataOverHttps](INFO): SBD MOMSN=23951830
2025-01-31T18:35:14.345Z,1738348514.345 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:35:14.345Z,1738348514.345 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:35:14.345Z,1738348514.345 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:35:32.922Z,1738348532.922 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:38:46.981Z,1738348726.981 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-01-31T18:40:14.979Z,1738348814.979 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:40:14.979Z,1738348814.979 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:40:14.980Z,1738348814.980 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:40:14.980Z,1738348814.980 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:40:15.388Z,1738348815.388 [Default:CheckIn:D] Stopped
2025-01-31T18:40:15.388Z,1738348815.388 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:40:15.790Z,1738348815.790 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  47.955497 min 
2025-01-31T18:40:15.790Z,1738348815.790 [Default:CheckIn:E] Stopped
2025-01-31T18:40:15.790Z,1738348815.790 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:40:15.790Z,1738348815.790 [Default:CheckIn] Stopped
2025-01-31T18:40:15.790Z,1738348815.790 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:40:15.791Z,1738348815.791 [Default:CheckIn](INFO): Running loop #9
2025-01-31T18:40:15.791Z,1738348815.791 [Default:CheckIn] Running Loop=9
2025-01-31T18:40:15.791Z,1738348815.791 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:40:15.791Z,1738348815.791 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:40:17.804Z,1738348817.804 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184021.00,A,3648.55829,N,12149.16850,W,3.965,104.19,310125,,,D*78
2025-01-31T18:40:17.814Z,1738348817.814 [NAL9602](INFO): GPS fix at 20250131T184021: (36.809305, -121.819475)
2025-01-31T18:40:17.825Z,1738348817.825 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:40:17.825Z,1738348817.825 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:40:25.564Z,1738348825.564 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0024.lzma
2025-01-31T18:40:26.567Z,1738348826.567 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0024.lzma.bak
2025-01-31T18:40:26.567Z,1738348826.567 [DataOverHttps](INFO): SBD MOMSN=23951834
2025-01-31T18:40:40.424Z,1738348840.424 [NAL9602](INFO): SBD MO Status=0, MOMSN=21669, MT Status=0, MTMSN=0
2025-01-31T18:40:40.424Z,1738348840.424 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:40:42.208Z,1738348842.208 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20250131T175815/Express0025.lzma
2025-01-31T18:40:43.211Z,1738348843.211 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0025.lzma.bak
2025-01-31T18:40:43.211Z,1738348843.211 [DataOverHttps](INFO): SBD MOMSN=23951837
2025-01-31T18:40:44.485Z,1738348844.485 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:40:44.485Z,1738348844.485 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:40:44.485Z,1738348844.485 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:41:11.190Z,1738348871.190 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:45:45.175Z,1738349145.175 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:45:45.175Z,1738349145.175 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:45:45.175Z,1738349145.175 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:45:45.175Z,1738349145.175 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:45:45.601Z,1738349145.601 [Default:CheckIn:D] Stopped
2025-01-31T18:45:45.601Z,1738349145.601 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:45:45.000Z,1738349146.000 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  53.458972 min 
2025-01-31T18:45:45.000Z,1738349146.000 [Default:CheckIn:E] Stopped
2025-01-31T18:45:46.000Z,1738349146.000 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:45:46.000Z,1738349146.000 [Default:CheckIn] Stopped
2025-01-31T18:45:46.000Z,1738349146.000 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:45:46.000Z,1738349146.000 [Default:CheckIn](INFO): Running loop #10
2025-01-31T18:45:46.000Z,1738349146.000 [Default:CheckIn] Running Loop=10
2025-01-31T18:45:46.001Z,1738349146.001 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:45:46.001Z,1738349146.001 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:45:47.992Z,1738349147.992 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184552.00,A,3648.44125,N,12148.73952,W,3.985,112.64,310125,,,D*7E
2025-01-31T18:45:47.994Z,1738349147.994 [NAL9602](INFO): GPS fix at 20250131T184552: (36.807354, -121.812325)
2025-01-31T18:45:48.005Z,1738349148.005 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:45:48.005Z,1738349148.005 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:45:55.836Z,1738349155.836 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0027.lzma
2025-01-31T18:45:56.839Z,1738349156.839 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0027.lzma.bak
2025-01-31T18:45:56.839Z,1738349156.839 [DataOverHttps](INFO): SBD MOMSN=23951841
2025-01-31T18:46:15.480Z,1738349175.480 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20250131T175815/Express0028.lzma
2025-01-31T18:46:16.483Z,1738349176.483 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0028.lzma.bak
2025-01-31T18:46:16.483Z,1738349176.483 [DataOverHttps](INFO): SBD MOMSN=23951844
2025-01-31T18:46:17.924Z,1738349177.924 [NAL9602](INFO): SBD MO Status=2, MOMSN=21670, MT Status=2, MTMSN=0
2025-01-31T18:46:17.924Z,1738349177.924 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T18:46:17.943Z,1738349177.943 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:46:17.943Z,1738349177.943 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:46:17.943Z,1738349177.943 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:47:51.400Z,1738349271.400 [NAL9602](INFO): SBD MO Status=0, MOMSN=21670, MT Status=0, MTMSN=0
2025-01-31T18:47:51.400Z,1738349271.400 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:48:22.106Z,1738349302.106 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:48:48.861Z,1738349328.861 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-01-31T18:51:18.679Z,1738349478.679 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:51:18.679Z,1738349478.679 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:51:18.679Z,1738349478.679 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:51:18.680Z,1738349478.680 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:51:19.072Z,1738349479.072 [Default:CheckIn:D] Stopped
2025-01-31T18:51:19.072Z,1738349479.072 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:51:19.477Z,1738349479.477 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  59.016886 min 
2025-01-31T18:51:19.477Z,1738349479.477 [Default:CheckIn:E] Stopped
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn] Stopped
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn](INFO): Running loop #11
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn] Running Loop=11
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:51:19.478Z,1738349479.478 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:51:21.492Z,1738349481.492 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185125.00,A,3648.35689,N,12148.28066,W,4.082,96.87,310125,,,D*45
2025-01-31T18:51:21.503Z,1738349481.503 [NAL9602](INFO): GPS fix at 20250131T185125: (36.805948, -121.804678)
2025-01-31T18:51:21.514Z,1738349481.514 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:51:21.514Z,1738349481.514 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:51:28.940Z,1738349488.940 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0030.lzma
2025-01-31T18:51:29.943Z,1738349489.943 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0030.lzma.bak
2025-01-31T18:51:29.943Z,1738349489.943 [DataOverHttps](INFO): SBD MOMSN=23951848
2025-01-31T18:51:47.248Z,1738349507.248 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20250131T175815/Express0031.lzma
2025-01-31T18:51:48.251Z,1738349508.251 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0031.lzma.bak
2025-01-31T18:51:48.251Z,1738349508.251 [DataOverHttps](INFO): SBD MOMSN=23951851
2025-01-31T18:51:49.375Z,1738349509.375 [NAL9602](INFO): SBD MO Status=2, MOMSN=21671, MT Status=2, MTMSN=0
2025-01-31T18:51:49.376Z,1738349509.376 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T18:51:49.826Z,1738349509.826 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:51:49.826Z,1738349509.826 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:51:49.826Z,1738349509.826 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:52:07.156Z,1738349527.156 [NAL9602](INFO): SBD MO Status=0, MOMSN=21671, MT Status=0, MTMSN=0
2025-01-31T18:52:07.156Z,1738349527.156 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:52:37.854Z,1738349557.854 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T18:56:50.446Z,1738349810.446 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T18:56:50.446Z,1738349810.446 [Default:CheckIn:C.Wait] Stopped
2025-01-31T18:56:50.446Z,1738349810.446 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T18:56:50.446Z,1738349810.446 [Default:CheckIn:D] Running Loop=1
2025-01-31T18:56:50.856Z,1738349810.856 [Default:CheckIn:D] Stopped
2025-01-31T18:56:50.857Z,1738349810.857 [Default:CheckIn:E] Running Loop=1
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  64.546631 min 
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn:E] Stopped
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn] Stopped
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn](INFO): Running loop #12
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn] Running Loop=12
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T18:56:51.236Z,1738349811.236 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T18:56:53.235Z,1738349813.235 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185657.00,A,3648.27230,N,12147.80477,W,4.276,97.15,310125,,,D*48
2025-01-31T18:56:53.247Z,1738349813.247 [NAL9602](INFO): GPS fix at 20250131T185657: (36.804538, -121.796746)
2025-01-31T18:56:53.259Z,1738349813.259 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T18:56:53.259Z,1738349813.259 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T18:57:00.208Z,1738349820.208 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0033.lzma
2025-01-31T18:57:01.211Z,1738349821.211 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0033.lzma.bak
2025-01-31T18:57:01.211Z,1738349821.211 [DataOverHttps](INFO): SBD MOMSN=23951855
2025-01-31T18:57:16.796Z,1738349836.796 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20250131T175815/Express0034.lzma
2025-01-31T18:57:17.799Z,1738349837.799 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0034.lzma.bak
2025-01-31T18:57:17.799Z,1738349837.799 [DataOverHttps](INFO): SBD MOMSN=23951858
2025-01-31T18:57:19.106Z,1738349839.106 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T18:57:19.106Z,1738349839.106 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T18:57:19.106Z,1738349839.106 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T18:57:22.723Z,1738349842.723 [NAL9602](INFO): SBD MO Status=0, MOMSN=21672, MT Status=0, MTMSN=0
2025-01-31T18:57:22.724Z,1738349842.724 [NAL9602](INFO): No messages in MT queue
2025-01-31T18:57:53.426Z,1738349873.426 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:02:19.676Z,1738350139.676 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:02:19.677Z,1738350139.677 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:02:19.677Z,1738350139.677 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:02:19.677Z,1738350139.677 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:02:20.076Z,1738350140.076 [Default:CheckIn:D] Stopped
2025-01-31T19:02:20.076Z,1738350140.076 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:02:20.485Z,1738350140.485 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  70.033618 min 
2025-01-31T19:02:20.485Z,1738350140.485 [Default:CheckIn:E] Stopped
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn] Stopped
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn](INFO): Running loop #13
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn] Running Loop=13
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:02:20.486Z,1738350140.486 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:02:22.496Z,1738350142.496 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190226.00,A,3648.40216,N,12147.36485,W,0.700,51.86,310125,,,D*4B
2025-01-31T19:02:22.498Z,1738350142.498 [NAL9602](INFO): GPS fix at 20250131T190226: (36.806703, -121.789414)
2025-01-31T19:02:22.509Z,1738350142.509 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:02:22.509Z,1738350142.509 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:02:29.436Z,1738350149.436 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0036.lzma
2025-01-31T19:02:30.439Z,1738350150.439 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0036.lzma.bak
2025-01-31T19:02:30.439Z,1738350150.439 [DataOverHttps](INFO): SBD MOMSN=23951862
2025-01-31T19:02:47.000Z,1738350168.000 [NAL9602](INFO): SBD MO Status=0, MOMSN=21673, MT Status=0, MTMSN=0
2025-01-31T19:02:47.000Z,1738350168.000 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:02:53.809Z,1738350173.809 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20250131T175815/Express0037.lzma
2025-01-31T19:02:54.815Z,1738350174.815 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0037.lzma.bak
2025-01-31T19:02:54.815Z,1738350174.815 [DataOverHttps](INFO): SBD MOMSN=23951865
2025-01-31T19:02:56.614Z,1738350176.614 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:02:56.614Z,1738350176.614 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:02:56.614Z,1738350176.614 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:03:18.790Z,1738350198.790 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:07:57.160Z,1738350477.160 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:07:57.160Z,1738350477.160 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:07:57.160Z,1738350477.160 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:07:57.160Z,1738350477.160 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:07:57.570Z,1738350477.570 [Default:CheckIn:D] Stopped
2025-01-31T19:07:57.570Z,1738350477.570 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:07:57.980Z,1738350477.980 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  75.658521 min 
2025-01-31T19:07:57.980Z,1738350477.980 [Default:CheckIn:E] Stopped
2025-01-31T19:07:57.980Z,1738350477.980 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:07:57.980Z,1738350477.980 [Default:CheckIn] Stopped
2025-01-31T19:07:57.980Z,1738350477.980 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:07:57.981Z,1738350477.981 [Default:CheckIn](INFO): Running loop #14
2025-01-31T19:07:57.981Z,1738350477.981 [Default:CheckIn] Running Loop=14
2025-01-31T19:07:57.981Z,1738350477.981 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:07:57.981Z,1738350477.981 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:07:59.984Z,1738350479.984 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190804.00,A,3648.40664,N,12147.12479,W,3.654,183.42,310125,,,D*70
2025-01-31T19:07:59.987Z,1738350479.987 [NAL9602](INFO): GPS fix at 20250131T190804: (36.806777, -121.785413)
2025-01-31T19:08:00.016Z,1738350480.016 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:08:00.016Z,1738350480.016 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:08:06.932Z,1738350486.932 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20250131T175815/Courier0039.lzma
2025-01-31T19:08:07.935Z,1738350487.935 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0039.lzma.bak
2025-01-31T19:08:07.935Z,1738350487.935 [DataOverHttps](INFO): SBD MOMSN=23951869
2025-01-31T19:08:17.756Z,1738350497.756 [NAL9602](INFO): SBD MO Status=0, MOMSN=21674, MT Status=0, MTMSN=0
2025-01-31T19:08:17.756Z,1738350497.756 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:08:23.564Z,1738350503.564 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20250131T175815/Express0040.lzma
2025-01-31T19:08:24.567Z,1738350504.567 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0040.lzma.bak
2025-01-31T19:08:24.567Z,1738350504.567 [DataOverHttps](INFO): SBD MOMSN=23951872
2025-01-31T19:08:25.856Z,1738350505.856 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:08:25.856Z,1738350505.856 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:08:25.856Z,1738350505.856 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:08:48.454Z,1738350528.454 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:13:26.415Z,1738350806.415 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:13:26.415Z,1738350806.415 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:13:26.415Z,1738350806.415 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:13:26.415Z,1738350806.415 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:13:26.828Z,1738350806.828 [Default:CheckIn:D] Stopped
2025-01-31T19:13:26.828Z,1738350806.828 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:13:27.235Z,1738350807.235 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  81.146167 min 
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn:E] Stopped
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn] Stopped
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn](INFO): Running loop #15
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn] Running Loop=15
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:13:27.236Z,1738350807.236 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:13:29.240Z,1738350809.240 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191333.00,A,3648.13160,N,12147.19553,W,1.516,243.92,310125,,,D*7C
2025-01-31T19:13:29.242Z,1738350809.242 [NAL9602](INFO): GPS fix at 20250131T191333: (36.802193, -121.786592)
2025-01-31T19:13:29.278Z,1738350809.278 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:13:29.278Z,1738350809.278 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:13:36.984Z,1738350816.984 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0042.lzma
2025-01-31T19:13:37.987Z,1738350817.987 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0042.lzma.bak
2025-01-31T19:13:37.987Z,1738350817.987 [DataOverHttps](INFO): SBD MOMSN=23951876
2025-01-31T19:13:39.747Z,1738350819.747 [NAL9602](INFO): SBD MO Status=0, MOMSN=21675, MT Status=0, MTMSN=0
2025-01-31T19:13:39.747Z,1738350819.747 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:13:53.577Z,1738350833.577 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20250131T175815/Express0043.lzma
2025-01-31T19:13:54.579Z,1738350834.579 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0043.lzma.bak
2025-01-31T19:13:54.579Z,1738350834.579 [DataOverHttps](INFO): SBD MOMSN=23951879
2025-01-31T19:13:55.915Z,1738350835.915 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:13:55.915Z,1738350835.915 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:13:55.915Z,1738350835.915 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:14:10.446Z,1738350850.446 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:18:56.484Z,1738351136.484 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:18:56.484Z,1738351136.484 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:18:56.484Z,1738351136.484 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:18:56.484Z,1738351136.484 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:18:56.893Z,1738351136.893 [Default:CheckIn:D] Stopped
2025-01-31T19:18:56.893Z,1738351136.893 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:18:57.299Z,1738351137.299 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  86.647233 min 
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn:E] Stopped
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn] Stopped
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn](INFO): Running loop #16
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn] Running Loop=16
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:18:57.300Z,1738351137.300 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:18:59.308Z,1738351139.308 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191903.00,A,3648.13028,N,12147.21080,W,0.019,286.94,310125,,,D*7C
2025-01-31T19:18:59.310Z,1738351139.310 [NAL9602](INFO): GPS fix at 20250131T191903: (36.802171, -121.786847)
2025-01-31T19:18:59.336Z,1738351139.336 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:18:59.336Z,1738351139.336 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:19:06.160Z,1738351146.160 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0045.lzma
2025-01-31T19:19:07.163Z,1738351147.163 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0045.lzma.bak
2025-01-31T19:19:07.163Z,1738351147.163 [DataOverHttps](INFO): SBD MOMSN=23951883
2025-01-31T19:19:22.801Z,1738351162.801 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20250131T175815/Express0046.lzma
2025-01-31T19:19:23.803Z,1738351163.803 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0046.lzma.bak
2025-01-31T19:19:23.803Z,1738351163.803 [DataOverHttps](INFO): SBD MOMSN=23951886
2025-01-31T19:19:25.170Z,1738351165.170 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:19:25.170Z,1738351165.170 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:19:25.170Z,1738351165.170 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:19:44.151Z,1738351184.151 [NAL9602](INFO): SBD MO Status=0, MOMSN=21676, MT Status=0, MTMSN=0
2025-01-31T19:19:44.152Z,1738351184.152 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:20:14.848Z,1738351214.848 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:24:25.807Z,1738351465.807 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:24:25.808Z,1738351465.808 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:24:25.808Z,1738351465.808 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:24:25.808Z,1738351465.808 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:24:26.217Z,1738351466.217 [Default:CheckIn:D] Stopped
2025-01-31T19:24:26.217Z,1738351466.217 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  92.135978 min 
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn:E] Stopped
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn] Stopped
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn](INFO): Running loop #17
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn] Running Loop=17
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:24:26.624Z,1738351466.624 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:24:28.627Z,1738351468.627 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192432.00,A,3648.15533,N,12147.19397,W,1.866,4.63,310125,,,D*76
2025-01-31T19:24:28.629Z,1738351468.629 [NAL9602](INFO): GPS fix at 20250131T192432: (36.802589, -121.786566)
2025-01-31T19:24:28.655Z,1738351468.655 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:24:28.655Z,1738351468.655 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:24:35.252Z,1738351475.252 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0048.lzma
2025-01-31T19:24:36.255Z,1738351476.255 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0048.lzma.bak
2025-01-31T19:24:36.255Z,1738351476.255 [DataOverHttps](INFO): SBD MOMSN=23951890
2025-01-31T19:24:45.199Z,1738351485.199 [NAL9602](INFO): SBD MO Status=0, MOMSN=21677, MT Status=0, MTMSN=0
2025-01-31T19:24:45.199Z,1738351485.199 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:24:54.920Z,1738351494.920 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20250131T175815/Express0049.lzma
2025-01-31T19:24:55.923Z,1738351495.923 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0049.lzma.bak
2025-01-31T19:24:55.923Z,1738351495.923 [DataOverHttps](INFO): SBD MOMSN=23951893
2025-01-31T19:24:57.384Z,1738351497.384 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:24:57.384Z,1738351497.384 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:24:57.384Z,1738351497.384 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:25:15.945Z,1738351515.945 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:29:50.259Z,1738351790.259 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:29:57.954Z,1738351797.954 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:29:57.954Z,1738351797.954 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:29:57.954Z,1738351797.954 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:29:57.954Z,1738351797.954 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:29:58.367Z,1738351798.367 [Default:CheckIn:D] Stopped
2025-01-31T19:29:58.368Z,1738351798.368 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:29:58.798Z,1738351798.798 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  97.671818 min 
2025-01-31T19:29:58.798Z,1738351798.798 [Default:CheckIn:E] Stopped
2025-01-31T19:29:58.798Z,1738351798.798 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:29:58.798Z,1738351798.798 [Default:CheckIn] Stopped
2025-01-31T19:29:58.799Z,1738351798.799 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:29:58.799Z,1738351798.799 [Default:CheckIn](INFO): Running loop #18
2025-01-31T19:29:58.799Z,1738351798.799 [Default:CheckIn] Running Loop=18
2025-01-31T19:29:58.799Z,1738351798.799 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:29:58.799Z,1738351798.799 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:30:00.785Z,1738351800.785 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193004.00,A,3648.15055,N,12147.22118,W,0.019,227.41,310125,,,D*7C
2025-01-31T19:30:00.787Z,1738351800.787 [NAL9602](INFO): GPS fix at 20250131T193004: (36.802509, -121.787020)
2025-01-31T19:30:00.798Z,1738351800.798 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:30:00.799Z,1738351800.799 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:30:05.612Z,1738351805.612 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:30:08.824Z,1738351808.824 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0051.lzma
2025-01-31T19:30:09.827Z,1738351809.827 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0051.lzma.bak
2025-01-31T19:30:09.827Z,1738351809.827 [DataOverHttps](INFO): SBD MOMSN=23951897
2025-01-31T19:30:20.998Z,1738351820.998 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:30:27.032Z,1738351827.032 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20250131T175815/Express0052.lzma
2025-01-31T19:30:27.860Z,1738351827.860 [NAL9602](INFO): SBD MO Status=2, MOMSN=21678, MT Status=2, MTMSN=0
2025-01-31T19:30:27.860Z,1738351827.860 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T19:30:28.039Z,1738351828.039 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0052.lzma.bak
2025-01-31T19:30:28.039Z,1738351828.039 [DataOverHttps](INFO): SBD MOMSN=23951900
2025-01-31T19:30:29.484Z,1738351829.484 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:30:29.484Z,1738351829.484 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:30:29.484Z,1738351829.484 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:30:35.940Z,1738351835.940 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:30:38.772Z,1738351838.772 [NAL9602](INFO): SBD MO Status=0, MOMSN=21678, MT Status=0, MTMSN=0
2025-01-31T19:30:38.772Z,1738351838.772 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:30:51.305Z,1738351851.305 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:31:06.643Z,1738351866.643 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:31:09.478Z,1738351869.478 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:31:21.591Z,1738351881.591 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:31:36.943Z,1738351896.943 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:31:52.700Z,1738351912.700 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:32:07.245Z,1738351927.245 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-01-31T19:34:29.855Z,1738352069.855 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2025-01-31T19:34:36.723Z,1738352076.723 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:34:50.864Z,1738352090.864 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:35:04.599Z,1738352104.599 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:35:18.337Z,1738352118.337 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:35:30.066Z,1738352130.066 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:35:30.066Z,1738352130.066 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:35:30.066Z,1738352130.066 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:35:30.067Z,1738352130.067 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:35:30.476Z,1738352130.476 [Default:CheckIn:D] Stopped
2025-01-31T19:35:30.476Z,1738352130.476 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:35:30.877Z,1738352130.877 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  103.206966 min 
2025-01-31T19:35:30.877Z,1738352130.877 [Default:CheckIn:E] Stopped
2025-01-31T19:35:30.877Z,1738352130.877 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:35:30.878Z,1738352130.878 [Default:CheckIn] Stopped
2025-01-31T19:35:30.878Z,1738352130.878 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:35:30.878Z,1738352130.878 [Default:CheckIn](INFO): Running loop #19
2025-01-31T19:35:30.878Z,1738352130.878 [Default:CheckIn] Running Loop=19
2025-01-31T19:35:30.878Z,1738352130.878 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:35:30.878Z,1738352130.878 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:35:32.072Z,1738352132.072 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:35:32.900Z,1738352132.900 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193537.00,A,3648.14313,N,12147.22822,W,0.039,206.34,310125,,,D*7A
2025-01-31T19:35:32.903Z,1738352132.903 [NAL9602](INFO): GPS fix at 20250131T193537: (36.802385, -121.787137)
2025-01-31T19:35:32.934Z,1738352132.934 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:35:32.934Z,1738352132.934 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:35:40.480Z,1738352140.480 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0054.lzma
2025-01-31T19:35:41.483Z,1738352141.483 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0054.lzma.bak
2025-01-31T19:35:41.483Z,1738352141.483 [DataOverHttps](INFO): SBD MOMSN=23951904
2025-01-31T19:35:43.791Z,1738352143.791 [NAL9602](INFO): SBD MO Status=0, MOMSN=21679, MT Status=0, MTMSN=0
2025-01-31T19:35:43.791Z,1738352143.791 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:35:46.213Z,1738352146.213 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:35:57.189Z,1738352157.189 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250131T175815/Express0055.lzma
2025-01-31T19:35:58.194Z,1738352158.194 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0055.lzma.bak
2025-01-31T19:35:58.194Z,1738352158.194 [DataOverHttps](INFO): SBD MOMSN=23951907
2025-01-31T19:35:59.608Z,1738352159.608 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:35:59.609Z,1738352159.609 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:35:59.609Z,1738352159.609 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:35:59.948Z,1738352159.948 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:36:13.684Z,1738352173.684 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:36:14.510Z,1738352174.510 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:36:27.419Z,1738352187.419 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:36:41.963Z,1738352201.963 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:39:12.259Z,1738352352.259 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:39:18.723Z,1738352358.723 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:39:33.673Z,1738352373.673 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:39:48.217Z,1738352388.217 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:40:02.016Z,1738352402.016 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-01-31T19:40:03.568Z,1738352403.568 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:40:18.921Z,1738352418.921 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:40:33.872Z,1738352433.872 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:40:48.817Z,1738352448.817 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:41:00.141Z,1738352460.141 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:41:00.141Z,1738352460.141 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:41:00.141Z,1738352460.141 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:41:00.142Z,1738352460.142 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:41:00.557Z,1738352460.557 [Default:CheckIn:D] Stopped
2025-01-31T19:41:00.557Z,1738352460.557 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:41:00.953Z,1738352460.953 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  108.708301 min 
2025-01-31T19:41:00.953Z,1738352460.953 [Default:CheckIn:E] Stopped
2025-01-31T19:41:00.953Z,1738352460.953 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:41:00.953Z,1738352460.953 [Default:CheckIn] Stopped
2025-01-31T19:41:00.953Z,1738352460.953 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:41:00.954Z,1738352460.954 [Default:CheckIn](INFO): Running loop #20
2025-01-31T19:41:00.954Z,1738352460.954 [Default:CheckIn] Running Loop=20
2025-01-31T19:41:00.954Z,1738352460.954 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:41:00.954Z,1738352460.954 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:41:02.959Z,1738352462.959 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194107.00,A,3648.14314,N,12147.22851,W,0.019,206.34,310125,,,D*7B
2025-01-31T19:41:02.962Z,1738352462.962 [NAL9602](INFO): GPS fix at 20250131T194107: (36.802386, -121.787142)
2025-01-31T19:41:02.974Z,1738352462.974 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:41:02.974Z,1738352462.974 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:41:04.167Z,1738352464.167 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:41:09.988Z,1738352469.988 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0057.lzma
2025-01-31T19:41:10.994Z,1738352470.994 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0057.lzma.bak
2025-01-31T19:41:10.994Z,1738352470.994 [DataOverHttps](INFO): SBD MOMSN=23951911
2025-01-31T19:41:17.103Z,1738352477.103 [NAL9602](INFO): SBD MO Status=0, MOMSN=21680, MT Status=0, MTMSN=0
2025-01-31T19:41:17.104Z,1738352477.104 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:41:19.116Z,1738352479.116 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:41:26.612Z,1738352486.612 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250131T175815/Express0058.lzma
2025-01-31T19:41:27.615Z,1738352487.615 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0058.lzma.bak
2025-01-31T19:41:27.615Z,1738352487.615 [DataOverHttps](INFO): SBD MOMSN=23951914
2025-01-31T19:41:28.830Z,1738352488.830 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:41:28.830Z,1738352488.830 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:41:28.830Z,1738352488.830 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:41:47.864Z,1738352507.864 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:43:54.655Z,1738352634.655 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:44:07.987Z,1738352647.987 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:44:21.723Z,1738352661.723 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:44:35.951Z,1738352675.951 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:44:50.026Z,1738352690.026 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:45:04.575Z,1738352704.575 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:45:18.715Z,1738352718.715 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:45:32.047Z,1738352732.047 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:45:45.784Z,1738352745.784 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:45:59.923Z,1738352759.923 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:46:12.851Z,1738352772.851 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:46:29.436Z,1738352789.436 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:46:29.436Z,1738352789.436 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:46:29.436Z,1738352789.436 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:46:29.436Z,1738352789.436 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:46:29.847Z,1738352789.847 [Default:CheckIn:D] Stopped
2025-01-31T19:46:29.847Z,1738352789.847 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:46:30.237Z,1738352790.237 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  114.196452 min 
2025-01-31T19:46:30.237Z,1738352790.237 [Default:CheckIn:E] Stopped
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn] Stopped
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn](INFO): Running loop #21
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn] Running Loop=21
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:46:30.238Z,1738352790.238 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:46:32.252Z,1738352792.252 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194636.00,A,3648.14290,N,12147.22915,W,0.019,206.34,310125,,,D*72
2025-01-31T19:46:32.254Z,1738352792.254 [NAL9602](INFO): GPS fix at 20250131T194636: (36.802382, -121.787153)
2025-01-31T19:46:32.268Z,1738352792.268 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:46:32.268Z,1738352792.268 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:46:39.968Z,1738352799.968 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0060.lzma
2025-01-31T19:46:40.971Z,1738352800.971 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0060.lzma.bak
2025-01-31T19:46:40.971Z,1738352800.971 [DataOverHttps](INFO): SBD MOMSN=23951918
2025-01-31T19:46:46.605Z,1738352806.605 [NAL9602](INFO): SBD MO Status=0, MOMSN=21681, MT Status=0, MTMSN=0
2025-01-31T19:46:46.617Z,1738352806.617 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:46:59.644Z,1738352819.644 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20250131T175815/Express0061.lzma
2025-01-31T19:47:00.647Z,1738352820.647 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0061.lzma.bak
2025-01-31T19:47:00.647Z,1738352820.647 [DataOverHttps](INFO): SBD MOMSN=23951921
2025-01-31T19:47:01.890Z,1738352821.890 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:47:01.890Z,1738352821.890 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:47:01.890Z,1738352821.890 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:47:17.138Z,1738352837.138 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:48:35.916Z,1738352915.916 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:48:43.188Z,1738352923.188 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:48:58.135Z,1738352938.135 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:49:13.500Z,1738352953.500 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:49:28.839Z,1738352968.839 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:49:39.808Z,1738352979.808 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-01-31T19:49:43.787Z,1738352983.787 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:49:58.736Z,1738352998.736 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:50:14.089Z,1738353014.089 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:50:29.036Z,1738353029.036 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:50:43.984Z,1738353043.984 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:52:02.377Z,1738353122.377 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:52:02.377Z,1738353122.377 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:52:02.377Z,1738353122.377 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:52:02.377Z,1738353122.377 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:52:02.781Z,1738353122.781 [Default:CheckIn:D] Stopped
2025-01-31T19:52:02.781Z,1738353122.781 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:52:03.181Z,1738353123.181 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  119.745369 min 
2025-01-31T19:52:03.181Z,1738353123.181 [Default:CheckIn:E] Stopped
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn] Stopped
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn](INFO): Running loop #22
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn] Running Loop=22
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:52:03.182Z,1738353123.182 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:52:05.196Z,1738353125.196 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195209.00,A,3648.17063,N,12147.28073,W,0.233,247.76,310125,,,D*7C
2025-01-31T19:52:05.198Z,1738353125.198 [NAL9602](INFO): GPS fix at 20250131T195209: (36.802844, -121.788012)
2025-01-31T19:52:05.228Z,1738353125.228 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:52:05.229Z,1738353125.229 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:52:12.960Z,1738353132.960 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0063.lzma
2025-01-31T19:52:13.963Z,1738353133.963 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0063.lzma.bak
2025-01-31T19:52:13.963Z,1738353133.963 [DataOverHttps](INFO): SBD MOMSN=23951925
2025-01-31T19:52:29.572Z,1738353149.572 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20250131T175815/Express0064.lzma
2025-01-31T19:52:30.575Z,1738353150.575 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0064.lzma.bak
2025-01-31T19:52:30.575Z,1738353150.575 [DataOverHttps](INFO): SBD MOMSN=23951928
2025-01-31T19:52:30.648Z,1738353150.648 [NAL9602](INFO): SBD MO Status=0, MOMSN=21682, MT Status=0, MTMSN=0
2025-01-31T19:52:30.648Z,1738353150.648 [NAL9602](INFO): No messages in MT queue
2025-01-31T19:52:31.876Z,1738353151.876 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:52:31.876Z,1738353151.876 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:52:31.876Z,1738353151.876 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:53:01.404Z,1738353181.404 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T19:53:17.106Z,1738353197.106 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:53:31.240Z,1738353211.240 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:53:44.572Z,1738353224.572 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:53:58.307Z,1738353238.307 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:54:12.447Z,1738353252.447 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:54:26.589Z,1738353266.589 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:54:40.727Z,1738353280.727 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:54:54.870Z,1738353294.870 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:55:08.199Z,1738353308.199 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:55:21.936Z,1738353321.936 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:55:35.671Z,1738353335.671 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:57:32.456Z,1738353452.456 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T19:57:32.456Z,1738353452.456 [Default:CheckIn:C.Wait] Stopped
2025-01-31T19:57:32.456Z,1738353452.456 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T19:57:32.456Z,1738353452.456 [Default:CheckIn:D] Running Loop=1
2025-01-31T19:57:32.848Z,1738353452.848 [Default:CheckIn:D] Stopped
2025-01-31T19:57:32.848Z,1738353452.848 [Default:CheckIn:E] Running Loop=1
2025-01-31T19:57:33.257Z,1738353453.257 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  125.246493 min 
2025-01-31T19:57:33.257Z,1738353453.257 [Default:CheckIn:E] Stopped
2025-01-31T19:57:33.257Z,1738353453.257 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T19:57:33.257Z,1738353453.257 [Default:CheckIn] Stopped
2025-01-31T19:57:33.257Z,1738353453.257 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T19:57:33.257Z,1738353453.257 [Default:CheckIn](INFO): Running loop #23
2025-01-31T19:57:33.258Z,1738353453.258 [Default:CheckIn] Running Loop=23
2025-01-31T19:57:33.258Z,1738353453.258 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T19:57:33.258Z,1738353453.258 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T19:57:35.264Z,1738353455.264 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195739.00,A,3648.17249,N,12147.28118,W,0.039,247.76,310125,,,A*71
2025-01-31T19:57:35.266Z,1738353455.266 [NAL9602](INFO): GPS fix at 20250131T195739: (36.802875, -121.788020)
2025-01-31T19:57:35.278Z,1738353455.278 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T19:57:35.278Z,1738353455.278 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T19:57:44.224Z,1738353464.224 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0066.lzma
2025-01-31T19:57:45.227Z,1738353465.227 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0066.lzma.bak
2025-01-31T19:57:45.227Z,1738353465.227 [DataOverHttps](INFO): SBD MOMSN=23951932
2025-01-31T19:57:57.112Z,1738353477.112 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:58:01.065Z,1738353481.065 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20250131T175815/Express0067.lzma
2025-01-31T19:58:02.067Z,1738353482.067 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0067.lzma.bak
2025-01-31T19:58:02.068Z,1738353482.068 [DataOverHttps](INFO): SBD MOMSN=23951935
2025-01-31T19:58:03.601Z,1738353483.601 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T19:58:03.601Z,1738353483.601 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T19:58:03.601Z,1738353483.601 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T19:58:03.981Z,1738353483.981 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:58:19.735Z,1738353499.735 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:58:34.683Z,1738353514.683 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:58:49.631Z,1738353529.631 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:59:04.985Z,1738353544.985 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:59:19.968Z,1738353559.968 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:59:35.319Z,1738353575.319 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T19:59:43.821Z,1738353583.821 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2025-01-31T19:59:43.822Z,1738353583.822 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5.
2025-01-31T19:59:43.825Z,1738353583.825 [BPC1](FAULT): Failed to receive data from 8 sticks prior to timeout. Will not retry this scan cycle. Missing stick IDs are: 9, 10, 11, 14, 35, 52, 53, 59.
2025-01-31T20:01:57.955Z,1738353717.955 [NAL9602](INFO): SBD MO Status=2, MOMSN=21683, MT Status=2, MTMSN=0
2025-01-31T20:01:57.955Z,1738353717.955 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T20:02:08.459Z,1738353728.459 [NAL9602](INFO): SBD MO Status=0, MOMSN=21683, MT Status=0, MTMSN=0
2025-01-31T20:02:08.460Z,1738353728.460 [NAL9602](INFO): No messages in MT queue
2025-01-31T20:02:39.168Z,1738353759.168 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T20:03:04.234Z,1738353784.234 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T20:03:04.234Z,1738353784.234 [Default:CheckIn:C.Wait] Stopped
2025-01-31T20:03:04.234Z,1738353784.234 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T20:03:04.234Z,1738353784.234 [Default:CheckIn:D] Running Loop=1
2025-01-31T20:03:04.636Z,1738353784.636 [Default:CheckIn:D] Stopped
2025-01-31T20:03:04.636Z,1738353784.636 [Default:CheckIn:E] Running Loop=1
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  130.776286 min 
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn:E] Stopped
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn] Stopped
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn](INFO): Running loop #24
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn] Running Loop=24
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T20:03:05.047Z,1738353785.047 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T20:03:07.056Z,1738353787.056 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200311.00,A,3648.17220,N,12147.27858,W,0.078,247.76,310125,,,A*78
2025-01-31T20:03:07.058Z,1738353787.058 [NAL9602](INFO): GPS fix at 20250131T200311: (36.802870, -121.787976)
2025-01-31T20:03:07.089Z,1738353787.089 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T20:03:07.089Z,1738353787.089 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T20:03:16.896Z,1738353796.896 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20250131T175815/Courier0069.lzma
2025-01-31T20:03:17.899Z,1738353797.899 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0069.lzma.bak
2025-01-31T20:03:17.899Z,1738353797.899 [DataOverHttps](INFO): SBD MOMSN=23951939
2025-01-31T20:03:30.511Z,1738353810.511 [NAL9602](INFO): SBD MO Status=2, MOMSN=21684, MT Status=2, MTMSN=0
2025-01-31T20:03:30.512Z,1738353810.512 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-01-31T20:03:33.597Z,1738353813.597 [DataOverHttps](INFO): Sending 249 bytes from file Logs/20250131T175815/Express0070.lzma
2025-01-31T20:03:34.599Z,1738353814.599 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0070.lzma.bak
2025-01-31T20:03:34.599Z,1738353814.599 [DataOverHttps](INFO): SBD MOMSN=23951942
2025-01-31T20:03:35.801Z,1738353815.801 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T20:03:35.801Z,1738353815.801 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T20:03:35.801Z,1738353815.801 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T20:03:58.391Z,1738353838.391 [NAL9602](INFO): SBD MO Status=0, MOMSN=21684, MT Status=0, MTMSN=0
2025-01-31T20:03:58.392Z,1738353838.392 [NAL9602](INFO): No messages in MT queue
2025-01-31T20:04:29.094Z,1738353869.094 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T20:07:16.354Z,1738354036.354 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2025-01-31T20:07:16.354Z,1738354036.354 [DropWeight] Hardware Fault, FailCount= 1
2025-01-31T20:07:16.354Z,1738354036.354 [DropWeight](ERROR): Hardware Fault
2025-01-31T20:07:16.403Z,1738354036.403 [CommandExec](FAULT): Scheduling is paused
2025-01-31T20:07:16.403Z,1738354036.403 [CBIT](INFO): Critical error at 20250131T200716
2025-01-31T20:07:16.406Z,1738354036.406 [CBIT](ERROR): Hardware Fault in component: DropWeight
2025-01-31T20:07:16.406Z,1738354036.406 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2025-01-31T20:07:16.770Z,1738354036.770 [CBIT](INFO): Critical error at 20250131T200716
2025-01-31T20:08:36.356Z,1738354116.356 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T20:08:36.356Z,1738354116.356 [Default:CheckIn:C.Wait] Stopped
2025-01-31T20:08:36.356Z,1738354116.356 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T20:08:36.356Z,1738354116.356 [Default:CheckIn:D] Running Loop=1
2025-01-31T20:08:36.758Z,1738354116.758 [Default:CheckIn:D] Stopped
2025-01-31T20:08:36.758Z,1738354116.758 [Default:CheckIn:E] Running Loop=1
2025-01-31T20:08:37.171Z,1738354117.171 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  136.311654 min 
2025-01-31T20:08:37.171Z,1738354117.171 [Default:CheckIn:E] Stopped
2025-01-31T20:08:37.171Z,1738354117.171 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T20:08:37.171Z,1738354117.171 [Default:CheckIn] Stopped
2025-01-31T20:08:37.171Z,1738354117.171 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T20:08:37.172Z,1738354117.172 [Default:CheckIn](INFO): Running loop #25
2025-01-31T20:08:37.172Z,1738354117.172 [Default:CheckIn] Running Loop=25
2025-01-31T20:08:37.172Z,1738354117.172 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T20:08:37.172Z,1738354117.172 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T20:08:39.176Z,1738354119.176 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200843.00,A,3648.17375,N,12147.28073,W,0.039,247.76,310125,,,A*7E
2025-01-31T20:08:39.178Z,1738354119.178 [NAL9602](INFO): GPS fix at 20250131T200843: (36.802896, -121.788012)
2025-01-31T20:08:39.209Z,1738354119.209 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T20:08:39.209Z,1738354119.209 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T20:08:50.001Z,1738354130.001 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20250131T175815/Courier0072.lzma
2025-01-31T20:08:51.011Z,1738354131.011 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0072.lzma.bak
2025-01-31T20:08:51.011Z,1738354131.011 [DataOverHttps](INFO): SBD MOMSN=23951947
2025-01-31T20:09:10.819Z,1738354150.819 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20250131T175815/Express0073.lzma
2025-01-31T20:09:11.819Z,1738354151.819 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0073.lzma.bak
2025-01-31T20:09:11.819Z,1738354151.819 [DataOverHttps](INFO): SBD MOMSN=23951952
2025-01-31T20:09:13.178Z,1738354153.178 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T20:09:13.178Z,1738354153.178 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T20:09:13.178Z,1738354153.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T20:12:06.121Z,1738354326.121 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:12:19.855Z,1738354339.855 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:12:33.996Z,1738354353.996 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:12:48.144Z,1738354368.144 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:13:01.925Z,1738354381.925 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:13:15.655Z,1738354395.655 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:13:29.795Z,1738354409.795 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:13:41.518Z,1738354421.518 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-01-31T20:13:43.938Z,1738354423.938 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:13:57.671Z,1738354437.671 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:14:11.407Z,1738354451.407 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:14:12.218Z,1738354452.218 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T20:14:13.849Z,1738354453.849 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T20:14:13.849Z,1738354453.849 [Default:CheckIn:C.Wait] Stopped
2025-01-31T20:14:13.849Z,1738354453.849 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T20:14:13.849Z,1738354453.849 [Default:CheckIn:D] Running Loop=1
2025-01-31T20:14:14.260Z,1738354454.260 [Default:CheckIn:D] Stopped
2025-01-31T20:14:14.260Z,1738354454.260 [Default:CheckIn:E] Running Loop=1
2025-01-31T20:14:14.656Z,1738354454.656 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  141.936686 min 
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn:E] Stopped
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn] Stopped
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn](INFO): Running loop #26
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn] Running Loop=26
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T20:14:14.657Z,1738354454.657 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T20:14:16.663Z,1738354456.663 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201420.00,A,3648.17083,N,12147.27760,W,0.272,233.16,310125,,,A*7E
2025-01-31T20:14:16.665Z,1738354456.665 [NAL9602](INFO): GPS fix at 20250131T201420: (36.802847, -121.787960)
2025-01-31T20:14:16.677Z,1738354456.677 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T20:14:16.677Z,1738354456.677 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T20:14:26.672Z,1738354466.672 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250131T175815/Courier0075.lzma
2025-01-31T20:14:27.675Z,1738354467.675 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0075.lzma.bak
2025-01-31T20:14:27.675Z,1738354467.675 [DataOverHttps](INFO): SBD MOMSN=23951956
2025-01-31T20:14:44.085Z,1738354484.085 [DataOverHttps](INFO): Sending 231 bytes from file Logs/20250131T175815/Express0076.lzma
2025-01-31T20:14:45.087Z,1738354485.087 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0076.lzma.bak
2025-01-31T20:14:45.087Z,1738354485.087 [DataOverHttps](INFO): SBD MOMSN=23951959
2025-01-31T20:14:46.593Z,1738354486.593 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T20:14:46.593Z,1738354486.593 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T20:14:46.593Z,1738354486.593 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T20:14:47.374Z,1738354487.374 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-01-31T20:14:47.449Z,1738354487.449 [NAL9602](ERROR): received: 
+CSQ:0

OK684, 0, 0, 0, 0

OK
2025-01-31T20:16:42.518Z,1738354602.518 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:16:49.383Z,1738354609.383 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:17:04.333Z,1738354624.333 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:17:19.279Z,1738354639.279 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:17:34.631Z,1738354654.631 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:17:49.984Z,1738354669.984 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:18:05.739Z,1738354685.739 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:18:21.097Z,1738354701.097 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:18:36.847Z,1738354716.847 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:18:51.797Z,1738354731.797 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:19:18.522Z,1738354758.522 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-01-31T20:19:47.219Z,1738354787.219 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-01-31T20:19:47.220Z,1738354787.220 [Default:CheckIn:C.Wait] Stopped
2025-01-31T20:19:47.220Z,1738354787.220 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T20:19:47.220Z,1738354787.220 [Default:CheckIn:D] Running Loop=1
2025-01-31T20:19:47.620Z,1738354787.620 [Default:CheckIn:D] Stopped
2025-01-31T20:19:47.620Z,1738354787.620 [Default:CheckIn:E] Running Loop=1
2025-01-31T20:19:48.020Z,1738354788.020 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  147.492692 min 
2025-01-31T20:19:48.020Z,1738354788.020 [Default:CheckIn:E] Stopped
2025-01-31T20:19:48.020Z,1738354788.020 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-01-31T20:19:48.020Z,1738354788.020 [Default:CheckIn] Stopped
2025-01-31T20:19:48.021Z,1738354788.021 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T20:19:48.021Z,1738354788.021 [Default:CheckIn](INFO): Running loop #27
2025-01-31T20:19:48.021Z,1738354788.021 [Default:CheckIn] Running Loop=27
2025-01-31T20:19:48.021Z,1738354788.021 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-01-31T20:19:48.021Z,1738354788.021 [Default:CheckIn:Read_GPS] Running Loop=1
2025-01-31T20:20:29.220Z,1738354829.220 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202033.00,A,3648.12657,N,12147.21054,W,8.592,92.27,310125,,,A*4D
2025-01-31T20:20:29.222Z,1738354829.222 [NAL9602](INFO): GPS fix at 20250131T202033: (36.802110, -121.786842)
2025-01-31T20:20:29.269Z,1738354829.269 [Default:CheckIn:Read_GPS] Stopped
2025-01-31T20:20:29.269Z,1738354829.269 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-01-31T20:20:32.040Z,1738354832.040 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250131T175815/Courier0078.lzma
2025-01-31T20:20:33.043Z,1738354833.043 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Courier0078.lzma.bak
2025-01-31T20:20:33.043Z,1738354833.043 [DataOverHttps](INFO): SBD MOMSN=23951963
2025-01-31T20:20:55.689Z,1738354855.689 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20250131T175815/Express0079.lzma
2025-01-31T20:20:56.691Z,1738354856.691 [DataOverHttps](INFO): Moved sent file to Logs/20250131T175815/Express0079.lzma.bak
2025-01-31T20:20:56.691Z,1738354856.691 [DataOverHttps](INFO): SBD MOMSN=23951966
2025-01-31T20:20:58.488Z,1738354858.488 [Default:CheckIn:Read_Iridium] Stopped
2025-01-31T20:20:58.488Z,1738354858.488 [Default:CheckIn:C.Wait] Running Loop=1
2025-01-31T20:20:58.488Z,1738354858.488 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-01-31T20:21:01.690Z,1738354861.690 [NAL9602](INFO): Not Powering down - fast GPS
2025-01-31T20:21:29.169Z,1738354889.169 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:21:42.512Z,1738354902.512 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:21:56.249Z,1738354916.249 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:22:09.984Z,1738354929.984 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:22:16.472Z,1738354936.472 [CBIT](INFO): Clearing failed state for component DropWeight
2025-01-31T20:22:16.472Z,1738354936.472 [DropWeight] No Fault, FailCount= 1
2025-01-31T20:22:23.719Z,1738354943.719 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:22:37.859Z,1738354957.859 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:22:51.000Z,1738354972.000 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:23:05.741Z,1738354985.741 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:23:19.876Z,1738354999.876 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:23:34.015Z,1738355014.015 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-01-31T20:25:14.866Z,1738355114.866 [CommandExec](IMPORTANT): got command gfscan
2025-01-31T20:25:15.046Z,1738355115.046 [CBIT](IMPORTANT): Beginning ground fault scan
2025-01-31T20:25:17.894Z,1738355117.894 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2025-01-31T20:25:25.971Z,1738355125.971 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.545137
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): 0.400938
CHAN A3 (5V): 0.144354
CHAN B0 (3.3V): 0.103911
CHAN B1 (3.15aV): 0.109174
CHAN B2 (3.15bV): 0.107948
CHAN B3 (GND): 0.000892
OPEN: 0.023725
Full Scale: +/- 1 mA
2025-01-31T20:25:33.641Z,1738355133.641 [CommandExec](IMPORTANT): got command failComponent
2025-01-31T20:25:33.642Z,1738355133.642 [CommandExec](IMPORTANT): Failed components:
2025-01-31T20:25:33.642Z,1738355133.642 [CommandExec](IMPORTANT): No failed Components.
2025-01-31T20:25:36.158Z,1738355136.158 [CommandExec](IMPORTANT): got command quit
2025-01-31T20:25:37.161Z,1738355137.161 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:37.161Z,1738355137.161 [CommandExec](INFO): Uninitializing the command executive.
2025-01-31T20:25:37.161Z,1738355137.161 [CommandExec](INFO): Uninitializing the command scheduler.
2025-01-31T20:25:37.162Z,1738355137.162 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:37.349Z,1738355137.349 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-01-31T20:25:37.349Z,1738355137.349 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-01-31T20:25:37.349Z,1738355137.349 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:37.350Z,1738355137.350 [NavChartDb](INFO): Join timeout helper Thread ID is 1470
2025-01-31T20:25:37.397Z,1738355137.397 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:37.397Z,1738355137.397 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:37.401Z,1738355137.401 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-01-31T20:25:37.401Z,1738355137.401 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:37.401Z,1738355137.401 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1471
2025-01-31T20:25:37.493Z,1738355137.493 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:37.493Z,1738355137.493 [WetLabsBB2FL](INFO): Powering down
2025-01-31T20:25:37.494Z,1738355137.494 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:37.509Z,1738355137.509 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-01-31T20:25:37.509Z,1738355137.509 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:37.509Z,1738355137.509 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1472
2025-01-31T20:25:38.285Z,1738355138.285 [CTD_Seabird](INFO): Powering down
2025-01-31T20:25:38.297Z,1738355138.297 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:38.297Z,1738355138.297 [CTD_Seabird](INFO): Powering down
2025-01-31T20:25:38.309Z,1738355138.309 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:38.321Z,1738355138.321 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-01-31T20:25:38.321Z,1738355138.321 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:38.321Z,1738355138.321 [Radio_Surface](INFO): Join timeout helper Thread ID is 1473
2025-01-31T20:25:38.597Z,1738355138.597 [Radio_Surface](INFO): Powering down
2025-01-31T20:25:38.598Z,1738355138.598 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:38.598Z,1738355138.598 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:38.613Z,1738355138.613 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-01-31T20:25:38.613Z,1738355138.613 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:38.613Z,1738355138.613 [Onboard](INFO): Join timeout helper Thread ID is 1474
2025-01-31T20:25:40.325Z,1738355140.325 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:40.325Z,1738355140.325 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:40.346Z,1738355140.346 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-01-31T20:25:40.346Z,1738355140.346 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:40.346Z,1738355140.346 [DataOverHttps](INFO): Join timeout helper Thread ID is 1475
2025-01-31T20:25:41.237Z,1738355141.237 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:41.240Z,1738355141.240 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.246Z,1738355141.246 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-01-31T20:25:41.246Z,1738355141.246 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.246Z,1738355141.246 [BackseatComponent](INFO): Join timeout helper Thread ID is 1476
2025-01-31T20:25:41.326Z,1738355141.326 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:41.328Z,1738355141.328 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.346Z,1738355141.346 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-01-31T20:25:41.346Z,1738355141.346 [logger ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.346Z,1738355141.346 [logger](INFO): Join timeout helper Thread ID is 1477
2025-01-31T20:25:41.361Z,1738355141.361 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:41.361Z,1738355141.361 [logger ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.366Z,1738355141.366 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-01-31T20:25:41.366Z,1738355141.366 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.366Z,1738355141.366 [CommandLine](INFO): Join timeout helper Thread ID is 1478
2025-01-31T20:25:41.405Z,1738355141.405 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:41.405Z,1738355141.405 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.426Z,1738355141.426 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-01-31T20:25:41.426Z,1738355141.426 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.426Z,1738355141.426 [CommandExec](INFO): Join timeout helper Thread ID is 1479
2025-01-31T20:25:41.427Z,1738355141.427 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-01-31T20:25:41.427Z,1738355141.427 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.428Z,1738355141.428 [controlThread](INFO): Join timeout helper Thread ID is 1480
2025-01-31T20:25:41.665Z,1738355141.665 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-01-31T20:25:41.665Z,1738355141.665 [controlThread](DEBUG): Uninitializing ControlThread
2025-01-31T20:25:41.666Z,1738355141.666 [AHRS_M2](INFO): Powering down
2025-01-31T20:25:41.738Z,1738355141.738 [NAL9602](INFO): Powering down
2025-01-31T20:25:41.739Z,1738355141.739 [Sonardyne_Nano](INFO): Powering down
2025-01-31T20:25:41.857Z,1738355141.857 [Waterlinked](INFO): Powering down
2025-01-31T20:25:41.859Z,1738355141.859 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-01-31T20:25:41.860Z,1738355141.860 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-01-31T20:25:41.860Z,1738355141.860 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-01-31T20:25:41.860Z,1738355141.860 [MissionManager](INFO): Uninitializing Mission Default
2025-01-31T20:25:41.861Z,1738355141.861 [Default] Stopped
2025-01-31T20:25:41.861Z,1738355141.861 [Default](DEBUG): Aggregate::uninitialize Default
2025-01-31T20:25:41.861Z,1738355141.861 [Default:B.GoToSurface] Stopped
2025-01-31T20:25:41.861Z,1738355141.861 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-01-31T20:25:41.861Z,1738355141.861 [Default:CheckIn] Stopped
2025-01-31T20:25:41.861Z,1738355141.861 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-01-31T20:25:41.861Z,1738355141.861 [Default:CheckIn:C.Wait] Stopped
2025-01-31T20:25:41.861Z,1738355141.861 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-01-31T20:25:41.864Z,1738355141.864 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-01-31T20:25:41.864Z,1738355141.864 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-01-31T20:25:41.865Z,1738355141.865 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-01-31T20:25:41.865Z,1738355141.865 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-01-31T20:25:41.865Z,1738355141.865 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-01-31T20:25:41.866Z,1738355141.866 [BuoyancyServo](INFO): Powering down
2025-01-31T20:25:41.877Z,1738355141.877 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-01-31T20:25:41.877Z,1738355141.877 [ElevatorServo](INFO): Powering down
2025-01-31T20:25:41.878Z,1738355141.878 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-01-31T20:25:41.878Z,1738355141.878 [MassServo](INFO): Powering down
2025-01-31T20:25:41.879Z,1738355141.879 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-01-31T20:25:41.879Z,1738355141.879 [RudderServo](INFO): Powering down
2025-01-31T20:25:41.880Z,1738355141.880 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-01-31T20:25:41.880Z,1738355141.880 [ThrusterHE](INFO): Powering down
2025-01-31T20:25:41.881Z,1738355141.881 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-01-31T20:25:41.881Z,1738355141.881 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-01-31T20:25:41.881Z,1738355141.881 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-01-31T20:25:41.881Z,1738355141.881 [CBIT](DEBUG): Powering off loads.
2025-01-31T20:25:41.893Z,1738355141.893 [CBIT](DEBUG): Disabling WDT.
2025-01-31T20:25:41.905Z,1738355141.905 [CBIT](DEBUG): Opening all GF detection circuits.
2025-01-31T20:25:41.906Z,1738355141.906 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.962Z,1738355141.962 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.964Z,1738355141.964 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:41.971Z,1738355141.971 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:42.014Z,1738355142.014 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:42.109Z,1738355142.109 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:42.115Z,1738355142.115 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:42.124Z,1738355142.124 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-01-31T20:25:42.216Z,1738355142.216 [logger ThreadHandler](INFO): Thread cancelled.