2021-05-28T18:08:46.618Z,1622225326.618 [CommandLine](IMPORTANT): got command restart logs 2021-05-28T18:08:47.942Z,1622225327.942 [DataOverHttps](INFO): Moved sent file to Logs/20210528T130949/Express0068.lzma.bak 2021-05-28T18:08:47.942Z,1622225327.942 [DataOverHttps](INFO): SBD MOMSN=15679158 2021-05-28T18:09:04.538Z,1622225344.538 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:09:16.368Z,1622225356.368 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210528T130949/Courier0070.lzma 2021-05-28T18:09:17.363Z,1622225357.363 [DataOverHttps](INFO): Moved sent file to Logs/20210528T130949/Courier0070.lzma.bak 2021-05-28T18:09:17.363Z,1622225357.363 [DataOverHttps](INFO): SBD MOMSN=15679162 2021-05-28T18:09:35.401Z,1622225375.401 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20210528T130949/Express0071.lzma 2021-05-28T18:09:36.403Z,1622225376.403 [DataOverHttps](INFO): Moved sent file to Logs/20210528T130949/Express0071.lzma.bak 2021-05-28T18:09:36.403Z,1622225376.403 [DataOverHttps](INFO): SBD MOMSN=15679164 2021-05-28T18:09:38.905Z,1622225378.905 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:09:38.905Z,1622225378.905 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:09:38.906Z,1622225378.906 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:14:39.421Z,1622225679.421 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:14:39.421Z,1622225679.421 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:14:39.422Z,1622225679.422 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:14:39.422Z,1622225679.422 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:14:39.838Z,1622225679.838 [Default:CheckIn:D] Stopped 2021-05-28T18:14:39.838Z,1622225679.838 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:14:40.210Z,1622225680.210 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.433259 min 2021-05-28T18:14:40.210Z,1622225680.210 [Default:CheckIn:E] Stopped 2021-05-28T18:14:40.210Z,1622225680.210 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:14:40.210Z,1622225680.210 [Default:CheckIn] Stopped 2021-05-28T18:14:40.210Z,1622225680.210 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:14:40.211Z,1622225680.211 [Default:CheckIn](INFO): Running loop #3 2021-05-28T18:14:40.211Z,1622225680.211 [Default:CheckIn] Running Loop=3 2021-05-28T18:14:40.211Z,1622225680.211 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:14:40.211Z,1622225680.211 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:14:42.225Z,1622225682.225 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181445.00,A,3648.39610,N,12147.12114,W,3.013,193.82,280521,,,D*7A 2021-05-28T18:14:42.227Z,1622225682.227 [NAL9602](INFO): GPS fix at 20210528T181445: (36.806602, -121.785352) 2021-05-28T18:14:42.246Z,1622225682.246 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:14:42.246Z,1622225682.246 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:14:49.893Z,1622225689.893 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20210528T180846/Courier0003.lzma 2021-05-28T18:14:50.895Z,1622225690.895 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0003.lzma.bak 2021-05-28T18:14:50.895Z,1622225690.895 [DataOverHttps](INFO): SBD MOMSN=15679180 2021-05-28T18:15:04.444Z,1622225704.444 [NAL9602](INFO): SBD MO Status=2, MOMSN=16093, MT Status=2, MTMSN=0 2021-05-28T18:15:04.444Z,1622225704.444 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:15:09.825Z,1622225709.825 [DataOverHttps](INFO): Sending 392 bytes from file Logs/20210528T180846/Express0004.lzma 2021-05-28T18:15:10.827Z,1622225710.827 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0004.lzma.bak 2021-05-28T18:15:10.827Z,1622225710.827 [DataOverHttps](INFO): SBD MOMSN=15679184 2021-05-28T18:15:13.363Z,1622225713.363 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:15:13.363Z,1622225713.363 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:15:13.363Z,1622225713.363 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:15:29.096Z,1622225729.096 [NAL9602](INFO): SBD MO Status=2, MOMSN=16093, MT Status=2, MTMSN=0 2021-05-28T18:15:29.096Z,1622225729.096 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:15:45.652Z,1622225745.652 [NAL9602](INFO): SBD MO Status=1, MOMSN=16093, MT Status=0, MTMSN=0 2021-05-28T18:15:45.652Z,1622225745.652 [NAL9602](INFO): No messages in MT queue 2021-05-28T18:16:16.386Z,1622225776.386 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:20:14.034Z,1622226014.034 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:20:14.034Z,1622226014.034 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:20:14.034Z,1622226014.034 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:20:14.034Z,1622226014.034 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:20:14.478Z,1622226014.478 [Default:CheckIn:D] Stopped 2021-05-28T18:20:14.478Z,1622226014.478 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:20:14.830Z,1622226014.830 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.010569 min 2021-05-28T18:20:14.830Z,1622226014.830 [Default:CheckIn:E] Stopped 2021-05-28T18:20:14.830Z,1622226014.830 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:20:14.830Z,1622226014.830 [Default:CheckIn] Stopped 2021-05-28T18:20:14.830Z,1622226014.830 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:20:14.831Z,1622226014.831 [Default:CheckIn](INFO): Running loop #4 2021-05-28T18:20:14.831Z,1622226014.831 [Default:CheckIn] Running Loop=4 2021-05-28T18:20:14.831Z,1622226014.831 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:20:14.831Z,1622226014.831 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:20:16.836Z,1622226016.836 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182020.00,A,3648.15239,N,12147.21926,W,0.389,199.62,280521,,,A*74 2021-05-28T18:20:16.838Z,1622226016.838 [NAL9602](INFO): GPS fix at 20210528T182020: (36.802540, -121.786988) 2021-05-28T18:20:16.862Z,1622226016.862 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:20:16.862Z,1622226016.862 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:20:30.999Z,1622226030.999 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210528T180846/Courier0006.lzma 2021-05-28T18:20:31.311Z,1622226031.311 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0006.lzma.bak 2021-05-28T18:20:31.312Z,1622226031.312 [DataOverHttps](INFO): SBD MOMSN=15679197 2021-05-28T18:20:36.392Z,1622226036.392 [NAL9602](INFO): SBD MO Status=1, MOMSN=16094, MT Status=0, MTMSN=0 2021-05-28T18:20:36.392Z,1622226036.392 [NAL9602](INFO): No messages in MT queue 2021-05-28T18:20:50.161Z,1622226050.161 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210528T180846/Express0007.lzma 2021-05-28T18:20:51.151Z,1622226051.151 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0007.lzma.bak 2021-05-28T18:20:51.151Z,1622226051.151 [DataOverHttps](INFO): SBD MOMSN=15679202 2021-05-28T18:20:53.396Z,1622226053.396 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:20:53.396Z,1622226053.396 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:20:53.396Z,1622226053.396 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:21:07.082Z,1622226067.082 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:25:54.017Z,1622226354.017 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:25:54.017Z,1622226354.017 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:25:54.017Z,1622226354.017 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:25:54.018Z,1622226354.018 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:25:54.442Z,1622226354.442 [Default:CheckIn:D] Stopped 2021-05-28T18:25:54.442Z,1622226354.442 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:25:54.826Z,1622226354.826 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.676652 min 2021-05-28T18:25:54.826Z,1622226354.826 [Default:CheckIn:E] Stopped 2021-05-28T18:25:54.826Z,1622226354.826 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:25:54.826Z,1622226354.826 [Default:CheckIn] Stopped 2021-05-28T18:25:54.827Z,1622226354.827 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:25:54.827Z,1622226354.827 [Default:CheckIn](INFO): Running loop #5 2021-05-28T18:25:54.827Z,1622226354.827 [Default:CheckIn] Running Loop=5 2021-05-28T18:25:54.827Z,1622226354.827 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:25:54.827Z,1622226354.827 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:25:56.836Z,1622226356.836 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182600.00,A,3648.15227,N,12147.22012,W,0.117,199.62,280521,,,D*72 2021-05-28T18:25:56.838Z,1622226356.838 [NAL9602](INFO): GPS fix at 20210528T182600: (36.802538, -121.787002) 2021-05-28T18:25:56.851Z,1622226356.851 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:25:56.851Z,1622226356.851 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:26:04.684Z,1622226364.684 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210528T180846/Courier0009.lzma 2021-05-28T18:26:05.687Z,1622226365.687 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0009.lzma.bak 2021-05-28T18:26:05.687Z,1622226365.687 [DataOverHttps](INFO): SBD MOMSN=15679214 2021-05-28T18:26:24.772Z,1622226384.772 [NAL9602](INFO): SBD MO Status=2, MOMSN=16095, MT Status=2, MTMSN=0 2021-05-28T18:26:24.772Z,1622226384.772 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:26:28.413Z,1622226388.413 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210528T180846/Express0010.lzma 2021-05-28T18:26:29.415Z,1622226389.415 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0010.lzma.bak 2021-05-28T18:26:29.415Z,1622226389.415 [DataOverHttps](INFO): SBD MOMSN=15679217 2021-05-28T18:26:33.354Z,1622226393.354 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:26:33.355Z,1622226393.355 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:26:33.355Z,1622226393.355 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:26:38.972Z,1622226398.972 [NAL9602](INFO): SBD MO Status=2, MOMSN=16095, MT Status=2, MTMSN=0 2021-05-28T18:26:38.972Z,1622226398.972 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:26:56.372Z,1622226416.372 [NAL9602](INFO): SBD MO Status=2, MOMSN=16095, MT Status=2, MTMSN=0 2021-05-28T18:26:56.372Z,1622226416.372 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:27:57.344Z,1622226477.344 [NAL9602](INFO): SBD MO Status=1, MOMSN=16095, MT Status=0, MTMSN=0 2021-05-28T18:27:57.344Z,1622226477.344 [NAL9602](INFO): No messages in MT queue 2021-05-28T18:28:28.050Z,1622226508.050 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:31:33.994Z,1622226693.994 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:31:33.994Z,1622226693.994 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:31:33.995Z,1622226693.995 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:31:33.995Z,1622226693.995 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:31:34.468Z,1622226694.468 [Default:CheckIn:D] Stopped 2021-05-28T18:31:34.468Z,1622226694.468 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:31:34.791Z,1622226694.791 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.343758 min 2021-05-28T18:31:34.791Z,1622226694.791 [Default:CheckIn:E] Stopped 2021-05-28T18:31:34.791Z,1622226694.791 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:31:34.792Z,1622226694.792 [Default:CheckIn] Stopped 2021-05-28T18:31:34.792Z,1622226694.792 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:31:34.792Z,1622226694.792 [Default:CheckIn](INFO): Running loop #6 2021-05-28T18:31:34.792Z,1622226694.792 [Default:CheckIn] Running Loop=6 2021-05-28T18:31:34.792Z,1622226694.792 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:31:34.792Z,1622226694.792 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:31:36.797Z,1622226696.797 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183140.00,A,3648.15210,N,12147.22250,W,0.019,279.73,280521,,,D*72 2021-05-28T18:31:36.800Z,1622226696.800 [NAL9602](INFO): GPS fix at 20210528T183140: (36.802535, -121.787042) 2021-05-28T18:31:36.812Z,1622226696.812 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:31:36.812Z,1622226696.812 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:31:44.965Z,1622226704.965 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210528T180846/Courier0012.lzma 2021-05-28T18:31:45.967Z,1622226705.967 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0012.lzma.bak 2021-05-28T18:31:45.967Z,1622226705.967 [DataOverHttps](INFO): SBD MOMSN=15679229 2021-05-28T18:32:03.061Z,1622226723.061 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210528T180846/Express0013.lzma 2021-05-28T18:32:04.063Z,1622226724.063 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0013.lzma.bak 2021-05-28T18:32:04.063Z,1622226724.063 [DataOverHttps](INFO): SBD MOMSN=15679232 2021-05-28T18:32:06.323Z,1622226726.323 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:32:06.324Z,1622226726.324 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:32:06.324Z,1622226726.324 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:32:28.198Z,1622226748.198 [NAL9602](INFO): SBD MO Status=2, MOMSN=16096, MT Status=2, MTMSN=0 2021-05-28T18:32:28.198Z,1622226748.198 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:32:37.092Z,1622226757.092 [NAL9602](INFO): SBD MO Status=1, MOMSN=16096, MT Status=0, MTMSN=0 2021-05-28T18:32:37.092Z,1622226757.092 [NAL9602](INFO): No messages in MT queue 2021-05-28T18:33:07.797Z,1622226787.797 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:37:07.059Z,1622227027.059 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:37:07.059Z,1622227027.059 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:37:07.059Z,1622227027.059 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:37:07.059Z,1622227027.059 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:37:07.470Z,1622227027.470 [Default:CheckIn:D] Stopped 2021-05-28T18:37:07.470Z,1622227027.470 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:37:07.877Z,1622227027.877 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.893791 min 2021-05-28T18:37:07.877Z,1622227027.877 [Default:CheckIn:E] Stopped 2021-05-28T18:37:07.877Z,1622227027.877 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:37:07.877Z,1622227027.877 [Default:CheckIn] Stopped 2021-05-28T18:37:07.877Z,1622227027.877 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:37:07.877Z,1622227027.877 [Default:CheckIn](INFO): Running loop #7 2021-05-28T18:37:07.878Z,1622227027.878 [Default:CheckIn] Running Loop=7 2021-05-28T18:37:07.878Z,1622227027.878 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:37:07.878Z,1622227027.878 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:37:09.880Z,1622227029.880 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183713.00,A,3648.16718,N,12147.28377,W,0.097,343.37,280521,,,A*79 2021-05-28T18:37:09.882Z,1622227029.882 [NAL9602](INFO): GPS fix at 20210528T183713: (36.802786, -121.788063) 2021-05-28T18:37:09.919Z,1622227029.919 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:37:09.919Z,1622227029.919 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:37:17.997Z,1622227037.997 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210528T180846/Courier0015.lzma 2021-05-28T18:37:18.999Z,1622227038.999 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0015.lzma.bak 2021-05-28T18:37:18.999Z,1622227038.999 [DataOverHttps](INFO): SBD MOMSN=15679244 2021-05-28T18:37:37.725Z,1622227057.725 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20210528T180846/Express0016.lzma 2021-05-28T18:37:38.727Z,1622227058.727 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0016.lzma.bak 2021-05-28T18:37:38.727Z,1622227058.727 [DataOverHttps](INFO): SBD MOMSN=15679248 2021-05-28T18:37:41.021Z,1622227061.021 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:37:41.025Z,1622227061.025 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:37:41.025Z,1622227061.025 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:40:31.200Z,1622227231.200 [NAL9602](INFO): SBD MO Status=1, MOMSN=16097, MT Status=0, MTMSN=0 2021-05-28T18:40:31.200Z,1622227231.200 [NAL9602](INFO): No messages in MT queue 2021-05-28T18:41:01.902Z,1622227261.902 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:42:41.709Z,1622227361.709 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:42:41.709Z,1622227361.709 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:42:41.709Z,1622227361.709 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:42:41.710Z,1622227361.710 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:42:42.116Z,1622227362.116 [Default:CheckIn:D] Stopped 2021-05-28T18:42:42.116Z,1622227362.116 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:42:42.544Z,1622227362.544 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.471220 min 2021-05-28T18:42:42.544Z,1622227362.544 [Default:CheckIn:E] Stopped 2021-05-28T18:42:42.544Z,1622227362.544 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:42:42.544Z,1622227362.544 [Default:CheckIn] Stopped 2021-05-28T18:42:42.544Z,1622227362.544 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:42:42.545Z,1622227362.545 [Default:CheckIn](INFO): Running loop #8 2021-05-28T18:42:42.545Z,1622227362.545 [Default:CheckIn] Running Loop=8 2021-05-28T18:42:42.545Z,1622227362.545 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:42:42.545Z,1622227362.545 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:42:44.521Z,1622227364.521 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184248.00,A,3648.17157,N,12147.28085,W,0.078,343.37,280521,,,A*76 2021-05-28T18:42:44.524Z,1622227364.524 [NAL9602](INFO): GPS fix at 20210528T184248: (36.802859, -121.788014) 2021-05-28T18:42:44.575Z,1622227364.575 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:42:44.576Z,1622227364.576 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:42:53.344Z,1622227373.344 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210528T180846/Courier0018.lzma 2021-05-28T18:42:54.350Z,1622227374.350 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0018.lzma.bak 2021-05-28T18:42:54.350Z,1622227374.350 [DataOverHttps](INFO): SBD MOMSN=15679262 2021-05-28T18:43:12.029Z,1622227392.029 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210528T180846/Express0019.lzma 2021-05-28T18:43:13.031Z,1622227393.031 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0019.lzma.bak 2021-05-28T18:43:13.031Z,1622227393.031 [DataOverHttps](INFO): SBD MOMSN=15679265 2021-05-28T18:43:15.266Z,1622227395.266 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:43:15.267Z,1622227395.267 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:43:15.267Z,1622227395.267 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:43:28.156Z,1622227408.156 [NAL9602](INFO): SBD MO Status=2, MOMSN=16098, MT Status=2, MTMSN=0 2021-05-28T18:43:28.156Z,1622227408.156 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:47:56.492Z,1622227676.492 [NAL9602](INFO): SBD MO Status=2, MOMSN=16098, MT Status=2, MTMSN=0 2021-05-28T18:47:56.492Z,1622227676.492 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:47:56.894Z,1622227676.894 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-05-28T18:48:15.962Z,1622227695.962 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:48:15.962Z,1622227695.962 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:48:15.962Z,1622227695.962 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:48:15.962Z,1622227695.962 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:48:16.610Z,1622227696.610 [Default:CheckIn:D] Stopped 2021-05-28T18:48:16.610Z,1622227696.610 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:48:16.794Z,1622227696.794 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.046118 min 2021-05-28T18:48:16.794Z,1622227696.794 [Default:CheckIn:E] Stopped 2021-05-28T18:48:16.794Z,1622227696.794 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:48:16.794Z,1622227696.794 [Default:CheckIn] Stopped 2021-05-28T18:48:16.794Z,1622227696.794 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:48:16.794Z,1622227696.794 [Default:CheckIn](INFO): Running loop #9 2021-05-28T18:48:16.795Z,1622227696.795 [Default:CheckIn] Running Loop=9 2021-05-28T18:48:16.795Z,1622227696.795 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:48:16.795Z,1622227696.795 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:48:18.752Z,1622227698.752 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184822.00,A,3648.16963,N,12147.28202,W,0.194,144.32,280521,,,A*70 2021-05-28T18:48:18.754Z,1622227698.754 [NAL9602](INFO): GPS fix at 20210528T184822: (36.802827, -121.788034) 2021-05-28T18:48:18.791Z,1622227698.791 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:48:18.791Z,1622227698.791 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:48:30.957Z,1622227710.957 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210528T180846/Courier0021.lzma 2021-05-28T18:48:31.964Z,1622227711.964 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0021.lzma.bak 2021-05-28T18:48:31.965Z,1622227711.965 [DataOverHttps](INFO): SBD MOMSN=15679275 2021-05-28T18:48:51.169Z,1622227731.169 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:48:51.906Z,1622227731.906 [DataOverHttps](INFO): Sending 229 bytes from file Logs/20210528T180846/Express0022.lzma 2021-05-28T18:48:52.907Z,1622227732.907 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0022.lzma.bak 2021-05-28T18:48:52.907Z,1622227732.907 [DataOverHttps](INFO): SBD MOMSN=15679278 2021-05-28T18:48:55.621Z,1622227735.621 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:48:55.622Z,1622227735.622 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:48:55.622Z,1622227735.622 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:53:56.269Z,1622228036.269 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:53:56.269Z,1622228036.269 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:53:56.270Z,1622228036.270 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:53:56.270Z,1622228036.270 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:53:56.707Z,1622228036.707 [Default:CheckIn:D] Stopped 2021-05-28T18:53:56.707Z,1622228036.707 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.714404 min 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn:E] Stopped 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn] Stopped 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn](INFO): Running loop #10 2021-05-28T18:53:57.066Z,1622228037.066 [Default:CheckIn] Running Loop=10 2021-05-28T18:53:57.067Z,1622228037.067 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:53:57.067Z,1622228037.067 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:53:59.072Z,1622228039.072 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185402.00,A,3648.16599,N,12147.28328,W,0.194,81.77,280521,,,A*46 2021-05-28T18:53:59.074Z,1622228039.074 [NAL9602](INFO): GPS fix at 20210528T185402: (36.802766, -121.788055) 2021-05-28T18:53:59.103Z,1622228039.103 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:53:59.104Z,1622228039.104 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:54:07.376Z,1622228047.376 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210528T180846/Courier0024.lzma 2021-05-28T18:54:08.379Z,1622228048.379 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0024.lzma.bak 2021-05-28T18:54:08.379Z,1622228048.379 [DataOverHttps](INFO): SBD MOMSN=15679304 2021-05-28T18:54:28.636Z,1622228068.636 [NAL9602](INFO): SBD MO Status=2, MOMSN=16098, MT Status=2, MTMSN=0 2021-05-28T18:54:28.636Z,1622228068.636 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-05-28T18:54:33.185Z,1622228073.185 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20210528T180846/Express0025.lzma 2021-05-28T18:54:34.187Z,1622228074.187 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0025.lzma.bak 2021-05-28T18:54:34.187Z,1622228074.187 [DataOverHttps](INFO): SBD MOMSN=15679337 2021-05-28T18:54:37.595Z,1622228077.595 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T18:54:37.595Z,1622228077.595 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T18:54:37.595Z,1622228077.595 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T18:54:44.452Z,1622228084.452 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-05-28T18:54:56.579Z,1622228096.579 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-05-28T18:54:56.581Z,1622228096.581 [BPC1](INFO): Received data from all battery sticks. 2021-05-28T18:59:01.066Z,1622228341.066 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-05-28T18:59:31.770Z,1622228371.770 [NAL9602](INFO): Not Powering down - fast GPS 2021-05-28T18:59:38.285Z,1622228378.285 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-05-28T18:59:38.285Z,1622228378.285 [Default:CheckIn:C.Wait] Stopped 2021-05-28T18:59:38.285Z,1622228378.285 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T18:59:38.285Z,1622228378.285 [Default:CheckIn:D] Running Loop=1 2021-05-28T18:59:38.716Z,1622228378.716 [Default:CheckIn:D] Stopped 2021-05-28T18:59:38.716Z,1622228378.716 [Default:CheckIn:E] Running Loop=1 2021-05-28T18:59:39.079Z,1622228379.079 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 59.414555 min 2021-05-28T18:59:39.079Z,1622228379.079 [Default:CheckIn:E] Stopped 2021-05-28T18:59:39.079Z,1622228379.079 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-05-28T18:59:39.079Z,1622228379.079 [Default:CheckIn] Stopped 2021-05-28T18:59:39.079Z,1622228379.079 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T18:59:39.080Z,1622228379.080 [Default:CheckIn](INFO): Running loop #11 2021-05-28T18:59:39.080Z,1622228379.080 [Default:CheckIn] Running Loop=11 2021-05-28T18:59:39.080Z,1622228379.080 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-05-28T18:59:39.080Z,1622228379.080 [Default:CheckIn:Read_GPS] Running Loop=1 2021-05-28T18:59:41.064Z,1622228381.064 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185944.00,A,3648.17570,N,12147.27412,W,0.253,81.77,280521,,,A*46 2021-05-28T18:59:41.066Z,1622228381.066 [NAL9602](INFO): GPS fix at 20210528T185944: (36.802928, -121.787902) 2021-05-28T18:59:41.098Z,1622228381.098 [Default:CheckIn:Read_GPS] Stopped 2021-05-28T18:59:41.098Z,1622228381.098 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-05-28T18:59:50.798Z,1622228390.798 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20210528T180846/Courier0027.lzma 2021-05-28T18:59:51.293Z,1622228391.293 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Courier0027.lzma.bak 2021-05-28T18:59:51.293Z,1622228391.293 [DataOverHttps](INFO): SBD MOMSN=15679361 2021-05-28T19:00:08.637Z,1622228408.637 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20210528T180846/Express0028.lzma 2021-05-28T19:00:09.639Z,1622228409.639 [DataOverHttps](INFO): Moved sent file to Logs/20210528T180846/Express0028.lzma.bak 2021-05-28T19:00:09.639Z,1622228409.639 [DataOverHttps](INFO): SBD MOMSN=15679364 2021-05-28T19:00:11.798Z,1622228411.798 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-05-28T19:00:11.873Z,1622228411.873 [NAL9602](ERROR): received: +CSQ:0 OK098, 2, 0, 0, 0 OK 2021-05-28T19:00:11.921Z,1622228411.921 [Default:CheckIn:Read_Iridium] Stopped 2021-05-28T19:00:11.922Z,1622228411.922 [Default:CheckIn:C.Wait] Running Loop=1 2021-05-28T19:00:11.922Z,1622228411.922 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-05-28T19:02:06.985Z,1622228526.985 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2021-05-28T19:02:08.993Z,1622228528.993 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.743294 2021-05-28T19:02:19.602Z,1622228539.602 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003654 2021-05-28T19:03:25.742Z,1622228605.742 [CommandLine](IMPORTANT): got command quit 2021-05-28T19:03:26.745Z,1622228606.745 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:26.745Z,1622228606.745 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:26.901Z,1622228606.901 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-05-28T19:03:26.901Z,1622228606.901 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:26.902Z,1622228606.902 [CommandLine](INFO): Join timeout helper Thread ID is 1242 2021-05-28T19:03:26.909Z,1622228606.909 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-05-28T19:03:26.909Z,1622228606.909 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:26.910Z,1622228606.910 [NavChartDb](INFO): Join timeout helper Thread ID is 1243 2021-05-28T19:03:26.917Z,1622228606.917 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:26.917Z,1622228606.917 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:26.918Z,1622228606.918 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2021-05-28T19:03:26.918Z,1622228606.918 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:26.918Z,1622228606.918 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1244 2021-05-28T19:03:27.033Z,1622228607.033 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:27.033Z,1622228607.033 [WetLabsUBAT](INFO): Powering down 2021-05-28T19:03:27.034Z,1622228607.034 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:27.045Z,1622228607.045 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-05-28T19:03:27.045Z,1622228607.045 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:27.045Z,1622228607.045 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1245 2021-05-28T19:03:27.349Z,1622228607.349 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:27.349Z,1622228607.349 [WetLabsBB2FL](INFO): Powering down 2021-05-28T19:03:27.350Z,1622228607.350 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:27.357Z,1622228607.357 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-05-28T19:03:27.357Z,1622228607.357 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:27.357Z,1622228607.357 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1246 2021-05-28T19:03:27.885Z,1622228607.885 [CTD_Seabird](INFO): Powering down 2021-05-28T19:03:27.897Z,1622228607.897 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:27.897Z,1622228607.897 [CTD_Seabird](INFO): Powering down 2021-05-28T19:03:27.909Z,1622228607.909 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:27.930Z,1622228607.930 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-05-28T19:03:27.930Z,1622228607.930 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:27.930Z,1622228607.930 [Radio_Surface](INFO): Join timeout helper Thread ID is 1247 2021-05-28T19:03:28.245Z,1622228608.245 [Radio_Surface](INFO): Powering down 2021-05-28T19:03:28.246Z,1622228608.246 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:28.246Z,1622228608.246 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:28.258Z,1622228608.258 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-05-28T19:03:28.258Z,1622228608.258 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:28.258Z,1622228608.258 [Onboard](INFO): Join timeout helper Thread ID is 1248 2021-05-28T19:03:32.145Z,1622228612.145 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:32.145Z,1622228612.145 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.166Z,1622228612.166 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-05-28T19:03:32.166Z,1622228612.166 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.166Z,1622228612.166 [DataOverHttps](INFO): Join timeout helper Thread ID is 1249 2021-05-28T19:03:32.521Z,1622228612.521 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:32.524Z,1622228612.524 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.534Z,1622228612.534 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2021-05-28T19:03:32.534Z,1622228612.534 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.534Z,1622228612.534 [BackseatComponent](INFO): Join timeout helper Thread ID is 1250 2021-05-28T19:03:32.657Z,1622228612.657 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:32.657Z,1622228612.657 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.674Z,1622228612.674 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-05-28T19:03:32.674Z,1622228612.674 [logger ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.674Z,1622228612.674 [logger](INFO): Join timeout helper Thread ID is 1251 2021-05-28T19:03:32.705Z,1622228612.705 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:32.705Z,1622228612.705 [logger ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.714Z,1622228612.714 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-05-28T19:03:32.714Z,1622228612.714 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.714Z,1622228612.714 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-05-28T19:03:32.714Z,1622228612.714 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:32.714Z,1622228612.714 [controlThread](INFO): Join timeout helper Thread ID is 1252 2021-05-28T19:03:32.761Z,1622228612.761 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-05-28T19:03:32.761Z,1622228612.761 [controlThread](DEBUG): Uninitializing ControlThread 2021-05-28T19:03:32.762Z,1622228612.762 [AHRS_M2](INFO): Powering down 2021-05-28T19:03:32.834Z,1622228612.834 [NAL9602](INFO): Powering down 2021-05-28T19:03:32.905Z,1622228612.905 [RDI_Pathfinder](INFO): Powering down 2021-05-28T19:03:32.906Z,1622228612.906 [DAT](INFO): Powering down 2021-05-28T19:03:32.978Z,1622228612.978 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-05-28T19:03:32.979Z,1622228612.979 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-05-28T19:03:32.979Z,1622228612.979 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-05-28T19:03:32.980Z,1622228612.980 [MissionManager](INFO): Uninitializing Mission Default 2021-05-28T19:03:32.980Z,1622228612.980 [Default] Stopped 2021-05-28T19:03:32.980Z,1622228612.980 [Default](DEBUG): Aggregate::uninitialize Default 2021-05-28T19:03:32.980Z,1622228612.980 [Default:B.GoToSurface] Stopped 2021-05-28T19:03:32.980Z,1622228612.980 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-05-28T19:03:32.980Z,1622228612.980 [Default:CheckIn] Stopped 2021-05-28T19:03:32.981Z,1622228612.981 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-05-28T19:03:32.981Z,1622228612.981 [Default:CheckIn:C.Wait] Stopped 2021-05-28T19:03:32.981Z,1622228612.981 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-05-28T19:03:32.984Z,1622228612.984 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-05-28T19:03:32.984Z,1622228612.984 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-05-28T19:03:32.984Z,1622228612.984 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-05-28T19:03:32.984Z,1622228612.984 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-05-28T19:03:32.985Z,1622228612.985 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-05-28T19:03:32.985Z,1622228612.985 [BuoyancyServo](INFO): Powering down 2021-05-28T19:03:32.997Z,1622228612.997 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-05-28T19:03:32.997Z,1622228612.997 [ElevatorServo](INFO): Powering down 2021-05-28T19:03:32.998Z,1622228612.998 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-05-28T19:03:32.998Z,1622228612.998 [MassServo](INFO): Powering down 2021-05-28T19:03:32.999Z,1622228612.999 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-05-28T19:03:32.999Z,1622228612.999 [RudderServo](INFO): Powering down 2021-05-28T19:03:32.000Z,1622228613.000 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-05-28T19:03:32.000Z,1622228613.000 [ThrusterServo](INFO): Powering down 2021-05-28T19:03:33.001Z,1622228613.001 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-05-28T19:03:33.001Z,1622228613.001 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-05-28T19:03:33.001Z,1622228613.001 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-05-28T19:03:33.001Z,1622228613.001 [CBIT](DEBUG): Powering off loads. 2021-05-28T19:03:33.013Z,1622228613.013 [CBIT](DEBUG): Disabling WDT. 2021-05-28T19:03:33.025Z,1622228613.025 [CBIT](DEBUG): Opening all GF detection circuits. 2021-05-28T19:03:33.026Z,1622228613.026 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.080Z,1622228613.080 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.083Z,1622228613.083 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.089Z,1622228613.089 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.132Z,1622228613.132 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.185Z,1622228613.185 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.187Z,1622228613.187 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.190Z,1622228613.190 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.198Z,1622228613.198 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-05-28T19:03:33.272Z,1622228613.272 [logger ThreadHandler](INFO): Thread cancelled.