2024-08-23T19:16:48.774Z,1724440608.774 [CommandExec](IMPORTANT): got command restart logs 2024-08-23T19:17:01.267Z,1724440621.267 [Default:A.Wait](INFO): Done Waiting. 2024-08-23T19:17:01.267Z,1724440621.267 [Default:A.Wait] Stopped 2024-08-23T19:17:01.267Z,1724440621.267 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-08-23T19:17:01.671Z,1724440621.671 [Default:CheckIn] Running Loop=1 2024-08-23T19:17:01.671Z,1724440621.671 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-23T19:17:01.671Z,1724440621.671 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-23T19:17:03.263Z,1724440623.263 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-23T19:17:03.263Z,1724440623.263 [NAL9602] Data Fault, FailCount= 1 2024-08-23T19:17:03.263Z,1724440623.263 [NAL9602](ERROR): Data Fault 2024-08-23T19:17:03.317Z,1724440623.317 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-23T19:17:03.679Z,1724440623.679 [NAL9602](INFO): Powering down 2024-08-23T19:17:04.517Z,1724440624.517 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-23T19:17:04.518Z,1724440624.518 [NAL9602] No Fault, FailCount= 1 2024-08-23T19:17:33.979Z,1724440653.979 [NAL9602](INFO): Powering up NAL9602 2024-08-23T19:17:44.863Z,1724440664.863 [NAL9602](INFO): NAL9602 initialized 2024-08-23T19:18:28.155Z,1724440708.155 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-23T19:19:06.532Z,1724440746.532 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-23T19:19:33.194Z,1724440773.194 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-23T19:22:01.915Z,1724440921.915 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-23T19:17:01.7Z 2024-08-23T19:22:01.915Z,1724440921.915 [Default:CheckIn:Read_GPS] Stopped 2024-08-23T19:22:01.915Z,1724440921.915 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-23T19:22:09.512Z,1724440929.512 [DataOverHttps](INFO): Sending 55 bytes from file Logs/20240823T190437/Courier0003.lzma 2024-08-23T19:22:10.514Z,1724440930.514 [DataOverHttps](INFO): Moved sent file to Logs/20240823T190437/Courier0003.lzma.bak 2024-08-23T19:22:10.515Z,1724440930.515 [DataOverHttps](INFO): SBD MOMSN=23056510 2024-08-23T19:22:26.412Z,1724440946.412 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240823T191648/Courier0000.lzma 2024-08-23T19:22:27.414Z,1724440947.414 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Courier0000.lzma.bak 2024-08-23T19:22:27.415Z,1724440947.415 [DataOverHttps](INFO): SBD MOMSN=23056512 2024-08-23T19:22:45.472Z,1724440965.472 [DataOverHttps](INFO): Sending 990 bytes from file Logs/20240823T190437/Express0005.lzma 2024-08-23T19:22:46.470Z,1724440966.470 [DataOverHttps](INFO): Moved sent file to Logs/20240823T190437/Express0005.lzma.bak 2024-08-23T19:22:46.471Z,1724440966.471 [DataOverHttps](INFO): SBD MOMSN=23056515 2024-08-23T19:22:47.898Z,1724440967.898 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-23T19:23:05.253Z,1724440985.253 [DataOverHttps](INFO): Sending 368 bytes from file Logs/20240823T191648/Express0001.lzma 2024-08-23T19:23:06.254Z,1724440986.254 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Express0001.lzma.bak 2024-08-23T19:23:06.255Z,1724440986.255 [DataOverHttps](INFO): SBD MOMSN=23056601 2024-08-23T19:23:09.350Z,1724440989.350 [Default:CheckIn:Read_Iridium] Stopped 2024-08-23T19:23:09.350Z,1724440989.350 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-23T19:23:09.350Z,1724440989.350 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-23T19:23:18.586Z,1724440998.586 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-23T19:23:35.618Z,1724441015.618 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-23T19:24:56.015Z,1724441096.015 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-23T19:25:44.437Z,1724441144.437 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-08-23T19:25:44.438Z,1724441144.438 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6. 2024-08-23T19:25:44.440Z,1724441144.440 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-08-23T19:28:09.883Z,1724441289.883 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-23T19:28:09.883Z,1724441289.883 [Default:CheckIn:C.Wait] Stopped 2024-08-23T19:28:09.883Z,1724441289.883 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-23T19:28:09.883Z,1724441289.883 [Default:CheckIn:D] Running Loop=1 2024-08-23T19:28:10.283Z,1724441290.283 [Default:CheckIn:D] Stopped 2024-08-23T19:28:10.283Z,1724441290.283 [Default:CheckIn:E] Running Loop=1 2024-08-23T19:28:10.691Z,1724441290.691 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.369161 min 2024-08-23T19:28:10.691Z,1724441290.691 [Default:CheckIn:E] Stopped 2024-08-23T19:28:10.691Z,1724441290.691 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-23T19:28:10.691Z,1724441290.691 [Default:CheckIn] Stopped 2024-08-23T19:28:10.692Z,1724441290.692 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-23T19:28:10.692Z,1724441290.692 [Default:CheckIn](INFO): Running loop #2 2024-08-23T19:28:10.692Z,1724441290.692 [Default:CheckIn] Running Loop=2 2024-08-23T19:28:10.692Z,1724441290.692 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-23T19:28:10.692Z,1724441290.692 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-23T19:28:12.297Z,1724441292.297 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-23T19:28:12.297Z,1724441292.297 [NAL9602] Data Fault, FailCount= 2 2024-08-23T19:28:12.297Z,1724441292.297 [NAL9602](ERROR): Data Fault 2024-08-23T19:28:12.320Z,1724441292.320 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-23T19:28:12.701Z,1724441292.701 [NAL9602](INFO): Powering down 2024-08-23T19:28:13.525Z,1724441293.525 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-23T19:28:13.525Z,1724441293.525 [NAL9602] No Fault, FailCount= 2 2024-08-23T19:28:43.001Z,1724441323.001 [NAL9602](INFO): Powering up NAL9602 2024-08-23T19:28:53.913Z,1724441333.913 [NAL9602](INFO): NAL9602 initialized 2024-08-23T19:33:10.875Z,1724441590.875 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-23T19:28:10.7Z 2024-08-23T19:33:10.875Z,1724441590.875 [Default:CheckIn:Read_GPS] Stopped 2024-08-23T19:33:10.876Z,1724441590.876 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-23T19:33:18.060Z,1724441598.060 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240823T191648/Courier0003.lzma 2024-08-23T19:33:19.062Z,1724441599.062 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Courier0003.lzma.bak 2024-08-23T19:33:19.063Z,1724441599.063 [DataOverHttps](INFO): SBD MOMSN=23056656 2024-08-23T19:33:36.442Z,1724441616.442 [DataOverHttps](INFO): Sending 256 bytes from file Logs/20240823T191648/Express0004.lzma 2024-08-23T19:33:37.442Z,1724441617.442 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Express0004.lzma.bak 2024-08-23T19:33:37.442Z,1724441617.442 [DataOverHttps](INFO): SBD MOMSN=23056660 2024-08-23T19:33:40.404Z,1724441620.404 [Default:CheckIn:Read_Iridium] Stopped 2024-08-23T19:33:40.404Z,1724441620.404 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-23T19:33:40.404Z,1724441620.404 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-23T19:33:56.904Z,1724441636.904 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-23T19:34:27.610Z,1724441667.610 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-23T19:38:40.947Z,1724441920.947 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-23T19:38:40.947Z,1724441920.947 [Default:CheckIn:C.Wait] Stopped 2024-08-23T19:38:40.947Z,1724441920.947 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-23T19:38:40.947Z,1724441920.947 [Default:CheckIn:D] Running Loop=1 2024-08-23T19:38:41.342Z,1724441921.342 [Default:CheckIn:D] Stopped 2024-08-23T19:38:41.342Z,1724441921.342 [Default:CheckIn:E] Running Loop=1 2024-08-23T19:38:41.741Z,1724441921.741 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.886812 min 2024-08-23T19:38:41.741Z,1724441921.741 [Default:CheckIn:E] Stopped 2024-08-23T19:38:41.741Z,1724441921.741 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-23T19:38:41.742Z,1724441921.742 [Default:CheckIn] Stopped 2024-08-23T19:38:41.742Z,1724441921.742 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-23T19:38:41.742Z,1724441921.742 [Default:CheckIn](INFO): Running loop #3 2024-08-23T19:38:41.742Z,1724441921.742 [Default:CheckIn] Running Loop=3 2024-08-23T19:38:41.742Z,1724441921.742 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-23T19:38:41.742Z,1724441921.742 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-23T19:39:14.448Z,1724441954.448 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-23T19:39:14.521Z,1724441954.521 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-23T19:43:41.914Z,1724442221.914 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-23T19:38:41.7Z 2024-08-23T19:43:41.914Z,1724442221.914 [Default:CheckIn:Read_GPS] Stopped 2024-08-23T19:43:41.914Z,1724442221.914 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-23T19:43:46.006Z,1724442226.006 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-23T19:43:49.776Z,1724442229.776 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240823T191648/Courier0006.lzma 2024-08-23T19:43:50.778Z,1724442230.778 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Courier0006.lzma.bak 2024-08-23T19:43:50.778Z,1724442230.778 [DataOverHttps](INFO): SBD MOMSN=23056679 2024-08-23T19:44:08.181Z,1724442248.181 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20240823T191648/Express0007.lzma 2024-08-23T19:44:09.182Z,1724442249.182 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Express0007.lzma.bak 2024-08-23T19:44:09.183Z,1724442249.183 [DataOverHttps](INFO): SBD MOMSN=23056681 2024-08-23T19:44:11.886Z,1724442251.886 [Default:CheckIn:Read_Iridium] Stopped 2024-08-23T19:44:11.886Z,1724442251.886 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-23T19:44:11.887Z,1724442251.887 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-23T19:44:16.705Z,1724442256.705 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-23T19:49:12.445Z,1724442552.445 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-23T19:49:12.446Z,1724442552.446 [Default:CheckIn:C.Wait] Stopped 2024-08-23T19:49:12.446Z,1724442552.446 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-23T19:49:12.446Z,1724442552.446 [Default:CheckIn:D] Running Loop=1 2024-08-23T19:49:12.861Z,1724442552.861 [Default:CheckIn:D] Stopped 2024-08-23T19:49:12.861Z,1724442552.861 [Default:CheckIn:E] Running Loop=1 2024-08-23T19:49:13.272Z,1724442553.272 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.412115 min 2024-08-23T19:49:13.272Z,1724442553.272 [Default:CheckIn:E] Stopped 2024-08-23T19:49:13.272Z,1724442553.272 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-23T19:49:13.272Z,1724442553.272 [Default:CheckIn] Stopped 2024-08-23T19:49:13.272Z,1724442553.272 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-23T19:49:13.273Z,1724442553.273 [Default:CheckIn](INFO): Running loop #4 2024-08-23T19:49:13.273Z,1724442553.273 [Default:CheckIn] Running Loop=4 2024-08-23T19:49:13.273Z,1724442553.273 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-23T19:49:13.273Z,1724442553.273 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-23T19:49:14.860Z,1724442554.860 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-23T19:49:14.860Z,1724442554.860 [NAL9602] Data Fault, FailCount= 3 2024-08-23T19:49:14.860Z,1724442554.860 [NAL9602](ERROR): Data Fault 2024-08-23T19:49:14.926Z,1724442554.926 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-23T19:49:15.260Z,1724442555.260 [NAL9602](INFO): Powering down 2024-08-23T19:49:16.097Z,1724442556.097 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-23T19:49:16.097Z,1724442556.097 [NAL9602] No Fault, FailCount= 3 2024-08-23T19:49:45.560Z,1724442585.560 [NAL9602](INFO): Powering up NAL9602 2024-08-23T19:49:56.472Z,1724442596.472 [NAL9602](INFO): NAL9602 initialized 2024-08-23T19:54:13.444Z,1724442853.444 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-23T19:49:13.3Z 2024-08-23T19:54:13.444Z,1724442853.444 [Default:CheckIn:Read_GPS] Stopped 2024-08-23T19:54:13.444Z,1724442853.444 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-23T19:54:20.712Z,1724442860.712 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240823T191648/Courier0009.lzma 2024-08-23T19:54:21.714Z,1724442861.714 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Courier0009.lzma.bak 2024-08-23T19:54:21.715Z,1724442861.715 [DataOverHttps](INFO): SBD MOMSN=23056702 2024-08-23T19:54:40.544Z,1724442880.544 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240823T191648/Express0010.lzma 2024-08-23T19:54:41.542Z,1724442881.542 [DataOverHttps](INFO): Moved sent file to Logs/20240823T191648/Express0010.lzma.bak 2024-08-23T19:54:41.543Z,1724442881.543 [DataOverHttps](INFO): SBD MOMSN=23056704 2024-08-23T19:54:44.562Z,1724442884.562 [Default:CheckIn:Read_Iridium] Stopped 2024-08-23T19:54:44.562Z,1724442884.562 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-23T19:54:44.562Z,1724442884.562 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-23T19:54:59.484Z,1724442899.484 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-23T19:55:30.186Z,1724442930.186 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-23T19:59:45.116Z,1724443185.116 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-23T19:59:45.116Z,1724443185.116 [Default:CheckIn:C.Wait] Stopped 2024-08-23T19:59:45.116Z,1724443185.116 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-23T19:59:45.144Z,1724443185.144 [Default:CheckIn:D] Running Loop=1 2024-08-23T19:59:45.525Z,1724443185.525 [Default:CheckIn:D] Stopped 2024-08-23T19:59:45.525Z,1724443185.525 [Default:CheckIn:E] Running Loop=1 2024-08-23T19:59:45.923Z,1724443185.923 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.956514 min 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn:E] Stopped 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn] Stopped 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn](INFO): Running loop #5 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn] Running Loop=5 2024-08-23T19:59:45.924Z,1724443185.924 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-23T19:59:45.925Z,1724443185.925 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-23T20:00:18.640Z,1724443218.640 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-23T20:00:18.721Z,1724443218.721 [NAL9602](ERROR): received: +CSQ:0 OK