2024-09-27T18:24:08.739Z,1727461448.739 [DataOverHttps](INFO): Received command: restart logs 2024-09-27T18:24:08.753Z,1727461448.753 [CommandExec](IMPORTANT): got command restart logs 2024-09-27T18:25:42.126Z,1727461542.126 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:25:42.126Z,1727461542.126 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:25:42.137Z,1727461542.137 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:25:42.547Z,1727461542.547 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:25:42.547Z,1727461542.547 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:26:30.599Z,1727461590.599 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T18:26:50.128Z,1727461610.128 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-09-27T18:27:38.074Z,1727461658.074 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T18:27:38.074Z,1727461658.074 [Default:CheckIn:C.Wait] Stopped 2024-09-27T18:27:38.074Z,1727461658.074 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T18:27:38.074Z,1727461658.074 [Default:CheckIn:D] Running Loop=1 2024-09-27T18:27:38.490Z,1727461658.490 [Default:CheckIn:D] Stopped 2024-09-27T18:27:38.490Z,1727461658.490 [Default:CheckIn:E] Running Loop=1 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.551213 min 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn:E] Stopped 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn] Stopped 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn](INFO): Running loop #3 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn] Running Loop=3 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T18:27:38.882Z,1727461658.882 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T18:27:40.895Z,1727461660.895 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182741.00,A,3648.36595,N,12149.51927,W,4.374,277.56,270924,,,D*7D 2024-09-27T18:27:40.897Z,1727461660.897 [NAL9602](INFO): GPS fix at 20240927T182741: (36.806099, -121.825321) 2024-09-27T18:27:40.914Z,1727461660.914 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T18:27:40.914Z,1727461660.914 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T18:27:48.947Z,1727461668.947 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240927T060551/Courier0073.lzma 2024-09-27T18:27:49.952Z,1727461669.952 [DataOverHttps](INFO): Moved sent file to Logs/20240927T060551/Courier0073.lzma.bak 2024-09-27T18:27:49.952Z,1727461669.952 [DataOverHttps](INFO): SBD MOMSN=23235649 2024-09-27T18:27:53.818Z,1727461673.818 [NAL9602](INFO): SBD MO Status=0, MOMSN=18751, MT Status=0, MTMSN=0 2024-09-27T18:27:53.818Z,1727461673.818 [NAL9602](INFO): No messages in MT queue 2024-09-27T18:28:19.596Z,1727461699.596 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20240927T182408/Courier0000.lzma 2024-09-27T18:28:21.602Z,1727461701.602 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0000.lzma.bak 2024-09-27T18:28:21.602Z,1727461701.602 [DataOverHttps](INFO): SBD MOMSN=23235651 2024-09-27T18:28:24.533Z,1727461704.533 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T18:28:37.459Z,1727461717.459 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20240927T060551/Express0074.lzma 2024-09-27T18:28:38.462Z,1727461718.462 [DataOverHttps](INFO): Moved sent file to Logs/20240927T060551/Express0074.lzma.bak 2024-09-27T18:28:38.462Z,1727461718.462 [DataOverHttps](INFO): SBD MOMSN=23235656 2024-09-27T18:28:43.249Z,1727461723.249 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:28:43.249Z,1727461723.249 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:28:43.328Z,1727461723.328 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:28:43.618Z,1727461723.618 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:28:43.618Z,1727461723.618 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:29:00.980Z,1727461740.980 [DataOverHttps](INFO): Sending 402 bytes from file Logs/20240927T182408/Express0001.lzma 2024-09-27T18:29:01.982Z,1727461741.982 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0001.lzma.bak 2024-09-27T18:29:01.982Z,1727461741.982 [DataOverHttps](INFO): SBD MOMSN=23235659 2024-09-27T18:30:16.960Z,1727461816.960 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-09-27T18:30:48.084Z,1727461848.084 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-09-27T18:31:19.208Z,1727461879.208 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-09-27T18:31:26.607Z,1727461886.607 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20240927T182408/Express0004.lzma 2024-09-27T18:31:27.609Z,1727461887.609 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0004.lzma.bak 2024-09-27T18:31:27.610Z,1727461887.610 [DataOverHttps](INFO): SBD MOMSN=23235689 2024-09-27T18:31:28.854Z,1727461888.854 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T18:31:28.854Z,1727461888.854 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T18:31:28.855Z,1727461888.855 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T18:31:44.201Z,1727461904.201 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T18:31:44.201Z,1727461904.201 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:31:44.213Z,1727461904.213 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:31:44.688Z,1727461904.688 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:31:44.688Z,1727461904.688 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T18:34:45.230Z,1727462085.230 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3 2024-09-27T18:34:45.230Z,1727462085.230 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:34:45.251Z,1727462085.251 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:34:45.619Z,1727462085.619 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:34:45.619Z,1727462085.619 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3 2024-09-27T18:36:29.479Z,1727462189.479 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T18:36:29.479Z,1727462189.479 [Default:CheckIn:C.Wait] Stopped 2024-09-27T18:36:29.479Z,1727462189.479 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T18:36:29.492Z,1727462189.492 [Default:CheckIn:D] Running Loop=1 2024-09-27T18:36:29.879Z,1727462189.879 [Default:CheckIn:D] Stopped 2024-09-27T18:36:29.879Z,1727462189.879 [Default:CheckIn:E] Running Loop=1 2024-09-27T18:36:30.289Z,1727462190.289 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.407694 min 2024-09-27T18:36:30.289Z,1727462190.289 [Default:CheckIn:E] Stopped 2024-09-27T18:36:30.289Z,1727462190.289 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T18:36:30.289Z,1727462190.289 [Default:CheckIn] Stopped 2024-09-27T18:36:30.289Z,1727462190.289 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T18:36:30.290Z,1727462190.290 [Default:CheckIn](INFO): Running loop #4 2024-09-27T18:36:30.290Z,1727462190.290 [Default:CheckIn] Running Loop=4 2024-09-27T18:36:30.290Z,1727462190.290 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T18:36:30.290Z,1727462190.290 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T18:36:30.675Z,1727462190.675 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T18:36:32.295Z,1727462192.295 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183632.00,A,3648.25060,N,12148.26946,W,6.181,108.36,270924,,,D*75 2024-09-27T18:36:32.307Z,1727462192.307 [NAL9602](INFO): GPS fix at 20240927T183632: (36.804177, -121.804491) 2024-09-27T18:36:32.322Z,1727462192.322 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T18:36:32.322Z,1727462192.322 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T18:36:40.064Z,1727462200.064 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240927T182408/Courier0006.lzma 2024-09-27T18:36:41.066Z,1727462201.066 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0006.lzma.bak 2024-09-27T18:36:41.066Z,1727462201.066 [DataOverHttps](INFO): SBD MOMSN=23235733 2024-09-27T18:36:50.547Z,1727462210.547 [NAL9602](INFO): SBD MO Status=0, MOMSN=18752, MT Status=0, MTMSN=0 2024-09-27T18:36:50.547Z,1727462210.547 [NAL9602](INFO): No messages in MT queue 2024-09-27T18:37:01.019Z,1727462221.019 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240927T182408/Express0007.lzma 2024-09-27T18:37:02.022Z,1727462222.022 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0007.lzma.bak 2024-09-27T18:37:02.022Z,1727462222.022 [DataOverHttps](INFO): SBD MOMSN=23235738 2024-09-27T18:37:03.511Z,1727462223.511 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T18:37:03.511Z,1727462223.511 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T18:37:03.511Z,1727462223.511 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T18:37:21.277Z,1727462241.277 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T18:37:46.342Z,1727462266.342 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:37:46.342Z,1727462266.342 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:37:46.353Z,1727462266.353 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:37:46.756Z,1727462266.756 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:37:46.756Z,1727462266.756 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:40:47.381Z,1727462447.381 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T18:40:47.381Z,1727462447.381 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:40:47.408Z,1727462447.408 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:40:47.816Z,1727462447.816 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:40:47.816Z,1727462447.816 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T18:42:04.142Z,1727462524.142 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T18:42:04.142Z,1727462524.142 [Default:CheckIn:C.Wait] Stopped 2024-09-27T18:42:04.142Z,1727462524.142 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T18:42:04.142Z,1727462524.142 [Default:CheckIn:D] Running Loop=1 2024-09-27T18:42:04.554Z,1727462524.554 [Default:CheckIn:D] Stopped 2024-09-27T18:42:04.554Z,1727462524.554 [Default:CheckIn:E] Running Loop=1 2024-09-27T18:42:04.945Z,1727462524.945 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.985610 min 2024-09-27T18:42:04.945Z,1727462524.945 [Default:CheckIn:E] Stopped 2024-09-27T18:42:04.945Z,1727462524.945 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T18:42:04.945Z,1727462524.945 [Default:CheckIn] Stopped 2024-09-27T18:42:04.946Z,1727462524.946 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T18:42:04.946Z,1727462524.946 [Default:CheckIn](INFO): Running loop #5 2024-09-27T18:42:04.946Z,1727462524.946 [Default:CheckIn] Running Loop=5 2024-09-27T18:42:04.946Z,1727462524.946 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T18:42:04.946Z,1727462524.946 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T18:42:06.955Z,1727462526.955 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184207.00,A,3648.50570,N,12147.16335,W,5.054,98.94,270924,,,D*4E 2024-09-27T18:42:06.957Z,1727462526.957 [NAL9602](INFO): GPS fix at 20240927T184207: (36.808428, -121.786056) 2024-09-27T18:42:06.974Z,1727462526.974 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T18:42:06.974Z,1727462526.974 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T18:42:15.059Z,1727462535.059 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0009.lzma 2024-09-27T18:42:16.063Z,1727462536.063 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0009.lzma.bak 2024-09-27T18:42:16.063Z,1727462536.063 [DataOverHttps](INFO): SBD MOMSN=23235790 2024-09-27T18:42:19.114Z,1727462539.114 [NAL9602](INFO): SBD MO Status=0, MOMSN=18753, MT Status=0, MTMSN=0 2024-09-27T18:42:19.114Z,1727462539.114 [NAL9602](INFO): No messages in MT queue 2024-09-27T18:42:31.964Z,1727462551.964 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240927T182408/Express0010.lzma 2024-09-27T18:42:32.966Z,1727462552.966 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0010.lzma.bak 2024-09-27T18:42:32.966Z,1727462552.966 [DataOverHttps](INFO): SBD MOMSN=23235793 2024-09-27T18:42:34.475Z,1727462554.475 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T18:42:34.475Z,1727462554.475 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T18:42:34.475Z,1727462554.475 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T18:42:49.777Z,1727462569.777 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T18:43:48.377Z,1727462628.377 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:43:48.377Z,1727462628.377 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:43:48.421Z,1727462628.421 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:43:48.790Z,1727462628.790 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:43:48.790Z,1727462628.790 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:46:30.823Z,1727462790.823 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T18:46:49.418Z,1727462809.418 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T18:46:49.418Z,1727462809.418 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:46:49.437Z,1727462809.437 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:46:49.859Z,1727462809.859 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:46:49.859Z,1727462809.859 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T18:47:35.082Z,1727462855.082 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T18:47:35.082Z,1727462855.082 [Default:CheckIn:C.Wait] Stopped 2024-09-27T18:47:35.083Z,1727462855.083 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T18:47:35.083Z,1727462855.083 [Default:CheckIn:D] Running Loop=1 2024-09-27T18:47:35.499Z,1727462855.499 [Default:CheckIn:D] Stopped 2024-09-27T18:47:35.499Z,1727462855.499 [Default:CheckIn:E] Running Loop=1 2024-09-27T18:47:35.891Z,1727462855.891 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.501363 min 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn:E] Stopped 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn] Stopped 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn](INFO): Running loop #6 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn] Running Loop=6 2024-09-27T18:47:35.892Z,1727462855.892 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T18:47:35.893Z,1727462855.893 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T18:47:37.899Z,1727462857.899 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184738.00,A,3648.16061,N,12147.21551,W,0.058,234.43,270924,,,D*77 2024-09-27T18:47:37.901Z,1727462857.901 [NAL9602](INFO): GPS fix at 20240927T184738: (36.802677, -121.786925) 2024-09-27T18:47:37.917Z,1727462857.917 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T18:47:37.917Z,1727462857.917 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T18:47:45.239Z,1727462865.239 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0012.lzma 2024-09-27T18:47:46.242Z,1727462866.242 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0012.lzma.bak 2024-09-27T18:47:46.242Z,1727462866.242 [DataOverHttps](INFO): SBD MOMSN=23235817 2024-09-27T18:47:53.654Z,1727462873.654 [NAL9602](INFO): SBD MO Status=0, MOMSN=18754, MT Status=0, MTMSN=0 2024-09-27T18:47:53.655Z,1727462873.655 [NAL9602](INFO): No messages in MT queue 2024-09-27T18:48:04.236Z,1727462884.236 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20240927T182408/Express0013.lzma 2024-09-27T18:48:05.238Z,1727462885.238 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0013.lzma.bak 2024-09-27T18:48:05.238Z,1727462885.238 [DataOverHttps](INFO): SBD MOMSN=23235821 2024-09-27T18:48:06.619Z,1727462886.619 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T18:48:06.619Z,1727462886.619 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T18:48:06.619Z,1727462886.619 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T18:48:24.383Z,1727462904.383 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T18:49:50.493Z,1727462990.493 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:49:50.493Z,1727462990.493 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:49:50.504Z,1727462990.504 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:49:50.911Z,1727462990.911 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:49:50.911Z,1727462990.911 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:52:51.569Z,1727463171.569 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T18:52:51.569Z,1727463171.569 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:52:51.637Z,1727463171.637 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:52:51.981Z,1727463171.981 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:52:51.981Z,1727463171.981 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T18:53:07.309Z,1727463187.309 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T18:53:07.309Z,1727463187.309 [Default:CheckIn:C.Wait] Stopped 2024-09-27T18:53:07.309Z,1727463187.309 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T18:53:07.310Z,1727463187.310 [Default:CheckIn:D] Running Loop=1 2024-09-27T18:53:07.722Z,1727463187.722 [Default:CheckIn:D] Stopped 2024-09-27T18:53:07.722Z,1727463187.722 [Default:CheckIn:E] Running Loop=1 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 38.038416 min 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn:E] Stopped 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn] Stopped 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn](INFO): Running loop #7 2024-09-27T18:53:08.134Z,1727463188.134 [Default:CheckIn] Running Loop=7 2024-09-27T18:53:08.135Z,1727463188.135 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T18:53:08.135Z,1727463188.135 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T18:53:10.131Z,1727463190.131 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185310.00,A,3648.14035,N,12147.24390,W,2.060,277.90,270924,,,D*75 2024-09-27T18:53:10.133Z,1727463190.133 [NAL9602](INFO): GPS fix at 20240927T185310: (36.802339, -121.787398) 2024-09-27T18:53:10.171Z,1727463190.171 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T18:53:10.171Z,1727463190.171 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T18:53:17.395Z,1727463197.395 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0015.lzma 2024-09-27T18:53:18.398Z,1727463198.398 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0015.lzma.bak 2024-09-27T18:53:18.398Z,1727463198.398 [DataOverHttps](INFO): SBD MOMSN=23235856 2024-09-27T18:53:31.975Z,1727463211.975 [NAL9602](INFO): SBD MO Status=0, MOMSN=18755, MT Status=0, MTMSN=0 2024-09-27T18:53:31.975Z,1727463211.975 [NAL9602](INFO): No messages in MT queue 2024-09-27T18:53:34.907Z,1727463214.907 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240927T182408/Express0016.lzma 2024-09-27T18:53:35.910Z,1727463215.910 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0016.lzma.bak 2024-09-27T18:53:35.910Z,1727463215.910 [DataOverHttps](INFO): SBD MOMSN=23235859 2024-09-27T18:53:37.238Z,1727463217.238 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T18:53:37.238Z,1727463217.238 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T18:53:37.238Z,1727463217.238 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T18:54:02.664Z,1727463242.664 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T18:55:52.623Z,1727463352.623 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:55:52.623Z,1727463352.623 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:55:52.634Z,1727463352.634 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:55:53.055Z,1727463353.055 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:55:53.055Z,1727463353.055 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:56:30.983Z,1727463390.983 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T18:58:37.854Z,1727463517.854 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T18:58:37.854Z,1727463517.854 [Default:CheckIn:C.Wait] Stopped 2024-09-27T18:58:37.854Z,1727463517.854 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T18:58:37.855Z,1727463517.855 [Default:CheckIn:D] Running Loop=1 2024-09-27T18:58:38.259Z,1727463518.259 [Default:CheckIn:D] Stopped 2024-09-27T18:58:38.259Z,1727463518.259 [Default:CheckIn:E] Running Loop=1 2024-09-27T18:58:38.673Z,1727463518.673 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 43.547355 min 2024-09-27T18:58:38.673Z,1727463518.673 [Default:CheckIn:E] Stopped 2024-09-27T18:58:38.673Z,1727463518.673 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T18:58:38.674Z,1727463518.674 [Default:CheckIn] Stopped 2024-09-27T18:58:38.674Z,1727463518.674 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T18:58:38.674Z,1727463518.674 [Default:CheckIn](INFO): Running loop #8 2024-09-27T18:58:38.674Z,1727463518.674 [Default:CheckIn] Running Loop=8 2024-09-27T18:58:38.674Z,1727463518.674 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T18:58:38.674Z,1727463518.674 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T18:58:40.671Z,1727463520.671 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185841.00,A,3648.17402,N,12147.28027,W,0.156,279.27,270924,,,D*7E 2024-09-27T18:58:40.673Z,1727463520.673 [NAL9602](INFO): GPS fix at 20240927T185841: (36.802900, -121.788004) 2024-09-27T18:58:40.709Z,1727463520.709 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T18:58:40.709Z,1727463520.709 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T18:58:49.346Z,1727463529.346 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0018.lzma 2024-09-27T18:58:50.346Z,1727463530.346 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0018.lzma.bak 2024-09-27T18:58:50.346Z,1727463530.346 [DataOverHttps](INFO): SBD MOMSN=23235888 2024-09-27T18:58:53.670Z,1727463533.670 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T18:58:53.670Z,1727463533.670 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T18:58:53.764Z,1727463533.764 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T18:58:54.191Z,1727463534.191 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T18:58:54.191Z,1727463534.191 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T18:59:10.171Z,1727463550.171 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20240927T182408/Express0019.lzma 2024-09-27T18:59:11.174Z,1727463551.174 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0019.lzma.bak 2024-09-27T18:59:11.174Z,1727463551.174 [DataOverHttps](INFO): SBD MOMSN=23235891 2024-09-27T18:59:12.659Z,1727463552.659 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T18:59:12.659Z,1727463552.659 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T18:59:12.660Z,1727463552.660 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:01:54.732Z,1727463714.732 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:01:54.732Z,1727463714.732 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:01:54.744Z,1727463714.744 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:01:55.165Z,1727463715.165 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:01:55.165Z,1727463715.165 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:02:44.807Z,1727463764.807 [NAL9602](INFO): SBD MO Status=0, MOMSN=18756, MT Status=0, MTMSN=0 2024-09-27T19:02:44.807Z,1727463764.807 [NAL9602](INFO): No messages in MT queue 2024-09-27T19:03:15.569Z,1727463795.569 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T19:04:13.368Z,1727463853.368 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:04:13.368Z,1727463853.368 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:04:13.368Z,1727463853.368 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:04:13.368Z,1727463853.368 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:04:13.757Z,1727463853.757 [Default:CheckIn:D] Stopped 2024-09-27T19:04:13.757Z,1727463853.757 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:04:14.166Z,1727463854.166 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 49.138993 min 2024-09-27T19:04:14.166Z,1727463854.166 [Default:CheckIn:E] Stopped 2024-09-27T19:04:14.166Z,1727463854.166 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:04:14.167Z,1727463854.167 [Default:CheckIn] Stopped 2024-09-27T19:04:14.167Z,1727463854.167 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:04:14.167Z,1727463854.167 [Default:CheckIn](INFO): Running loop #9 2024-09-27T19:04:14.167Z,1727463854.167 [Default:CheckIn] Running Loop=9 2024-09-27T19:04:14.167Z,1727463854.167 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:04:14.167Z,1727463854.167 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:04:16.171Z,1727463856.171 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190416.00,A,3648.17468,N,12147.27996,W,0.019,169.47,270924,,,A*7F 2024-09-27T19:04:16.173Z,1727463856.173 [NAL9602](INFO): GPS fix at 20240927T190416: (36.802911, -121.787999) 2024-09-27T19:04:16.189Z,1727463856.189 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:04:16.189Z,1727463856.189 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:04:23.911Z,1727463863.911 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240927T182408/Courier0021.lzma 2024-09-27T19:04:24.914Z,1727463864.914 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0021.lzma.bak 2024-09-27T19:04:24.914Z,1727463864.914 [DataOverHttps](INFO): SBD MOMSN=23235895 2024-09-27T19:04:41.696Z,1727463881.696 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20240927T182408/Express0022.lzma 2024-09-27T19:04:42.698Z,1727463882.698 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0022.lzma.bak 2024-09-27T19:04:42.698Z,1727463882.698 [DataOverHttps](INFO): SBD MOMSN=23235898 2024-09-27T19:04:44.063Z,1727463884.063 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:04:44.063Z,1727463884.063 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:04:44.063Z,1727463884.063 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:04:55.846Z,1727463895.846 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:04:55.846Z,1727463895.846 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:04:55.886Z,1727463895.886 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:04:56.271Z,1727463896.271 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:04:56.271Z,1727463896.271 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:04:56.638Z,1727463896.638 [NAL9602](INFO): SBD MO Status=2, MOMSN=18757, MT Status=2, MTMSN=0 2024-09-27T19:04:56.639Z,1727463896.639 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-27T19:05:33.394Z,1727463933.394 [NAL9602](INFO): SBD MO Status=2, MOMSN=18757, MT Status=2, MTMSN=0 2024-09-27T19:05:33.395Z,1727463933.395 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-27T19:05:51.570Z,1727463951.570 [NAL9602](INFO): SBD MO Status=0, MOMSN=18757, MT Status=0, MTMSN=0 2024-09-27T19:05:51.571Z,1727463951.571 [NAL9602](INFO): No messages in MT queue 2024-09-27T19:06:22.269Z,1727463982.269 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T19:06:31.157Z,1727463991.157 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T19:06:40.455Z,1727464000.455 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-09-27T19:06:40.455Z,1727464000.455 [DropWeight] Hardware Fault, FailCount= 1 2024-09-27T19:06:40.455Z,1727464000.455 [DropWeight](ERROR): Hardware Fault 2024-09-27T19:06:40.497Z,1727464000.497 [CommandExec](FAULT): Scheduling is paused 2024-09-27T19:06:40.497Z,1727464000.497 [CBIT](INFO): Critical error at 20240927T190640 2024-09-27T19:06:40.499Z,1727464000.499 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-09-27T19:06:40.504Z,1727464000.504 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-09-27T19:06:40.906Z,1727464000.906 [CBIT](INFO): Critical error at 20240927T190640 2024-09-27T19:07:56.848Z,1727464076.848 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:07:56.848Z,1727464076.848 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:07:56.859Z,1727464076.859 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:07:57.267Z,1727464077.267 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:07:57.267Z,1727464077.267 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:09:44.803Z,1727464184.803 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:09:44.803Z,1727464184.803 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:09:44.803Z,1727464184.803 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:09:44.803Z,1727464184.803 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:09:45.186Z,1727464185.186 [Default:CheckIn:D] Stopped 2024-09-27T19:09:45.186Z,1727464185.186 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:09:45.591Z,1727464185.591 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 54.662809 min 2024-09-27T19:09:45.591Z,1727464185.591 [Default:CheckIn:E] Stopped 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn] Stopped 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn](INFO): Running loop #10 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn] Running Loop=10 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:09:45.592Z,1727464185.592 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:09:47.602Z,1727464187.602 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190948.00,A,3648.17480,N,12147.27848,W,0.136,73.25,270924,,,A*4F 2024-09-27T19:09:47.605Z,1727464187.605 [NAL9602](INFO): GPS fix at 20240927T190948: (36.802913, -121.787975) 2024-09-27T19:09:47.648Z,1727464187.648 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:09:47.648Z,1727464187.648 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:09:55.387Z,1727464195.387 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20240927T182408/Courier0024.lzma 2024-09-27T19:09:56.390Z,1727464196.390 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0024.lzma.bak 2024-09-27T19:09:56.390Z,1727464196.390 [DataOverHttps](INFO): SBD MOMSN=23235943 2024-09-27T19:10:12.260Z,1727464212.260 [DataOverHttps](INFO): Sending 158 bytes from file Logs/20240927T182408/Express0025.lzma 2024-09-27T19:10:13.262Z,1727464213.262 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0025.lzma.bak 2024-09-27T19:10:13.262Z,1727464213.262 [DataOverHttps](INFO): SBD MOMSN=23235948 2024-09-27T19:10:14.691Z,1727464214.691 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:10:14.691Z,1727464214.691 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:10:14.691Z,1727464214.691 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:10:57.977Z,1727464257.977 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:10:57.977Z,1727464257.977 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:10:58.016Z,1727464258.016 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:10:58.433Z,1727464258.433 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:10:58.433Z,1727464258.433 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:13:45.646Z,1727464425.646 [NAL9602](INFO): SBD MO Status=2, MOMSN=18758, MT Status=2, MTMSN=0 2024-09-27T19:13:45.646Z,1727464425.646 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-27T19:13:59.015Z,1727464439.015 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:13:59.015Z,1727464439.015 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:13:59.027Z,1727464439.027 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:13:59.402Z,1727464439.402 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:13:59.402Z,1727464439.402 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:14:51.174Z,1727464491.174 [NAL9602](INFO): SBD MO Status=2, MOMSN=18758, MT Status=2, MTMSN=0 2024-09-27T19:14:51.174Z,1727464491.174 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-09-27T19:14:51.517Z,1727464491.517 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-27T19:15:15.402Z,1727464515.402 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:15:15.402Z,1727464515.402 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:15:15.402Z,1727464515.402 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:15:15.402Z,1727464515.402 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:15:15.806Z,1727464515.806 [Default:CheckIn:D] Stopped 2024-09-27T19:15:15.806Z,1727464515.806 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:15:16.214Z,1727464516.214 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 60.173145 min 2024-09-27T19:15:16.214Z,1727464516.214 [Default:CheckIn:E] Stopped 2024-09-27T19:15:16.214Z,1727464516.214 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:15:16.214Z,1727464516.214 [Default:CheckIn] Stopped 2024-09-27T19:15:16.214Z,1727464516.214 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:15:16.215Z,1727464516.215 [Default:CheckIn](INFO): Running loop #11 2024-09-27T19:15:16.215Z,1727464516.215 [Default:CheckIn] Running Loop=11 2024-09-27T19:15:16.215Z,1727464516.215 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:15:16.215Z,1727464516.215 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:15:18.218Z,1727464518.218 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191518.00,A,3648.17383,N,12147.28344,W,0.214,260.23,270924,,,A*7E 2024-09-27T19:15:18.231Z,1727464518.231 [NAL9602](INFO): GPS fix at 20240927T191518: (36.802897, -121.788057) 2024-09-27T19:15:18.248Z,1727464518.248 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:15:18.248Z,1727464518.248 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:15:19.841Z,1727464519.841 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:15:25.931Z,1727464525.931 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0027.lzma 2024-09-27T19:15:26.934Z,1727464526.934 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0027.lzma.bak 2024-09-27T19:15:26.934Z,1727464526.934 [DataOverHttps](INFO): SBD MOMSN=23235965 2024-09-27T19:15:35.179Z,1727464535.179 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:15:42.855Z,1727464542.855 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20240927T182408/Express0028.lzma 2024-09-27T19:15:43.858Z,1727464543.858 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0028.lzma.bak 2024-09-27T19:15:43.858Z,1727464543.858 [DataOverHttps](INFO): SBD MOMSN=23235968 2024-09-27T19:15:45.315Z,1727464545.315 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:15:45.315Z,1727464545.315 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:15:45.315Z,1727464545.315 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:15:50.126Z,1727464550.126 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:15:50.167Z,1727464550.167 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T19:16:05.075Z,1727464565.075 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:16:20.030Z,1727464580.030 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:16:31.339Z,1727464591.339 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T19:16:35.375Z,1727464595.375 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:16:51.220Z,1727464611.220 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:17:00.082Z,1727464620.082 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:17:00.082Z,1727464620.082 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:17:00.124Z,1727464620.124 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:17:00.529Z,1727464620.529 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:17:00.529Z,1727464620.529 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:17:06.135Z,1727464626.135 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:17:21.491Z,1727464641.491 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:17:36.430Z,1727464656.430 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2024-09-27T19:20:01.146Z,1727464801.146 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:20:01.146Z,1727464801.146 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:20:01.157Z,1727464801.157 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:20:01.576Z,1727464801.576 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:20:01.577Z,1727464801.577 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:20:02.738Z,1727464802.738 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:20:16.474Z,1727464816.474 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:20:30.614Z,1727464830.614 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:20:44.350Z,1727464844.350 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:20:45.990Z,1727464845.990 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:20:45.990Z,1727464845.990 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:20:45.990Z,1727464845.990 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:20:45.991Z,1727464845.991 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:20:46.387Z,1727464846.387 [Default:CheckIn:D] Stopped 2024-09-27T19:20:46.387Z,1727464846.387 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:20:46.802Z,1727464846.802 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 65.682829 min 2024-09-27T19:20:46.802Z,1727464846.802 [Default:CheckIn:E] Stopped 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn] Stopped 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn](INFO): Running loop #12 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn] Running Loop=12 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:20:46.803Z,1727464846.803 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:20:48.798Z,1727464848.798 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192049.00,A,3648.17362,N,12147.27941,W,0.680,239.59,270924,,,A*7B 2024-09-27T19:20:48.801Z,1727464848.801 [NAL9602](INFO): GPS fix at 20240927T192049: (36.802894, -121.787990) 2024-09-27T19:20:48.857Z,1727464848.857 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:20:48.857Z,1727464848.857 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:20:56.523Z,1727464856.523 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0030.lzma 2024-09-27T19:20:57.526Z,1727464857.526 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0030.lzma.bak 2024-09-27T19:20:57.526Z,1727464857.526 [DataOverHttps](INFO): SBD MOMSN=23236045 2024-09-27T19:20:58.230Z,1727464858.230 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:21:12.371Z,1727464872.371 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:21:13.571Z,1727464873.571 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20240927T182408/Express0031.lzma 2024-09-27T19:21:14.574Z,1727464874.574 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0031.lzma.bak 2024-09-27T19:21:14.574Z,1727464874.574 [DataOverHttps](INFO): SBD MOMSN=23236048 2024-09-27T19:21:16.041Z,1727464876.041 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:21:16.041Z,1727464876.041 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:21:16.041Z,1727464876.041 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:21:26.114Z,1727464886.114 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:21:39.448Z,1727464899.448 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:21:40.721Z,1727464900.721 [CBIT](INFO): Clearing failed state for component DropWeight 2024-09-27T19:21:40.721Z,1727464900.721 [DropWeight] No Fault, FailCount= 1 2024-09-27T19:21:53.182Z,1727464913.182 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:21:53.517Z,1727464913.517 [DataOverHttps](IMPORTANT): SBD MTMSN=20240927T192153 2024-09-27T19:22:01.003Z,1727464921.003 [DataOverHttps](INFO): Received command: strobe off 2024-09-27T19:22:01.013Z,1727464921.013 [CommandExec](IMPORTANT): got command strobe off 2024-09-27T19:22:01.013Z,1727464921.013 [CommandExec](IMPORTANT): Deactivating strobe 2024-09-27T19:22:06.918Z,1727464926.918 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:22:20.255Z,1727464940.255 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-09-27T19:22:27.539Z,1727464947.539 [BPC1](ERROR): Battery stick #59 (s/n: 0184) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2024-09-27T19:22:27.556Z,1727464947.556 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5. 2024-09-27T19:22:27.565Z,1727464947.565 [BPC1](INFO): Received data from all battery sticks. 2024-09-27T19:23:02.288Z,1727464982.288 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:23:02.288Z,1727464982.288 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:23:02.300Z,1727464982.300 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:23:02.712Z,1727464982.712 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:23:02.712Z,1727464982.712 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:25:51.150Z,1727465151.150 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-27T19:26:03.345Z,1727465163.345 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:26:03.345Z,1727465163.345 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:26:03.381Z,1727465163.381 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:26:03.702Z,1727465163.702 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:26:03.702Z,1727465163.702 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:26:16.618Z,1727465176.618 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:26:16.618Z,1727465176.618 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:26:16.619Z,1727465176.619 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:26:16.619Z,1727465176.619 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:26:17.027Z,1727465177.027 [Default:CheckIn:D] Stopped 2024-09-27T19:26:17.027Z,1727465177.027 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:26:17.421Z,1727465177.421 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.193490 min 2024-09-27T19:26:17.421Z,1727465177.421 [Default:CheckIn:E] Stopped 2024-09-27T19:26:17.421Z,1727465177.421 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:26:17.422Z,1727465177.422 [Default:CheckIn] Stopped 2024-09-27T19:26:17.422Z,1727465177.422 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:26:17.422Z,1727465177.422 [Default:CheckIn](INFO): Running loop #13 2024-09-27T19:26:17.422Z,1727465177.422 [Default:CheckIn] Running Loop=13 2024-09-27T19:26:17.422Z,1727465177.422 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:26:17.422Z,1727465177.422 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:26:19.430Z,1727465179.430 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192620.00,A,3648.16471,N,12147.26567,W,0.408,239.59,270924,,,A*7D 2024-09-27T19:26:19.433Z,1727465179.433 [NAL9602](INFO): GPS fix at 20240927T192620: (36.802745, -121.787761) 2024-09-27T19:26:19.448Z,1727465179.448 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:26:19.448Z,1727465179.448 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:26:27.091Z,1727465187.091 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20240927T182408/Courier0033.lzma 2024-09-27T19:26:28.094Z,1727465188.094 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0033.lzma.bak 2024-09-27T19:26:28.094Z,1727465188.094 [DataOverHttps](INFO): SBD MOMSN=23236053 2024-09-27T19:26:31.555Z,1727465191.555 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T19:26:46.872Z,1727465206.872 [DataOverHttps](INFO): Sending 319 bytes from file Logs/20240927T182408/Express0034.lzma 2024-09-27T19:26:47.874Z,1727465207.874 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0034.lzma.bak 2024-09-27T19:26:47.875Z,1727465207.875 [DataOverHttps](INFO): SBD MOMSN=23236056 2024-09-27T19:26:52.210Z,1727465212.210 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T19:27:03.747Z,1727465223.747 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20240927T182408/Express0037.lzma 2024-09-27T19:27:04.750Z,1727465224.750 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0037.lzma.bak 2024-09-27T19:27:04.750Z,1727465224.750 [DataOverHttps](INFO): SBD MOMSN=23236063 2024-09-27T19:27:05.955Z,1727465225.955 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:27:05.955Z,1727465225.955 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:27:05.955Z,1727465225.955 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:29:04.352Z,1727465344.352 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:29:04.352Z,1727465344.352 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:29:04.363Z,1727465344.363 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:29:04.774Z,1727465344.774 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:29:04.774Z,1727465344.774 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:32:05.371Z,1727465525.371 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:32:05.371Z,1727465525.371 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:32:05.383Z,1727465525.383 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:32:05.792Z,1727465525.792 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:32:05.792Z,1727465525.792 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:32:06.581Z,1727465526.581 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:32:06.581Z,1727465526.581 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:32:06.581Z,1727465526.581 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:32:06.581Z,1727465526.581 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:32:06.987Z,1727465526.987 [Default:CheckIn:D] Stopped 2024-09-27T19:32:06.987Z,1727465526.987 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.026156 min 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn:E] Stopped 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn] Stopped 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn](INFO): Running loop #14 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn] Running Loop=14 2024-09-27T19:32:07.403Z,1727465527.403 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:32:07.404Z,1727465527.404 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:32:09.403Z,1727465529.403 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193210.00,A,3648.17165,N,12147.28186,W,0.253,335.96,270924,,,A*79 2024-09-27T19:32:09.405Z,1727465529.405 [NAL9602](INFO): GPS fix at 20240927T193210: (36.802861, -121.788031) 2024-09-27T19:32:09.440Z,1727465529.440 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:32:09.441Z,1727465529.441 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:32:17.039Z,1727465537.039 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0039.lzma 2024-09-27T19:32:18.042Z,1727465538.042 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0039.lzma.bak 2024-09-27T19:32:18.042Z,1727465538.042 [DataOverHttps](INFO): SBD MOMSN=23236100 2024-09-27T19:32:33.967Z,1727465553.967 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20240927T182408/Express0040.lzma 2024-09-27T19:32:34.970Z,1727465554.970 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0040.lzma.bak 2024-09-27T19:32:34.970Z,1727465554.970 [DataOverHttps](INFO): SBD MOMSN=23236103 2024-09-27T19:32:36.515Z,1727465556.515 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:32:36.515Z,1727465556.515 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:32:36.515Z,1727465556.515 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:32:40.138Z,1727465560.138 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-09-27T19:32:40.220Z,1727465560.220 [NAL9602](ERROR): received: +CSQ:0 OK758, 2, 0, 0, 0 OK 2024-09-27T19:35:06.447Z,1727465706.447 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:35:06.447Z,1727465706.447 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:35:06.461Z,1727465706.461 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:35:06.871Z,1727465706.871 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:35:06.871Z,1727465706.871 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:36:31.659Z,1727465791.659 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2024-09-27T19:37:12.053Z,1727465832.053 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-27T19:37:37.126Z,1727465857.126 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:37:37.126Z,1727465857.126 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:37:37.126Z,1727465857.126 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:37:37.127Z,1727465857.127 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:37:37.527Z,1727465857.527 [Default:CheckIn:D] Stopped 2024-09-27T19:37:37.527Z,1727465857.527 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 82.535156 min 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn:E] Stopped 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn] Stopped 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn](INFO): Running loop #15 2024-09-27T19:37:37.942Z,1727465857.942 [Default:CheckIn] Running Loop=15 2024-09-27T19:37:37.943Z,1727465857.943 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:37:37.943Z,1727465857.943 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:37:39.943Z,1727465859.943 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193740.00,A,3648.19522,N,12147.28641,W,0.836,321.17,270924,,,A*79 2024-09-27T19:37:39.945Z,1727465859.945 [NAL9602](INFO): GPS fix at 20240927T193740: (36.803254, -121.788107) 2024-09-27T19:37:39.981Z,1727465859.981 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:37:39.981Z,1727465859.981 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:37:47.603Z,1727465867.603 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240927T182408/Courier0042.lzma 2024-09-27T19:37:48.606Z,1727465868.606 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0042.lzma.bak 2024-09-27T19:37:48.606Z,1727465868.606 [DataOverHttps](INFO): SBD MOMSN=23236106 2024-09-27T19:38:04.496Z,1727465884.496 [DataOverHttps](INFO): Sending 218 bytes from file Logs/20240927T182408/Express0043.lzma 2024-09-27T19:38:05.498Z,1727465885.498 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0043.lzma.bak 2024-09-27T19:38:05.498Z,1727465885.498 [DataOverHttps](INFO): SBD MOMSN=23236109 2024-09-27T19:38:06.656Z,1727465886.656 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:38:06.656Z,1727465886.656 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:38:06.656Z,1727465886.656 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:38:07.449Z,1727465887.449 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:38:07.449Z,1727465887.449 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:38:07.460Z,1727465887.460 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:38:07.870Z,1727465887.870 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:38:07.870Z,1727465887.870 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:38:12.281Z,1727465892.281 [NAL9602](INFO): Not Powering down - fast GPS 2024-09-27T19:41:08.523Z,1727466068.523 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2 2024-09-27T19:41:08.523Z,1727466068.523 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:41:08.584Z,1727466068.584 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:41:08.969Z,1727466068.969 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:41:08.969Z,1727466068.969 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2 2024-09-27T19:43:07.069Z,1727466187.069 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-27T19:43:07.069Z,1727466187.069 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:43:07.069Z,1727466187.069 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:43:07.069Z,1727466187.069 [Default:CheckIn:D] Running Loop=1 2024-09-27T19:43:07.476Z,1727466187.476 [Default:CheckIn:D] Stopped 2024-09-27T19:43:07.476Z,1727466187.476 [Default:CheckIn:E] Running Loop=1 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 88.034310 min 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn:E] Stopped 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn] Stopped 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn](INFO): Running loop #16 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn] Running Loop=16 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-27T19:43:07.863Z,1727466187.863 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-27T19:43:09.865Z,1727466189.865 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194309.00,A,3648.17563,N,12147.27602,W,0.117,321.17,270924,,,A*7E 2024-09-27T19:43:09.867Z,1727466189.867 [NAL9602](INFO): GPS fix at 20240927T194309: (36.802927, -121.787934) 2024-09-27T19:43:09.925Z,1727466189.925 [Default:CheckIn:Read_GPS] Stopped 2024-09-27T19:43:09.925Z,1727466189.925 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-27T19:43:20.382Z,1727466200.382 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240927T182408/Courier0045.lzma 2024-09-27T19:43:21.384Z,1727466201.384 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Courier0045.lzma.bak 2024-09-27T19:43:21.384Z,1727466201.384 [DataOverHttps](INFO): SBD MOMSN=23236159 2024-09-27T19:43:40.496Z,1727466220.496 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-09-27T19:43:40.572Z,1727466220.572 [NAL9602](ERROR): received: +CSQ:0 OK758, 2, 0, 0, 0 OK 2024-09-27T19:43:46.330Z,1727466226.330 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20240927T182408/Express0046.lzma 2024-09-27T19:43:47.333Z,1727466227.333 [DataOverHttps](INFO): Moved sent file to Logs/20240927T182408/Express0046.lzma.bak 2024-09-27T19:43:47.333Z,1727466227.333 [DataOverHttps](INFO): SBD MOMSN=23236162 2024-09-27T19:43:48.626Z,1727466228.626 [Default:CheckIn:Read_Iridium] Stopped 2024-09-27T19:43:48.630Z,1727466228.630 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-27T19:43:48.631Z,1727466228.631 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-27T19:44:09.631Z,1727466249.631 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2024-09-27T19:44:09.631Z,1727466249.631 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2024-09-27T19:44:09.700Z,1727466249.700 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2024-09-27T19:44:10.063Z,1727466250.063 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2024-09-27T19:44:10.063Z,1727466250.063 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2024-09-27T19:44:45.187Z,1727466285.187 [CommandExec](IMPORTANT): got command quit 2024-09-27T19:44:46.191Z,1727466286.191 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:46.191Z,1727466286.191 [CommandExec](INFO): Uninitializing the command executive. 2024-09-27T19:44:46.191Z,1727466286.191 [CommandExec](INFO): Uninitializing the command scheduler. 2024-09-27T19:44:46.191Z,1727466286.191 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:46.290Z,1727466286.290 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-09-27T19:44:46.290Z,1727466286.290 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-09-27T19:44:46.291Z,1727466286.291 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:46.291Z,1727466286.291 [NavChartDb](INFO): Join timeout helper Thread ID is 6418 2024-09-27T19:44:46.535Z,1727466286.535 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:46.535Z,1727466286.535 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:46.550Z,1727466286.550 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-09-27T19:44:46.550Z,1727466286.550 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:46.551Z,1727466286.551 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6419 2024-09-27T19:44:46.795Z,1727466286.795 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:46.795Z,1727466286.795 [WetLabsBB2FL](INFO): Powering down 2024-09-27T19:44:46.796Z,1727466286.796 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:46.807Z,1727466286.807 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-09-27T19:44:46.807Z,1727466286.807 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:46.808Z,1727466286.808 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6420 2024-09-27T19:44:47.118Z,1727466287.118 [CTD_Seabird](INFO): Powering down 2024-09-27T19:44:47.138Z,1727466287.138 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:47.145Z,1727466287.145 [CTD_Seabird](INFO): Powering down 2024-09-27T19:44:47.158Z,1727466287.158 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:47.178Z,1727466287.178 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-09-27T19:44:47.178Z,1727466287.178 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:47.179Z,1727466287.179 [Radio_Surface](INFO): Join timeout helper Thread ID is 6421 2024-09-27T19:44:47.363Z,1727466287.363 [Radio_Surface](INFO): Powering down 2024-09-27T19:44:47.363Z,1727466287.363 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:47.364Z,1727466287.364 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:47.374Z,1727466287.374 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-09-27T19:44:47.375Z,1727466287.375 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:47.375Z,1727466287.375 [Onboard](INFO): Join timeout helper Thread ID is 6422 2024-09-27T19:44:47.751Z,1727466287.751 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-09-27T19:44:50.618Z,1727466290.618 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:50.619Z,1727466290.619 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:50.631Z,1727466290.631 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-09-27T19:44:50.631Z,1727466290.631 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:50.631Z,1727466290.631 [DataOverHttps](INFO): Join timeout helper Thread ID is 6423 2024-09-27T19:44:50.762Z,1727466290.762 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:50.763Z,1727466290.763 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:50.772Z,1727466290.772 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler 2024-09-27T19:44:50.772Z,1727466290.772 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:50.772Z,1727466290.772 [DATMMP](INFO): Join timeout helper Thread ID is 6424 2024-09-27T19:44:51.002Z,1727466291.002 [DATMMP](INFO): Stop 2024-09-27T19:44:51.002Z,1727466291.002 [DATMMP](INFO): uninitialize 2024-09-27T19:44:51.003Z,1727466291.003 [DATMMP](INFO): Powering down 2024-09-27T19:44:51.079Z,1727466291.079 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:51.079Z,1727466291.079 [DATMMP](INFO): uninitialize 2024-09-27T19:44:51.079Z,1727466291.079 [DATMMP](INFO): Powering down 2024-09-27T19:44:51.080Z,1727466291.080 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.097Z,1727466291.097 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-09-27T19:44:51.097Z,1727466291.097 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.097Z,1727466291.097 [BackseatComponent](INFO): Join timeout helper Thread ID is 6425 2024-09-27T19:44:51.266Z,1727466291.266 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:51.267Z,1727466291.267 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.279Z,1727466291.279 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-09-27T19:44:51.279Z,1727466291.279 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.280Z,1727466291.280 [logger](INFO): Join timeout helper Thread ID is 6426 2024-09-27T19:44:51.310Z,1727466291.310 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:51.310Z,1727466291.310 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.331Z,1727466291.331 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-09-27T19:44:51.331Z,1727466291.331 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.331Z,1727466291.331 [CommandLine](INFO): Join timeout helper Thread ID is 6427 2024-09-27T19:44:51.354Z,1727466291.354 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:51.355Z,1727466291.355 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.371Z,1727466291.371 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-09-27T19:44:51.371Z,1727466291.371 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.371Z,1727466291.371 [CommandExec](INFO): Join timeout helper Thread ID is 6428 2024-09-27T19:44:51.373Z,1727466291.373 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-09-27T19:44:51.373Z,1727466291.373 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.373Z,1727466291.373 [controlThread](INFO): Join timeout helper Thread ID is 6429 2024-09-27T19:44:51.602Z,1727466291.602 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-27T19:44:51.603Z,1727466291.603 [controlThread](DEBUG): Uninitializing ControlThread 2024-09-27T19:44:51.603Z,1727466291.603 [AHRS_M2](INFO): Powering down 2024-09-27T19:44:51.675Z,1727466291.675 [NAL9602](INFO): Powering down 2024-09-27T19:44:51.676Z,1727466291.676 [Sonardyne_Nano](INFO): Powering down 2024-09-27T19:44:51.795Z,1727466291.795 [Waterlinked](INFO): Powering down 2024-09-27T19:44:51.796Z,1727466291.796 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-09-27T19:44:51.797Z,1727466291.797 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-09-27T19:44:51.798Z,1727466291.798 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-09-27T19:44:51.799Z,1727466291.799 [MissionManager](INFO): Uninitializing Mission Default 2024-09-27T19:44:51.799Z,1727466291.799 [Default] Stopped 2024-09-27T19:44:51.799Z,1727466291.799 [Default](DEBUG): Aggregate::uninitialize Default 2024-09-27T19:44:51.799Z,1727466291.799 [Default:B.GoToSurface] Stopped 2024-09-27T19:44:51.799Z,1727466291.799 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-27T19:44:51.799Z,1727466291.799 [Default:CheckIn] Stopped 2024-09-27T19:44:51.799Z,1727466291.799 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-27T19:44:51.799Z,1727466291.799 [Default:CheckIn:C.Wait] Stopped 2024-09-27T19:44:51.799Z,1727466291.799 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-27T19:44:51.802Z,1727466291.802 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-09-27T19:44:51.802Z,1727466291.802 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-09-27T19:44:51.803Z,1727466291.803 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-09-27T19:44:51.803Z,1727466291.803 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-09-27T19:44:51.803Z,1727466291.803 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-09-27T19:44:51.804Z,1727466291.804 [BuoyancyServo](INFO): Powering down 2024-09-27T19:44:51.819Z,1727466291.819 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-09-27T19:44:51.819Z,1727466291.819 [ElevatorServo](INFO): Powering down 2024-09-27T19:44:51.819Z,1727466291.819 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-09-27T19:44:51.820Z,1727466291.820 [MassServo](INFO): Powering down 2024-09-27T19:44:51.820Z,1727466291.820 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-27T19:44:51.820Z,1727466291.820 [RudderServo](INFO): Powering down 2024-09-27T19:44:51.821Z,1727466291.821 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-09-27T19:44:51.821Z,1727466291.821 [ThrusterHE](INFO): Powering down 2024-09-27T19:44:51.822Z,1727466291.822 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-09-27T19:44:51.823Z,1727466291.823 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-09-27T19:44:51.823Z,1727466291.823 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-09-27T19:44:51.823Z,1727466291.823 [CBIT](DEBUG): Powering off loads. 2024-09-27T19:44:51.834Z,1727466291.834 [CBIT](DEBUG): Disabling WDT. 2024-09-27T19:44:51.846Z,1727466291.846 [CBIT](DEBUG): Opening all GF detection circuits. 2024-09-27T19:44:51.847Z,1727466291.847 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.874Z,1727466291.874 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.877Z,1727466291.877 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.883Z,1727466291.883 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.890Z,1727466291.890 [DATMMP ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:51.932Z,1727466291.932 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:52.039Z,1727466292.039 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:52.045Z,1727466292.045 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:52.053Z,1727466292.053 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-27T19:44:52.106Z,1727466292.106 [logger ThreadHandler](INFO): Thread cancelled.