2024-06-19T16:59:18.117Z,1718816358.117 [CommandExec](IMPORTANT): got command restart logs 2024-06-19T17:02:32.218Z,1718816552.218 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:02:32.218Z,1718816552.218 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:02:32.218Z,1718816552.218 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:02:32.219Z,1718816552.219 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:02:32.619Z,1718816552.619 [Default:CheckIn:D] Stopped 2024-06-19T17:02:32.619Z,1718816552.619 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:02:33.032Z,1718816553.032 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.165288 min 2024-06-19T17:02:33.032Z,1718816553.032 [Default:CheckIn:E] Stopped 2024-06-19T17:02:33.032Z,1718816553.032 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:02:33.033Z,1718816553.033 [Default:CheckIn] Stopped 2024-06-19T17:02:33.033Z,1718816553.033 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:02:33.033Z,1718816553.033 [Default:CheckIn](INFO): Running loop #3 2024-06-19T17:02:33.033Z,1718816553.033 [Default:CheckIn] Running Loop=3 2024-06-19T17:02:33.033Z,1718816553.033 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:02:33.033Z,1718816553.033 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:02:35.037Z,1718816555.037 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170234.00,A,3647.84876,N,12150.57044,W,6.317,52.28,190624,,,A*4F 2024-06-19T17:02:35.040Z,1718816555.040 [NAL9602](INFO): GPS fix at 20240619T170234: (36.797479, -121.842841) 2024-06-19T17:02:35.067Z,1718816555.067 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:02:35.067Z,1718816555.067 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:02:42.766Z,1718816562.766 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240618T194820/Courier0099.lzma 2024-06-19T17:02:43.769Z,1718816563.769 [DataOverHttps](INFO): Moved sent file to Logs/20240618T194820/Courier0099.lzma.bak 2024-06-19T17:02:43.769Z,1718816563.769 [DataOverHttps](INFO): SBD MOMSN=21257749 2024-06-19T17:02:49.605Z,1718816569.605 [NAL9602](INFO): SBD MO Status=0, MOMSN=53061, MT Status=0, MTMSN=0 2024-06-19T17:02:49.605Z,1718816569.605 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:03:03.074Z,1718816583.074 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240618T194820/Courier0102.lzma 2024-06-19T17:03:04.078Z,1718816584.078 [DataOverHttps](INFO): Moved sent file to Logs/20240618T194820/Courier0102.lzma.bak 2024-06-19T17:03:04.078Z,1718816584.078 [DataOverHttps](INFO): SBD MOMSN=21257753 2024-06-19T17:03:19.927Z,1718816599.927 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20240619T165918/Courier0000.lzma 2024-06-19T17:03:20.330Z,1718816600.330 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:03:20.928Z,1718816600.928 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0000.lzma.bak 2024-06-19T17:03:20.929Z,1718816600.929 [DataOverHttps](INFO): SBD MOMSN=21257755 2024-06-19T17:03:36.899Z,1718816616.899 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20240618T194820/Express0100.lzma 2024-06-19T17:03:37.901Z,1718816617.901 [DataOverHttps](INFO): Moved sent file to Logs/20240618T194820/Express0100.lzma.bak 2024-06-19T17:03:37.901Z,1718816617.901 [DataOverHttps](INFO): SBD MOMSN=21257759 2024-06-19T17:03:53.834Z,1718816633.834 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20240618T194820/Express0103.lzma 2024-06-19T17:03:54.837Z,1718816634.837 [DataOverHttps](INFO): Moved sent file to Logs/20240618T194820/Express0103.lzma.bak 2024-06-19T17:03:54.837Z,1718816634.837 [DataOverHttps](INFO): SBD MOMSN=21257765 2024-06-19T17:04:13.800Z,1718816653.800 [DataOverHttps](INFO): Sending 397 bytes from file Logs/20240619T165918/Express0001.lzma 2024-06-19T17:04:14.801Z,1718816654.801 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0001.lzma.bak 2024-06-19T17:04:14.801Z,1718816654.801 [DataOverHttps](INFO): SBD MOMSN=21257769 2024-06-19T17:04:34.050Z,1718816674.050 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20240619T165918/Express0004.lzma 2024-06-19T17:04:35.052Z,1718816675.052 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0004.lzma.bak 2024-06-19T17:04:35.052Z,1718816675.052 [DataOverHttps](INFO): SBD MOMSN=21257776 2024-06-19T17:04:36.351Z,1718816676.351 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:04:36.351Z,1718816676.351 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:04:36.351Z,1718816676.351 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:08:09.707Z,1718816889.707 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-06-19T17:08:40.835Z,1718816920.835 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-06-19T17:09:11.959Z,1718816951.959 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-06-19T17:09:36.930Z,1718816976.930 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:09:36.930Z,1718816976.930 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:09:36.930Z,1718816976.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:09:36.930Z,1718816976.930 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:09:37.334Z,1718816977.334 [Default:CheckIn:D] Stopped 2024-06-19T17:09:37.334Z,1718816977.334 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:09:37.738Z,1718816977.738 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.243866 min 2024-06-19T17:09:37.738Z,1718816977.739 [Default:CheckIn:E] Stopped 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn] Stopped 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn](INFO): Running loop #4 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn] Running Loop=4 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:09:37.739Z,1718816977.739 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:09:39.749Z,1718816979.749 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170938.00,A,3648.55843,N,12149.06867,W,0.855,119.12,190624,,,A*74 2024-06-19T17:09:39.760Z,1718816979.760 [NAL9602](INFO): GPS fix at 20240619T170938: (36.809307, -121.817811) 2024-06-19T17:09:39.771Z,1718816979.771 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:09:39.771Z,1718816979.771 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:09:43.091Z,1718816983.091 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-06-19T17:10:01.965Z,1718817001.965 [NAL9602](INFO): SBD MO Status=0, MOMSN=53062, MT Status=0, MTMSN=0 2024-06-19T17:10:01.965Z,1718817001.965 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:10:05.646Z,1718817005.646 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0006.lzma 2024-06-19T17:10:06.648Z,1718817006.648 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0006.lzma.bak 2024-06-19T17:10:06.648Z,1718817006.648 [DataOverHttps](INFO): SBD MOMSN=21257792 2024-06-19T17:10:26.243Z,1718817026.243 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20240619T165918/Express0007.lzma 2024-06-19T17:10:27.244Z,1718817027.244 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0007.lzma.bak 2024-06-19T17:10:27.245Z,1718817027.245 [DataOverHttps](INFO): SBD MOMSN=21257803 2024-06-19T17:10:28.702Z,1718817028.702 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:10:28.712Z,1718817028.712 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:10:28.712Z,1718817028.712 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:10:32.716Z,1718817032.716 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:15:29.282Z,1718817329.282 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:15:29.283Z,1718817329.283 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:15:29.283Z,1718817329.283 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:15:29.283Z,1718817329.283 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:15:29.712Z,1718817329.712 [Default:CheckIn:D] Stopped 2024-06-19T17:15:29.712Z,1718817329.712 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:15:30.097Z,1718817330.097 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.116838 min 2024-06-19T17:15:30.097Z,1718817330.097 [Default:CheckIn:E] Stopped 2024-06-19T17:15:30.097Z,1718817330.097 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:15:30.097Z,1718817330.097 [Default:CheckIn] Stopped 2024-06-19T17:15:30.098Z,1718817330.098 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:15:30.098Z,1718817330.098 [Default:CheckIn](INFO): Running loop #5 2024-06-19T17:15:30.098Z,1718817330.098 [Default:CheckIn] Running Loop=5 2024-06-19T17:15:30.098Z,1718817330.098 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:15:30.098Z,1718817330.098 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:15:32.099Z,1718817332.099 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171531.00,A,3648.33338,N,12149.37614,W,0.389,60.08,190624,,,A*41 2024-06-19T17:15:32.101Z,1718817332.101 [NAL9602](INFO): GPS fix at 20240619T171531: (36.805556, -121.822936) 2024-06-19T17:15:32.128Z,1718817332.128 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:15:32.128Z,1718817332.128 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:15:39.426Z,1718817339.426 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0009.lzma 2024-06-19T17:15:40.428Z,1718817340.428 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0009.lzma.bak 2024-06-19T17:15:40.429Z,1718817340.429 [DataOverHttps](INFO): SBD MOMSN=21257818 2024-06-19T17:15:56.387Z,1718817356.387 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240619T165918/Express0010.lzma 2024-06-19T17:15:58.392Z,1718817358.392 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0010.lzma.bak 2024-06-19T17:15:58.392Z,1718817358.392 [DataOverHttps](INFO): SBD MOMSN=21257823 2024-06-19T17:15:59.645Z,1718817359.645 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:15:59.646Z,1718817359.646 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:15:59.646Z,1718817359.646 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:16:08.862Z,1718817368.862 [NAL9602](INFO): SBD MO Status=2, MOMSN=53063, MT Status=2, MTMSN=0 2024-06-19T17:16:08.862Z,1718817368.862 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T17:16:21.789Z,1718817381.789 [NAL9602](INFO): SBD MO Status=0, MOMSN=53063, MT Status=0, MTMSN=0 2024-06-19T17:16:21.789Z,1718817381.789 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:16:52.495Z,1718817412.495 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:20:03.544Z,1718817603.544 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-06-19T17:21:00.167Z,1718817660.167 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:21:00.167Z,1718817660.167 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:21:00.167Z,1718817660.167 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:21:00.167Z,1718817660.167 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:21:00.578Z,1718817660.578 [Default:CheckIn:D] Stopped 2024-06-19T17:21:00.578Z,1718817660.578 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:21:00.970Z,1718817660.970 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.631274 min 2024-06-19T17:21:00.970Z,1718817660.970 [Default:CheckIn:E] Stopped 2024-06-19T17:21:00.970Z,1718817660.970 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:21:00.970Z,1718817660.970 [Default:CheckIn] Stopped 2024-06-19T17:21:00.970Z,1718817660.970 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:21:00.970Z,1718817660.970 [Default:CheckIn](INFO): Running loop #6 2024-06-19T17:21:00.971Z,1718817660.971 [Default:CheckIn] Running Loop=6 2024-06-19T17:21:00.971Z,1718817660.971 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:21:00.971Z,1718817660.971 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:21:02.977Z,1718817662.977 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172102.00,A,3648.33037,N,12149.24212,W,4.685,112.65,190624,,,A*78 2024-06-19T17:21:02.980Z,1718817662.980 [NAL9602](INFO): GPS fix at 20240619T172102: (36.805506, -121.820702) 2024-06-19T17:21:02.991Z,1718817662.991 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:21:02.991Z,1718817662.991 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:21:10.099Z,1718817670.099 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0012.lzma 2024-06-19T17:21:11.112Z,1718817671.112 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0012.lzma.bak 2024-06-19T17:21:11.112Z,1718817671.112 [DataOverHttps](INFO): SBD MOMSN=21257836 2024-06-19T17:21:15.905Z,1718817675.905 [NAL9602](INFO): SBD MO Status=0, MOMSN=53064, MT Status=0, MTMSN=0 2024-06-19T17:21:15.906Z,1718817675.906 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:21:29.119Z,1718817689.119 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20240619T165918/Express0013.lzma 2024-06-19T17:21:30.121Z,1718817690.121 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0013.lzma.bak 2024-06-19T17:21:30.121Z,1718817690.121 [DataOverHttps](INFO): SBD MOMSN=21257840 2024-06-19T17:21:31.280Z,1718817691.280 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:21:31.281Z,1718817691.281 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:21:31.281Z,1718817691.281 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:21:46.621Z,1718817706.621 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:26:31.853Z,1718817991.853 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:26:31.853Z,1718817991.853 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:26:31.854Z,1718817991.854 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:26:31.854Z,1718817991.854 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:26:32.260Z,1718817992.260 [Default:CheckIn:D] Stopped 2024-06-19T17:26:32.260Z,1718817992.260 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:26:32.674Z,1718817992.674 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.159302 min 2024-06-19T17:26:32.674Z,1718817992.674 [Default:CheckIn:E] Stopped 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn] Stopped 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn](INFO): Running loop #7 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn] Running Loop=7 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:26:32.675Z,1718817992.675 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:26:34.673Z,1718817994.673 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172633.00,A,3648.27264,N,12148.72619,W,5.618,88.07,190624,,,A*42 2024-06-19T17:26:34.676Z,1718817994.676 [NAL9602](INFO): GPS fix at 20240619T172633: (36.804544, -121.812103) 2024-06-19T17:26:34.687Z,1718817994.687 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:26:34.687Z,1718817994.687 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:26:42.074Z,1718818002.074 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0015.lzma 2024-06-19T17:26:43.076Z,1718818003.076 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0015.lzma.bak 2024-06-19T17:26:43.076Z,1718818003.076 [DataOverHttps](INFO): SBD MOMSN=21257859 2024-06-19T17:27:02.271Z,1718818022.271 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240619T165918/Express0016.lzma 2024-06-19T17:27:03.272Z,1718818023.272 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0016.lzma.bak 2024-06-19T17:27:03.272Z,1718818023.272 [DataOverHttps](INFO): SBD MOMSN=21257862 2024-06-19T17:27:04.755Z,1718818024.755 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:27:04.755Z,1718818024.755 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:27:04.755Z,1718818024.755 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:27:09.461Z,1718818029.461 [NAL9602](INFO): SBD MO Status=2, MOMSN=53065, MT Status=2, MTMSN=0 2024-06-19T17:27:09.461Z,1718818029.461 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T17:27:30.469Z,1718818050.469 [NAL9602](INFO): SBD MO Status=2, MOMSN=53065, MT Status=2, MTMSN=0 2024-06-19T17:27:30.470Z,1718818050.470 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T17:27:42.992Z,1718818062.992 [Sonardyne_Nano](ERROR): Failed to parse response: >VS:2109,HPR45,EXT,TILT 2024-06-19T17:27:53.093Z,1718818073.093 [NAL9602](INFO): SBD MO Status=0, MOMSN=53065, MT Status=0, MTMSN=0 2024-06-19T17:27:53.093Z,1718818073.093 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:28:23.796Z,1718818103.796 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:32:05.205Z,1718818325.205 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:32:05.205Z,1718818325.205 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:32:05.206Z,1718818325.206 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:32:05.206Z,1718818325.206 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:32:05.605Z,1718818325.605 [Default:CheckIn:D] Stopped 2024-06-19T17:32:05.605Z,1718818325.605 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:32:06.015Z,1718818326.015 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.715051 min 2024-06-19T17:32:06.015Z,1718818326.015 [Default:CheckIn:E] Stopped 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn] Stopped 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn](INFO): Running loop #8 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn] Running Loop=8 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:32:06.016Z,1718818326.016 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:32:08.021Z,1718818328.021 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173207.00,A,3648.23133,N,12148.10091,W,5.482,93.39,190624,,,A*41 2024-06-19T17:32:08.024Z,1718818328.024 [NAL9602](INFO): GPS fix at 20240619T173207: (36.803855, -121.801682) 2024-06-19T17:32:08.035Z,1718818328.035 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:32:08.035Z,1718818328.035 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:32:15.742Z,1718818335.742 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0018.lzma 2024-06-19T17:32:16.745Z,1718818336.745 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0018.lzma.bak 2024-06-19T17:32:16.745Z,1718818336.745 [DataOverHttps](INFO): SBD MOMSN=21257882 2024-06-19T17:32:28.265Z,1718818348.265 [NAL9602](INFO): SBD MO Status=0, MOMSN=53066, MT Status=0, MTMSN=0 2024-06-19T17:32:28.265Z,1718818348.265 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:32:35.071Z,1718818355.071 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20240619T165918/Express0019.lzma 2024-06-19T17:32:36.072Z,1718818356.072 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0019.lzma.bak 2024-06-19T17:32:36.072Z,1718818356.072 [DataOverHttps](INFO): SBD MOMSN=21257885 2024-06-19T17:32:37.159Z,1718818357.159 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:32:37.159Z,1718818357.159 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:32:37.159Z,1718818357.159 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:32:58.967Z,1718818378.967 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:37:37.750Z,1718818657.750 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:37:37.750Z,1718818657.750 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:37:37.750Z,1718818657.750 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:37:37.751Z,1718818657.751 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:37:38.159Z,1718818658.159 [Default:CheckIn:D] Stopped 2024-06-19T17:37:38.159Z,1718818658.159 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:37:38.564Z,1718818658.564 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.257625 min 2024-06-19T17:37:38.564Z,1718818658.564 [Default:CheckIn:E] Stopped 2024-06-19T17:37:38.564Z,1718818658.564 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:37:38.564Z,1718818658.564 [Default:CheckIn] Stopped 2024-06-19T17:37:38.565Z,1718818658.565 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:37:38.565Z,1718818658.565 [Default:CheckIn](INFO): Running loop #9 2024-06-19T17:37:38.565Z,1718818658.565 [Default:CheckIn] Running Loop=9 2024-06-19T17:37:38.565Z,1718818658.565 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:37:38.565Z,1718818658.565 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:37:40.566Z,1718818660.566 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173739.00,A,3648.27700,N,12147.58235,W,0.447,72.71,190624,,,A*4B 2024-06-19T17:37:40.568Z,1718818660.568 [NAL9602](INFO): GPS fix at 20240619T173739: (36.804617, -121.793039) 2024-06-19T17:37:40.604Z,1718818660.604 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:37:40.604Z,1718818660.604 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:37:48.202Z,1718818668.202 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0021.lzma 2024-06-19T17:37:49.200Z,1718818669.200 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0021.lzma.bak 2024-06-19T17:37:49.200Z,1718818669.200 [DataOverHttps](INFO): SBD MOMSN=21257901 2024-06-19T17:37:55.513Z,1718818675.513 [NAL9602](INFO): SBD MO Status=0, MOMSN=53067, MT Status=0, MTMSN=0 2024-06-19T17:37:55.513Z,1718818675.513 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:38:05.167Z,1718818685.167 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240619T165918/Express0022.lzma 2024-06-19T17:38:06.168Z,1718818686.168 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0022.lzma.bak 2024-06-19T17:38:06.169Z,1718818686.169 [DataOverHttps](INFO): SBD MOMSN=21257906 2024-06-19T17:38:07.255Z,1718818687.255 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:38:07.255Z,1718818687.255 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:38:07.256Z,1718818687.256 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:38:26.224Z,1718818706.224 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:39:57.141Z,1718818797.141 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:40:10.453Z,1718818810.453 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:40:22.573Z,1718818822.573 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:40:35.097Z,1718818835.097 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:40:48.025Z,1718818848.025 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:41:00.549Z,1718818860.549 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:41:13.477Z,1718818873.477 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T17:41:26.809Z,1718818886.809 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-06-19T17:42:20.567Z,1718818940.567 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-06-19T17:43:07.871Z,1718818987.871 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:43:07.871Z,1718818987.871 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:43:07.871Z,1718818987.871 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:43:07.872Z,1718818987.872 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:43:08.262Z,1718818988.262 [Default:CheckIn:D] Stopped 2024-06-19T17:43:08.262Z,1718818988.262 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:43:08.667Z,1718818988.667 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.759338 min 2024-06-19T17:43:08.667Z,1718818988.667 [Default:CheckIn:E] Stopped 2024-06-19T17:43:08.667Z,1718818988.667 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:43:08.668Z,1718818988.668 [Default:CheckIn] Stopped 2024-06-19T17:43:08.668Z,1718818988.668 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:43:08.668Z,1718818988.668 [Default:CheckIn](INFO): Running loop #10 2024-06-19T17:43:08.668Z,1718818988.668 [Default:CheckIn] Running Loop=10 2024-06-19T17:43:08.668Z,1718818988.668 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:43:08.668Z,1718818988.668 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:43:10.670Z,1718818990.670 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174309.00,A,3648.47461,N,12147.24726,W,4.393,47.96,190624,,,A*40 2024-06-19T17:43:10.672Z,1718818990.672 [NAL9602](INFO): GPS fix at 20240619T174309: (36.807910, -121.787454) 2024-06-19T17:43:10.683Z,1718818990.683 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:43:10.683Z,1718818990.683 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:43:18.710Z,1718818998.710 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0024.lzma 2024-06-19T17:43:19.874Z,1718818999.874 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0024.lzma.bak 2024-06-19T17:43:19.875Z,1718818999.875 [DataOverHttps](INFO): SBD MOMSN=21257929 2024-06-19T17:43:25.213Z,1718819005.213 [NAL9602](INFO): SBD MO Status=0, MOMSN=53068, MT Status=0, MTMSN=0 2024-06-19T17:43:25.213Z,1718819005.213 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:43:35.771Z,1718819015.771 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20240619T165918/Express0025.lzma 2024-06-19T17:43:36.772Z,1718819016.772 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0025.lzma.bak 2024-06-19T17:43:36.772Z,1718819016.772 [DataOverHttps](INFO): SBD MOMSN=21257932 2024-06-19T17:43:38.155Z,1718819018.155 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:43:38.155Z,1718819018.155 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:43:38.155Z,1718819018.155 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:43:53.497Z,1718819033.497 [BPC1](INFO): Calculating totals. Valid battery stick count: 40. Valid reserve battery stick count: 6. 2024-06-19T17:43:53.500Z,1718819033.500 [BPC1](INFO): Received data from all battery sticks. 2024-06-19T17:43:55.919Z,1718819035.919 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:48:38.756Z,1718819318.756 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:48:38.756Z,1718819318.756 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:48:38.756Z,1718819318.756 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:48:38.756Z,1718819318.756 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:48:39.165Z,1718819319.165 [Default:CheckIn:D] Stopped 2024-06-19T17:48:39.165Z,1718819319.165 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:48:39.558Z,1718819319.558 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.274398 min 2024-06-19T17:48:39.558Z,1718819319.558 [Default:CheckIn:E] Stopped 2024-06-19T17:48:39.558Z,1718819319.558 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:48:39.558Z,1718819319.558 [Default:CheckIn] Stopped 2024-06-19T17:48:39.558Z,1718819319.558 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:48:39.559Z,1718819319.559 [Default:CheckIn](INFO): Running loop #11 2024-06-19T17:48:39.559Z,1718819319.559 [Default:CheckIn] Running Loop=11 2024-06-19T17:48:39.559Z,1718819319.559 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:48:39.559Z,1718819319.559 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:48:41.564Z,1718819321.564 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174840.00,A,3648.32806,N,12147.12695,W,2.935,187.82,190624,,,A*7D 2024-06-19T17:48:41.567Z,1718819321.567 [NAL9602](INFO): GPS fix at 20240619T174840: (36.805468, -121.785449) 2024-06-19T17:48:41.577Z,1718819321.577 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:48:41.577Z,1718819321.577 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:48:49.335Z,1718819329.335 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20240619T165918/Courier0027.lzma 2024-06-19T17:48:50.337Z,1718819330.337 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0027.lzma.bak 2024-06-19T17:48:50.337Z,1718819330.337 [DataOverHttps](INFO): SBD MOMSN=21257954 2024-06-19T17:49:08.570Z,1718819348.570 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240619T165918/Express0028.lzma 2024-06-19T17:49:09.843Z,1718819349.843 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0028.lzma.bak 2024-06-19T17:49:09.844Z,1718819349.844 [DataOverHttps](INFO): SBD MOMSN=21257957 2024-06-19T17:49:10.713Z,1718819350.713 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:49:10.713Z,1718819350.713 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:49:10.713Z,1718819350.713 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:49:13.921Z,1718819353.921 [NAL9602](INFO): SBD MO Status=0, MOMSN=53069, MT Status=0, MTMSN=0 2024-06-19T17:49:13.921Z,1718819353.921 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:49:44.624Z,1718819384.624 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:54:11.358Z,1718819651.358 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:54:11.358Z,1718819651.358 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:54:11.358Z,1718819651.358 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:54:11.358Z,1718819651.358 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:54:11.777Z,1718819651.777 [Default:CheckIn:D] Stopped 2024-06-19T17:54:11.777Z,1718819651.777 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:54:12.163Z,1718819652.163 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.817928 min 2024-06-19T17:54:12.163Z,1718819652.163 [Default:CheckIn:E] Stopped 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn] Stopped 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn](INFO): Running loop #12 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn] Running Loop=12 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:54:12.164Z,1718819652.164 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:54:14.170Z,1718819654.170 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175413.00,A,3648.12214,N,12147.18962,W,0.350,205.20,190624,,,A*7A 2024-06-19T17:54:14.172Z,1718819654.172 [NAL9602](INFO): GPS fix at 20240619T175413: (36.802036, -121.786494) 2024-06-19T17:54:14.183Z,1718819654.183 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:54:14.183Z,1718819654.183 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:54:28.890Z,1718819668.890 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0030.lzma 2024-06-19T17:54:29.892Z,1718819669.892 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0030.lzma.bak 2024-06-19T17:54:29.893Z,1718819669.893 [DataOverHttps](INFO): SBD MOMSN=21257978 2024-06-19T17:54:35.269Z,1718819675.269 [NAL9602](INFO): SBD MO Status=2, MOMSN=53070, MT Status=2, MTMSN=0 2024-06-19T17:54:35.270Z,1718819675.270 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T17:54:46.107Z,1718819686.107 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20240619T165918/Express0031.lzma 2024-06-19T17:54:47.108Z,1718819687.108 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0031.lzma.bak 2024-06-19T17:54:47.108Z,1718819687.108 [DataOverHttps](INFO): SBD MOMSN=21257981 2024-06-19T17:54:48.682Z,1718819688.682 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T17:54:48.683Z,1718819688.683 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T17:54:48.683Z,1718819688.683 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T17:54:52.681Z,1718819692.681 [NAL9602](INFO): SBD MO Status=2, MOMSN=53070, MT Status=2, MTMSN=0 2024-06-19T17:54:52.682Z,1718819692.682 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T17:57:00.062Z,1718819820.062 [NAL9602](INFO): SBD MO Status=0, MOMSN=53070, MT Status=0, MTMSN=0 2024-06-19T17:57:00.062Z,1718819820.062 [NAL9602](INFO): No messages in MT queue 2024-06-19T17:57:30.759Z,1718819850.759 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T17:59:49.427Z,1718819989.427 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T17:59:49.428Z,1718819989.428 [Default:CheckIn:C.Wait] Stopped 2024-06-19T17:59:49.428Z,1718819989.428 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T17:59:49.428Z,1718819989.428 [Default:CheckIn:D] Running Loop=1 2024-06-19T17:59:49.838Z,1718819989.838 [Default:CheckIn:D] Stopped 2024-06-19T17:59:49.838Z,1718819989.838 [Default:CheckIn:E] Running Loop=1 2024-06-19T17:59:50.257Z,1718819990.257 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.452271 min 2024-06-19T17:59:50.257Z,1718819990.257 [Default:CheckIn:E] Stopped 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn] Stopped 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn](INFO): Running loop #13 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn] Running Loop=13 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T17:59:50.258Z,1718819990.258 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T17:59:52.244Z,1718819992.244 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175951.00,A,3648.13185,N,12147.20970,W,0.078,285.72,190624,,,A*75 2024-06-19T17:59:52.247Z,1718819992.247 [NAL9602](INFO): GPS fix at 20240619T175951: (36.802197, -121.786828) 2024-06-19T17:59:52.257Z,1718819992.257 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T17:59:52.257Z,1718819992.257 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T17:59:59.450Z,1718819999.450 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240619T165918/Courier0033.lzma 2024-06-19T18:00:00.452Z,1718820000.452 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0033.lzma.bak 2024-06-19T18:00:00.453Z,1718820000.453 [DataOverHttps](INFO): SBD MOMSN=21257999 2024-06-19T18:00:16.310Z,1718820016.310 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20240619T165918/Express0034.lzma 2024-06-19T18:00:17.312Z,1718820017.312 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0034.lzma.bak 2024-06-19T18:00:17.313Z,1718820017.313 [DataOverHttps](INFO): SBD MOMSN=21258002 2024-06-19T18:00:18.526Z,1718820018.526 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:00:18.527Z,1718820018.527 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:00:18.527Z,1718820018.527 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:00:33.513Z,1718820033.513 [NAL9602](INFO): SBD MO Status=0, MOMSN=53071, MT Status=0, MTMSN=0 2024-06-19T18:00:33.513Z,1718820033.513 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:01:04.259Z,1718820064.259 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:05:19.284Z,1718820319.284 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:05:19.284Z,1718820319.284 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:05:19.284Z,1718820319.284 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:05:19.284Z,1718820319.284 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:05:19.706Z,1718820319.706 [Default:CheckIn:D] Stopped 2024-06-19T18:05:19.706Z,1718820319.706 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.950073 min 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn:E] Stopped 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn] Stopped 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn](INFO): Running loop #14 2024-06-19T18:05:20.091Z,1718820320.091 [Default:CheckIn] Running Loop=14 2024-06-19T18:05:20.092Z,1718820320.092 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:05:20.092Z,1718820320.092 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:05:22.097Z,1718820322.097 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180521.00,A,3648.13172,N,12147.20994,W,0.019,285.72,190624,,,A*71 2024-06-19T18:05:22.100Z,1718820322.100 [NAL9602](INFO): GPS fix at 20240619T180521: (36.802195, -121.786832) 2024-06-19T18:05:22.110Z,1718820322.110 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:05:22.110Z,1718820322.110 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:05:29.002Z,1718820329.002 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0036.lzma 2024-06-19T18:05:30.004Z,1718820330.004 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0036.lzma.bak 2024-06-19T18:05:30.004Z,1718820330.004 [DataOverHttps](INFO): SBD MOMSN=21258020 2024-06-19T18:05:38.256Z,1718820338.256 [NAL9602](INFO): SBD MO Status=0, MOMSN=53072, MT Status=0, MTMSN=0 2024-06-19T18:05:38.256Z,1718820338.256 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:05:46.262Z,1718820346.262 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0037.lzma 2024-06-19T18:05:47.264Z,1718820347.264 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0037.lzma.bak 2024-06-19T18:05:47.265Z,1718820347.265 [DataOverHttps](INFO): SBD MOMSN=21258023 2024-06-19T18:05:48.773Z,1718820348.773 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:05:48.773Z,1718820348.773 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:05:48.774Z,1718820348.774 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:06:08.964Z,1718820368.964 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:10:49.506Z,1718820649.506 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:10:49.506Z,1718820649.506 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:10:49.507Z,1718820649.507 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:10:49.507Z,1718820649.507 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:10:49.935Z,1718820649.935 [Default:CheckIn:D] Stopped 2024-06-19T18:10:49.935Z,1718820649.935 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:10:50.343Z,1718820650.343 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.453898 min 2024-06-19T18:10:50.343Z,1718820650.343 [Default:CheckIn:E] Stopped 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn] Stopped 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn](INFO): Running loop #15 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn] Running Loop=15 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:10:50.344Z,1718820650.344 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:10:52.320Z,1718820652.320 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181051.00,A,3648.14980,N,12147.22098,W,0.019,213.84,190624,,,A*71 2024-06-19T18:10:52.323Z,1718820652.323 [NAL9602](INFO): GPS fix at 20240619T181051: (36.802497, -121.787016) 2024-06-19T18:10:52.367Z,1718820652.367 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:10:52.367Z,1718820652.367 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:11:00.610Z,1718820660.610 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0039.lzma 2024-06-19T18:11:01.612Z,1718820661.612 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0039.lzma.bak 2024-06-19T18:11:01.613Z,1718820661.613 [DataOverHttps](INFO): SBD MOMSN=21258041 2024-06-19T18:11:17.559Z,1718820677.559 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20240619T165918/Express0040.lzma 2024-06-19T18:11:18.560Z,1718820678.560 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0040.lzma.bak 2024-06-19T18:11:18.561Z,1718820678.561 [DataOverHttps](INFO): SBD MOMSN=21258044 2024-06-19T18:11:19.975Z,1718820679.975 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:11:19.975Z,1718820679.975 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:11:19.975Z,1718820679.975 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:11:20.373Z,1718820680.373 [NAL9602](INFO): SBD MO Status=2, MOMSN=53073, MT Status=2, MTMSN=0 2024-06-19T18:11:20.374Z,1718820680.374 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:11:35.317Z,1718820695.317 [NAL9602](INFO): SBD MO Status=2, MOMSN=53073, MT Status=2, MTMSN=0 2024-06-19T18:11:35.317Z,1718820695.317 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:11:53.901Z,1718820713.901 [NAL9602](INFO): SBD MO Status=2, MOMSN=53073, MT Status=2, MTMSN=0 2024-06-19T18:11:53.901Z,1718820713.901 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:12:21.377Z,1718820741.377 [NAL9602](INFO): SBD MO Status=0, MOMSN=53073, MT Status=0, MTMSN=0 2024-06-19T18:12:21.377Z,1718820741.377 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:12:52.110Z,1718820772.110 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:16:20.650Z,1718820980.650 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:16:20.659Z,1718820980.659 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:16:20.659Z,1718820980.659 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:16:20.659Z,1718820980.659 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:16:21.042Z,1718820981.042 [Default:CheckIn:D] Stopped 2024-06-19T18:16:21.042Z,1718820981.042 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:16:21.448Z,1718820981.448 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.972331 min 2024-06-19T18:16:21.448Z,1718820981.448 [Default:CheckIn:E] Stopped 2024-06-19T18:16:21.448Z,1718820981.448 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:16:21.448Z,1718820981.448 [Default:CheckIn] Stopped 2024-06-19T18:16:21.448Z,1718820981.448 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:16:21.448Z,1718820981.448 [Default:CheckIn](INFO): Running loop #16 2024-06-19T18:16:21.449Z,1718820981.449 [Default:CheckIn] Running Loop=16 2024-06-19T18:16:21.449Z,1718820981.449 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:16:21.449Z,1718820981.449 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:16:23.449Z,1718820983.449 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181622.00,A,3648.15109,N,12147.22083,W,0.078,213.84,190624,,,A*76 2024-06-19T18:16:23.452Z,1718820983.452 [NAL9602](INFO): GPS fix at 20240619T181622: (36.802518, -121.787014) 2024-06-19T18:16:23.495Z,1718820983.495 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:16:23.495Z,1718820983.495 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:16:30.878Z,1718820990.878 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0042.lzma 2024-06-19T18:16:31.880Z,1718820991.880 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0042.lzma.bak 2024-06-19T18:16:31.880Z,1718820991.880 [DataOverHttps](INFO): SBD MOMSN=21258062 2024-06-19T18:16:48.256Z,1718821008.256 [NAL9602](INFO): SBD MO Status=2, MOMSN=53074, MT Status=2, MTMSN=0 2024-06-19T18:16:48.256Z,1718821008.256 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:16:48.263Z,1718821008.263 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240619T165918/Express0043.lzma 2024-06-19T18:16:49.265Z,1718821009.265 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0043.lzma.bak 2024-06-19T18:16:49.265Z,1718821009.265 [DataOverHttps](INFO): SBD MOMSN=21258065 2024-06-19T18:16:50.687Z,1718821010.687 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:16:50.687Z,1718821010.687 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:16:50.687Z,1718821010.687 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:17:06.466Z,1718821026.466 [NAL9602](INFO): SBD MO Status=0, MOMSN=53074, MT Status=0, MTMSN=0 2024-06-19T18:17:06.466Z,1718821026.466 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:17:37.163Z,1718821057.163 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:21:51.306Z,1718821311.306 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:21:51.306Z,1718821311.306 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:21:51.306Z,1718821311.306 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:21:51.306Z,1718821311.306 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:21:51.715Z,1718821311.715 [Default:CheckIn:D] Stopped 2024-06-19T18:21:51.715Z,1718821311.715 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:21:52.130Z,1718821312.130 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.483553 min 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn:E] Stopped 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn] Stopped 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn](INFO): Running loop #17 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn] Running Loop=17 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:21:52.131Z,1718821312.131 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:21:54.129Z,1718821314.129 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182153.00,A,3648.14483,N,12147.22721,W,0.661,207.65,190624,,,A*79 2024-06-19T18:21:54.132Z,1718821314.132 [NAL9602](INFO): GPS fix at 20240619T182153: (36.802414, -121.787120) 2024-06-19T18:21:54.143Z,1718821314.143 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:21:54.144Z,1718821314.144 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:22:01.398Z,1718821321.398 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0045.lzma 2024-06-19T18:22:02.400Z,1718821322.400 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0045.lzma.bak 2024-06-19T18:22:02.401Z,1718821322.401 [DataOverHttps](INFO): SBD MOMSN=21258083 2024-06-19T18:22:08.269Z,1718821328.269 [NAL9602](INFO): SBD MO Status=0, MOMSN=53075, MT Status=0, MTMSN=0 2024-06-19T18:22:08.269Z,1718821328.269 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:22:18.459Z,1718821338.459 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20240619T165918/Express0046.lzma 2024-06-19T18:22:19.461Z,1718821339.461 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0046.lzma.bak 2024-06-19T18:22:19.461Z,1718821339.461 [DataOverHttps](INFO): SBD MOMSN=21258086 2024-06-19T18:22:20.827Z,1718821340.827 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:22:20.827Z,1718821340.827 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:22:20.827Z,1718821340.827 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:22:39.015Z,1718821359.015 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:27:21.462Z,1718821641.462 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:27:21.462Z,1718821641.462 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:27:21.462Z,1718821641.462 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:27:21.463Z,1718821641.463 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:27:21.873Z,1718821641.873 [Default:CheckIn:D] Stopped 2024-06-19T18:27:21.873Z,1718821641.873 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 96.986190 min 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn:E] Stopped 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn] Stopped 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn](INFO): Running loop #18 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn] Running Loop=18 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:27:22.272Z,1718821642.272 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:27:24.276Z,1718821644.276 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182723.00,A,3648.13997,N,12147.23286,W,0.019,241.33,190624,,,A*76 2024-06-19T18:27:24.278Z,1718821644.278 [NAL9602](INFO): GPS fix at 20240619T182723: (36.802333, -121.787214) 2024-06-19T18:27:24.289Z,1718821644.289 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:27:24.289Z,1718821644.289 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:27:32.098Z,1718821652.098 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0048.lzma 2024-06-19T18:27:33.100Z,1718821653.100 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0048.lzma.bak 2024-06-19T18:27:33.100Z,1718821653.100 [DataOverHttps](INFO): SBD MOMSN=21258104 2024-06-19T18:27:37.209Z,1718821657.209 [NAL9602](INFO): SBD MO Status=0, MOMSN=53076, MT Status=0, MTMSN=0 2024-06-19T18:27:37.209Z,1718821657.209 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:27:48.948Z,1718821668.948 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0049.lzma 2024-06-19T18:27:49.948Z,1718821669.948 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0049.lzma.bak 2024-06-19T18:27:49.949Z,1718821669.949 [DataOverHttps](INFO): SBD MOMSN=21258107 2024-06-19T18:27:51.357Z,1718821671.357 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:27:51.357Z,1718821671.357 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:27:51.357Z,1718821671.357 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:28:07.907Z,1718821687.907 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:32:51.999Z,1718821971.999 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:32:51.999Z,1718821971.999 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:32:51.999Z,1718821971.999 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:32:51.999Z,1718821971.999 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:32:52.402Z,1718821972.402 [Default:CheckIn:D] Stopped 2024-06-19T18:32:52.402Z,1718821972.402 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:32:52.790Z,1718821972.790 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 102.495003 min 2024-06-19T18:32:52.790Z,1718821972.790 [Default:CheckIn:E] Stopped 2024-06-19T18:32:52.790Z,1718821972.790 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:32:52.798Z,1718821972.798 [Default:CheckIn] Stopped 2024-06-19T18:32:52.799Z,1718821972.799 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:32:52.799Z,1718821972.799 [Default:CheckIn](INFO): Running loop #19 2024-06-19T18:32:52.799Z,1718821972.799 [Default:CheckIn] Running Loop=19 2024-06-19T18:32:52.799Z,1718821972.799 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:32:52.799Z,1718821972.799 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:32:54.802Z,1718821974.802 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183253.00,A,3648.17720,N,12147.28190,W,0.233,255.60,190624,,,A*75 2024-06-19T18:32:54.804Z,1718821974.804 [NAL9602](INFO): GPS fix at 20240619T183253: (36.802953, -121.788032) 2024-06-19T18:32:54.835Z,1718821974.835 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:32:54.835Z,1718821974.835 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:33:02.762Z,1718821982.762 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0051.lzma 2024-06-19T18:33:03.764Z,1718821983.764 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0051.lzma.bak 2024-06-19T18:33:03.765Z,1718821983.765 [DataOverHttps](INFO): SBD MOMSN=21258126 2024-06-19T18:33:19.607Z,1718821999.607 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240619T165918/Express0052.lzma 2024-06-19T18:33:20.608Z,1718822000.608 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0052.lzma.bak 2024-06-19T18:33:20.609Z,1718822000.609 [DataOverHttps](INFO): SBD MOMSN=21258130 2024-06-19T18:33:21.887Z,1718822001.887 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:33:21.887Z,1718822001.887 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:33:21.887Z,1718822001.887 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:35:26.705Z,1718822126.705 [NAL9602](INFO): SBD MO Status=2, MOMSN=53077, MT Status=2, MTMSN=0 2024-06-19T18:35:26.705Z,1718822126.705 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:36:39.020Z,1718822199.020 [NAL9602](INFO): SBD MO Status=2, MOMSN=53077, MT Status=2, MTMSN=0 2024-06-19T18:36:39.020Z,1718822199.020 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:36:53.568Z,1718822213.568 [NAL9602](INFO): SBD MO Status=2, MOMSN=53077, MT Status=2, MTMSN=0 2024-06-19T18:36:53.568Z,1718822213.568 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:37:56.596Z,1718822276.596 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-06-19T18:38:22.466Z,1718822302.466 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:38:22.466Z,1718822302.466 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:38:22.466Z,1718822302.466 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:38:22.467Z,1718822302.467 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:38:22.873Z,1718822302.873 [Default:CheckIn:D] Stopped 2024-06-19T18:38:22.873Z,1718822302.873 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:38:23.286Z,1718822303.286 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 108.002848 min 2024-06-19T18:38:23.286Z,1718822303.286 [Default:CheckIn:E] Stopped 2024-06-19T18:38:23.286Z,1718822303.286 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:38:23.286Z,1718822303.286 [Default:CheckIn] Stopped 2024-06-19T18:38:23.286Z,1718822303.286 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:38:23.286Z,1718822303.286 [Default:CheckIn](INFO): Running loop #20 2024-06-19T18:38:23.295Z,1718822303.295 [Default:CheckIn] Running Loop=20 2024-06-19T18:38:23.295Z,1718822303.295 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:38:23.295Z,1718822303.295 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:38:25.285Z,1718822305.285 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183824.00,A,3648.17606,N,12147.28277,W,0.156,197.09,190624,,,A*72 2024-06-19T18:38:25.288Z,1718822305.288 [NAL9602](INFO): GPS fix at 20240619T183824: (36.802934, -121.788046) 2024-06-19T18:38:25.316Z,1718822305.316 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:38:25.316Z,1718822305.316 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:38:33.062Z,1718822313.062 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240619T165918/Courier0054.lzma 2024-06-19T18:38:34.065Z,1718822314.065 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0054.lzma.bak 2024-06-19T18:38:34.065Z,1718822314.065 [DataOverHttps](INFO): SBD MOMSN=21258149 2024-06-19T18:38:52.335Z,1718822332.335 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20240619T165918/Express0055.lzma 2024-06-19T18:38:53.337Z,1718822333.337 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0055.lzma.bak 2024-06-19T18:38:53.337Z,1718822333.337 [DataOverHttps](INFO): SBD MOMSN=21258152 2024-06-19T18:38:54.835Z,1718822334.835 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:38:54.835Z,1718822334.835 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:38:54.835Z,1718822334.835 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:38:57.643Z,1718822337.643 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:43:55.419Z,1718822635.419 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:43:55.419Z,1718822635.419 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:43:55.419Z,1718822635.419 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:43:55.420Z,1718822635.420 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:43:55.828Z,1718822635.828 [Default:CheckIn:D] Stopped 2024-06-19T18:43:55.828Z,1718822635.828 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:43:56.226Z,1718822636.226 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 113.552108 min 2024-06-19T18:43:56.226Z,1718822636.226 [Default:CheckIn:E] Stopped 2024-06-19T18:43:56.226Z,1718822636.226 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:43:56.226Z,1718822636.226 [Default:CheckIn] Stopped 2024-06-19T18:43:56.226Z,1718822636.226 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:43:56.227Z,1718822636.227 [Default:CheckIn](INFO): Running loop #21 2024-06-19T18:43:56.227Z,1718822636.227 [Default:CheckIn] Running Loop=21 2024-06-19T18:43:56.227Z,1718822636.227 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:43:56.227Z,1718822636.227 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:43:58.237Z,1718822638.237 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184357.00,A,3648.17871,N,12147.28208,W,0.097,197.09,190624,,,A*70 2024-06-19T18:43:58.240Z,1718822638.240 [NAL9602](INFO): GPS fix at 20240619T184357: (36.802979, -121.788035) 2024-06-19T18:43:58.251Z,1718822638.251 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:43:58.251Z,1718822638.251 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:44:05.626Z,1718822645.626 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0057.lzma 2024-06-19T18:44:06.628Z,1718822646.628 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0057.lzma.bak 2024-06-19T18:44:06.629Z,1718822646.629 [DataOverHttps](INFO): SBD MOMSN=21258170 2024-06-19T18:44:25.430Z,1718822665.430 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240619T165918/Express0058.lzma 2024-06-19T18:44:26.433Z,1718822666.433 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0058.lzma.bak 2024-06-19T18:44:26.433Z,1718822666.433 [DataOverHttps](INFO): SBD MOMSN=21258173 2024-06-19T18:44:27.850Z,1718822667.850 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:44:27.851Z,1718822667.851 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:44:27.851Z,1718822667.851 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:45:00.525Z,1718822700.525 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:45:13.857Z,1718822713.857 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:45:26.785Z,1718822726.785 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:45:39.309Z,1718822739.309 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:45:52.641Z,1718822752.641 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:46:05.973Z,1718822765.973 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:46:18.497Z,1718822778.497 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-06-19T18:47:44.173Z,1718822864.173 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-06-19T18:48:03.949Z,1718822883.949 [NAL9602](INFO): SBD MO Status=2, MOMSN=53077, MT Status=2, MTMSN=0 2024-06-19T18:48:03.949Z,1718822883.949 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:48:15.665Z,1718822895.665 [NAL9602](INFO): SBD MO Status=0, MOMSN=53077, MT Status=0, MTMSN=0 2024-06-19T18:48:15.665Z,1718822895.665 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:48:46.432Z,1718822926.432 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:49:00.109Z,1718822940.109 [BPC1](INFO): Calculating totals. Valid battery stick count: 40. Valid reserve battery stick count: 6. 2024-06-19T18:49:00.112Z,1718822940.112 [BPC1](INFO): Received data from all battery sticks. 2024-06-19T18:49:28.395Z,1718822968.395 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:49:28.395Z,1718822968.395 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:49:28.396Z,1718822968.396 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:49:28.396Z,1718822968.396 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:49:28.808Z,1718822968.808 [Default:CheckIn:D] Stopped 2024-06-19T18:49:28.808Z,1718822968.808 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:49:29.229Z,1718822969.229 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 119.101774 min 2024-06-19T18:49:29.229Z,1718822969.229 [Default:CheckIn:E] Stopped 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn] Stopped 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn](INFO): Running loop #22 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn] Running Loop=22 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:49:29.230Z,1718822969.230 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:49:31.217Z,1718822971.217 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184930.00,A,3648.17622,N,12147.27983,W,0.369,156.45,190624,,,A*73 2024-06-19T18:49:31.220Z,1718822971.220 [NAL9602](INFO): GPS fix at 20240619T184930: (36.802937, -121.787997) 2024-06-19T18:49:31.235Z,1718822971.235 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:49:31.235Z,1718822971.235 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:49:38.142Z,1718822978.142 [DataOverHttps](INFO): Sending 84 bytes from file Logs/20240619T165918/Courier0060.lzma 2024-06-19T18:49:39.144Z,1718822979.144 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0060.lzma.bak 2024-06-19T18:49:39.145Z,1718822979.145 [DataOverHttps](INFO): SBD MOMSN=21258195 2024-06-19T18:49:45.753Z,1718822985.753 [NAL9602](INFO): SBD MO Status=0, MOMSN=53078, MT Status=0, MTMSN=0 2024-06-19T18:49:45.753Z,1718822985.753 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:49:54.974Z,1718822994.974 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0061.lzma 2024-06-19T18:49:55.976Z,1718822995.976 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0061.lzma.bak 2024-06-19T18:49:55.977Z,1718822995.977 [DataOverHttps](INFO): SBD MOMSN=21258198 2024-06-19T18:49:57.087Z,1718822997.087 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:49:57.087Z,1718822997.087 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:49:57.087Z,1718822997.087 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:50:16.456Z,1718823016.456 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T18:54:57.665Z,1718823297.665 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T18:54:57.665Z,1718823297.665 [Default:CheckIn:C.Wait] Stopped 2024-06-19T18:54:57.666Z,1718823297.666 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T18:54:57.666Z,1718823297.666 [Default:CheckIn:D] Running Loop=1 2024-06-19T18:54:58.075Z,1718823298.075 [Default:CheckIn:D] Stopped 2024-06-19T18:54:58.075Z,1718823298.075 [Default:CheckIn:E] Running Loop=1 2024-06-19T18:54:58.471Z,1718823298.471 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 124.589559 min 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn:E] Stopped 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn] Stopped 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn](INFO): Running loop #23 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn] Running Loop=23 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T18:54:58.472Z,1718823298.472 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T18:55:00.485Z,1718823300.485 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185459.00,A,3648.17516,N,12147.28166,W,0.117,156.45,190624,,,A*73 2024-06-19T18:55:00.488Z,1718823300.488 [NAL9602](INFO): GPS fix at 20240619T185459: (36.802919, -121.788028) 2024-06-19T18:55:00.499Z,1718823300.499 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T18:55:00.499Z,1718823300.499 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T18:55:07.954Z,1718823307.954 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0063.lzma 2024-06-19T18:55:08.956Z,1718823308.956 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0063.lzma.bak 2024-06-19T18:55:08.957Z,1718823308.957 [DataOverHttps](INFO): SBD MOMSN=21258216 2024-06-19T18:55:25.007Z,1718823325.007 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0064.lzma 2024-06-19T18:55:26.009Z,1718823326.009 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0064.lzma.bak 2024-06-19T18:55:26.009Z,1718823326.009 [DataOverHttps](INFO): SBD MOMSN=21258219 2024-06-19T18:55:27.175Z,1718823327.175 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T18:55:27.175Z,1718823327.175 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T18:55:27.175Z,1718823327.175 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T18:56:48.350Z,1718823408.350 [NAL9602](INFO): SBD MO Status=2, MOMSN=53079, MT Status=2, MTMSN=0 2024-06-19T18:56:48.350Z,1718823408.350 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:57:34.405Z,1718823454.405 [NAL9602](INFO): SBD MO Status=2, MOMSN=53079, MT Status=2, MTMSN=0 2024-06-19T18:57:34.405Z,1718823454.405 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:58:00.260Z,1718823480.260 [NAL9602](INFO): SBD MO Status=2, MOMSN=53079, MT Status=2, MTMSN=0 2024-06-19T18:58:00.260Z,1718823480.260 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:58:13.592Z,1718823493.592 [NAL9602](INFO): SBD MO Status=2, MOMSN=53079, MT Status=2, MTMSN=0 2024-06-19T18:58:13.592Z,1718823493.592 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T18:58:26.121Z,1718823506.121 [NAL9602](INFO): SBD MO Status=0, MOMSN=53079, MT Status=0, MTMSN=0 2024-06-19T18:58:26.121Z,1718823506.121 [NAL9602](INFO): No messages in MT queue 2024-06-19T18:58:56.832Z,1718823536.832 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T19:00:27.734Z,1718823627.734 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:00:27.734Z,1718823627.734 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:00:27.734Z,1718823627.734 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:00:27.735Z,1718823627.735 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:00:28.134Z,1718823628.134 [Default:CheckIn:D] Stopped 2024-06-19T19:00:28.134Z,1718823628.134 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:00:28.538Z,1718823628.538 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 130.090535 min 2024-06-19T19:00:28.538Z,1718823628.538 [Default:CheckIn:E] Stopped 2024-06-19T19:00:28.538Z,1718823628.538 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:00:28.538Z,1718823628.538 [Default:CheckIn] Stopped 2024-06-19T19:00:28.539Z,1718823628.539 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:00:28.539Z,1718823628.539 [Default:CheckIn](INFO): Running loop #24 2024-06-19T19:00:28.539Z,1718823628.539 [Default:CheckIn] Running Loop=24 2024-06-19T19:00:28.539Z,1718823628.539 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:00:28.539Z,1718823628.539 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:00:30.548Z,1718823630.548 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190029.00,A,3648.17670,N,12147.28007,W,0.117,277.59,190624,,,A*7C 2024-06-19T19:00:30.561Z,1718823630.561 [NAL9602](INFO): GPS fix at 20240619T190029: (36.802945, -121.788001) 2024-06-19T19:00:30.572Z,1718823630.572 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T19:00:30.573Z,1718823630.573 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T19:00:37.898Z,1718823637.898 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0066.lzma 2024-06-19T19:00:38.900Z,1718823638.900 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0066.lzma.bak 2024-06-19T19:00:38.901Z,1718823638.901 [DataOverHttps](INFO): SBD MOMSN=21258240 2024-06-19T19:00:54.437Z,1718823654.437 [NAL9602](INFO): SBD MO Status=0, MOMSN=53080, MT Status=0, MTMSN=0 2024-06-19T19:00:54.437Z,1718823654.437 [NAL9602](INFO): No messages in MT queue 2024-06-19T19:00:57.647Z,1718823657.647 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20240619T165918/Express0067.lzma 2024-06-19T19:00:58.649Z,1718823658.649 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0067.lzma.bak 2024-06-19T19:00:58.649Z,1718823658.649 [DataOverHttps](INFO): SBD MOMSN=21258243 2024-06-19T19:01:00.102Z,1718823660.102 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T19:01:00.103Z,1718823660.103 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T19:01:00.103Z,1718823660.103 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T19:01:25.140Z,1718823685.140 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T19:06:00.719Z,1718823960.719 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:06:00.719Z,1718823960.719 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:06:00.719Z,1718823960.719 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:06:00.720Z,1718823960.720 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:06:01.120Z,1718823961.120 [Default:CheckIn:D] Stopped 2024-06-19T19:06:01.120Z,1718823961.120 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 135.640299 min 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn:E] Stopped 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn] Stopped 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn](INFO): Running loop #25 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn] Running Loop=25 2024-06-19T19:06:01.533Z,1718823961.533 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:06:01.534Z,1718823961.534 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:06:03.533Z,1718823963.533 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190602.00,A,3648.17995,N,12147.27454,W,0.078,277.59,190624,,,A*72 2024-06-19T19:06:03.535Z,1718823963.535 [NAL9602](INFO): GPS fix at 20240619T190602: (36.802999, -121.787909) 2024-06-19T19:06:03.546Z,1718823963.546 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T19:06:03.546Z,1718823963.546 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T19:06:11.138Z,1718823971.138 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0069.lzma 2024-06-19T19:06:12.140Z,1718823972.140 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0069.lzma.bak 2024-06-19T19:06:12.140Z,1718823972.140 [DataOverHttps](INFO): SBD MOMSN=21258262 2024-06-19T19:06:31.602Z,1718823991.602 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0070.lzma 2024-06-19T19:06:32.604Z,1718823992.604 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0070.lzma.bak 2024-06-19T19:06:32.605Z,1718823992.605 [DataOverHttps](INFO): SBD MOMSN=21258265 2024-06-19T19:06:33.908Z,1718823993.908 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T19:06:33.908Z,1718823993.908 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T19:06:33.908Z,1718823993.908 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T19:06:38.333Z,1718823998.333 [NAL9602](INFO): SBD MO Status=0, MOMSN=53081, MT Status=0, MTMSN=0 2024-06-19T19:06:38.333Z,1718823998.333 [NAL9602](INFO): No messages in MT queue 2024-06-19T19:07:09.032Z,1718824029.032 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T19:11:34.473Z,1718824294.473 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:11:34.473Z,1718824294.473 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:11:34.474Z,1718824294.474 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:11:34.474Z,1718824294.474 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:11:34.877Z,1718824294.877 [Default:CheckIn:D] Stopped 2024-06-19T19:11:34.877Z,1718824294.877 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:11:35.290Z,1718824295.290 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 141.202913 min 2024-06-19T19:11:35.290Z,1718824295.290 [Default:CheckIn:E] Stopped 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn] Stopped 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn](INFO): Running loop #26 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn] Running Loop=26 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:11:35.291Z,1718824295.291 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:11:37.294Z,1718824297.294 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191136.00,A,3648.17614,N,12147.27482,W,0.097,277.59,190624,,,A*7F 2024-06-19T19:11:37.296Z,1718824297.296 [NAL9602](INFO): GPS fix at 20240619T191136: (36.802936, -121.787914) 2024-06-19T19:11:37.307Z,1718824297.307 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T19:11:37.307Z,1718824297.307 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T19:11:45.134Z,1718824305.134 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240619T165918/Courier0072.lzma 2024-06-19T19:11:46.136Z,1718824306.136 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0072.lzma.bak 2024-06-19T19:11:46.137Z,1718824306.137 [DataOverHttps](INFO): SBD MOMSN=21258283 2024-06-19T19:12:02.058Z,1718824322.058 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0073.lzma 2024-06-19T19:12:03.060Z,1718824323.060 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0073.lzma.bak 2024-06-19T19:12:03.061Z,1718824323.061 [DataOverHttps](INFO): SBD MOMSN=21258286 2024-06-19T19:12:04.374Z,1718824324.374 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T19:12:04.374Z,1718824324.374 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T19:12:04.374Z,1718824324.374 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T19:12:49.208Z,1718824369.208 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-06-19T19:12:49.208Z,1718824369.208 [DropWeight] Hardware Fault, FailCount= 1 2024-06-19T19:12:49.208Z,1718824369.208 [DropWeight](ERROR): Hardware Fault 2024-06-19T19:12:49.234Z,1718824369.234 [CommandExec](FAULT): Scheduling is paused 2024-06-19T19:12:49.243Z,1718824369.243 [CBIT](INFO): Critical error at 20240619T191249 2024-06-19T19:12:49.246Z,1718824369.246 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-06-19T19:12:49.246Z,1718824369.246 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-06-19T19:12:49.671Z,1718824369.671 [CBIT](INFO): Critical error at 20240619T191249 2024-06-19T19:15:02.120Z,1718824502.120 [NAL9602](INFO): SBD MO Status=2, MOMSN=53082, MT Status=2, MTMSN=0 2024-06-19T19:15:02.121Z,1718824502.121 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T19:15:19.097Z,1718824519.097 [NAL9602](INFO): SBD MO Status=2, MOMSN=53082, MT Status=2, MTMSN=0 2024-06-19T19:15:19.097Z,1718824519.097 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T19:15:50.605Z,1718824550.605 [NAL9602](INFO): SBD MO Status=0, MOMSN=53082, MT Status=0, MTMSN=0 2024-06-19T19:15:50.605Z,1718824550.605 [NAL9602](INFO): No messages in MT queue 2024-06-19T19:16:21.304Z,1718824581.304 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T19:17:04.947Z,1718824624.947 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:17:04.947Z,1718824624.947 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:17:04.947Z,1718824624.947 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:17:04.947Z,1718824624.947 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:17:05.363Z,1718824625.363 [Default:CheckIn:D] Stopped 2024-06-19T19:17:05.363Z,1718824625.363 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:17:05.759Z,1718824625.759 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 146.711019 min 2024-06-19T19:17:05.759Z,1718824625.759 [Default:CheckIn:E] Stopped 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn] Stopped 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn](INFO): Running loop #27 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn] Running Loop=27 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:17:05.760Z,1718824625.760 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:17:07.769Z,1718824627.769 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191706.00,A,3648.17475,N,12147.27927,W,0.117,277.59,190624,,,A*74 2024-06-19T19:17:07.771Z,1718824627.771 [NAL9602](INFO): GPS fix at 20240619T191706: (36.802912, -121.787988) 2024-06-19T19:17:07.782Z,1718824627.782 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T19:17:07.782Z,1718824627.782 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T19:17:15.099Z,1718824635.099 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20240619T165918/Courier0075.lzma 2024-06-19T19:17:16.103Z,1718824636.103 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0075.lzma.bak 2024-06-19T19:17:16.103Z,1718824636.103 [DataOverHttps](INFO): SBD MOMSN=21258304 2024-06-19T19:17:18.672Z,1718824638.672 [NAL9602](INFO): SBD MO Status=0, MOMSN=53083, MT Status=0, MTMSN=0 2024-06-19T19:17:18.672Z,1718824638.672 [NAL9602](INFO): No messages in MT queue 2024-06-19T19:17:32.047Z,1718824652.047 [DataOverHttps](INFO): Sending 158 bytes from file Logs/20240619T165918/Express0076.lzma 2024-06-19T19:17:33.048Z,1718824653.048 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0076.lzma.bak 2024-06-19T19:17:33.049Z,1718824653.049 [DataOverHttps](INFO): SBD MOMSN=21258311 2024-06-19T19:17:34.443Z,1718824654.443 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T19:17:34.443Z,1718824654.443 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T19:17:34.443Z,1718824654.443 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T19:17:49.378Z,1718824669.378 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T19:22:35.023Z,1718824955.023 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:22:35.023Z,1718824955.023 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:22:35.023Z,1718824955.023 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:22:35.024Z,1718824955.024 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:22:35.422Z,1718824955.422 [Default:CheckIn:D] Stopped 2024-06-19T19:22:35.422Z,1718824955.422 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 152.212012 min 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn:E] Stopped 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn] Stopped 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn](INFO): Running loop #28 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn] Running Loop=28 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:22:35.821Z,1718824955.821 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:22:37.841Z,1718824957.841 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192236.00,A,3648.17099,N,12147.28280,W,0.156,146.00,190624,,,A*76 2024-06-19T19:22:37.843Z,1718824957.843 [NAL9602](INFO): GPS fix at 20240619T192236: (36.802850, -121.788047) 2024-06-19T19:22:37.855Z,1718824957.855 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T19:22:37.855Z,1718824957.855 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T19:22:44.834Z,1718824964.834 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240619T165918/Courier0078.lzma 2024-06-19T19:22:45.836Z,1718824965.836 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0078.lzma.bak 2024-06-19T19:22:45.837Z,1718824965.837 [DataOverHttps](INFO): SBD MOMSN=21258335 2024-06-19T19:23:04.566Z,1718824984.566 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20240619T165918/Express0079.lzma 2024-06-19T19:23:05.569Z,1718824985.569 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0079.lzma.bak 2024-06-19T19:23:05.569Z,1718824985.569 [DataOverHttps](INFO): SBD MOMSN=21258341 2024-06-19T19:23:06.988Z,1718824986.988 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T19:23:06.989Z,1718824986.989 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T19:23:06.989Z,1718824986.989 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T19:24:54.438Z,1718825094.438 [NAL9602](INFO): SBD MO Status=2, MOMSN=53084, MT Status=2, MTMSN=0 2024-06-19T19:24:54.438Z,1718825094.438 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T19:27:13.821Z,1718825233.821 [NAL9602](INFO): SBD MO Status=2, MOMSN=53084, MT Status=2, MTMSN=0 2024-06-19T19:27:13.821Z,1718825233.821 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-06-19T19:27:40.475Z,1718825260.475 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-06-19T19:27:49.389Z,1718825269.389 [CBIT](INFO): Clearing failed state for component DropWeight 2024-06-19T19:27:49.389Z,1718825269.389 [DropWeight] No Fault, FailCount= 1 2024-06-19T19:28:07.564Z,1718825287.564 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:28:07.564Z,1718825287.564 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:28:07.564Z,1718825287.564 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:28:07.564Z,1718825287.564 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:28:07.961Z,1718825287.961 [Default:CheckIn:D] Stopped 2024-06-19T19:28:07.961Z,1718825287.961 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:28:08.366Z,1718825288.366 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 157.754329 min 2024-06-19T19:28:08.366Z,1718825288.366 [Default:CheckIn:E] Stopped 2024-06-19T19:28:08.366Z,1718825288.366 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:28:08.366Z,1718825288.366 [Default:CheckIn] Stopped 2024-06-19T19:28:08.367Z,1718825288.367 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:28:08.367Z,1718825288.367 [Default:CheckIn](INFO): Running loop #29 2024-06-19T19:28:08.367Z,1718825288.367 [Default:CheckIn] Running Loop=29 2024-06-19T19:28:08.367Z,1718825288.367 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:28:08.367Z,1718825288.367 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:28:10.378Z,1718825290.378 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192809.00,A,3648.16773,N,12147.28310,W,0.816,85.42,190624,,,A*4F 2024-06-19T19:28:10.380Z,1718825290.380 [NAL9602](INFO): GPS fix at 20240619T192809: (36.802796, -121.788052) 2024-06-19T19:28:10.396Z,1718825290.396 [Default:CheckIn:Read_GPS] Stopped 2024-06-19T19:28:10.396Z,1718825290.396 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-19T19:28:18.114Z,1718825298.114 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20240619T165918/Courier0081.lzma 2024-06-19T19:28:19.117Z,1718825299.117 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Courier0081.lzma.bak 2024-06-19T19:28:19.117Z,1718825299.117 [DataOverHttps](INFO): SBD MOMSN=21258355 2024-06-19T19:28:38.267Z,1718825318.267 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20240619T165918/Express0082.lzma 2024-06-19T19:28:39.268Z,1718825319.268 [DataOverHttps](INFO): Moved sent file to Logs/20240619T165918/Express0082.lzma.bak 2024-06-19T19:28:39.269Z,1718825319.269 [DataOverHttps](INFO): SBD MOMSN=21258364 2024-06-19T19:28:40.730Z,1718825320.730 [Default:CheckIn:Read_Iridium] Stopped 2024-06-19T19:28:40.730Z,1718825320.730 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-19T19:28:40.731Z,1718825320.731 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-19T19:28:42.747Z,1718825322.747 [NAL9602](INFO): Not Powering down - fast GPS 2024-06-19T19:33:41.321Z,1718825621.321 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-19T19:33:41.321Z,1718825621.321 [Default:CheckIn:C.Wait] Stopped 2024-06-19T19:33:41.321Z,1718825621.321 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-19T19:33:41.322Z,1718825621.322 [Default:CheckIn:D] Running Loop=1 2024-06-19T19:33:41.714Z,1718825621.714 [Default:CheckIn:D] Stopped 2024-06-19T19:33:41.714Z,1718825621.714 [Default:CheckIn:E] Running Loop=1 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 163.316862 min 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn:E] Stopped 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn] Stopped 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn](INFO): Running loop #30 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn] Running Loop=30 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-19T19:33:42.123Z,1718825622.123 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-19T19:34:14.833Z,1718825654.833 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-06-19T19:34:14.910Z,1718825654.910 [NAL9602](ERROR): received: +CSQ:0 OK084, 2, 0, 0, 0 OK 2024-06-19T19:35:05.596Z,1718825705.596 [CommandExec](IMPORTANT): got command restart system 2024-06-19T19:35:07.695Z,1718825707.695 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-19T19:35:07.695Z,1718825707.695 [CommandExec](INFO): Uninitializing the command executive. 2024-06-19T19:35:07.695Z,1718825707.695 [CommandExec](INFO): Uninitializing the command scheduler. 2024-06-19T19:35:07.695Z,1718825707.695 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-06-19T19:35:07.855Z,1718825707.855 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-06-19T19:35:07.855Z,1718825707.855 [ComponentRegistry](INFO): Shutting down Nav