2021-10-06T16:43:00.684Z,1633538580.684 [NAL9602](INFO): Received command: restart logs 2021-10-06T16:43:00.686Z,1633538580.686 [CommandExec](IMPORTANT): got command restart logs 2021-10-06T16:43:00.986Z,1633538580.986 [CTD_Seabird](ERROR): Salinity reading out of range: 16.058168 psu 2021-10-06T16:43:01.991Z,1633538581.991 [CTD_Seabird](ERROR): Salinity reading out of range: 16.836983 psu 2021-10-06T16:43:02.994Z,1633538582.994 [CTD_Seabird](ERROR): Salinity reading out of range: 16.395185 psu 2021-10-06T16:43:03.998Z,1633538583.998 [CTD_Seabird](ERROR): Salinity reading out of range: 15.716593 psu 2021-10-06T16:43:06.006Z,1633538586.006 [CTD_Seabird](ERROR): Salinity reading out of range: 11.003761 psu 2021-10-06T16:43:07.010Z,1633538587.010 [CTD_Seabird](ERROR): Salinity reading out of range: 23.186373 psu 2021-10-06T16:43:08.014Z,1633538588.014 [CTD_Seabird](ERROR): Salinity reading out of range: 16.946508 psu 2021-10-06T16:43:09.018Z,1633538589.018 [CTD_Seabird](ERROR): Salinity reading out of range: 17.350706 psu 2021-10-06T16:43:10.022Z,1633538590.022 [CTD_Seabird](ERROR): Salinity reading out of range: 17.409737 psu 2021-10-06T16:43:11.026Z,1633538591.026 [CTD_Seabird](ERROR): Salinity reading out of range: 17.594618 psu 2021-10-06T16:43:12.030Z,1633538592.030 [CTD_Seabird](ERROR): Salinity reading out of range: 18.269943 psu 2021-10-06T16:43:12.520Z,1633538592.520 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:43:13.034Z,1633538593.034 [CTD_Seabird](ERROR): Salinity reading out of range: 16.753025 psu 2021-10-06T16:43:14.038Z,1633538594.038 [CTD_Seabird](ERROR): Salinity reading out of range: 21.405619 psu 2021-10-06T16:43:15.042Z,1633538595.042 [CTD_Seabird](ERROR): Salinity reading out of range: 11.321613 psu 2021-10-06T16:43:16.046Z,1633538596.046 [CTD_Seabird](ERROR): Salinity reading out of range: 25.623915 psu 2021-10-06T16:43:17.050Z,1633538597.050 [CTD_Seabird](ERROR): Salinity reading out of range: 17.320839 psu 2021-10-06T16:43:18.054Z,1633538598.054 [CTD_Seabird](ERROR): Salinity reading out of range: 18.478085 psu 2021-10-06T16:43:18.927Z,1633538598.927 [NAL9602](INFO): SBD MO Status=1, MOMSN=6454, MT Status=0, MTMSN=0 2021-10-06T16:43:18.980Z,1633538598.980 [NAL9602](INFO): Sent 39 bytes from file Logs/20211005T222135/Courier0166.lzma 2021-10-06T16:43:18.980Z,1633538598.980 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:43:19.058Z,1633538599.058 [CTD_Seabird](ERROR): Salinity reading out of range: 21.756176 psu 2021-10-06T16:43:20.062Z,1633538600.062 [CTD_Seabird](ERROR): Salinity reading out of range: 16.951818 psu 2021-10-06T16:43:21.066Z,1633538601.066 [CTD_Seabird](ERROR): Salinity reading out of range: 19.131662 psu 2021-10-06T16:43:22.070Z,1633538602.070 [CTD_Seabird](ERROR): Salinity reading out of range: 16.658092 psu 2021-10-06T16:43:23.074Z,1633538603.074 [CTD_Seabird](ERROR): Salinity reading out of range: 17.465479 psu 2021-10-06T16:43:24.078Z,1633538604.078 [CTD_Seabird](ERROR): Salinity reading out of range: 17.559027 psu 2021-10-06T16:43:25.082Z,1633538605.082 [CTD_Seabird](ERROR): Salinity reading out of range: 17.508240 psu 2021-10-06T16:43:26.086Z,1633538606.086 [CTD_Seabird](ERROR): Salinity reading out of range: 17.690989 psu 2021-10-06T16:43:27.090Z,1633538607.090 [CTD_Seabird](ERROR): Salinity reading out of range: 17.020241 psu 2021-10-06T16:43:27.619Z,1633538607.619 [NAL9602](INFO): SBD MO Status=1, MOMSN=6455, MT Status=0, MTMSN=0 2021-10-06T16:43:27.676Z,1633538607.676 [NAL9602](INFO): Sent 332 bytes from file Logs/20211005T222135/Express0164.lzma 2021-10-06T16:43:27.676Z,1633538607.676 [NAL9602](INFO): Packets left to send: 1 2021-10-06T16:43:28.094Z,1633538608.094 [CTD_Seabird](ERROR): Salinity reading out of range: 17.346777 psu 2021-10-06T16:43:29.098Z,1633538609.098 [CTD_Seabird](ERROR): Salinity reading out of range: 16.866411 psu 2021-10-06T16:43:30.102Z,1633538610.102 [CTD_Seabird](ERROR): Salinity reading out of range: 16.634995 psu 2021-10-06T16:43:31.106Z,1633538611.106 [CTD_Seabird](ERROR): Salinity reading out of range: 17.128288 psu 2021-10-06T16:43:32.110Z,1633538612.110 [CTD_Seabird](ERROR): Salinity reading out of range: 17.576906 psu 2021-10-06T16:43:33.114Z,1633538613.114 [CTD_Seabird](ERROR): Salinity reading out of range: 16.881485 psu 2021-10-06T16:43:34.118Z,1633538614.118 [CTD_Seabird](ERROR): Salinity reading out of range: 17.182358 psu 2021-10-06T16:43:35.122Z,1633538615.122 [CTD_Seabird](ERROR): Salinity reading out of range: 16.453238 psu 2021-10-06T16:43:36.126Z,1633538616.126 [CTD_Seabird](ERROR): Salinity reading out of range: 17.390657 psu 2021-10-06T16:43:37.102Z,1633538617.102 [NAL9602](INFO): SBD MO Status=1, MOMSN=6456, MT Status=0, MTMSN=0 2021-10-06T16:43:37.130Z,1633538617.130 [CTD_Seabird](ERROR): Salinity reading out of range: 16.716894 psu 2021-10-06T16:43:37.156Z,1633538617.156 [NAL9602](INFO): Sent 15 bytes from file Logs/20211005T222135/Express0164.lzma 2021-10-06T16:43:37.156Z,1633538617.156 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:43:38.134Z,1633538618.134 [CTD_Seabird](ERROR): Salinity reading out of range: 18.448084 psu 2021-10-06T16:43:39.138Z,1633538619.138 [CTD_Seabird](ERROR): Salinity reading out of range: 16.707636 psu 2021-10-06T16:43:40.142Z,1633538620.142 [CTD_Seabird](ERROR): Salinity reading out of range: 16.985498 psu 2021-10-06T16:43:41.146Z,1633538621.146 [CTD_Seabird](ERROR): Salinity reading out of range: 17.450743 psu 2021-10-06T16:43:42.155Z,1633538622.155 [CTD_Seabird](ERROR): Salinity reading out of range: 16.375967 psu 2021-10-06T16:43:43.158Z,1633538623.158 [CTD_Seabird](ERROR): Salinity reading out of range: 16.711432 psu 2021-10-06T16:43:44.162Z,1633538624.162 [CTD_Seabird](ERROR): Salinity reading out of range: 16.970821 psu 2021-10-06T16:43:45.166Z,1633538625.166 [CTD_Seabird](ERROR): Salinity reading out of range: 16.507057 psu 2021-10-06T16:43:46.170Z,1633538626.170 [CTD_Seabird](ERROR): Salinity reading out of range: 16.349947 psu 2021-10-06T16:43:47.174Z,1633538627.174 [CTD_Seabird](ERROR): Salinity reading out of range: 16.658043 psu 2021-10-06T16:43:47.660Z,1633538627.660 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:43:48.178Z,1633538628.178 [CTD_Seabird](ERROR): Salinity reading out of range: 16.532831 psu 2021-10-06T16:43:48.230Z,1633538628.230 [NAL9602](INFO): SBD MO Status=1, MOMSN=6457, MT Status=0, MTMSN=0 2021-10-06T16:43:48.280Z,1633538628.280 [NAL9602](INFO): Sent 137 bytes from file Logs/20211005T222135/Express0167.lzma 2021-10-06T16:43:48.280Z,1633538628.280 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:43:49.182Z,1633538629.182 [CTD_Seabird](ERROR): Salinity reading out of range: 16.611509 psu 2021-10-06T16:43:50.187Z,1633538630.187 [CTD_Seabird](ERROR): Salinity reading out of range: 16.391548 psu 2021-10-06T16:43:51.190Z,1633538631.190 [CTD_Seabird](ERROR): Salinity reading out of range: 16.909107 psu 2021-10-06T16:43:52.194Z,1633538632.194 [CTD_Seabird](ERROR): Salinity reading out of range: 16.385164 psu 2021-10-06T16:43:53.198Z,1633538633.198 [CTD_Seabird](ERROR): Salinity reading out of range: 16.569695 psu 2021-10-06T16:43:54.202Z,1633538634.202 [CTD_Seabird](ERROR): Salinity reading out of range: 16.540943 psu 2021-10-06T16:43:55.206Z,1633538635.206 [CTD_Seabird](ERROR): Salinity reading out of range: 16.163263 psu 2021-10-06T16:43:56.210Z,1633538636.210 [CTD_Seabird](ERROR): Salinity reading out of range: 16.791784 psu 2021-10-06T16:43:57.214Z,1633538637.214 [CTD_Seabird](ERROR): Salinity reading out of range: 16.239710 psu 2021-10-06T16:43:58.218Z,1633538638.218 [CTD_Seabird](ERROR): Salinity reading out of range: 16.556412 psu 2021-10-06T16:43:58.741Z,1633538638.741 [NAL9602](INFO): SBD MO Status=0, MOMSN=6458, MT Status=0, MTMSN=0 2021-10-06T16:43:59.222Z,1633538639.222 [CTD_Seabird](ERROR): Salinity reading out of range: 16.409338 psu 2021-10-06T16:44:00.226Z,1633538640.226 [CTD_Seabird](ERROR): Salinity reading out of range: 16.353483 psu 2021-10-06T16:44:01.230Z,1633538641.230 [CTD_Seabird](ERROR): Salinity reading out of range: 16.805294 psu 2021-10-06T16:44:02.234Z,1633538642.234 [CTD_Seabird](ERROR): Salinity reading out of range: 16.495070 psu 2021-10-06T16:44:03.238Z,1633538643.238 [CTD_Seabird](ERROR): Salinity reading out of range: 16.343689 psu 2021-10-06T16:44:04.242Z,1633538644.242 [CTD_Seabird](ERROR): Salinity reading out of range: 16.413794 psu 2021-10-06T16:44:05.246Z,1633538645.246 [CTD_Seabird](ERROR): Salinity reading out of range: 16.282238 psu 2021-10-06T16:44:06.250Z,1633538646.250 [CTD_Seabird](ERROR): Salinity reading out of range: 16.811174 psu 2021-10-06T16:44:07.254Z,1633538647.254 [CTD_Seabird](ERROR): Salinity reading out of range: 16.393661 psu 2021-10-06T16:44:08.258Z,1633538648.258 [CTD_Seabird](ERROR): Salinity reading out of range: 17.324825 psu 2021-10-06T16:44:09.320Z,1633538649.320 [CTD_Seabird](ERROR): Salinity reading out of range: 16.778328 psu 2021-10-06T16:44:10.301Z,1633538650.301 [CTD_Seabird](ERROR): Salinity reading out of range: 16.438391 psu 2021-10-06T16:44:11.305Z,1633538651.305 [CTD_Seabird](ERROR): Salinity reading out of range: 16.715008 psu 2021-10-06T16:44:12.308Z,1633538652.308 [CTD_Seabird](ERROR): Salinity reading out of range: 16.836195 psu 2021-10-06T16:44:13.301Z,1633538653.301 [CTD_Seabird](ERROR): Salinity reading out of range: 16.294359 psu 2021-10-06T16:44:14.305Z,1633538654.305 [CTD_Seabird](ERROR): Salinity reading out of range: 20.805689 psu 2021-10-06T16:44:15.308Z,1633538655.308 [CTD_Seabird](ERROR): Salinity reading out of range: 16.794886 psu 2021-10-06T16:44:16.305Z,1633538656.305 [CTD_Seabird](ERROR): Salinity reading out of range: 17.577486 psu 2021-10-06T16:44:17.305Z,1633538657.305 [CTD_Seabird](ERROR): Salinity reading out of range: 17.658714 psu 2021-10-06T16:44:18.214Z,1633538658.214 [NAL9602](INFO): SBD MO Status=1, MOMSN=6459, MT Status=0, MTMSN=0 2021-10-06T16:44:18.265Z,1633538658.265 [NAL9602](INFO): Sent 151 bytes from file Logs/20211006T164300/Courier0000.lzma 2021-10-06T16:44:18.265Z,1633538658.265 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:44:18.298Z,1633538658.298 [CTD_Seabird](ERROR): Salinity reading out of range: 11.658706 psu 2021-10-06T16:44:20.306Z,1633538660.306 [CTD_Seabird](ERROR): Salinity reading out of range: 16.837490 psu 2021-10-06T16:44:21.310Z,1633538661.310 [CTD_Seabird](ERROR): Salinity reading out of range: 25.261709 psu 2021-10-06T16:44:22.314Z,1633538662.314 [CTD_Seabird](ERROR): Salinity reading out of range: 17.367382 psu 2021-10-06T16:44:22.804Z,1633538662.804 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:44:23.318Z,1633538663.318 [CTD_Seabird](ERROR): Salinity reading out of range: 16.403889 psu 2021-10-06T16:44:24.322Z,1633538664.322 [CTD_Seabird](ERROR): Salinity reading out of range: 20.395163 psu 2021-10-06T16:44:25.326Z,1633538665.326 [CTD_Seabird](ERROR): Salinity reading out of range: 16.681759 psu 2021-10-06T16:44:26.330Z,1633538666.330 [CTD_Seabird](ERROR): Salinity reading out of range: 16.887991 psu 2021-10-06T16:44:27.334Z,1633538667.334 [CTD_Seabird](ERROR): Salinity reading out of range: 16.520182 psu 2021-10-06T16:44:28.338Z,1633538668.338 [CTD_Seabird](ERROR): Salinity reading out of range: 17.423149 psu 2021-10-06T16:44:29.342Z,1633538669.342 [CTD_Seabird](ERROR): Salinity reading out of range: 16.571243 psu 2021-10-06T16:44:30.346Z,1633538670.346 [CTD_Seabird](ERROR): Salinity reading out of range: 16.522326 psu 2021-10-06T16:44:31.350Z,1633538671.350 [CTD_Seabird](ERROR): Salinity reading out of range: 18.575365 psu 2021-10-06T16:44:32.354Z,1633538672.354 [CTD_Seabird](ERROR): Salinity reading out of range: 22.264694 psu 2021-10-06T16:44:32.488Z,1633538672.488 [NAL9602](INFO): SBD MO Status=2, MOMSN=6460, MT Status=2, MTMSN=0 2021-10-06T16:44:32.488Z,1633538672.488 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:44:33.358Z,1633538673.358 [CTD_Seabird](ERROR): Salinity reading out of range: 17.119942 psu 2021-10-06T16:44:34.362Z,1633538674.362 [CTD_Seabird](ERROR): Salinity reading out of range: 25.565905 psu 2021-10-06T16:44:35.366Z,1633538675.366 [CTD_Seabird](ERROR): Salinity reading out of range: 16.822800 psu 2021-10-06T16:44:36.370Z,1633538676.370 [CTD_Seabird](ERROR): Salinity reading out of range: 16.621763 psu 2021-10-06T16:44:37.374Z,1633538677.374 [CTD_Seabird](ERROR): Salinity reading out of range: 18.621233 psu 2021-10-06T16:44:38.382Z,1633538678.382 [CTD_Seabird](ERROR): Salinity reading out of range: 17.347548 psu 2021-10-06T16:44:39.382Z,1633538679.382 [CTD_Seabird](ERROR): Salinity reading out of range: 16.960157 psu 2021-10-06T16:44:40.386Z,1633538680.386 [CTD_Seabird](ERROR): Salinity reading out of range: 17.199938 psu 2021-10-06T16:44:41.390Z,1633538681.390 [CTD_Seabird](ERROR): Salinity reading out of range: 16.370972 psu 2021-10-06T16:44:42.394Z,1633538682.394 [CTD_Seabird](ERROR): Salinity reading out of range: 16.898731 psu 2021-10-06T16:44:43.398Z,1633538683.398 [CTD_Seabird](ERROR): Salinity reading out of range: 16.441271 psu 2021-10-06T16:44:44.402Z,1633538684.402 [CTD_Seabird](ERROR): Salinity reading out of range: 16.380714 psu 2021-10-06T16:44:45.406Z,1633538685.406 [CTD_Seabird](ERROR): Salinity reading out of range: 16.450226 psu 2021-10-06T16:44:46.410Z,1633538686.410 [CTD_Seabird](ERROR): Salinity reading out of range: 16.369631 psu 2021-10-06T16:44:47.414Z,1633538687.414 [CTD_Seabird](ERROR): Salinity reading out of range: 17.739084 psu 2021-10-06T16:44:48.418Z,1633538688.418 [CTD_Seabird](ERROR): Salinity reading out of range: 17.065180 psu 2021-10-06T16:44:49.422Z,1633538689.422 [CTD_Seabird](ERROR): Salinity reading out of range: 17.032406 psu 2021-10-06T16:44:50.426Z,1633538690.426 [CTD_Seabird](ERROR): Salinity reading out of range: 16.480844 psu 2021-10-06T16:44:51.430Z,1633538691.430 [CTD_Seabird](ERROR): Salinity reading out of range: 16.851900 psu 2021-10-06T16:44:52.434Z,1633538692.434 [CTD_Seabird](ERROR): Salinity reading out of range: 16.409407 psu 2021-10-06T16:44:53.438Z,1633538693.438 [CTD_Seabird](ERROR): Salinity reading out of range: 17.190630 psu 2021-10-06T16:44:54.442Z,1633538694.442 [CTD_Seabird](ERROR): Salinity reading out of range: 16.439865 psu 2021-10-06T16:44:55.446Z,1633538695.446 [CTD_Seabird](ERROR): Salinity reading out of range: 16.368080 psu 2021-10-06T16:44:56.450Z,1633538696.450 [CTD_Seabird](ERROR): Salinity reading out of range: 18.782431 psu 2021-10-06T16:44:57.454Z,1633538697.454 [CTD_Seabird](ERROR): Salinity reading out of range: 17.144745 psu 2021-10-06T16:44:57.944Z,1633538697.944 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:44:58.458Z,1633538698.458 [CTD_Seabird](ERROR): Salinity reading out of range: 16.343712 psu 2021-10-06T16:44:59.462Z,1633538699.462 [CTD_Seabird](ERROR): Salinity reading out of range: 18.633490 psu 2021-10-06T16:45:00.466Z,1633538700.466 [CTD_Seabird](ERROR): Salinity reading out of range: 16.457138 psu 2021-10-06T16:45:01.470Z,1633538701.470 [CTD_Seabird](ERROR): Salinity reading out of range: 18.415409 psu 2021-10-06T16:45:02.474Z,1633538702.474 [CTD_Seabird](ERROR): Salinity reading out of range: 18.461554 psu 2021-10-06T16:45:03.478Z,1633538703.478 [CTD_Seabird](ERROR): Salinity reading out of range: 19.025820 psu 2021-10-06T16:45:04.482Z,1633538704.482 [CTD_Seabird](ERROR): Salinity reading out of range: 17.992792 psu 2021-10-06T16:45:05.486Z,1633538705.486 [CTD_Seabird](ERROR): Salinity reading out of range: 20.849401 psu 2021-10-06T16:45:06.490Z,1633538706.490 [CTD_Seabird](ERROR): Salinity reading out of range: 27.452351 psu 2021-10-06T16:45:06.739Z,1633538706.739 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=6460, MT Status=1, MTMSN=427 2021-10-06T16:45:06.796Z,1633538706.796 [NAL9602](INFO): Sent 332 bytes from file Logs/20211006T164300/Express0001.lzma 2021-10-06T16:45:06.796Z,1633538706.796 [NAL9602](INFO): Packets left to send: 1 2021-10-06T16:45:07.228Z,1633538707.228 [NAL9602](INFO): Received command: stop 2021-10-06T16:45:07.245Z,1633538707.245 [CommandExec](IMPORTANT): got command stop 2021-10-06T16:45:07.245Z,1633538707.245 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2021-10-06T16:45:07.273Z,1633538707.273 [MissionManager](INFO): MissionManager is completed. 2021-10-06T16:45:07.274Z,1633538707.274 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2021-10-06T16:45:07.274Z,1633538707.274 [run_backseat_on_surface] Stopped 2021-10-06T16:45:07.274Z,1633538707.274 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2021-10-06T16:45:07.274Z,1633538707.274 [run_backseat_on_surface:Science] Stopped 2021-10-06T16:45:07.274Z,1633538707.274 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science 2021-10-06T16:45:07.274Z,1633538707.274 [run_backseat_on_surface:Science:B] Stopped 2021-10-06T16:45:07.274Z,1633538707.274 [run_backseat_on_surface:Science:C] Stopped 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:Science:E] Stopped 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:Science:OceanCurrent] Stopped 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:B.BackseatDriver] Stopped 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Uninitialize. 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:C.GoToSurface] Stopped 2021-10-06T16:45:07.275Z,1633538707.275 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-10-06T16:45:07.276Z,1633538707.276 [run_backseat_on_surface:CheckIn] Stopped 2021-10-06T16:45:07.276Z,1633538707.276 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2021-10-06T16:45:07.276Z,1633538707.276 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped 2021-10-06T16:45:07.520Z,1633538707.520 [WetLabsBB2FL](INFO): Powering down 2021-10-06T16:45:07.554Z,1633538707.554 [MissionManager](IMPORTANT): Started mission Default 2021-10-06T16:45:07.555Z,1633538707.555 [Default] Running Loop=1 2021-10-06T16:45:07.555Z,1633538707.555 [Default](DEBUG): Aggregate::initialize Default 2021-10-06T16:45:07.555Z,1633538707.555 [Default:B.GoToSurface] Running Loop=1 2021-10-06T16:45:07.555Z,1633538707.555 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-10-06T16:45:07.555Z,1633538707.555 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-10-06T16:45:07.556Z,1633538707.556 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-10-06T16:45:07.556Z,1633538707.556 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-10-06T16:45:07.557Z,1633538707.557 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-10-06T16:45:07.557Z,1633538707.557 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-10-06T16:45:07.558Z,1633538707.558 [Default:A.Wait] Running Loop=1 2021-10-06T16:45:07.558Z,1633538707.558 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-10-06T16:45:09.381Z,1633538709.381 [BackseatComponent](INFO): Sent LCM shutdown request. 2021-10-06T16:45:20.883Z,1633538720.883 [Default:A.Wait](INFO): Done Waiting. 2021-10-06T16:45:20.883Z,1633538720.883 [Default:A.Wait] Stopped 2021-10-06T16:45:20.883Z,1633538720.883 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T16:45:21.288Z,1633538721.288 [Default:CheckIn] Running Loop=1 2021-10-06T16:45:21.288Z,1633538721.288 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T16:45:21.289Z,1633538721.289 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T16:45:23.307Z,1633538723.307 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164521.00,A,3648.47527,N,12148.57892,W,4.976,97.84,061021,,,D*43 2021-10-06T16:45:23.310Z,1633538723.310 [NAL9602](INFO): GPS fix at 20211006T164521: (36.807921, -121.809649) 2021-10-06T16:45:23.321Z,1633538723.321 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T16:45:23.321Z,1633538723.321 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T16:45:24.532Z,1633538724.532 [BackseatComponent](INFO): Powering down 2021-10-06T16:45:24.736Z,1633538724.736 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2021-10-06T16:45:24.736Z,1633538724.736 [LcmUniversalReporter](INFO): Deactivating messaging. 2021-10-06T16:45:33.084Z,1633538733.084 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:46:01.323Z,1633538761.323 [NAL9602](INFO): SBD MO Status=1, MOMSN=6461, MT Status=0, MTMSN=0 2021-10-06T16:46:01.380Z,1633538761.380 [NAL9602](INFO): Sent 225 bytes from file Logs/20211006T164300/Courier0003.lzma 2021-10-06T16:46:01.380Z,1633538761.380 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:46:08.224Z,1633538768.224 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:46:08.631Z,1633538768.631 [NAL9602](INFO): SBD MO Status=1, MOMSN=6462, MT Status=0, MTMSN=0 2021-10-06T16:46:08.684Z,1633538768.684 [NAL9602](INFO): Sent 207 bytes from file Logs/20211006T164300/Express0001.lzma 2021-10-06T16:46:08.684Z,1633538768.684 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:46:20.403Z,1633538780.403 [NAL9602](INFO): SBD MO Status=1, MOMSN=6463, MT Status=0, MTMSN=0 2021-10-06T16:46:20.456Z,1633538780.456 [NAL9602](INFO): Sent 247 bytes from file Logs/20211006T164300/Express0004.lzma 2021-10-06T16:46:20.456Z,1633538780.456 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:46:31.319Z,1633538791.319 [NAL9602](INFO): SBD MO Status=0, MOMSN=6464, MT Status=0, MTMSN=0 2021-10-06T16:46:43.377Z,1633538803.377 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:47:12.978Z,1633538832.978 [NAL9602](INFO): SBD MO Status=2, MOMSN=6465, MT Status=2, MTMSN=0 2021-10-06T16:47:12.979Z,1633538832.979 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:47:18.524Z,1633538838.524 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:47:50.998Z,1633538870.998 [NAL9602](INFO): SBD MO Status=2, MOMSN=6465, MT Status=2, MTMSN=0 2021-10-06T16:47:50.998Z,1633538870.998 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:47:53.664Z,1633538873.664 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:48:22.980Z,1633538902.980 [NAL9602](INFO): SBD MO Status=2, MOMSN=6465, MT Status=2, MTMSN=0 2021-10-06T16:48:22.980Z,1633538902.980 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:48:28.860Z,1633538908.860 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:48:49.698Z,1633538929.698 [NAL9602](INFO): SBD MO Status=1, MOMSN=6465, MT Status=0, MTMSN=0 2021-10-06T16:48:49.746Z,1633538929.746 [NAL9602](INFO): Sent 39 bytes from file Logs/20211006T164300/Courier0006.lzma 2021-10-06T16:48:49.746Z,1633538929.746 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:49:03.502Z,1633538943.502 [NAL9602](INFO): SBD MO Status=1, MOMSN=6466, MT Status=0, MTMSN=0 2021-10-06T16:49:03.556Z,1633538943.556 [NAL9602](INFO): Sent 83 bytes from file Logs/20211006T164300/Express0007.lzma 2021-10-06T16:49:03.556Z,1633538943.556 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:49:04.000Z,1633538944.000 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:49:18.859Z,1633538958.859 [NAL9602](INFO): SBD MO Status=2, MOMSN=6467, MT Status=2, MTMSN=0 2021-10-06T16:49:18.859Z,1633538958.859 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:49:39.152Z,1633538979.152 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:49:42.291Z,1633538982.291 [NAL9602](INFO): SBD MO Status=2, MOMSN=6467, MT Status=2, MTMSN=0 2021-10-06T16:49:42.291Z,1633538982.291 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:49:47.025Z,1633538987.025 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2021-10-06T16:49:50.307Z,1633538990.307 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2021-10-06T16:49:52.279Z,1633538992.279 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2021-10-06T16:49:56.713Z,1633538996.713 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2021-10-06T16:49:58.743Z,1633538998.743 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2021-10-06T16:50:03.191Z,1633539003.191 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2021-10-06T16:50:14.296Z,1633539014.296 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:50:18.248Z,1633539018.248 [NAL9602](INFO): SBD MO Status=0, MOMSN=6467, MT Status=0, MTMSN=0 2021-10-06T16:50:18.323Z,1633539018.323 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T16:50:18.323Z,1633539018.323 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T16:50:18.323Z,1633539018.323 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T16:50:48.946Z,1633539048.946 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T16:50:49.440Z,1633539049.440 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:51:24.580Z,1633539084.580 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:51:59.721Z,1633539119.721 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:52:34.868Z,1633539154.868 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:53:10.008Z,1633539190.008 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:53:45.148Z,1633539225.148 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:54:20.372Z,1633539260.372 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:54:55.512Z,1633539295.512 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:55:18.839Z,1633539318.839 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T16:55:18.839Z,1633539318.839 [Default:CheckIn:C.Wait] Stopped 2021-10-06T16:55:18.839Z,1633539318.839 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T16:55:18.840Z,1633539318.840 [Default:CheckIn:D] Running Loop=1 2021-10-06T16:55:19.235Z,1633539319.235 [Default:CheckIn:D] Stopped 2021-10-06T16:55:19.235Z,1633539319.235 [Default:CheckIn:E] Running Loop=1 2021-10-06T16:55:19.637Z,1633539319.637 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.194671 min 2021-10-06T16:55:19.637Z,1633539319.637 [Default:CheckIn:E] Stopped 2021-10-06T16:55:19.637Z,1633539319.637 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T16:55:19.637Z,1633539319.637 [Default:CheckIn] Stopped 2021-10-06T16:55:19.637Z,1633539319.637 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T16:55:19.638Z,1633539319.638 [Default:CheckIn](INFO): Running loop #2 2021-10-06T16:55:19.638Z,1633539319.638 [Default:CheckIn] Running Loop=2 2021-10-06T16:55:19.638Z,1633539319.638 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T16:55:19.638Z,1633539319.638 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T16:55:21.655Z,1633539321.655 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165519.00,A,3648.31615,N,12147.58051,W,4.898,84.78,061021,,,D*4D 2021-10-06T16:55:21.658Z,1633539321.658 [NAL9602](INFO): GPS fix at 20211006T165519: (36.805269, -121.793008) 2021-10-06T16:55:21.673Z,1633539321.673 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T16:55:21.673Z,1633539321.673 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T16:55:30.656Z,1633539330.656 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:55:46.740Z,1633539346.740 [NAL9602](INFO): SBD MO Status=2, MOMSN=6468, MT Status=2, MTMSN=0 2021-10-06T16:55:46.740Z,1633539346.740 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:56:05.820Z,1633539365.820 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:56:15.074Z,1633539375.074 [NAL9602](INFO): SBD MO Status=2, MOMSN=6468, MT Status=2, MTMSN=0 2021-10-06T16:56:15.075Z,1633539375.075 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:56:40.984Z,1633539400.984 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-10-06T16:56:42.591Z,1633539402.591 [NAL9602](INFO): SBD MO Status=1, MOMSN=6468, MT Status=0, MTMSN=0 2021-10-06T16:56:42.652Z,1633539402.652 [NAL9602](INFO): Sent 72 bytes from file Logs/20211006T164300/Courier0009.lzma 2021-10-06T16:56:42.652Z,1633539402.652 [NAL9602](INFO): Packets left to send: 0 2021-10-06T16:56:53.392Z,1633539413.392 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002986 2021-10-06T16:57:02.420Z,1633539422.420 [DataOverHttps](INFO): Sending 218 bytes from file Logs/20211006T164300/Express0010.lzma 2021-10-06T16:57:03.422Z,1633539423.422 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0010.lzma.bak 2021-10-06T16:57:03.422Z,1633539423.422 [DataOverHttps](INFO): SBD MOMSN=15974654 2021-10-06T16:57:04.918Z,1633539424.918 [NAL9602](INFO): SBD MO Status=2, MOMSN=6469, MT Status=2, MTMSN=0 2021-10-06T16:57:04.918Z,1633539424.918 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T16:57:05.316Z,1633539425.316 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T16:57:05.316Z,1633539425.316 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T16:57:05.317Z,1633539425.317 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T16:57:35.621Z,1633539455.621 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:02:06.010Z,1633539726.010 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:02:06.010Z,1633539726.010 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:02:06.010Z,1633539726.010 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:02:06.010Z,1633539726.010 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:02:06.429Z,1633539726.429 [Default:CheckIn:D] Stopped 2021-10-06T17:02:06.429Z,1633539726.429 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:02:06.809Z,1633539726.809 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.981235 min 2021-10-06T17:02:06.809Z,1633539726.809 [Default:CheckIn:E] Stopped 2021-10-06T17:02:06.809Z,1633539726.809 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:02:06.809Z,1633539726.809 [Default:CheckIn] Stopped 2021-10-06T17:02:06.810Z,1633539726.810 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:02:06.810Z,1633539726.810 [Default:CheckIn](INFO): Running loop #3 2021-10-06T17:02:06.810Z,1633539726.810 [Default:CheckIn] Running Loop=3 2021-10-06T17:02:06.810Z,1633539726.810 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:02:06.810Z,1633539726.810 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:02:08.823Z,1633539728.823 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170206.00,A,3648.38193,N,12147.12412,W,4.607,188.04,061021,,,D*73 2021-10-06T17:02:08.825Z,1633539728.825 [NAL9602](INFO): GPS fix at 20211006T170206: (36.806365, -121.785402) 2021-10-06T17:02:08.857Z,1633539728.857 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:02:08.857Z,1633539728.857 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:02:16.703Z,1633539736.703 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211006T164300/Courier0012.lzma 2021-10-06T17:02:17.705Z,1633539737.705 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0012.lzma.bak 2021-10-06T17:02:17.706Z,1633539737.706 [DataOverHttps](INFO): SBD MOMSN=15974666 2021-10-06T17:02:26.259Z,1633539746.259 [NAL9602](INFO): SBD MO Status=1, MOMSN=6469, MT Status=0, MTMSN=0 2021-10-06T17:02:26.259Z,1633539746.259 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:02:36.255Z,1633539756.255 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20211006T164300/Express0013.lzma 2021-10-06T17:02:37.257Z,1633539757.257 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0013.lzma.bak 2021-10-06T17:02:37.258Z,1633539757.258 [DataOverHttps](INFO): SBD MOMSN=15974672 2021-10-06T17:02:38.789Z,1633539758.789 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:02:38.789Z,1633539758.789 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:02:38.789Z,1633539758.789 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:02:57.001Z,1633539777.001 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:07:39.427Z,1633540059.427 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:07:39.427Z,1633540059.427 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:07:39.427Z,1633540059.427 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:07:39.428Z,1633540059.428 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:07:39.824Z,1633540059.824 [Default:CheckIn:D] Stopped 2021-10-06T17:07:39.824Z,1633540059.824 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.537823 min 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn:E] Stopped 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn] Stopped 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn](INFO): Running loop #4 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn] Running Loop=4 2021-10-06T17:07:40.238Z,1633540060.238 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:07:40.239Z,1633540060.239 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:07:42.239Z,1633540062.239 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170740.00,A,3648.13202,N,12147.21086,W,0.350,226.16,061021,,,A*7D 2021-10-06T17:07:42.242Z,1633540062.242 [NAL9602](INFO): GPS fix at 20211006T170740: (36.802200, -121.786848) 2021-10-06T17:07:42.265Z,1633540062.265 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:07:42.265Z,1633540062.265 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:07:49.879Z,1633540069.879 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20211006T164300/Courier0015.lzma 2021-10-06T17:07:50.882Z,1633540070.882 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0015.lzma.bak 2021-10-06T17:07:50.882Z,1633540070.882 [DataOverHttps](INFO): SBD MOMSN=15974681 2021-10-06T17:08:06.739Z,1633540086.739 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20211006T164300/Express0016.lzma 2021-10-06T17:08:07.742Z,1633540087.742 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0016.lzma.bak 2021-10-06T17:08:07.742Z,1633540087.742 [DataOverHttps](INFO): SBD MOMSN=15974687 2021-10-06T17:08:09.329Z,1633540089.329 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:08:09.329Z,1633540089.329 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:08:09.329Z,1633540089.329 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:08:19.006Z,1633540099.006 [NAL9602](INFO): SBD MO Status=2, MOMSN=6470, MT Status=2, MTMSN=0 2021-10-06T17:08:19.007Z,1633540099.007 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T17:10:07.682Z,1633540207.682 [NAL9602](INFO): SBD MO Status=2, MOMSN=6470, MT Status=2, MTMSN=0 2021-10-06T17:10:07.682Z,1633540207.682 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T17:11:00.223Z,1633540260.223 [NAL9602](INFO): SBD MO Status=2, MOMSN=6470, MT Status=2, MTMSN=0 2021-10-06T17:11:00.223Z,1633540260.223 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T17:12:16.978Z,1633540336.978 [NAL9602](INFO): SBD MO Status=1, MOMSN=6470, MT Status=0, MTMSN=0 2021-10-06T17:12:16.978Z,1633540336.978 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:12:47.761Z,1633540367.761 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:13:10.011Z,1633540390.011 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:13:10.011Z,1633540390.011 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:13:10.011Z,1633540390.011 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:13:10.011Z,1633540390.011 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:13:10.404Z,1633540390.404 [Default:CheckIn:D] Stopped 2021-10-06T17:13:10.404Z,1633540390.404 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:13:10.800Z,1633540390.800 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 28.047483 min 2021-10-06T17:13:10.800Z,1633540390.800 [Default:CheckIn:E] Stopped 2021-10-06T17:13:10.800Z,1633540390.800 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:13:10.800Z,1633540390.800 [Default:CheckIn] Stopped 2021-10-06T17:13:10.801Z,1633540390.801 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:13:10.801Z,1633540390.801 [Default:CheckIn](INFO): Running loop #5 2021-10-06T17:13:10.801Z,1633540390.801 [Default:CheckIn] Running Loop=5 2021-10-06T17:13:10.801Z,1633540390.801 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:13:10.801Z,1633540390.801 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:13:12.817Z,1633540392.817 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171310.00,A,3648.13228,N,12147.21075,W,0.000,226.16,061021,,,A*7F 2021-10-06T17:13:12.819Z,1633540392.819 [NAL9602](INFO): GPS fix at 20211006T171310: (36.802205, -121.786846) 2021-10-06T17:13:12.831Z,1633540392.831 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:13:12.831Z,1633540392.831 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:13:20.863Z,1633540400.863 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211006T164300/Courier0018.lzma 2021-10-06T17:13:21.866Z,1633540401.866 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0018.lzma.bak 2021-10-06T17:13:21.866Z,1633540401.866 [DataOverHttps](INFO): SBD MOMSN=15974694 2021-10-06T17:13:28.969Z,1633540408.969 [NAL9602](INFO): SBD MO Status=1, MOMSN=6471, MT Status=0, MTMSN=0 2021-10-06T17:13:28.969Z,1633540408.969 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:13:37.708Z,1633540417.708 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20211006T164300/Express0019.lzma 2021-10-06T17:13:38.718Z,1633540418.718 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0019.lzma.bak 2021-10-06T17:13:38.718Z,1633540418.718 [DataOverHttps](INFO): SBD MOMSN=15974700 2021-10-06T17:13:40.296Z,1633540420.296 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:13:40.296Z,1633540420.296 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:13:40.297Z,1633540420.297 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:13:59.677Z,1633540439.677 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:18:40.923Z,1633540720.923 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:18:40.923Z,1633540720.923 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:18:40.923Z,1633540720.923 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:18:40.923Z,1633540720.923 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:18:41.323Z,1633540721.323 [Default:CheckIn:D] Stopped 2021-10-06T17:18:41.323Z,1633540721.323 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:18:41.729Z,1633540721.729 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.562809 min 2021-10-06T17:18:41.729Z,1633540721.729 [Default:CheckIn:E] Stopped 2021-10-06T17:18:41.729Z,1633540721.729 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:18:41.730Z,1633540721.730 [Default:CheckIn] Stopped 2021-10-06T17:18:41.730Z,1633540721.730 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:18:41.730Z,1633540721.730 [Default:CheckIn](INFO): Running loop #6 2021-10-06T17:18:41.730Z,1633540721.730 [Default:CheckIn] Running Loop=6 2021-10-06T17:18:41.730Z,1633540721.730 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:18:41.730Z,1633540721.730 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:18:43.743Z,1633540723.743 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171841.00,A,3648.13126,N,12147.20983,W,0.078,226.16,061021,,,D*76 2021-10-06T17:18:43.745Z,1633540723.745 [NAL9602](INFO): GPS fix at 20211006T171841: (36.802188, -121.786830) 2021-10-06T17:18:43.779Z,1633540723.779 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:18:43.779Z,1633540723.779 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:18:50.983Z,1633540730.983 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211006T164300/Courier0021.lzma 2021-10-06T17:18:51.986Z,1633540731.986 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0021.lzma.bak 2021-10-06T17:18:51.986Z,1633540731.986 [DataOverHttps](INFO): SBD MOMSN=15974713 2021-10-06T17:19:06.363Z,1633540746.363 [NAL9602](INFO): SBD MO Status=2, MOMSN=6472, MT Status=2, MTMSN=0 2021-10-06T17:19:06.363Z,1633540746.363 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T17:19:07.867Z,1633540747.867 [DataOverHttps](INFO): Sending 139 bytes from file Logs/20211006T164300/Express0022.lzma 2021-10-06T17:19:08.870Z,1633540748.870 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0022.lzma.bak 2021-10-06T17:19:08.870Z,1633540748.870 [DataOverHttps](INFO): SBD MOMSN=15974719 2021-10-06T17:19:10.419Z,1633540750.419 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:19:10.419Z,1633540750.419 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:19:10.419Z,1633540750.419 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:19:28.179Z,1633540768.179 [NAL9602](INFO): SBD MO Status=2, MOMSN=6472, MT Status=2, MTMSN=0 2021-10-06T17:19:28.179Z,1633540768.179 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T17:20:34.902Z,1633540834.902 [NAL9602](INFO): SBD MO Status=2, MOMSN=6472, MT Status=2, MTMSN=0 2021-10-06T17:20:34.902Z,1633540834.902 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-10-06T17:21:18.938Z,1633540878.938 [NAL9602](INFO): SBD MO Status=1, MOMSN=6472, MT Status=0, MTMSN=0 2021-10-06T17:21:18.939Z,1633540878.939 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:21:49.640Z,1633540909.640 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:24:11.053Z,1633541051.053 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:24:11.053Z,1633541051.053 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:24:11.053Z,1633541051.053 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:24:11.054Z,1633541051.054 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:24:11.461Z,1633541051.461 [Default:CheckIn:D] Stopped 2021-10-06T17:24:11.461Z,1633541051.461 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.065108 min 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn:E] Stopped 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn] Stopped 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn](INFO): Running loop #7 2021-10-06T17:24:11.868Z,1633541051.868 [Default:CheckIn] Running Loop=7 2021-10-06T17:24:11.869Z,1633541051.869 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:24:11.869Z,1633541051.869 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:24:13.871Z,1633541053.871 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172411.00,A,3648.14030,N,12147.20840,W,0.894,226.16,061021,,,D*79 2021-10-06T17:24:13.873Z,1633541053.873 [NAL9602](INFO): GPS fix at 20211006T172411: (36.802338, -121.786807) 2021-10-06T17:24:13.905Z,1633541053.905 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:24:13.905Z,1633541053.905 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:24:22.139Z,1633541062.139 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211006T164300/Courier0024.lzma 2021-10-06T17:24:23.142Z,1633541063.142 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0024.lzma.bak 2021-10-06T17:24:23.142Z,1633541063.142 [DataOverHttps](INFO): SBD MOMSN=15974731 2021-10-06T17:24:44.696Z,1633541084.696 [NAL9602](INFO): SBD MO Status=1, MOMSN=6473, MT Status=0, MTMSN=0 2021-10-06T17:24:44.696Z,1633541084.696 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:24:45.788Z,1633541085.788 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20211006T164300/Express0025.lzma 2021-10-06T17:24:46.790Z,1633541086.790 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0025.lzma.bak 2021-10-06T17:24:46.790Z,1633541086.790 [DataOverHttps](INFO): SBD MOMSN=15974740 2021-10-06T17:24:48.328Z,1633541088.328 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:24:48.328Z,1633541088.328 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:24:48.328Z,1633541088.328 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:25:15.386Z,1633541115.386 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:29:49.029Z,1633541389.029 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:29:49.029Z,1633541389.029 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:29:49.029Z,1633541389.029 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:29:49.029Z,1633541389.029 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:29:49.433Z,1633541389.433 [Default:CheckIn:D] Stopped 2021-10-06T17:29:49.433Z,1633541389.433 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:29:49.838Z,1633541389.838 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.697970 min 2021-10-06T17:29:49.838Z,1633541389.838 [Default:CheckIn:E] Stopped 2021-10-06T17:29:49.838Z,1633541389.838 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:29:49.838Z,1633541389.838 [Default:CheckIn] Stopped 2021-10-06T17:29:49.838Z,1633541389.838 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:29:49.838Z,1633541389.838 [Default:CheckIn](INFO): Running loop #8 2021-10-06T17:29:49.839Z,1633541389.839 [Default:CheckIn] Running Loop=8 2021-10-06T17:29:49.839Z,1633541389.839 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:29:49.839Z,1633541389.839 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:29:51.874Z,1633541391.874 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172949.00,A,3648.15339,N,12147.24963,W,2.974,24.41,061021,,,A*4C 2021-10-06T17:29:51.876Z,1633541391.876 [NAL9602](INFO): GPS fix at 20211006T172949: (36.802557, -121.787494) 2021-10-06T17:29:51.887Z,1633541391.887 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:29:51.887Z,1633541391.887 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:29:58.703Z,1633541398.703 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211006T164300/Courier0027.lzma 2021-10-06T17:29:59.706Z,1633541399.706 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0027.lzma.bak 2021-10-06T17:29:59.706Z,1633541399.706 [DataOverHttps](INFO): SBD MOMSN=15974750 2021-10-06T17:30:16.095Z,1633541416.095 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20211006T164300/Express0028.lzma 2021-10-06T17:30:17.098Z,1633541417.098 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0028.lzma.bak 2021-10-06T17:30:17.098Z,1633541417.098 [DataOverHttps](INFO): SBD MOMSN=15974757 2021-10-06T17:30:18.569Z,1633541418.569 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:30:18.569Z,1633541418.569 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:30:18.570Z,1633541418.570 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:30:25.475Z,1633541425.475 [NAL9602](INFO): SBD MO Status=1, MOMSN=6474, MT Status=0, MTMSN=0 2021-10-06T17:30:25.475Z,1633541425.475 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:30:56.197Z,1633541456.197 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:33:25.255Z,1633541605.255 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2021-10-06T17:35:19.211Z,1633541719.211 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:35:19.211Z,1633541719.211 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:35:19.211Z,1633541719.211 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:35:19.212Z,1633541719.212 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:35:19.620Z,1633541719.620 [Default:CheckIn:D] Stopped 2021-10-06T17:35:19.620Z,1633541719.620 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 50.201086 min 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn:E] Stopped 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn] Stopped 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn](INFO): Running loop #9 2021-10-06T17:35:20.028Z,1633541720.028 [Default:CheckIn] Running Loop=9 2021-10-06T17:35:20.029Z,1633541720.029 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:35:20.029Z,1633541720.029 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:35:22.038Z,1633541722.038 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173520.00,A,3648.16906,N,12147.27971,W,0.894,273.93,061021,,,D*7C 2021-10-06T17:35:22.053Z,1633541722.053 [NAL9602](INFO): GPS fix at 20211006T173520: (36.802818, -121.787995) 2021-10-06T17:35:22.064Z,1633541722.064 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:35:22.064Z,1633541722.064 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:35:29.835Z,1633541729.835 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20211006T164300/Courier0030.lzma 2021-10-06T17:35:30.838Z,1633541730.838 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0030.lzma.bak 2021-10-06T17:35:30.838Z,1633541730.838 [DataOverHttps](INFO): SBD MOMSN=15974767 2021-10-06T17:35:45.469Z,1633541745.469 [BPC1](INFO): Calculating totals. Valid battery stick count: 28. Valid reserve battery stick count: 3. 2021-10-06T17:35:45.472Z,1633541745.472 [BPC1](INFO): Received data from all battery sticks. 2021-10-06T17:35:46.803Z,1633541746.803 [DataOverHttps](INFO): Sending 153 bytes from file Logs/20211006T164300/Express0031.lzma 2021-10-06T17:35:47.806Z,1633541747.806 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0031.lzma.bak 2021-10-06T17:35:47.806Z,1633541747.806 [DataOverHttps](INFO): SBD MOMSN=15974775 2021-10-06T17:35:49.111Z,1633541749.111 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:35:49.111Z,1633541749.111 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:35:49.111Z,1633541749.111 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:35:55.975Z,1633541755.975 [NAL9602](INFO): SBD MO Status=1, MOMSN=6475, MT Status=0, MTMSN=0 2021-10-06T17:35:55.975Z,1633541755.975 [NAL9602](INFO): No messages in MT queue 2021-10-06T17:36:26.669Z,1633541786.669 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:40:49.756Z,1633542049.756 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:40:49.756Z,1633542049.756 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:40:49.756Z,1633542049.756 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:40:49.757Z,1633542049.757 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:40:50.172Z,1633542050.172 [Default:CheckIn:D] Stopped 2021-10-06T17:40:50.172Z,1633542050.172 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:40:50.564Z,1633542050.564 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.710286 min 2021-10-06T17:40:50.564Z,1633542050.564 [Default:CheckIn:E] Stopped 2021-10-06T17:40:50.564Z,1633542050.564 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:40:50.564Z,1633542050.564 [Default:CheckIn] Stopped 2021-10-06T17:40:50.564Z,1633542050.564 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:40:50.564Z,1633542050.564 [Default:CheckIn](INFO): Running loop #10 2021-10-06T17:40:50.565Z,1633542050.565 [Default:CheckIn] Running Loop=10 2021-10-06T17:40:50.565Z,1633542050.565 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:40:50.565Z,1633542050.565 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:40:52.581Z,1633542052.581 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174050.00,A,3648.16802,N,12147.28921,W,1.536,216.69,061021,,,D*74 2021-10-06T17:40:52.583Z,1633542052.583 [NAL9602](INFO): GPS fix at 20211006T174050: (36.802800, -121.788153) 2021-10-06T17:40:52.594Z,1633542052.594 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:40:52.594Z,1633542052.594 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:40:59.804Z,1633542059.804 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20211006T164300/Courier0033.lzma 2021-10-06T17:41:00.806Z,1633542060.806 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0033.lzma.bak 2021-10-06T17:41:00.806Z,1633542060.806 [DataOverHttps](INFO): SBD MOMSN=15974780 2021-10-06T17:41:16.727Z,1633542076.727 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20211006T164300/Express0034.lzma 2021-10-06T17:41:17.730Z,1633542077.730 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0034.lzma.bak 2021-10-06T17:41:17.730Z,1633542077.730 [DataOverHttps](INFO): SBD MOMSN=15974786 2021-10-06T17:41:19.248Z,1633542079.248 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:41:19.248Z,1633542079.248 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:41:19.248Z,1633542079.248 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:45:54.849Z,1633542354.849 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-10-06T17:46:19.914Z,1633542379.914 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:46:19.915Z,1633542379.915 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:46:19.915Z,1633542379.915 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:46:19.915Z,1633542379.915 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:46:20.328Z,1633542380.328 [Default:CheckIn:D] Stopped 2021-10-06T17:46:20.328Z,1633542380.328 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:46:20.737Z,1633542380.737 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 61.212891 min 2021-10-06T17:46:20.737Z,1633542380.737 [Default:CheckIn:E] Stopped 2021-10-06T17:46:20.737Z,1633542380.737 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:46:20.737Z,1633542380.737 [Default:CheckIn] Stopped 2021-10-06T17:46:20.737Z,1633542380.737 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:46:20.737Z,1633542380.737 [Default:CheckIn](INFO): Running loop #11 2021-10-06T17:46:20.738Z,1633542380.738 [Default:CheckIn] Running Loop=11 2021-10-06T17:46:20.738Z,1633542380.738 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:46:20.738Z,1633542380.738 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:46:22.735Z,1633542382.735 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174620.00,A,3648.15255,N,12147.28449,W,1.613,249.59,061021,,,A*75 2021-10-06T17:46:22.737Z,1633542382.737 [NAL9602](INFO): GPS fix at 20211006T174620: (36.802543, -121.788075) 2021-10-06T17:46:22.781Z,1633542382.781 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:46:22.781Z,1633542382.781 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:46:35.615Z,1633542395.615 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20211006T164300/Courier0036.lzma 2021-10-06T17:46:36.618Z,1633542396.618 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0036.lzma.bak 2021-10-06T17:46:36.618Z,1633542396.618 [DataOverHttps](INFO): SBD MOMSN=15974796 2021-10-06T17:46:53.408Z,1633542413.408 [DataOverHttps](INFO): Sending 226 bytes from file Logs/20211006T164300/Express0037.lzma 2021-10-06T17:46:54.410Z,1633542414.410 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0037.lzma.bak 2021-10-06T17:46:54.410Z,1633542414.410 [DataOverHttps](INFO): SBD MOMSN=15974802 2021-10-06T17:46:54.737Z,1633542414.737 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:46:55.967Z,1633542415.967 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:46:55.968Z,1633542415.968 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:46:55.968Z,1633542415.968 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:51:56.623Z,1633542716.623 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:51:56.623Z,1633542716.623 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:51:56.623Z,1633542716.623 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:51:56.623Z,1633542716.623 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:51:57.031Z,1633542717.031 [Default:CheckIn:D] Stopped 2021-10-06T17:51:57.031Z,1633542717.031 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:51:57.448Z,1633542717.448 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 66.824605 min 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn:E] Stopped 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn] Stopped 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn](INFO): Running loop #12 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn] Running Loop=12 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:51:57.449Z,1633542717.449 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:51:59.447Z,1633542719.447 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175157.00,A,3648.15399,N,12147.29309,W,4.160,236.73,061021,,,A*76 2021-10-06T17:51:59.449Z,1633542719.449 [NAL9602](INFO): GPS fix at 20211006T175157: (36.802566, -121.788218) 2021-10-06T17:51:59.484Z,1633542719.484 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:51:59.484Z,1633542719.484 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:52:06.771Z,1633542726.771 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20211006T164300/Courier0039.lzma 2021-10-06T17:52:07.774Z,1633542727.774 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0039.lzma.bak 2021-10-06T17:52:07.774Z,1633542727.774 [DataOverHttps](INFO): SBD MOMSN=15974810 2021-10-06T17:52:23.655Z,1633542743.655 [DataOverHttps](INFO): Sending 140 bytes from file Logs/20211006T164300/Express0040.lzma 2021-10-06T17:52:24.658Z,1633542744.658 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0040.lzma.bak 2021-10-06T17:52:24.658Z,1633542744.658 [DataOverHttps](INFO): SBD MOMSN=15974817 2021-10-06T17:52:26.560Z,1633542746.560 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:52:26.560Z,1633542746.560 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:52:26.560Z,1633542746.560 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:52:30.182Z,1633542750.182 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2021-10-06T17:52:30.264Z,1633542750.264 [NAL9602](ERROR): received: +CSQ:0 OK75, 0, 0, 0, 0 OK 2021-10-06T17:52:42.333Z,1633542762.333 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-10-06T17:52:42.334Z,1633542762.334 [DropWeight] Hardware Fault, FailCount= 1 2021-10-06T17:52:42.334Z,1633542762.334 [DropWeight](ERROR): Hardware Fault 2021-10-06T17:52:42.432Z,1633542762.432 [CommandExec](FAULT): Scheduling is paused 2021-10-06T17:52:42.433Z,1633542762.433 [CBIT](INFO): Critical error at 20211006T175242 2021-10-06T17:52:42.435Z,1633542762.435 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-10-06T17:52:42.440Z,1633542762.440 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-10-06T17:52:42.757Z,1633542762.757 [CBIT](INFO): Critical error at 20211006T175242 2021-10-06T17:55:19.720Z,1633542919.720 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2021-10-06T17:55:21.736Z,1633542921.736 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.687130 2021-10-06T17:55:32.296Z,1633542932.296 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003375 2021-10-06T17:57:01.705Z,1633543021.705 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-10-06T17:57:27.175Z,1633543047.175 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-06T17:57:27.175Z,1633543047.175 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:57:27.175Z,1633543047.175 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:57:27.176Z,1633543047.176 [Default:CheckIn:D] Running Loop=1 2021-10-06T17:57:27.589Z,1633543047.589 [Default:CheckIn:D] Stopped 2021-10-06T17:57:27.589Z,1633543047.589 [Default:CheckIn:E] Running Loop=1 2021-10-06T17:57:27.980Z,1633543047.980 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.333895 min 2021-10-06T17:57:27.980Z,1633543047.980 [Default:CheckIn:E] Stopped 2021-10-06T17:57:27.980Z,1633543047.980 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-06T17:57:27.981Z,1633543047.981 [Default:CheckIn] Stopped 2021-10-06T17:57:27.981Z,1633543047.981 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:57:27.981Z,1633543047.981 [Default:CheckIn](INFO): Running loop #13 2021-10-06T17:57:27.981Z,1633543047.981 [Default:CheckIn] Running Loop=13 2021-10-06T17:57:27.981Z,1633543047.981 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-06T17:57:27.981Z,1633543047.981 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-06T17:57:33.222Z,1633543053.222 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,175731.00,A,3648.15199,N,12147.15968,W,7.931,139.87,061021,,,A*78 2021-10-06T17:57:33.224Z,1633543053.224 [NAL9602](INFO): GPS fix at 20211006T175731: (36.802533, -121.785995) 2021-10-06T17:57:33.235Z,1633543053.235 [Default:CheckIn:Read_GPS] Stopped 2021-10-06T17:57:33.235Z,1633543053.235 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-06T17:57:40.199Z,1633543060.199 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20211006T164300/Courier0042.lzma 2021-10-06T17:57:41.202Z,1633543061.202 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Courier0042.lzma.bak 2021-10-06T17:57:41.202Z,1633543061.202 [DataOverHttps](INFO): SBD MOMSN=15974823 2021-10-06T17:57:56.948Z,1633543076.948 [DataOverHttps](INFO): Sending 252 bytes from file Logs/20211006T164300/Express0043.lzma 2021-10-06T17:57:57.950Z,1633543077.950 [DataOverHttps](INFO): Moved sent file to Logs/20211006T164300/Express0043.lzma.bak 2021-10-06T17:57:57.950Z,1633543077.950 [DataOverHttps](INFO): SBD MOMSN=15974831 2021-10-06T17:57:59.508Z,1633543079.508 [Default:CheckIn:Read_Iridium] Stopped 2021-10-06T17:57:59.508Z,1633543079.508 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-06T17:57:59.509Z,1633543079.509 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-06T17:58:05.550Z,1633543085.550 [NAL9602](INFO): Not Powering down - fast GPS 2021-10-06T17:58:28.321Z,1633543108.321 [CommandExec](IMPORTANT): got command quit 2021-10-06T17:58:29.324Z,1633543109.324 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:29.324Z,1633543109.324 [CommandExec](INFO): Uninitializing the command executive. 2021-10-06T17:58:29.324Z,1633543109.324 [CommandExec](INFO): Uninitializing the command scheduler. 2021-10-06T17:58:29.324Z,1633543109.324 [CommandExec ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:29.524Z,1633543109.524 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-10-06T17:58:29.524Z,1633543109.524 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-10-06T17:58:29.524Z,1633543109.524 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:29.525Z,1633543109.525 [NavChartDb](INFO): Join timeout helper Thread ID is 9531 2021-10-06T17:58:29.772Z,1633543109.772 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:29.772Z,1633543109.772 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:29.780Z,1633543109.780 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-10-06T17:58:29.780Z,1633543109.780 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:29.781Z,1633543109.781 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9532 2021-10-06T17:58:29.812Z,1633543109.812 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:29.812Z,1633543109.812 [WetLabsBB2FL](INFO): Powering down 2021-10-06T17:58:29.813Z,1633543109.813 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:29.824Z,1633543109.824 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-10-06T17:58:29.824Z,1633543109.824 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:29.824Z,1633543109.824 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9533 2021-10-06T17:58:30.632Z,1633543110.632 [CTD_Seabird](INFO): Powering down 2021-10-06T17:58:30.644Z,1633543110.644 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:30.652Z,1633543110.652 [CTD_Seabird](INFO): Powering down 2021-10-06T17:58:30.664Z,1633543110.664 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:30.666Z,1633543110.666 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-10-06T17:58:30.666Z,1633543110.666 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:30.666Z,1633543110.666 [Radio_Surface](INFO): Join timeout helper Thread ID is 9534 2021-10-06T17:58:30.752Z,1633543110.752 [Radio_Surface](INFO): Powering down 2021-10-06T17:58:30.753Z,1633543110.753 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:30.753Z,1633543110.753 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:30.764Z,1633543110.764 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-10-06T17:58:30.764Z,1633543110.764 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:30.764Z,1633543110.764 [Onboard](INFO): Join timeout helper Thread ID is 9535 2021-10-06T17:58:31.372Z,1633543111.372 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-10-06T17:58:34.884Z,1633543114.884 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:34.884Z,1633543114.884 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:34.897Z,1633543114.897 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-10-06T17:58:34.897Z,1633543114.897 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:34.897Z,1633543114.897 [DataOverHttps](INFO): Join timeout helper Thread ID is 9536 2021-10-06T17:58:35.388Z,1633543115.388 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:35.388Z,1633543115.388 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.405Z,1633543115.405 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2021-10-06T17:58:35.405Z,1633543115.405 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.405Z,1633543115.405 [BackseatComponent](INFO): Join timeout helper Thread ID is 9537 2021-10-06T17:58:35.504Z,1633543115.504 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:35.504Z,1633543115.504 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.513Z,1633543115.513 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-10-06T17:58:35.513Z,1633543115.513 [logger ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.513Z,1633543115.513 [logger](INFO): Join timeout helper Thread ID is 9538 2021-10-06T17:58:35.542Z,1633543115.542 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:35.542Z,1633543115.542 [logger ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.548Z,1633543115.548 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-10-06T17:58:35.549Z,1633543115.549 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.549Z,1633543115.549 [CommandLine](INFO): Join timeout helper Thread ID is 9539 2021-10-06T17:58:35.616Z,1633543115.616 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:35.616Z,1633543115.616 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.628Z,1633543115.628 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2021-10-06T17:58:35.629Z,1633543115.629 [CommandExec ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.629Z,1633543115.629 [CommandExec](INFO): Join timeout helper Thread ID is 9540 2021-10-06T17:58:35.630Z,1633543115.630 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-10-06T17:58:35.630Z,1633543115.630 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.631Z,1633543115.631 [controlThread](INFO): Join timeout helper Thread ID is 9541 2021-10-06T17:58:35.820Z,1633543115.820 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-06T17:58:35.820Z,1633543115.820 [controlThread](DEBUG): Uninitializing ControlThread 2021-10-06T17:58:35.821Z,1633543115.821 [AHRS_M2](INFO): Powering down 2021-10-06T17:58:35.893Z,1633543115.893 [NAL9602](INFO): Powering down 2021-10-06T17:58:35.895Z,1633543115.895 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-10-06T17:58:35.896Z,1633543115.896 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-10-06T17:58:35.896Z,1633543115.896 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-10-06T17:58:35.897Z,1633543115.897 [MissionManager](INFO): Uninitializing Mission Default 2021-10-06T17:58:35.897Z,1633543115.897 [Default] Stopped 2021-10-06T17:58:35.897Z,1633543115.897 [Default](DEBUG): Aggregate::uninitialize Default 2021-10-06T17:58:35.897Z,1633543115.897 [Default:B.GoToSurface] Stopped 2021-10-06T17:58:35.897Z,1633543115.897 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-10-06T17:58:35.897Z,1633543115.897 [Default:CheckIn] Stopped 2021-10-06T17:58:35.897Z,1633543115.897 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-06T17:58:35.898Z,1633543115.898 [Default:CheckIn:C.Wait] Stopped 2021-10-06T17:58:35.898Z,1633543115.898 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-06T17:58:35.901Z,1633543115.901 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-10-06T17:58:35.901Z,1633543115.901 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-10-06T17:58:35.901Z,1633543115.901 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-10-06T17:58:35.902Z,1633543115.902 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-10-06T17:58:35.902Z,1633543115.902 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-10-06T17:58:35.902Z,1633543115.902 [BuoyancyServo](INFO): Powering down 2021-10-06T17:58:35.916Z,1633543115.916 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-10-06T17:58:35.916Z,1633543115.916 [ElevatorServo](INFO): Powering down 2021-10-06T17:58:35.917Z,1633543115.917 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-10-06T17:58:35.917Z,1633543115.917 [MassServo](INFO): Powering down 2021-10-06T17:58:35.918Z,1633543115.918 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-10-06T17:58:35.918Z,1633543115.918 [RudderServo](INFO): Powering down 2021-10-06T17:58:35.919Z,1633543115.919 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2021-10-06T17:58:35.919Z,1633543115.919 [ThrusterHE](INFO): Powering down 2021-10-06T17:58:35.920Z,1633543115.920 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-10-06T17:58:35.920Z,1633543115.920 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-10-06T17:58:35.921Z,1633543115.921 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-10-06T17:58:35.921Z,1633543115.921 [CBIT](DEBUG): Powering off loads. 2021-10-06T17:58:35.932Z,1633543115.932 [CBIT](DEBUG): Disabling WDT. 2021-10-06T17:58:35.944Z,1633543115.944 [CBIT](DEBUG): Opening all GF detection circuits. 2021-10-06T17:58:35.945Z,1633543115.945 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.997Z,1633543115.997 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:35.999Z,1633543115.999 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:36.006Z,1633543116.006 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:36.051Z,1633543116.051 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:36.085Z,1633543116.085 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:36.090Z,1633543116.090 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:36.124Z,1633543116.124 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-10-06T17:58:36.201Z,1633543116.201 [logger ThreadHandler](INFO): Thread cancelled.