2025-07-18T17:53:43.000Z,1752861224.000 [CommandExec](IMPORTANT): got command restart logs
2025-07-18T17:53:54.972Z,1752861234.972 [DataOverHttps](INFO): Moved sent file to Logs/20250718T135352/Courier0034.lzma.bak
2025-07-18T17:53:54.972Z,1752861234.972 [DataOverHttps](INFO): SBD MOMSN=25545931
2025-07-18T17:54:07.218Z,1752861247.218 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T17:54:23.485Z,1752861263.485 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20250718T135352/Courier0037.lzma
2025-07-18T17:54:34.552Z,1752861274.552 [DataOverHttps](INFO): Moved sent file to Logs/20250718T135352/Courier0037.lzma.bak
2025-07-18T17:54:34.552Z,1752861274.552 [DataOverHttps](INFO): SBD MOMSN=25545942
2025-07-18T17:55:00.438Z,1752861300.438 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20250718T135352/Express0035.lzma
2025-07-18T17:55:11.480Z,1752861311.480 [DataOverHttps](INFO): Moved sent file to Logs/20250718T135352/Express0035.lzma.bak
2025-07-18T17:55:11.480Z,1752861311.480 [DataOverHttps](INFO): SBD MOMSN=25545944
2025-07-18T17:55:37.274Z,1752861337.274 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250718T135352/Express0038.lzma
2025-07-18T17:55:48.316Z,1752861348.316 [DataOverHttps](INFO): Moved sent file to Logs/20250718T135352/Express0038.lzma.bak
2025-07-18T17:55:48.316Z,1752861348.316 [DataOverHttps](INFO): SBD MOMSN=25545949
2025-07-18T17:55:49.842Z,1752861349.842 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T17:55:49.843Z,1752861349.843 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T17:55:49.843Z,1752861349.843 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:00:50.425Z,1752861650.425 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:00:50.425Z,1752861650.425 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:00:50.425Z,1752861650.425 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:00:50.425Z,1752861650.425 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:00:50.831Z,1752861650.831 [Default:CheckIn:D] Stopped
2025-07-18T18:00:50.831Z,1752861650.831 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  18.064866 min 
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn:E] Stopped
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn] Stopped
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn](INFO): Running loop #2
2025-07-18T18:00:51.247Z,1752861651.247 [Default:CheckIn] Running Loop=2
2025-07-18T18:00:51.248Z,1752861651.248 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:00:51.248Z,1752861651.248 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:00:53.245Z,1752861653.245 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180052.00,A,3647.95706,N,12150.27545,W,1.652,257.94,180725,,,D*7E
2025-07-18T18:00:53.247Z,1752861653.247 [NAL9602](INFO): GPS fix at 20250718T180052: (36.799284, -121.837924)
2025-07-18T18:00:53.257Z,1752861653.257 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:00:53.257Z,1752861653.257 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:01:00.798Z,1752861660.798 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20250718T175343/Courier0003.lzma
2025-07-18T18:01:11.852Z,1752861671.852 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0003.lzma.bak
2025-07-18T18:01:11.852Z,1752861671.852 [DataOverHttps](INFO): SBD MOMSN=25545958
2025-07-18T18:01:25.155Z,1752861685.155 [NAL9602](INFO): SBD MO Status=2, MOMSN=10198, MT Status=2, MTMSN=0
2025-07-18T18:01:25.156Z,1752861685.156 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:01:37.651Z,1752861697.651 [DataOverHttps](INFO): Sending 491 bytes from file Logs/20250718T175343/Express0004.lzma
2025-07-18T18:01:45.356Z,1752861705.356 [NAL9602](INFO): SBD MO Status=0, MOMSN=10198, MT Status=0, MTMSN=0
2025-07-18T18:01:45.356Z,1752861705.356 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:01:48.692Z,1752861708.692 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0004.lzma.bak
2025-07-18T18:01:48.692Z,1752861708.692 [DataOverHttps](INFO): SBD MOMSN=25545962
2025-07-18T18:01:50.219Z,1752861710.219 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:01:50.219Z,1752861710.219 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:01:50.219Z,1752861710.219 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:02:16.060Z,1752861736.060 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:06:50.805Z,1752862010.805 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:06:50.805Z,1752862010.805 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:06:50.805Z,1752862010.805 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:06:50.806Z,1752862010.806 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:06:51.220Z,1752862011.220 [Default:CheckIn:D] Stopped
2025-07-18T18:06:51.221Z,1752862011.221 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  24.071358 min 
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn:E] Stopped
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn] Stopped
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn](INFO): Running loop #3
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn] Running Loop=3
2025-07-18T18:06:51.629Z,1752862011.629 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:06:51.630Z,1752862011.630 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:06:53.626Z,1752862013.626 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180652.00,A,3647.96305,N,12150.23322,W,1.050,77.83,180725,,,D*4D
2025-07-18T18:06:53.628Z,1752862013.628 [NAL9602](INFO): GPS fix at 20250718T180652: (36.799384, -121.837220)
2025-07-18T18:06:53.639Z,1752862013.639 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:06:53.639Z,1752862013.639 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:07:01.586Z,1752862021.586 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20250718T175343/Courier0006.lzma
2025-07-18T18:07:07.769Z,1752862027.769 [NAL9602](INFO): SBD MO Status=0, MOMSN=10199, MT Status=0, MTMSN=0
2025-07-18T18:07:07.769Z,1752862027.769 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:07:12.628Z,1752862032.628 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0006.lzma.bak
2025-07-18T18:07:12.628Z,1752862032.628 [DataOverHttps](INFO): SBD MOMSN=25545973
2025-07-18T18:07:38.426Z,1752862058.426 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20250718T175343/Express0007.lzma
2025-07-18T18:07:38.473Z,1752862058.473 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:07:51.476Z,1752862071.476 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0007.lzma.bak
2025-07-18T18:07:51.476Z,1752862071.476 [DataOverHttps](INFO): SBD MOMSN=25545977
2025-07-18T18:07:53.025Z,1752862073.025 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:07:53.025Z,1752862073.025 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:07:53.025Z,1752862073.025 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:09:13.105Z,1752862153.105 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.090015
2025-07-18T18:10:02.878Z,1752862202.878 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002594
2025-07-18T18:11:20.930Z,1752862280.930 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-07-18T18:11:33.393Z,1752862293.393 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=61.032928
2025-07-18T18:12:23.910Z,1752862343.910 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002593
2025-07-18T18:12:53.597Z,1752862373.597 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:12:53.597Z,1752862373.597 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:12:53.597Z,1752862373.597 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:12:53.597Z,1752862373.597 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:12:54.005Z,1752862374.005 [Default:CheckIn:D] Stopped
2025-07-18T18:12:54.005Z,1752862374.005 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  30.117761 min 
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn:E] Stopped
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn] Stopped
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn](INFO): Running loop #4
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn] Running Loop=4
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:12:54.408Z,1752862374.408 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:12:56.418Z,1752862376.418 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181255.00,A,3647.99203,N,12150.12846,W,0.700,70.63,180725,,,D*46
2025-07-18T18:12:56.420Z,1752862376.420 [NAL9602](INFO): GPS fix at 20250718T181255: (36.799867, -121.835474)
2025-07-18T18:12:56.447Z,1752862376.447 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:12:56.447Z,1752862376.447 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:13:07.459Z,1752862387.459 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-07-18T18:13:21.882Z,1752862401.882 [NAL9602](INFO): SBD MO Status=2, MOMSN=10200, MT Status=2, MTMSN=0
2025-07-18T18:13:21.883Z,1752862401.883 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:13:24.528Z,1752862404.528 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.620327
2025-07-18T18:14:30.806Z,1752862470.806 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:15:15.801Z,1752862515.801 [NAL9602](INFO): SBD MO Status=0, MOMSN=10200, MT Status=0, MTMSN=0
2025-07-18T18:15:15.801Z,1752862515.801 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:15:41.102Z,1752862541.102 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:15:41.697Z,1752862541.697 [NAL9602](INFO): SBD MO Status=2, MOMSN=10201, MT Status=2, MTMSN=0
2025-07-18T18:15:41.697Z,1752862541.697 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:16:09.213Z,1752862569.213 [NAL9602](INFO): SBD MO Status=1, MOMSN=10201, MT Status=0, MTMSN=0
2025-07-18T18:16:09.270Z,1752862569.270 [NAL9602](INFO): Sent 72 bytes from file Logs/20250718T175343/Courier0009.lzma
2025-07-18T18:16:09.271Z,1752862569.271 [NAL9602](INFO): Packets left to send: 0
2025-07-18T18:16:16.242Z,1752862576.242 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:16:16.535Z,1752862576.535 [NAL9602](INFO): SBD MO Status=1, MOMSN=10202, MT Status=0, MTMSN=0
2025-07-18T18:16:16.594Z,1752862576.594 [NAL9602](INFO): Sent 166 bytes from file Logs/20250718T175343/Express0010.lzma
2025-07-18T18:16:16.595Z,1752862576.595 [NAL9602](INFO): Packets left to send: 0
2025-07-18T18:16:40.775Z,1752862600.775 [NAL9602](INFO): SBD MO Status=0, MOMSN=10203, MT Status=0, MTMSN=0
2025-07-18T18:16:40.853Z,1752862600.853 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:16:40.853Z,1752862600.853 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:16:40.853Z,1752862600.853 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:16:51.386Z,1752862611.386 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:17:11.477Z,1752862631.477 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:17:26.526Z,1752862646.526 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:18:01.674Z,1752862681.674 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:18:36.814Z,1752862716.814 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:19:11.954Z,1752862751.954 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:19:47.094Z,1752862787.094 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:20:22.263Z,1752862822.263 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-07-18T18:20:47.734Z,1752862847.734 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002731
2025-07-18T18:21:41.382Z,1752862901.382 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:21:41.382Z,1752862901.382 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:21:41.382Z,1752862901.382 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:21:41.383Z,1752862901.383 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:21:41.790Z,1752862901.790 [Default:CheckIn:D] Stopped
2025-07-18T18:21:41.790Z,1752862901.790 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:21:42.177Z,1752862902.177 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  38.914115 min 
2025-07-18T18:21:42.178Z,1752862902.178 [Default:CheckIn:E] Stopped
2025-07-18T18:21:42.178Z,1752862902.178 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:21:42.178Z,1752862902.178 [Default:CheckIn] Stopped
2025-07-18T18:21:42.210Z,1752862902.210 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:21:42.210Z,1752862902.210 [Default:CheckIn](INFO): Running loop #5
2025-07-18T18:21:42.210Z,1752862902.210 [Default:CheckIn] Running Loop=5
2025-07-18T18:21:42.211Z,1752862902.211 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:21:42.211Z,1752862902.211 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:21:44.202Z,1752862904.202 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182143.00,A,3647.98199,N,12150.29135,W,1.166,71.63,180725,,,D*43
2025-07-18T18:21:44.204Z,1752862904.204 [NAL9602](INFO): GPS fix at 20250718T182143: (36.799700, -121.838189)
2025-07-18T18:21:44.287Z,1752862904.287 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:21:44.287Z,1752862904.287 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:21:45.883Z,1752862905.883 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250718T175343/Courier0012.lzma
2025-07-18T18:21:56.660Z,1752862916.660 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0012.lzma.bak
2025-07-18T18:21:56.660Z,1752862916.660 [DataOverHttps](INFO): SBD MOMSN=25546005
2025-07-18T18:22:03.505Z,1752862923.505 [NAL9602](INFO): SBD MO Status=2, MOMSN=10204, MT Status=2, MTMSN=0
2025-07-18T18:22:03.505Z,1752862923.505 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:22:21.281Z,1752862941.281 [NAL9602](INFO): SBD MO Status=0, MOMSN=10204, MT Status=0, MTMSN=0
2025-07-18T18:22:21.281Z,1752862941.281 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:22:22.634Z,1752862942.634 [DataOverHttps](INFO): Sending 163 bytes from file Logs/20250718T175343/Express0013.lzma
2025-07-18T18:22:33.676Z,1752862953.676 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0013.lzma.bak
2025-07-18T18:22:33.676Z,1752862953.676 [DataOverHttps](INFO): SBD MOMSN=25546008
2025-07-18T18:22:35.034Z,1752862955.034 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:22:35.034Z,1752862955.034 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:22:35.034Z,1752862955.034 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:22:51.987Z,1752862971.987 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:25:06.907Z,1752863106.907 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.746475
2025-07-18T18:26:02.195Z,1752863162.195 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-07-18T18:26:32.651Z,1752863192.651 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002748
2025-07-18T18:27:13.330Z,1752863233.330 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting.
2025-07-18T18:27:32.781Z,1752863252.781 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.133404
2025-07-18T18:27:35.597Z,1752863255.597 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:27:35.597Z,1752863255.597 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:27:35.598Z,1752863255.598 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:27:35.598Z,1752863255.598 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:27:36.003Z,1752863256.003 [Default:CheckIn:D] Stopped
2025-07-18T18:27:36.003Z,1752863256.003 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  44.817733 min 
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn:E] Stopped
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn] Stopped
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn](INFO): Running loop #6
2025-07-18T18:27:36.409Z,1752863256.409 [Default:CheckIn] Running Loop=6
2025-07-18T18:27:36.410Z,1752863256.410 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:27:36.410Z,1752863256.410 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:27:38.441Z,1752863258.441 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182737.00,A,3648.18892,N,12147.93360,W,26.184,76.18,180725,,,D*74
2025-07-18T18:27:38.443Z,1752863258.443 [NAL9602](INFO): GPS fix at 20250718T182737: (36.803149, -121.798893)
2025-07-18T18:27:38.453Z,1752863258.453 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:27:38.453Z,1752863258.453 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:28:00.273Z,1752863280.273 [NAL9602](INFO): SBD MO Status=2, MOMSN=10205, MT Status=2, MTMSN=0
2025-07-18T18:28:00.273Z,1752863280.273 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:28:11.322Z,1752863291.322 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002611
2025-07-18T18:28:18.635Z,1752863298.635 [NAL9602](INFO): SBD MO Status=1, MOMSN=10205, MT Status=0, MTMSN=0
2025-07-18T18:28:18.684Z,1752863298.684 [NAL9602](INFO): Sent 73 bytes from file Logs/20250718T175343/Courier0015.lzma
2025-07-18T18:28:18.684Z,1752863298.684 [NAL9602](INFO): Packets left to send: 0
2025-07-18T18:28:19.686Z,1752863299.686 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250718T175343/Express0016.lzma
2025-07-18T18:28:21.850Z,1752863301.850 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:28:22.266Z,1752863302.266 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:28:30.572Z,1752863310.572 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0016.lzma.bak
2025-07-18T18:28:30.572Z,1752863310.572 [DataOverHttps](INFO): SBD MOMSN=25546019
2025-07-18T18:28:31.983Z,1752863311.983 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:28:31.984Z,1752863311.984 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:28:31.984Z,1752863311.984 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:28:36.806Z,1752863316.806 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:28:37.220Z,1752863317.220 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:28:49.324Z,1752863329.324 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:28:51.345Z,1752863331.345 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:28:52.554Z,1752863332.554 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:06.291Z,1752863346.291 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:08.311Z,1752863348.311 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:21.642Z,1752863361.642 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:23.272Z,1752863363.272 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:37.398Z,1752863377.398 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:38.612Z,1752863378.612 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:52.752Z,1752863392.752 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:29:53.571Z,1752863393.571 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:30:07.698Z,1752863407.698 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:30:08.911Z,1752863408.911 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:30:23.051Z,1752863423.051 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-07-18T18:30:23.865Z,1752863423.865 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:30:38.044Z,1752863438.044 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-07-18T18:30:38.818Z,1752863438.818 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-07-18T18:30:38.820Z,1752863438.820 [BPC1](ERROR): BPC1B: No match for serial number FFFF in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-07-18T18:30:38.825Z,1752863438.825 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5.
2025-07-18T18:30:38.828Z,1752863438.828 [BPC1](INFO): Received data from all battery sticks.
2025-07-18T18:33:32.548Z,1752863612.548 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:33:32.548Z,1752863612.548 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:33:32.548Z,1752863612.548 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:33:32.549Z,1752863612.549 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:33:32.961Z,1752863612.961 [Default:CheckIn:D] Stopped
2025-07-18T18:33:32.961Z,1752863612.961 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  50.767037 min 
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn:E] Stopped
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn] Stopped
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn](INFO): Running loop #7
2025-07-18T18:33:33.351Z,1752863613.351 [Default:CheckIn] Running Loop=7
2025-07-18T18:33:33.352Z,1752863613.352 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:33:33.352Z,1752863613.352 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:33:35.357Z,1752863615.357 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183334.00,A,3648.31542,N,12147.12976,W,4.276,185.60,180725,,,D*71
2025-07-18T18:33:35.361Z,1752863615.361 [NAL9602](INFO): GPS fix at 20250718T183334: (36.805257, -121.785496)
2025-07-18T18:33:35.390Z,1752863615.390 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:33:35.390Z,1752863615.390 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:33:42.706Z,1752863622.706 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20250718T175343/Courier0018.lzma
2025-07-18T18:33:53.748Z,1752863633.748 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0018.lzma.bak
2025-07-18T18:33:53.748Z,1752863633.748 [DataOverHttps](INFO): SBD MOMSN=25546031
2025-07-18T18:33:56.807Z,1752863636.807 [NAL9602](INFO): SBD MO Status=2, MOMSN=10206, MT Status=2, MTMSN=0
2025-07-18T18:33:56.808Z,1752863636.808 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:34:06.071Z,1752863646.071 [NAL9602](INFO): SBD MO Status=0, MOMSN=10206, MT Status=0, MTMSN=0
2025-07-18T18:34:06.072Z,1752863646.072 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:34:19.946Z,1752863659.946 [DataOverHttps](INFO): Sending 166 bytes from file Logs/20250718T175343/Express0019.lzma
2025-07-18T18:34:30.988Z,1752863670.988 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0019.lzma.bak
2025-07-18T18:34:30.988Z,1752863670.988 [DataOverHttps](INFO): SBD MOMSN=25546035
2025-07-18T18:34:32.340Z,1752863672.340 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:34:32.340Z,1752863672.340 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:34:32.340Z,1752863672.340 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:34:36.763Z,1752863676.763 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:39:32.912Z,1752863972.912 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:39:32.912Z,1752863972.912 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:39:32.912Z,1752863972.912 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:39:32.913Z,1752863972.913 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:39:33.310Z,1752863973.310 [Default:CheckIn:D] Stopped
2025-07-18T18:39:33.310Z,1752863973.310 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  56.772847 min 
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn:E] Stopped
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn] Stopped
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn](INFO): Running loop #8
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn] Running Loop=8
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:39:33.720Z,1752863973.720 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:39:35.726Z,1752863975.726 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183934.00,A,3648.15287,N,12147.22044,W,0.097,199.85,180725,,,D*77
2025-07-18T18:39:35.728Z,1752863975.728 [NAL9602](INFO): GPS fix at 20250718T183934: (36.802548, -121.787007)
2025-07-18T18:39:35.759Z,1752863975.759 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:39:35.759Z,1752863975.759 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:39:43.302Z,1752863983.302 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250718T175343/Courier0021.lzma
2025-07-18T18:39:54.344Z,1752863994.344 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0021.lzma.bak
2025-07-18T18:39:54.344Z,1752863994.344 [DataOverHttps](INFO): SBD MOMSN=25546045
2025-07-18T18:40:08.857Z,1752864008.857 [NAL9602](INFO): SBD MO Status=0, MOMSN=10207, MT Status=0, MTMSN=0
2025-07-18T18:40:08.857Z,1752864008.857 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:40:21.306Z,1752864021.306 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20250718T175343/Express0022.lzma
2025-07-18T18:40:32.348Z,1752864032.348 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0022.lzma.bak
2025-07-18T18:40:32.348Z,1752864032.348 [DataOverHttps](INFO): SBD MOMSN=25546054
2025-07-18T18:40:33.932Z,1752864033.932 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:40:33.932Z,1752864033.932 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:40:33.932Z,1752864033.932 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:40:39.560Z,1752864039.560 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:45:34.519Z,1752864334.519 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:45:34.519Z,1752864334.519 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:45:34.519Z,1752864334.519 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:45:34.520Z,1752864334.520 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:45:34.931Z,1752864334.931 [Default:CheckIn:D] Stopped
2025-07-18T18:45:34.931Z,1752864334.931 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  62.799862 min 
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn:E] Stopped
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn] Stopped
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn](INFO): Running loop #9
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn] Running Loop=9
2025-07-18T18:45:35.359Z,1752864335.359 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:45:35.360Z,1752864335.360 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:45:37.324Z,1752864337.324 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184536.00,A,3648.15481,N,12147.21971,W,0.019,199.85,180725,,,A*71
2025-07-18T18:45:37.327Z,1752864337.327 [NAL9602](INFO): GPS fix at 20250718T184536: (36.802580, -121.786995)
2025-07-18T18:45:37.337Z,1752864337.337 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:45:37.337Z,1752864337.337 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:45:45.558Z,1752864345.558 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250718T175343/Courier0024.lzma
2025-07-18T18:45:56.600Z,1752864356.600 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0024.lzma.bak
2025-07-18T18:45:56.600Z,1752864356.600 [DataOverHttps](INFO): SBD MOMSN=25546065
2025-07-18T18:46:18.949Z,1752864378.949 [NAL9602](INFO): SBD MO Status=2, MOMSN=10208, MT Status=2, MTMSN=0
2025-07-18T18:46:18.949Z,1752864378.949 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T18:46:22.530Z,1752864382.530 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20250718T175343/Express0025.lzma
2025-07-18T18:46:29.457Z,1752864389.457 [NAL9602](INFO): SBD MO Status=0, MOMSN=10208, MT Status=0, MTMSN=0
2025-07-18T18:46:29.457Z,1752864389.457 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:46:33.572Z,1752864393.572 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0025.lzma.bak
2025-07-18T18:46:33.573Z,1752864393.573 [DataOverHttps](INFO): SBD MOMSN=25546068
2025-07-18T18:46:35.122Z,1752864395.122 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:46:35.122Z,1752864395.122 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:46:35.122Z,1752864395.122 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:47:00.180Z,1752864420.180 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:51:35.703Z,1752864695.703 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:51:35.703Z,1752864695.703 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:51:35.703Z,1752864695.703 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:51:35.703Z,1752864695.703 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:51:36.101Z,1752864696.101 [Default:CheckIn:D] Stopped
2025-07-18T18:51:36.101Z,1752864696.101 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  68.819360 min 
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn:E] Stopped
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn] Stopped
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn](INFO): Running loop #10
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn] Running Loop=10
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:51:36.501Z,1752864696.501 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:51:38.516Z,1752864698.516 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185137.00,A,3648.17919,N,12147.27755,W,0.058,296.44,180725,,,D*74
2025-07-18T18:51:38.519Z,1752864698.519 [NAL9602](INFO): GPS fix at 20250718T185137: (36.802987, -121.787959)
2025-07-18T18:51:38.529Z,1752864698.529 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:51:38.529Z,1752864698.529 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:51:47.874Z,1752864707.874 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250718T175343/Courier0027.lzma
2025-07-18T18:51:58.734Z,1752864718.734 [NAL9602](INFO): SBD MO Status=0, MOMSN=10209, MT Status=0, MTMSN=0
2025-07-18T18:51:58.734Z,1752864718.734 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:51:58.917Z,1752864718.917 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0027.lzma.bak
2025-07-18T18:51:58.918Z,1752864718.918 [DataOverHttps](INFO): SBD MOMSN=25546078
2025-07-18T18:52:24.766Z,1752864744.766 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20250718T175343/Express0028.lzma
2025-07-18T18:52:29.435Z,1752864749.435 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T18:52:35.808Z,1752864755.808 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0028.lzma.bak
2025-07-18T18:52:35.808Z,1752864755.808 [DataOverHttps](INFO): SBD MOMSN=25546081
2025-07-18T18:52:37.132Z,1752864757.132 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:52:37.133Z,1752864757.133 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:52:37.133Z,1752864757.133 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:57:37.713Z,1752865057.713 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T18:57:37.713Z,1752865057.713 [Default:CheckIn:C.Wait] Stopped
2025-07-18T18:57:37.713Z,1752865057.713 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T18:57:37.713Z,1752865057.713 [Default:CheckIn:D] Running Loop=1
2025-07-18T18:57:38.118Z,1752865058.118 [Default:CheckIn:D] Stopped
2025-07-18T18:57:38.119Z,1752865058.119 [Default:CheckIn:E] Running Loop=1
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  74.852987 min 
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn:E] Stopped
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn] Stopped
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn](INFO): Running loop #11
2025-07-18T18:57:38.532Z,1752865058.532 [Default:CheckIn] Running Loop=11
2025-07-18T18:57:38.533Z,1752865058.533 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T18:57:38.533Z,1752865058.533 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T18:57:40.538Z,1752865060.538 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185739.00,A,3648.18330,N,12147.27755,W,0.039,345.14,180725,,,D*7F
2025-07-18T18:57:40.540Z,1752865060.540 [NAL9602](INFO): GPS fix at 20250718T185739: (36.803055, -121.787959)
2025-07-18T18:57:40.569Z,1752865060.569 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T18:57:40.569Z,1752865060.569 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T18:57:50.286Z,1752865070.286 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250718T175343/Courier0030.lzma
2025-07-18T18:58:01.328Z,1752865081.328 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0030.lzma.bak
2025-07-18T18:58:01.328Z,1752865081.328 [DataOverHttps](INFO): SBD MOMSN=25546091
2025-07-18T18:58:27.374Z,1752865107.374 [DataOverHttps](INFO): Sending 154 bytes from file Logs/20250718T175343/Express0031.lzma
2025-07-18T18:58:39.421Z,1752865119.421 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0031.lzma.bak
2025-07-18T18:58:39.421Z,1752865119.421 [DataOverHttps](INFO): SBD MOMSN=25546094
2025-07-18T18:58:40.762Z,1752865120.762 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T18:58:40.762Z,1752865120.762 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T18:58:40.762Z,1752865120.762 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T18:59:00.947Z,1752865140.947 [NAL9602](INFO): SBD MO Status=0, MOMSN=10210, MT Status=0, MTMSN=0
2025-07-18T18:59:00.947Z,1752865140.947 [NAL9602](INFO): No messages in MT queue
2025-07-18T18:59:31.651Z,1752865171.651 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T19:03:41.338Z,1752865421.338 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T19:03:41.338Z,1752865421.338 [Default:CheckIn:C.Wait] Stopped
2025-07-18T19:03:41.354Z,1752865421.354 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T19:03:41.354Z,1752865421.354 [Default:CheckIn:D] Running Loop=1
2025-07-18T19:03:41.745Z,1752865421.745 [Default:CheckIn:D] Stopped
2025-07-18T19:03:41.745Z,1752865421.745 [Default:CheckIn:E] Running Loop=1
2025-07-18T19:03:42.144Z,1752865422.144 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  80.913428 min 
2025-07-18T19:03:42.144Z,1752865422.144 [Default:CheckIn:E] Stopped
2025-07-18T19:03:42.144Z,1752865422.144 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T19:03:42.144Z,1752865422.144 [Default:CheckIn] Stopped
2025-07-18T19:03:42.144Z,1752865422.144 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T19:03:42.144Z,1752865422.144 [Default:CheckIn](INFO): Running loop #12
2025-07-18T19:03:42.145Z,1752865422.145 [Default:CheckIn] Running Loop=12
2025-07-18T19:03:42.145Z,1752865422.145 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T19:03:42.145Z,1752865422.145 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T19:03:44.163Z,1752865424.163 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190343.00,A,3648.18523,N,12147.27872,W,0.136,345.14,180725,,,A*77
2025-07-18T19:03:44.165Z,1752865424.165 [NAL9602](INFO): GPS fix at 20250718T190343: (36.803087, -121.787979)
2025-07-18T19:03:44.195Z,1752865424.195 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T19:03:44.195Z,1752865424.195 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T19:03:51.014Z,1752865431.014 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250718T175343/Courier0033.lzma
2025-07-18T19:04:02.056Z,1752865442.056 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0033.lzma.bak
2025-07-18T19:04:02.056Z,1752865442.056 [DataOverHttps](INFO): SBD MOMSN=25546104
2025-07-18T19:04:13.893Z,1752865453.893 [NAL9602](INFO): SBD MO Status=2, MOMSN=10211, MT Status=2, MTMSN=0
2025-07-18T19:04:13.893Z,1752865453.893 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T19:04:28.022Z,1752865468.022 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250718T175343/Express0034.lzma
2025-07-18T19:04:41.072Z,1752865481.072 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0034.lzma.bak
2025-07-18T19:04:41.072Z,1752865481.072 [DataOverHttps](INFO): SBD MOMSN=25546107
2025-07-18T19:04:42.593Z,1752865482.593 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T19:04:42.593Z,1752865482.593 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T19:04:42.594Z,1752865482.594 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T19:05:06.811Z,1752865506.811 [NAL9602](INFO): SBD MO Status=0, MOMSN=10211, MT Status=0, MTMSN=0
2025-07-18T19:05:06.811Z,1752865506.811 [NAL9602](INFO): No messages in MT queue
2025-07-18T19:05:37.534Z,1752865537.534 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T19:09:43.199Z,1752865783.199 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T19:09:43.199Z,1752865783.199 [Default:CheckIn:C.Wait] Stopped
2025-07-18T19:09:43.199Z,1752865783.199 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T19:09:43.199Z,1752865783.199 [Default:CheckIn:D] Running Loop=1
2025-07-18T19:09:43.620Z,1752865783.620 [Default:CheckIn:D] Stopped
2025-07-18T19:09:43.620Z,1752865783.620 [Default:CheckIn:E] Running Loop=1
2025-07-18T19:09:44.003Z,1752865784.003 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  86.944678 min 
2025-07-18T19:09:44.003Z,1752865784.003 [Default:CheckIn:E] Stopped
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn] Stopped
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn](INFO): Running loop #13
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn] Running Loop=13
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T19:09:44.004Z,1752865784.004 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T19:09:46.005Z,1752865786.005 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190945.00,A,3648.16730,N,12147.27918,W,0.311,207.40,180725,,,A*79
2025-07-18T19:09:46.008Z,1752865786.008 [NAL9602](INFO): GPS fix at 20250718T190945: (36.802788, -121.787986)
2025-07-18T19:09:46.017Z,1752865786.017 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T19:09:46.018Z,1752865786.018 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-07-18T19:09:53.074Z,1752865793.074 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250718T175343/Courier0036.lzma
2025-07-18T19:10:04.116Z,1752865804.116 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Courier0036.lzma.bak
2025-07-18T19:10:04.116Z,1752865804.116 [DataOverHttps](INFO): SBD MOMSN=25546117
2025-07-18T19:10:09.446Z,1752865809.446 [NAL9602](INFO): SBD MO Status=2, MOMSN=10212, MT Status=2, MTMSN=0
2025-07-18T19:10:09.446Z,1752865809.446 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-07-18T19:10:30.002Z,1752865830.002 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20250718T175343/Express0037.lzma
2025-07-18T19:10:41.045Z,1752865841.045 [DataOverHttps](INFO): Moved sent file to Logs/20250718T175343/Express0037.lzma.bak
2025-07-18T19:10:41.045Z,1752865841.045 [DataOverHttps](INFO): SBD MOMSN=25546120
2025-07-18T19:10:42.581Z,1752865842.581 [Default:CheckIn:Read_Iridium] Stopped
2025-07-18T19:10:42.582Z,1752865842.582 [Default:CheckIn:C.Wait] Running Loop=1
2025-07-18T19:10:42.582Z,1752865842.582 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-07-18T19:14:24.275Z,1752866064.275 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:14:24.396Z,1752866064.396 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:14:28.833Z,1752866068.833 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.071347
CHAN A1 (24V): 0.087050
CHAN A2 (12V): 0.035108
CHAN A3 (5V): 0.006286
CHAN B0 (3.3V): 0.005063
CHAN B1 (3.15aV): 0.004265
CHAN B2 (3.15bV): 0.004365
CHAN B3 (GND): -0.007670
OPEN: 0.006940
Full Scale: +/- 1 mA
2025-07-18T19:14:48.209Z,1752866088.209 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-07-18T19:14:49.299Z,1752866089.299 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:14:49.434Z,1752866089.434 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:14:53.919Z,1752866093.919 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.071135
CHAN A1 (24V): 0.086750
CHAN A2 (12V): 0.034764
CHAN A3 (5V): 0.006736
CHAN B0 (3.3V): 0.004514
CHAN B1 (3.15aV): 0.004568
CHAN B2 (3.15bV): 0.004262
CHAN B3 (GND): -0.008263
OPEN: 0.006369
Full Scale: +/- 1 mA
2025-07-18T19:14:57.007Z,1752866097.007 [CommandExec](IMPORTANT): got command failComponent
2025-07-18T19:14:57.008Z,1752866097.008 [CommandExec](IMPORTANT): Failed components:
2025-07-18T19:14:57.009Z,1752866097.009 [CommandExec](IMPORTANT): No failed Components.
2025-07-18T19:15:18.900Z,1752866118.900 [NAL9602](INFO): Not Powering down - fast GPS
2025-07-18T19:15:36.316Z,1752866136.316 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadc3
2025-07-18T19:15:39.335Z,1752866139.335 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:15:39.524Z,1752866139.524 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:15:43.151Z,1752866143.151 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-07-18T19:15:43.152Z,1752866143.152 [Default:CheckIn:C.Wait] Stopped
2025-07-18T19:15:43.152Z,1752866143.152 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-07-18T19:15:43.152Z,1752866143.152 [Default:CheckIn:D] Running Loop=1
2025-07-18T19:15:43.561Z,1752866143.561 [Default:CheckIn:D] Stopped
2025-07-18T19:15:43.561Z,1752866143.561 [Default:CheckIn:E] Running Loop=1
2025-07-18T19:15:43.957Z,1752866143.957 [Default:CheckIn:E](IMPORTANT): Default mission has been running for  92.943701 min 
2025-07-18T19:15:43.957Z,1752866143.957 [Default:CheckIn:E] Stopped
2025-07-18T19:15:43.958Z,1752866143.958 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-07-18T19:15:43.958Z,1752866143.958 [Default:CheckIn] Stopped
2025-07-18T19:15:43.958Z,1752866143.958 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T19:15:43.958Z,1752866143.958 [Default:CheckIn](INFO): Running loop #14
2025-07-18T19:15:43.958Z,1752866143.958 [Default:CheckIn] Running Loop=14
2025-07-18T19:15:43.958Z,1752866143.958 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-07-18T19:15:43.959Z,1752866143.959 [Default:CheckIn:Read_GPS] Running Loop=1
2025-07-18T19:15:43.000Z,1752866144.000 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.067718
CHAN A1 (24V): 0.086656
CHAN A2 (12V): 0.034652
CHAN A3 (5V): 0.005297
CHAN B0 (3.3V): 0.004208
CHAN B1 (3.15aV): 0.004169
CHAN B2 (3.15bV): 0.004268
CHAN B3 (GND): -0.007938
OPEN: 0.007203
Full Scale: +/- 1 mA
2025-07-18T19:15:52.155Z,1752866152.155 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:15:52.454Z,1752866152.454 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:15:56.923Z,1752866156.923 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.072848
CHAN A1 (24V): 0.086168
CHAN A2 (12V): 0.034610
CHAN A3 (5V): 0.006032
CHAN B0 (3.3V): 0.004474
CHAN B1 (3.15aV): 0.004540
CHAN B2 (3.15bV): 0.004884
CHAN B3 (GND): -0.008185
OPEN: 0.006750
Full Scale: +/- 1 mA
2025-07-18T19:16:01.637Z,1752866161.637 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3
2025-07-18T19:16:07.147Z,1752866167.147 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:16:07.436Z,1752866167.436 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:16:11.853Z,1752866171.853 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.031976
CHAN A1 (24V): 0.029222
CHAN A2 (12V): 0.008791
CHAN A3 (5V): -0.002643
CHAN B0 (3.3V): -0.000613
CHAN B1 (3.15aV): -0.000063
CHAN B2 (3.15bV): -0.000660
CHAN B3 (GND): -0.003141
OPEN: 0.005341
Full Scale: +/- 1 mA
2025-07-18T19:16:16.681Z,1752866176.681 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-07-18T19:16:16.758Z,1752866176.758 [NAL9602](ERROR): received: 
+CSQ:0

OK212, 2, 0, 0, 0

OK
2025-07-18T19:16:19.655Z,1752866179.655 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:16:19.933Z,1752866179.933 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:16:24.373Z,1752866184.373 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.032132
CHAN A1 (24V): 0.029012
CHAN A2 (12V): 0.009235
CHAN A3 (5V): -0.001397
CHAN B0 (3.3V): 0.000353
CHAN B1 (3.15aV): -0.000187
CHAN B2 (3.15bV): -0.000129
CHAN B3 (GND): -0.004486
OPEN: 0.005099
Full Scale: +/- 1 mA
2025-07-18T19:16:28.711Z,1752866188.711 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:16:28.815Z,1752866188.815 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:16:33.295Z,1752866193.295 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.031337
CHAN A1 (24V): 0.028206
CHAN A2 (12V): 0.007473
CHAN A3 (5V): -0.001725
CHAN B0 (3.3V): 0.000066
CHAN B1 (3.15aV): -0.000997
CHAN B2 (3.15bV): -0.000561
CHAN B3 (GND): -0.004286
OPEN: 0.005402
Full Scale: +/- 1 mA
2025-07-18T19:16:38.311Z,1752866198.311 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:16:38.536Z,1752866198.536 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:16:43.019Z,1752866203.019 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.027262
CHAN A1 (24V): 0.028123
CHAN A2 (12V): 0.008288
CHAN A3 (5V): -0.002510
CHAN B0 (3.3V): -0.000039
CHAN B1 (3.15aV): -0.000552
CHAN B2 (3.15bV): 0.000714
CHAN B3 (GND): -0.004979
OPEN: 0.005161
Full Scale: +/- 1 mA
2025-07-18T19:16:45.487Z,1752866205.487 [CommandExec](IMPORTANT): got command failComponent
2025-07-18T19:16:45.487Z,1752866205.487 [CommandExec](IMPORTANT): Failed components:
2025-07-18T19:16:45.487Z,1752866205.487 [CommandExec](IMPORTANT): No failed Components.
2025-07-18T19:16:52.887Z,1752866212.887 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:16:53.054Z,1752866213.054 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:16:57.523Z,1752866217.523 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.026909
CHAN A1 (24V): 0.028009
CHAN A2 (12V): 0.007967
CHAN A3 (5V): -0.003819
CHAN B0 (3.3V): -0.001205
CHAN B1 (3.15aV): -0.000984
CHAN B2 (3.15bV): -0.000985
CHAN B3 (GND): -0.003852
OPEN: 0.005350
Full Scale: +/- 1 mA
2025-07-18T19:17:23.952Z,1752866243.952 [CommandExec](IMPORTANT): got command ! echo d > /dev/loadA4
2025-07-18T19:17:27.607Z,1752866247.607 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:17:27.830Z,1752866247.830 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:17:32.269Z,1752866252.269 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.178526
CHAN A1 (24V): 0.245259
CHAN A2 (12V): 0.108522
CHAN A3 (5V): 0.028244
CHAN B0 (3.3V): 0.019433
CHAN B1 (3.15aV): 0.018667
CHAN B2 (3.15bV): 0.019226
CHAN B3 (GND): -0.006918
OPEN: 0.009025
Full Scale: +/- 1 mA
2025-07-18T19:17:40.199Z,1752866260.199 [CommandExec](IMPORTANT): got command gfscan
2025-07-18T19:17:40.324Z,1752866260.324 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-07-18T19:17:44.795Z,1752866264.795 [GFScanner](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.183170
CHAN A1 (24V): 0.247472
CHAN A2 (12V): 0.110007
CHAN A3 (5V): 0.025579
CHAN B0 (3.3V): 0.017061
CHAN B1 (3.15aV): 0.016377
CHAN B2 (3.15bV): 0.017276
CHAN B3 (GND): -0.008072
OPEN: 0.010232
Full Scale: +/- 1 mA
2025-07-18T19:18:01.059Z,1752866281.059 [CommandExec](IMPORTANT): got command quit
2025-07-18T19:18:02.062Z,1752866282.062 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:02.062Z,1752866282.062 [CommandExec](INFO): Uninitializing the command executive.
2025-07-18T19:18:02.062Z,1752866282.062 [CommandExec](INFO): Uninitializing the command scheduler.
2025-07-18T19:18:02.063Z,1752866282.063 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:02.106Z,1752866282.106 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2025-07-18T19:18:02.106Z,1752866282.106 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-07-18T19:18:02.107Z,1752866282.107 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:02.107Z,1752866282.107 [NavChartDb](INFO): Join timeout helper Thread ID is 2615
2025-07-18T19:18:02.390Z,1752866282.390 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:02.391Z,1752866282.391 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:02.406Z,1752866282.406 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-07-18T19:18:02.406Z,1752866282.406 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:02.407Z,1752866282.407 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2616
2025-07-18T19:18:02.867Z,1752866282.867 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:02.867Z,1752866282.867 [WetLabsBB2FL](INFO): Powering down
2025-07-18T19:18:02.868Z,1752866282.868 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:02.874Z,1752866282.874 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-07-18T19:18:02.874Z,1752866282.874 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:02.875Z,1752866282.875 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2617
2025-07-18T19:18:03.870Z,1752866283.870 [CTD_Seabird](INFO): Powering down
2025-07-18T19:18:03.882Z,1752866283.882 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:03.882Z,1752866283.882 [CTD_Seabird](INFO): Powering down
2025-07-18T19:18:03.894Z,1752866283.894 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:03.902Z,1752866283.902 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-07-18T19:18:03.902Z,1752866283.902 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:03.903Z,1752866283.903 [Radio_Surface](INFO): Join timeout helper Thread ID is 2618
2025-07-18T19:18:04.046Z,1752866284.046 [Radio_Surface](INFO): Powering down
2025-07-18T19:18:04.047Z,1752866284.047 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:04.047Z,1752866284.047 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:04.062Z,1752866284.062 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-07-18T19:18:04.062Z,1752866284.062 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:04.062Z,1752866284.062 [Onboard](INFO): Join timeout helper Thread ID is 2619
2025-07-18T19:18:04.679Z,1752866284.679 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-07-18T19:18:05.754Z,1752866285.754 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:05.755Z,1752866285.755 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:05.767Z,1752866285.767 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-07-18T19:18:05.767Z,1752866285.767 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:05.768Z,1752866285.768 [DataOverHttps](INFO): Join timeout helper Thread ID is 2620
2025-07-18T19:18:06.686Z,1752866286.686 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:06.686Z,1752866286.686 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.695Z,1752866286.695 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-07-18T19:18:06.695Z,1752866286.695 [DAT ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.695Z,1752866286.695 [DAT](INFO): Join timeout helper Thread ID is 2621
2025-07-18T19:18:06.754Z,1752866286.754 [DAT](INFO): Powering down
2025-07-18T19:18:06.827Z,1752866286.827 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:06.827Z,1752866286.827 [DAT](INFO): Powering down
2025-07-18T19:18:06.828Z,1752866286.828 [DAT ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.841Z,1752866286.841 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-07-18T19:18:06.841Z,1752866286.841 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.842Z,1752866286.842 [BackseatComponent](INFO): Join timeout helper Thread ID is 2622
2025-07-18T19:18:06.842Z,1752866286.842 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:06.843Z,1752866286.843 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.855Z,1752866286.855 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-07-18T19:18:06.855Z,1752866286.855 [logger ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.856Z,1752866286.856 [logger](INFO): Join timeout helper Thread ID is 2623
2025-07-18T19:18:06.877Z,1752866286.877 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:06.877Z,1752866286.877 [logger ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.887Z,1752866286.887 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-07-18T19:18:06.887Z,1752866286.887 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.887Z,1752866286.887 [CommandLine](INFO): Join timeout helper Thread ID is 2624
2025-07-18T19:18:06.966Z,1752866286.966 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:06.967Z,1752866286.967 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.974Z,1752866286.974 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-07-18T19:18:06.974Z,1752866286.974 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.975Z,1752866286.975 [CommandExec](INFO): Join timeout helper Thread ID is 2625
2025-07-18T19:18:06.991Z,1752866286.991 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-07-18T19:18:06.991Z,1752866286.991 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:06.991Z,1752866286.991 [controlThread](INFO): Join timeout helper Thread ID is 2626
2025-07-18T19:18:07.023Z,1752866287.023 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-07-18T19:18:07.023Z,1752866287.023 [controlThread](DEBUG): Uninitializing ControlThread
2025-07-18T19:18:07.023Z,1752866287.023 [AHRS_M2](INFO): Powering down
2025-07-18T19:18:07.103Z,1752866287.103 [NAL9602](INFO): Powering down
2025-07-18T19:18:07.104Z,1752866287.104 [Sonardyne_Nano](INFO): Powering down
2025-07-18T19:18:07.311Z,1752866287.311 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-07-18T19:18:07.312Z,1752866287.312 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-07-18T19:18:07.312Z,1752866287.312 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-07-18T19:18:07.313Z,1752866287.313 [MissionManager](INFO): Uninitializing Mission Default
2025-07-18T19:18:07.313Z,1752866287.313 [Default] Stopped
2025-07-18T19:18:07.313Z,1752866287.313 [Default](DEBUG): Aggregate::uninitialize Default
2025-07-18T19:18:07.313Z,1752866287.313 [Default:B.GoToSurface] Stopped
2025-07-18T19:18:07.313Z,1752866287.313 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-07-18T19:18:07.313Z,1752866287.313 [Default:CheckIn] Stopped
2025-07-18T19:18:07.313Z,1752866287.313 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-07-18T19:18:07.313Z,1752866287.313 [Default:CheckIn:Read_GPS] Stopped
2025-07-18T19:18:07.317Z,1752866287.317 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-07-18T19:18:07.317Z,1752866287.317 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-07-18T19:18:07.318Z,1752866287.318 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-07-18T19:18:07.318Z,1752866287.318 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-07-18T19:18:07.319Z,1752866287.319 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-07-18T19:18:07.319Z,1752866287.319 [BuoyancyServo](INFO): Powering down
2025-07-18T19:18:07.330Z,1752866287.330 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-07-18T19:18:07.331Z,1752866287.331 [MassServo](INFO): Powering down
2025-07-18T19:18:07.331Z,1752866287.331 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-07-18T19:18:07.332Z,1752866287.332 [RudderServo](INFO): Powering down
2025-07-18T19:18:07.332Z,1752866287.332 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-07-18T19:18:07.332Z,1752866287.332 [ThrusterHE](INFO): Powering down
2025-07-18T19:18:07.333Z,1752866287.333 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-07-18T19:18:07.334Z,1752866287.334 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-07-18T19:18:07.334Z,1752866287.334 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-07-18T19:18:07.334Z,1752866287.334 [CBIT](DEBUG): Powering off loads.
2025-07-18T19:18:07.346Z,1752866287.346 [CBIT](DEBUG): Disabling WDT.
2025-07-18T19:18:07.358Z,1752866287.358 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-07-18T19:18:07.358Z,1752866287.358 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-07-18T19:18:07.359Z,1752866287.359 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.414Z,1752866287.414 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.417Z,1752866287.417 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.423Z,1752866287.423 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.430Z,1752866287.430 [DAT ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.472Z,1752866287.472 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.516Z,1752866287.516 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.520Z,1752866287.520 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.541Z,1752866287.541 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-07-18T19:18:07.541Z,1752866287.541 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-07-18T19:18:07.556Z,1752866287.556 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-07-18T19:18:07.608Z,1752866287.608 [logger ThreadHandler](INFO): Thread cancelled.