2021-07-26T21:20:10.888Z,1627334410.888 [CommandLine](IMPORTANT): got command restart logs 2021-07-26T21:20:52.440Z,1627334452.440 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-07-26T21:20:52.444Z,1627334452.444 [BPC1](INFO): Received data from all battery sticks. 2021-07-26T21:23:06.553Z,1627334586.553 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:23:37.257Z,1627334617.257 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:23:44.951Z,1627334624.951 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:23:44.951Z,1627334624.951 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:23:44.951Z,1627334624.951 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:23:44.952Z,1627334624.952 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:23:45.359Z,1627334625.359 [Default:CheckIn:D] Stopped 2021-07-26T21:23:45.359Z,1627334625.359 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:23:45.757Z,1627334625.757 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.360136 min 2021-07-26T21:23:45.757Z,1627334625.757 [Default:CheckIn:E] Stopped 2021-07-26T21:23:45.757Z,1627334625.757 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:23:45.757Z,1627334625.757 [Default:CheckIn] Stopped 2021-07-26T21:23:45.757Z,1627334625.757 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:23:45.757Z,1627334625.757 [Default:CheckIn](INFO): Running loop #7 2021-07-26T21:23:45.758Z,1627334625.758 [Default:CheckIn] Running Loop=7 2021-07-26T21:23:45.758Z,1627334625.758 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:23:45.758Z,1627334625.758 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:23:47.762Z,1627334627.762 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212347.00,A,3648.16741,N,12147.27672,W,2.799,153.51,260721,,,A*70 2021-07-26T21:23:47.764Z,1627334627.764 [NAL9602](INFO): GPS fix at 20210726T212347: (36.802790, -121.787945) 2021-07-26T21:23:47.787Z,1627334627.787 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:23:47.787Z,1627334627.787 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:23:56.711Z,1627334636.711 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210726T200544/Courier0028.lzma 2021-07-26T21:23:57.713Z,1627334637.713 [DataOverHttps](INFO): Moved sent file to Logs/20210726T200544/Courier0028.lzma.bak 2021-07-26T21:23:57.713Z,1627334637.713 [DataOverHttps](INFO): SBD MOMSN=15762155 2021-07-26T21:24:14.715Z,1627334654.715 [DataOverHttps](INFO): Sending 309 bytes from file Logs/20210726T212010/Courier0000.lzma 2021-07-26T21:24:15.717Z,1627334655.717 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0000.lzma.bak 2021-07-26T21:24:15.717Z,1627334655.717 [DataOverHttps](INFO): SBD MOMSN=15762157 2021-07-26T21:24:18.490Z,1627334658.490 [NAL9602](INFO): SBD MO Status=2, MOMSN=28519, MT Status=2, MTMSN=0 2021-07-26T21:24:18.490Z,1627334658.490 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-07-26T21:24:43.963Z,1627334683.963 [DataOverHttps](INFO): Sending 103 bytes from file Logs/20210726T200544/Express0029.lzma 2021-07-26T21:24:44.965Z,1627334684.965 [DataOverHttps](INFO): Moved sent file to Logs/20210726T200544/Express0029.lzma.bak 2021-07-26T21:24:44.965Z,1627334684.965 [DataOverHttps](INFO): SBD MOMSN=15762161 2021-07-26T21:25:03.112Z,1627334703.112 [DataOverHttps](INFO): Sending 467 bytes from file Logs/20210726T212010/Express0001.lzma 2021-07-26T21:25:04.113Z,1627334704.113 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0001.lzma.bak 2021-07-26T21:25:04.113Z,1627334704.113 [DataOverHttps](INFO): SBD MOMSN=15762164 2021-07-26T21:25:22.379Z,1627334722.379 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20210726T212010/Express0004.lzma 2021-07-26T21:25:23.381Z,1627334723.381 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0004.lzma.bak 2021-07-26T21:25:23.381Z,1627334723.381 [DataOverHttps](INFO): SBD MOMSN=15762169 2021-07-26T21:25:26.941Z,1627334726.941 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:25:26.941Z,1627334726.941 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:25:26.941Z,1627334726.941 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T21:28:50.529Z,1627334930.529 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:29:21.240Z,1627334961.240 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:30:27.517Z,1627335027.517 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:30:27.517Z,1627335027.517 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:30:27.517Z,1627335027.517 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:30:27.517Z,1627335027.517 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:30:27.948Z,1627335027.948 [Default:CheckIn:D] Stopped 2021-07-26T21:30:27.948Z,1627335027.948 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:30:28.319Z,1627335028.319 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.069958 min 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn:E] Stopped 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn] Stopped 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn](INFO): Running loop #8 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn] Running Loop=8 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:30:28.320Z,1627335028.320 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:30:30.326Z,1627335030.326 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213029.00,A,3648.17243,N,12147.28398,W,0.641,243.69,260721,,,A*7D 2021-07-26T21:30:30.329Z,1627335030.329 [NAL9602](INFO): GPS fix at 20210726T213029: (36.802874, -121.788066) 2021-07-26T21:30:30.384Z,1627335030.384 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:30:30.384Z,1627335030.384 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:30:41.047Z,1627335041.047 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0006.lzma 2021-07-26T21:30:42.049Z,1627335042.049 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0006.lzma.bak 2021-07-26T21:30:42.049Z,1627335042.049 [DataOverHttps](INFO): SBD MOMSN=15762171 2021-07-26T21:31:00.191Z,1627335060.191 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20210726T212010/Express0007.lzma 2021-07-26T21:31:01.049Z,1627335061.049 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-26T21:31:01.131Z,1627335061.131 [NAL9602](ERROR): received: +CSQ:0 OK519, 2, 0, 0, 0 OK 2021-07-26T21:31:01.193Z,1627335061.193 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0007.lzma.bak 2021-07-26T21:31:01.193Z,1627335061.193 [DataOverHttps](INFO): SBD MOMSN=15762174 2021-07-26T21:31:04.717Z,1627335064.717 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:31:04.717Z,1627335064.717 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:31:04.717Z,1627335064.717 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T21:35:32.253Z,1627335332.253 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:36:02.956Z,1627335362.956 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:36:05.406Z,1627335365.406 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:36:05.406Z,1627335365.406 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:36:05.406Z,1627335365.406 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:36:05.407Z,1627335365.407 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:36:05.801Z,1627335365.801 [Default:CheckIn:D] Stopped 2021-07-26T21:36:05.801Z,1627335365.801 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:36:06.199Z,1627335366.199 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.700834 min 2021-07-26T21:36:06.199Z,1627335366.199 [Default:CheckIn:E] Stopped 2021-07-26T21:36:06.199Z,1627335366.199 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:36:06.199Z,1627335366.199 [Default:CheckIn] Stopped 2021-07-26T21:36:06.199Z,1627335366.199 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:36:06.200Z,1627335366.200 [Default:CheckIn](INFO): Running loop #9 2021-07-26T21:36:06.200Z,1627335366.200 [Default:CheckIn] Running Loop=9 2021-07-26T21:36:06.200Z,1627335366.200 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:36:06.200Z,1627335366.200 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:36:08.212Z,1627335368.212 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213607.00,A,3648.16645,N,12147.28233,W,0.525,336.88,260721,,,A*79 2021-07-26T21:36:08.214Z,1627335368.214 [NAL9602](INFO): GPS fix at 20210726T213607: (36.802774, -121.788039) 2021-07-26T21:36:08.225Z,1627335368.225 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:36:08.225Z,1627335368.225 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:36:16.735Z,1627335376.735 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0009.lzma 2021-07-26T21:36:17.737Z,1627335377.737 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0009.lzma.bak 2021-07-26T21:36:17.737Z,1627335377.737 [DataOverHttps](INFO): SBD MOMSN=15762178 2021-07-26T21:36:38.645Z,1627335398.645 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-26T21:36:38.727Z,1627335398.727 [NAL9602](ERROR): received: +CSQ:0 OK519, 2, 0, 0, 0 OK 2021-07-26T21:36:43.187Z,1627335403.187 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20210726T212010/Express0010.lzma 2021-07-26T21:36:44.189Z,1627335404.189 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0010.lzma.bak 2021-07-26T21:36:44.189Z,1627335404.189 [DataOverHttps](INFO): SBD MOMSN=15762181 2021-07-26T21:36:47.951Z,1627335407.951 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:36:47.952Z,1627335407.952 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:36:47.952Z,1627335407.952 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T21:41:10.527Z,1627335670.527 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:41:41.228Z,1627335701.228 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:41:48.512Z,1627335708.512 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:41:48.513Z,1627335708.513 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:41:48.513Z,1627335708.513 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:41:48.513Z,1627335708.513 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:41:48.928Z,1627335708.928 [Default:CheckIn:D] Stopped 2021-07-26T21:41:48.928Z,1627335708.928 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:41:49.323Z,1627335709.323 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 57.419629 min 2021-07-26T21:41:49.323Z,1627335709.323 [Default:CheckIn:E] Stopped 2021-07-26T21:41:49.323Z,1627335709.323 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:41:49.323Z,1627335709.323 [Default:CheckIn] Stopped 2021-07-26T21:41:49.323Z,1627335709.323 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:41:49.324Z,1627335709.324 [Default:CheckIn](INFO): Running loop #10 2021-07-26T21:41:49.324Z,1627335709.324 [Default:CheckIn] Running Loop=10 2021-07-26T21:41:49.324Z,1627335709.324 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:41:49.324Z,1627335709.324 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:41:51.331Z,1627335711.331 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214150.00,A,3648.17287,N,12147.28302,W,0.447,141.59,260721,,,A*78 2021-07-26T21:41:51.333Z,1627335711.333 [NAL9602](INFO): GPS fix at 20210726T214150: (36.802881, -121.788050) 2021-07-26T21:41:51.344Z,1627335711.344 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:41:51.344Z,1627335711.344 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:42:00.107Z,1627335720.107 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0012.lzma 2021-07-26T21:42:01.109Z,1627335721.109 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0012.lzma.bak 2021-07-26T21:42:01.109Z,1627335721.109 [DataOverHttps](INFO): SBD MOMSN=15762185 2021-07-26T21:42:21.567Z,1627335741.567 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210726T212010/Express0013.lzma 2021-07-26T21:42:22.570Z,1627335742.570 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0013.lzma.bak 2021-07-26T21:42:22.570Z,1627335742.570 [DataOverHttps](INFO): SBD MOMSN=15762188 2021-07-26T21:42:28.220Z,1627335748.220 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:42:28.221Z,1627335748.221 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:42:28.221Z,1627335748.221 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T21:46:53.473Z,1627336013.473 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:47:24.180Z,1627336044.180 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:47:29.034Z,1627336049.034 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:47:29.034Z,1627336049.034 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:47:29.035Z,1627336049.035 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:47:29.035Z,1627336049.035 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:47:29.435Z,1627336049.435 [Default:CheckIn:D] Stopped 2021-07-26T21:47:29.435Z,1627336049.435 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:47:29.853Z,1627336049.853 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.094735 min 2021-07-26T21:47:29.853Z,1627336049.853 [Default:CheckIn:E] Stopped 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn] Stopped 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn](INFO): Running loop #11 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn] Running Loop=11 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:47:29.854Z,1627336049.854 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:47:31.851Z,1627336051.851 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214731.00,A,3648.16846,N,12147.28355,W,0.272,141.59,260721,,,A*7D 2021-07-26T21:47:31.854Z,1627336051.854 [NAL9602](INFO): GPS fix at 20210726T214731: (36.802808, -121.788059) 2021-07-26T21:47:31.892Z,1627336051.892 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:47:31.892Z,1627336051.892 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:47:41.455Z,1627336061.455 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0015.lzma 2021-07-26T21:47:42.457Z,1627336062.457 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0015.lzma.bak 2021-07-26T21:47:42.457Z,1627336062.457 [DataOverHttps](INFO): SBD MOMSN=15762192 2021-07-26T21:48:00.615Z,1627336080.615 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20210726T212010/Express0016.lzma 2021-07-26T21:48:01.619Z,1627336081.619 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0016.lzma.bak 2021-07-26T21:48:01.619Z,1627336081.619 [DataOverHttps](INFO): SBD MOMSN=15762195 2021-07-26T21:48:04.991Z,1627336084.991 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:48:04.992Z,1627336084.992 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:48:04.992Z,1627336084.992 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T21:52:34.661Z,1627336354.661 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:53:05.364Z,1627336385.364 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:53:05.788Z,1627336385.788 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:53:05.788Z,1627336385.788 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:53:05.788Z,1627336385.788 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:53:05.789Z,1627336385.789 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:53:06.194Z,1627336386.194 [Default:CheckIn:D] Stopped 2021-07-26T21:53:06.194Z,1627336386.194 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:53:06.606Z,1627336386.606 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 68.707389 min 2021-07-26T21:53:06.606Z,1627336386.606 [Default:CheckIn:E] Stopped 2021-07-26T21:53:06.607Z,1627336386.607 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:53:06.607Z,1627336386.607 [Default:CheckIn] Stopped 2021-07-26T21:53:06.607Z,1627336386.607 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:53:06.607Z,1627336386.607 [Default:CheckIn](INFO): Running loop #12 2021-07-26T21:53:06.607Z,1627336386.607 [Default:CheckIn] Running Loop=12 2021-07-26T21:53:06.607Z,1627336386.607 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:53:06.608Z,1627336386.608 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:53:08.599Z,1627336388.599 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215307.00,A,3648.16456,N,12147.28046,W,0.952,350.64,260721,,,A*74 2021-07-26T21:53:08.601Z,1627336388.601 [NAL9602](INFO): GPS fix at 20210726T215307: (36.802743, -121.788008) 2021-07-26T21:53:08.612Z,1627336388.612 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:53:08.612Z,1627336388.612 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:53:19.067Z,1627336399.067 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0018.lzma 2021-07-26T21:53:20.069Z,1627336400.069 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0018.lzma.bak 2021-07-26T21:53:20.069Z,1627336400.069 [DataOverHttps](INFO): SBD MOMSN=15762199 2021-07-26T21:53:38.247Z,1627336418.247 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20210726T212010/Express0019.lzma 2021-07-26T21:53:39.249Z,1627336419.249 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0019.lzma.bak 2021-07-26T21:53:39.249Z,1627336419.249 [DataOverHttps](INFO): SBD MOMSN=15762202 2021-07-26T21:53:39.307Z,1627336419.307 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-26T21:53:39.383Z,1627336419.383 [NAL9602](ERROR): received: +CSQ:0 OK519, 2, 0, 0, 0 OK 2021-07-26T21:53:42.957Z,1627336422.957 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:53:42.957Z,1627336422.957 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:53:42.957Z,1627336422.957 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T21:58:10.513Z,1627336690.513 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T21:58:41.252Z,1627336721.252 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T21:58:43.687Z,1627336723.687 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T21:58:43.687Z,1627336723.687 [Default:CheckIn:C.Wait] Stopped 2021-07-26T21:58:43.687Z,1627336723.687 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T21:58:43.687Z,1627336723.687 [Default:CheckIn:D] Running Loop=1 2021-07-26T21:58:44.108Z,1627336724.108 [Default:CheckIn:D] Stopped 2021-07-26T21:58:44.109Z,1627336724.109 [Default:CheckIn:E] Running Loop=1 2021-07-26T21:58:44.494Z,1627336724.494 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.339299 min 2021-07-26T21:58:44.495Z,1627336724.495 [Default:CheckIn:E] Stopped 2021-07-26T21:58:44.495Z,1627336724.495 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T21:58:44.495Z,1627336724.495 [Default:CheckIn] Stopped 2021-07-26T21:58:44.495Z,1627336724.495 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T21:58:44.507Z,1627336724.507 [Default:CheckIn](INFO): Running loop #13 2021-07-26T21:58:44.507Z,1627336724.507 [Default:CheckIn] Running Loop=13 2021-07-26T21:58:44.508Z,1627336724.508 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T21:58:44.508Z,1627336724.508 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T21:58:46.513Z,1627336726.513 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,215845.00,A,3648.16709,N,12147.28693,W,0.311,350.64,260721,,,A*73 2021-07-26T21:58:46.516Z,1627336726.516 [NAL9602](INFO): GPS fix at 20210726T215845: (36.802785, -121.788116) 2021-07-26T21:58:46.553Z,1627336726.553 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T21:58:46.553Z,1627336726.553 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T21:58:55.195Z,1627336735.195 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0021.lzma 2021-07-26T21:58:56.197Z,1627336736.197 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0021.lzma.bak 2021-07-26T21:58:56.198Z,1627336736.198 [DataOverHttps](INFO): SBD MOMSN=15762206 2021-07-26T21:59:14.167Z,1627336754.167 [DataOverHttps](INFO): Sending 204 bytes from file Logs/20210726T212010/Express0022.lzma 2021-07-26T21:59:15.169Z,1627336755.169 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0022.lzma.bak 2021-07-26T21:59:15.169Z,1627336755.169 [DataOverHttps](INFO): SBD MOMSN=15762209 2021-07-26T21:59:18.533Z,1627336758.533 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T21:59:18.533Z,1627336758.533 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T21:59:18.533Z,1627336758.533 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T22:03:48.358Z,1627337028.358 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T22:04:19.060Z,1627337059.060 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T22:04:19.076Z,1627337059.076 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T22:04:19.076Z,1627337059.076 [Default:CheckIn:C.Wait] Stopped 2021-07-26T22:04:19.076Z,1627337059.076 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T22:04:19.076Z,1627337059.076 [Default:CheckIn:D] Running Loop=1 2021-07-26T22:04:19.488Z,1627337059.488 [Default:CheckIn:D] Stopped 2021-07-26T22:04:19.488Z,1627337059.488 [Default:CheckIn:E] Running Loop=1 2021-07-26T22:04:19.906Z,1627337059.906 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 79.928955 min 2021-07-26T22:04:19.906Z,1627337059.906 [Default:CheckIn:E] Stopped 2021-07-26T22:04:19.906Z,1627337059.906 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T22:04:19.906Z,1627337059.906 [Default:CheckIn] Stopped 2021-07-26T22:04:19.906Z,1627337059.906 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T22:04:19.906Z,1627337059.906 [Default:CheckIn](INFO): Running loop #14 2021-07-26T22:04:19.907Z,1627337059.907 [Default:CheckIn] Running Loop=14 2021-07-26T22:04:19.907Z,1627337059.907 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T22:04:19.907Z,1627337059.907 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T22:04:21.890Z,1627337061.890 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220421.00,A,3648.16599,N,12147.28092,W,0.603,350.64,260721,,,A*71 2021-07-26T22:04:21.893Z,1627337061.893 [NAL9602](INFO): GPS fix at 20210726T220421: (36.802766, -121.788015) 2021-07-26T22:04:21.913Z,1627337061.913 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T22:04:21.913Z,1627337061.913 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T22:04:34.651Z,1627337074.651 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0024.lzma 2021-07-26T22:04:35.653Z,1627337075.653 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0024.lzma.bak 2021-07-26T22:04:35.653Z,1627337075.653 [DataOverHttps](INFO): SBD MOMSN=15762213 2021-07-26T22:04:52.713Z,1627337092.713 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-26T22:04:52.787Z,1627337092.787 [NAL9602](ERROR): received: +CSQ:1 OK519, 2, 0, 0, 0 OK 2021-07-26T22:04:56.827Z,1627337096.827 [DataOverHttps](INFO): Sending 206 bytes from file Logs/20210726T212010/Express0025.lzma 2021-07-26T22:04:57.829Z,1627337097.829 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0025.lzma.bak 2021-07-26T22:04:57.829Z,1627337097.829 [DataOverHttps](INFO): SBD MOMSN=15762216 2021-07-26T22:05:01.247Z,1627337101.247 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T22:05:01.248Z,1627337101.248 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T22:05:01.248Z,1627337101.248 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T22:09:24.681Z,1627337364.681 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-07-26T22:09:55.380Z,1627337395.380 [NAL9602](INFO): Not Powering down - fast GPS 2021-07-26T22:10:01.855Z,1627337401.855 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-07-26T22:10:01.855Z,1627337401.855 [Default:CheckIn:C.Wait] Stopped 2021-07-26T22:10:01.855Z,1627337401.855 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T22:10:01.856Z,1627337401.856 [Default:CheckIn:D] Running Loop=1 2021-07-26T22:10:02.258Z,1627337402.258 [Default:CheckIn:D] Stopped 2021-07-26T22:10:02.258Z,1627337402.258 [Default:CheckIn:E] Running Loop=1 2021-07-26T22:10:02.673Z,1627337402.673 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 85.641781 min 2021-07-26T22:10:02.673Z,1627337402.673 [Default:CheckIn:E] Stopped 2021-07-26T22:10:02.673Z,1627337402.673 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-07-26T22:10:02.673Z,1627337402.673 [Default:CheckIn] Stopped 2021-07-26T22:10:02.673Z,1627337402.673 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T22:10:02.673Z,1627337402.673 [Default:CheckIn](INFO): Running loop #15 2021-07-26T22:10:02.674Z,1627337402.674 [Default:CheckIn] Running Loop=15 2021-07-26T22:10:02.674Z,1627337402.674 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-07-26T22:10:02.674Z,1627337402.674 [Default:CheckIn:Read_GPS] Running Loop=1 2021-07-26T22:10:04.670Z,1627337404.670 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221003.00,A,3648.16635,N,12147.28079,W,0.389,69.15,260721,,,A*4C 2021-07-26T22:10:04.673Z,1627337404.673 [NAL9602](INFO): GPS fix at 20210726T221003: (36.802773, -121.788013) 2021-07-26T22:10:04.684Z,1627337404.684 [Default:CheckIn:Read_GPS] Stopped 2021-07-26T22:10:04.684Z,1627337404.684 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-07-26T22:10:13.327Z,1627337413.327 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210726T212010/Courier0027.lzma 2021-07-26T22:10:14.329Z,1627337414.329 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Courier0027.lzma.bak 2021-07-26T22:10:14.329Z,1627337414.329 [DataOverHttps](INFO): SBD MOMSN=15762220 2021-07-26T22:10:35.493Z,1627337435.493 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-07-26T22:10:35.575Z,1627337435.575 [NAL9602](ERROR): received: +CSQ:0 OK519, 2, 0, 0, 0 OK 2021-07-26T22:10:41.928Z,1627337441.928 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20210726T212010/Express0028.lzma 2021-07-26T22:10:42.929Z,1627337442.929 [DataOverHttps](INFO): Moved sent file to Logs/20210726T212010/Express0028.lzma.bak 2021-07-26T22:10:42.929Z,1627337442.929 [DataOverHttps](INFO): SBD MOMSN=15762223 2021-07-26T22:10:46.497Z,1627337446.497 [Default:CheckIn:Read_Iridium] Stopped 2021-07-26T22:10:46.497Z,1627337446.497 [Default:CheckIn:C.Wait] Running Loop=1 2021-07-26T22:10:46.497Z,1627337446.497 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-07-26T22:12:39.013Z,1627337559.013 [DataOverHttps](IMPORTANT): SBD MTMSN=20210726T221238 2021-07-26T22:12:46.387Z,1627337566.387 [DataOverHttps](INFO): Received command:configSet VerticalControl.kiDepthBuoy 0.15 1/s persist;restart app 2021-07-26T22:12:46.703Z,1627337566.703 [CommandLine](IMPORTANT): got command configSet VerticalControl.kiDepthBuoy 0.150000 reciprocal_second persist 2021-07-26T22:12:46.705Z,1627337566.705 [CommandLine](IMPORTANT): got command restart application 2021-07-26T22:12:47.707Z,1627337567.707 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2021-07-26T22:12:47.708Z,1627337567.708 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:47.708Z,1627337567.708 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:47.743Z,1627337567.743 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-07-26T22:12:47.743Z,1627337567.743 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:47.744Z,1627337567.744 [CommandLine](INFO): Join timeout helper Thread ID is 6147 2021-07-26T22:12:47.745Z,1627337567.745 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-07-26T22:12:47.745Z,1627337567.745 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:47.745Z,1627337567.745 [NavChartDb](INFO): Join timeout helper Thread ID is 6148 2021-07-26T22:12:47.827Z,1627337567.827 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:47.828Z,1627337567.828 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:47.848Z,1627337567.848 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-07-26T22:12:47.848Z,1627337567.848 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:47.848Z,1627337567.848 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6149 2021-07-26T22:12:48.015Z,1627337568.015 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:48.016Z,1627337568.016 [WetLabsBB2FL](INFO): Powering down 2021-07-26T22:12:48.016Z,1627337568.016 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:48.027Z,1627337568.027 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-07-26T22:12:48.027Z,1627337568.027 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:48.028Z,1627337568.028 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6150 2021-07-26T22:12:48.063Z,1627337568.063 [CTD_Seabird](INFO): Powering down 2021-07-26T22:12:48.075Z,1627337568.075 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:48.076Z,1627337568.076 [CTD_Seabird](INFO): Powering down 2021-07-26T22:12:48.087Z,1627337568.087 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:48.091Z,1627337568.091 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-07-26T22:12:48.091Z,1627337568.091 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:48.092Z,1627337568.092 [Radio_Surface](INFO): Join timeout helper Thread ID is 6151 2021-07-26T22:12:48.291Z,1627337568.291 [Radio_Surface](INFO): Powering down 2021-07-26T22:12:48.292Z,1627337568.292 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:48.292Z,1627337568.292 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:48.308Z,1627337568.308 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-07-26T22:12:48.308Z,1627337568.308 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:48.309Z,1627337568.309 [Onboard](INFO): Join timeout helper Thread ID is 6152 2021-07-26T22:12:48.392Z,1627337568.392 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-07-26T22:12:51.491Z,1627337571.491 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:51.492Z,1627337571.492 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:51.504Z,1627337571.504 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-07-26T22:12:51.504Z,1627337571.504 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:51.504Z,1627337571.504 [DataOverHttps](INFO): Join timeout helper Thread ID is 6153 2021-07-26T22:12:52.407Z,1627337572.407 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:52.408Z,1627337572.408 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.420Z,1627337572.420 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-07-26T22:12:52.420Z,1627337572.420 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.421Z,1627337572.421 [logger](INFO): Join timeout helper Thread ID is 6154 2021-07-26T22:12:52.421Z,1627337572.421 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:52.421Z,1627337572.421 [logger ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.422Z,1627337572.422 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-07-26T22:12:52.422Z,1627337572.422 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.422Z,1627337572.422 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-07-26T22:12:52.423Z,1627337572.423 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.423Z,1627337572.423 [controlThread](INFO): Join timeout helper Thread ID is 6155 2021-07-26T22:12:52.495Z,1627337572.495 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-07-26T22:12:52.496Z,1627337572.496 [controlThread](DEBUG): Uninitializing ControlThread 2021-07-26T22:12:52.496Z,1627337572.496 [AHRS_M2](INFO): Powering down 2021-07-26T22:12:52.568Z,1627337572.568 [NAL9602](INFO): Powering down 2021-07-26T22:12:52.571Z,1627337572.571 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-07-26T22:12:52.572Z,1627337572.572 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-07-26T22:12:52.572Z,1627337572.572 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-07-26T22:12:52.573Z,1627337572.573 [MissionManager](INFO): Uninitializing Mission Default 2021-07-26T22:12:52.573Z,1627337572.573 [Default] Stopped 2021-07-26T22:12:52.573Z,1627337572.573 [Default](DEBUG): Aggregate::uninitialize Default 2021-07-26T22:12:52.573Z,1627337572.573 [Default:B.GoToSurface] Stopped 2021-07-26T22:12:52.573Z,1627337572.573 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-07-26T22:12:52.573Z,1627337572.573 [Default:CheckIn] Stopped 2021-07-26T22:12:52.574Z,1627337572.574 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-07-26T22:12:52.574Z,1627337572.574 [Default:CheckIn:C.Wait] Stopped 2021-07-26T22:12:52.574Z,1627337572.574 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-07-26T22:12:52.577Z,1627337572.577 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-07-26T22:12:52.577Z,1627337572.577 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-07-26T22:12:52.578Z,1627337572.578 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-07-26T22:12:52.578Z,1627337572.578 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-07-26T22:12:52.578Z,1627337572.578 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-07-26T22:12:52.579Z,1627337572.579 [BuoyancyServo](INFO): Powering down 2021-07-26T22:12:52.591Z,1627337572.591 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-07-26T22:12:52.592Z,1627337572.592 [ElevatorServo](INFO): Powering down 2021-07-26T22:12:52.593Z,1627337572.593 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-07-26T22:12:52.593Z,1627337572.593 [MassServo](INFO): Powering down 2021-07-26T22:12:52.594Z,1627337572.594 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-07-26T22:12:52.594Z,1627337572.594 [RudderServo](INFO): Powering down 2021-07-26T22:12:52.595Z,1627337572.595 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-07-26T22:12:52.595Z,1627337572.595 [ThrusterServo](INFO): Powering down 2021-07-26T22:12:52.596Z,1627337572.596 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-07-26T22:12:52.596Z,1627337572.596 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-07-26T22:12:52.596Z,1627337572.596 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-07-26T22:12:52.596Z,1627337572.596 [CBIT](DEBUG): Powering off loads. 2021-07-26T22:12:52.607Z,1627337572.607 [CBIT](DEBUG): Disabling WDT. 2021-07-26T22:12:52.619Z,1627337572.619 [CBIT](DEBUG): Opening all GF detection circuits. 2021-07-26T22:12:52.620Z,1627337572.620 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.658Z,1627337572.658 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.661Z,1627337572.661 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.668Z,1627337572.668 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.740Z,1627337572.740 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.744Z,1627337572.744 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.783Z,1627337572.783 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-07-26T22:12:52.861Z,1627337572.861 [logger ThreadHandler](INFO): Thread cancelled.