2025-05-16T17:26:15.179Z,1747416375.179 [CommandExec](IMPORTANT): got command restart logs 2025-05-16T17:26:21.040Z,1747416381.040 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:26:21.040Z,1747416381.040 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:26:21.053Z,1747416381.053 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:26:21.563Z,1747416381.563 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:26:21.563Z,1747416381.563 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T17:28:02.463Z,1747416482.463 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-16T17:28:28.737Z,1747416508.737 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T17:28:28.737Z,1747416508.737 [Default:CheckIn:C.Wait] Stopped 2025-05-16T17:28:28.737Z,1747416508.737 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T17:28:28.738Z,1747416508.738 [Default:CheckIn:D] Running Loop=1 2025-05-16T17:28:29.188Z,1747416509.188 [Default:CheckIn:D] Stopped 2025-05-16T17:28:29.188Z,1747416509.188 [Default:CheckIn:E] Running Loop=1 2025-05-16T17:28:29.541Z,1747416509.541 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.111275 min 2025-05-16T17:28:29.541Z,1747416509.541 [Default:CheckIn:E] Stopped 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn] Stopped 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn](INFO): Running loop #4 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn] Running Loop=4 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T17:28:29.542Z,1747416509.542 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T17:28:31.529Z,1747416511.529 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172830.00,A,3648.33137,N,12147.98575,W,19.827,87.61,160525,,,D*75 2025-05-16T17:28:31.540Z,1747416511.540 [NAL9602](INFO): GPS fix at 20250516T172830: (36.805523, -121.799762) 2025-05-16T17:28:31.575Z,1747416511.575 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T17:28:31.575Z,1747416511.575 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T17:28:39.570Z,1747416519.570 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250516T134848/Courier0063.lzma 2025-05-16T17:28:40.572Z,1747416520.572 [DataOverHttps](INFO): Moved sent file to Logs/20250516T134848/Courier0063.lzma.bak 2025-05-16T17:28:40.572Z,1747416520.572 [DataOverHttps](INFO): SBD MOMSN=24895928 2025-05-16T17:29:00.078Z,1747416540.078 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20250516T172615/Courier0000.lzma 2025-05-16T17:29:01.080Z,1747416541.080 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0000.lzma.bak 2025-05-16T17:29:01.080Z,1747416541.080 [DataOverHttps](INFO): SBD MOMSN=24895930 2025-05-16T17:29:03.459Z,1747416543.459 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T17:29:22.102Z,1747416562.102 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:29:22.102Z,1747416562.102 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:29:22.124Z,1747416562.124 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:29:22.502Z,1747416562.502 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:29:22.502Z,1747416562.502 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T17:29:23.020Z,1747416563.020 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20250516T134848/Express0064.lzma 2025-05-16T17:29:24.020Z,1747416564.020 [DataOverHttps](INFO): Moved sent file to Logs/20250516T134848/Express0064.lzma.bak 2025-05-16T17:29:24.020Z,1747416564.020 [DataOverHttps](INFO): SBD MOMSN=24895938 2025-05-16T17:29:41.523Z,1747416581.523 [DataOverHttps](INFO): Sending 576 bytes from file Logs/20250516T172615/Express0001.lzma 2025-05-16T17:29:42.524Z,1747416582.524 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0001.lzma.bak 2025-05-16T17:29:42.524Z,1747416582.524 [DataOverHttps](INFO): SBD MOMSN=24895944 2025-05-16T17:29:59.375Z,1747416599.375 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250516T172615/Express0004.lzma 2025-05-16T17:30:00.376Z,1747416600.376 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0004.lzma.bak 2025-05-16T17:30:00.376Z,1747416600.376 [DataOverHttps](INFO): SBD MOMSN=24895949 2025-05-16T17:30:02.089Z,1747416602.089 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T17:30:02.090Z,1747416602.090 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T17:30:02.090Z,1747416602.090 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T17:31:45.203Z,1747416705.203 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-32768,-32768V32768,-32768,-32768,V 2025-05-16T17:32:16.234Z,1747416736.234 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-05-16T17:32:23.109Z,1747416743.109 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T17:32:23.109Z,1747416743.109 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:32:23.180Z,1747416743.180 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:32:23.574Z,1747416743.574 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:32:23.574Z,1747416743.574 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T17:35:02.695Z,1747416902.695 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T17:35:02.696Z,1747416902.696 [Default:CheckIn:C.Wait] Stopped 2025-05-16T17:35:02.696Z,1747416902.696 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T17:35:02.696Z,1747416902.696 [Default:CheckIn:D] Running Loop=1 2025-05-16T17:35:03.113Z,1747416903.113 [Default:CheckIn:D] Stopped 2025-05-16T17:35:03.113Z,1747416903.113 [Default:CheckIn:E] Running Loop=1 2025-05-16T17:35:03.509Z,1747416903.509 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 24.676683 min 2025-05-16T17:35:03.509Z,1747416903.509 [Default:CheckIn:E] Stopped 2025-05-16T17:35:03.510Z,1747416903.510 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T17:35:03.510Z,1747416903.510 [Default:CheckIn] Stopped 2025-05-16T17:35:03.526Z,1747416903.526 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T17:35:03.526Z,1747416903.526 [Default:CheckIn](INFO): Running loop #5 2025-05-16T17:35:03.526Z,1747416903.526 [Default:CheckIn] Running Loop=5 2025-05-16T17:35:03.526Z,1747416903.526 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T17:35:03.527Z,1747416903.527 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T17:35:05.529Z,1747416905.529 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173504.00,A,3648.21338,N,12147.16351,W,4.762,207.28,160525,,,D*73 2025-05-16T17:35:05.531Z,1747416905.531 [NAL9602](INFO): GPS fix at 20250516T173504: (36.803556, -121.786058) 2025-05-16T17:35:05.543Z,1747416905.543 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T17:35:05.544Z,1747416905.544 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T17:35:12.106Z,1747416912.106 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250516T172615/Courier0006.lzma 2025-05-16T17:35:13.109Z,1747416913.109 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0006.lzma.bak 2025-05-16T17:35:13.109Z,1747416913.109 [DataOverHttps](INFO): SBD MOMSN=24896008 2025-05-16T17:35:24.169Z,1747416924.169 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:35:24.169Z,1747416924.169 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:35:24.217Z,1747416924.217 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:35:24.615Z,1747416924.615 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:35:24.616Z,1747416924.616 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T17:35:33.194Z,1747416933.194 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250516T172615/Express0007.lzma 2025-05-16T17:35:34.200Z,1747416934.200 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0007.lzma.bak 2025-05-16T17:35:34.200Z,1747416934.200 [DataOverHttps](INFO): SBD MOMSN=24896011 2025-05-16T17:35:35.888Z,1747416935.888 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T17:35:35.888Z,1747416935.888 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T17:35:35.888Z,1747416935.888 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T17:35:36.256Z,1747416936.256 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-05-16T17:35:36.330Z,1747416936.330 [NAL9602](ERROR): received: +CSQ:0 OK349, 2, 0, 0, 0 OK 2025-05-16T17:36:13.829Z,1747416973.829 [NAL9602](INFO): SBD MO Status=0, MOMSN=10349, MT Status=0, MTMSN=0 2025-05-16T17:36:13.829Z,1747416973.829 [NAL9602](INFO): No messages in MT queue 2025-05-16T17:36:44.555Z,1747417004.555 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T17:38:25.157Z,1747417105.157 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T17:38:25.157Z,1747417105.157 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:38:25.170Z,1747417105.170 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:38:25.582Z,1747417105.582 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:38:25.582Z,1747417105.582 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T17:40:36.513Z,1747417236.513 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T17:40:36.513Z,1747417236.513 [Default:CheckIn:C.Wait] Stopped 2025-05-16T17:40:36.513Z,1747417236.513 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T17:40:36.513Z,1747417236.513 [Default:CheckIn:D] Running Loop=1 2025-05-16T17:40:36.849Z,1747417236.849 [Default:CheckIn:D] Stopped 2025-05-16T17:40:36.849Z,1747417236.849 [Default:CheckIn:E] Running Loop=1 2025-05-16T17:40:37.253Z,1747417237.253 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.238955 min 2025-05-16T17:40:37.253Z,1747417237.253 [Default:CheckIn:E] Stopped 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn] Stopped 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn](INFO): Running loop #6 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn] Running Loop=6 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T17:40:37.254Z,1747417237.254 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T17:40:39.272Z,1747417239.272 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174038.00,A,3648.15111,N,12147.22145,W,0.369,233.84,160525,,,D*7A 2025-05-16T17:40:39.275Z,1747417239.275 [NAL9602](INFO): GPS fix at 20250516T174038: (36.802518, -121.787024) 2025-05-16T17:40:39.287Z,1747417239.287 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T17:40:39.287Z,1747417239.287 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T17:40:47.002Z,1747417247.002 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250516T172615/Courier0009.lzma 2025-05-16T17:40:48.004Z,1747417248.004 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0009.lzma.bak 2025-05-16T17:40:48.004Z,1747417248.004 [DataOverHttps](INFO): SBD MOMSN=24896022 2025-05-16T17:41:04.863Z,1747417264.863 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20250516T172615/Express0010.lzma 2025-05-16T17:41:05.864Z,1747417265.864 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0010.lzma.bak 2025-05-16T17:41:05.864Z,1747417265.864 [DataOverHttps](INFO): SBD MOMSN=24896025 2025-05-16T17:41:07.973Z,1747417267.973 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T17:41:07.973Z,1747417267.973 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T17:41:07.973Z,1747417267.973 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T17:41:26.148Z,1747417286.148 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:41:26.148Z,1747417286.148 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:41:26.209Z,1747417286.209 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:41:26.575Z,1747417286.575 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:41:26.575Z,1747417286.575 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T17:41:35.828Z,1747417295.828 [NAL9602](INFO): SBD MO Status=2, MOMSN=10350, MT Status=2, MTMSN=0 2025-05-16T17:41:35.829Z,1747417295.829 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-16T17:44:27.157Z,1747417467.157 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T17:44:27.157Z,1747417467.157 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:44:27.192Z,1747417467.192 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:44:27.597Z,1747417467.597 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:44:27.597Z,1747417467.597 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T17:45:41.492Z,1747417541.492 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-16T17:46:08.586Z,1747417568.586 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T17:46:08.586Z,1747417568.586 [Default:CheckIn:C.Wait] Stopped 2025-05-16T17:46:08.586Z,1747417568.586 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T17:46:08.586Z,1747417568.586 [Default:CheckIn:D] Running Loop=1 2025-05-16T17:46:08.965Z,1747417568.965 [Default:CheckIn:D] Stopped 2025-05-16T17:46:08.965Z,1747417568.965 [Default:CheckIn:E] Running Loop=1 2025-05-16T17:46:09.378Z,1747417569.378 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.774219 min 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn:E] Stopped 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn] Stopped 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn](INFO): Running loop #7 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn] Running Loop=7 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T17:46:09.379Z,1747417569.379 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T17:46:11.385Z,1747417571.385 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174610.00,A,3648.15605,N,12147.22299,W,0.019,242.77,160525,,,D*78 2025-05-16T17:46:11.387Z,1747417571.387 [NAL9602](INFO): GPS fix at 20250516T174610: (36.802601, -121.787050) 2025-05-16T17:46:11.400Z,1747417571.400 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T17:46:11.401Z,1747417571.401 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T17:46:19.926Z,1747417579.926 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250516T172615/Courier0012.lzma 2025-05-16T17:46:20.929Z,1747417580.929 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0012.lzma.bak 2025-05-16T17:46:20.930Z,1747417580.930 [DataOverHttps](INFO): SBD MOMSN=24896089 2025-05-16T17:46:38.040Z,1747417598.040 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20250516T172615/Express0013.lzma 2025-05-16T17:46:39.040Z,1747417599.040 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0013.lzma.bak 2025-05-16T17:46:39.040Z,1747417599.040 [DataOverHttps](INFO): SBD MOMSN=24896092 2025-05-16T17:46:40.551Z,1747417600.551 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T17:46:40.551Z,1747417600.551 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T17:46:40.552Z,1747417600.552 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T17:46:43.723Z,1747417603.723 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T17:47:28.235Z,1747417648.235 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:47:28.235Z,1747417648.235 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:47:28.267Z,1747417648.267 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:47:28.583Z,1747417648.583 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:47:28.584Z,1747417648.584 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T17:50:29.167Z,1747417829.167 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T17:50:29.167Z,1747417829.167 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:50:29.205Z,1747417829.205 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:50:29.584Z,1747417829.584 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:50:29.584Z,1747417829.584 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T17:51:26.233Z,1747417886.233 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00021119110654,35.0, +14.4,504.8, 0 2025-05-16T17:51:41.100Z,1747417901.100 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T17:51:41.100Z,1747417901.100 [Default:CheckIn:C.Wait] Stopped 2025-05-16T17:51:41.100Z,1747417901.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T17:51:41.100Z,1747417901.100 [Default:CheckIn:D] Running Loop=1 2025-05-16T17:51:41.513Z,1747417901.513 [Default:CheckIn:D] Stopped 2025-05-16T17:51:41.514Z,1747417901.514 [Default:CheckIn:E] Running Loop=1 2025-05-16T17:51:42.102Z,1747417902.102 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.316695 min 2025-05-16T17:51:42.102Z,1747417902.102 [Default:CheckIn:E] Stopped 2025-05-16T17:51:42.171Z,1747417902.171 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T17:51:42.171Z,1747417902.171 [Default:CheckIn] Stopped 2025-05-16T17:51:42.173Z,1747417902.173 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T17:51:42.175Z,1747417902.175 [Default:CheckIn](INFO): Running loop #8 2025-05-16T17:51:42.177Z,1747417902.177 [Default:CheckIn] Running Loop=8 2025-05-16T17:51:42.177Z,1747417902.177 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T17:51:42.179Z,1747417902.179 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T17:51:43.930Z,1747417903.930 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175143.00,A,3648.17367,N,12147.27375,W,3.091,286.29,160525,,,D*7D 2025-05-16T17:51:43.932Z,1747417903.932 [NAL9602](INFO): GPS fix at 20250516T175143: (36.802895, -121.787896) 2025-05-16T17:51:43.967Z,1747417903.967 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T17:51:43.967Z,1747417903.967 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T17:51:53.123Z,1747417913.123 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250516T172615/Courier0015.lzma 2025-05-16T17:51:55.128Z,1747417915.128 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0015.lzma.bak 2025-05-16T17:51:55.128Z,1747417915.128 [DataOverHttps](INFO): SBD MOMSN=24896103 2025-05-16T17:52:14.623Z,1747417934.623 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-05-16T17:52:14.706Z,1747417934.706 [NAL9602](ERROR): received: +CSQ:0 OK350, 2, 0, 0, 0 OK 2025-05-16T17:52:14.986Z,1747417934.986 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20250516T172615/Express0016.lzma 2025-05-16T17:52:16.992Z,1747417936.992 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0016.lzma.bak 2025-05-16T17:52:16.992Z,1747417936.992 [DataOverHttps](INFO): SBD MOMSN=24896106 2025-05-16T17:52:18.674Z,1747417938.674 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T17:52:18.674Z,1747417938.674 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T17:52:18.674Z,1747417938.674 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T17:53:30.233Z,1747418010.233 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:53:30.233Z,1747418010.233 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:53:30.264Z,1747418010.264 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:53:30.634Z,1747418010.634 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:53:30.634Z,1747418010.634 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T17:54:37.681Z,1747418077.681 [NAL9602](INFO): SBD MO Status=0, MOMSN=10350, MT Status=0, MTMSN=0 2025-05-16T17:54:37.681Z,1747418077.681 [NAL9602](INFO): No messages in MT queue 2025-05-16T17:55:08.411Z,1747418108.411 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T17:56:31.297Z,1747418191.297 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T17:56:31.297Z,1747418191.297 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:56:31.422Z,1747418191.422 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:56:31.741Z,1747418191.741 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:56:31.741Z,1747418191.741 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T17:57:19.355Z,1747418239.355 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T17:57:19.355Z,1747418239.355 [Default:CheckIn:C.Wait] Stopped 2025-05-16T17:57:19.355Z,1747418239.355 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T17:57:19.355Z,1747418239.355 [Default:CheckIn:D] Running Loop=1 2025-05-16T17:57:19.733Z,1747418239.733 [Default:CheckIn:D] Stopped 2025-05-16T17:57:19.733Z,1747418239.733 [Default:CheckIn:E] Running Loop=1 2025-05-16T17:57:20.252Z,1747418240.252 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.953682 min 2025-05-16T17:57:20.252Z,1747418240.252 [Default:CheckIn:E] Stopped 2025-05-16T17:57:20.252Z,1747418240.252 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T17:57:20.252Z,1747418240.252 [Default:CheckIn] Stopped 2025-05-16T17:57:20.253Z,1747418240.253 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T17:57:20.253Z,1747418240.253 [Default:CheckIn](INFO): Running loop #9 2025-05-16T17:57:20.253Z,1747418240.253 [Default:CheckIn] Running Loop=9 2025-05-16T17:57:20.253Z,1747418240.253 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T17:57:20.253Z,1747418240.253 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T17:57:22.213Z,1747418242.213 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175721.00,A,3648.17422,N,12147.28352,W,0.175,345.42,160525,,,D*78 2025-05-16T17:57:22.216Z,1747418242.216 [NAL9602](INFO): GPS fix at 20250516T175721: (36.802904, -121.788059) 2025-05-16T17:57:22.250Z,1747418242.250 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T17:57:22.250Z,1747418242.250 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T17:57:37.474Z,1747418257.474 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250516T172615/Courier0018.lzma 2025-05-16T17:57:42.492Z,1747418262.492 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0018.lzma.bak 2025-05-16T17:57:42.492Z,1747418262.492 [DataOverHttps](INFO): SBD MOMSN=24896162 2025-05-16T17:58:05.720Z,1747418285.720 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250516T172615/Express0019.lzma 2025-05-16T17:58:06.721Z,1747418286.721 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0019.lzma.bak 2025-05-16T17:58:06.721Z,1747418286.721 [DataOverHttps](INFO): SBD MOMSN=24896166 2025-05-16T17:58:08.045Z,1747418288.045 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T17:58:08.046Z,1747418288.046 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T17:58:08.046Z,1747418288.046 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T17:59:32.507Z,1747418372.507 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T17:59:32.507Z,1747418372.507 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T17:59:32.523Z,1747418372.523 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T17:59:32.932Z,1747418372.932 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T17:59:32.932Z,1747418372.932 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T18:02:24.644Z,1747418544.644 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-16T18:02:33.522Z,1747418553.522 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T18:02:33.522Z,1747418553.522 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T18:02:33.536Z,1747418553.536 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T18:02:33.946Z,1747418553.946 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T18:02:33.947Z,1747418553.947 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T18:02:55.326Z,1747418575.326 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T18:03:08.690Z,1747418588.690 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T18:03:08.690Z,1747418588.690 [Default:CheckIn:C.Wait] Stopped 2025-05-16T18:03:08.690Z,1747418588.690 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T18:03:08.690Z,1747418588.690 [Default:CheckIn:D] Running Loop=1 2025-05-16T18:03:09.075Z,1747418589.075 [Default:CheckIn:D] Stopped 2025-05-16T18:03:09.075Z,1747418589.075 [Default:CheckIn:E] Running Loop=1 2025-05-16T18:03:09.473Z,1747418589.473 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.776058 min 2025-05-16T18:03:09.473Z,1747418589.473 [Default:CheckIn:E] Stopped 2025-05-16T18:03:09.473Z,1747418589.473 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T18:03:09.473Z,1747418589.473 [Default:CheckIn] Stopped 2025-05-16T18:03:09.473Z,1747418589.473 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T18:03:09.474Z,1747418589.474 [Default:CheckIn](INFO): Running loop #10 2025-05-16T18:03:09.474Z,1747418589.474 [Default:CheckIn] Running Loop=10 2025-05-16T18:03:09.486Z,1747418589.486 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T18:03:09.486Z,1747418589.486 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T18:03:11.497Z,1747418591.497 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180310.00,A,3648.17569,N,12147.28283,W,0.117,345.42,160525,,,D*73 2025-05-16T18:03:11.499Z,1747418591.499 [NAL9602](INFO): GPS fix at 20250516T180310: (36.802928, -121.788047) 2025-05-16T18:03:11.541Z,1747418591.541 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T18:03:11.541Z,1747418591.541 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T18:03:22.119Z,1747418602.119 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250516T172615/Courier0021.lzma 2025-05-16T18:03:24.128Z,1747418604.128 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0021.lzma.bak 2025-05-16T18:03:24.128Z,1747418604.128 [DataOverHttps](INFO): SBD MOMSN=24896175 2025-05-16T18:03:42.238Z,1747418622.238 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-05-16T18:03:42.281Z,1747418622.281 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20250516T172615/Express0022.lzma 2025-05-16T18:03:42.310Z,1747418622.310 [NAL9602](ERROR): received: +CSQ:0 OK350, 0, 0, 0, 0 OK 2025-05-16T18:03:44.276Z,1747418624.276 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0022.lzma.bak 2025-05-16T18:03:44.276Z,1747418624.276 [DataOverHttps](INFO): SBD MOMSN=24896184 2025-05-16T18:03:45.878Z,1747418625.878 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T18:03:45.878Z,1747418625.878 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T18:03:45.878Z,1747418625.878 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T18:04:14.964Z,1747418654.964 [NAL9602](INFO): SBD MO Status=0, MOMSN=10351, MT Status=0, MTMSN=0 2025-05-16T18:04:14.964Z,1747418654.964 [NAL9602](INFO): No messages in MT queue 2025-05-16T18:04:45.635Z,1747418685.635 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T18:05:34.587Z,1747418734.587 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T18:05:34.587Z,1747418734.587 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T18:05:34.612Z,1747418734.612 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T18:05:35.004Z,1747418735.004 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T18:05:35.004Z,1747418735.004 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T18:08:08.524Z,1747418888.524 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00021119274854,35.0, +15.6, 0.0,1508.:RA, 0.00, 0.00, 0.00, 0.00, 0.00 2025-05-16T18:08:35.577Z,1747418915.577 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2025-05-16T18:08:35.577Z,1747418915.577 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T18:08:35.589Z,1747418915.589 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T18:08:35.996Z,1747418915.996 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T18:08:35.996Z,1747418915.996 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2025-05-16T18:08:46.537Z,1747418926.537 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T18:08:46.537Z,1747418926.537 [Default:CheckIn:C.Wait] Stopped 2025-05-16T18:08:46.537Z,1747418926.537 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T18:08:46.538Z,1747418926.538 [Default:CheckIn:D] Running Loop=1 2025-05-16T18:08:46.893Z,1747418926.893 [Default:CheckIn:D] Stopped 2025-05-16T18:08:46.893Z,1747418926.893 [Default:CheckIn:E] Running Loop=1 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.406352 min 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn:E] Stopped 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn] Stopped 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn](INFO): Running loop #11 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn] Running Loop=11 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T18:08:47.301Z,1747418927.301 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T18:08:49.305Z,1747418929.305 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180848.00,A,3648.16808,N,12147.28021,W,0.875,158.78,160525,,,D*7E 2025-05-16T18:08:49.307Z,1747418929.307 [NAL9602](INFO): GPS fix at 20250516T180848: (36.802801, -121.788004) 2025-05-16T18:08:49.341Z,1747418929.341 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T18:08:49.342Z,1747418929.342 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T18:08:56.426Z,1747418936.426 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250516T172615/Courier0024.lzma 2025-05-16T18:08:57.428Z,1747418937.428 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0024.lzma.bak 2025-05-16T18:08:57.428Z,1747418937.428 [DataOverHttps](INFO): SBD MOMSN=24896235 2025-05-16T18:09:21.410Z,1747418961.410 [DataOverHttps](INFO): Sending 175 bytes from file Logs/20250516T172615/Express0025.lzma 2025-05-16T18:09:22.412Z,1747418962.412 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0025.lzma.bak 2025-05-16T18:09:22.412Z,1747418962.412 [DataOverHttps](INFO): SBD MOMSN=24896238 2025-05-16T18:09:23.768Z,1747418963.768 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T18:09:23.768Z,1747418963.768 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T18:09:23.768Z,1747418963.768 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T18:10:42.219Z,1747419042.219 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 0.00, 0.00, 0.00 2025-05-16T18:10:52.245Z,1747419052.245 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for water velocity. Device response is::WS,-32768,-32768,-3 2025-05-16T18:11:02.484Z,1747419062.484 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,-32768V 2025-05-16T18:11:12.231Z,1747419072.231 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, , +0.00, +0.00, 20.00,2893.05 2025-05-16T18:11:32.618Z,1747419092.618 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, , +0.00, +0.00, 0.00, 2025-05-16T18:11:36.494Z,1747419096.494 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T18:11:36.494Z,1747419096.494 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T18:11:36.507Z,1747419096.507 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T18:11:36.904Z,1747419096.904 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T18:11:36.904Z,1747419096.904 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T18:13:51.426Z,1747419231.426 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-16T18:14:22.201Z,1747419262.201 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-16T18:14:24.336Z,1747419264.336 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-16T18:14:24.336Z,1747419264.336 [Default:CheckIn:C.Wait] Stopped 2025-05-16T18:14:24.336Z,1747419264.336 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T18:14:24.337Z,1747419264.337 [Default:CheckIn:D] Running Loop=1 2025-05-16T18:14:24.596Z,1747419264.596 [Default:CheckIn:D] Stopped 2025-05-16T18:14:24.596Z,1747419264.596 [Default:CheckIn:E] Running Loop=1 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.034729 min 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn:E] Stopped 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn] Stopped 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn](INFO): Running loop #12 2025-05-16T18:14:24.995Z,1747419264.995 [Default:CheckIn] Running Loop=12 2025-05-16T18:14:24.996Z,1747419264.996 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-16T18:14:24.996Z,1747419264.996 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-16T18:14:27.012Z,1747419267.012 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181426.00,A,3648.18667,N,12147.27367,W,1.536,40.57,160525,,,D*42 2025-05-16T18:14:27.014Z,1747419267.014 [NAL9602](INFO): GPS fix at 20250516T181426: (36.803111, -121.787894) 2025-05-16T18:14:27.031Z,1747419267.031 [Default:CheckIn:Read_GPS] Stopped 2025-05-16T18:14:27.031Z,1747419267.031 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-16T18:14:34.235Z,1747419274.235 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250516T172615/Courier0027.lzma 2025-05-16T18:14:35.236Z,1747419275.236 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Courier0027.lzma.bak 2025-05-16T18:14:35.236Z,1747419275.236 [DataOverHttps](INFO): SBD MOMSN=24896297 2025-05-16T18:14:37.552Z,1747419277.552 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2025-05-16T18:14:37.552Z,1747419277.552 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2025-05-16T18:14:37.565Z,1747419277.565 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2025-05-16T18:14:37.973Z,1747419277.973 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2025-05-16T18:14:37.973Z,1747419277.973 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2025-05-16T18:14:57.789Z,1747419297.789 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-05-16T18:14:57.866Z,1747419297.866 [NAL9602](ERROR): received: +CSQ:0 OK351, 0, 0, 0, 0 OK 2025-05-16T18:14:59.939Z,1747419299.939 [DataOverHttps](INFO): Sending 254 bytes from file Logs/20250516T172615/Express0028.lzma 2025-05-16T18:15:00.940Z,1747419300.940 [DataOverHttps](INFO): Moved sent file to Logs/20250516T172615/Express0028.lzma.bak 2025-05-16T18:15:00.940Z,1747419300.940 [DataOverHttps](INFO): SBD MOMSN=24896300 2025-05-16T18:15:02.637Z,1747419302.637 [Default:CheckIn:Read_Iridium] Stopped 2025-05-16T18:15:02.638Z,1747419302.638 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-16T18:15:02.638Z,1747419302.638 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-16T18:16:30.099Z,1747419390.099 [CommandExec](IMPORTANT): got command quit 2025-05-16T18:16:31.110Z,1747419391.110 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:31.110Z,1747419391.110 [CommandExec](INFO): Uninitializing the command executive. 2025-05-16T18:16:31.110Z,1747419391.110 [CommandExec](INFO): Uninitializing the command scheduler. 2025-05-16T18:16:31.111Z,1747419391.111 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.130Z,1747419391.130 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-05-16T18:16:31.130Z,1747419391.130 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-05-16T18:16:31.130Z,1747419391.130 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.131Z,1747419391.131 [NavChartDb](INFO): Join timeout helper Thread ID is 9441 2025-05-16T18:16:31.307Z,1747419391.307 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:31.307Z,1747419391.307 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.318Z,1747419391.318 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-05-16T18:16:31.318Z,1747419391.318 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.319Z,1747419391.319 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9442 2025-05-16T18:16:31.373Z,1747419391.373 [CTD_Seabird](INFO): Powering down 2025-05-16T18:16:31.386Z,1747419391.386 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:31.386Z,1747419391.386 [CTD_Seabird](INFO): Powering down 2025-05-16T18:16:31.401Z,1747419391.401 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.404Z,1747419391.404 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-05-16T18:16:31.404Z,1747419391.404 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.404Z,1747419391.404 [Radio_Surface](INFO): Join timeout helper Thread ID is 9443 2025-05-16T18:16:31.738Z,1747419391.738 [Radio_Surface](INFO): Powering down 2025-05-16T18:16:31.739Z,1747419391.739 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:31.739Z,1747419391.739 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.742Z,1747419391.742 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-05-16T18:16:31.742Z,1747419391.742 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:31.743Z,1747419391.743 [Onboard](INFO): Join timeout helper Thread ID is 9444 2025-05-16T18:16:32.458Z,1747419392.458 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:32.458Z,1747419392.458 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.474Z,1747419392.474 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-05-16T18:16:32.474Z,1747419392.474 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.474Z,1747419392.474 [DataOverHttps](INFO): Join timeout helper Thread ID is 9445 2025-05-16T18:16:32.558Z,1747419392.558 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:32.559Z,1747419392.559 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.563Z,1747419392.563 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-05-16T18:16:32.563Z,1747419392.563 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.564Z,1747419392.564 [DAT](INFO): Join timeout helper Thread ID is 9446 2025-05-16T18:16:32.614Z,1747419392.614 [DAT](INFO): Powering down 2025-05-16T18:16:32.687Z,1747419392.687 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:32.687Z,1747419392.687 [DAT](INFO): Powering down 2025-05-16T18:16:32.688Z,1747419392.688 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.711Z,1747419392.711 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-05-16T18:16:32.711Z,1747419392.711 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.711Z,1747419392.711 [BackseatComponent](INFO): Join timeout helper Thread ID is 9447 2025-05-16T18:16:32.746Z,1747419392.746 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:32.747Z,1747419392.747 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.763Z,1747419392.763 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-05-16T18:16:32.763Z,1747419392.763 [logger ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.764Z,1747419392.764 [logger](INFO): Join timeout helper Thread ID is 9448 2025-05-16T18:16:32.808Z,1747419392.808 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:32.808Z,1747419392.808 [logger ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.823Z,1747419392.823 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-05-16T18:16:32.823Z,1747419392.823 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.823Z,1747419392.823 [CommandLine](INFO): Join timeout helper Thread ID is 9449 2025-05-16T18:16:32.906Z,1747419392.906 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:32.907Z,1747419392.907 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.923Z,1747419392.923 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-05-16T18:16:32.923Z,1747419392.923 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.923Z,1747419392.923 [CommandExec](INFO): Join timeout helper Thread ID is 9450 2025-05-16T18:16:32.924Z,1747419392.924 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-05-16T18:16:32.924Z,1747419392.924 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:32.925Z,1747419392.925 [controlThread](INFO): Join timeout helper Thread ID is 9451 2025-05-16T18:16:33.102Z,1747419393.102 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-16T18:16:33.103Z,1747419393.103 [controlThread](DEBUG): Uninitializing ControlThread 2025-05-16T18:16:33.103Z,1747419393.103 [AHRS_M2](INFO): Powering down 2025-05-16T18:16:33.175Z,1747419393.174 [DepthKeller33X](INFO): Powering down 2025-05-16T18:16:33.271Z,1747419393.271 [NAL9602](INFO): Powering down 2025-05-16T18:16:33.342Z,1747419393.342 [RDI_Pathfinder](INFO): Powering down 2025-05-16T18:16:33.343Z,1747419393.343 [Sonardyne_Nano](INFO): Powering down 2025-05-16T18:16:33.462Z,1747419393.462 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-05-16T18:16:33.463Z,1747419393.463 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-05-16T18:16:33.464Z,1747419393.464 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-05-16T18:16:33.464Z,1747419393.464 [MissionManager](INFO): Uninitializing Mission Default 2025-05-16T18:16:33.464Z,1747419393.464 [Default] Stopped 2025-05-16T18:16:33.464Z,1747419393.464 [Default](DEBUG): Aggregate::uninitialize Default 2025-05-16T18:16:33.465Z,1747419393.465 [Default:B.GoToSurface] Stopped 2025-05-16T18:16:33.465Z,1747419393.465 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-05-16T18:16:33.465Z,1747419393.465 [Default:CheckIn] Stopped 2025-05-16T18:16:33.465Z,1747419393.465 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-16T18:16:33.465Z,1747419393.465 [Default:CheckIn:C.Wait] Stopped 2025-05-16T18:16:33.465Z,1747419393.465 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-16T18:16:33.468Z,1747419393.468 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-05-16T18:16:33.468Z,1747419393.468 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-05-16T18:16:33.469Z,1747419393.469 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-05-16T18:16:33.469Z,1747419393.469 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-05-16T18:16:33.469Z,1747419393.469 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-05-16T18:16:33.469Z,1747419393.469 [BuoyancyServo](INFO): Powering down 2025-05-16T18:16:33.482Z,1747419393.482 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-05-16T18:16:33.482Z,1747419393.482 [ElevatorServo](INFO): Powering down 2025-05-16T18:16:33.483Z,1747419393.483 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-05-16T18:16:33.483Z,1747419393.483 [MassServo](INFO): Powering down 2025-05-16T18:16:33.484Z,1747419393.484 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-05-16T18:16:33.484Z,1747419393.484 [RudderServo](INFO): Powering down 2025-05-16T18:16:33.485Z,1747419393.485 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-05-16T18:16:33.485Z,1747419393.485 [ThrusterHE](INFO): Powering down 2025-05-16T18:16:33.486Z,1747419393.486 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-05-16T18:16:33.486Z,1747419393.486 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-05-16T18:16:33.487Z,1747419393.487 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-05-16T18:16:33.487Z,1747419393.487 [CBIT](DEBUG): Powering off loads. 2025-05-16T18:16:33.498Z,1747419393.498 [CBIT](DEBUG): Disabling WDT. 2025-05-16T18:16:33.510Z,1747419393.510 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-05-16T18:16:33.510Z,1747419393.510 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-05-16T18:16:33.511Z,1747419393.511 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.541Z,1747419393.541 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.544Z,1747419393.544 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.551Z,1747419393.551 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.558Z,1747419393.558 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.563Z,1747419393.563 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.625Z,1747419393.625 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.670Z,1747419393.670 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-05-16T18:16:33.670Z,1747419393.670 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-05-16T18:16:33.689Z,1747419393.689 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-16T18:16:33.777Z,1747419393.777 [logger ThreadHandler](INFO): Thread cancelled.