2023-05-25T16:39:04.692Z,1685032744.692 [DataOverHttps](INFO): Received command: restart logs 2023-05-25T16:39:04.711Z,1685032744.711 [CommandExec](IMPORTANT): got command restart logs 2023-05-25T16:39:53.968Z,1685032793.968 [DVL_micro](ERROR): Failed to parse: :BI,-00017,00181,+00000,I 2023-05-25T16:40:56.572Z,1685032856.572 [NAL9602](INFO): SBD MO Status=2, MOMSN=19435, MT Status=2, MTMSN=0 2023-05-25T16:40:56.572Z,1685032856.572 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-05-25T16:41:10.266Z,1685032870.266 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.276020 2023-05-25T16:41:30.906Z,1685032890.906 [NAL9602](INFO): SBD MO Status=2, MOMSN=19435, MT Status=2, MTMSN=0 2023-05-25T16:41:30.906Z,1685032890.906 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-05-25T16:41:34.147Z,1685032894.147 [DVL_micro](ERROR): only read 3 of 4 data items 2023-05-25T16:41:34.147Z,1685032894.147 [DVL_micro](ERROR): Failed to parse: :BI,-00018,-00042,-00188,+0:BD,+00000000.00,+0000000000000.00,9999.99,000.00 2023-05-25T16:41:53.991Z,1685032913.991 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-05-25T16:42:24.302Z,1685032944.302 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T16:42:24.302Z,1685032944.302 [Default:CheckIn:C.Wait] Stopped 2023-05-25T16:42:24.302Z,1685032944.302 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T16:42:24.302Z,1685032944.302 [Default:CheckIn:D] Running Loop=1 2023-05-25T16:42:24.694Z,1685032944.694 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-25T16:42:24.706Z,1685032944.706 [Default:CheckIn:D] Stopped 2023-05-25T16:42:24.706Z,1685032944.706 [Default:CheckIn:E] Running Loop=1 2023-05-25T16:42:25.108Z,1685032945.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.172608 min 2023-05-25T16:42:25.108Z,1685032945.108 [Default:CheckIn:E] Stopped 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn] Stopped 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn](INFO): Running loop #3 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn] Running Loop=3 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T16:42:25.109Z,1685032945.109 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T16:42:27.129Z,1685032947.129 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164233.00,A,3648.43591,N,12148.24832,W,17.184,101.23,250523,,,A*46 2023-05-25T16:42:27.131Z,1685032947.131 [NAL9602](INFO): GPS fix at 20230525T164233: (36.807265, -121.804139) 2023-05-25T16:42:27.142Z,1685032947.142 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T16:42:27.142Z,1685032947.142 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T16:42:57.830Z,1685032977.830 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 2023-05-25T16:42:57.905Z,1685032977.905 [NAL9602](ERROR): received: +CSQ:0 OK435, 2, 0, 0, 0 OK 2023-05-25T16:43:12.689Z,1685032992.689 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003089 2023-05-25T16:43:20.124Z,1685033000.124 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230524T185822/Courier0091.lzma 2023-05-25T16:43:21.127Z,1685033001.127 [DataOverHttps](INFO): Moved sent file to Logs/20230524T185822/Courier0091.lzma.bak 2023-05-25T16:43:21.127Z,1685033001.127 [DataOverHttps](INFO): SBD MOMSN=18349366 2023-05-25T16:43:26.559Z,1685033006.559 [NAL9602](INFO): SBD MO Status=1, MOMSN=19435, MT Status=0, MTMSN=0 2023-05-25T16:43:26.609Z,1685033006.609 [NAL9602](INFO): Sent 39 bytes from file Logs/20230524T185822/Courier0091.lzma 2023-05-25T16:43:26.609Z,1685033006.609 [NAL9602](INFO): Packets left to send: 0 2023-05-25T16:43:40.853Z,1685033020.853 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20230525T163904/Courier0000.lzma 2023-05-25T16:43:41.855Z,1685033021.855 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0000.lzma.bak 2023-05-25T16:43:41.855Z,1685033021.855 [DataOverHttps](INFO): SBD MOMSN=18349368 2023-05-25T16:43:57.322Z,1685033037.322 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-25T16:44:02.876Z,1685033042.876 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230525T163904/Courier0003.lzma 2023-05-25T16:44:03.879Z,1685033043.879 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0003.lzma.bak 2023-05-25T16:44:03.879Z,1685033043.879 [DataOverHttps](INFO): SBD MOMSN=18349375 2023-05-25T16:44:19.952Z,1685033059.952 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20230524T185822/Express0092.lzma 2023-05-25T16:44:20.955Z,1685033060.955 [DataOverHttps](INFO): Moved sent file to Logs/20230524T185822/Express0092.lzma.bak 2023-05-25T16:44:20.955Z,1685033060.955 [DataOverHttps](INFO): SBD MOMSN=18349381 2023-05-25T16:44:36.949Z,1685033076.949 [DataOverHttps](INFO): Sending 481 bytes from file Logs/20230525T163904/Express0001.lzma 2023-05-25T16:44:37.951Z,1685033077.951 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0001.lzma.bak 2023-05-25T16:44:37.951Z,1685033077.951 [DataOverHttps](INFO): SBD MOMSN=18349384 2023-05-25T16:44:53.848Z,1685033093.848 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230525T163904/Express0004.lzma 2023-05-25T16:44:54.851Z,1685033094.851 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0004.lzma.bak 2023-05-25T16:44:54.851Z,1685033094.851 [DataOverHttps](INFO): SBD MOMSN=18349394 2023-05-25T16:44:56.332Z,1685033096.332 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T16:44:56.332Z,1685033096.332 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T16:44:56.332Z,1685033096.332 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T16:46:34.529Z,1685033194.529 [DVL_micro](ERROR): Failed to parse: :WI,-00022,-00736,-00310,+00000,A 2023-05-25T16:49:49.672Z,1685033389.672 [DVL_micro](ERROR): Failed to parse: :WI,-00025,-00256,-00096,+ 2023-05-25T16:49:56.964Z,1685033396.964 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T16:49:56.964Z,1685033396.964 [Default:CheckIn:C.Wait] Stopped 2023-05-25T16:49:56.964Z,1685033396.964 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T16:49:56.964Z,1685033396.964 [Default:CheckIn:D] Running Loop=1 2023-05-25T16:49:57.385Z,1685033397.385 [Default:CheckIn:D] Stopped 2023-05-25T16:49:57.386Z,1685033397.386 [Default:CheckIn:E] Running Loop=1 2023-05-25T16:49:57.759Z,1685033397.759 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.717265 min 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn:E] Stopped 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn] Stopped 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn](INFO): Running loop #4 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn] Running Loop=4 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T16:49:57.760Z,1685033397.760 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T16:49:59.789Z,1685033399.789 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165005.00,A,3648.26864,N,12147.14118,W,4.937,189.75,250523,,,D*7D 2023-05-25T16:49:59.791Z,1685033399.791 [NAL9602](INFO): GPS fix at 20230525T165005: (36.804477, -121.785686) 2023-05-25T16:49:59.802Z,1685033399.802 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T16:49:59.802Z,1685033399.802 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T16:50:11.056Z,1685033411.056 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230525T163904/Courier0006.lzma 2023-05-25T16:50:12.064Z,1685033412.064 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0006.lzma.bak 2023-05-25T16:50:12.064Z,1685033412.064 [DataOverHttps](INFO): SBD MOMSN=18349398 2023-05-25T16:50:31.902Z,1685033431.902 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20230525T163904/Express0007.lzma 2023-05-25T16:50:32.902Z,1685033432.902 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0007.lzma.bak 2023-05-25T16:50:32.903Z,1685033432.903 [DataOverHttps](INFO): SBD MOMSN=18349402 2023-05-25T16:50:34.192Z,1685033434.192 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T16:50:34.193Z,1685033434.193 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T16:50:34.193Z,1685033434.193 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T16:51:52.573Z,1685033512.573 [NAL9602](INFO): SBD MO Status=0, MOMSN=19436, MT Status=0, MTMSN=0 2023-05-25T16:51:52.573Z,1685033512.573 [NAL9602](INFO): No messages in MT queue 2023-05-25T16:52:23.262Z,1685033543.262 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-25T16:54:32.593Z,1685033672.593 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-05-25T16:54:32.593Z,1685033672.593 [DVL_micro](ERROR): Failed to parse: :TS,000000035.0,+12.81489.0,000 2023-05-25T16:55:34.840Z,1685033734.840 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T16:55:34.840Z,1685033734.840 [Default:CheckIn:C.Wait] Stopped 2023-05-25T16:55:34.840Z,1685033734.840 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T16:55:34.850Z,1685033734.850 [Default:CheckIn:D] Running Loop=1 2023-05-25T16:55:35.265Z,1685033735.265 [Default:CheckIn:D] Stopped 2023-05-25T16:55:35.266Z,1685033735.266 [Default:CheckIn:E] Running Loop=1 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.348598 min 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn:E] Stopped 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn] Stopped 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn](INFO): Running loop #5 2023-05-25T16:55:35.645Z,1685033735.645 [Default:CheckIn] Running Loop=5 2023-05-25T16:55:35.646Z,1685033735.646 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T16:55:35.646Z,1685033735.646 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T16:55:37.647Z,1685033737.647 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165543.00,A,3648.14987,N,12147.22065,W,0.019,204.20,250523,,,D*7E 2023-05-25T16:55:37.649Z,1685033737.649 [NAL9602](INFO): GPS fix at 20230525T165543: (36.802498, -121.787011) 2023-05-25T16:55:37.692Z,1685033737.692 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T16:55:37.692Z,1685033737.692 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T16:55:46.176Z,1685033746.176 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230525T163904/Courier0009.lzma 2023-05-25T16:55:47.179Z,1685033747.179 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0009.lzma.bak 2023-05-25T16:55:47.179Z,1685033747.179 [DataOverHttps](INFO): SBD MOMSN=18349406 2023-05-25T16:55:59.866Z,1685033759.866 [DVL_micro](ERROR): only read 3 of 4 data items 2023-05-25T16:55:59.866Z,1685033759.866 [DVL_micro](ERROR): Failed to parse: :BI,+00100,+00037,-0000,I 2023-05-25T16:56:03.640Z,1685033763.640 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20230525T163904/Express0010.lzma 2023-05-25T16:56:04.643Z,1685033764.643 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0010.lzma.bak 2023-05-25T16:56:04.643Z,1685033764.643 [DataOverHttps](INFO): SBD MOMSN=18349409 2023-05-25T16:56:05.938Z,1685033765.938 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T16:56:05.938Z,1685033765.938 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T16:56:05.938Z,1685033765.938 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T16:57:48.544Z,1685033868.544 [NAL9602](INFO): SBD MO Status=2, MOMSN=19437, MT Status=2, MTMSN=0 2023-05-25T16:57:48.544Z,1685033868.544 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-05-25T16:58:21.283Z,1685033901.283 [NAL9602](INFO): SBD MO Status=2, MOMSN=19437, MT Status=2, MTMSN=0 2023-05-25T16:58:21.283Z,1685033901.283 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-05-25T16:59:12.577Z,1685033952.577 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-05-25T16:59:12.577Z,1685033952.577 [DVL_micro](ERROR): Failed to parse: :TS,000000035.0,+13.0,0000.0,1489.0,000 2023-05-25T16:59:21.464Z,1685033961.464 [NAL9602](INFO): SBD MO Status=2, MOMSN=19437, MT Status=2, MTMSN=0 2023-05-25T16:59:21.464Z,1685033961.464 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2023-05-25T17:00:53.597Z,1685034053.597 [NAL9602](INFO): SBD MO Status=0, MOMSN=19437, MT Status=0, MTMSN=0 2023-05-25T17:00:53.597Z,1685034053.597 [NAL9602](INFO): No messages in MT queue 2023-05-25T17:01:06.536Z,1685034066.536 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T17:01:06.536Z,1685034066.536 [Default:CheckIn:C.Wait] Stopped 2023-05-25T17:01:06.536Z,1685034066.536 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T17:01:06.537Z,1685034066.537 [Default:CheckIn:D] Running Loop=1 2023-05-25T17:01:06.936Z,1685034066.936 [Default:CheckIn:D] Stopped 2023-05-25T17:01:06.936Z,1685034066.936 [Default:CheckIn:E] Running Loop=1 2023-05-25T17:01:07.352Z,1685034067.352 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.876438 min 2023-05-25T17:01:07.352Z,1685034067.352 [Default:CheckIn:E] Stopped 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn] Stopped 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn](INFO): Running loop #6 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn] Running Loop=6 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T17:01:07.353Z,1685034067.353 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T17:01:09.351Z,1685034069.351 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170115.00,A,3648.15043,N,12147.22475,W,0.019,318.96,250523,,,D*79 2023-05-25T17:01:09.353Z,1685034069.353 [NAL9602](INFO): GPS fix at 20230525T170115: (36.802507, -121.787079) 2023-05-25T17:01:09.363Z,1685034069.363 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T17:01:09.363Z,1685034069.363 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T17:01:16.532Z,1685034076.532 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230525T163904/Courier0012.lzma 2023-05-25T17:01:17.535Z,1685034077.535 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0012.lzma.bak 2023-05-25T17:01:17.535Z,1685034077.535 [DataOverHttps](INFO): SBD MOMSN=18349412 2023-05-25T17:01:33.697Z,1685034093.697 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20230525T163904/Express0013.lzma 2023-05-25T17:01:34.699Z,1685034094.699 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0013.lzma.bak 2023-05-25T17:01:34.700Z,1685034094.700 [DataOverHttps](INFO): SBD MOMSN=18349415 2023-05-25T17:01:36.040Z,1685034096.040 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T17:01:36.040Z,1685034096.040 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T17:01:36.040Z,1685034096.040 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T17:01:41.743Z,1685034101.743 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-25T17:05:10.239Z,1685034310.239 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-05-25T17:05:10.239Z,1685034310.239 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,33,0000.0,1489.0,000 2023-05-25T17:06:36.655Z,1685034396.655 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T17:06:36.655Z,1685034396.655 [Default:CheckIn:C.Wait] Stopped 2023-05-25T17:06:36.655Z,1685034396.655 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T17:06:36.655Z,1685034396.655 [Default:CheckIn:D] Running Loop=1 2023-05-25T17:06:37.066Z,1685034397.066 [Default:CheckIn:D] Stopped 2023-05-25T17:06:37.066Z,1685034397.066 [Default:CheckIn:E] Running Loop=1 2023-05-25T17:06:37.478Z,1685034397.478 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.378605 min 2023-05-25T17:06:37.478Z,1685034397.478 [Default:CheckIn:E] Stopped 2023-05-25T17:06:37.478Z,1685034397.478 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T17:06:37.478Z,1685034397.478 [Default:CheckIn] Stopped 2023-05-25T17:06:37.478Z,1685034397.478 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T17:06:37.478Z,1685034397.478 [Default:CheckIn](INFO): Running loop #7 2023-05-25T17:06:37.479Z,1685034397.479 [Default:CheckIn] Running Loop=7 2023-05-25T17:06:37.479Z,1685034397.479 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T17:06:37.479Z,1685034397.479 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T17:06:39.479Z,1685034399.479 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170645.00,A,3648.16436,N,12147.24954,W,2.819,305.33,250523,,,D*7F 2023-05-25T17:06:39.482Z,1685034399.482 [NAL9602](INFO): GPS fix at 20230525T170645: (36.802739, -121.787492) 2023-05-25T17:06:39.517Z,1685034399.517 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T17:06:39.517Z,1685034399.517 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T17:06:45.561Z,1685034405.561 [DVL_micro](ERROR): only read 3 of 4 data items 2023-05-25T17:06:45.561Z,1685034405.561 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.999 2023-05-25T17:06:46.687Z,1685034406.687 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20230525T163904/Courier0015.lzma 2023-05-25T17:06:47.687Z,1685034407.687 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0015.lzma.bak 2023-05-25T17:06:47.687Z,1685034407.687 [DataOverHttps](INFO): SBD MOMSN=18349419 2023-05-25T17:07:03.632Z,1685034423.632 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20230525T163904/Express0016.lzma 2023-05-25T17:07:04.635Z,1685034424.635 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0016.lzma.bak 2023-05-25T17:07:04.635Z,1685034424.635 [DataOverHttps](INFO): SBD MOMSN=18349422 2023-05-25T17:07:06.166Z,1685034426.166 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T17:07:06.166Z,1685034426.166 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T17:07:06.166Z,1685034426.166 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T17:11:41.670Z,1685034701.670 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-05-25T17:12:06.728Z,1685034726.728 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T17:12:06.728Z,1685034726.728 [Default:CheckIn:C.Wait] Stopped 2023-05-25T17:12:06.728Z,1685034726.728 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T17:12:06.728Z,1685034726.728 [Default:CheckIn:D] Running Loop=1 2023-05-25T17:12:07.142Z,1685034727.142 [Default:CheckIn:D] Stopped 2023-05-25T17:12:07.142Z,1685034727.142 [Default:CheckIn:E] Running Loop=1 2023-05-25T17:12:07.549Z,1685034727.549 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.879871 min 2023-05-25T17:12:07.549Z,1685034727.549 [Default:CheckIn:E] Stopped 2023-05-25T17:12:07.549Z,1685034727.549 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T17:12:07.549Z,1685034727.549 [Default:CheckIn] Stopped 2023-05-25T17:12:07.549Z,1685034727.549 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T17:12:07.550Z,1685034727.550 [Default:CheckIn](INFO): Running loop #8 2023-05-25T17:12:07.550Z,1685034727.550 [Default:CheckIn] Running Loop=8 2023-05-25T17:12:07.550Z,1685034727.550 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T17:12:07.550Z,1685034727.550 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T17:12:09.557Z,1685034729.557 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171215.00,A,3648.16627,N,12147.28561,W,0.175,193.89,250523,,,D*76 2023-05-25T17:12:09.560Z,1685034729.560 [NAL9602](INFO): GPS fix at 20230525T171215: (36.802771, -121.788094) 2023-05-25T17:12:09.582Z,1685034729.582 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T17:12:09.582Z,1685034729.582 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T17:12:16.728Z,1685034736.728 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230525T163904/Courier0018.lzma 2023-05-25T17:12:17.731Z,1685034737.731 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0018.lzma.bak 2023-05-25T17:12:17.731Z,1685034737.731 [DataOverHttps](INFO): SBD MOMSN=18349432 2023-05-25T17:12:33.472Z,1685034753.472 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20230525T163904/Express0019.lzma 2023-05-25T17:12:34.475Z,1685034754.475 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0019.lzma.bak 2023-05-25T17:12:34.475Z,1685034754.475 [DataOverHttps](INFO): SBD MOMSN=18349436 2023-05-25T17:12:35.832Z,1685034755.832 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T17:12:35.832Z,1685034755.832 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T17:12:35.832Z,1685034755.832 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T17:12:41.875Z,1685034761.875 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-25T17:14:54.392Z,1685034894.392 [DVL_micro](ERROR): only read 3 of 4 data items 2023-05-25T17:14:54.392Z,1685034894.392 [DVL_micro](ERROR): Failed to parse: :BI,-00013,+0199,+00000,I 2023-05-25T17:17:36.454Z,1685035056.454 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T17:17:36.454Z,1685035056.454 [Default:CheckIn:C.Wait] Stopped 2023-05-25T17:17:36.454Z,1685035056.454 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T17:17:36.454Z,1685035056.454 [Default:CheckIn:D] Running Loop=1 2023-05-25T17:17:36.860Z,1685035056.860 [Default:CheckIn:D] Stopped 2023-05-25T17:17:36.860Z,1685035056.860 [Default:CheckIn:E] Running Loop=1 2023-05-25T17:17:37.261Z,1685035057.261 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.375175 min 2023-05-25T17:17:37.261Z,1685035057.261 [Default:CheckIn:E] Stopped 2023-05-25T17:17:37.261Z,1685035057.261 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T17:17:37.261Z,1685035057.261 [Default:CheckIn] Stopped 2023-05-25T17:17:37.261Z,1685035057.261 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T17:17:37.262Z,1685035057.262 [Default:CheckIn](INFO): Running loop #9 2023-05-25T17:17:37.262Z,1685035057.262 [Default:CheckIn] Running Loop=9 2023-05-25T17:17:37.262Z,1685035057.262 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T17:17:37.262Z,1685035057.262 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T17:17:39.272Z,1685035059.272 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171745.00,A,3648.15291,N,12147.27581,W,0.097,180.63,250523,,,A*73 2023-05-25T17:17:39.275Z,1685035059.275 [NAL9602](INFO): GPS fix at 20230525T171745: (36.802549, -121.787930) 2023-05-25T17:17:39.318Z,1685035059.318 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T17:17:39.318Z,1685035059.318 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T17:17:53.197Z,1685035073.197 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230525T163904/Courier0021.lzma 2023-05-25T17:17:55.203Z,1685035075.203 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0021.lzma.bak 2023-05-25T17:17:55.203Z,1685035075.203 [DataOverHttps](INFO): SBD MOMSN=18349441 2023-05-25T17:18:10.022Z,1685035090.022 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2023-05-25T17:18:10.105Z,1685035090.105 [NAL9602](ERROR): received: +CSQ:0 OK437, 0, 0, 0, 0 OK 2023-05-25T17:18:12.784Z,1685035092.784 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20230525T163904/Express0022.lzma 2023-05-25T17:18:13.787Z,1685035093.787 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0022.lzma.bak 2023-05-25T17:18:13.787Z,1685035093.787 [DataOverHttps](INFO): SBD MOMSN=18349444 2023-05-25T17:18:15.310Z,1685035095.310 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T17:18:15.310Z,1685035095.310 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T17:18:15.310Z,1685035095.310 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T17:19:31.279Z,1685035171.279 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-05-25T17:19:31.280Z,1685035171.280 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0000.0,148 2023-05-25T17:21:10.445Z,1685035270.445 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.843315 2023-05-25T17:21:21.014Z,1685035281.014 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003452 2023-05-25T17:22:41.963Z,1685035361.963 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-05-25T17:23:12.670Z,1685035392.670 [NAL9602](INFO): Not Powering down - fast GPS 2023-05-25T17:23:15.909Z,1685035395.909 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-05-25T17:23:15.909Z,1685035395.909 [Default:CheckIn:C.Wait] Stopped 2023-05-25T17:23:15.909Z,1685035395.909 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T17:23:15.910Z,1685035395.910 [Default:CheckIn:D] Running Loop=1 2023-05-25T17:23:16.338Z,1685035396.338 [Default:CheckIn:D] Stopped 2023-05-25T17:23:16.338Z,1685035396.338 [Default:CheckIn:E] Running Loop=1 2023-05-25T17:23:16.711Z,1685035396.711 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.033146 min 2023-05-25T17:23:16.711Z,1685035396.711 [Default:CheckIn:E] Stopped 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn] Stopped 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn](INFO): Running loop #10 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn] Running Loop=10 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-05-25T17:23:16.712Z,1685035396.712 [Default:CheckIn:Read_GPS] Running Loop=1 2023-05-25T17:23:18.723Z,1685035398.723 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172324.00,A,3648.13908,N,12147.26175,W,1.575,28.58,250523,,,A*43 2023-05-25T17:23:18.725Z,1685035398.725 [NAL9602](INFO): GPS fix at 20230525T172324: (36.802318, -121.787696) 2023-05-25T17:23:18.736Z,1685035398.736 [Default:CheckIn:Read_GPS] Stopped 2023-05-25T17:23:18.736Z,1685035398.736 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-05-25T17:23:26.104Z,1685035406.104 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20230525T163904/Courier0024.lzma 2023-05-25T17:23:27.107Z,1685035407.107 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Courier0024.lzma.bak 2023-05-25T17:23:27.107Z,1685035407.107 [DataOverHttps](INFO): SBD MOMSN=18349447 2023-05-25T17:23:47.461Z,1685035427.461 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20230525T163904/Express0025.lzma 2023-05-25T17:23:48.463Z,1685035428.463 [DataOverHttps](INFO): Moved sent file to Logs/20230525T163904/Express0025.lzma.bak 2023-05-25T17:23:48.463Z,1685035428.463 [DataOverHttps](INFO): SBD MOMSN=18349450 2023-05-25T17:23:49.495Z,1685035429.495 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2023-05-25T17:23:49.569Z,1685035429.569 [NAL9602](ERROR): received: +CSQ:0 OK437, 0, 0, 0, 0 OK 2023-05-25T17:23:49.914Z,1685035429.914 [Default:CheckIn:Read_Iridium] Stopped 2023-05-25T17:23:49.914Z,1685035429.914 [Default:CheckIn:C.Wait] Running Loop=1 2023-05-25T17:23:49.915Z,1685035429.915 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-05-25T17:23:59.975Z,1685035439.975 [DVL_micro](ERROR): only read 3 of 4 data items 2023-05-25T17:23:59.975Z,1685035439.975 [DVL_micro](ERROR): Failed to parse: :BI,+00296,-00678,+00111,+00BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2023-05-25T17:24:10.066Z,1685035450.066 [DVL_micro](ERROR): only read 3 of 4 data items 2023-05-25T17:24:10.067Z,1685035450.067 [DVL_micro](ERROR): Failed to parse: :BI,+00604,-00525,+0000,I 2023-05-25T17:24:46.019Z,1685035486.019 [DVL_micro](ERROR): Failed to parse: :BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2023-05-25T17:24:47.249Z,1685035487.249 [CommandExec](IMPORTANT): got command quit 2023-05-25T17:24:48.265Z,1685035488.265 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:48.265Z,1685035488.265 [CommandExec](INFO): Uninitializing the command executive. 2023-05-25T17:24:48.265Z,1685035488.265 [CommandExec](INFO): Uninitializing the command scheduler. 2023-05-25T17:24:48.266Z,1685035488.266 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:48.381Z,1685035488.381 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-05-25T17:24:48.381Z,1685035488.381 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-05-25T17:24:48.381Z,1685035488.381 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:48.382Z,1685035488.382 [NavChartDb](INFO): Join timeout helper Thread ID is 6174 2023-05-25T17:24:48.613Z,1685035488.613 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:48.613Z,1685035488.613 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:48.634Z,1685035488.634 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-05-25T17:24:48.635Z,1685035488.635 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:48.636Z,1685035488.636 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6175 2023-05-25T17:24:49.105Z,1685035489.105 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:49.105Z,1685035489.105 [WetLabsBB2FL](INFO): Powering down 2023-05-25T17:24:49.106Z,1685035489.106 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:49.117Z,1685035489.117 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-05-25T17:24:49.117Z,1685035489.117 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:49.117Z,1685035489.117 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6176 2023-05-25T17:24:49.217Z,1685035489.217 [CTD_Seabird](INFO): Powering down 2023-05-25T17:24:49.229Z,1685035489.229 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:49.229Z,1685035489.229 [CTD_Seabird](INFO): Powering down 2023-05-25T17:24:49.241Z,1685035489.241 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:49.249Z,1685035489.249 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-05-25T17:24:49.249Z,1685035489.249 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:49.249Z,1685035489.249 [Radio_Surface](INFO): Join timeout helper Thread ID is 6177 2023-05-25T17:24:49.493Z,1685035489.493 [Radio_Surface](INFO): Powering down 2023-05-25T17:24:49.494Z,1685035489.494 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:49.494Z,1685035489.494 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:49.513Z,1685035489.513 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-05-25T17:24:49.513Z,1685035489.513 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:49.513Z,1685035489.513 [Onboard](INFO): Join timeout helper Thread ID is 6178 2023-05-25T17:24:50.325Z,1685035490.325 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-05-25T17:24:51.189Z,1685035491.189 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.189Z,1685035491.189 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.202Z,1685035491.202 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-05-25T17:24:51.202Z,1685035491.202 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.202Z,1685035491.202 [DataOverHttps](INFO): Join timeout helper Thread ID is 6179 2023-05-25T17:24:51.329Z,1685035491.329 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.329Z,1685035491.329 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.342Z,1685035491.342 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2023-05-25T17:24:51.342Z,1685035491.342 [DAT ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.342Z,1685035491.342 [DAT](INFO): Join timeout helper Thread ID is 6180 2023-05-25T17:24:51.345Z,1685035491.345 [DAT](INFO): Powering down 2023-05-25T17:24:51.417Z,1685035491.417 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.418Z,1685035491.418 [DAT](INFO): Powering down 2023-05-25T17:24:51.418Z,1685035491.418 [DAT ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.422Z,1685035491.422 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-05-25T17:24:51.422Z,1685035491.422 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.422Z,1685035491.422 [BackseatComponent](INFO): Join timeout helper Thread ID is 6181 2023-05-25T17:24:51.465Z,1685035491.465 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.465Z,1685035491.465 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.481Z,1685035491.481 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-05-25T17:24:51.482Z,1685035491.482 [logger ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.482Z,1685035491.482 [logger](INFO): Join timeout helper Thread ID is 6182 2023-05-25T17:24:51.501Z,1685035491.501 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.501Z,1685035491.501 [logger ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.521Z,1685035491.521 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-05-25T17:24:51.522Z,1685035491.522 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.522Z,1685035491.522 [CommandLine](INFO): Join timeout helper Thread ID is 6183 2023-05-25T17:24:51.557Z,1685035491.557 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.557Z,1685035491.557 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.561Z,1685035491.561 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-05-25T17:24:51.562Z,1685035491.562 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.562Z,1685035491.562 [CommandExec](INFO): Join timeout helper Thread ID is 6184 2023-05-25T17:24:51.563Z,1685035491.563 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-05-25T17:24:51.563Z,1685035491.563 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.564Z,1685035491.564 [controlThread](INFO): Join timeout helper Thread ID is 6185 2023-05-25T17:24:51.653Z,1685035491.653 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-05-25T17:24:51.653Z,1685035491.653 [controlThread](DEBUG): Uninitializing ControlThread 2023-05-25T17:24:51.654Z,1685035491.654 [AHRS_M2](INFO): Powering down 2023-05-25T17:24:51.797Z,1685035491.797 [DVL_micro](INFO): Powering down 2023-05-25T17:24:51.798Z,1685035491.798 [NAL9602](INFO): Powering down 2023-05-25T17:24:51.801Z,1685035491.801 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-05-25T17:24:51.802Z,1685035491.802 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-05-25T17:24:51.802Z,1685035491.802 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-05-25T17:24:51.803Z,1685035491.803 [MissionManager](INFO): Uninitializing Mission Default 2023-05-25T17:24:51.803Z,1685035491.803 [Default] Stopped 2023-05-25T17:24:51.803Z,1685035491.803 [Default](DEBUG): Aggregate::uninitialize Default 2023-05-25T17:24:51.803Z,1685035491.803 [Default:B.GoToSurface] Stopped 2023-05-25T17:24:51.803Z,1685035491.803 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-05-25T17:24:51.803Z,1685035491.803 [Default:CheckIn] Stopped 2023-05-25T17:24:51.803Z,1685035491.803 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-05-25T17:24:51.803Z,1685035491.803 [Default:CheckIn:C.Wait] Stopped 2023-05-25T17:24:51.803Z,1685035491.803 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-05-25T17:24:51.806Z,1685035491.806 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-05-25T17:24:51.806Z,1685035491.806 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-05-25T17:24:51.807Z,1685035491.807 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-05-25T17:24:51.807Z,1685035491.807 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-05-25T17:24:51.807Z,1685035491.807 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-05-25T17:24:51.807Z,1685035491.807 [BuoyancyServo](INFO): Powering down 2023-05-25T17:24:51.821Z,1685035491.821 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-05-25T17:24:51.821Z,1685035491.821 [ElevatorServo](INFO): Powering down 2023-05-25T17:24:51.822Z,1685035491.822 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-05-25T17:24:51.822Z,1685035491.822 [MassServo](INFO): Powering down 2023-05-25T17:24:51.823Z,1685035491.823 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-05-25T17:24:51.823Z,1685035491.823 [RudderServo](INFO): Powering down 2023-05-25T17:24:51.824Z,1685035491.824 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-05-25T17:24:51.824Z,1685035491.824 [ThrusterHE](INFO): Powering down 2023-05-25T17:24:51.825Z,1685035491.825 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-05-25T17:24:51.825Z,1685035491.825 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-05-25T17:24:51.825Z,1685035491.825 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-05-25T17:24:51.825Z,1685035491.825 [CBIT](DEBUG): Powering off loads. 2023-05-25T17:24:51.837Z,1685035491.837 [CBIT](DEBUG): Disabling WDT. 2023-05-25T17:24:51.849Z,1685035491.849 [CBIT](DEBUG): Opening all GF detection circuits. 2023-05-25T17:24:51.850Z,1685035491.850 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.907Z,1685035491.907 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.910Z,1685035491.910 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.918Z,1685035491.918 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.924Z,1685035491.924 [DAT ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:51.966Z,1685035491.966 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:52.024Z,1685035492.024 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:52.029Z,1685035492.029 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:52.052Z,1685035492.052 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-05-25T17:24:52.138Z,1685035492.138 [logger ThreadHandler](INFO): Thread cancelled.