2020-03-02T19:48:51.324Z,1583178531.324 [DataOverHttps](INFO): Received command:restart logs 2020-03-02T19:48:51.333Z,1583178531.333 [CommandLine](IMPORTANT): got command restart logs 2020-03-02T19:49:00.657Z,1583178540.657 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T19:49:00.657Z,1583178540.657 [Default:CheckIn:C.Wait] Stopped 2020-03-02T19:49:00.657Z,1583178540.657 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T19:49:00.657Z,1583178540.657 [Default:CheckIn:D] Running Loop=1 2020-03-02T19:49:01.053Z,1583178541.053 [Default:CheckIn:D] Stopped 2020-03-02T19:49:01.053Z,1583178541.053 [Default:CheckIn:E] Running Loop=1 2020-03-02T19:49:01.477Z,1583178541.477 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 14.029926 min 2020-03-02T19:49:01.477Z,1583178541.477 [Default:CheckIn:E] Stopped 2020-03-02T19:49:01.477Z,1583178541.477 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T19:49:01.477Z,1583178541.477 [Default:CheckIn] Stopped 2020-03-02T19:49:01.477Z,1583178541.477 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T19:49:01.478Z,1583178541.478 [Default:CheckIn](INFO): Running loop #3 2020-03-02T19:49:01.478Z,1583178541.478 [Default:CheckIn] Running Loop=3 2020-03-02T19:49:01.478Z,1583178541.478 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T19:49:01.478Z,1583178541.478 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T19:49:03.460Z,1583178543.460 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193943.00,A,3648.62495,N,12149.38350,W,0.758,50.79,020320,,,A*4C 2020-03-02T19:49:03.462Z,1583178543.462 [NAL9602](INFO): GPS fix at 20200302T193943: (36.810416, -121.823058) 2020-03-02T19:49:03.517Z,1583178543.517 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T19:49:03.517Z,1583178543.517 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T19:49:11.157Z,1583178551.157 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20200302T194851/Courier0000.lzma 2020-03-02T19:49:13.162Z,1583178553.162 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0000.lzma.bak 2020-03-02T19:49:13.163Z,1583178553.163 [DataOverHttps](INFO): SBD MOMSN=12279762 2020-03-02T19:49:23.659Z,1583178563.659 [NAL9602](INFO): SBD MO Status=0, MOMSN=20335, MT Status=0, MTMSN=0 2020-03-02T19:49:23.659Z,1583178563.659 [NAL9602](INFO): No messages in MT queue 2020-03-02T19:49:30.076Z,1583178570.076 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20200302T170628/Express0049.lzma 2020-03-02T19:49:32.082Z,1583178572.082 [DataOverHttps](INFO): Moved sent file to Logs/20200302T170628/Express0049.lzma.bak 2020-03-02T19:49:32.083Z,1583178572.083 [DataOverHttps](INFO): SBD MOMSN=12279766 2020-03-02T19:49:54.358Z,1583178594.358 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T19:49:55.593Z,1583178595.593 [DataOverHttps](INFO): Sending 339 bytes from file Logs/20200302T194851/Express0001.lzma 2020-03-02T19:49:57.598Z,1583178597.598 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0001.lzma.bak 2020-03-02T19:49:57.598Z,1583178597.598 [DataOverHttps](INFO): SBD MOMSN=12279769 2020-03-02T19:50:14.884Z,1583178614.884 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20200302T194851/Express0004.lzma 2020-03-02T19:50:16.890Z,1583178616.890 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0004.lzma.bak 2020-03-02T19:50:16.890Z,1583178616.890 [DataOverHttps](INFO): SBD MOMSN=12279773 2020-03-02T19:50:18.233Z,1583178618.233 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T19:50:18.233Z,1583178618.233 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T19:50:18.233Z,1583178618.233 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T19:52:50.297Z,1583178770.297 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2020-03-02T19:53:21.421Z,1583178801.421 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2020-03-02T19:53:52.545Z,1583178832.545 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2020-03-02T19:55:18.797Z,1583178918.797 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T19:55:18.797Z,1583178918.797 [Default:CheckIn:C.Wait] Stopped 2020-03-02T19:55:18.797Z,1583178918.797 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T19:55:18.797Z,1583178918.797 [Default:CheckIn:D] Running Loop=1 2020-03-02T19:55:19.200Z,1583178919.200 [Default:CheckIn:D] Stopped 2020-03-02T19:55:19.200Z,1583178919.200 [Default:CheckIn:E] Running Loop=1 2020-03-02T19:55:19.613Z,1583178919.613 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.332381 min 2020-03-02T19:55:19.613Z,1583178919.613 [Default:CheckIn:E] Stopped 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn] Stopped 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn](INFO): Running loop #4 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn] Running Loop=4 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T19:55:19.614Z,1583178919.614 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T19:55:21.604Z,1583178921.604 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,194600.00,A,3648.49019,N,12147.12686,W,5.482,155.63,020320,,,A*7C 2020-03-02T19:55:21.606Z,1583178921.606 [NAL9602](INFO): GPS fix at 20200302T194600: (36.808170, -121.785448) 2020-03-02T19:55:21.647Z,1583178921.647 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T19:55:21.647Z,1583178921.647 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T19:55:28.796Z,1583178928.796 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20200302T194851/Courier0006.lzma 2020-03-02T19:55:30.802Z,1583178930.802 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0006.lzma.bak 2020-03-02T19:55:30.802Z,1583178930.802 [DataOverHttps](INFO): SBD MOMSN=12279787 2020-03-02T19:55:35.335Z,1583178935.335 [NAL9602](INFO): SBD MO Status=0, MOMSN=20336, MT Status=0, MTMSN=0 2020-03-02T19:55:35.336Z,1583178935.336 [NAL9602](INFO): No messages in MT queue 2020-03-02T19:55:48.140Z,1583178948.140 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20200302T194851/Express0007.lzma 2020-03-02T19:55:50.146Z,1583178950.146 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0007.lzma.bak 2020-03-02T19:55:50.146Z,1583178950.146 [DataOverHttps](INFO): SBD MOMSN=12279790 2020-03-02T19:55:51.537Z,1583178951.537 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T19:55:51.537Z,1583178951.537 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T19:55:51.537Z,1583178951.537 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T19:56:06.054Z,1583178966.054 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:00:52.134Z,1583179252.134 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:00:52.134Z,1583179252.134 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:00:52.134Z,1583179252.134 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:00:52.135Z,1583179252.135 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:00:52.510Z,1583179252.510 [Default:CheckIn:D] Stopped 2020-03-02T20:00:52.510Z,1583179252.510 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:00:52.921Z,1583179252.921 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.887541 min 2020-03-02T20:00:52.921Z,1583179252.921 [Default:CheckIn:E] Stopped 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn] Stopped 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn](INFO): Running loop #5 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn] Running Loop=5 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:00:52.922Z,1583179252.922 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:00:54.906Z,1583179254.906 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195133.00,A,3648.15728,N,12147.21407,W,1.283,221.35,020320,,,D*78 2020-03-02T20:00:54.908Z,1583179254.908 [NAL9602](INFO): GPS fix at 20200302T195133: (36.802621, -121.786901) 2020-03-02T20:00:54.944Z,1583179254.944 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:00:54.944Z,1583179254.944 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:01:02.756Z,1583179262.756 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20200302T194851/Courier0009.lzma 2020-03-02T20:01:04.762Z,1583179264.762 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0009.lzma.bak 2020-03-02T20:01:04.762Z,1583179264.762 [DataOverHttps](INFO): SBD MOMSN=12279795 2020-03-02T20:01:15.515Z,1583179275.515 [NAL9602](INFO): SBD MO Status=0, MOMSN=20337, MT Status=0, MTMSN=0 2020-03-02T20:01:15.516Z,1583179275.516 [NAL9602](INFO): No messages in MT queue 2020-03-02T20:01:21.708Z,1583179281.708 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20200302T194851/Express0010.lzma 2020-03-02T20:01:23.714Z,1583179283.714 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0010.lzma.bak 2020-03-02T20:01:23.714Z,1583179283.714 [DataOverHttps](INFO): SBD MOMSN=12279798 2020-03-02T20:01:24.867Z,1583179284.867 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:01:24.867Z,1583179284.867 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:01:24.867Z,1583179284.867 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:01:46.222Z,1583179306.222 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:02:27.043Z,1583179347.043 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-03-02T20:02:27.045Z,1583179347.045 [BPC1](INFO): Received data from all battery sticks. 2020-03-02T20:06:25.427Z,1583179585.427 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:06:25.427Z,1583179585.427 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:06:25.427Z,1583179585.427 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:06:25.427Z,1583179585.427 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:06:25.813Z,1583179585.813 [Default:CheckIn:D] Stopped 2020-03-02T20:06:25.813Z,1583179585.813 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:06:26.228Z,1583179586.228 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.442588 min 2020-03-02T20:06:26.228Z,1583179586.228 [Default:CheckIn:E] Stopped 2020-03-02T20:06:26.228Z,1583179586.228 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:06:26.228Z,1583179586.228 [Default:CheckIn] Stopped 2020-03-02T20:06:26.228Z,1583179586.228 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:06:26.229Z,1583179586.229 [Default:CheckIn](INFO): Running loop #6 2020-03-02T20:06:26.229Z,1583179586.229 [Default:CheckIn] Running Loop=6 2020-03-02T20:06:26.229Z,1583179586.229 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:06:26.229Z,1583179586.229 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:06:28.212Z,1583179588.212 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195706.00,A,3648.14926,N,12147.22357,W,0.058,333.79,020320,,,D*77 2020-03-02T20:06:28.215Z,1583179588.215 [NAL9602](INFO): GPS fix at 20200302T195706: (36.802488, -121.787059) 2020-03-02T20:06:28.238Z,1583179588.238 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:06:28.238Z,1583179588.238 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:06:35.880Z,1583179595.880 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20200302T194851/Courier0012.lzma 2020-03-02T20:06:37.886Z,1583179597.886 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0012.lzma.bak 2020-03-02T20:06:37.887Z,1583179597.887 [DataOverHttps](INFO): SBD MOMSN=12279818 2020-03-02T20:06:54.820Z,1583179614.820 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200302T194851/Express0013.lzma 2020-03-02T20:06:56.826Z,1583179616.826 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0013.lzma.bak 2020-03-02T20:06:56.826Z,1583179616.826 [DataOverHttps](INFO): SBD MOMSN=12279822 2020-03-02T20:06:58.140Z,1583179618.140 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:06:58.141Z,1583179618.141 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:06:58.141Z,1583179618.141 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:09:23.551Z,1583179763.551 [NAL9602](INFO): SBD MO Status=0, MOMSN=20338, MT Status=0, MTMSN=0 2020-03-02T20:09:23.552Z,1583179763.552 [NAL9602](INFO): No messages in MT queue 2020-03-02T20:09:54.255Z,1583179794.255 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:11:58.717Z,1583179918.717 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:11:58.717Z,1583179918.717 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:11:58.717Z,1583179918.717 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:11:58.717Z,1583179918.717 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:11:59.136Z,1583179919.136 [Default:CheckIn:D] Stopped 2020-03-02T20:11:59.137Z,1583179919.137 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.997986 min 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn:E] Stopped 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn] Stopped 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn](INFO): Running loop #7 2020-03-02T20:11:59.533Z,1583179919.533 [Default:CheckIn] Running Loop=7 2020-03-02T20:11:59.534Z,1583179919.534 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:11:59.534Z,1583179919.534 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:12:01.520Z,1583179921.520 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200239.00,A,3648.16937,N,12147.27807,W,0.136,283.51,020320,,,A*74 2020-03-02T20:12:01.522Z,1583179921.522 [NAL9602](INFO): GPS fix at 20200302T200239: (36.802823, -121.787968) 2020-03-02T20:12:01.547Z,1583179921.547 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:12:01.547Z,1583179921.547 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:12:08.672Z,1583179928.672 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20200302T194851/Courier0015.lzma 2020-03-02T20:12:10.678Z,1583179930.678 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0015.lzma.bak 2020-03-02T20:12:10.678Z,1583179930.678 [DataOverHttps](INFO): SBD MOMSN=12279835 2020-03-02T20:12:27.668Z,1583179947.668 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20200302T194851/Express0016.lzma 2020-03-02T20:12:29.674Z,1583179949.674 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0016.lzma.bak 2020-03-02T20:12:29.675Z,1583179949.675 [DataOverHttps](INFO): SBD MOMSN=12279841 2020-03-02T20:12:31.057Z,1583179951.057 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:12:31.057Z,1583179951.057 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:12:31.057Z,1583179951.057 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:17:04.118Z,1583180224.118 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-03-02T20:17:31.624Z,1583180251.624 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:17:31.624Z,1583180251.624 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:17:31.624Z,1583180251.624 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:17:31.624Z,1583180251.624 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:17:32.035Z,1583180252.035 [Default:CheckIn:D] Stopped 2020-03-02T20:17:32.035Z,1583180252.035 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:17:32.416Z,1583180252.416 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.546293 min 2020-03-02T20:17:32.416Z,1583180252.416 [Default:CheckIn:E] Stopped 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn] Stopped 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn](INFO): Running loop #8 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn] Running Loop=8 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:17:32.417Z,1583180252.417 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:17:34.422Z,1583180254.422 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200811.00,A,3648.16411,N,12147.28169,W,0.564,242.88,020320,,,A*79 2020-03-02T20:17:34.424Z,1583180254.424 [NAL9602](INFO): GPS fix at 20200302T200811: (36.802735, -121.788028) 2020-03-02T20:17:34.454Z,1583180254.454 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:17:34.454Z,1583180254.454 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:17:42.204Z,1583180262.204 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20200302T194851/Courier0018.lzma 2020-03-02T20:17:44.210Z,1583180264.210 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0018.lzma.bak 2020-03-02T20:17:44.210Z,1583180264.210 [DataOverHttps](INFO): SBD MOMSN=12279848 2020-03-02T20:18:01.141Z,1583180281.141 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20200302T194851/Express0019.lzma 2020-03-02T20:18:03.146Z,1583180283.146 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0019.lzma.bak 2020-03-02T20:18:03.147Z,1583180283.147 [DataOverHttps](INFO): SBD MOMSN=12279851 2020-03-02T20:18:04.341Z,1583180284.341 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:18:04.341Z,1583180284.341 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:18:04.341Z,1583180284.341 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:18:06.734Z,1583180286.734 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:22:51.962Z,1583180571.962 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-03-02T20:22:51.962Z,1583180571.962 [DropWeight] Hardware Fault, FailCount= 1 2020-03-02T20:22:51.962Z,1583180571.962 [DropWeight](ERROR): Hardware Fault 2020-03-02T20:22:52.032Z,1583180572.032 [CommandLine](FAULT): Scheduling is paused 2020-03-02T20:22:52.032Z,1583180572.032 [CBIT](INFO): Critical error at 20200302T202251 2020-03-02T20:22:52.035Z,1583180572.035 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-03-02T20:22:52.035Z,1583180572.035 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-03-02T20:22:52.402Z,1583180572.402 [CBIT](INFO): Critical error at 20200302T202252 2020-03-02T20:23:04.921Z,1583180584.921 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:23:04.921Z,1583180584.921 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:23:04.921Z,1583180584.921 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:23:04.922Z,1583180584.922 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:23:05.329Z,1583180585.329 [Default:CheckIn:D] Stopped 2020-03-02T20:23:05.329Z,1583180585.329 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.101200 min 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn:E] Stopped 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn] Stopped 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn](INFO): Running loop #9 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn] Running Loop=9 2020-03-02T20:23:05.726Z,1583180585.726 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:23:05.727Z,1583180585.727 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:23:07.720Z,1583180587.720 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201344.00,A,3648.16730,N,12147.28389,W,0.214,242.88,020320,,,A*7F 2020-03-02T20:23:07.722Z,1583180587.722 [NAL9602](INFO): GPS fix at 20200302T201344: (36.802788, -121.788065) 2020-03-02T20:23:07.747Z,1583180587.747 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:23:07.747Z,1583180587.747 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:23:15.060Z,1583180595.060 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20200302T194851/Courier0021.lzma 2020-03-02T20:23:17.066Z,1583180597.066 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0021.lzma.bak 2020-03-02T20:23:17.067Z,1583180597.067 [DataOverHttps](INFO): SBD MOMSN=12279861 2020-03-02T20:23:34.069Z,1583180614.069 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20200302T194851/Express0022.lzma 2020-03-02T20:23:36.074Z,1583180616.074 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0022.lzma.bak 2020-03-02T20:23:36.074Z,1583180616.074 [DataOverHttps](INFO): SBD MOMSN=12279866 2020-03-02T20:23:37.301Z,1583180617.301 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:23:37.301Z,1583180617.301 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:23:37.301Z,1583180617.301 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:23:38.420Z,1583180618.420 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2020-03-02T20:23:38.497Z,1583180618.497 [NAL9602](FAULT): received: +CSQ:0 OK338, 0, 0, 0, 0 OK 2020-03-02T20:23:38.497Z,1583180618.497 [NAL9602] Data Fault, FailCount= 1 2020-03-02T20:23:38.497Z,1583180618.497 [NAL9602](ERROR): Data Fault 2020-03-02T20:23:38.550Z,1583180618.550 [CBIT](ERROR): Data Fault in component: NAL9602 2020-03-02T20:23:38.830Z,1583180618.830 [NAL9602](INFO): Powering down 2020-03-02T20:23:39.718Z,1583180619.718 [CBIT](INFO): Clearing failed state for component NAL9602 2020-03-02T20:23:39.718Z,1583180619.718 [NAL9602] No Fault, FailCount= 1 2020-03-02T20:24:09.126Z,1583180649.126 [NAL9602](INFO): Powering up NAL9602 2020-03-02T20:24:20.038Z,1583180660.038 [NAL9602](INFO): NAL9602 initialized 2020-03-02T20:24:51.142Z,1583180691.142 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:28:37.842Z,1583180917.842 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:28:37.842Z,1583180917.842 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:28:37.842Z,1583180917.842 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:28:37.843Z,1583180917.843 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:28:38.254Z,1583180918.254 [Default:CheckIn:D] Stopped 2020-03-02T20:28:38.254Z,1583180918.254 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:28:38.645Z,1583180918.645 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.649943 min 2020-03-02T20:28:38.645Z,1583180918.645 [Default:CheckIn:E] Stopped 2020-03-02T20:28:38.645Z,1583180918.645 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:28:38.645Z,1583180918.645 [Default:CheckIn] Stopped 2020-03-02T20:28:38.645Z,1583180918.645 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:28:38.646Z,1583180918.646 [Default:CheckIn](INFO): Running loop #10 2020-03-02T20:28:38.646Z,1583180918.646 [Default:CheckIn] Running Loop=10 2020-03-02T20:28:38.646Z,1583180918.646 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:28:38.646Z,1583180918.646 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:28:40.635Z,1583180920.635 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201916.00,A,3648.16598,N,12147.28092,W,0.058,0.00,020320,,,A*75 2020-03-02T20:28:40.649Z,1583180920.649 [NAL9602](INFO): GPS fix at 20200302T201916: (36.802766, -121.788015) 2020-03-02T20:28:40.681Z,1583180920.681 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:28:40.681Z,1583180920.681 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:28:42.255Z,1583180922.255 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-03-02T20:28:47.752Z,1583180927.752 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20200302T194851/Courier0024.lzma 2020-03-02T20:28:49.758Z,1583180929.758 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0024.lzma.bak 2020-03-02T20:28:49.758Z,1583180929.758 [DataOverHttps](INFO): SBD MOMSN=12279870 2020-03-02T20:29:06.632Z,1583180946.632 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20200302T194851/Express0025.lzma 2020-03-02T20:29:08.638Z,1583180948.638 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0025.lzma.bak 2020-03-02T20:29:08.639Z,1583180948.639 [DataOverHttps](INFO): SBD MOMSN=12279873 2020-03-02T20:29:10.154Z,1583180950.154 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:29:10.154Z,1583180950.154 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:29:10.154Z,1583180950.154 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:29:12.953Z,1583180952.953 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:34:10.761Z,1583181250.761 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:34:10.761Z,1583181250.761 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:34:10.761Z,1583181250.761 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:34:10.761Z,1583181250.761 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:34:11.152Z,1583181251.152 [Default:CheckIn:D] Stopped 2020-03-02T20:34:11.153Z,1583181251.153 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:34:11.567Z,1583181251.567 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 59.198250 min 2020-03-02T20:34:11.567Z,1583181251.567 [Default:CheckIn:E] Stopped 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn] Stopped 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn](INFO): Running loop #11 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn] Running Loop=11 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:34:11.568Z,1583181251.568 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:34:13.559Z,1583181253.559 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202449.00,A,3648.16397,N,12147.27858,W,0.875,332.50,020320,,,A*79 2020-03-02T20:34:13.561Z,1583181253.561 [NAL9602](INFO): GPS fix at 20200302T202449: (36.802733, -121.787976) 2020-03-02T20:34:13.601Z,1583181253.601 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:34:13.601Z,1583181253.601 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:34:21.220Z,1583181261.220 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20200302T194851/Courier0027.lzma 2020-03-02T20:34:23.226Z,1583181263.226 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0027.lzma.bak 2020-03-02T20:34:23.226Z,1583181263.226 [DataOverHttps](INFO): SBD MOMSN=12279884 2020-03-02T20:34:40.192Z,1583181280.192 [DataOverHttps](INFO): Sending 197 bytes from file Logs/20200302T194851/Express0028.lzma 2020-03-02T20:34:42.198Z,1583181282.198 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0028.lzma.bak 2020-03-02T20:34:42.198Z,1583181282.198 [DataOverHttps](INFO): SBD MOMSN=12279887 2020-03-02T20:34:43.502Z,1583181283.502 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:34:43.502Z,1583181283.502 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:34:43.502Z,1583181283.502 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:37:52.201Z,1583181472.201 [CBIT](INFO): Clearing failed state for component DropWeight 2020-03-02T20:37:52.201Z,1583181472.201 [DropWeight] No Fault, FailCount= 1 2020-03-02T20:39:16.164Z,1583181556.164 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-03-02T20:39:44.100Z,1583181584.100 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:39:44.100Z,1583181584.100 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:39:44.100Z,1583181584.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:39:44.100Z,1583181584.100 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:39:44.515Z,1583181584.515 [Default:CheckIn:D] Stopped 2020-03-02T20:39:44.515Z,1583181584.515 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:39:44.900Z,1583181584.900 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 64.754289 min 2020-03-02T20:39:44.925Z,1583181584.925 [Default:CheckIn:E] Stopped 2020-03-02T20:39:44.925Z,1583181584.925 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:39:44.925Z,1583181584.925 [Default:CheckIn] Stopped 2020-03-02T20:39:44.925Z,1583181584.925 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:39:44.925Z,1583181584.925 [Default:CheckIn](INFO): Running loop #12 2020-03-02T20:39:44.926Z,1583181584.926 [Default:CheckIn] Running Loop=12 2020-03-02T20:39:44.926Z,1583181584.926 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:39:44.926Z,1583181584.926 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:40:43.428Z,1583181643.428 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203118.00,A,3648.16262,N,12147.28465,W,1.166,0.00,020320,,,A*72 2020-03-02T20:40:43.430Z,1583181643.430 [NAL9602](INFO): GPS fix at 20200302T203118: (36.802710, -121.788077) 2020-03-02T20:40:43.527Z,1583181643.527 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:40:43.527Z,1583181643.527 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:40:56.037Z,1583181656.037 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20200302T194851/Courier0030.lzma 2020-03-02T20:40:58.043Z,1583181658.043 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0030.lzma.bak 2020-03-02T20:40:58.043Z,1583181658.043 [DataOverHttps](INFO): SBD MOMSN=12279893 2020-03-02T20:41:15.892Z,1583181675.892 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:41:24.817Z,1583181684.817 [DataOverHttps](INFO): Sending 197 bytes from file Logs/20200302T194851/Express0031.lzma 2020-03-02T20:41:26.823Z,1583181686.823 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0031.lzma.bak 2020-03-02T20:41:26.823Z,1583181686.823 [DataOverHttps](INFO): SBD MOMSN=12279896 2020-03-02T20:41:28.446Z,1583181688.446 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:41:28.447Z,1583181688.447 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:41:28.447Z,1583181688.447 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:46:29.048Z,1583181989.048 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:46:29.048Z,1583181989.048 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:46:29.048Z,1583181989.048 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:46:29.048Z,1583181989.048 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:46:29.460Z,1583181989.460 [Default:CheckIn:D] Stopped 2020-03-02T20:46:29.461Z,1583181989.461 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 71.503385 min 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn:E] Stopped 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn] Stopped 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn](INFO): Running loop #13 2020-03-02T20:46:29.839Z,1583181989.839 [Default:CheckIn] Running Loop=13 2020-03-02T20:46:29.840Z,1583181989.840 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:46:29.840Z,1583181989.840 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:51:30.024Z,1583182290.024 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-03-02T20:46:29.8Z 2020-03-02T20:51:30.025Z,1583182290.025 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T20:51:30.029Z,1583182290.029 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T20:51:34.596Z,1583182294.596 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-03-02T20:51:42.332Z,1583182302.332 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200302T194851/Express0034.lzma 2020-03-02T20:51:44.338Z,1583182304.338 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0034.lzma.bak 2020-03-02T20:51:44.338Z,1583182304.338 [DataOverHttps](INFO): SBD MOMSN=12279905 2020-03-02T20:51:45.560Z,1583182305.560 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T20:51:45.560Z,1583182305.560 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T20:51:45.561Z,1583182305.561 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T20:52:05.294Z,1583182325.294 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T20:56:46.134Z,1583182606.134 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T20:56:46.135Z,1583182606.135 [Default:CheckIn:C.Wait] Stopped 2020-03-02T20:56:46.135Z,1583182606.135 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T20:56:46.136Z,1583182606.136 [Default:CheckIn:D] Running Loop=1 2020-03-02T20:56:46.547Z,1583182606.547 [Default:CheckIn:D] Stopped 2020-03-02T20:56:46.547Z,1583182606.547 [Default:CheckIn:E] Running Loop=1 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 81.788159 min 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn:E] Stopped 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn] Stopped 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn](INFO): Running loop #14 2020-03-02T20:56:46.962Z,1583182606.962 [Default:CheckIn] Running Loop=14 2020-03-02T20:56:46.963Z,1583182606.963 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T20:56:46.963Z,1583182606.963 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T20:56:48.502Z,1583182608.502 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-03-02T20:56:48.502Z,1583182608.502 [NAL9602] Data Fault, FailCount= 1 2020-03-02T20:56:48.502Z,1583182608.502 [NAL9602](ERROR): Data Fault 2020-03-02T20:56:48.587Z,1583182608.587 [CBIT](ERROR): Data Fault in component: NAL9602 2020-03-02T20:56:48.906Z,1583182608.906 [NAL9602](INFO): Powering down 2020-03-02T20:56:49.794Z,1583182609.794 [CBIT](INFO): Clearing failed state for component NAL9602 2020-03-02T20:56:49.794Z,1583182609.794 [NAL9602] No Fault, FailCount= 1 2020-03-02T20:57:19.202Z,1583182639.202 [NAL9602](INFO): Powering up NAL9602 2020-03-02T20:57:30.118Z,1583182650.118 [NAL9602](INFO): NAL9602 initialized 2020-03-02T21:01:47.076Z,1583182907.076 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-03-02T20:56:46.0Z 2020-03-02T21:01:47.076Z,1583182907.076 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T21:01:47.077Z,1583182907.077 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T21:01:54.272Z,1583182914.272 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20200302T194851/Express0037.lzma 2020-03-02T21:01:56.278Z,1583182916.278 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0037.lzma.bak 2020-03-02T21:01:56.278Z,1583182916.278 [DataOverHttps](INFO): SBD MOMSN=12279914 2020-03-02T21:01:57.593Z,1583182917.593 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T21:01:57.593Z,1583182917.593 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T21:01:57.593Z,1583182917.593 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T21:02:33.514Z,1583182953.514 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-03-02T21:03:04.218Z,1583182984.218 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T21:03:33.352Z,1583183013.352 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:03:33.378Z,1583183013.378 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:03:44.302Z,1583183024.302 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:03:44.372Z,1583183024.372 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:03:55.213Z,1583183035.213 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:03:55.621Z,1583183035.621 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:06.120Z,1583183046.120 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:06.525Z,1583183046.525 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:17.048Z,1583183057.048 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:17.435Z,1583183057.435 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:27.936Z,1583183067.936 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:28.338Z,1583183068.338 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:04:38.849Z,1583183078.849 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:06:16.593Z,1583183176.593 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:06:53.374Z,1583183213.374 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:06:58.166Z,1583183218.166 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-03-02T21:06:58.166Z,1583183218.166 [Default:CheckIn:C.Wait] Stopped 2020-03-02T21:06:58.166Z,1583183218.166 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T21:06:58.167Z,1583183218.167 [Default:CheckIn:D] Running Loop=1 2020-03-02T21:06:58.577Z,1583183218.577 [Default:CheckIn:D] Stopped 2020-03-02T21:06:58.577Z,1583183218.577 [Default:CheckIn:E] Running Loop=1 2020-03-02T21:06:58.993Z,1583183218.993 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 91.988664 min 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn:E] Stopped 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn] Stopped 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn](INFO): Running loop #15 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn] Running Loop=15 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-03-02T21:06:58.994Z,1583183218.994 [Default:CheckIn:Read_GPS] Running Loop=1 2020-03-02T21:07:11.514Z,1583183231.514 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:07:22.473Z,1583183242.473 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:07:31.678Z,1583183251.678 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2020-03-02T21:07:31.753Z,1583183251.753 [NAL9602](FAULT): received: +CSQ:0 OK338, 0, 0, 0, 0 OK 2020-03-02T21:07:31.753Z,1583183251.753 [NAL9602] Data Fault, FailCount= 2 2020-03-02T21:07:31.753Z,1583183251.753 [NAL9602](ERROR): Data Fault 2020-03-02T21:07:31.847Z,1583183251.847 [CBIT](ERROR): Data Fault in component: NAL9602 2020-03-02T21:07:32.087Z,1583183252.087 [NAL9602](INFO): Powering down 2020-03-02T21:07:32.972Z,1583183252.972 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:07:32.990Z,1583183252.990 [CBIT](INFO): Clearing failed state for component NAL9602 2020-03-02T21:07:32.990Z,1583183252.990 [NAL9602] No Fault, FailCount= 2 2020-03-02T21:07:33.773Z,1583183253.773 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:07:44.285Z,1583183264.285 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:07:53.498Z,1583183273.498 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2020-03-02T21:07:53.498Z,1583183273.498 [DropWeight] Hardware Fault, FailCount= 1 2020-03-02T21:07:53.498Z,1583183273.498 [DropWeight](ERROR): Hardware Fault 2020-03-02T21:07:53.529Z,1583183273.529 [CBIT](INFO): Critical error at 20200302T210753 2020-03-02T21:07:53.531Z,1583183273.531 [CBIT](ERROR): Hardware Fault in component: DropWeight 2020-03-02T21:07:53.531Z,1583183273.531 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2020-03-02T21:07:53.933Z,1583183273.933 [CBIT](INFO): Critical error at 20200302T210753 2020-03-02T21:07:55.197Z,1583183275.197 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:08:02.382Z,1583183282.382 [NAL9602](INFO): Powering up NAL9602 2020-03-02T21:08:06.511Z,1583183286.511 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:08:13.285Z,1583183293.285 [NAL9602](INFO): NAL9602 initialized 2020-03-02T21:08:14.098Z,1583183294.098 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-03-02T21:08:14.098Z,1583183294.098 [NAL9602] Data Fault, FailCount= 3 2020-03-02T21:08:14.098Z,1583183294.098 [NAL9602](ERROR): Data Fault 2020-03-02T21:08:14.132Z,1583183294.132 [CBIT](ERROR): Data Fault in component: NAL9602 2020-03-02T21:08:14.507Z,1583183294.507 [NAL9602](INFO): Powering down 2020-03-02T21:08:15.368Z,1583183295.368 [CBIT](INFO): Clearing failed state for component NAL9602 2020-03-02T21:08:15.368Z,1583183295.368 [NAL9602] No Fault, FailCount= 3 2020-03-02T21:08:17.411Z,1583183297.411 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:08:28.394Z,1583183308.394 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:08:39.323Z,1583183319.323 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:08:44.807Z,1583183324.807 [NAL9602](INFO): Powering up NAL9602 2020-03-02T21:08:50.546Z,1583183330.546 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:08:55.710Z,1583183335.710 [NAL9602](INFO): NAL9602 initialized 2020-03-02T21:09:01.454Z,1583183341.454 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:12.016Z,1583183352.016 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:21.254Z,1583183361.254 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:22.859Z,1583183362.859 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:32.562Z,1583183372.562 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:33.772Z,1583183373.772 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:43.467Z,1583183383.467 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:44.676Z,1583183384.676 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:54.377Z,1583183394.377 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:09:55.589Z,1583183395.589 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:05.291Z,1583183405.291 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:06.914Z,1583183406.914 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:16.611Z,1583183416.611 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:17.816Z,1583183417.816 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:27.513Z,1583183427.513 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:28.327Z,1583183428.327 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:38.411Z,1583183438.411 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:39.715Z,1583183439.715 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:49.323Z,1583183449.323 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:10:50.533Z,1583183450.533 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:00.228Z,1583183460.228 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:01.444Z,1583183461.444 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:11.208Z,1583183471.208 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:12.405Z,1583183472.405 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:22.045Z,1583183482.045 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:23.260Z,1583183483.260 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:32.958Z,1583183492.958 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:34.173Z,1583183494.173 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:43.911Z,1583183503.911 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:45.087Z,1583183505.087 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:54.773Z,1583183514.773 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:55.986Z,1583183515.986 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:11:59.158Z,1583183519.158 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-03-02T21:06:58.0Z 2020-03-02T21:11:59.158Z,1583183519.158 [Default:CheckIn:Read_GPS] Stopped 2020-03-02T21:11:59.159Z,1583183519.159 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-03-02T21:12:02.758Z,1583183522.758 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-03-02T21:12:05.720Z,1583183525.720 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:06.499Z,1583183526.499 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:07.112Z,1583183527.112 [DataOverHttps](INFO): Sending 103 bytes from file Logs/20200302T194851/Courier0039.lzma 2020-03-02T21:12:09.118Z,1583183529.118 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Courier0039.lzma.bak 2020-03-02T21:12:09.119Z,1583183529.119 [DataOverHttps](INFO): SBD MOMSN=12279925 2020-03-02T21:12:16.587Z,1583183536.587 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:17.402Z,1583183537.402 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:26.221Z,1583183546.221 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20200302T194851/Express0040.lzma 2020-03-02T21:12:27.489Z,1583183547.489 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:28.226Z,1583183548.226 [DataOverHttps](INFO): Moved sent file to Logs/20200302T194851/Express0040.lzma.bak 2020-03-02T21:12:28.227Z,1583183548.227 [DataOverHttps](INFO): SBD MOMSN=12279929 2020-03-02T21:12:28.326Z,1583183548.326 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:29.461Z,1583183549.461 [Default:CheckIn:Read_Iridium] Stopped 2020-03-02T21:12:29.461Z,1583183549.461 [Default:CheckIn:C.Wait] Running Loop=1 2020-03-02T21:12:29.461Z,1583183549.461 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-03-02T21:12:33.461Z,1583183553.461 [NAL9602](INFO): Not Powering down - fast GPS 2020-03-02T21:12:38.405Z,1583183558.405 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:39.257Z,1583183559.257 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:49.308Z,1583183569.308 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:12:50.522Z,1583183570.522 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:00.215Z,1583183580.215 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:01.934Z,1583183581.934 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:11.568Z,1583183591.568 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:13.150Z,1583183593.150 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:22.434Z,1583183602.434 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:24.455Z,1583183604.455 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:33.392Z,1583183613.392 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:35.023Z,1583183615.023 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:44.658Z,1583183624.658 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:45.068Z,1583183625.068 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:55.564Z,1583183635.564 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-03-02T21:13:55.984Z,1583183635.984 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:14:06.932Z,1583183646.932 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:14:17.784Z,1583183657.784 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:14:28.288Z,1583183668.288 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-03-02T21:16:02.818Z,1583183762.818 [CommandLine](IMPORTANT): got command quit 2020-03-02T21:16:03.825Z,1583183763.825 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:03.825Z,1583183763.825 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.017Z,1583183764.017 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-03-02T21:16:04.017Z,1583183764.017 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.018Z,1583183764.018 [CommandLine](INFO): Join timeout helper Thread ID is 597 2020-03-02T21:16:04.025Z,1583183764.025 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-03-02T21:16:04.026Z,1583183764.026 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.026Z,1583183764.026 [NavChartDb](INFO): Join timeout helper Thread ID is 598 2020-03-02T21:16:04.281Z,1583183764.281 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:04.281Z,1583183764.281 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.293Z,1583183764.293 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-03-02T21:16:04.293Z,1583183764.293 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.293Z,1583183764.293 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 599 2020-03-02T21:16:04.529Z,1583183764.529 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:04.529Z,1583183764.529 [WetLabsBB2FL](INFO): Powering down 2020-03-02T21:16:04.530Z,1583183764.530 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.537Z,1583183764.537 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-03-02T21:16:04.537Z,1583183764.537 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.537Z,1583183764.537 [CTD_Seabird](INFO): Join timeout helper Thread ID is 600 2020-03-02T21:16:04.825Z,1583183764.825 [CTD_Seabird](INFO): Powering down 2020-03-02T21:16:04.837Z,1583183764.837 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:04.837Z,1583183764.837 [CTD_Seabird](INFO): Powering down 2020-03-02T21:16:04.849Z,1583183764.849 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.863Z,1583183764.863 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-03-02T21:16:04.863Z,1583183764.863 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.863Z,1583183764.863 [Radio_Surface](INFO): Join timeout helper Thread ID is 601 2020-03-02T21:16:04.933Z,1583183764.933 [Radio_Surface](INFO): Powering down 2020-03-02T21:16:04.934Z,1583183764.934 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:04.934Z,1583183764.934 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.942Z,1583183764.942 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-03-02T21:16:04.942Z,1583183764.942 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:04.942Z,1583183764.942 [DataOverHttps](INFO): Join timeout helper Thread ID is 602 2020-03-02T21:16:05.661Z,1583183765.661 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:05.661Z,1583183765.661 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:05.669Z,1583183765.669 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-03-02T21:16:05.670Z,1583183765.670 [logger ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:05.670Z,1583183765.670 [logger](INFO): Join timeout helper Thread ID is 603 2020-03-02T21:16:05.685Z,1583183765.685 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:05.685Z,1583183765.685 [logger ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:05.689Z,1583183765.689 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-03-02T21:16:05.690Z,1583183765.690 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:05.690Z,1583183765.690 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-03-02T21:16:05.690Z,1583183765.690 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:05.690Z,1583183765.690 [controlThread](INFO): Join timeout helper Thread ID is 604 2020-03-02T21:16:05.949Z,1583183765.949 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-03-02T21:16:05.949Z,1583183765.949 [controlThread](DEBUG): Uninitializing ControlThread 2020-03-02T21:16:05.950Z,1583183765.950 [AHRS_M2](INFO): Powering down 2020-03-02T21:16:06.021Z,1583183766.021 [NAL9602](INFO): Powering down 2020-03-02T21:16:06.024Z,1583183766.024 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-03-02T21:16:06.025Z,1583183766.025 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-03-02T21:16:06.026Z,1583183766.026 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-03-02T21:16:06.026Z,1583183766.026 [MissionManager](INFO): Uninitializing Mission Default 2020-03-02T21:16:06.026Z,1583183766.026 [Default] Stopped 2020-03-02T21:16:06.026Z,1583183766.026 [Default](DEBUG): Aggregate::uninitialize Default 2020-03-02T21:16:06.026Z,1583183766.026 [Default:B.GoToSurface] Stopped 2020-03-02T21:16:06.027Z,1583183766.027 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-03-02T21:16:06.027Z,1583183766.027 [Default:CheckIn] Stopped 2020-03-02T21:16:06.027Z,1583183766.027 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-03-02T21:16:06.027Z,1583183766.027 [Default:CheckIn:C.Wait] Stopped 2020-03-02T21:16:06.027Z,1583183766.027 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-03-02T21:16:06.029Z,1583183766.029 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-03-02T21:16:06.030Z,1583183766.030 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-03-02T21:16:06.030Z,1583183766.030 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-03-02T21:16:06.030Z,1583183766.030 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-03-02T21:16:06.031Z,1583183766.031 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-03-02T21:16:06.031Z,1583183766.031 [BuoyancyServo](INFO): Powering down 2020-03-02T21:16:06.045Z,1583183766.045 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-03-02T21:16:06.045Z,1583183766.045 [ElevatorServo](INFO): Powering down 2020-03-02T21:16:06.046Z,1583183766.046 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-03-02T21:16:06.046Z,1583183766.046 [MassServo](INFO): Powering down 2020-03-02T21:16:06.047Z,1583183766.047 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-03-02T21:16:06.047Z,1583183766.047 [RudderServo](INFO): Powering down 2020-03-02T21:16:06.047Z,1583183766.047 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-03-02T21:16:06.048Z,1583183766.048 [ThrusterServo](INFO): Powering down 2020-03-02T21:16:06.048Z,1583183766.048 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-03-02T21:16:06.049Z,1583183766.049 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-03-02T21:16:06.049Z,1583183766.049 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-03-02T21:16:06.049Z,1583183766.049 [CBIT](DEBUG): Powering off loads. 2020-03-02T21:16:06.061Z,1583183766.061 [CBIT](DEBUG): Disabling WDT. 2020-03-02T21:16:06.073Z,1583183766.073 [CBIT](DEBUG): Opening all GF detection circuits. 2020-03-02T21:16:06.073Z,1583183766.073 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:06.167Z,1583183766.167 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:06.173Z,1583183766.173 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:06.208Z,1583183766.208 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:06.212Z,1583183766.212 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:06.249Z,1583183766.249 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-03-02T21:16:06.352Z,1583183766.352 [logger ThreadHandler](INFO): Thread cancelled.