2021-07-20T21:21:34.481Z,1626816094.481 [CommandLine](IMPORTANT): got command restart logs
2021-07-20T21:25:13.567Z,1626816313.567 [NAL9602](INFO): SBD MO Status=1, MOMSN=28496, MT Status=0, MTMSN=0
2021-07-20T21:25:13.567Z,1626816313.567 [NAL9602](INFO): No messages in MT queue
2021-07-20T21:25:35.052Z,1626816335.052 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-20T21:25:35.052Z,1626816335.052 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:25:35.052Z,1626816335.052 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:25:35.053Z,1626816335.053 [Default:CheckIn:D] Running Loop=1
2021-07-20T21:25:35.426Z,1626816335.426 [Default:CheckIn:D] Stopped
2021-07-20T21:25:35.426Z,1626816335.426 [Default:CheckIn:E] Running Loop=1
2021-07-20T21:25:35.821Z,1626816335.821 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.364105 min 
2021-07-20T21:25:35.821Z,1626816335.821 [Default:CheckIn:E] Stopped
2021-07-20T21:25:35.821Z,1626816335.821 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-20T21:25:35.821Z,1626816335.821 [Default:CheckIn] Stopped
2021-07-20T21:25:35.821Z,1626816335.821 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:25:35.822Z,1626816335.822 [Default:CheckIn](INFO): Running loop #4
2021-07-20T21:25:35.822Z,1626816335.822 [Default:CheckIn] Running Loop=4
2021-07-20T21:25:35.822Z,1626816335.822 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-20T21:25:35.822Z,1626816335.822 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-20T21:25:37.799Z,1626816337.799 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212527.00,A,3648.16592,N,12147.28208,W,0.156,357.30,200721,,,A*7A
2021-07-20T21:25:37.812Z,1626816337.812 [NAL9602](INFO): GPS fix at 20210720T212527: (36.802765, -121.788035)
2021-07-20T21:25:37.849Z,1626816337.849 [Default:CheckIn:Read_GPS] Stopped
2021-07-20T21:25:37.849Z,1626816337.849 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-20T21:25:40.100Z,1626816340.100 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210720T203003/Courier0022.lzma
2021-07-20T21:25:41.130Z,1626816341.130 [DataOverHttps](INFO): Moved sent file to Logs/20210720T203003/Courier0022.lzma.bak
2021-07-20T21:25:41.130Z,1626816341.130 [DataOverHttps](INFO): SBD MOMSN=15750253
2021-07-20T21:25:58.092Z,1626816358.092 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20210720T212134/Courier0000.lzma
2021-07-20T21:25:59.094Z,1626816359.094 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Courier0000.lzma.bak
2021-07-20T21:25:59.094Z,1626816359.094 [DataOverHttps](INFO): SBD MOMSN=15750255
2021-07-20T21:26:09.806Z,1626816369.806 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-20T21:26:16.796Z,1626816376.796 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20210720T203003/Express0023.lzma
2021-07-20T21:26:17.798Z,1626816377.798 [DataOverHttps](INFO): Moved sent file to Logs/20210720T203003/Express0023.lzma.bak
2021-07-20T21:26:17.798Z,1626816377.798 [DataOverHttps](INFO): SBD MOMSN=15750259
2021-07-20T21:26:38.626Z,1626816398.626 [DataOverHttps](INFO): Sending 426 bytes from file Logs/20210720T212134/Express0001.lzma
2021-07-20T21:26:39.626Z,1626816399.626 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0001.lzma.bak
2021-07-20T21:26:39.626Z,1626816399.626 [DataOverHttps](INFO): SBD MOMSN=15750262
2021-07-20T21:27:00.872Z,1626816420.872 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210720T212134/Express0002.lzma
2021-07-20T21:27:01.874Z,1626816421.874 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0002.lzma.bak
2021-07-20T21:27:01.874Z,1626816421.874 [DataOverHttps](INFO): SBD MOMSN=15750266
2021-07-20T21:27:04.948Z,1626816424.948 [Default:CheckIn:Read_Iridium] Stopped
2021-07-20T21:27:04.948Z,1626816424.948 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-20T21:27:04.948Z,1626816424.948 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-20T21:32:05.480Z,1626816725.480 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-20T21:32:05.480Z,1626816725.480 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:32:05.480Z,1626816725.480 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:32:05.480Z,1626816725.480 [Default:CheckIn:D] Running Loop=1
2021-07-20T21:32:05.890Z,1626816725.890 [Default:CheckIn:D] Stopped
2021-07-20T21:32:05.890Z,1626816725.890 [Default:CheckIn:E] Running Loop=1
2021-07-20T21:32:06.280Z,1626816726.280 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.871834 min 
2021-07-20T21:32:06.280Z,1626816726.280 [Default:CheckIn:E] Stopped
2021-07-20T21:32:06.280Z,1626816726.280 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-20T21:32:06.280Z,1626816726.280 [Default:CheckIn] Stopped
2021-07-20T21:32:06.280Z,1626816726.280 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:32:06.280Z,1626816726.280 [Default:CheckIn](INFO): Running loop #5
2021-07-20T21:32:06.281Z,1626816726.281 [Default:CheckIn] Running Loop=5
2021-07-20T21:32:06.281Z,1626816726.281 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-20T21:32:06.281Z,1626816726.281 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-20T21:32:08.299Z,1626816728.299 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213158.00,A,3648.16595,N,12147.28340,W,0.214,27.57,200721,,,A*4D
2021-07-20T21:32:08.301Z,1626816728.301 [NAL9602](INFO): GPS fix at 20210720T213158: (36.802766, -121.788057)
2021-07-20T21:32:08.312Z,1626816728.312 [Default:CheckIn:Read_GPS] Stopped
2021-07-20T21:32:08.312Z,1626816728.312 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-20T21:32:17.284Z,1626816737.284 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210720T212134/Courier0005.lzma
2021-07-20T21:32:18.286Z,1626816738.286 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Courier0005.lzma.bak
2021-07-20T21:32:18.286Z,1626816738.286 [DataOverHttps](INFO): SBD MOMSN=15750288
2021-07-20T21:32:40.292Z,1626816760.292 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20210720T212134/Express0007.lzma
2021-07-20T21:32:41.294Z,1626816761.294 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0007.lzma.bak
2021-07-20T21:32:41.294Z,1626816761.294 [DataOverHttps](INFO): SBD MOMSN=15750291
2021-07-20T21:32:46.484Z,1626816766.484 [Default:CheckIn:Read_Iridium] Stopped
2021-07-20T21:32:46.485Z,1626816766.485 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-20T21:32:46.485Z,1626816766.485 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-20T21:34:01.151Z,1626816841.151 [NAL9602](INFO): SBD MO Status=2, MOMSN=28497, MT Status=2, MTMSN=0
2021-07-20T21:34:01.151Z,1626816841.151 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-20T21:34:41.171Z,1626816881.171 [NAL9602](INFO): SBD MO Status=2, MOMSN=28497, MT Status=2, MTMSN=0
2021-07-20T21:34:41.171Z,1626816881.171 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-20T21:34:59.347Z,1626816899.347 [NAL9602](INFO): SBD MO Status=2, MOMSN=28497, MT Status=2, MTMSN=0
2021-07-20T21:34:59.347Z,1626816899.347 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-20T21:35:29.239Z,1626816929.239 [NAL9602](INFO): SBD MO Status=1, MOMSN=28497, MT Status=0, MTMSN=0
2021-07-20T21:35:29.239Z,1626816929.239 [NAL9602](INFO): No messages in MT queue
2021-07-20T21:35:59.941Z,1626816959.941 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-20T21:37:47.012Z,1626817067.012 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-20T21:37:47.012Z,1626817067.012 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:37:47.012Z,1626817067.012 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:37:47.012Z,1626817067.012 [Default:CheckIn:D] Running Loop=1
2021-07-20T21:37:47.416Z,1626817067.416 [Default:CheckIn:D] Stopped
2021-07-20T21:37:47.416Z,1626817067.416 [Default:CheckIn:E] Running Loop=1
2021-07-20T21:37:47.822Z,1626817067.822 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.563932 min 
2021-07-20T21:37:47.822Z,1626817067.822 [Default:CheckIn:E] Stopped
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn] Stopped
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn](INFO): Running loop #6
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn] Running Loop=6
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-20T21:37:47.823Z,1626817067.823 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-20T21:37:49.831Z,1626817069.831 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213739.00,A,3648.16440,N,12147.28346,W,0.311,82.57,200721,,,A*48
2021-07-20T21:37:49.834Z,1626817069.834 [NAL9602](INFO): GPS fix at 20210720T213739: (36.802740, -121.788058)
2021-07-20T21:37:49.863Z,1626817069.863 [Default:CheckIn:Read_GPS] Stopped
2021-07-20T21:37:49.864Z,1626817069.864 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-20T21:37:58.787Z,1626817078.787 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210720T212134/Courier0009.lzma
2021-07-20T21:37:59.790Z,1626817079.790 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Courier0009.lzma.bak
2021-07-20T21:37:59.790Z,1626817079.790 [DataOverHttps](INFO): SBD MOMSN=15750296
2021-07-20T21:38:17.672Z,1626817097.672 [DataOverHttps](INFO): Sending 141 bytes from file Logs/20210720T212134/Express0010.lzma
2021-07-20T21:38:18.674Z,1626817098.674 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0010.lzma.bak
2021-07-20T21:38:18.674Z,1626817098.674 [DataOverHttps](INFO): SBD MOMSN=15750299
2021-07-20T21:38:21.755Z,1626817101.755 [Default:CheckIn:Read_Iridium] Stopped
2021-07-20T21:38:21.756Z,1626817101.756 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-20T21:38:21.756Z,1626817101.756 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-20T21:42:35.798Z,1626817355.798 [NAL9602](INFO): SBD MO Status=2, MOMSN=28498, MT Status=2, MTMSN=0
2021-07-20T21:42:35.798Z,1626817355.798 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-20T21:43:01.697Z,1626817381.697 [NAL9602](INFO): SBD MO Status=2, MOMSN=28498, MT Status=2, MTMSN=0
2021-07-20T21:43:01.697Z,1626817381.697 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-07-20T21:43:02.100Z,1626817382.100 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-07-20T21:43:22.305Z,1626817402.305 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-20T21:43:22.305Z,1626817402.305 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:43:22.305Z,1626817402.305 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:43:22.306Z,1626817402.306 [Default:CheckIn:D] Running Loop=1
2021-07-20T21:43:22.708Z,1626817402.708 [Default:CheckIn:D] Stopped
2021-07-20T21:43:22.709Z,1626817402.709 [Default:CheckIn:E] Running Loop=1
2021-07-20T21:43:23.110Z,1626817403.110 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.152144 min 
2021-07-20T21:43:23.110Z,1626817403.110 [Default:CheckIn:E] Stopped
2021-07-20T21:43:23.110Z,1626817403.110 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-20T21:43:23.111Z,1626817403.111 [Default:CheckIn] Stopped
2021-07-20T21:43:23.111Z,1626817403.111 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:43:23.111Z,1626817403.111 [Default:CheckIn](INFO): Running loop #7
2021-07-20T21:43:23.111Z,1626817403.111 [Default:CheckIn] Running Loop=7
2021-07-20T21:43:23.111Z,1626817403.111 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-20T21:43:23.111Z,1626817403.111 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-20T21:43:25.119Z,1626817405.119 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214315.00,A,3648.16457,N,12147.28084,W,0.330,119.66,200721,,,A*7C
2021-07-20T21:43:25.132Z,1626817405.132 [NAL9602](INFO): GPS fix at 20210720T214315: (36.802743, -121.788014)
2021-07-20T21:43:25.143Z,1626817405.143 [Default:CheckIn:Read_GPS] Stopped
2021-07-20T21:43:25.143Z,1626817405.143 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-20T21:43:33.404Z,1626817413.404 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210720T212134/Courier0012.lzma
2021-07-20T21:43:34.406Z,1626817414.406 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Courier0012.lzma.bak
2021-07-20T21:43:34.406Z,1626817414.406 [DataOverHttps](INFO): SBD MOMSN=15750308
2021-07-20T21:43:57.973Z,1626817437.973 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-20T21:44:01.965Z,1626817441.965 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20210720T212134/Express0013.lzma
2021-07-20T21:44:02.966Z,1626817442.966 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0013.lzma.bak
2021-07-20T21:44:02.966Z,1626817442.966 [DataOverHttps](INFO): SBD MOMSN=15750311
2021-07-20T21:44:08.504Z,1626817448.504 [Default:CheckIn:Read_Iridium] Stopped
2021-07-20T21:44:08.504Z,1626817448.504 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-20T21:44:08.504Z,1626817448.504 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-20T21:45:07.831Z,1626817507.831 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-07-20T21:45:07.853Z,1626817507.853 [BPC1](INFO): Received data from all battery sticks.
2021-07-20T21:49:09.143Z,1626817749.143 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-20T21:49:09.143Z,1626817749.143 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:49:09.143Z,1626817749.143 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:49:09.144Z,1626817749.144 [Default:CheckIn:D] Running Loop=1
2021-07-20T21:49:09.551Z,1626817749.551 [Default:CheckIn:D] Stopped
2021-07-20T21:49:09.551Z,1626817749.551 [Default:CheckIn:E] Running Loop=1
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.932857 min 
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn:E] Stopped
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn] Stopped
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn](INFO): Running loop #8
2021-07-20T21:49:09.953Z,1626817749.953 [Default:CheckIn] Running Loop=8
2021-07-20T21:49:09.954Z,1626817749.954 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-20T21:49:09.954Z,1626817749.954 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-20T21:49:11.955Z,1626817751.955 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214901.00,A,3648.16806,N,12147.28669,W,0.428,154.61,200721,,,A*7E
2021-07-20T21:49:11.958Z,1626817751.958 [NAL9602](INFO): GPS fix at 20210720T214901: (36.802801, -121.788111)
2021-07-20T21:49:11.969Z,1626817751.969 [Default:CheckIn:Read_GPS] Stopped
2021-07-20T21:49:11.969Z,1626817751.969 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-20T21:49:21.600Z,1626817761.600 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20210720T212134/Courier0015.lzma
2021-07-20T21:49:22.602Z,1626817762.602 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Courier0015.lzma.bak
2021-07-20T21:49:22.602Z,1626817762.602 [DataOverHttps](INFO): SBD MOMSN=15750315
2021-07-20T21:49:40.620Z,1626817780.620 [DataOverHttps](INFO): Sending 138 bytes from file Logs/20210720T212134/Express0016.lzma
2021-07-20T21:49:41.622Z,1626817781.622 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0016.lzma.bak
2021-07-20T21:49:41.622Z,1626817781.622 [DataOverHttps](INFO): SBD MOMSN=15750318
2021-07-20T21:49:44.737Z,1626817784.737 [Default:CheckIn:Read_Iridium] Stopped
2021-07-20T21:49:44.737Z,1626817784.737 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-20T21:49:44.737Z,1626817784.737 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-20T21:54:13.946Z,1626818053.946 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-07-20T21:54:44.337Z,1626818084.337 [NAL9602](INFO): Not Powering down - fast GPS
2021-07-20T21:54:45.152Z,1626818085.152 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-07-20T21:54:45.152Z,1626818085.152 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:54:45.153Z,1626818085.153 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:54:45.153Z,1626818085.153 [Default:CheckIn:D] Running Loop=1
2021-07-20T21:54:45.508Z,1626818085.508 [Default:CheckIn:D] Stopped
2021-07-20T21:54:45.508Z,1626818085.508 [Default:CheckIn:E] Running Loop=1
2021-07-20T21:54:45.918Z,1626818085.918 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.532133 min 
2021-07-20T21:54:45.918Z,1626818085.918 [Default:CheckIn:E] Stopped
2021-07-20T21:54:45.918Z,1626818085.918 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-07-20T21:54:45.918Z,1626818085.918 [Default:CheckIn] Stopped
2021-07-20T21:54:45.918Z,1626818085.918 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:54:45.919Z,1626818085.919 [Default:CheckIn](INFO): Running loop #9
2021-07-20T21:54:45.919Z,1626818085.919 [Default:CheckIn] Running Loop=9
2021-07-20T21:54:45.919Z,1626818085.919 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-07-20T21:54:45.919Z,1626818085.919 [Default:CheckIn:Read_GPS] Running Loop=1
2021-07-20T21:54:47.923Z,1626818087.923 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215437.00,A,3648.16499,N,12147.28163,W,0.097,334.33,200721,,,A*73
2021-07-20T21:54:47.926Z,1626818087.926 [NAL9602](INFO): GPS fix at 20210720T215437: (36.802750, -121.788027)
2021-07-20T21:54:47.954Z,1626818087.954 [Default:CheckIn:Read_GPS] Stopped
2021-07-20T21:54:47.954Z,1626818087.954 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-07-20T21:54:55.752Z,1626818095.752 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210720T212134/Courier0018.lzma
2021-07-20T21:54:56.754Z,1626818096.754 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Courier0018.lzma.bak
2021-07-20T21:54:56.754Z,1626818096.754 [DataOverHttps](INFO): SBD MOMSN=15750327
2021-07-20T21:55:14.584Z,1626818114.584 [DataOverHttps](INFO): Sending 215 bytes from file Logs/20210720T212134/Express0019.lzma
2021-07-20T21:55:15.586Z,1626818115.586 [DataOverHttps](INFO): Moved sent file to Logs/20210720T212134/Express0019.lzma.bak
2021-07-20T21:55:15.586Z,1626818115.586 [DataOverHttps](INFO): SBD MOMSN=15750330
2021-07-20T21:55:18.653Z,1626818118.653 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2021-07-20T21:55:18.732Z,1626818118.732 [NAL9602](ERROR): received: 
+CSQ:0

OK498, 2, 0, 0, 0

OK
2021-07-20T21:55:18.785Z,1626818118.785 [Default:CheckIn:Read_Iridium] Stopped
2021-07-20T21:55:18.786Z,1626818118.786 [Default:CheckIn:C.Wait] Running Loop=1
2021-07-20T21:55:18.786Z,1626818118.786 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-07-20T21:56:39.314Z,1626818199.314 [DataOverHttps](IMPORTANT): SBD MTMSN=20210720T215628
2021-07-20T21:56:50.192Z,1626818210.192 [DataOverHttps](INFO): Received command:configSet VerticalControl.kdDepthBuoy 5000 s persist;restart app
2021-07-20T21:56:50.400Z,1626818210.400 [CommandLine](IMPORTANT): got command configSet VerticalControl.kdDepthBuoy 5000.000000 second persist
2021-07-20T21:56:50.402Z,1626818210.402 [CommandLine](IMPORTANT): got command restart application
2021-07-20T21:56:51.404Z,1626818211.404 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2021-07-20T21:56:51.404Z,1626818211.404 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:51.405Z,1626818211.405 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.416Z,1626818211.416 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-07-20T21:56:51.416Z,1626818211.416 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.417Z,1626818211.417 [CommandLine](INFO): Join timeout helper Thread ID is 2217
2021-07-20T21:56:51.417Z,1626818211.417 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-07-20T21:56:51.417Z,1626818211.417 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.418Z,1626818211.418 [NavChartDb](INFO): Join timeout helper Thread ID is 2218
2021-07-20T21:56:51.529Z,1626818211.529 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:51.530Z,1626818211.530 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.544Z,1626818211.544 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-07-20T21:56:51.544Z,1626818211.544 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.544Z,1626818211.544 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2219
2021-07-20T21:56:51.705Z,1626818211.705 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:51.705Z,1626818211.705 [WetLabsBB2FL](INFO): Powering down
2021-07-20T21:56:51.706Z,1626818211.706 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.706Z,1626818211.706 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-07-20T21:56:51.706Z,1626818211.706 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:51.707Z,1626818211.707 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2220
2021-07-20T21:56:52.428Z,1626818212.428 [CTD_Seabird](INFO): Powering down
2021-07-20T21:56:52.440Z,1626818212.440 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:52.440Z,1626818212.440 [CTD_Seabird](INFO): Powering down
2021-07-20T21:56:52.452Z,1626818212.452 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:52.456Z,1626818212.456 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-07-20T21:56:52.456Z,1626818212.456 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:52.456Z,1626818212.456 [Radio_Surface](INFO): Join timeout helper Thread ID is 2221
2021-07-20T21:56:52.584Z,1626818212.584 [Radio_Surface](INFO): Powering down
2021-07-20T21:56:52.585Z,1626818212.585 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:52.585Z,1626818212.585 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:52.605Z,1626818212.605 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-07-20T21:56:52.605Z,1626818212.605 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:52.605Z,1626818212.605 [Onboard](INFO): Join timeout helper Thread ID is 2222
2021-07-20T21:56:53.201Z,1626818213.201 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2021-07-20T21:56:54.032Z,1626818214.032 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:54.032Z,1626818214.032 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.037Z,1626818214.037 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-07-20T21:56:54.037Z,1626818214.037 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.037Z,1626818214.037 [DataOverHttps](INFO): Join timeout helper Thread ID is 2223
2021-07-20T21:56:54.204Z,1626818214.204 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:54.204Z,1626818214.204 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.217Z,1626818214.217 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-07-20T21:56:54.217Z,1626818214.217 [logger ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.217Z,1626818214.217 [logger](INFO): Join timeout helper Thread ID is 2224
2021-07-20T21:56:54.248Z,1626818214.248 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:54.248Z,1626818214.248 [logger ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.257Z,1626818214.257 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-07-20T21:56:54.257Z,1626818214.257 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.257Z,1626818214.257 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-07-20T21:56:54.257Z,1626818214.257 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.257Z,1626818214.257 [controlThread](INFO): Join timeout helper Thread ID is 2225
2021-07-20T21:56:54.508Z,1626818214.508 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-07-20T21:56:54.508Z,1626818214.508 [controlThread](DEBUG): Uninitializing ControlThread
2021-07-20T21:56:54.509Z,1626818214.509 [AHRS_M2](INFO): Powering down
2021-07-20T21:56:54.581Z,1626818214.581 [NAL9602](INFO): Powering down
2021-07-20T21:56:54.583Z,1626818214.583 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-07-20T21:56:54.585Z,1626818214.585 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-07-20T21:56:54.585Z,1626818214.585 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-07-20T21:56:54.586Z,1626818214.586 [MissionManager](INFO): Uninitializing Mission Default
2021-07-20T21:56:54.586Z,1626818214.586 [Default] Stopped
2021-07-20T21:56:54.586Z,1626818214.586 [Default](DEBUG): Aggregate::uninitialize Default
2021-07-20T21:56:54.586Z,1626818214.586 [Default:B.GoToSurface] Stopped
2021-07-20T21:56:54.586Z,1626818214.586 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-07-20T21:56:54.586Z,1626818214.586 [Default:CheckIn] Stopped
2021-07-20T21:56:54.586Z,1626818214.586 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-07-20T21:56:54.586Z,1626818214.586 [Default:CheckIn:C.Wait] Stopped
2021-07-20T21:56:54.586Z,1626818214.586 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-07-20T21:56:54.590Z,1626818214.590 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-07-20T21:56:54.590Z,1626818214.590 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-07-20T21:56:54.591Z,1626818214.591 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-07-20T21:56:54.591Z,1626818214.591 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-07-20T21:56:54.591Z,1626818214.591 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-07-20T21:56:54.591Z,1626818214.591 [BuoyancyServo](INFO): Powering down
2021-07-20T21:56:54.604Z,1626818214.604 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-07-20T21:56:54.604Z,1626818214.604 [ElevatorServo](INFO): Powering down
2021-07-20T21:56:54.605Z,1626818214.605 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-07-20T21:56:54.605Z,1626818214.605 [MassServo](INFO): Powering down
2021-07-20T21:56:54.606Z,1626818214.606 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-07-20T21:56:54.606Z,1626818214.606 [RudderServo](INFO): Powering down
2021-07-20T21:56:54.607Z,1626818214.607 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-07-20T21:56:54.607Z,1626818214.607 [ThrusterServo](INFO): Powering down
2021-07-20T21:56:54.608Z,1626818214.608 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-07-20T21:56:54.609Z,1626818214.609 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-07-20T21:56:54.609Z,1626818214.609 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-07-20T21:56:54.609Z,1626818214.609 [CBIT](DEBUG): Powering off loads.
2021-07-20T21:56:54.620Z,1626818214.620 [CBIT](DEBUG): Disabling WDT.
2021-07-20T21:56:54.632Z,1626818214.632 [CBIT](DEBUG): Opening all GF detection circuits.
2021-07-20T21:56:54.633Z,1626818214.633 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.673Z,1626818214.673 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.677Z,1626818214.677 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.684Z,1626818214.684 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.765Z,1626818214.765 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.769Z,1626818214.769 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.810Z,1626818214.810 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-07-20T21:56:54.892Z,1626818214.892 [logger ThreadHandler](INFO): Thread cancelled.