2024-08-20T17:54:24.589Z,1724176464.589 [CommandExec](IMPORTANT): got command restart logs 2024-08-20T17:56:56.860Z,1724176616.860 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T17:56:56.860Z,1724176616.860 [Default:CheckIn:C.Wait] Stopped 2024-08-20T17:56:56.860Z,1724176616.860 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T17:56:56.861Z,1724176616.861 [Default:CheckIn:D] Running Loop=1 2024-08-20T17:56:57.262Z,1724176617.262 [Default:CheckIn:D] Stopped 2024-08-20T17:56:57.262Z,1724176617.262 [Default:CheckIn:E] Running Loop=1 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.719045 min 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn:E] Stopped 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn] Stopped 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn](INFO): Running loop #2 2024-08-20T17:56:57.677Z,1724176617.677 [Default:CheckIn] Running Loop=2 2024-08-20T17:56:57.678Z,1724176617.678 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T17:56:57.678Z,1724176617.678 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T17:57:30.382Z,1724176650.382 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T17:57:30.460Z,1724176650.460 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T18:01:57.857Z,1724176917.857 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T17:56:57.7Z 2024-08-20T18:01:57.857Z,1724176917.857 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T18:01:57.858Z,1724176917.858 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T18:02:01.874Z,1724176921.874 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T18:02:05.075Z,1724176925.075 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T172130/Courier0009.lzma 2024-08-20T18:02:06.078Z,1724176926.078 [DataOverHttps](INFO): Moved sent file to Logs/20240820T172130/Courier0009.lzma.bak 2024-08-20T18:02:06.078Z,1724176926.078 [DataOverHttps](INFO): SBD MOMSN=23033625 2024-08-20T18:02:21.796Z,1724176941.796 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240820T175424/Courier0000.lzma 2024-08-20T18:02:22.798Z,1724176942.798 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0000.lzma.bak 2024-08-20T18:02:22.798Z,1724176942.798 [DataOverHttps](INFO): SBD MOMSN=23033627 2024-08-20T18:02:32.578Z,1724176952.578 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T18:02:39.832Z,1724176959.832 [DataOverHttps](INFO): Sending 284 bytes from file Logs/20240820T172130/Express0010.lzma 2024-08-20T18:02:40.834Z,1724176960.834 [DataOverHttps](INFO): Moved sent file to Logs/20240820T172130/Express0010.lzma.bak 2024-08-20T18:02:40.834Z,1724176960.834 [DataOverHttps](INFO): SBD MOMSN=23033630 2024-08-20T18:02:57.956Z,1724176977.956 [DataOverHttps](INFO): Sending 384 bytes from file Logs/20240820T175424/Express0001.lzma 2024-08-20T18:02:58.958Z,1724176978.958 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0001.lzma.bak 2024-08-20T18:02:58.958Z,1724176978.958 [DataOverHttps](INFO): SBD MOMSN=23033637 2024-08-20T18:03:01.684Z,1724176981.684 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T18:03:01.685Z,1724176981.685 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T18:03:01.685Z,1724176981.685 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T18:08:02.270Z,1724177282.270 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T18:08:02.270Z,1724177282.270 [Default:CheckIn:C.Wait] Stopped 2024-08-20T18:08:02.270Z,1724177282.270 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T18:08:02.270Z,1724177282.270 [Default:CheckIn:D] Running Loop=1 2024-08-20T18:08:02.688Z,1724177282.688 [Default:CheckIn:D] Stopped 2024-08-20T18:08:02.688Z,1724177282.688 [Default:CheckIn:E] Running Loop=1 2024-08-20T18:08:03.076Z,1724177283.076 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.809479 min 2024-08-20T18:08:03.076Z,1724177283.076 [Default:CheckIn:E] Stopped 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn] Stopped 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn](INFO): Running loop #3 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn] Running Loop=3 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T18:08:03.077Z,1724177283.077 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T18:08:04.680Z,1724177284.680 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T18:08:04.680Z,1724177284.680 [NAL9602] Data Fault, FailCount= 4 2024-08-20T18:08:04.680Z,1724177284.680 [NAL9602](ERROR): Data Fault 2024-08-20T18:08:04.702Z,1724177284.702 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T18:08:05.083Z,1724177285.083 [NAL9602](INFO): Powering down 2024-08-20T18:08:05.912Z,1724177285.912 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T18:08:05.912Z,1724177285.912 [NAL9602] No Fault, FailCount= 4 2024-08-20T18:08:35.387Z,1724177315.387 [NAL9602](INFO): Powering up NAL9602 2024-08-20T18:08:46.291Z,1724177326.291 [NAL9602](INFO): NAL9602 initialized 2024-08-20T18:13:03.285Z,1724177583.285 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T18:08:03.1Z 2024-08-20T18:13:03.285Z,1724177583.285 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T18:13:03.285Z,1724177583.285 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T18:13:10.623Z,1724177590.623 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0003.lzma 2024-08-20T18:13:11.626Z,1724177591.626 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0003.lzma.bak 2024-08-20T18:13:11.626Z,1724177591.626 [DataOverHttps](INFO): SBD MOMSN=23033731 2024-08-20T18:13:27.784Z,1724177607.784 [DataOverHttps](INFO): Sending 251 bytes from file Logs/20240820T175424/Express0004.lzma 2024-08-20T18:13:28.786Z,1724177608.786 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0004.lzma.bak 2024-08-20T18:13:28.786Z,1724177608.786 [DataOverHttps](INFO): SBD MOMSN=23033733 2024-08-20T18:13:31.562Z,1724177611.562 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T18:13:31.562Z,1724177611.562 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T18:13:31.562Z,1724177611.562 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T18:13:49.313Z,1724177629.313 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T18:14:20.015Z,1724177660.015 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T18:18:32.127Z,1724177912.127 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T18:18:32.127Z,1724177912.127 [Default:CheckIn:C.Wait] Stopped 2024-08-20T18:18:32.127Z,1724177912.127 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T18:18:32.127Z,1724177912.127 [Default:CheckIn:D] Running Loop=1 2024-08-20T18:18:32.531Z,1724177912.531 [Default:CheckIn:D] Stopped 2024-08-20T18:18:32.531Z,1724177912.531 [Default:CheckIn:E] Running Loop=1 2024-08-20T18:18:32.931Z,1724177912.931 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.306858 min 2024-08-20T18:18:32.931Z,1724177912.931 [Default:CheckIn:E] Stopped 2024-08-20T18:18:32.931Z,1724177912.931 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T18:18:32.931Z,1724177912.931 [Default:CheckIn] Stopped 2024-08-20T18:18:32.932Z,1724177912.932 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T18:18:32.932Z,1724177912.932 [Default:CheckIn](INFO): Running loop #4 2024-08-20T18:18:32.932Z,1724177912.932 [Default:CheckIn] Running Loop=4 2024-08-20T18:18:32.932Z,1724177912.932 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T18:18:32.932Z,1724177912.932 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T18:19:05.644Z,1724177945.644 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T18:19:05.724Z,1724177945.724 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T18:20:19.270Z,1724178019.270 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:20:20.121Z,1724178020.121 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:20:46.713Z,1724178046.713 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:21:40.850Z,1724178100.850 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:22:32.955Z,1724178152.955 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:23:02.046Z,1724178182.046 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:23:26.277Z,1724178206.277 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:23:28.298Z,1724178208.298 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:23:33.120Z,1724178213.120 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T18:18:32.9Z 2024-08-20T18:23:33.120Z,1724178213.120 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T18:23:33.121Z,1724178213.121 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T18:23:37.129Z,1724178217.129 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T18:23:40.327Z,1724178220.327 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0006.lzma 2024-08-20T18:23:41.330Z,1724178221.330 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0006.lzma.bak 2024-08-20T18:23:41.330Z,1724178221.330 [DataOverHttps](INFO): SBD MOMSN=23033765 2024-08-20T18:23:58.532Z,1724178238.532 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20240820T175424/Express0007.lzma 2024-08-20T18:23:59.533Z,1724178239.533 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0007.lzma.bak 2024-08-20T18:23:59.534Z,1724178239.534 [DataOverHttps](INFO): SBD MOMSN=23033767 2024-08-20T18:24:02.220Z,1724178242.220 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T18:24:02.220Z,1724178242.220 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T18:24:02.220Z,1724178242.220 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T18:24:07.841Z,1724178247.841 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T18:25:17.062Z,1724178317.062 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:25:57.816Z,1724178357.816 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:29:02.802Z,1724178542.802 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T18:29:02.802Z,1724178542.802 [Default:CheckIn:C.Wait] Stopped 2024-08-20T18:29:02.802Z,1724178542.802 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T18:29:02.803Z,1724178542.803 [Default:CheckIn:D] Running Loop=1 2024-08-20T18:29:03.210Z,1724178543.210 [Default:CheckIn:D] Stopped 2024-08-20T18:29:03.210Z,1724178543.210 [Default:CheckIn:E] Running Loop=1 2024-08-20T18:29:03.600Z,1724178543.600 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.818176 min 2024-08-20T18:29:03.600Z,1724178543.600 [Default:CheckIn:E] Stopped 2024-08-20T18:29:03.600Z,1724178543.600 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T18:29:03.600Z,1724178543.600 [Default:CheckIn] Stopped 2024-08-20T18:29:03.600Z,1724178543.600 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T18:29:03.601Z,1724178543.601 [Default:CheckIn](INFO): Running loop #5 2024-08-20T18:29:03.601Z,1724178543.601 [Default:CheckIn] Running Loop=5 2024-08-20T18:29:03.601Z,1724178543.601 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T18:29:03.601Z,1724178543.601 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T18:29:05.203Z,1724178545.203 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T18:29:05.203Z,1724178545.203 [NAL9602] Data Fault, FailCount= 5 2024-08-20T18:29:05.203Z,1724178545.203 [NAL9602](ERROR): Data Fault 2024-08-20T18:29:05.225Z,1724178545.225 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T18:29:05.226Z,1724178545.226 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-08-20T18:29:05.613Z,1724178545.613 [NAL9602](INFO): Powering down 2024-08-20T18:29:05.633Z,1724178545.633 [CommandExec](FAULT): Scheduling is paused 2024-08-20T18:29:05.634Z,1724178545.634 [CBIT](INFO): Critical error at 20240820T182905 2024-08-20T18:29:05.634Z,1724178545.634 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-08-20T18:29:29.106Z,1724178569.106 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:30:23.650Z,1724178623.650 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:31:05.226Z,1724178665.226 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T18:31:05.226Z,1724178665.226 [NAL9602] No Fault, FailCount= 5 2024-08-20T18:31:05.591Z,1724178665.591 [NAL9602](INFO): Powering up NAL9602 2024-08-20T18:31:16.495Z,1724178676.495 [NAL9602](INFO): NAL9602 initialized 2024-08-20T18:31:30.299Z,1724178690.299 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:31:58.974Z,1724178718.974 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:32:52.360Z,1724178772.360 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:34:01.798Z,1724178841.798 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:34:03.774Z,1724178843.774 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T18:29:03.6Z 2024-08-20T18:34:03.774Z,1724178843.774 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T18:34:03.775Z,1724178843.775 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T18:34:12.430Z,1724178852.430 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20240820T175424/Courier0009.lzma 2024-08-20T18:34:13.438Z,1724178853.438 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0009.lzma.bak 2024-08-20T18:34:13.438Z,1724178853.438 [DataOverHttps](INFO): SBD MOMSN=23033864 2024-08-20T18:34:14.893Z,1724178854.893 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:34:30.928Z,1724178870.928 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20240820T175424/Express0010.lzma 2024-08-20T18:34:31.930Z,1724178871.930 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0010.lzma.bak 2024-08-20T18:34:31.930Z,1724178871.930 [DataOverHttps](INFO): SBD MOMSN=23033867 2024-08-20T18:34:34.491Z,1724178874.491 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T18:34:34.491Z,1724178874.491 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T18:34:34.492Z,1724178874.492 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T18:36:19.497Z,1724178979.497 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T18:36:50.211Z,1724179010.211 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T18:36:51.076Z,1724179011.076 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:36:53.081Z,1724179013.081 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:37:17.329Z,1724179037.329 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:39:03.982Z,1724179143.982 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:39:33.885Z,1724179173.885 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:39:35.048Z,1724179175.048 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T18:39:35.048Z,1724179175.048 [Default:CheckIn:C.Wait] Stopped 2024-08-20T18:39:35.048Z,1724179175.048 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T18:39:35.049Z,1724179175.049 [Default:CheckIn:D] Running Loop=1 2024-08-20T18:39:35.448Z,1724179175.448 [Default:CheckIn:D] Stopped 2024-08-20T18:39:35.449Z,1724179175.449 [Default:CheckIn:E] Running Loop=1 2024-08-20T18:39:35.855Z,1724179175.855 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.355481 min 2024-08-20T18:39:35.855Z,1724179175.855 [Default:CheckIn:E] Stopped 2024-08-20T18:39:35.855Z,1724179175.855 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T18:39:35.855Z,1724179175.855 [Default:CheckIn] Stopped 2024-08-20T18:39:35.855Z,1724179175.855 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T18:39:35.856Z,1724179175.856 [Default:CheckIn](INFO): Running loop #6 2024-08-20T18:39:35.856Z,1724179175.856 [Default:CheckIn] Running Loop=6 2024-08-20T18:39:35.856Z,1724179175.856 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T18:39:35.856Z,1724179175.856 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T18:40:08.589Z,1724179208.589 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T18:40:08.668Z,1724179208.668 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T18:41:33.502Z,1724179293.502 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:41:59.763Z,1724179319.763 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:42:30.866Z,1724179350.866 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:42:54.244Z,1724179374.244 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-08-20T18:43:58.929Z,1724179438.929 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T18:44:36.100Z,1724179476.100 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T18:39:35.9Z 2024-08-20T18:44:36.100Z,1724179476.100 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T18:44:36.101Z,1724179476.101 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T18:44:39.277Z,1724179479.277 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T18:44:43.129Z,1724179483.129 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0012.lzma 2024-08-20T18:44:44.126Z,1724179484.126 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0012.lzma.bak 2024-08-20T18:44:44.126Z,1724179484.126 [DataOverHttps](INFO): SBD MOMSN=23033879 2024-08-20T18:45:02.716Z,1724179502.716 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20240820T175424/Express0013.lzma 2024-08-20T18:45:03.718Z,1724179503.718 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0013.lzma.bak 2024-08-20T18:45:03.718Z,1724179503.718 [DataOverHttps](INFO): SBD MOMSN=23033881 2024-08-20T18:45:06.376Z,1724179506.376 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T18:45:06.376Z,1724179506.376 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T18:45:06.376Z,1724179506.376 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T18:45:09.985Z,1724179509.985 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T18:45:34.231Z,1724179534.231 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-08-20T18:47:00.329Z,1724179620.329 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:48:40.543Z,1724179720.543 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T18:48:45.735Z,1724179725.735 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-08-20T18:48:45.736Z,1724179725.736 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6. 2024-08-20T18:48:45.738Z,1724179725.738 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-08-20T18:50:06.955Z,1724179806.955 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T18:50:06.955Z,1724179806.955 [Default:CheckIn:C.Wait] Stopped 2024-08-20T18:50:06.955Z,1724179806.955 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T18:50:06.955Z,1724179806.955 [Default:CheckIn:D] Running Loop=1 2024-08-20T18:50:07.364Z,1724179807.364 [Default:CheckIn:D] Stopped 2024-08-20T18:50:07.364Z,1724179807.364 [Default:CheckIn:E] Running Loop=1 2024-08-20T18:50:07.763Z,1724179807.763 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.887406 min 2024-08-20T18:50:07.763Z,1724179807.763 [Default:CheckIn:E] Stopped 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn] Stopped 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn](INFO): Running loop #7 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn] Running Loop=7 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T18:50:07.764Z,1724179807.764 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T18:50:09.365Z,1724179809.365 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T18:50:09.365Z,1724179809.365 [NAL9602] Data Fault, FailCount= 1 2024-08-20T18:50:09.365Z,1724179809.365 [NAL9602](ERROR): Data Fault 2024-08-20T18:50:09.387Z,1724179809.387 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T18:50:09.771Z,1724179809.771 [NAL9602](INFO): Powering down 2024-08-20T18:50:10.602Z,1724179810.602 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T18:50:10.602Z,1724179810.602 [NAL9602] No Fault, FailCount= 1 2024-08-20T18:50:40.069Z,1724179840.069 [NAL9602](INFO): Powering up NAL9602 2024-08-20T18:50:50.986Z,1724179850.986 [NAL9602](INFO): NAL9602 initialized 2024-08-20T18:55:07.941Z,1724180107.941 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T18:50:07.8Z 2024-08-20T18:55:07.941Z,1724180107.941 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T18:55:07.941Z,1724180107.941 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T18:55:15.612Z,1724180115.612 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240820T175424/Courier0015.lzma 2024-08-20T18:55:16.614Z,1724180116.614 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0015.lzma.bak 2024-08-20T18:55:16.614Z,1724180116.614 [DataOverHttps](INFO): SBD MOMSN=23033896 2024-08-20T18:55:35.028Z,1724180135.028 [DataOverHttps](INFO): Sending 225 bytes from file Logs/20240820T175424/Express0016.lzma 2024-08-20T18:55:36.030Z,1724180136.030 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0016.lzma.bak 2024-08-20T18:55:36.030Z,1724180136.030 [DataOverHttps](INFO): SBD MOMSN=23033898 2024-08-20T18:55:38.648Z,1724180138.648 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T18:55:38.648Z,1724180138.648 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T18:55:38.648Z,1724180138.648 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T18:55:54.005Z,1724180154.005 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T18:56:24.701Z,1724180184.701 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:00:39.258Z,1724180439.258 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T19:00:39.258Z,1724180439.258 [Default:CheckIn:C.Wait] Stopped 2024-08-20T19:00:39.258Z,1724180439.258 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T19:00:39.258Z,1724180439.258 [Default:CheckIn:D] Running Loop=1 2024-08-20T19:00:39.649Z,1724180439.649 [Default:CheckIn:D] Stopped 2024-08-20T19:00:39.649Z,1724180439.649 [Default:CheckIn:E] Running Loop=1 2024-08-20T19:00:40.054Z,1724180440.054 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.425496 min 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn:E] Stopped 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn] Stopped 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn](INFO): Running loop #8 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn] Running Loop=8 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T19:00:40.055Z,1724180440.055 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T19:01:12.773Z,1724180472.773 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T19:01:12.848Z,1724180472.848 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T19:05:40.268Z,1724180740.268 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T19:00:40.1Z 2024-08-20T19:05:40.268Z,1724180740.268 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T19:05:40.268Z,1724180740.268 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T19:05:43.865Z,1724180743.865 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T19:05:47.860Z,1724180747.860 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0018.lzma 2024-08-20T19:05:48.862Z,1724180748.862 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0018.lzma.bak 2024-08-20T19:05:48.862Z,1724180748.862 [DataOverHttps](INFO): SBD MOMSN=23033907 2024-08-20T19:06:06.060Z,1724180766.060 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20240820T175424/Express0019.lzma 2024-08-20T19:06:07.062Z,1724180767.062 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0019.lzma.bak 2024-08-20T19:06:07.062Z,1724180767.062 [DataOverHttps](INFO): SBD MOMSN=23033909 2024-08-20T19:06:09.740Z,1724180769.740 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T19:06:09.740Z,1724180769.740 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T19:06:09.740Z,1724180769.740 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T19:06:14.579Z,1724180774.579 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:11:10.330Z,1724181070.330 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T19:11:10.330Z,1724181070.330 [Default:CheckIn:C.Wait] Stopped 2024-08-20T19:11:10.330Z,1724181070.330 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T19:11:10.330Z,1724181070.330 [Default:CheckIn:D] Running Loop=1 2024-08-20T19:11:10.741Z,1724181070.741 [Default:CheckIn:D] Stopped 2024-08-20T19:11:10.741Z,1724181070.741 [Default:CheckIn:E] Running Loop=1 2024-08-20T19:11:11.134Z,1724181071.134 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.943693 min 2024-08-20T19:11:11.134Z,1724181071.134 [Default:CheckIn:E] Stopped 2024-08-20T19:11:11.134Z,1724181071.134 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T19:11:11.134Z,1724181071.134 [Default:CheckIn] Stopped 2024-08-20T19:11:11.134Z,1724181071.134 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T19:11:11.134Z,1724181071.134 [Default:CheckIn](INFO): Running loop #9 2024-08-20T19:11:11.135Z,1724181071.135 [Default:CheckIn] Running Loop=9 2024-08-20T19:11:11.135Z,1724181071.135 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T19:11:11.135Z,1724181071.135 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T19:11:12.741Z,1724181072.741 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T19:11:12.741Z,1724181072.741 [NAL9602] Data Fault, FailCount= 2 2024-08-20T19:11:12.741Z,1724181072.741 [NAL9602](ERROR): Data Fault 2024-08-20T19:11:12.809Z,1724181072.809 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T19:11:13.139Z,1724181073.139 [NAL9602](INFO): Powering down 2024-08-20T19:11:13.981Z,1724181073.981 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T19:11:13.981Z,1724181073.981 [NAL9602] No Fault, FailCount= 2 2024-08-20T19:11:43.447Z,1724181103.447 [NAL9602](INFO): Powering up NAL9602 2024-08-20T19:11:54.359Z,1724181114.359 [NAL9602](INFO): NAL9602 initialized 2024-08-20T19:16:11.313Z,1724181371.313 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T19:11:11.1Z 2024-08-20T19:16:11.313Z,1724181371.313 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T19:16:11.313Z,1724181371.313 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T19:16:18.311Z,1724181378.311 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0021.lzma 2024-08-20T19:16:19.314Z,1724181379.314 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0021.lzma.bak 2024-08-20T19:16:19.314Z,1724181379.314 [DataOverHttps](INFO): SBD MOMSN=23033917 2024-08-20T19:16:36.520Z,1724181396.520 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20240820T175424/Express0022.lzma 2024-08-20T19:16:37.522Z,1724181397.522 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0022.lzma.bak 2024-08-20T19:16:37.522Z,1724181397.522 [DataOverHttps](INFO): SBD MOMSN=23033919 2024-08-20T19:16:40.008Z,1724181400.008 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T19:16:40.008Z,1724181400.008 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T19:16:40.008Z,1724181400.008 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T19:16:57.351Z,1724181417.351 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T19:17:28.059Z,1724181448.059 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:21:40.577Z,1724181700.577 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T19:21:40.577Z,1724181700.577 [Default:CheckIn:C.Wait] Stopped 2024-08-20T19:21:40.577Z,1724181700.577 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T19:21:40.578Z,1724181700.578 [Default:CheckIn:D] Running Loop=1 2024-08-20T19:21:40.972Z,1724181700.972 [Default:CheckIn:D] Stopped 2024-08-20T19:21:40.972Z,1724181700.972 [Default:CheckIn:E] Running Loop=1 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 95.447534 min 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn:E] Stopped 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn] Stopped 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn](INFO): Running loop #10 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn] Running Loop=10 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T19:21:41.377Z,1724181701.377 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T19:26:41.553Z,1724182001.553 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T19:21:41.4Z 2024-08-20T19:26:41.553Z,1724182001.553 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T19:26:41.553Z,1724182001.553 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T19:26:45.217Z,1724182005.217 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T19:26:48.391Z,1724182008.391 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0024.lzma 2024-08-20T19:26:49.394Z,1724182009.394 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0024.lzma.bak 2024-08-20T19:26:49.394Z,1724182009.394 [DataOverHttps](INFO): SBD MOMSN=23033957 2024-08-20T19:27:07.780Z,1724182027.780 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20240820T175424/Express0025.lzma 2024-08-20T19:27:08.782Z,1724182028.782 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0025.lzma.bak 2024-08-20T19:27:08.782Z,1724182028.782 [DataOverHttps](INFO): SBD MOMSN=23033963 2024-08-20T19:27:11.520Z,1724182031.520 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T19:27:11.520Z,1724182031.520 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T19:27:11.520Z,1724182031.520 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T19:27:15.921Z,1724182035.921 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:32:12.081Z,1724182332.081 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T19:32:12.081Z,1724182332.081 [Default:CheckIn:C.Wait] Stopped 2024-08-20T19:32:12.081Z,1724182332.081 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T19:32:12.082Z,1724182332.082 [Default:CheckIn:D] Running Loop=1 2024-08-20T19:32:12.491Z,1724182332.491 [Default:CheckIn:D] Stopped 2024-08-20T19:32:12.491Z,1724182332.491 [Default:CheckIn:E] Running Loop=1 2024-08-20T19:32:12.901Z,1724182332.901 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.972860 min 2024-08-20T19:32:12.901Z,1724182332.901 [Default:CheckIn:E] Stopped 2024-08-20T19:32:12.901Z,1724182332.901 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T19:32:12.901Z,1724182332.901 [Default:CheckIn] Stopped 2024-08-20T19:32:12.902Z,1724182332.902 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T19:32:12.902Z,1724182332.902 [Default:CheckIn](INFO): Running loop #11 2024-08-20T19:32:12.902Z,1724182332.902 [Default:CheckIn] Running Loop=11 2024-08-20T19:32:12.902Z,1724182332.902 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T19:32:12.902Z,1724182332.902 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T19:32:14.491Z,1724182334.491 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T19:32:14.491Z,1724182334.491 [NAL9602] Data Fault, FailCount= 3 2024-08-20T19:32:14.491Z,1724182334.491 [NAL9602](ERROR): Data Fault 2024-08-20T19:32:14.549Z,1724182334.549 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T19:32:14.896Z,1724182334.896 [NAL9602](INFO): Powering down 2024-08-20T19:32:15.729Z,1724182335.729 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T19:32:15.729Z,1724182335.729 [NAL9602] No Fault, FailCount= 3 2024-08-20T19:32:45.200Z,1724182365.200 [NAL9602](INFO): Powering up NAL9602 2024-08-20T19:32:56.108Z,1724182376.108 [NAL9602](INFO): NAL9602 initialized 2024-08-20T19:37:13.065Z,1724182633.065 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T19:32:12.9Z 2024-08-20T19:37:13.065Z,1724182633.065 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T19:37:13.066Z,1724182633.066 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T19:37:20.663Z,1724182640.663 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0027.lzma 2024-08-20T19:37:21.666Z,1724182641.666 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0027.lzma.bak 2024-08-20T19:37:21.666Z,1724182641.666 [DataOverHttps](INFO): SBD MOMSN=23034029 2024-08-20T19:37:39.864Z,1724182659.864 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20240820T175424/Express0028.lzma 2024-08-20T19:37:40.866Z,1724182660.866 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0028.lzma.bak 2024-08-20T19:37:40.866Z,1724182660.866 [DataOverHttps](INFO): SBD MOMSN=23034031 2024-08-20T19:37:43.386Z,1724182663.386 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T19:37:43.386Z,1724182663.386 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T19:37:43.386Z,1724182663.386 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T19:37:59.107Z,1724182679.107 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T19:38:29.811Z,1724182709.811 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:42:44.004Z,1724182964.004 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T19:42:44.004Z,1724182964.004 [Default:CheckIn:C.Wait] Stopped 2024-08-20T19:42:44.004Z,1724182964.004 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T19:42:44.005Z,1724182964.005 [Default:CheckIn:D] Running Loop=1 2024-08-20T19:42:44.399Z,1724182964.399 [Default:CheckIn:D] Stopped 2024-08-20T19:42:44.399Z,1724182964.399 [Default:CheckIn:E] Running Loop=1 2024-08-20T19:42:44.807Z,1724182964.807 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 116.504663 min 2024-08-20T19:42:44.807Z,1724182964.807 [Default:CheckIn:E] Stopped 2024-08-20T19:42:44.807Z,1724182964.807 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T19:42:44.807Z,1724182964.807 [Default:CheckIn] Stopped 2024-08-20T19:42:44.808Z,1724182964.808 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T19:42:44.808Z,1724182964.808 [Default:CheckIn](INFO): Running loop #12 2024-08-20T19:42:44.808Z,1724182964.808 [Default:CheckIn] Running Loop=12 2024-08-20T19:42:44.808Z,1724182964.808 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T19:42:44.808Z,1724182964.808 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T19:43:17.517Z,1724182997.517 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T19:43:17.596Z,1724182997.596 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T19:47:44.991Z,1724183264.991 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T19:42:44.8Z 2024-08-20T19:47:44.991Z,1724183264.991 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T19:47:44.991Z,1724183264.991 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T19:47:49.017Z,1724183269.017 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T19:47:51.883Z,1724183271.883 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0030.lzma 2024-08-20T19:47:52.886Z,1724183272.886 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0030.lzma.bak 2024-08-20T19:47:52.886Z,1724183272.886 [DataOverHttps](INFO): SBD MOMSN=23034257 2024-08-20T19:48:10.108Z,1724183290.108 [DataOverHttps](INFO): Sending 210 bytes from file Logs/20240820T175424/Express0031.lzma 2024-08-20T19:48:11.110Z,1724183291.110 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0031.lzma.bak 2024-08-20T19:48:11.110Z,1724183291.110 [DataOverHttps](INFO): SBD MOMSN=23034260 2024-08-20T19:48:13.681Z,1724183293.681 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T19:48:13.681Z,1724183293.681 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T19:48:13.681Z,1724183293.681 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T19:48:19.709Z,1724183299.709 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:51:06.693Z,1724183466.693 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T19:51:19.620Z,1724183479.620 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T19:53:14.310Z,1724183594.310 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T19:53:14.310Z,1724183594.310 [Default:CheckIn:C.Wait] Stopped 2024-08-20T19:53:14.310Z,1724183594.310 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T19:53:14.311Z,1724183594.311 [Default:CheckIn:D] Running Loop=1 2024-08-20T19:53:14.714Z,1724183594.714 [Default:CheckIn:D] Stopped 2024-08-20T19:53:14.714Z,1724183594.714 [Default:CheckIn:E] Running Loop=1 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 127.009904 min 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn:E] Stopped 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn] Stopped 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn](INFO): Running loop #13 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn] Running Loop=13 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T19:53:15.131Z,1724183595.131 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T19:53:16.719Z,1724183596.719 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T19:53:16.719Z,1724183596.719 [NAL9602] Data Fault, FailCount= 4 2024-08-20T19:53:16.719Z,1724183596.719 [NAL9602](ERROR): Data Fault 2024-08-20T19:53:16.786Z,1724183596.786 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T19:53:17.119Z,1724183597.119 [NAL9602](INFO): Powering down 2024-08-20T19:53:17.956Z,1724183597.956 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T19:53:17.956Z,1724183597.956 [NAL9602] No Fault, FailCount= 4 2024-08-20T19:53:24.851Z,1724183604.851 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T19:53:47.424Z,1724183627.424 [NAL9602](INFO): Powering up NAL9602 2024-08-20T19:53:58.332Z,1724183638.332 [NAL9602](INFO): NAL9602 initialized 2024-08-20T19:54:33.183Z,1724183673.183 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T19:55:12.730Z,1724183712.730 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T19:55:58.373Z,1724183758.373 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T19:58:15.293Z,1724183895.293 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T19:53:15.1Z 2024-08-20T19:58:15.293Z,1724183895.293 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T19:58:15.294Z,1724183895.294 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T19:58:19.432Z,1724183899.432 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T19:58:22.179Z,1724183902.179 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0033.lzma 2024-08-20T19:58:23.182Z,1724183903.182 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0033.lzma.bak 2024-08-20T19:58:23.182Z,1724183903.182 [DataOverHttps](INFO): SBD MOMSN=23034325 2024-08-20T19:58:40.672Z,1724183920.672 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240820T175424/Express0034.lzma 2024-08-20T19:58:41.674Z,1724183921.674 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0034.lzma.bak 2024-08-20T19:58:41.674Z,1724183921.674 [DataOverHttps](INFO): SBD MOMSN=23034327 2024-08-20T19:58:44.411Z,1724183924.411 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T19:58:44.411Z,1724183924.411 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T19:58:44.411Z,1724183924.411 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T19:58:59.782Z,1724183939.782 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T19:59:01.337Z,1724183941.337 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T19:59:32.043Z,1724183972.043 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T19:59:40.183Z,1724183980.183 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T19:59:59.577Z,1724183999.577 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:00:47.365Z,1724184047.365 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:01:13.983Z,1724184073.983 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:03:45.057Z,1724184225.057 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T20:03:45.057Z,1724184225.057 [Default:CheckIn:C.Wait] Stopped 2024-08-20T20:03:45.057Z,1724184225.057 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T20:03:45.058Z,1724184225.058 [Default:CheckIn:D] Running Loop=1 2024-08-20T20:03:45.459Z,1724184225.459 [Default:CheckIn:D] Stopped 2024-08-20T20:03:45.459Z,1724184225.459 [Default:CheckIn:E] Running Loop=1 2024-08-20T20:03:45.854Z,1724184225.854 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 137.522314 min 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn:E] Stopped 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn] Stopped 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn](INFO): Running loop #14 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn] Running Loop=14 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T20:03:45.855Z,1724184225.855 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T20:03:56.806Z,1724184236.806 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:04:18.555Z,1724184258.555 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T20:04:18.632Z,1724184258.632 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T20:04:23.463Z,1724184263.463 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:04:39.231Z,1724184279.231 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:05:07.896Z,1724184307.896 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:05:33.406Z,1724184333.406 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:08:16.182Z,1724184496.182 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:08:40.014Z,1724184520.014 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:08:46.041Z,1724184526.041 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T20:03:45.9Z 2024-08-20T20:08:46.041Z,1724184526.041 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T20:08:46.041Z,1724184526.041 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T20:08:50.057Z,1724184530.057 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T20:08:53.699Z,1724184533.699 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0036.lzma 2024-08-20T20:08:54.702Z,1724184534.702 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0036.lzma.bak 2024-08-20T20:08:54.702Z,1724184534.702 [DataOverHttps](INFO): SBD MOMSN=23034347 2024-08-20T20:09:06.271Z,1724184546.271 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:09:12.040Z,1724184552.040 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20240820T175424/Express0037.lzma 2024-08-20T20:09:13.042Z,1724184553.042 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0037.lzma.bak 2024-08-20T20:09:13.042Z,1724184553.042 [DataOverHttps](INFO): SBD MOMSN=23034351 2024-08-20T20:09:15.536Z,1724184555.536 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T20:09:15.536Z,1724184555.536 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T20:09:15.536Z,1724184555.536 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T20:09:20.785Z,1724184560.785 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T20:10:14.205Z,1724184614.205 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:11:08.751Z,1724184668.751 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:12:54.552Z,1724184774.552 [BPC1](ERROR): BPC1A failed to parse battery stick message. 2024-08-20T20:12:57.829Z,1724184777.829 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:13:10.352Z,1724184790.352 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:14:01.317Z,1724184841.317 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:14:16.178Z,1724184856.178 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T20:14:16.178Z,1724184856.178 [Default:CheckIn:C.Wait] Stopped 2024-08-20T20:14:16.178Z,1724184856.178 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T20:14:16.179Z,1724184856.179 [Default:CheckIn:D] Running Loop=1 2024-08-20T20:14:16.564Z,1724184856.564 [Default:CheckIn:D] Stopped 2024-08-20T20:14:16.564Z,1724184856.564 [Default:CheckIn:E] Running Loop=1 2024-08-20T20:14:16.970Z,1724184856.970 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 148.040739 min 2024-08-20T20:14:16.970Z,1724184856.970 [Default:CheckIn:E] Stopped 2024-08-20T20:14:16.970Z,1724184856.970 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T20:14:16.970Z,1724184856.970 [Default:CheckIn] Stopped 2024-08-20T20:14:16.970Z,1724184856.970 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T20:14:16.971Z,1724184856.971 [Default:CheckIn](INFO): Running loop #15 2024-08-20T20:14:16.971Z,1724184856.971 [Default:CheckIn] Running Loop=15 2024-08-20T20:14:16.971Z,1724184856.971 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T20:14:16.971Z,1724184856.971 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T20:14:18.580Z,1724184858.580 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T20:14:18.580Z,1724184858.580 [NAL9602] Data Fault, FailCount= 5 2024-08-20T20:14:18.580Z,1724184858.580 [NAL9602](ERROR): Data Fault 2024-08-20T20:14:18.602Z,1724184858.602 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T20:14:18.603Z,1724184858.603 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-08-20T20:14:19.001Z,1724184859.001 [NAL9602](INFO): Powering down 2024-08-20T20:14:19.021Z,1724184859.021 [CBIT](INFO): Critical error at 20240820T201418 2024-08-20T20:16:17.407Z,1724184977.407 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:16:18.614Z,1724184978.614 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T20:16:18.614Z,1724184978.614 [NAL9602] No Fault, FailCount= 5 2024-08-20T20:16:18.985Z,1724184978.985 [NAL9602](INFO): Powering up NAL9602 2024-08-20T20:16:29.872Z,1724184989.872 [NAL9602](INFO): NAL9602 initialized 2024-08-20T20:17:30.125Z,1724185050.125 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:18:10.533Z,1724185090.533 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:18:19.014Z,1724185099.014 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T20:19:04.258Z,1724185144.258 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T20:19:17.204Z,1724185157.204 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T20:14:16.0Z 2024-08-20T20:19:17.205Z,1724185157.205 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T20:19:17.205Z,1724185157.205 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T20:19:24.335Z,1724185164.335 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20240820T175424/Courier0039.lzma 2024-08-20T20:19:25.338Z,1724185165.338 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0039.lzma.bak 2024-08-20T20:19:25.338Z,1724185165.338 [DataOverHttps](INFO): SBD MOMSN=23034385 2024-08-20T20:19:43.724Z,1724185183.724 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240820T175424/Express0040.lzma 2024-08-20T20:19:44.726Z,1724185184.726 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0040.lzma.bak 2024-08-20T20:19:44.726Z,1724185184.726 [DataOverHttps](INFO): SBD MOMSN=23034390 2024-08-20T20:19:47.019Z,1724185187.019 [BPC1](FAULT): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2024-08-20T20:19:47.019Z,1724185187.019 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6. 2024-08-20T20:19:47.022Z,1724185187.022 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-08-20T20:19:47.480Z,1724185187.480 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T20:19:47.480Z,1724185187.480 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T20:19:47.480Z,1724185187.480 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T20:21:32.901Z,1724185292.901 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T20:22:03.617Z,1724185323.616 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T20:24:48.056Z,1724185488.056 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T20:24:48.056Z,1724185488.056 [Default:CheckIn:C.Wait] Stopped 2024-08-20T20:24:48.056Z,1724185488.056 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T20:24:48.056Z,1724185488.056 [Default:CheckIn:D] Running Loop=1 2024-08-20T20:24:48.446Z,1724185488.446 [Default:CheckIn:D] Stopped 2024-08-20T20:24:48.446Z,1724185488.446 [Default:CheckIn:E] Running Loop=1 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 158.572103 min 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn:E] Stopped 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn] Stopped 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn](INFO): Running loop #16 2024-08-20T20:24:48.846Z,1724185488.846 [Default:CheckIn] Running Loop=16 2024-08-20T20:24:48.847Z,1724185488.847 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T20:24:48.847Z,1724185488.847 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T20:25:21.559Z,1724185521.559 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T20:25:21.636Z,1724185521.636 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T20:29:49.036Z,1724185789.036 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T20:24:48.8Z 2024-08-20T20:29:49.036Z,1724185789.036 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T20:29:49.036Z,1724185789.036 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T20:29:52.653Z,1724185792.653 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T20:29:56.711Z,1724185796.711 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20240820T175424/Courier0042.lzma 2024-08-20T20:29:57.714Z,1724185797.714 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0042.lzma.bak 2024-08-20T20:29:57.714Z,1724185797.714 [DataOverHttps](INFO): SBD MOMSN=23034571 2024-08-20T20:30:18.364Z,1724185818.364 [DataOverHttps](INFO): Sending 308 bytes from file Logs/20240820T175424/Express0043.lzma 2024-08-20T20:30:19.366Z,1724185819.366 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0043.lzma.bak 2024-08-20T20:30:19.366Z,1724185819.366 [DataOverHttps](INFO): SBD MOMSN=23034605 2024-08-20T20:30:22.590Z,1724185822.590 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T20:30:22.590Z,1724185822.590 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T20:30:22.590Z,1724185822.590 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T20:30:23.403Z,1724185823.403 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T20:35:23.160Z,1724186123.160 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T20:35:23.160Z,1724186123.160 [Default:CheckIn:C.Wait] Stopped 2024-08-20T20:35:23.160Z,1724186123.160 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T20:35:23.161Z,1724186123.161 [Default:CheckIn:D] Running Loop=1 2024-08-20T20:35:23.570Z,1724186123.570 [Default:CheckIn:D] Stopped 2024-08-20T20:35:23.570Z,1724186123.570 [Default:CheckIn:E] Running Loop=1 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 169.157503 min 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn:E] Stopped 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn] Stopped 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn](INFO): Running loop #17 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn] Running Loop=17 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T20:35:23.971Z,1724186123.971 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T20:35:25.567Z,1724186125.567 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T20:35:25.567Z,1724186125.567 [NAL9602] Data Fault, FailCount= 1 2024-08-20T20:35:25.567Z,1724186125.567 [NAL9602](ERROR): Data Fault 2024-08-20T20:35:25.629Z,1724186125.629 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T20:35:25.971Z,1724186125.971 [NAL9602](INFO): Powering down 2024-08-20T20:35:26.802Z,1724186126.802 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T20:35:26.802Z,1724186126.802 [NAL9602] No Fault, FailCount= 1 2024-08-20T20:35:56.271Z,1724186156.271 [NAL9602](INFO): Powering up NAL9602 2024-08-20T20:36:07.183Z,1724186167.183 [NAL9602](INFO): NAL9602 initialized 2024-08-20T20:40:24.159Z,1724186424.159 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T20:35:23.0Z 2024-08-20T20:40:24.159Z,1724186424.159 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T20:40:24.160Z,1724186424.160 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T20:40:34.751Z,1724186434.751 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0045.lzma 2024-08-20T20:40:35.766Z,1724186435.766 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0045.lzma.bak 2024-08-20T20:40:35.766Z,1724186435.766 [DataOverHttps](INFO): SBD MOMSN=23034646 2024-08-20T20:40:51.868Z,1724186451.868 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240820T175424/Express0046.lzma 2024-08-20T20:40:52.870Z,1724186452.870 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0046.lzma.bak 2024-08-20T20:40:52.870Z,1724186452.870 [DataOverHttps](INFO): SBD MOMSN=23034648 2024-08-20T20:40:55.685Z,1724186455.685 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T20:40:55.685Z,1724186455.685 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T20:40:55.685Z,1724186455.685 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T20:41:10.193Z,1724186470.193 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T20:41:40.893Z,1724186500.893 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T20:45:56.235Z,1724186756.235 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T20:45:56.235Z,1724186756.235 [Default:CheckIn:C.Wait] Stopped 2024-08-20T20:45:56.235Z,1724186756.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T20:45:56.236Z,1724186756.236 [Default:CheckIn:D] Running Loop=1 2024-08-20T20:45:56.637Z,1724186756.637 [Default:CheckIn:D] Stopped 2024-08-20T20:45:56.637Z,1724186756.637 [Default:CheckIn:E] Running Loop=1 2024-08-20T20:45:57.046Z,1724186757.046 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 179.708626 min 2024-08-20T20:45:57.046Z,1724186757.046 [Default:CheckIn:E] Stopped 2024-08-20T20:45:57.046Z,1724186757.046 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T20:45:57.046Z,1724186757.046 [Default:CheckIn] Stopped 2024-08-20T20:45:57.047Z,1724186757.047 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T20:45:57.047Z,1724186757.047 [Default:CheckIn](INFO): Running loop #18 2024-08-20T20:45:57.047Z,1724186757.047 [Default:CheckIn] Running Loop=18 2024-08-20T20:45:57.047Z,1724186757.047 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T20:45:57.047Z,1724186757.047 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T20:50:57.229Z,1724187057.229 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T20:45:57.0Z 2024-08-20T20:50:57.229Z,1724187057.229 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T20:50:57.230Z,1724187057.230 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T20:51:01.241Z,1724187061.241 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T20:51:04.031Z,1724187064.031 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0048.lzma 2024-08-20T20:51:05.034Z,1724187065.034 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0048.lzma.bak 2024-08-20T20:51:05.035Z,1724187065.035 [DataOverHttps](INFO): SBD MOMSN=23034653 2024-08-20T20:51:22.164Z,1724187082.164 [DataOverHttps](INFO): Sending 209 bytes from file Logs/20240820T175424/Express0049.lzma 2024-08-20T20:51:23.166Z,1724187083.166 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0049.lzma.bak 2024-08-20T20:51:23.166Z,1724187083.166 [DataOverHttps](INFO): SBD MOMSN=23034655 2024-08-20T20:51:25.906Z,1724187085.906 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T20:51:25.906Z,1724187085.906 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T20:51:25.906Z,1724187085.906 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T20:51:31.945Z,1724187091.945 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T20:56:26.478Z,1724187386.478 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T20:56:26.478Z,1724187386.478 [Default:CheckIn:C.Wait] Stopped 2024-08-20T20:56:26.478Z,1724187386.478 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T20:56:26.478Z,1724187386.478 [Default:CheckIn:D] Running Loop=1 2024-08-20T20:56:26.897Z,1724187386.897 [Default:CheckIn:D] Stopped 2024-08-20T20:56:26.897Z,1724187386.897 [Default:CheckIn:E] Running Loop=1 2024-08-20T20:56:27.278Z,1724187387.278 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 190.212956 min 2024-08-20T20:56:27.278Z,1724187387.278 [Default:CheckIn:E] Stopped 2024-08-20T20:56:27.278Z,1724187387.278 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T20:56:27.278Z,1724187387.278 [Default:CheckIn] Stopped 2024-08-20T20:56:27.278Z,1724187387.278 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T20:56:27.279Z,1724187387.279 [Default:CheckIn](INFO): Running loop #19 2024-08-20T20:56:27.279Z,1724187387.279 [Default:CheckIn] Running Loop=19 2024-08-20T20:56:27.279Z,1724187387.279 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T20:56:27.279Z,1724187387.279 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T20:56:28.883Z,1724187388.883 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T20:56:28.883Z,1724187388.883 [NAL9602] Data Fault, FailCount= 2 2024-08-20T20:56:28.883Z,1724187388.883 [NAL9602](ERROR): Data Fault 2024-08-20T20:56:28.905Z,1724187388.905 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T20:56:29.292Z,1724187389.292 [NAL9602](INFO): Powering down 2024-08-20T20:56:30.135Z,1724187390.135 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T20:56:30.135Z,1724187390.135 [NAL9602] No Fault, FailCount= 2 2024-08-20T20:56:59.609Z,1724187419.609 [NAL9602](INFO): Powering up NAL9602 2024-08-20T20:57:10.495Z,1724187430.495 [NAL9602](INFO): NAL9602 initialized 2024-08-20T21:01:27.477Z,1724187687.477 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T20:56:27.3Z 2024-08-20T21:01:27.477Z,1724187687.477 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T21:01:27.477Z,1724187687.477 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T21:01:34.727Z,1724187694.727 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0051.lzma 2024-08-20T21:01:35.734Z,1724187695.734 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0051.lzma.bak 2024-08-20T21:01:35.734Z,1724187695.734 [DataOverHttps](INFO): SBD MOMSN=23034659 2024-08-20T21:01:52.920Z,1724187712.920 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240820T175424/Express0052.lzma 2024-08-20T21:01:53.922Z,1724187713.922 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0052.lzma.bak 2024-08-20T21:01:53.922Z,1724187713.922 [DataOverHttps](INFO): SBD MOMSN=23034661 2024-08-20T21:01:56.567Z,1724187716.567 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T21:01:56.567Z,1724187716.567 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T21:01:56.567Z,1724187716.567 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T21:02:13.503Z,1724187733.503 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T21:02:44.207Z,1724187764.207 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T21:06:57.130Z,1724188017.130 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T21:06:57.130Z,1724188017.130 [Default:CheckIn:C.Wait] Stopped 2024-08-20T21:06:57.130Z,1724188017.130 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T21:06:57.131Z,1724188017.131 [Default:CheckIn:D] Running Loop=1 2024-08-20T21:06:57.535Z,1724188017.535 [Default:CheckIn:D] Stopped 2024-08-20T21:06:57.535Z,1724188017.535 [Default:CheckIn:E] Running Loop=1 2024-08-20T21:06:57.947Z,1724188017.947 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 200.723584 min 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn:E] Stopped 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn] Stopped 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn](INFO): Running loop #20 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn] Running Loop=20 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T21:06:57.948Z,1724188017.948 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T21:07:30.641Z,1724188050.641 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-20T21:07:30.720Z,1724188050.720 [NAL9602](ERROR): received: +CSQ:0 OK 2024-08-20T21:11:58.119Z,1724188318.119 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T21:06:57.9Z 2024-08-20T21:11:58.119Z,1724188318.119 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T21:11:58.119Z,1724188318.119 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T21:12:02.542Z,1724188322.542 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T21:12:05.795Z,1724188325.795 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0054.lzma 2024-08-20T21:12:06.798Z,1724188326.798 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0054.lzma.bak 2024-08-20T21:12:06.798Z,1724188326.798 [DataOverHttps](INFO): SBD MOMSN=23034694 2024-08-20T21:12:23.876Z,1724188343.876 [DataOverHttps](INFO): Sending 211 bytes from file Logs/20240820T175424/Express0055.lzma 2024-08-20T21:12:24.878Z,1724188344.878 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0055.lzma.bak 2024-08-20T21:12:24.878Z,1724188344.878 [DataOverHttps](INFO): SBD MOMSN=23034696 2024-08-20T21:12:27.647Z,1724188347.647 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T21:12:27.647Z,1724188347.647 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T21:12:27.647Z,1724188347.647 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T21:12:33.244Z,1724188353.244 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-20T21:17:28.178Z,1724188648.178 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-20T21:17:28.178Z,1724188648.178 [Default:CheckIn:C.Wait] Stopped 2024-08-20T21:17:28.178Z,1724188648.178 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-20T21:17:28.179Z,1724188648.179 [Default:CheckIn:D] Running Loop=1 2024-08-20T21:17:28.584Z,1724188648.584 [Default:CheckIn:D] Stopped 2024-08-20T21:17:28.584Z,1724188648.584 [Default:CheckIn:E] Running Loop=1 2024-08-20T21:17:28.980Z,1724188648.980 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 211.240934 min 2024-08-20T21:17:28.980Z,1724188648.980 [Default:CheckIn:E] Stopped 2024-08-20T21:17:28.980Z,1724188648.980 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-20T21:17:28.980Z,1724188648.980 [Default:CheckIn] Stopped 2024-08-20T21:17:28.980Z,1724188648.980 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-20T21:17:28.981Z,1724188648.981 [Default:CheckIn](INFO): Running loop #21 2024-08-20T21:17:28.981Z,1724188648.981 [Default:CheckIn] Running Loop=21 2024-08-20T21:17:28.981Z,1724188648.981 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-20T21:17:28.981Z,1724188648.981 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-20T21:17:30.619Z,1724188650.619 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-08-20T21:17:30.619Z,1724188650.619 [NAL9602] Data Fault, FailCount= 3 2024-08-20T21:17:30.619Z,1724188650.619 [NAL9602](ERROR): Data Fault 2024-08-20T21:17:30.641Z,1724188650.641 [CBIT](ERROR): Data Fault in component: NAL9602 2024-08-20T21:17:30.993Z,1724188650.993 [NAL9602](INFO): Powering down 2024-08-20T21:17:31.835Z,1724188651.835 [CBIT](INFO): Clearing failed state for component NAL9602 2024-08-20T21:17:31.835Z,1724188651.835 [NAL9602] No Fault, FailCount= 3 2024-08-20T21:18:01.297Z,1724188681.297 [NAL9602](INFO): Powering up NAL9602 2024-08-20T21:18:12.202Z,1724188692.202 [NAL9602](INFO): NAL9602 initialized 2024-08-20T21:21:14.462Z,1724188874.462 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T21:22:22.334Z,1724188942.334 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-08-20T21:22:29.161Z,1724188949.161 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-08-20T21:17:28.0Z 2024-08-20T21:22:29.161Z,1724188949.161 [Default:CheckIn:Read_GPS] Stopped 2024-08-20T21:22:29.161Z,1724188949.161 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-20T21:22:36.179Z,1724188956.179 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240820T175424/Courier0057.lzma 2024-08-20T21:22:37.182Z,1724188957.182 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Courier0057.lzma.bak 2024-08-20T21:22:37.182Z,1724188957.182 [DataOverHttps](INFO): SBD MOMSN=23034706 2024-08-20T21:22:54.494Z,1724188974.494 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20240820T175424/Express0058.lzma 2024-08-20T21:22:55.494Z,1724188975.494 [DataOverHttps](INFO): Moved sent file to Logs/20240820T175424/Express0058.lzma.bak 2024-08-20T21:22:55.494Z,1724188975.494 [DataOverHttps](INFO): SBD MOMSN=23034708 2024-08-20T21:22:56.271Z,1724188976.271 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-08-20T21:22:58.279Z,1724188978.279 [Default:CheckIn:Read_Iridium] Stopped 2024-08-20T21:22:58.284Z,1724188978.284 [Default:CheckIn:C.Wait] Running Loop=1 2024-08-20T21:22:58.284Z,1724188978.284 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-08-20T21:23:15.200Z,1724188995.200 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-20T21:23:45.924Z,1724189025.924 [NAL9602](INFO): Not Powering down - fast GPS