2025-05-14T20:35:29.254Z,1747254929.254 [CommandExec](IMPORTANT): got command restart logs 2025-05-14T20:36:09.376Z,1747254969.376 [NAL9602](INFO): SBD MO Status=2, MOMSN=20717, MT Status=2, MTMSN=0 2025-05-14T20:36:09.376Z,1747254969.376 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-14T20:36:36.445Z,1747254996.445 [NAL9602](INFO): SBD MO Status=2, MOMSN=20717, MT Status=2, MTMSN=0 2025-05-14T20:36:36.445Z,1747254996.445 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-14T20:37:45.527Z,1747255065.527 [NAL9602](INFO): SBD MO Status=2, MOMSN=20717, MT Status=2, MTMSN=0 2025-05-14T20:37:45.527Z,1747255065.527 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-14T20:38:14.218Z,1747255094.218 [NAL9602](INFO): SBD MO Status=2, MOMSN=20717, MT Status=2, MTMSN=0 2025-05-14T20:38:14.218Z,1747255094.218 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-14T20:38:16.240Z,1747255096.240 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-05-14T20:38:42.905Z,1747255122.905 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T20:38:42.905Z,1747255122.905 [Default:CheckIn:C.Wait] Stopped 2025-05-14T20:38:42.905Z,1747255122.905 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T20:38:42.905Z,1747255122.905 [Default:CheckIn:D] Running Loop=1 2025-05-14T20:38:43.322Z,1747255123.322 [Default:CheckIn:D] Stopped 2025-05-14T20:38:43.323Z,1747255123.323 [Default:CheckIn:E] Running Loop=1 2025-05-14T20:38:43.731Z,1747255123.731 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.301213 min 2025-05-14T20:38:43.731Z,1747255123.731 [Default:CheckIn:E] Stopped 2025-05-14T20:38:43.731Z,1747255123.731 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T20:38:43.731Z,1747255123.731 [Default:CheckIn] Stopped 2025-05-14T20:38:43.731Z,1747255123.731 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T20:38:43.731Z,1747255123.731 [Default:CheckIn](INFO): Running loop #5 2025-05-14T20:38:43.732Z,1747255123.732 [Default:CheckIn] Running Loop=5 2025-05-14T20:38:43.732Z,1747255123.732 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T20:38:43.732Z,1747255123.732 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T20:38:45.731Z,1747255125.731 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203844.00,A,3648.29644,N,12148.09632,W,28.905,95.96,140525,,,D*76 2025-05-14T20:38:45.735Z,1747255125.735 [NAL9602](INFO): GPS fix at 20250514T203844: (36.804941, -121.801605) 2025-05-14T20:38:45.766Z,1747255125.766 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T20:38:45.766Z,1747255125.766 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T20:38:53.012Z,1747255133.012 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20250514T193200/Courier0024.lzma 2025-05-14T20:38:54.014Z,1747255134.014 [DataOverHttps](INFO): Moved sent file to Logs/20250514T193200/Courier0024.lzma.bak 2025-05-14T20:38:54.015Z,1747255134.015 [DataOverHttps](INFO): SBD MOMSN=24876325 2025-05-14T20:39:11.225Z,1747255151.225 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20250514T203529/Courier0000.lzma 2025-05-14T20:39:12.226Z,1747255152.226 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0000.lzma.bak 2025-05-14T20:39:12.227Z,1747255152.227 [DataOverHttps](INFO): SBD MOMSN=24876327 2025-05-14T20:39:18.452Z,1747255158.452 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T20:39:28.443Z,1747255168.443 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20250514T193200/Express0025.lzma 2025-05-14T20:39:29.442Z,1747255169.442 [DataOverHttps](INFO): Moved sent file to Logs/20250514T193200/Express0025.lzma.bak 2025-05-14T20:39:29.443Z,1747255169.443 [DataOverHttps](INFO): SBD MOMSN=24876331 2025-05-14T20:39:48.269Z,1747255188.269 [DataOverHttps](INFO): Sending 581 bytes from file Logs/20250514T203529/Express0001.lzma 2025-05-14T20:39:49.270Z,1747255189.270 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0001.lzma.bak 2025-05-14T20:39:49.270Z,1747255189.270 [DataOverHttps](INFO): SBD MOMSN=24876340 2025-05-14T20:39:50.390Z,1747255190.390 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T20:39:50.390Z,1747255190.390 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T20:39:50.391Z,1747255190.391 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T20:40:52.995Z,1747255252.995 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-05-14T20:42:35.213Z,1747255355.213 [DVL_micro](ERROR): Failed to parse: :SA,-00.83,-00.20,178.0 2025-05-14T20:44:50.966Z,1747255490.966 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T20:44:50.966Z,1747255490.966 [Default:CheckIn:C.Wait] Stopped 2025-05-14T20:44:50.966Z,1747255490.966 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T20:44:50.966Z,1747255490.966 [Default:CheckIn:D] Running Loop=1 2025-05-14T20:44:51.365Z,1747255491.365 [Default:CheckIn:D] Stopped 2025-05-14T20:44:51.365Z,1747255491.365 [Default:CheckIn:E] Running Loop=1 2025-05-14T20:44:51.779Z,1747255491.779 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 28.435260 min 2025-05-14T20:44:51.779Z,1747255491.779 [Default:CheckIn:E] Stopped 2025-05-14T20:44:51.779Z,1747255491.779 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T20:44:51.779Z,1747255491.779 [Default:CheckIn] Stopped 2025-05-14T20:44:51.779Z,1747255491.779 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T20:44:51.780Z,1747255491.780 [Default:CheckIn](INFO): Running loop #6 2025-05-14T20:44:51.780Z,1747255491.780 [Default:CheckIn] Running Loop=6 2025-05-14T20:44:51.780Z,1747255491.780 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T20:44:51.780Z,1747255491.780 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T20:44:53.786Z,1747255493.786 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204453.00,A,3648.25645,N,12147.14642,W,3.713,203.16,140525,,,D*77 2025-05-14T20:44:53.788Z,1747255493.788 [NAL9602](INFO): GPS fix at 20250514T204453: (36.804274, -121.785774) 2025-05-14T20:44:53.815Z,1747255493.815 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T20:44:53.815Z,1747255493.815 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T20:45:01.828Z,1747255501.828 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250514T203529/Courier0003.lzma 2025-05-14T20:45:02.940Z,1747255502.940 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0003.lzma.bak 2025-05-14T20:45:02.940Z,1747255502.940 [DataOverHttps](INFO): SBD MOMSN=24876437 2025-05-14T20:45:18.937Z,1747255518.937 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20250514T203529/Express0005.lzma 2025-05-14T20:45:19.938Z,1747255519.938 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0005.lzma.bak 2025-05-14T20:45:19.939Z,1747255519.939 [DataOverHttps](INFO): SBD MOMSN=24876441 2025-05-14T20:45:21.260Z,1747255521.260 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T20:45:21.260Z,1747255521.260 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T20:45:21.260Z,1747255521.260 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T20:45:24.493Z,1747255524.493 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-05-14T20:45:24.573Z,1747255524.573 [NAL9602](ERROR): received: +SBDI: 2, 20717, 2, 0, 0, 0 OK 2025-05-14T20:45:44.678Z,1747255544.678 [NAL9602](INFO): SBD MO Status=1, MOMSN=20717, MT Status=0, MTMSN=0 2025-05-14T20:45:44.678Z,1747255544.678 [NAL9602](INFO): No messages in MT queue 2025-05-14T20:46:15.401Z,1747255575.401 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T20:50:21.840Z,1747255821.840 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T20:50:21.840Z,1747255821.840 [Default:CheckIn:C.Wait] Stopped 2025-05-14T20:50:21.840Z,1747255821.840 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T20:50:21.840Z,1747255821.840 [Default:CheckIn:D] Running Loop=1 2025-05-14T20:50:22.249Z,1747255822.249 [Default:CheckIn:D] Stopped 2025-05-14T20:50:22.249Z,1747255822.249 [Default:CheckIn:E] Running Loop=1 2025-05-14T20:50:22.664Z,1747255822.664 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.949984 min 2025-05-14T20:50:22.664Z,1747255822.664 [Default:CheckIn:E] Stopped 2025-05-14T20:50:22.664Z,1747255822.664 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T20:50:22.665Z,1747255822.665 [Default:CheckIn] Stopped 2025-05-14T20:50:22.665Z,1747255822.665 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T20:50:22.665Z,1747255822.665 [Default:CheckIn](INFO): Running loop #7 2025-05-14T20:50:22.665Z,1747255822.665 [Default:CheckIn] Running Loop=7 2025-05-14T20:50:22.665Z,1747255822.665 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T20:50:22.665Z,1747255822.665 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T20:50:24.694Z,1747255824.694 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205023.00,A,3648.14888,N,12147.22173,W,0.039,213.93,140525,,,D*78 2025-05-14T20:50:24.697Z,1747255824.697 [NAL9602](INFO): GPS fix at 20250514T205023: (36.802481, -121.787029) 2025-05-14T20:50:24.708Z,1747255824.708 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T20:50:24.708Z,1747255824.708 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T20:50:32.540Z,1747255832.540 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250514T203529/Courier0009.lzma 2025-05-14T20:50:33.542Z,1747255833.542 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0009.lzma.bak 2025-05-14T20:50:33.542Z,1747255833.542 [DataOverHttps](INFO): SBD MOMSN=24876472 2025-05-14T20:50:50.249Z,1747255850.249 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20250514T203529/Express0010.lzma 2025-05-14T20:50:51.250Z,1747255851.250 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0010.lzma.bak 2025-05-14T20:50:51.251Z,1747255851.251 [DataOverHttps](INFO): SBD MOMSN=24876475 2025-05-14T20:50:52.549Z,1747255852.549 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T20:50:52.549Z,1747255852.549 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T20:50:52.549Z,1747255852.549 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T20:50:53.362Z,1747255853.362 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-05-14T20:52:26.702Z,1747255946.702 [NAL9602](INFO): SBD MO Status=2, MOMSN=20718, MT Status=2, MTMSN=0 2025-05-14T20:52:26.703Z,1747255946.703 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-05-14T20:52:45.683Z,1747255965.683 [NAL9602](INFO): SBD MO Status=1, MOMSN=20718, MT Status=0, MTMSN=0 2025-05-14T20:52:45.683Z,1747255965.683 [NAL9602](INFO): No messages in MT queue 2025-05-14T20:53:16.375Z,1747255996.375 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T20:55:53.150Z,1747256153.150 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T20:55:53.150Z,1747256153.150 [Default:CheckIn:C.Wait] Stopped 2025-05-14T20:55:53.151Z,1747256153.151 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T20:55:53.151Z,1747256153.151 [Default:CheckIn:D] Running Loop=1 2025-05-14T20:55:53.555Z,1747256153.555 [Default:CheckIn:D] Stopped 2025-05-14T20:55:53.555Z,1747256153.555 [Default:CheckIn:E] Running Loop=1 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.471749 min 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn:E] Stopped 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn] Stopped 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn](INFO): Running loop #8 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn] Running Loop=8 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T20:55:53.957Z,1747256153.957 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T20:55:55.973Z,1747256155.973 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205555.00,A,3648.17407,N,12147.28089,W,0.039,325.64,140525,,,A*73 2025-05-14T20:55:55.975Z,1747256155.975 [NAL9602](INFO): GPS fix at 20250514T205555: (36.802901, -121.788015) 2025-05-14T20:55:55.986Z,1747256155.986 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T20:55:55.986Z,1747256155.986 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T20:56:03.220Z,1747256163.220 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250514T203529/Courier0012.lzma 2025-05-14T20:56:04.222Z,1747256164.222 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0012.lzma.bak 2025-05-14T20:56:04.223Z,1747256164.223 [DataOverHttps](INFO): SBD MOMSN=24876546 2025-05-14T20:56:10.534Z,1747256170.534 [NAL9602](INFO): SBD MO Status=1, MOMSN=20719, MT Status=0, MTMSN=0 2025-05-14T20:56:10.535Z,1747256170.535 [NAL9602](INFO): No messages in MT queue 2025-05-14T20:56:20.265Z,1747256180.265 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20250514T203529/Express0013.lzma 2025-05-14T20:56:21.266Z,1747256181.266 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0013.lzma.bak 2025-05-14T20:56:21.267Z,1747256181.267 [DataOverHttps](INFO): SBD MOMSN=24876549 2025-05-14T20:56:22.653Z,1747256182.653 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T20:56:22.653Z,1747256182.653 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T20:56:22.653Z,1747256182.653 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T20:56:41.218Z,1747256201.218 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T21:00:53.353Z,1747256453.353 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-05-14T21:01:23.254Z,1747256483.254 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T21:01:23.254Z,1747256483.254 [Default:CheckIn:C.Wait] Stopped 2025-05-14T21:01:23.254Z,1747256483.254 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T21:01:23.255Z,1747256483.255 [Default:CheckIn:D] Running Loop=1 2025-05-14T21:01:23.658Z,1747256483.658 [Default:CheckIn:D] Stopped 2025-05-14T21:01:23.658Z,1747256483.658 [Default:CheckIn:E] Running Loop=1 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.973470 min 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn:E] Stopped 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn] Stopped 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn](INFO): Running loop #9 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn] Running Loop=9 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T21:01:24.066Z,1747256484.066 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T21:01:26.100Z,1747256486.100 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210125.00,A,3648.17675,N,12147.28046,W,0.058,325.64,140525,,,D*72 2025-05-14T21:01:26.103Z,1747256486.103 [NAL9602](INFO): GPS fix at 20250514T210125: (36.802946, -121.788008) 2025-05-14T21:01:26.113Z,1747256486.113 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T21:01:26.113Z,1747256486.113 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T21:01:33.236Z,1747256493.236 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250514T203529/Courier0015.lzma 2025-05-14T21:01:34.254Z,1747256494.254 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0015.lzma.bak 2025-05-14T21:01:34.255Z,1747256494.255 [DataOverHttps](INFO): SBD MOMSN=24876570 2025-05-14T21:01:50.464Z,1747256510.464 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20250514T203529/Express0016.lzma 2025-05-14T21:01:51.467Z,1747256511.467 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0016.lzma.bak 2025-05-14T21:01:51.467Z,1747256511.467 [DataOverHttps](INFO): SBD MOMSN=24876575 2025-05-14T21:01:52.777Z,1747256512.777 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T21:01:52.777Z,1747256512.777 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T21:01:52.777Z,1747256512.777 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T21:02:10.156Z,1747256530.156 [NAL9602](INFO): SBD MO Status=1, MOMSN=20720, MT Status=0, MTMSN=0 2025-05-14T21:02:10.156Z,1747256530.156 [NAL9602](INFO): No messages in MT queue 2025-05-14T21:02:40.840Z,1747256560.840 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T21:06:53.359Z,1747256813.359 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T21:06:53.359Z,1747256813.359 [Default:CheckIn:C.Wait] Stopped 2025-05-14T21:06:53.360Z,1747256813.360 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T21:06:53.360Z,1747256813.360 [Default:CheckIn:D] Running Loop=1 2025-05-14T21:06:53.767Z,1747256813.767 [Default:CheckIn:D] Stopped 2025-05-14T21:06:53.767Z,1747256813.767 [Default:CheckIn:E] Running Loop=1 2025-05-14T21:06:54.168Z,1747256814.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.475285 min 2025-05-14T21:06:54.168Z,1747256814.168 [Default:CheckIn:E] Stopped 2025-05-14T21:06:54.168Z,1747256814.168 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T21:06:54.168Z,1747256814.168 [Default:CheckIn] Stopped 2025-05-14T21:06:54.168Z,1747256814.168 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T21:06:54.184Z,1747256814.184 [Default:CheckIn](INFO): Running loop #10 2025-05-14T21:06:54.185Z,1747256814.185 [Default:CheckIn] Running Loop=10 2025-05-14T21:06:54.185Z,1747256814.185 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T21:06:54.185Z,1747256814.185 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T21:06:56.175Z,1747256816.175 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210655.00,A,3648.17613,N,12147.27756,W,0.078,354.01,140525,,,D*7C 2025-05-14T21:06:56.177Z,1747256816.177 [NAL9602](INFO): GPS fix at 20250514T210655: (36.802935, -121.787959) 2025-05-14T21:06:56.187Z,1747256816.187 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T21:06:56.188Z,1747256816.188 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T21:07:03.820Z,1747256823.820 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250514T203529/Courier0018.lzma 2025-05-14T21:07:04.823Z,1747256824.823 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0018.lzma.bak 2025-05-14T21:07:04.823Z,1747256824.823 [DataOverHttps](INFO): SBD MOMSN=24876655 2025-05-14T21:07:18.804Z,1747256838.804 [NAL9602](INFO): SBD MO Status=1, MOMSN=20721, MT Status=0, MTMSN=0 2025-05-14T21:07:18.804Z,1747256838.804 [NAL9602](INFO): No messages in MT queue 2025-05-14T21:07:21.021Z,1747256841.021 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20250514T203529/Express0019.lzma 2025-05-14T21:07:22.023Z,1747256842.023 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0019.lzma.bak 2025-05-14T21:07:22.023Z,1747256842.023 [DataOverHttps](INFO): SBD MOMSN=24876658 2025-05-14T21:07:23.260Z,1747256843.260 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T21:07:23.260Z,1747256843.260 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T21:07:23.260Z,1747256843.260 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T21:07:49.505Z,1747256869.505 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T21:10:53.738Z,1747257053.738 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-05-14T21:12:23.866Z,1747257143.866 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T21:12:23.866Z,1747257143.866 [Default:CheckIn:C.Wait] Stopped 2025-05-14T21:12:23.866Z,1747257143.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T21:12:23.867Z,1747257143.867 [Default:CheckIn:D] Running Loop=1 2025-05-14T21:12:24.270Z,1747257144.270 [Default:CheckIn:D] Stopped 2025-05-14T21:12:24.270Z,1747257144.270 [Default:CheckIn:E] Running Loop=1 2025-05-14T21:12:24.692Z,1747257144.692 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.983671 min 2025-05-14T21:12:24.692Z,1747257144.692 [Default:CheckIn:E] Stopped 2025-05-14T21:12:24.692Z,1747257144.692 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T21:12:24.692Z,1747257144.692 [Default:CheckIn] Stopped 2025-05-14T21:12:24.693Z,1747257144.693 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T21:12:24.693Z,1747257144.693 [Default:CheckIn](INFO): Running loop #11 2025-05-14T21:12:24.693Z,1747257144.693 [Default:CheckIn] Running Loop=11 2025-05-14T21:12:24.693Z,1747257144.693 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T21:12:24.693Z,1747257144.693 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T21:12:26.679Z,1747257146.679 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211225.00,A,3648.17777,N,12147.27864,W,0.039,354.01,140525,,,D*76 2025-05-14T21:12:26.681Z,1747257146.681 [NAL9602](INFO): GPS fix at 20250514T211225: (36.802963, -121.787977) 2025-05-14T21:12:26.692Z,1747257146.692 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T21:12:26.692Z,1747257146.692 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T21:12:36.144Z,1747257156.144 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20250514T203529/Courier0021.lzma 2025-05-14T21:12:37.146Z,1747257157.146 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0021.lzma.bak 2025-05-14T21:12:37.147Z,1747257157.147 [DataOverHttps](INFO): SBD MOMSN=24876676 2025-05-14T21:12:41.248Z,1747257161.248 [NAL9602](INFO): SBD MO Status=1, MOMSN=20722, MT Status=0, MTMSN=0 2025-05-14T21:12:41.248Z,1747257161.248 [NAL9602](INFO): No messages in MT queue 2025-05-14T21:12:53.807Z,1747257173.807 [DataOverHttps](INFO): Sending 157 bytes from file Logs/20250514T203529/Express0022.lzma 2025-05-14T21:12:54.807Z,1747257174.807 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0022.lzma.bak 2025-05-14T21:12:54.807Z,1747257174.807 [DataOverHttps](INFO): SBD MOMSN=24876685 2025-05-14T21:12:56.213Z,1747257176.213 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T21:12:56.213Z,1747257176.213 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T21:12:56.213Z,1747257176.213 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T21:13:11.955Z,1747257191.955 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T21:17:48.762Z,1747257468.762 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,000009999.99,+9999.99 2025-05-14T21:17:48.762Z,1747257468.762 [DVL_micro](ERROR): Failed to parse: :TS,000009999.99,+9999.99 2025-05-14T21:17:56.866Z,1747257476.866 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T21:17:56.866Z,1747257476.866 [Default:CheckIn:C.Wait] Stopped 2025-05-14T21:17:56.866Z,1747257476.866 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T21:17:56.867Z,1747257476.867 [Default:CheckIn:D] Running Loop=1 2025-05-14T21:17:57.272Z,1747257477.272 [Default:CheckIn:D] Stopped 2025-05-14T21:17:57.272Z,1747257477.272 [Default:CheckIn:E] Running Loop=1 2025-05-14T21:17:57.801Z,1747257477.801 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.533700 min 2025-05-14T21:17:57.801Z,1747257477.801 [Default:CheckIn:E] Stopped 2025-05-14T21:17:57.801Z,1747257477.801 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T21:17:57.801Z,1747257477.801 [Default:CheckIn] Stopped 2025-05-14T21:17:57.801Z,1747257477.801 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T21:17:57.801Z,1747257477.801 [Default:CheckIn](INFO): Running loop #12 2025-05-14T21:17:57.802Z,1747257477.802 [Default:CheckIn] Running Loop=12 2025-05-14T21:17:57.802Z,1747257477.802 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T21:17:57.802Z,1747257477.802 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T21:17:59.678Z,1747257479.678 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,211758.00,A,3648.18121,N,12147.27033,W,0.214,277.35,140525,,,D*73 2025-05-14T21:17:59.680Z,1747257479.680 [NAL9602](INFO): GPS fix at 20250514T211758: (36.803020, -121.787839) 2025-05-14T21:17:59.690Z,1747257479.690 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T21:17:59.691Z,1747257479.691 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T21:18:07.420Z,1747257487.420 [DataOverHttps](INFO): Sending 76 bytes from file Logs/20250514T203529/Courier0024.lzma 2025-05-14T21:18:08.422Z,1747257488.422 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0024.lzma.bak 2025-05-14T21:18:08.423Z,1747257488.423 [DataOverHttps](INFO): SBD MOMSN=24876745 2025-05-14T21:18:24.637Z,1747257504.637 [DataOverHttps](INFO): Sending 158 bytes from file Logs/20250514T203529/Express0025.lzma 2025-05-14T21:18:25.638Z,1747257505.638 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0025.lzma.bak 2025-05-14T21:18:25.639Z,1747257505.639 [DataOverHttps](INFO): SBD MOMSN=24876748 2025-05-14T21:18:26.784Z,1747257506.784 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T21:18:26.784Z,1747257506.784 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T21:18:26.784Z,1747257506.784 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T21:19:36.674Z,1747257576.674 [BPC1](ERROR): Battery stick #2 (s/n: 0124) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2025-05-14T21:19:36.674Z,1747257576.674 [BPC1](ERROR): Battery stick #4 (s/n: 017A) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-05-14T21:19:36.675Z,1747257576.675 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2025-05-14T21:19:36.678Z,1747257576.678 [BPC1](INFO): Received data from all battery sticks. 2025-05-14T21:20:27.176Z,1747257627.176 [NAL9602](INFO): SBD MO Status=1, MOMSN=20723, MT Status=0, MTMSN=0 2025-05-14T21:20:27.176Z,1747257627.176 [NAL9602](INFO): No messages in MT queue 2025-05-14T21:20:53.839Z,1747257653.839 [Sonardyne_Nano](INFO): Battery below minimum, enabling charging 2025-05-14T21:20:57.884Z,1747257657.884 [NAL9602](INFO): Not Powering down - fast GPS 2025-05-14T21:23:27.374Z,1747257807.374 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-05-14T21:23:27.374Z,1747257807.374 [Default:CheckIn:C.Wait] Stopped 2025-05-14T21:23:27.374Z,1747257807.374 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T21:23:27.374Z,1747257807.374 [Default:CheckIn:D] Running Loop=1 2025-05-14T21:23:27.772Z,1747257807.772 [Default:CheckIn:D] Stopped 2025-05-14T21:23:27.772Z,1747257807.772 [Default:CheckIn:E] Running Loop=1 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.042033 min 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn:E] Stopped 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn] Stopped 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn](INFO): Running loop #13 2025-05-14T21:23:28.175Z,1747257808.175 [Default:CheckIn] Running Loop=13 2025-05-14T21:23:28.176Z,1747257808.176 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-05-14T21:23:28.176Z,1747257808.176 [Default:CheckIn:Read_GPS] Running Loop=1 2025-05-14T21:23:30.187Z,1747257810.187 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212329.00,A,3648.16415,N,12147.27675,W,0.855,232.77,140525,,,A*77 2025-05-14T21:23:30.199Z,1747257810.199 [NAL9602](INFO): GPS fix at 20250514T212329: (36.802736, -121.787946) 2025-05-14T21:23:30.210Z,1747257810.210 [Default:CheckIn:Read_GPS] Stopped 2025-05-14T21:23:30.210Z,1747257810.210 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-05-14T21:23:39.440Z,1747257819.440 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20250514T203529/Courier0027.lzma 2025-05-14T21:23:40.438Z,1747257820.438 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Courier0027.lzma.bak 2025-05-14T21:23:40.439Z,1747257820.439 [DataOverHttps](INFO): SBD MOMSN=24876818 2025-05-14T21:23:56.565Z,1747257836.565 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250514T203529/Express0028.lzma 2025-05-14T21:23:57.567Z,1747257837.567 [DataOverHttps](INFO): Moved sent file to Logs/20250514T203529/Express0028.lzma.bak 2025-05-14T21:23:57.567Z,1747257837.567 [DataOverHttps](INFO): SBD MOMSN=24876821 2025-05-14T21:23:58.901Z,1747257838.901 [Default:CheckIn:Read_Iridium] Stopped 2025-05-14T21:23:58.901Z,1747257838.901 [Default:CheckIn:C.Wait] Running Loop=1 2025-05-14T21:23:58.901Z,1747257838.901 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-05-14T21:26:54.113Z,1747258014.113 [CommandExec](IMPORTANT): got command quit 2025-05-14T21:26:55.121Z,1747258015.121 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2025-05-14T21:26:55.121Z,1747258015.121 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:55.121Z,1747258015.121 [CommandExec](INFO): Uninitializing the command executive. 2025-05-14T21:26:55.121Z,1747258015.121 [CommandExec](INFO): Uninitializing the command scheduler. 2025-05-14T21:26:55.122Z,1747258015.122 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:55.217Z,1747258015.217 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-05-14T21:26:55.217Z,1747258015.217 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-05-14T21:26:55.217Z,1747258015.217 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:55.218Z,1747258015.218 [NavChartDb](INFO): Join timeout helper Thread ID is 8366 2025-05-14T21:26:55.278Z,1747258015.278 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:55.278Z,1747258015.278 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:55.297Z,1747258015.297 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-05-14T21:26:55.297Z,1747258015.297 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:55.297Z,1747258015.297 [Radio_Surface](INFO): Join timeout helper Thread ID is 8367 2025-05-14T21:26:55.697Z,1747258015.697 [Radio_Surface](INFO): Powering down 2025-05-14T21:26:55.698Z,1747258015.698 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:55.698Z,1747258015.698 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:55.717Z,1747258015.717 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-05-14T21:26:55.717Z,1747258015.717 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:55.717Z,1747258015.717 [Onboard](INFO): Join timeout helper Thread ID is 8368 2025-05-14T21:26:56.373Z,1747258016.373 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-05-14T21:26:57.337Z,1747258017.337 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:57.337Z,1747258017.337 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.341Z,1747258017.341 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-05-14T21:26:57.341Z,1747258017.341 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.341Z,1747258017.341 [DataOverHttps](INFO): Join timeout helper Thread ID is 8369 2025-05-14T21:26:57.378Z,1747258017.378 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:57.379Z,1747258017.379 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.381Z,1747258017.381 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-05-14T21:26:57.381Z,1747258017.381 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.381Z,1747258017.381 [DAT](INFO): Join timeout helper Thread ID is 8370 2025-05-14T21:26:57.545Z,1747258017.545 [DAT](INFO): Powering down 2025-05-14T21:26:57.618Z,1747258017.618 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:57.618Z,1747258017.618 [DAT](INFO): Powering down 2025-05-14T21:26:57.619Z,1747258017.619 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.640Z,1747258017.640 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-05-14T21:26:57.640Z,1747258017.640 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.641Z,1747258017.641 [BackseatComponent](INFO): Join timeout helper Thread ID is 8371 2025-05-14T21:26:57.778Z,1747258017.778 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:57.779Z,1747258017.779 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.781Z,1747258017.781 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-05-14T21:26:57.781Z,1747258017.781 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:57.782Z,1747258017.782 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8372 2025-05-14T21:26:58.009Z,1747258018.009 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:58.009Z,1747258018.009 [WetLabsBB2FL](INFO): Powering down 2025-05-14T21:26:58.010Z,1747258018.010 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:58.022Z,1747258018.022 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-05-14T21:26:58.022Z,1747258018.022 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:58.022Z,1747258018.022 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8373 2025-05-14T21:26:58.909Z,1747258018.909 [CTD_Seabird](INFO): Powering down 2025-05-14T21:26:58.921Z,1747258018.921 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:58.921Z,1747258018.921 [CTD_Seabird](INFO): Powering down 2025-05-14T21:26:58.933Z,1747258018.933 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:58.962Z,1747258018.962 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-05-14T21:26:58.962Z,1747258018.962 [logger ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:58.962Z,1747258018.962 [logger](INFO): Join timeout helper Thread ID is 8374 2025-05-14T21:26:58.996Z,1747258018.996 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:59.001Z,1747258019.001 [logger ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.010Z,1747258019.010 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-05-14T21:26:59.010Z,1747258019.010 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.010Z,1747258019.010 [CommandLine](INFO): Join timeout helper Thread ID is 8375 2025-05-14T21:26:59.093Z,1747258019.093 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:59.094Z,1747258019.094 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.110Z,1747258019.110 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-05-14T21:26:59.110Z,1747258019.110 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.110Z,1747258019.110 [CommandExec](INFO): Join timeout helper Thread ID is 8376 2025-05-14T21:26:59.111Z,1747258019.111 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-05-14T21:26:59.111Z,1747258019.111 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.112Z,1747258019.112 [controlThread](INFO): Join timeout helper Thread ID is 8377 2025-05-14T21:26:59.129Z,1747258019.129 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-05-14T21:26:59.129Z,1747258019.129 [controlThread](DEBUG): Uninitializing ControlThread 2025-05-14T21:26:59.130Z,1747258019.130 [AHRS_M2](INFO): Powering down 2025-05-14T21:26:59.305Z,1747258019.305 [DVL_micro](INFO): Powering down 2025-05-14T21:26:59.306Z,1747258019.306 [NAL9602](INFO): Powering down 2025-05-14T21:26:59.307Z,1747258019.307 [Sonardyne_Nano](INFO): Powering down 2025-05-14T21:26:59.513Z,1747258019.513 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-05-14T21:26:59.514Z,1747258019.514 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-05-14T21:26:59.514Z,1747258019.514 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-05-14T21:26:59.515Z,1747258019.515 [MissionManager](INFO): Uninitializing Mission Default 2025-05-14T21:26:59.515Z,1747258019.515 [Default] Stopped 2025-05-14T21:26:59.515Z,1747258019.515 [Default](DEBUG): Aggregate::uninitialize Default 2025-05-14T21:26:59.515Z,1747258019.515 [Default:B.GoToSurface] Stopped 2025-05-14T21:26:59.515Z,1747258019.515 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-05-14T21:26:59.515Z,1747258019.515 [Default:CheckIn] Stopped 2025-05-14T21:26:59.515Z,1747258019.515 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-05-14T21:26:59.515Z,1747258019.515 [Default:CheckIn:C.Wait] Stopped 2025-05-14T21:26:59.515Z,1747258019.515 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-05-14T21:26:59.518Z,1747258019.518 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-05-14T21:26:59.518Z,1747258019.518 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-05-14T21:26:59.519Z,1747258019.519 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-05-14T21:26:59.519Z,1747258019.519 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-05-14T21:26:59.519Z,1747258019.519 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-05-14T21:26:59.519Z,1747258019.519 [BuoyancyServo](INFO): Powering down 2025-05-14T21:26:59.533Z,1747258019.533 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-05-14T21:26:59.533Z,1747258019.533 [ElevatorServo](INFO): Powering down 2025-05-14T21:26:59.534Z,1747258019.534 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-05-14T21:26:59.534Z,1747258019.534 [MassServo](INFO): Powering down 2025-05-14T21:26:59.534Z,1747258019.534 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-05-14T21:26:59.535Z,1747258019.535 [RudderServo](INFO): Powering down 2025-05-14T21:26:59.535Z,1747258019.535 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-05-14T21:26:59.535Z,1747258019.536 [ThrusterHE](INFO): Powering down 2025-05-14T21:26:59.536Z,1747258019.536 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-05-14T21:26:59.537Z,1747258019.537 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-05-14T21:26:59.537Z,1747258019.537 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-05-14T21:26:59.537Z,1747258019.537 [CBIT](DEBUG): Powering off loads. 2025-05-14T21:26:59.548Z,1747258019.548 [CBIT](DEBUG): Disabling WDT. 2025-05-14T21:26:59.561Z,1747258019.561 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-05-14T21:26:59.561Z,1747258019.561 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-05-14T21:26:59.562Z,1747258019.562 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.599Z,1747258019.599 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-05-14T21:26:59.599Z,1747258019.599 [GFScanner](DEBUG): Opening all GF detection circuits. 2025-05-14T21:26:59.614Z,1747258019.614 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.621Z,1747258019.621 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.653Z,1747258019.653 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.656Z,1747258019.656 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.664Z,1747258019.664 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.670Z,1747258019.670 [DAT ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.712Z,1747258019.712 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.766Z,1747258019.766 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-05-14T21:26:59.848Z,1747258019.848 [logger ThreadHandler](INFO): Thread cancelled.