2024-09-20T21:16:00.144Z,1726866960.144 [CommandExec](IMPORTANT): got command restart logs 2024-09-20T21:16:00.849Z,1726866960.849 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:16:02.058Z,1726866962.058 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:16:14.991Z,1726866974.991 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:16:56.640Z,1726867016.640 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:16:56.640Z,1726867016.640 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:16:56.652Z,1726867016.652 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:16:57.072Z,1726867017.072 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:16:57.072Z,1726867017.072 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:18:44.467Z,1726867124.467 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:18:56.186Z,1726867136.186 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-20T21:18:58.204Z,1726867138.204 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:19:11.938Z,1726867151.938 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:19:25.674Z,1726867165.674 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:19:39.815Z,1726867179.815 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:19:53.550Z,1726867193.550 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:19:57.604Z,1726867197.604 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:19:57.604Z,1726867197.604 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:19:57.615Z,1726867197.615 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:19:58.026Z,1726867198.026 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:19:58.027Z,1726867198.027 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:20:07.286Z,1726867207.286 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:20:21.022Z,1726867221.022 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:20:35.164Z,1726867235.164 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:20:48.903Z,1726867248.903 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-20T21:20:54.575Z,1726867254.575 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:20:54.575Z,1726867254.575 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:20:54.575Z,1726867254.575 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:20:54.576Z,1726867254.576 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:20:54.988Z,1726867254.988 [Default:CheckIn:D] Stopped 2024-09-20T21:20:54.988Z,1726867254.988 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:20:55.385Z,1726867255.385 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.208032 min 2024-09-20T21:20:55.385Z,1726867255.385 [Default:CheckIn:E] Stopped 2024-09-20T21:20:55.385Z,1726867255.385 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:20:55.385Z,1726867255.385 [Default:CheckIn] Stopped 2024-09-20T21:20:55.385Z,1726867255.385 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:20:55.386Z,1726867255.386 [Default:CheckIn](INFO): Running loop #6 2024-09-20T21:20:55.386Z,1726867255.386 [Default:CheckIn] Running Loop=6 2024-09-20T21:20:55.386Z,1726867255.386 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:20:55.386Z,1726867255.386 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:20:57.394Z,1726867257.394 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212104.00,A,3648.51335,N,12147.19330,W,4.704,79.68,200924,,,D*46 2024-09-20T21:20:57.397Z,1726867257.397 [NAL9602](INFO): GPS fix at 20240920T212104: (36.808556, -121.786555) 2024-09-20T21:20:57.412Z,1726867257.412 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:20:57.412Z,1726867257.412 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:21:05.227Z,1726867265.227 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240920T183618/Courier0039.lzma 2024-09-20T21:21:06.230Z,1726867266.230 [DataOverHttps](INFO): Moved sent file to Logs/20240920T183618/Courier0039.lzma.bak 2024-09-20T21:21:06.230Z,1726867266.230 [DataOverHttps](INFO): SBD MOMSN=23211805 2024-09-20T21:21:11.126Z,1726867271.126 [NAL9602](INFO): SBD MO Status=0, MOMSN=17663, MT Status=0, MTMSN=0 2024-09-20T21:21:11.127Z,1726867271.127 [NAL9602](INFO): No messages in MT queue 2024-09-20T21:21:22.052Z,1726867282.052 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20240920T211600/Courier0000.lzma 2024-09-20T21:21:23.054Z,1726867283.054 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0000.lzma.bak 2024-09-20T21:21:23.054Z,1726867283.054 [DataOverHttps](INFO): SBD MOMSN=23211808 2024-09-20T21:21:27.299Z,1726867287.299 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2024-09-20T21:21:27.299Z,1726867287.299 [BPC1](INFO): Calculating totals. Valid battery stick count: 43. Valid reserve battery stick count: 5. 2024-09-20T21:21:27.302Z,1726867287.302 [BPC1](INFO): Received data from all battery sticks. 2024-09-20T21:21:38.931Z,1726867298.931 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240920T211600/Courier0003.lzma 2024-09-20T21:21:39.933Z,1726867299.933 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0003.lzma.bak 2024-09-20T21:21:39.934Z,1726867299.934 [DataOverHttps](INFO): SBD MOMSN=23211812 2024-09-20T21:21:41.833Z,1726867301.833 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:21:55.851Z,1726867315.851 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240920T183618/Express0040.lzma 2024-09-20T21:21:56.854Z,1726867316.854 [DataOverHttps](INFO): Moved sent file to Logs/20240920T183618/Express0040.lzma.bak 2024-09-20T21:21:56.854Z,1726867316.854 [DataOverHttps](INFO): SBD MOMSN=23211814 2024-09-20T21:22:12.528Z,1726867332.528 [DataOverHttps](INFO): Sending 399 bytes from file Logs/20240920T211600/Express0001.lzma 2024-09-20T21:22:13.529Z,1726867333.529 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0001.lzma.bak 2024-09-20T21:22:13.530Z,1726867333.530 [DataOverHttps](INFO): SBD MOMSN=23211818 2024-09-20T21:22:29.403Z,1726867349.403 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20240920T211600/Express0004.lzma 2024-09-20T21:22:30.405Z,1726867350.405 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0004.lzma.bak 2024-09-20T21:22:30.406Z,1726867350.406 [DataOverHttps](INFO): SBD MOMSN=23211822 2024-09-20T21:22:31.941Z,1726867351.941 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:22:31.941Z,1726867351.941 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:22:31.941Z,1726867351.941 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:22:58.618Z,1726867378.618 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:22:58.618Z,1726867378.618 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:22:58.629Z,1726867378.629 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:22:59.045Z,1726867379.045 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:22:59.045Z,1726867379.045 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:25:59.638Z,1726867559.638 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:25:59.638Z,1726867559.638 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:25:59.649Z,1726867559.649 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:26:00.034Z,1726867560.034 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:26:00.034Z,1726867560.034 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:27:32.537Z,1726867652.537 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:27:32.537Z,1726867652.537 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:27:32.537Z,1726867652.537 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:27:32.538Z,1726867652.538 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:27:32.946Z,1726867652.946 [Default:CheckIn:D] Stopped 2024-09-20T21:27:32.946Z,1726867652.946 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:27:33.362Z,1726867653.362 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.840666 min 2024-09-20T21:27:33.362Z,1726867653.362 [Default:CheckIn:E] Stopped 2024-09-20T21:27:33.362Z,1726867653.362 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:27:33.363Z,1726867653.363 [Default:CheckIn] Stopped 2024-09-20T21:27:33.363Z,1726867653.363 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:27:33.363Z,1726867653.363 [Default:CheckIn](INFO): Running loop #7 2024-09-20T21:27:33.363Z,1726867653.363 [Default:CheckIn] Running Loop=7 2024-09-20T21:27:33.363Z,1726867653.363 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:27:33.363Z,1726867653.363 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:27:35.354Z,1726867655.354 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212742.00,A,3648.15006,N,12147.22082,W,0.039,234.14,200924,,,D*7E 2024-09-20T21:27:35.356Z,1726867655.356 [NAL9602](INFO): GPS fix at 20240920T212742: (36.802501, -121.787014) 2024-09-20T21:27:35.371Z,1726867655.371 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:27:35.371Z,1726867655.371 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:27:41.956Z,1726867661.956 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20240920T211600/Courier0006.lzma 2024-09-20T21:27:42.957Z,1726867662.957 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0006.lzma.bak 2024-09-20T21:27:42.958Z,1726867662.958 [DataOverHttps](INFO): SBD MOMSN=23211827 2024-09-20T21:27:53.134Z,1726867673.134 [NAL9602](INFO): SBD MO Status=2, MOMSN=17664, MT Status=2, MTMSN=0 2024-09-20T21:27:53.134Z,1726867673.134 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-20T21:27:58.735Z,1726867678.735 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240920T211600/Express0007.lzma 2024-09-20T21:27:59.737Z,1726867679.737 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0007.lzma.bak 2024-09-20T21:27:59.738Z,1726867679.738 [DataOverHttps](INFO): SBD MOMSN=23211830 2024-09-20T21:28:01.234Z,1726867681.234 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:28:01.235Z,1726867681.235 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:28:01.235Z,1726867681.235 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:28:03.634Z,1726867683.634 [NAL9602](INFO): SBD MO Status=0, MOMSN=17664, MT Status=0, MTMSN=0 2024-09-20T21:28:03.635Z,1726867683.635 [NAL9602](INFO): No messages in MT queue 2024-09-20T21:28:34.337Z,1726867714.337 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:28:56.580Z,1726867736.580 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-20T21:29:00.628Z,1726867740.628 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:29:00.628Z,1726867740.628 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:29:00.651Z,1726867740.651 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:29:01.041Z,1726867741.041 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:29:01.041Z,1726867741.041 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:32:01.620Z,1726867921.620 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:32:01.620Z,1726867921.620 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:32:01.632Z,1726867921.632 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:32:02.045Z,1726867922.045 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:32:02.045Z,1726867922.045 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:33:01.843Z,1726867981.843 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:33:01.843Z,1726867981.843 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:33:01.843Z,1726867981.843 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:33:01.843Z,1726867981.843 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:33:02.256Z,1726867982.256 [Default:CheckIn:D] Stopped 2024-09-20T21:33:02.256Z,1726867982.256 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:33:02.654Z,1726867982.654 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.329171 min 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn:E] Stopped 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn] Stopped 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn](INFO): Running loop #8 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn] Running Loop=8 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:33:02.655Z,1726867982.655 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:33:04.662Z,1726867984.662 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213311.00,A,3648.14032,N,12147.23057,W,1.575,230.37,200924,,,D*7B 2024-09-20T21:33:04.665Z,1726867984.665 [NAL9602](INFO): GPS fix at 20240920T213311: (36.802339, -121.787176) 2024-09-20T21:33:04.680Z,1726867984.680 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:33:04.680Z,1726867984.680 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:33:11.659Z,1726867991.659 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240920T211600/Courier0009.lzma 2024-09-20T21:33:12.661Z,1726867992.661 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0009.lzma.bak 2024-09-20T21:33:12.662Z,1726867992.662 [DataOverHttps](INFO): SBD MOMSN=23211835 2024-09-20T21:33:28.427Z,1726868008.427 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240920T211600/Express0010.lzma 2024-09-20T21:33:29.429Z,1726868009.429 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0010.lzma.bak 2024-09-20T21:33:29.430Z,1726868009.430 [DataOverHttps](INFO): SBD MOMSN=23211838 2024-09-20T21:33:30.934Z,1726868010.934 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:33:30.935Z,1726868010.935 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:33:30.935Z,1726868010.935 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:33:32.939Z,1726868012.939 [NAL9602](INFO): SBD MO Status=0, MOMSN=17665, MT Status=0, MTMSN=0 2024-09-20T21:33:32.939Z,1726868012.939 [NAL9602](INFO): No messages in MT queue 2024-09-20T21:34:03.641Z,1726868043.641 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:34:18.129Z,1726868058.129 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:18.131Z,1726868058.131 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:18.132Z,1726868058.132 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:18.132Z,1726868058.132 [DATMMP](INFO): Handled 2024-09-20T21:34:18.380Z,1726868058.380 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:18.381Z,1726868058.381 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:18.381Z,1726868058.381 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:18.381Z,1726868058.381 [DATMMP](INFO): Handled 2024-09-20T21:34:18.632Z,1726868058.632 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:18.633Z,1726868058.633 [DATMMP](INFO): timestamp rx: x1 x15 x22 x10 x9F1 2024-09-20T21:34:18.634Z,1726868058.634 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868080.894976 2024-09-20T21:34:18.634Z,1726868058.634 [DATMMP](INFO): Rx ping set to:1726868058.633363 2024-09-20T21:34:18.634Z,1726868058.634 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:18.634Z,1726868058.634 [DATMMP](INFO): Handled 2024-09-20T21:34:18.884Z,1726868058.884 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:18.886Z,1726868058.886 [DATMMP](INFO): acstats rx: x0 x0 x0 x6E x29 x1C x64 x0 x0 xFFFF x0 x5A x0 x0 2024-09-20T21:34:18.886Z,1726868058.886 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:18.886Z,1726868058.886 [DATMMP](INFO): Handled 2024-09-20T21:34:24.440Z,1726868064.440 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:24.441Z,1726868064.441 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:24.441Z,1726868064.441 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:24.441Z,1726868064.441 [DATMMP](INFO): Handled 2024-09-20T21:34:24.692Z,1726868064.692 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:24.693Z,1726868064.693 [DATMMP](INFO): timestamp rx: x1 x15 x22 x16 xCD5 2024-09-20T21:34:24.694Z,1726868064.694 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868094.083968 2024-09-20T21:34:24.694Z,1726868064.694 [DATMMP](INFO): Rx ping set to:1726868064.693338 2024-09-20T21:34:24.694Z,1726868064.694 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:24.694Z,1726868064.694 [DATMMP](INFO): Handled 2024-09-20T21:34:25.197Z,1726868065.197 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:25.199Z,1726868065.199 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:25.200Z,1726868065.200 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:25.200Z,1726868065.200 [DATMMP](INFO): Handled 2024-09-20T21:34:25.452Z,1726868065.452 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:25.453Z,1726868065.453 [DATMMP](INFO): directional_debug rx: x4F2 xFDE9 x53 x57C x4540 x50E1 x47D2 x6AE3 2024-09-20T21:34:25.454Z,1726868065.454 [DATMMP](INFO): Received message type: directional_debug 2024-09-20T21:34:25.454Z,1726868065.454 [DATMMP](INFO): Handled 2024-09-20T21:34:25.704Z,1726868065.704 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:25.706Z,1726868065.706 [DATMMP](INFO): directional rx: x4B3 xFDBE xEA x217 x25D x1E7 x0 x13E xFFE7 x3A x27B5966 x-43569E0 2024-09-20T21:34:25.707Z,1726868065.707 [DATMMP](INFO): Received message type: directional 2024-09-20T21:34:25.708Z,1726868065.708 [DATMMP](INFO): Handled 2024-09-20T21:34:25.956Z,1726868065.956 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:25.957Z,1726868065.957 [DATMMP](INFO): header_err rx: x0 xFFCE x25 x1D x64 x7D x5 2024-09-20T21:34:25.958Z,1726868065.958 [DATMMP](INFO): Received message type: header_err 2024-09-20T21:34:25.958Z,1726868065.958 [DATMMP](INFO): Handled 2024-09-20T21:34:27.216Z,1726868067.216 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:27.217Z,1726868067.217 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:27.217Z,1726868067.217 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:27.217Z,1726868067.217 [DATMMP](INFO): Handled 2024-09-20T21:34:27.472Z,1726868067.472 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:27.473Z,1726868067.473 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:27.473Z,1726868067.473 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:27.473Z,1726868067.473 [DATMMP](INFO): Handled 2024-09-20T21:34:27.724Z,1726868067.724 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:27.725Z,1726868067.725 [DATMMP](INFO): timestamp rx: x1 x15 x22 x19 x80D 2024-09-20T21:34:27.726Z,1726868067.726 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868085.133120 2024-09-20T21:34:27.726Z,1726868067.726 [DATMMP](INFO): Rx ping set to:1726868067.725164 2024-09-20T21:34:27.726Z,1726868067.726 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:27.726Z,1726868067.726 [DATMMP](INFO): Handled 2024-09-20T21:34:27.976Z,1726868067.976 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:27.978Z,1726868067.978 [DATMMP](INFO): acstats rx: x0 x0 x0 x4E x2C x1B x64 x0 x0 xFFFF x0 x5A x0 x0 2024-09-20T21:34:27.978Z,1726868067.978 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:27.978Z,1726868067.978 [DATMMP](INFO): Handled 2024-09-20T21:34:28.228Z,1726868068.228 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:28.229Z,1726868068.229 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:28.229Z,1726868068.229 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:28.229Z,1726868068.229 [DATMMP](INFO): Handled 2024-09-20T21:34:28.483Z,1726868068.483 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:28.485Z,1726868068.485 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:28.486Z,1726868068.486 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:28.486Z,1726868068.486 [DATMMP](INFO): Handled 2024-09-20T21:34:28.732Z,1726868068.732 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:28.733Z,1726868068.733 [DATMMP](INFO): timestamp rx: x1 x15 x22 x19 x1F7C 2024-09-20T21:34:28.734Z,1726868068.734 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868079.745472 2024-09-20T21:34:28.734Z,1726868068.734 [DATMMP](INFO): Rx ping set to:1726868068.733250 2024-09-20T21:34:28.734Z,1726868068.734 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:28.734Z,1726868068.734 [DATMMP](INFO): Handled 2024-09-20T21:34:28.984Z,1726868068.984 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:28.986Z,1726868068.986 [DATMMP](INFO): acstats rx: x0 x0 x0 x3A xF9 x1F x64 x0 x0 xFFFF x0 x5A x0 x0 2024-09-20T21:34:28.986Z,1726868068.986 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:28.986Z,1726868068.986 [DATMMP](INFO): Handled 2024-09-20T21:34:29.236Z,1726868069.236 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:29.237Z,1726868069.237 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:29.237Z,1726868069.237 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:29.237Z,1726868069.237 [DATMMP](INFO): Handled 2024-09-20T21:34:29.492Z,1726868069.492 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:29.493Z,1726868069.493 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:29.493Z,1726868069.493 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:29.493Z,1726868069.493 [DATMMP](INFO): Handled 2024-09-20T21:34:29.744Z,1726868069.744 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:29.745Z,1726868069.745 [DATMMP](INFO): timestamp rx: x1 x15 x22 x1A xE7E 2024-09-20T21:34:29.746Z,1726868069.746 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868102.241664 2024-09-20T21:34:29.746Z,1726868069.746 [DATMMP](INFO): Rx ping set to:1726868069.745257 2024-09-20T21:34:29.746Z,1726868069.746 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:29.746Z,1726868069.746 [DATMMP](INFO): Handled 2024-09-20T21:34:29.996Z,1726868069.996 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:29.998Z,1726868069.998 [DATMMP](INFO): acstats rx: x0 x0 x0 x74 x27 x21 x64 x0 x0 xFFFF x0 x5A x0 x0 2024-09-20T21:34:29.998Z,1726868069.998 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:29.998Z,1726868069.998 [DATMMP](INFO): Handled 2024-09-20T21:34:35.040Z,1726868075.040 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:35.041Z,1726868075.041 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:35.041Z,1726868075.041 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:35.041Z,1726868075.041 [DATMMP](INFO): Handled 2024-09-20T21:34:35.292Z,1726868075.292 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:35.293Z,1726868075.293 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:35.293Z,1726868075.293 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:35.293Z,1726868075.293 [DATMMP](INFO): Handled 2024-09-20T21:34:35.552Z,1726868075.552 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:35.553Z,1726868075.553 [DATMMP](INFO): timestamp rx: x1 x15 x22 x21 x215 2024-09-20T21:34:35.554Z,1726868075.554 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868078.215040 2024-09-20T21:34:35.554Z,1726868075.554 [DATMMP](INFO): Rx ping set to:1726868075.553237 2024-09-20T21:34:35.554Z,1726868075.554 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:35.554Z,1726868075.554 [DATMMP](INFO): Handled 2024-09-20T21:34:35.804Z,1726868075.804 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:35.806Z,1726868075.806 [DATMMP](INFO): acstats rx: x0 x0 x0 x2C x29 x1E x64 x0 x0 xFFFF x0 x56 x0 x0 2024-09-20T21:34:35.806Z,1726868075.806 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:35.806Z,1726868075.806 [DATMMP](INFO): Handled 2024-09-20T21:34:36.056Z,1726868076.056 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:36.057Z,1726868076.057 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:36.057Z,1726868076.057 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:36.057Z,1726868076.057 [DATMMP](INFO): Handled 2024-09-20T21:34:36.308Z,1726868076.308 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:36.309Z,1726868076.309 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:36.309Z,1726868076.309 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:36.309Z,1726868076.309 [DATMMP](INFO): Handled 2024-09-20T21:34:36.560Z,1726868076.560 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:36.561Z,1726868076.561 [DATMMP](INFO): timestamp rx: x1 x15 x22 x21 x1437 2024-09-20T21:34:36.562Z,1726868076.562 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868123.563200 2024-09-20T21:34:36.562Z,1726868076.562 [DATMMP](INFO): Rx ping set to:1726868076.561344 2024-09-20T21:34:36.562Z,1726868076.562 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:36.562Z,1726868076.562 [DATMMP](INFO): Handled 2024-09-20T21:34:36.812Z,1726868076.812 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:36.814Z,1726868076.814 [DATMMP](INFO): acstats rx: x0 x0 x0 x7E x2A x1F x64 x0 x0 xFFFF x0 x5A x0 x0 2024-09-20T21:34:36.814Z,1726868076.814 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:36.814Z,1726868076.814 [DATMMP](INFO): Handled 2024-09-20T21:34:37.064Z,1726868077.064 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:37.065Z,1726868077.065 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:37.065Z,1726868077.065 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:37.065Z,1726868077.065 [DATMMP](INFO): Handled 2024-09-20T21:34:37.316Z,1726868077.316 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:37.317Z,1726868077.317 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:37.317Z,1726868077.317 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:37.317Z,1726868077.317 [DATMMP](INFO): Handled 2024-09-20T21:34:37.568Z,1726868077.568 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:37.569Z,1726868077.569 [DATMMP](INFO): timestamp rx: x1 x15 x22 x22 x14 2024-09-20T21:34:37.570Z,1726868077.570 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868074.204800 2024-09-20T21:34:37.570Z,1726868077.570 [DATMMP](INFO): Rx ping set to:1726868077.569262 2024-09-20T21:34:37.570Z,1726868077.570 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:37.570Z,1726868077.570 [DATMMP](INFO): Handled 2024-09-20T21:34:37.820Z,1726868077.820 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:37.822Z,1726868077.822 [DATMMP](INFO): acstats rx: x0 x0 x0 x83 x29 x1F x64 x0 x0 xFFFF x0 x56 x0 x0 2024-09-20T21:34:37.822Z,1726868077.822 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:37.822Z,1726868077.822 [DATMMP](INFO): Handled 2024-09-20T21:34:38.072Z,1726868078.072 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:38.073Z,1726868078.073 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:38.073Z,1726868078.073 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:38.073Z,1726868078.073 [DATMMP](INFO): Handled 2024-09-20T21:34:38.324Z,1726868078.324 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:38.325Z,1726868078.325 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:38.325Z,1726868078.325 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:38.325Z,1726868078.325 [DATMMP](INFO): Handled 2024-09-20T21:34:38.577Z,1726868078.577 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:38.578Z,1726868078.578 [DATMMP](INFO): timestamp rx: x1 x15 x22 x23 x1699 2024-09-20T21:34:38.579Z,1726868078.579 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868131.518144 2024-09-20T21:34:38.579Z,1726868078.579 [DATMMP](INFO): Rx ping set to:1726868078.578201 2024-09-20T21:34:38.579Z,1726868078.579 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:38.579Z,1726868078.579 [DATMMP](INFO): Handled 2024-09-20T21:34:38.828Z,1726868078.828 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:38.830Z,1726868078.830 [DATMMP](INFO): acstats rx: x0 x0 x0 x73 x29 x21 x64 x0 x0 xFFFF x0 x5A x0 x0 2024-09-20T21:34:38.830Z,1726868078.830 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:38.830Z,1726868078.830 [DATMMP](INFO): Handled 2024-09-20T21:34:39.081Z,1726868079.081 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:39.081Z,1726868079.081 [DATMMP](INFO): doppler rx: x0 2024-09-20T21:34:39.081Z,1726868079.081 [DATMMP](INFO): Received message type: doppler 2024-09-20T21:34:39.081Z,1726868079.081 [DATMMP](INFO): Handled 2024-09-20T21:34:39.333Z,1726868079.333 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:39.333Z,1726868079.333 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2024-09-20T21:34:39.333Z,1726868079.333 [DATMMP](INFO): Received message type: nav_stat 2024-09-20T21:34:39.334Z,1726868079.334 [DATMMP](INFO): Handled 2024-09-20T21:34:39.585Z,1726868079.585 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:39.586Z,1726868079.586 [DATMMP](INFO): timestamp rx: x1 x15 x22 x24 xCB2 2024-09-20T21:34:39.587Z,1726868079.587 [DATMMP](INFO): Rx dataTimestamp_ set to:1726868107.774144 2024-09-20T21:34:39.587Z,1726868079.587 [DATMMP](INFO): Rx ping set to:1726868079.586418 2024-09-20T21:34:39.587Z,1726868079.587 [DATMMP](INFO): Received message type: timestamp 2024-09-20T21:34:39.588Z,1726868079.588 [DATMMP](INFO): Handled 2024-09-20T21:34:39.836Z,1726868079.836 [DATMMP](INFO): GSXN notify for xid: 0 2024-09-20T21:34:39.838Z,1726868079.838 [DATMMP](INFO): acstats rx: x0 x0 x0 x47 x2A x1B x64 x0 x0 xFFFF x0 x45 x0 x0 2024-09-20T21:34:39.838Z,1726868079.838 [DATMMP](INFO): Received message type: acstats 2024-09-20T21:34:39.838Z,1726868079.838 [DATMMP](INFO): Handled 2024-09-20T21:35:02.640Z,1726868102.640 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:35:02.640Z,1726868102.640 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:35:02.651Z,1726868102.651 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:35:03.068Z,1726868103.068 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:35:03.068Z,1726868103.068 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:38:03.627Z,1726868283.627 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:38:03.627Z,1726868283.627 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:38:03.643Z,1726868283.643 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:38:04.047Z,1726868284.047 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:38:04.047Z,1726868284.047 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:38:31.517Z,1726868311.517 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:38:31.517Z,1726868311.517 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:38:31.517Z,1726868311.517 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:38:31.518Z,1726868311.518 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:38:31.913Z,1726868311.913 [Default:CheckIn:D] Stopped 2024-09-20T21:38:31.913Z,1726868311.913 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:38:32.316Z,1726868312.316 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.823442 min 2024-09-20T21:38:32.316Z,1726868312.316 [Default:CheckIn:E] Stopped 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn] Stopped 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn](INFO): Running loop #9 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn] Running Loop=9 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:38:32.317Z,1726868312.317 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:38:34.334Z,1726868314.334 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213841.00,A,3648.17578,N,12147.28170,W,0.058,289.07,200924,,,D*78 2024-09-20T21:38:34.337Z,1726868314.337 [NAL9602](INFO): GPS fix at 20240920T213841: (36.802930, -121.788028) 2024-09-20T21:38:34.351Z,1726868314.351 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:38:34.351Z,1726868314.351 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:38:43.775Z,1726868323.775 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240920T211600/Courier0012.lzma 2024-09-20T21:38:44.778Z,1726868324.778 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0012.lzma.bak 2024-09-20T21:38:44.778Z,1726868324.778 [DataOverHttps](INFO): SBD MOMSN=23211842 2024-09-20T21:39:02.371Z,1726868342.371 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240920T211600/Express0013.lzma 2024-09-20T21:39:03.373Z,1726868343.373 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0013.lzma.bak 2024-09-20T21:39:03.374Z,1726868343.374 [DataOverHttps](INFO): SBD MOMSN=23211845 2024-09-20T21:39:04.675Z,1726868344.675 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:39:04.675Z,1726868344.675 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:39:04.675Z,1726868344.675 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:39:24.855Z,1726868364.855 [NAL9602](INFO): SBD MO Status=2, MOMSN=17666, MT Status=2, MTMSN=0 2024-09-20T21:39:24.855Z,1726868364.855 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-20T21:39:53.135Z,1726868393.135 [NAL9602](INFO): SBD MO Status=0, MOMSN=17666, MT Status=0, MTMSN=0 2024-09-20T21:39:53.135Z,1726868393.135 [NAL9602](INFO): No messages in MT queue 2024-09-20T21:40:23.841Z,1726868423.841 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:41:04.667Z,1726868464.667 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:41:04.667Z,1726868464.667 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:41:04.678Z,1726868464.678 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:41:05.090Z,1726868465.090 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:41:05.090Z,1726868465.090 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:44:05.358Z,1726868645.358 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:44:05.358Z,1726868645.358 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:44:05.358Z,1726868645.358 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:44:05.358Z,1726868645.358 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:44:05.775Z,1726868645.775 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:44:05.775Z,1726868645.775 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:44:05.777Z,1726868645.777 [Default:CheckIn:D] Stopped 2024-09-20T21:44:05.777Z,1726868645.777 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:44:05.786Z,1726868645.786 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.387846 min 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn:E] Stopped 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn] Stopped 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn](INFO): Running loop #10 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn] Running Loop=10 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:44:06.157Z,1726868646.157 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:44:06.167Z,1726868646.167 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:44:06.167Z,1726868646.167 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:44:08.168Z,1726868648.168 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214415.00,A,3648.17651,N,12147.28800,W,0.019,251.00,200924,,,D*73 2024-09-20T21:44:08.170Z,1726868648.170 [NAL9602](INFO): GPS fix at 20240920T214415: (36.802942, -121.788133) 2024-09-20T21:44:08.185Z,1726868648.185 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:44:08.185Z,1726868648.185 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:44:15.328Z,1726868655.328 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240920T211600/Courier0015.lzma 2024-09-20T21:44:16.329Z,1726868656.329 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0015.lzma.bak 2024-09-20T21:44:16.330Z,1726868656.330 [DataOverHttps](INFO): SBD MOMSN=23211849 2024-09-20T21:44:32.035Z,1726868672.035 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240920T211600/Express0016.lzma 2024-09-20T21:44:33.037Z,1726868673.037 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0016.lzma.bak 2024-09-20T21:44:33.038Z,1726868673.038 [DataOverHttps](INFO): SBD MOMSN=23211852 2024-09-20T21:44:34.443Z,1726868674.443 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:44:34.443Z,1726868674.443 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:44:34.443Z,1726868674.443 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:45:56.846Z,1726868756.846 [NAL9602](INFO): SBD MO Status=0, MOMSN=17667, MT Status=0, MTMSN=0 2024-09-20T21:45:56.846Z,1726868756.846 [NAL9602](INFO): No messages in MT queue 2024-09-20T21:46:27.557Z,1726868787.557 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:47:06.783Z,1726868826.783 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:47:06.788Z,1726868826.788 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:47:06.812Z,1726868826.812 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:47:07.201Z,1726868827.201 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:47:07.201Z,1726868827.201 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:49:35.092Z,1726868975.092 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:49:35.092Z,1726868975.092 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:49:35.092Z,1726868975.092 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:49:35.092Z,1726868975.092 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:49:35.506Z,1726868975.506 [Default:CheckIn:D] Stopped 2024-09-20T21:49:35.506Z,1726868975.506 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.883337 min 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn:E] Stopped 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn] Stopped 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn](INFO): Running loop #11 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn] Running Loop=11 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:49:35.914Z,1726868975.914 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:49:37.911Z,1726868977.911 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214944.00,A,3648.17575,N,12147.28131,W,0.058,251.00,200924,,,D*71 2024-09-20T21:49:37.913Z,1726868977.913 [NAL9602](INFO): GPS fix at 20240920T214944: (36.802929, -121.788022) 2024-09-20T21:49:37.948Z,1726868977.948 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:49:37.953Z,1726868977.953 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:49:44.847Z,1726868984.847 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20240920T211600/Courier0018.lzma 2024-09-20T21:49:45.849Z,1726868985.849 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0018.lzma.bak 2024-09-20T21:49:45.850Z,1726868985.850 [DataOverHttps](INFO): SBD MOMSN=23211869 2024-09-20T21:49:50.838Z,1726868990.838 [NAL9602](INFO): SBD MO Status=0, MOMSN=17668, MT Status=0, MTMSN=0 2024-09-20T21:49:50.838Z,1726868990.838 [NAL9602](INFO): No messages in MT queue 2024-09-20T21:50:01.667Z,1726869001.667 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240920T211600/Express0019.lzma 2024-09-20T21:50:02.670Z,1726869002.670 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0019.lzma.bak 2024-09-20T21:50:02.670Z,1726869002.670 [DataOverHttps](INFO): SBD MOMSN=23211872 2024-09-20T21:50:04.190Z,1726869004.190 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:50:04.190Z,1726869004.190 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:50:04.190Z,1726869004.190 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:50:07.853Z,1726869007.853 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:50:07.853Z,1726869007.853 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:50:07.897Z,1726869007.897 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:50:08.280Z,1726869008.280 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:50:08.281Z,1726869008.281 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:50:21.541Z,1726869021.541 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T21:53:08.875Z,1726869188.875 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:53:08.875Z,1726869188.875 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:53:08.898Z,1726869188.898 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:53:09.289Z,1726869189.289 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:53:09.289Z,1726869189.289 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:55:04.828Z,1726869304.828 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T21:55:04.829Z,1726869304.829 [Default:CheckIn:C.Wait] Stopped 2024-09-20T21:55:04.829Z,1726869304.829 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T21:55:04.829Z,1726869304.829 [Default:CheckIn:D] Running Loop=1 2024-09-20T21:55:05.216Z,1726869305.216 [Default:CheckIn:D] Stopped 2024-09-20T21:55:05.216Z,1726869305.216 [Default:CheckIn:E] Running Loop=1 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.378503 min 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn:E] Stopped 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn] Stopped 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn](INFO): Running loop #12 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn] Running Loop=12 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T21:55:05.614Z,1726869305.614 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T21:55:07.623Z,1726869307.623 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215514.00,A,3648.17363,N,12147.28017,W,0.778,306.50,200924,,,D*7E 2024-09-20T21:55:07.625Z,1726869307.625 [NAL9602](INFO): GPS fix at 20240920T215514: (36.802894, -121.788003) 2024-09-20T21:55:07.640Z,1726869307.640 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T21:55:07.640Z,1726869307.640 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T21:55:14.551Z,1726869314.551 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240920T211600/Courier0021.lzma 2024-09-20T21:55:15.553Z,1726869315.553 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0021.lzma.bak 2024-09-20T21:55:15.554Z,1726869315.554 [DataOverHttps](INFO): SBD MOMSN=23211894 2024-09-20T21:55:31.431Z,1726869331.431 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240920T211600/Express0022.lzma 2024-09-20T21:55:32.434Z,1726869332.434 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0022.lzma.bak 2024-09-20T21:55:32.434Z,1726869332.434 [DataOverHttps](INFO): SBD MOMSN=23211897 2024-09-20T21:55:33.900Z,1726869333.900 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T21:55:33.900Z,1726869333.900 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T21:55:33.900Z,1726869333.900 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T21:56:09.893Z,1726869369.893 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T21:56:09.893Z,1726869369.893 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:56:09.905Z,1726869369.905 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:56:10.269Z,1726869370.269 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:56:10.269Z,1726869370.269 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T21:58:06.594Z,1726869486.594 [NAL9602](INFO): SBD MO Status=2, MOMSN=17669, MT Status=2, MTMSN=0 2024-09-20T21:58:06.595Z,1726869486.595 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-20T21:58:23.966Z,1726869503.966 [NAL9602](INFO): SBD MO Status=2, MOMSN=17669, MT Status=2, MTMSN=0 2024-09-20T21:58:23.966Z,1726869503.966 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-20T21:59:10.878Z,1726869550.878 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T21:59:10.878Z,1726869550.878 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T21:59:10.902Z,1726869550.902 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T21:59:11.253Z,1726869551.253 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-09-20T21:59:11.253Z,1726869551.253 [DropWeight] Hardware Fault, FailCount= 1 2024-09-20T21:59:11.253Z,1726869551.253 [DropWeight](ERROR): Hardware Fault 2024-09-20T21:59:11.321Z,1726869551.321 [CommandExec](FAULT): Scheduling is paused 2024-09-20T21:59:11.321Z,1726869551.321 [CBIT](INFO): Critical error at 20240920T215911 2024-09-20T21:59:11.332Z,1726869551.332 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-09-20T21:59:11.332Z,1726869551.332 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-09-20T21:59:11.333Z,1726869551.333 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T21:59:11.333Z,1726869551.333 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T21:59:11.698Z,1726869551.698 [CBIT](INFO): Critical error at 20240920T215911 2024-09-20T22:00:09.433Z,1726869609.433 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-20T22:00:34.487Z,1726869634.487 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T22:00:34.488Z,1726869634.488 [Default:CheckIn:C.Wait] Stopped 2024-09-20T22:00:34.488Z,1726869634.488 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T22:00:34.488Z,1726869634.488 [Default:CheckIn:D] Running Loop=1 2024-09-20T22:00:34.897Z,1726869634.897 [Default:CheckIn:D] Stopped 2024-09-20T22:00:34.897Z,1726869634.897 [Default:CheckIn:E] Running Loop=1 2024-09-20T22:00:35.301Z,1726869635.301 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 68.873177 min 2024-09-20T22:00:35.301Z,1726869635.301 [Default:CheckIn:E] Stopped 2024-09-20T22:00:35.301Z,1726869635.301 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T22:00:35.301Z,1726869635.301 [Default:CheckIn] Stopped 2024-09-20T22:00:35.301Z,1726869635.301 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T22:00:35.302Z,1726869635.302 [Default:CheckIn](INFO): Running loop #13 2024-09-20T22:00:35.302Z,1726869635.302 [Default:CheckIn] Running Loop=13 2024-09-20T22:00:35.302Z,1726869635.302 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T22:00:35.302Z,1726869635.302 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T22:00:37.310Z,1726869637.310 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220044.00,A,3648.16573,N,12147.28495,W,2.896,228.70,200924,,,D*72 2024-09-20T22:00:37.322Z,1726869637.322 [NAL9602](INFO): GPS fix at 20240920T220044: (36.802762, -121.788083) 2024-09-20T22:00:37.337Z,1726869637.337 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T22:00:37.337Z,1726869637.337 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T22:00:47.347Z,1726869647.347 [DataOverHttps](INFO): Sending 179 bytes from file Logs/20240920T211600/Courier0024.lzma 2024-09-20T22:00:48.358Z,1726869648.358 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0024.lzma.bak 2024-09-20T22:00:48.358Z,1726869648.358 [DataOverHttps](INFO): SBD MOMSN=23211902 2024-09-20T22:01:04.152Z,1726869664.152 [DataOverHttps](INFO): Sending 258 bytes from file Logs/20240920T211600/Express0025.lzma 2024-09-20T22:01:05.154Z,1726869665.154 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0025.lzma.bak 2024-09-20T22:01:05.154Z,1726869665.154 [DataOverHttps](INFO): SBD MOMSN=23211907 2024-09-20T22:01:06.477Z,1726869666.477 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T22:01:06.477Z,1726869666.477 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T22:01:06.478Z,1726869666.478 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T22:01:09.692Z,1726869669.692 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T22:02:11.978Z,1726869731.978 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-20T22:02:11.979Z,1726869731.979 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T22:02:11.991Z,1726869731.991 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T22:02:12.353Z,1726869732.353 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T22:02:12.353Z,1726869732.353 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-20T22:05:13.050Z,1726869913.050 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-20T22:05:13.050Z,1726869913.050 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T22:05:13.074Z,1726869913.074 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T22:05:13.483Z,1726869913.483 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T22:05:13.483Z,1726869913.483 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-20T22:06:07.180Z,1726869967.180 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-20T22:06:07.181Z,1726869967.181 [Default:CheckIn:C.Wait] Stopped 2024-09-20T22:06:07.181Z,1726869967.181 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T22:06:07.181Z,1726869967.181 [Default:CheckIn:D] Running Loop=1 2024-09-20T22:06:07.584Z,1726869967.584 [Default:CheckIn:D] Stopped 2024-09-20T22:06:07.584Z,1726869967.584 [Default:CheckIn:E] Running Loop=1 2024-09-20T22:06:07.985Z,1726869967.985 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.417961 min 2024-09-20T22:06:07.985Z,1726869967.985 [Default:CheckIn:E] Stopped 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn] Stopped 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn](INFO): Running loop #14 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn] Running Loop=14 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-20T22:06:07.986Z,1726869967.986 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-20T22:06:40.692Z,1726870000.692 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-09-20T22:06:40.776Z,1726870000.776 [NAL9602](ERROR): received: +CSQ:0 OK669, 2, 0, 0, 0 OK 2024-09-20T22:08:14.084Z,1726870094.084 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-09-20T22:08:14.084Z,1726870094.084 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T22:08:14.099Z,1726870094.099 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T22:08:14.526Z,1726870094.526 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T22:08:14.526Z,1726870094.526 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-09-20T22:11:08.230Z,1726870268.230 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-20T22:06:07.0Z 2024-09-20T22:11:08.230Z,1726870268.230 [Default:CheckIn:Read_GPS] Stopped 2024-09-20T22:11:08.231Z,1726870268.231 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-20T22:11:12.661Z,1726870272.661 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-20T22:11:15.101Z,1726870275.101 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4 2024-09-20T22:11:15.101Z,1726870275.101 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-20T22:11:15.143Z,1726870275.143 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-20T22:11:15.510Z,1726870275.510 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-20T22:11:15.510Z,1726870275.510 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4 2024-09-20T22:11:15.843Z,1726870275.843 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240920T211600/Courier0027.lzma 2024-09-20T22:11:16.845Z,1726870276.845 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Courier0027.lzma.bak 2024-09-20T22:11:16.846Z,1726870276.846 [DataOverHttps](INFO): SBD MOMSN=23211920 2024-09-20T22:11:43.361Z,1726870303.361 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-20T22:12:04.059Z,1726870324.059 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240920T211600/Express0028.lzma 2024-09-20T22:12:05.061Z,1726870325.061 [DataOverHttps](INFO): Moved sent file to Logs/20240920T211600/Express0028.lzma.bak 2024-09-20T22:12:05.062Z,1726870325.062 [DataOverHttps](INFO): SBD MOMSN=23211922 2024-09-20T22:12:06.419Z,1726870326.419 [Default:CheckIn:Read_Iridium] Stopped 2024-09-20T22:12:06.419Z,1726870326.419 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-20T22:12:06.420Z,1726870326.420 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-20T22:12:39.932Z,1726870359.932 [CommandExec](IMPORTANT): got command quit 2024-09-20T22:12:40.936Z,1726870360.936 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:40.936Z,1726870360.936 [CommandExec](INFO): Uninitializing the command executive. 2024-09-20T22:12:40.936Z,1726870360.936 [CommandExec](INFO): Uninitializing the command scheduler. 2024-09-20T22:12:40.936Z,1726870360.936 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:40.988Z,1726870360.988 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-09-20T22:12:40.988Z,1726870360.988 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-09-20T22:12:40.988Z,1726870360.988 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:40.989Z,1726870360.989 [NavChartDb](INFO): Join timeout helper Thread ID is 9077 2024-09-20T22:12:41.332Z,1726870361.332 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:41.332Z,1726870361.332 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:41.352Z,1726870361.352 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-09-20T22:12:41.352Z,1726870361.352 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:41.352Z,1726870361.352 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9078 2024-09-20T22:12:41.732Z,1726870361.732 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:41.732Z,1726870361.732 [WetLabsBB2FL](INFO): Powering down 2024-09-20T22:12:41.733Z,1726870361.733 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:41.744Z,1726870361.744 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-09-20T22:12:41.744Z,1726870361.744 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:41.744Z,1726870361.744 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9079 2024-09-20T22:12:42.488Z,1726870362.488 [CTD_Seabird](INFO): Powering down 2024-09-20T22:12:42.500Z,1726870362.500 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:42.500Z,1726870362.500 [CTD_Seabird](INFO): Powering down 2024-09-20T22:12:42.512Z,1726870362.512 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:42.516Z,1726870362.516 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-09-20T22:12:42.516Z,1726870362.516 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:42.516Z,1726870362.516 [Radio_Surface](INFO): Join timeout helper Thread ID is 9080 2024-09-20T22:12:42.544Z,1726870362.544 [Radio_Surface](INFO): Powering down 2024-09-20T22:12:42.545Z,1726870362.545 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:42.545Z,1726870362.545 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:42.560Z,1726870362.560 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-09-20T22:12:42.560Z,1726870362.560 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:42.560Z,1726870362.560 [Onboard](INFO): Join timeout helper Thread ID is 9081 2024-09-20T22:12:45.656Z,1726870365.656 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:45.656Z,1726870365.656 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:45.677Z,1726870365.677 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-09-20T22:12:45.677Z,1726870365.677 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:45.677Z,1726870365.677 [DataOverHttps](INFO): Join timeout helper Thread ID is 9082 2024-09-20T22:12:46.088Z,1726870366.088 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:46.091Z,1726870366.091 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.093Z,1726870366.093 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-09-20T22:12:46.093Z,1726870366.093 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.093Z,1726870366.093 [DATMMP](INFO): Join timeout helper Thread ID is 9083 2024-09-20T22:12:46.232Z,1726870366.232 [DATMMP](INFO): Stop 2024-09-20T22:12:46.232Z,1726870366.232 [DATMMP](INFO): uninitialize 2024-09-20T22:12:46.232Z,1726870366.232 [DATMMP](INFO): Powering down 2024-09-20T22:12:46.308Z,1726870366.308 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:46.309Z,1726870366.309 [DATMMP](INFO): uninitialize 2024-09-20T22:12:46.309Z,1726870366.309 [DATMMP](INFO): Powering down 2024-09-20T22:12:46.309Z,1726870366.309 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.324Z,1726870366.324 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-09-20T22:12:46.324Z,1726870366.324 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.325Z,1726870366.325 [BackseatComponent](INFO): Join timeout helper Thread ID is 9084 2024-09-20T22:12:46.500Z,1726870366.500 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:46.500Z,1726870366.500 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.504Z,1726870366.504 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-09-20T22:12:46.505Z,1726870366.505 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.505Z,1726870366.505 [logger](INFO): Join timeout helper Thread ID is 9085 2024-09-20T22:12:46.548Z,1726870366.548 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:46.548Z,1726870366.548 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.564Z,1726870366.564 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-09-20T22:12:46.564Z,1726870366.564 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.565Z,1726870366.565 [CommandLine](INFO): Join timeout helper Thread ID is 9086 2024-09-20T22:12:46.612Z,1726870366.612 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:46.612Z,1726870366.612 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.624Z,1726870366.624 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-09-20T22:12:46.624Z,1726870366.624 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.625Z,1726870366.625 [CommandExec](INFO): Join timeout helper Thread ID is 9087 2024-09-20T22:12:46.626Z,1726870366.626 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-09-20T22:12:46.626Z,1726870366.626 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:46.627Z,1726870366.627 [controlThread](INFO): Join timeout helper Thread ID is 9088 2024-09-20T22:12:46.776Z,1726870366.776 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-20T22:12:46.776Z,1726870366.776 [controlThread](DEBUG): Uninitializing ControlThread 2024-09-20T22:12:46.777Z,1726870366.777 [AHRS_M2](INFO): Powering down 2024-09-20T22:12:46.849Z,1726870366.849 [NAL9602](INFO): Powering down 2024-09-20T22:12:46.850Z,1726870366.850 [Sonardyne_Nano](INFO): Powering down 2024-09-20T22:12:46.969Z,1726870366.969 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-09-20T22:12:46.969Z,1726870366.969 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-09-20T22:12:46.970Z,1726870366.970 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-09-20T22:12:46.971Z,1726870366.971 [MissionManager](INFO): Uninitializing Mission Default 2024-09-20T22:12:46.971Z,1726870366.971 [Default] Stopped 2024-09-20T22:12:46.971Z,1726870366.971 [Default](DEBUG): Aggregate::uninitialize Default 2024-09-20T22:12:46.971Z,1726870366.971 [Default:B.GoToSurface] Stopped 2024-09-20T22:12:46.971Z,1726870366.971 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-20T22:12:46.971Z,1726870366.971 [Default:CheckIn] Stopped 2024-09-20T22:12:46.971Z,1726870366.971 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-20T22:12:46.971Z,1726870366.971 [Default:CheckIn:C.Wait] Stopped 2024-09-20T22:12:46.971Z,1726870366.971 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-20T22:12:46.974Z,1726870366.974 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-09-20T22:12:46.974Z,1726870366.974 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-09-20T22:12:46.975Z,1726870366.975 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-09-20T22:12:46.975Z,1726870366.975 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-09-20T22:12:46.975Z,1726870366.975 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-09-20T22:12:46.976Z,1726870366.976 [BuoyancyServo](INFO): Powering down 2024-09-20T22:12:46.988Z,1726870366.988 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-09-20T22:12:46.988Z,1726870366.988 [ElevatorServo](INFO): Powering down 2024-09-20T22:12:46.989Z,1726870366.989 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-09-20T22:12:46.989Z,1726870366.989 [MassServo](INFO): Powering down 2024-09-20T22:12:46.990Z,1726870366.990 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-20T22:12:46.990Z,1726870366.990 [RudderServo](INFO): Powering down 2024-09-20T22:12:46.991Z,1726870366.991 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-09-20T22:12:46.991Z,1726870366.991 [ThrusterHE](INFO): Powering down 2024-09-20T22:12:46.992Z,1726870366.992 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-09-20T22:12:46.992Z,1726870366.992 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-09-20T22:12:46.992Z,1726870366.992 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-09-20T22:12:46.992Z,1726870366.992 [CBIT](DEBUG): Powering off loads. 2024-09-20T22:12:47.004Z,1726870367.004 [CBIT](DEBUG): Disabling WDT. 2024-09-20T22:12:47.015Z,1726870367.015 [CBIT](DEBUG): Opening all GF detection circuits. 2024-09-20T22:12:47.017Z,1726870367.017 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.054Z,1726870367.054 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.057Z,1726870367.057 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.063Z,1726870367.063 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.069Z,1726870367.069 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.110Z,1726870367.110 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.204Z,1726870367.204 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.210Z,1726870367.210 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.218Z,1726870367.218 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-20T22:12:47.274Z,1726870367.274 [logger ThreadHandler](INFO): Thread cancelled.