2019-12-16T20:23:12.634Z,1576527792.634 [CommandLine](IMPORTANT): got command restart logs
2019-12-16T20:23:24.366Z,1576527804.366 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T20:27:26.457Z,1576528046.457 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T20:27:26.457Z,1576528046.457 [Default:CheckIn:C.Wait] Stopped
2019-12-16T20:27:26.457Z,1576528046.457 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T20:27:26.458Z,1576528046.458 [Default:CheckIn:D] Running Loop=1
2019-12-16T20:27:26.862Z,1576528046.862 [Default:CheckIn:D] Stopped
2019-12-16T20:27:26.862Z,1576528046.862 [Default:CheckIn:E] Running Loop=1
2019-12-16T20:27:27.273Z,1576528047.273 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.067497 min 
2019-12-16T20:27:27.273Z,1576528047.273 [Default:CheckIn:E] Stopped
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn] Stopped
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn](INFO): Running loop #3
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn] Running Loop=3
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T20:27:27.274Z,1576528047.274 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T20:27:29.252Z,1576528049.252 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202048.00,A,3648.50213,N,12147.21741,W,8.222,53.98,161219,,,A*4D
2019-12-16T20:27:29.254Z,1576528049.254 [NAL9602](INFO): GPS fix at 20191216T202048: (36.808369, -121.786957)
2019-12-16T20:27:29.277Z,1576528049.277 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T20:27:29.277Z,1576528049.277 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T20:27:36.692Z,1576528056.692 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T175803/Courier0030.lzma
2019-12-16T20:27:38.698Z,1576528058.698 [DataOverHttps](INFO): Moved sent file to Logs/20191216T175803/Courier0030.lzma.bak
2019-12-16T20:27:38.699Z,1576528058.699 [DataOverHttps](INFO): SBD MOMSN=12171732
2019-12-16T20:27:54.299Z,1576528074.299 [NAL9602](INFO): SBD MO Status=2, MOMSN=18393, MT Status=2, MTMSN=0
2019-12-16T20:27:54.300Z,1576528074.300 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-12-16T20:27:55.801Z,1576528075.801 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20191216T202312/Courier0000.lzma
2019-12-16T20:27:57.806Z,1576528077.806 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0000.lzma.bak
2019-12-16T20:27:57.806Z,1576528077.806 [DataOverHttps](INFO): SBD MOMSN=12171734
2019-12-16T20:28:05.615Z,1576528085.615 [NAL9602](INFO): SBD MO Status=1, MOMSN=18393, MT Status=0, MTMSN=0
2019-12-16T20:28:05.615Z,1576528085.615 [NAL9602](INFO): No messages in MT queue
2019-12-16T20:28:14.952Z,1576528094.952 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0003.lzma
2019-12-16T20:28:16.958Z,1576528096.958 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0003.lzma.bak
2019-12-16T20:28:16.959Z,1576528096.959 [DataOverHttps](INFO): SBD MOMSN=12171738
2019-12-16T20:28:33.941Z,1576528113.941 [DataOverHttps](INFO): Sending 96 bytes from file Logs/20191216T175803/Express0031.lzma
2019-12-16T20:28:35.946Z,1576528115.946 [DataOverHttps](INFO): Moved sent file to Logs/20191216T175803/Express0031.lzma.bak
2019-12-16T20:28:35.947Z,1576528115.947 [DataOverHttps](INFO): SBD MOMSN=12171740
2019-12-16T20:28:36.318Z,1576528116.318 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T20:29:14.017Z,1576528154.017 [DataOverHttps](INFO): Sending 339 bytes from file Logs/20191216T202312/Express0001.lzma
2019-12-16T20:29:16.022Z,1576528156.022 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0001.lzma.bak
2019-12-16T20:29:16.022Z,1576528156.022 [DataOverHttps](INFO): SBD MOMSN=12171743
2019-12-16T20:29:33.008Z,1576528173.008 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20191216T202312/Express0004.lzma
2019-12-16T20:29:35.014Z,1576528175.014 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0004.lzma.bak
2019-12-16T20:29:35.015Z,1576528175.015 [DataOverHttps](INFO): SBD MOMSN=12171747
2019-12-16T20:29:36.140Z,1576528176.140 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T20:29:36.140Z,1576528176.140 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T20:29:36.140Z,1576528176.140 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T20:34:36.738Z,1576528476.738 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T20:34:36.738Z,1576528476.738 [Default:CheckIn:C.Wait] Stopped
2019-12-16T20:34:36.738Z,1576528476.738 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T20:34:36.738Z,1576528476.738 [Default:CheckIn:D] Running Loop=1
2019-12-16T20:34:37.153Z,1576528477.153 [Default:CheckIn:D] Stopped
2019-12-16T20:34:37.153Z,1576528477.153 [Default:CheckIn:E] Running Loop=1
2019-12-16T20:34:37.569Z,1576528477.569 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.239006 min 
2019-12-16T20:34:37.569Z,1576528477.569 [Default:CheckIn:E] Stopped
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn] Stopped
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn](INFO): Running loop #4
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn] Running Loop=4
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T20:34:37.570Z,1576528477.570 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T20:34:39.552Z,1576528479.552 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,202758.00,A,3648.14959,N,12147.22246,W,0.078,215.22,161219,,,A*7B
2019-12-16T20:34:39.554Z,1576528479.554 [NAL9602](INFO): GPS fix at 20191216T202758: (36.802493, -121.787041)
2019-12-16T20:34:39.577Z,1576528479.577 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T20:34:39.577Z,1576528479.577 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T20:34:47.640Z,1576528487.640 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20191216T202312/Courier0006.lzma
2019-12-16T20:34:49.649Z,1576528489.649 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0006.lzma.bak
2019-12-16T20:34:49.649Z,1576528489.649 [DataOverHttps](INFO): SBD MOMSN=12171760
2019-12-16T20:35:04.187Z,1576528504.187 [NAL9602](INFO): SBD MO Status=1, MOMSN=18394, MT Status=0, MTMSN=0
2019-12-16T20:35:04.188Z,1576528504.188 [NAL9602](INFO): No messages in MT queue
2019-12-16T20:35:06.647Z,1576528506.647 [DataOverHttps](INFO): Sending 131 bytes from file Logs/20191216T202312/Express0007.lzma
2019-12-16T20:35:08.653Z,1576528508.653 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0007.lzma.bak
2019-12-16T20:35:08.653Z,1576528508.653 [DataOverHttps](INFO): SBD MOMSN=12171763
2019-12-16T20:35:09.877Z,1576528509.877 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T20:35:09.877Z,1576528509.877 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T20:35:09.877Z,1576528509.877 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T20:35:34.928Z,1576528534.928 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T20:40:10.517Z,1576528810.517 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T20:40:10.518Z,1576528810.518 [Default:CheckIn:C.Wait] Stopped
2019-12-16T20:40:10.518Z,1576528810.518 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T20:40:10.518Z,1576528810.518 [Default:CheckIn:D] Running Loop=1
2019-12-16T20:40:10.929Z,1576528810.929 [Default:CheckIn:D] Stopped
2019-12-16T20:40:10.929Z,1576528810.929 [Default:CheckIn:E] Running Loop=1
2019-12-16T20:40:11.325Z,1576528811.325 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 25.801943 min 
2019-12-16T20:40:11.325Z,1576528811.325 [Default:CheckIn:E] Stopped
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn] Stopped
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn](INFO): Running loop #5
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn] Running Loop=5
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T20:40:11.326Z,1576528811.326 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T20:40:13.311Z,1576528813.311 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203331.00,A,3648.14093,N,12147.24392,W,2.060,290.34,161219,,,A*71
2019-12-16T20:40:13.313Z,1576528813.313 [NAL9602](INFO): GPS fix at 20191216T203331: (36.802349, -121.787399)
2019-12-16T20:40:13.365Z,1576528813.365 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T20:40:13.365Z,1576528813.365 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T20:40:20.544Z,1576528820.544 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20191216T202312/Courier0009.lzma
2019-12-16T20:40:22.550Z,1576528822.550 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0009.lzma.bak
2019-12-16T20:40:22.550Z,1576528822.550 [DataOverHttps](INFO): SBD MOMSN=12171767
2019-12-16T20:40:35.136Z,1576528835.136 [NAL9602](INFO): SBD MO Status=2, MOMSN=18395, MT Status=2, MTMSN=0
2019-12-16T20:40:35.137Z,1576528835.137 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-12-16T20:40:39.595Z,1576528839.595 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20191216T202312/Express0010.lzma
2019-12-16T20:40:41.602Z,1576528841.602 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0010.lzma.bak
2019-12-16T20:40:41.603Z,1576528841.603 [DataOverHttps](INFO): SBD MOMSN=12171770
2019-12-16T20:40:42.837Z,1576528842.837 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T20:40:42.837Z,1576528842.837 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T20:40:42.837Z,1576528842.837 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T20:40:47.251Z,1576528847.251 [NAL9602](INFO): SBD MO Status=1, MOMSN=18395, MT Status=0, MTMSN=0
2019-12-16T20:40:47.252Z,1576528847.252 [NAL9602](INFO): No messages in MT queue
2019-12-16T20:41:17.954Z,1576528877.954 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T20:45:43.424Z,1576529143.424 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T20:45:43.424Z,1576529143.424 [Default:CheckIn:C.Wait] Stopped
2019-12-16T20:45:43.424Z,1576529143.424 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T20:45:43.425Z,1576529143.425 [Default:CheckIn:D] Running Loop=1
2019-12-16T20:45:43.816Z,1576529143.816 [Default:CheckIn:D] Stopped
2019-12-16T20:45:43.816Z,1576529143.816 [Default:CheckIn:E] Running Loop=1
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.350055 min 
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn:E] Stopped
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn] Stopped
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn](INFO): Running loop #6
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn] Running Loop=6
2019-12-16T20:45:44.215Z,1576529144.215 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T20:45:44.216Z,1576529144.216 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T20:45:46.216Z,1576529146.216 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203903.00,A,3648.16855,N,12147.28092,W,0.058,271.39,161219,,,A*7E
2019-12-16T20:45:46.229Z,1576529146.229 [NAL9602](INFO): GPS fix at 20191216T203903: (36.802809, -121.788015)
2019-12-16T20:45:46.252Z,1576529146.252 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T20:45:46.252Z,1576529146.252 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T20:45:53.844Z,1576529153.844 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20191216T202312/Courier0012.lzma
2019-12-16T20:45:55.850Z,1576529155.850 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0012.lzma.bak
2019-12-16T20:45:55.851Z,1576529155.851 [DataOverHttps](INFO): SBD MOMSN=12171796
2019-12-16T20:46:12.865Z,1576529172.865 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20191216T202312/Express0013.lzma
2019-12-16T20:46:14.870Z,1576529174.870 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0013.lzma.bak
2019-12-16T20:46:14.871Z,1576529174.871 [DataOverHttps](INFO): SBD MOMSN=12171799
2019-12-16T20:46:16.147Z,1576529176.147 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T20:46:16.147Z,1576529176.147 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T20:46:16.147Z,1576529176.147 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T20:50:47.998Z,1576529447.998 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T20:51:16.732Z,1576529476.732 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T20:51:16.733Z,1576529476.733 [Default:CheckIn:C.Wait] Stopped
2019-12-16T20:51:16.733Z,1576529476.733 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T20:51:16.733Z,1576529476.733 [Default:CheckIn:D] Running Loop=1
2019-12-16T20:51:17.116Z,1576529477.116 [Default:CheckIn:D] Stopped
2019-12-16T20:51:17.116Z,1576529477.116 [Default:CheckIn:E] Running Loop=1
2019-12-16T20:51:17.606Z,1576529477.606 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.905054 min 
2019-12-16T20:51:17.606Z,1576529477.606 [Default:CheckIn:E] Stopped
2019-12-16T20:51:17.606Z,1576529477.606 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T20:51:17.606Z,1576529477.606 [Default:CheckIn] Stopped
2019-12-16T20:51:17.607Z,1576529477.607 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T20:51:17.607Z,1576529477.607 [Default:CheckIn](INFO): Running loop #7
2019-12-16T20:51:17.607Z,1576529477.607 [Default:CheckIn] Running Loop=7
2019-12-16T20:51:17.607Z,1576529477.607 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T20:51:17.607Z,1576529477.607 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T20:51:19.524Z,1576529479.524 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,204436.00,A,3648.15763,N,12147.28215,W,0.836,143.06,161219,,,A*78
2019-12-16T20:51:19.526Z,1576529479.526 [NAL9602](INFO): GPS fix at 20191216T204436: (36.802627, -121.788036)
2019-12-16T20:51:19.556Z,1576529479.556 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T20:51:19.557Z,1576529479.557 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T20:51:26.816Z,1576529486.816 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20191216T202312/Courier0015.lzma
2019-12-16T20:51:28.822Z,1576529488.822 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0015.lzma.bak
2019-12-16T20:51:28.822Z,1576529488.822 [DataOverHttps](INFO): SBD MOMSN=12171802
2019-12-16T20:51:45.825Z,1576529505.825 [DataOverHttps](INFO): Sending 220 bytes from file Logs/20191216T202312/Express0016.lzma
2019-12-16T20:51:47.831Z,1576529507.831 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0016.lzma.bak
2019-12-16T20:51:47.832Z,1576529507.832 [DataOverHttps](INFO): SBD MOMSN=12171805
2019-12-16T20:51:49.081Z,1576529509.081 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T20:51:49.081Z,1576529509.081 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T20:51:49.082Z,1576529509.082 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T20:51:51.870Z,1576529511.870 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T20:54:25.428Z,1576529665.428 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2019-12-16T20:54:25.430Z,1576529665.430 [BPC1](INFO): Received data from all battery sticks.
2019-12-16T20:56:49.649Z,1576529809.649 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T20:56:49.649Z,1576529809.649 [Default:CheckIn:C.Wait] Stopped
2019-12-16T20:56:49.649Z,1576529809.649 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T20:56:49.650Z,1576529809.650 [Default:CheckIn:D] Running Loop=1
2019-12-16T20:56:50.059Z,1576529810.059 [Default:CheckIn:D] Stopped
2019-12-16T20:56:50.059Z,1576529810.059 [Default:CheckIn:E] Running Loop=1
2019-12-16T20:56:50.464Z,1576529810.464 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.454106 min 
2019-12-16T20:56:50.464Z,1576529810.464 [Default:CheckIn:E] Stopped
2019-12-16T20:56:50.464Z,1576529810.464 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T20:56:50.465Z,1576529810.465 [Default:CheckIn] Stopped
2019-12-16T20:56:50.465Z,1576529810.465 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T20:56:50.465Z,1576529810.465 [Default:CheckIn](INFO): Running loop #8
2019-12-16T20:56:50.465Z,1576529810.465 [Default:CheckIn] Running Loop=8
2019-12-16T20:56:50.465Z,1576529810.465 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T20:56:50.465Z,1576529810.465 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T20:56:52.452Z,1576529812.452 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205009.00,A,3648.16594,N,12147.28898,W,0.603,56.39,161219,,,A*46
2019-12-16T20:56:52.455Z,1576529812.455 [NAL9602](INFO): GPS fix at 20191216T205009: (36.802766, -121.788150)
2019-12-16T20:56:52.503Z,1576529812.503 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T20:56:52.503Z,1576529812.503 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T20:57:00.512Z,1576529820.512 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20191216T202312/Courier0018.lzma
2019-12-16T20:57:02.514Z,1576529822.514 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0018.lzma.bak
2019-12-16T20:57:02.514Z,1576529822.514 [DataOverHttps](INFO): SBD MOMSN=12171824
2019-12-16T20:57:22.844Z,1576529842.844 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20191216T202312/Express0019.lzma
2019-12-16T20:57:23.170Z,1576529843.170 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-12-16T20:57:23.245Z,1576529843.245 [NAL9602](FAULT): received: 
+CSQ:0

OK395, 0, 0, 0, 0

OK
2019-12-16T20:57:23.245Z,1576529843.245 [NAL9602] Data Fault, FailCount= 1
2019-12-16T20:57:23.245Z,1576529843.245 [NAL9602](ERROR): Data Fault
2019-12-16T20:57:23.327Z,1576529843.327 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T20:57:23.575Z,1576529843.575 [NAL9602](INFO): Powering down
2019-12-16T20:57:23.978Z,1576529843.978 [NAL9602](FAULT): LCB fault:  Software Overcurrent.
2019-12-16T20:57:23.978Z,1576529843.978 [NAL9602] Hardware Fault, FailCount= 1
2019-12-16T20:57:23.978Z,1576529843.978 [NAL9602](ERROR): Hardware Fault
2019-12-16T20:57:24.428Z,1576529844.428 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T20:57:24.428Z,1576529844.428 [NAL9602] No Fault, FailCount= 1
2019-12-16T20:57:24.850Z,1576529844.850 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0019.lzma.bak
2019-12-16T20:57:24.851Z,1576529844.851 [DataOverHttps](INFO): SBD MOMSN=12171827
2019-12-16T20:57:26.053Z,1576529846.053 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T20:57:26.053Z,1576529846.053 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T20:57:26.053Z,1576529846.053 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T20:57:53.872Z,1576529873.872 [NAL9602](INFO): Powering up NAL9602
2019-12-16T20:58:04.790Z,1576529884.790 [NAL9602](INFO): NAL9602 initialized
2019-12-16T20:58:35.890Z,1576529915.890 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T20:59:15.998Z,1576529955.998 [Reporter](INFO): platform_buoyancy_position 191.501740 cc
2019-12-16T21:02:26.595Z,1576530146.595 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T21:02:26.595Z,1576530146.595 [Default:CheckIn:C.Wait] Stopped
2019-12-16T21:02:26.595Z,1576530146.595 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T21:02:26.595Z,1576530146.595 [Default:CheckIn:D] Running Loop=1
2019-12-16T21:02:27.005Z,1576530147.005 [Default:CheckIn:D] Stopped
2019-12-16T21:02:27.005Z,1576530147.005 [Default:CheckIn:E] Running Loop=1
2019-12-16T21:02:27.417Z,1576530147.417 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 48.069881 min 
2019-12-16T21:02:27.417Z,1576530147.417 [Default:CheckIn:E] Stopped
2019-12-16T21:02:27.417Z,1576530147.417 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T21:02:27.417Z,1576530147.417 [Default:CheckIn] Stopped
2019-12-16T21:02:27.417Z,1576530147.417 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T21:02:27.418Z,1576530147.418 [Default:CheckIn](INFO): Running loop #9
2019-12-16T21:02:27.418Z,1576530147.418 [Default:CheckIn] Running Loop=9
2019-12-16T21:02:27.418Z,1576530147.418 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T21:02:27.418Z,1576530147.418 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T21:02:31.421Z,1576530151.421 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T21:07:27.621Z,1576530447.621 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T21:02:27.4Z
2019-12-16T21:07:27.621Z,1576530447.621 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T21:07:27.621Z,1576530447.621 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T21:07:39.209Z,1576530459.209 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0021.lzma
2019-12-16T21:07:41.215Z,1576530461.215 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0021.lzma.bak
2019-12-16T21:07:41.215Z,1576530461.215 [DataOverHttps](INFO): SBD MOMSN=12171883
2019-12-16T21:07:57.970Z,1576530477.970 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T21:08:08.033Z,1576530488.033 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20191216T202312/Express0022.lzma
2019-12-16T21:08:10.038Z,1576530490.038 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0022.lzma.bak
2019-12-16T21:08:10.039Z,1576530490.039 [DataOverHttps](INFO): SBD MOMSN=12171885
2019-12-16T21:08:11.348Z,1576530491.348 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T21:08:11.353Z,1576530491.353 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T21:08:11.353Z,1576530491.353 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T21:13:11.928Z,1576530791.928 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T21:13:11.933Z,1576530791.933 [Default:CheckIn:C.Wait] Stopped
2019-12-16T21:13:11.933Z,1576530791.933 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T21:13:11.935Z,1576530791.935 [Default:CheckIn:D] Running Loop=1
2019-12-16T21:13:12.349Z,1576530792.349 [Default:CheckIn:D] Stopped
2019-12-16T21:13:12.349Z,1576530792.349 [Default:CheckIn:E] Running Loop=1
2019-12-16T21:13:12.771Z,1576530792.771 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.825610 min 
2019-12-16T21:13:12.771Z,1576530792.771 [Default:CheckIn:E] Stopped
2019-12-16T21:13:12.771Z,1576530792.771 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T21:13:12.771Z,1576530792.771 [Default:CheckIn] Stopped
2019-12-16T21:13:12.771Z,1576530792.771 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T21:13:12.772Z,1576530792.772 [Default:CheckIn](INFO): Running loop #10
2019-12-16T21:13:12.772Z,1576530792.772 [Default:CheckIn] Running Loop=10
2019-12-16T21:13:12.772Z,1576530792.772 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T21:13:12.772Z,1576530792.772 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T21:13:14.303Z,1576530794.303 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T21:13:14.303Z,1576530794.303 [NAL9602] Data Fault, FailCount= 1
2019-12-16T21:13:14.303Z,1576530794.303 [NAL9602](ERROR): Data Fault
2019-12-16T21:13:14.375Z,1576530794.375 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T21:13:14.706Z,1576530794.706 [NAL9602](INFO): Powering down
2019-12-16T21:13:15.586Z,1576530795.586 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T21:13:15.586Z,1576530795.586 [NAL9602] No Fault, FailCount= 1
2019-12-16T21:13:45.006Z,1576530825.006 [NAL9602](INFO): Powering up NAL9602
2019-12-16T21:13:55.914Z,1576530835.914 [NAL9602](INFO): NAL9602 initialized
2019-12-16T21:18:12.921Z,1576531092.921 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T21:13:12.8Z
2019-12-16T21:18:12.921Z,1576531092.921 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T21:18:12.921Z,1576531092.921 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T21:18:25.161Z,1576531105.161 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0024.lzma
2019-12-16T21:18:27.167Z,1576531107.167 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0024.lzma.bak
2019-12-16T21:18:27.167Z,1576531107.167 [DataOverHttps](INFO): SBD MOMSN=12171898
2019-12-16T21:18:51.769Z,1576531131.769 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20191216T202312/Express0025.lzma
2019-12-16T21:18:53.774Z,1576531133.774 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0025.lzma.bak
2019-12-16T21:18:53.775Z,1576531133.775 [DataOverHttps](INFO): SBD MOMSN=12171900
2019-12-16T21:18:54.976Z,1576531134.976 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T21:18:54.976Z,1576531134.976 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T21:18:54.976Z,1576531134.976 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T21:18:59.390Z,1576531139.390 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T21:19:30.094Z,1576531170.094 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T21:23:55.557Z,1576531435.557 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T21:23:55.557Z,1576531435.557 [Default:CheckIn:C.Wait] Stopped
2019-12-16T21:23:55.557Z,1576531435.557 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T21:23:55.558Z,1576531435.558 [Default:CheckIn:D] Running Loop=1
2019-12-16T21:23:55.949Z,1576531435.949 [Default:CheckIn:D] Stopped
2019-12-16T21:23:55.949Z,1576531435.949 [Default:CheckIn:E] Running Loop=1
2019-12-16T21:23:56.360Z,1576531436.360 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.552271 min 
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn:E] Stopped
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn] Stopped
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn](INFO): Running loop #11
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn] Running Loop=11
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T21:23:56.361Z,1576531436.361 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T21:23:57.946Z,1576531437.946 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T21:23:57.946Z,1576531437.946 [NAL9602] Data Fault, FailCount= 2
2019-12-16T21:23:57.946Z,1576531437.946 [NAL9602](ERROR): Data Fault
2019-12-16T21:23:57.978Z,1576531437.978 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T21:23:58.350Z,1576531438.350 [NAL9602](INFO): Powering down
2019-12-16T21:23:59.189Z,1576531439.189 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T21:23:59.189Z,1576531439.189 [NAL9602] No Fault, FailCount= 2
2019-12-16T21:24:28.650Z,1576531468.650 [NAL9602](INFO): Powering up NAL9602
2019-12-16T21:24:39.562Z,1576531479.562 [NAL9602](INFO): NAL9602 initialized
2019-12-16T21:28:56.553Z,1576531736.553 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T21:23:56.4Z
2019-12-16T21:28:56.553Z,1576531736.553 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T21:28:56.554Z,1576531736.554 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T21:29:04.587Z,1576531744.587 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0027.lzma
2019-12-16T21:29:06.590Z,1576531746.590 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0027.lzma.bak
2019-12-16T21:29:06.591Z,1576531746.591 [DataOverHttps](INFO): SBD MOMSN=12171910
2019-12-16T21:29:23.633Z,1576531763.633 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20191216T202312/Express0028.lzma
2019-12-16T21:29:25.638Z,1576531765.638 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0028.lzma.bak
2019-12-16T21:29:25.639Z,1576531765.639 [DataOverHttps](INFO): SBD MOMSN=12171912
2019-12-16T21:29:26.850Z,1576531766.850 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T21:29:26.850Z,1576531766.850 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T21:29:26.850Z,1576531766.850 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T21:29:42.966Z,1576531782.966 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T21:30:13.663Z,1576531813.663 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T21:33:30.066Z,1576532010.066 [CBIT](IMPORTANT): Beginning ground fault scan
2019-12-16T21:33:40.960Z,1576532020.960 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.000084
CHAN A1 (24V): -0.181208
CHAN A2 (12V): -0.001858
CHAN A3 (5V): -0.001291
CHAN B0 (3.3V): -0.000157
CHAN B1 (3.15aV): -0.000334
CHAN B2 (3.15bV): -0.000387
CHAN B3 (GND): -0.000219
OPEN: -0.000421
Full Scale Calc: 4.765 mA, -1.589 mA
2019-12-16T21:34:27.404Z,1576532067.404 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T21:34:27.404Z,1576532067.404 [Default:CheckIn:C.Wait] Stopped
2019-12-16T21:34:27.404Z,1576532067.404 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T21:34:27.405Z,1576532067.405 [Default:CheckIn:D] Running Loop=1
2019-12-16T21:34:27.817Z,1576532067.817 [Default:CheckIn:D] Stopped
2019-12-16T21:34:27.817Z,1576532067.817 [Default:CheckIn:E] Running Loop=1
2019-12-16T21:34:28.219Z,1576532068.219 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.083398 min 
2019-12-16T21:34:28.219Z,1576532068.219 [Default:CheckIn:E] Stopped
2019-12-16T21:34:28.219Z,1576532068.219 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T21:34:28.219Z,1576532068.219 [Default:CheckIn] Stopped
2019-12-16T21:34:28.220Z,1576532068.220 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T21:34:28.220Z,1576532068.220 [Default:CheckIn](INFO): Running loop #12
2019-12-16T21:34:28.220Z,1576532068.220 [Default:CheckIn] Running Loop=12
2019-12-16T21:34:28.220Z,1576532068.220 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T21:34:28.220Z,1576532068.220 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T21:39:28.453Z,1576532368.453 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T21:34:28.2Z
2019-12-16T21:39:28.453Z,1576532368.453 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T21:39:28.454Z,1576532368.454 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T21:39:32.462Z,1576532372.462 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T21:39:35.362Z,1576532375.362 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0030.lzma
2019-12-16T21:39:37.366Z,1576532377.366 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0030.lzma.bak
2019-12-16T21:39:37.367Z,1576532377.367 [DataOverHttps](INFO): SBD MOMSN=12171923
2019-12-16T21:39:54.377Z,1576532394.377 [DataOverHttps](INFO): Sending 401 bytes from file Logs/20191216T202312/Express0031.lzma
2019-12-16T21:39:56.382Z,1576532396.382 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0031.lzma.bak
2019-12-16T21:39:56.383Z,1576532396.383 [DataOverHttps](INFO): SBD MOMSN=12171925
2019-12-16T21:39:57.949Z,1576532397.949 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T21:39:57.949Z,1576532397.949 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T21:39:57.949Z,1576532397.949 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T21:40:03.166Z,1576532403.166 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T21:44:58.543Z,1576532698.543 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T21:44:58.543Z,1576532698.543 [Default:CheckIn:C.Wait] Stopped
2019-12-16T21:44:58.543Z,1576532698.543 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T21:44:58.543Z,1576532698.543 [Default:CheckIn:D] Running Loop=1
2019-12-16T21:44:58.954Z,1576532698.954 [Default:CheckIn:D] Stopped
2019-12-16T21:44:58.954Z,1576532698.954 [Default:CheckIn:E] Running Loop=1
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 90.602360 min 
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn:E] Stopped
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn] Stopped
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn](INFO): Running loop #13
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn] Running Loop=13
2019-12-16T21:44:59.349Z,1576532699.349 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T21:44:59.350Z,1576532699.350 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T21:45:00.946Z,1576532700.946 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T21:45:00.946Z,1576532700.946 [NAL9602] Data Fault, FailCount= 3
2019-12-16T21:45:00.946Z,1576532700.946 [NAL9602](ERROR): Data Fault
2019-12-16T21:45:01.034Z,1576532701.034 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T21:45:01.340Z,1576532701.340 [NAL9602](INFO): Powering down
2019-12-16T21:45:02.246Z,1576532702.246 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T21:45:02.246Z,1576532702.246 [NAL9602] No Fault, FailCount= 3
2019-12-16T21:45:31.652Z,1576532731.652 [NAL9602](INFO): Powering up NAL9602
2019-12-16T21:45:42.558Z,1576532742.558 [NAL9602](INFO): NAL9602 initialized
2019-12-16T21:49:59.522Z,1576532999.522 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T21:44:59.3Z
2019-12-16T21:49:59.522Z,1576532999.522 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T21:49:59.522Z,1576532999.522 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T21:50:07.332Z,1576533007.332 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0033.lzma
2019-12-16T21:50:09.338Z,1576533009.338 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0033.lzma.bak
2019-12-16T21:50:09.339Z,1576533009.339 [DataOverHttps](INFO): SBD MOMSN=12171949
2019-12-16T21:50:26.553Z,1576533026.553 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20191216T202312/Express0034.lzma
2019-12-16T21:50:28.558Z,1576533028.558 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0034.lzma.bak
2019-12-16T21:50:28.559Z,1576533028.559 [DataOverHttps](INFO): SBD MOMSN=12171951
2019-12-16T21:50:29.851Z,1576533029.851 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T21:50:29.851Z,1576533029.851 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T21:50:29.851Z,1576533029.851 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T21:50:45.955Z,1576533045.955 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T21:51:16.657Z,1576533076.657 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T21:55:30.424Z,1576533330.424 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T21:55:30.424Z,1576533330.424 [Default:CheckIn:C.Wait] Stopped
2019-12-16T21:55:30.424Z,1576533330.424 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T21:55:30.424Z,1576533330.424 [Default:CheckIn:D] Running Loop=1
2019-12-16T21:55:30.805Z,1576533330.805 [Default:CheckIn:D] Stopped
2019-12-16T21:55:30.805Z,1576533330.805 [Default:CheckIn:E] Running Loop=1
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 101.133211 min 
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn:E] Stopped
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn] Stopped
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn](INFO): Running loop #14
2019-12-16T21:55:31.208Z,1576533331.208 [Default:CheckIn] Running Loop=14
2019-12-16T21:55:31.209Z,1576533331.209 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T21:55:31.209Z,1576533331.209 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T22:00:31.381Z,1576533631.381 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T21:55:31.2Z
2019-12-16T22:00:31.382Z,1576533631.382 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T22:00:31.382Z,1576533631.382 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T22:00:35.390Z,1576533635.390 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T22:00:38.845Z,1576533638.845 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0036.lzma
2019-12-16T22:00:40.851Z,1576533640.851 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0036.lzma.bak
2019-12-16T22:00:40.851Z,1576533640.851 [DataOverHttps](INFO): SBD MOMSN=12171962
2019-12-16T22:00:58.541Z,1576533658.541 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20191216T202312/Express0037.lzma
2019-12-16T22:01:00.546Z,1576533660.546 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0037.lzma.bak
2019-12-16T22:01:00.547Z,1576533660.547 [DataOverHttps](INFO): SBD MOMSN=12171964
2019-12-16T22:01:01.677Z,1576533661.677 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T22:01:01.677Z,1576533661.677 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T22:01:01.677Z,1576533661.677 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T22:01:06.094Z,1576533666.094 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T22:01:53.392Z,1576533713.392 [BPC1](ERROR): Battery stick #6 (s/n: 01EA) reported OVER_TEMP_ALARM. Status code: 0x1717.
2019-12-16T22:01:53.393Z,1576533713.393 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 6.
2019-12-16T22:01:53.395Z,1576533713.395 [BPC1](INFO): Received data from all battery sticks.
2019-12-16T22:06:02.262Z,1576533962.262 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T22:06:02.262Z,1576533962.262 [Default:CheckIn:C.Wait] Stopped
2019-12-16T22:06:02.262Z,1576533962.262 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T22:06:02.262Z,1576533962.262 [Default:CheckIn:D] Running Loop=1
2019-12-16T22:06:02.657Z,1576533962.657 [Default:CheckIn:D] Stopped
2019-12-16T22:06:02.657Z,1576533962.657 [Default:CheckIn:E] Running Loop=1
2019-12-16T22:06:03.064Z,1576533963.064 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 111.664079 min 
2019-12-16T22:06:03.064Z,1576533963.064 [Default:CheckIn:E] Stopped
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn] Stopped
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn](INFO): Running loop #15
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn] Running Loop=15
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T22:06:03.065Z,1576533963.065 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T22:06:04.658Z,1576533964.658 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T22:06:04.658Z,1576533964.658 [NAL9602] Data Fault, FailCount= 4
2019-12-16T22:06:04.658Z,1576533964.658 [NAL9602](ERROR): Data Fault
2019-12-16T22:06:04.719Z,1576533964.719 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T22:06:05.058Z,1576533965.058 [NAL9602](INFO): Powering down
2019-12-16T22:06:05.926Z,1576533965.926 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T22:06:05.926Z,1576533965.926 [NAL9602] No Fault, FailCount= 4
2019-12-16T22:06:35.376Z,1576533995.376 [NAL9602](INFO): Powering up NAL9602
2019-12-16T22:06:46.260Z,1576534006.260 [NAL9602](INFO): NAL9602 initialized
2019-12-16T22:11:03.297Z,1576534263.297 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T22:06:03.1Z
2019-12-16T22:11:03.297Z,1576534263.297 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T22:11:03.297Z,1576534263.297 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T22:11:10.305Z,1576534270.305 [DataOverHttps](INFO): Sending 45 bytes from file Logs/20191216T202312/Courier0039.lzma
2019-12-16T22:11:12.310Z,1576534272.310 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0039.lzma.bak
2019-12-16T22:11:12.311Z,1576534272.311 [DataOverHttps](INFO): SBD MOMSN=12171976
2019-12-16T22:11:29.593Z,1576534289.593 [DataOverHttps](INFO): Sending 215 bytes from file Logs/20191216T202312/Express0040.lzma
2019-12-16T22:11:31.598Z,1576534291.598 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0040.lzma.bak
2019-12-16T22:11:31.599Z,1576534291.599 [DataOverHttps](INFO): SBD MOMSN=12171978
2019-12-16T22:11:32.815Z,1576534292.815 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T22:11:32.815Z,1576534292.815 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T22:11:32.815Z,1576534292.815 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T22:11:49.722Z,1576534309.722 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T22:12:20.430Z,1576534340.430 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T22:16:33.366Z,1576534593.366 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T22:16:33.366Z,1576534593.366 [Default:CheckIn:C.Wait] Stopped
2019-12-16T22:16:33.366Z,1576534593.366 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T22:16:33.366Z,1576534593.366 [Default:CheckIn:D] Running Loop=1
2019-12-16T22:16:33.782Z,1576534593.782 [Default:CheckIn:D] Stopped
2019-12-16T22:16:33.782Z,1576534593.782 [Default:CheckIn:E] Running Loop=1
2019-12-16T22:16:34.168Z,1576534594.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 122.182821 min 
2019-12-16T22:16:34.168Z,1576534594.168 [Default:CheckIn:E] Stopped
2019-12-16T22:16:34.168Z,1576534594.168 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T22:16:34.168Z,1576534594.168 [Default:CheckIn] Stopped
2019-12-16T22:16:34.169Z,1576534594.169 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T22:16:34.169Z,1576534594.169 [Default:CheckIn](INFO): Running loop #16
2019-12-16T22:16:34.169Z,1576534594.169 [Default:CheckIn] Running Loop=16
2019-12-16T22:16:34.169Z,1576534594.169 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T22:16:34.169Z,1576534594.169 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T22:21:34.345Z,1576534894.345 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T22:16:34.2Z
2019-12-16T22:21:34.345Z,1576534894.345 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T22:21:34.345Z,1576534894.345 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T22:21:38.350Z,1576534898.350 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T22:21:41.593Z,1576534901.593 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0042.lzma
2019-12-16T22:21:43.598Z,1576534903.598 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0042.lzma.bak
2019-12-16T22:21:43.599Z,1576534903.599 [DataOverHttps](INFO): SBD MOMSN=12171989
2019-12-16T22:22:00.629Z,1576534920.629 [DataOverHttps](INFO): Sending 199 bytes from file Logs/20191216T202312/Express0043.lzma
2019-12-16T22:22:02.643Z,1576534922.643 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0043.lzma.bak
2019-12-16T22:22:02.643Z,1576534922.643 [DataOverHttps](INFO): SBD MOMSN=12171991
2019-12-16T22:22:03.825Z,1576534923.825 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T22:22:03.825Z,1576534923.825 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T22:22:03.825Z,1576534923.825 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T22:22:09.054Z,1576534929.054 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T22:27:04.422Z,1576535224.422 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T22:27:04.422Z,1576535224.422 [Default:CheckIn:C.Wait] Stopped
2019-12-16T22:27:04.422Z,1576535224.422 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T22:27:04.422Z,1576535224.422 [Default:CheckIn:D] Running Loop=1
2019-12-16T22:27:04.817Z,1576535224.817 [Default:CheckIn:D] Stopped
2019-12-16T22:27:04.817Z,1576535224.817 [Default:CheckIn:E] Running Loop=1
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 132.700081 min 
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn:E] Stopped
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn] Stopped
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn](INFO): Running loop #17
2019-12-16T22:27:05.225Z,1576535225.225 [Default:CheckIn] Running Loop=17
2019-12-16T22:27:05.226Z,1576535225.226 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T22:27:05.226Z,1576535225.226 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T22:27:06.810Z,1576535226.810 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T22:27:06.810Z,1576535226.810 [NAL9602] Data Fault, FailCount= 5
2019-12-16T22:27:06.810Z,1576535226.810 [NAL9602](ERROR): Data Fault
2019-12-16T22:27:06.843Z,1576535226.843 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T22:27:06.844Z,1576535226.844 [CBIT](CRITICAL): Data Fault in component: NAL9602
2019-12-16T22:27:07.214Z,1576535227.214 [NAL9602](INFO): Powering down
2019-12-16T22:27:07.267Z,1576535227.267 [CommandLine](FAULT): Scheduling is paused
2019-12-16T22:27:07.267Z,1576535227.267 [CBIT](INFO): Critical error at 20191216T222706
2019-12-16T22:29:06.830Z,1576535346.830 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T22:29:06.830Z,1576535346.830 [NAL9602] No Fault, FailCount= 5
2019-12-16T22:29:07.209Z,1576535347.209 [NAL9602](INFO): Powering up NAL9602
2019-12-16T22:29:18.110Z,1576535358.110 [NAL9602](INFO): NAL9602 initialized
2019-12-16T22:32:05.403Z,1576535525.403 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T22:27:05.2Z
2019-12-16T22:32:05.403Z,1576535525.403 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T22:32:05.403Z,1576535525.403 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T22:32:12.756Z,1576535532.756 [DataOverHttps](INFO): Sending 93 bytes from file Logs/20191216T202312/Courier0045.lzma
2019-12-16T22:32:14.762Z,1576535534.762 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0045.lzma.bak
2019-12-16T22:32:14.763Z,1576535534.763 [DataOverHttps](INFO): SBD MOMSN=12172001
2019-12-16T22:32:31.917Z,1576535551.917 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20191216T202312/Express0046.lzma
2019-12-16T22:32:33.922Z,1576535553.922 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0046.lzma.bak
2019-12-16T22:32:33.923Z,1576535553.923 [DataOverHttps](INFO): SBD MOMSN=12172004
2019-12-16T22:32:35.316Z,1576535555.316 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T22:32:35.316Z,1576535555.316 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T22:32:35.316Z,1576535555.316 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T22:34:21.518Z,1576535661.518 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T22:34:52.216Z,1576535692.216 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T22:37:35.861Z,1576535855.861 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T22:37:35.861Z,1576535855.861 [Default:CheckIn:C.Wait] Stopped
2019-12-16T22:37:35.861Z,1576535855.861 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T22:37:35.862Z,1576535855.862 [Default:CheckIn:D] Running Loop=1
2019-12-16T22:37:36.277Z,1576535856.277 [Default:CheckIn:D] Stopped
2019-12-16T22:37:36.277Z,1576535856.277 [Default:CheckIn:E] Running Loop=1
2019-12-16T22:37:36.683Z,1576535856.683 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 143.224398 min 
2019-12-16T22:37:36.683Z,1576535856.683 [Default:CheckIn:E] Stopped
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn] Stopped
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn](INFO): Running loop #18
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn] Running Loop=18
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T22:37:36.684Z,1576535856.684 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T22:42:36.845Z,1576536156.845 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T22:37:36.7Z
2019-12-16T22:42:36.845Z,1576536156.845 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T22:42:36.846Z,1576536156.846 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T22:42:40.454Z,1576536160.454 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T22:42:44.552Z,1576536164.552 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0048.lzma
2019-12-16T22:42:46.588Z,1576536166.588 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0048.lzma.bak
2019-12-16T22:42:46.589Z,1576536166.589 [DataOverHttps](INFO): SBD MOMSN=12172016
2019-12-16T22:43:03.825Z,1576536183.825 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20191216T202312/Express0049.lzma
2019-12-16T22:43:05.830Z,1576536185.830 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0049.lzma.bak
2019-12-16T22:43:05.831Z,1576536185.831 [DataOverHttps](INFO): SBD MOMSN=12172018
2019-12-16T22:43:07.149Z,1576536187.149 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T22:43:07.149Z,1576536187.149 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T22:43:07.149Z,1576536187.149 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T22:43:11.162Z,1576536191.162 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T22:48:07.744Z,1576536487.744 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T22:48:07.744Z,1576536487.744 [Default:CheckIn:C.Wait] Stopped
2019-12-16T22:48:07.745Z,1576536487.745 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T22:48:07.745Z,1576536487.745 [Default:CheckIn:D] Running Loop=1
2019-12-16T22:48:08.128Z,1576536488.128 [Default:CheckIn:D] Stopped
2019-12-16T22:48:08.128Z,1576536488.128 [Default:CheckIn:E] Running Loop=1
2019-12-16T22:48:08.532Z,1576536488.532 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 153.755257 min 
2019-12-16T22:48:08.532Z,1576536488.532 [Default:CheckIn:E] Stopped
2019-12-16T22:48:08.532Z,1576536488.532 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T22:48:08.532Z,1576536488.532 [Default:CheckIn] Stopped
2019-12-16T22:48:08.532Z,1576536488.532 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T22:48:08.532Z,1576536488.532 [Default:CheckIn](INFO): Running loop #19
2019-12-16T22:48:08.533Z,1576536488.533 [Default:CheckIn] Running Loop=19
2019-12-16T22:48:08.533Z,1576536488.533 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T22:48:08.533Z,1576536488.533 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T22:48:10.118Z,1576536490.118 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T22:48:10.118Z,1576536490.118 [NAL9602] Data Fault, FailCount= 1
2019-12-16T22:48:10.118Z,1576536490.118 [NAL9602](ERROR): Data Fault
2019-12-16T22:48:10.189Z,1576536490.189 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T22:48:10.522Z,1576536490.522 [NAL9602](INFO): Powering down
2019-12-16T22:48:11.365Z,1576536491.365 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T22:48:11.365Z,1576536491.365 [NAL9602] No Fault, FailCount= 1
2019-12-16T22:48:40.823Z,1576536520.823 [NAL9602](INFO): Powering up NAL9602
2019-12-16T22:48:51.734Z,1576536531.734 [NAL9602](INFO): NAL9602 initialized
2019-12-16T22:53:08.802Z,1576536788.802 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T22:48:08.5Z
2019-12-16T22:53:08.803Z,1576536788.803 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T22:53:08.803Z,1576536788.803 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T22:53:19.253Z,1576536799.253 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0051.lzma
2019-12-16T22:53:21.254Z,1576536801.254 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0051.lzma.bak
2019-12-16T22:53:21.255Z,1576536801.255 [DataOverHttps](INFO): SBD MOMSN=12172033
2019-12-16T22:53:38.305Z,1576536818.305 [DataOverHttps](INFO): Sending 215 bytes from file Logs/20191216T202312/Express0052.lzma
2019-12-16T22:53:40.312Z,1576536820.312 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0052.lzma.bak
2019-12-16T22:53:40.312Z,1576536820.312 [DataOverHttps](INFO): SBD MOMSN=12172039
2019-12-16T22:53:41.457Z,1576536821.457 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T22:53:41.457Z,1576536821.457 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T22:53:41.457Z,1576536821.457 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T22:53:55.122Z,1576536835.122 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T22:54:25.830Z,1576536865.830 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T22:58:41.993Z,1576537121.993 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T22:58:41.993Z,1576537121.993 [Default:CheckIn:C.Wait] Stopped
2019-12-16T22:58:41.993Z,1576537121.993 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T22:58:41.993Z,1576537121.993 [Default:CheckIn:D] Running Loop=1
2019-12-16T22:58:42.401Z,1576537122.401 [Default:CheckIn:D] Stopped
2019-12-16T22:58:42.401Z,1576537122.401 [Default:CheckIn:E] Running Loop=1
2019-12-16T22:58:42.806Z,1576537122.806 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 164.326465 min 
2019-12-16T22:58:42.806Z,1576537122.806 [Default:CheckIn:E] Stopped
2019-12-16T22:58:42.806Z,1576537122.806 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T22:58:42.806Z,1576537122.806 [Default:CheckIn] Stopped
2019-12-16T22:58:42.806Z,1576537122.806 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T22:58:42.807Z,1576537122.807 [Default:CheckIn](INFO): Running loop #20
2019-12-16T22:58:42.807Z,1576537122.807 [Default:CheckIn] Running Loop=20
2019-12-16T22:58:42.807Z,1576537122.807 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T22:58:42.807Z,1576537122.807 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T23:03:42.997Z,1576537422.997 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T22:58:42.8Z
2019-12-16T23:03:42.998Z,1576537422.998 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T23:03:42.998Z,1576537422.998 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T23:03:46.986Z,1576537426.986 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T23:03:50.612Z,1576537430.612 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0054.lzma
2019-12-16T23:03:52.618Z,1576537432.618 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0054.lzma.bak
2019-12-16T23:03:52.619Z,1576537432.619 [DataOverHttps](INFO): SBD MOMSN=12172057
2019-12-16T23:04:08.633Z,1576537448.633 [DataOverHttps](INFO): Sending 200 bytes from file Logs/20191216T202312/Express0055.lzma
2019-12-16T23:04:10.638Z,1576537450.638 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0055.lzma.bak
2019-12-16T23:04:10.639Z,1576537450.639 [DataOverHttps](INFO): SBD MOMSN=12172059
2019-12-16T23:04:12.060Z,1576537452.060 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T23:04:12.060Z,1576537452.060 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T23:04:12.061Z,1576537452.061 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T23:04:17.686Z,1576537457.686 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T23:07:56.883Z,1576537676.883 [BPC1](ERROR): BPC1A: No match for serial number FFFF in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2019-12-16T23:09:12.856Z,1576537752.856 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T23:09:12.856Z,1576537752.856 [Default:CheckIn:C.Wait] Stopped
2019-12-16T23:09:12.856Z,1576537752.856 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T23:09:12.856Z,1576537752.856 [Default:CheckIn:D] Running Loop=1
2019-12-16T23:09:13.246Z,1576537753.246 [Default:CheckIn:D] Stopped
2019-12-16T23:09:13.246Z,1576537753.246 [Default:CheckIn:E] Running Loop=1
2019-12-16T23:09:13.654Z,1576537753.654 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 174.840544 min 
2019-12-16T23:09:13.654Z,1576537753.654 [Default:CheckIn:E] Stopped
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn] Stopped
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn](INFO): Running loop #21
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn] Running Loop=21
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T23:09:13.655Z,1576537753.655 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T23:09:15.246Z,1576537755.246 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T23:09:15.246Z,1576537755.246 [NAL9602] Data Fault, FailCount= 2
2019-12-16T23:09:15.246Z,1576537755.246 [NAL9602](ERROR): Data Fault
2019-12-16T23:09:15.418Z,1576537755.418 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T23:09:15.644Z,1576537755.644 [NAL9602](INFO): Powering down
2019-12-16T23:09:16.506Z,1576537756.506 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T23:09:16.506Z,1576537756.506 [NAL9602] No Fault, FailCount= 2
2019-12-16T23:09:45.946Z,1576537785.946 [NAL9602](INFO): Powering up NAL9602
2019-12-16T23:09:56.852Z,1576537796.852 [NAL9602](INFO): NAL9602 initialized
2019-12-16T23:14:13.854Z,1576538053.854 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T23:09:13.7Z
2019-12-16T23:14:13.854Z,1576538053.854 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T23:14:13.855Z,1576538053.855 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T23:14:21.176Z,1576538061.176 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0057.lzma
2019-12-16T23:14:23.182Z,1576538063.182 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0057.lzma.bak
2019-12-16T23:14:23.183Z,1576538063.183 [DataOverHttps](INFO): SBD MOMSN=12172069
2019-12-16T23:14:40.241Z,1576538080.241 [DataOverHttps](INFO): Sending 216 bytes from file Logs/20191216T202312/Express0058.lzma
2019-12-16T23:14:42.247Z,1576538082.247 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0058.lzma.bak
2019-12-16T23:14:42.247Z,1576538082.247 [DataOverHttps](INFO): SBD MOMSN=12172071
2019-12-16T23:14:43.434Z,1576538083.434 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T23:14:43.434Z,1576538083.434 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T23:14:43.435Z,1576538083.435 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T23:15:00.290Z,1576538100.290 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T23:15:30.996Z,1576538130.996 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T23:19:43.932Z,1576538383.932 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T23:19:43.932Z,1576538383.932 [Default:CheckIn:C.Wait] Stopped
2019-12-16T23:19:43.932Z,1576538383.932 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T23:19:43.933Z,1576538383.933 [Default:CheckIn:D] Running Loop=1
2019-12-16T23:19:44.333Z,1576538384.333 [Default:CheckIn:D] Stopped
2019-12-16T23:19:44.333Z,1576538384.333 [Default:CheckIn:E] Running Loop=1
2019-12-16T23:19:44.746Z,1576538384.746 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 185.358675 min 
2019-12-16T23:19:44.746Z,1576538384.746 [Default:CheckIn:E] Stopped
2019-12-16T23:19:44.746Z,1576538384.746 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T23:19:44.746Z,1576538384.746 [Default:CheckIn] Stopped
2019-12-16T23:19:44.747Z,1576538384.747 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T23:19:44.747Z,1576538384.747 [Default:CheckIn](INFO): Running loop #22
2019-12-16T23:19:44.747Z,1576538384.747 [Default:CheckIn] Running Loop=22
2019-12-16T23:19:44.747Z,1576538384.747 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T23:19:44.747Z,1576538384.747 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T23:20:17.424Z,1576538417.424 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-12-16T23:20:17.497Z,1576538417.497 [NAL9602](FAULT): received: 
+CSQ:0

OK395, 0, 0, 0, 0

OK
2019-12-16T23:20:17.497Z,1576538417.497 [NAL9602] Data Fault, FailCount= 3
2019-12-16T23:20:17.497Z,1576538417.497 [NAL9602](ERROR): Data Fault
2019-12-16T23:20:17.535Z,1576538417.535 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T23:20:17.830Z,1576538417.830 [NAL9602](INFO): Powering down
2019-12-16T23:20:18.678Z,1576538418.678 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T23:20:18.678Z,1576538418.678 [NAL9602] No Fault, FailCount= 3
2019-12-16T23:20:48.128Z,1576538448.128 [NAL9602](INFO): Powering up NAL9602
2019-12-16T23:20:59.042Z,1576538459.042 [NAL9602](INFO): NAL9602 initialized
2019-12-16T23:20:59.844Z,1576538459.844 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-12-16T23:20:59.844Z,1576538459.844 [NAL9602] Data Fault, FailCount= 4
2019-12-16T23:20:59.844Z,1576538459.844 [NAL9602](ERROR): Data Fault
2019-12-16T23:20:59.918Z,1576538459.918 [CBIT](ERROR): Data Fault in component: NAL9602
2019-12-16T23:21:00.254Z,1576538460.254 [NAL9602](INFO): Powering down
2019-12-16T23:21:01.103Z,1576538461.103 [CBIT](INFO): Clearing failed state for component NAL9602
2019-12-16T23:21:01.103Z,1576538461.103 [NAL9602] No Fault, FailCount= 4
2019-12-16T23:21:30.554Z,1576538490.554 [NAL9602](INFO): Powering up NAL9602
2019-12-16T23:21:41.464Z,1576538501.464 [NAL9602](INFO): NAL9602 initialized
2019-12-16T23:24:44.932Z,1576538684.932 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-12-16T23:19:44.7Z
2019-12-16T23:24:44.933Z,1576538684.933 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T23:24:44.933Z,1576538684.933 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-12-16T23:24:49.343Z,1576538689.343 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-12-16T23:24:52.409Z,1576538692.409 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191216T202312/Courier0060.lzma
2019-12-16T23:24:54.414Z,1576538694.414 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Courier0060.lzma.bak
2019-12-16T23:24:54.415Z,1576538694.415 [DataOverHttps](INFO): SBD MOMSN=12172082
2019-12-16T23:25:12.741Z,1576538712.741 [DataOverHttps](INFO): Sending 252 bytes from file Logs/20191216T202312/Express0061.lzma
2019-12-16T23:25:14.746Z,1576538714.746 [DataOverHttps](INFO): Moved sent file to Logs/20191216T202312/Express0061.lzma.bak
2019-12-16T23:25:14.747Z,1576538714.747 [DataOverHttps](INFO): SBD MOMSN=12172084
2019-12-16T23:25:16.056Z,1576538716.056 [Default:CheckIn:Read_Iridium] Stopped
2019-12-16T23:25:16.056Z,1576538716.056 [Default:CheckIn:C.Wait] Running Loop=1
2019-12-16T23:25:16.056Z,1576538716.056 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-12-16T23:25:20.058Z,1576538720.058 [NAL9602](INFO): Not Powering down - fast GPS
2019-12-16T23:28:25.306Z,1576538905.306 [CommandLine](IMPORTANT): got command help
2019-12-16T23:30:16.772Z,1576539016.772 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-12-16T23:30:16.777Z,1576539016.777 [Default:CheckIn:C.Wait] Stopped
2019-12-16T23:30:16.777Z,1576539016.777 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-12-16T23:30:16.777Z,1576539016.777 [Default:CheckIn:D] Running Loop=1
2019-12-16T23:30:17.190Z,1576539017.190 [Default:CheckIn:D] Stopped
2019-12-16T23:30:17.190Z,1576539017.190 [Default:CheckIn:E] Running Loop=1
2019-12-16T23:30:17.596Z,1576539017.596 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 195.906283 min 
2019-12-16T23:30:17.596Z,1576539017.596 [Default:CheckIn:E] Stopped
2019-12-16T23:30:17.596Z,1576539017.596 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-12-16T23:30:17.597Z,1576539017.597 [Default:CheckIn] Stopped
2019-12-16T23:30:17.597Z,1576539017.597 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T23:30:17.597Z,1576539017.597 [Default:CheckIn](INFO): Running loop #23
2019-12-16T23:30:17.597Z,1576539017.597 [Default:CheckIn] Running Loop=23
2019-12-16T23:30:17.597Z,1576539017.597 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-12-16T23:30:17.597Z,1576539017.597 [Default:CheckIn:Read_GPS] Running Loop=1
2019-12-16T23:30:25.097Z,1576539025.097 [CommandLine](IMPORTANT): got command quit
2019-12-16T23:30:26.105Z,1576539026.105 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:26.106Z,1576539026.106 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.121Z,1576539026.121 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-12-16T23:30:26.121Z,1576539026.121 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.122Z,1576539026.122 [CommandLine](INFO): Join timeout helper Thread ID is 8148
2019-12-16T23:30:26.137Z,1576539026.137 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-12-16T23:30:26.137Z,1576539026.137 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.137Z,1576539026.137 [NavChartDb](INFO): Join timeout helper Thread ID is 8149
2019-12-16T23:30:26.197Z,1576539026.197 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:26.197Z,1576539026.197 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.198Z,1576539026.198 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-12-16T23:30:26.198Z,1576539026.198 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.198Z,1576539026.198 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8150
2019-12-16T23:30:26.677Z,1576539026.677 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:26.678Z,1576539026.678 [WetLabsBB2FL](INFO): Powering down
2019-12-16T23:30:26.678Z,1576539026.678 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.685Z,1576539026.685 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-12-16T23:30:26.685Z,1576539026.685 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:26.685Z,1576539026.685 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8151
2019-12-16T23:30:27.289Z,1576539027.289 [CTD_Seabird](INFO): Powering down
2019-12-16T23:30:27.301Z,1576539027.301 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:27.301Z,1576539027.301 [CTD_Seabird](INFO): Powering down
2019-12-16T23:30:27.313Z,1576539027.313 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:27.321Z,1576539027.321 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-12-16T23:30:27.321Z,1576539027.321 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:27.321Z,1576539027.321 [Radio_Surface](INFO): Join timeout helper Thread ID is 8152
2019-12-16T23:30:27.385Z,1576539027.385 [Radio_Surface](INFO): Powering down
2019-12-16T23:30:27.386Z,1576539027.386 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:27.386Z,1576539027.386 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:27.394Z,1576539027.394 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-12-16T23:30:27.394Z,1576539027.394 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:27.394Z,1576539027.394 [DataOverHttps](INFO): Join timeout helper Thread ID is 8153
2019-12-16T23:30:27.990Z,1576539027.990 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:27.994Z,1576539027.994 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.006Z,1576539028.006 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-12-16T23:30:28.006Z,1576539028.006 [logger ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.006Z,1576539028.006 [logger](INFO): Join timeout helper Thread ID is 8154
2019-12-16T23:30:28.029Z,1576539028.029 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:28.029Z,1576539028.029 [logger ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.034Z,1576539028.034 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-12-16T23:30:28.034Z,1576539028.034 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.034Z,1576539028.034 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-12-16T23:30:28.034Z,1576539028.034 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.034Z,1576539028.034 [controlThread](INFO): Join timeout helper Thread ID is 8155
2019-12-16T23:30:28.082Z,1576539028.082 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-12-16T23:30:28.082Z,1576539028.082 [controlThread](DEBUG): Uninitializing ControlThread
2019-12-16T23:30:28.082Z,1576539028.082 [AHRS_M2](INFO): Powering down
2019-12-16T23:30:28.153Z,1576539028.153 [NAL9602](INFO): Powering down
2019-12-16T23:30:28.156Z,1576539028.156 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-12-16T23:30:28.157Z,1576539028.157 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-12-16T23:30:28.158Z,1576539028.158 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-12-16T23:30:28.158Z,1576539028.158 [MissionManager](INFO): Uninitializing Mission Default
2019-12-16T23:30:28.158Z,1576539028.158 [Default] Stopped
2019-12-16T23:30:28.159Z,1576539028.159 [Default](DEBUG): Aggregate::uninitialize Default
2019-12-16T23:30:28.159Z,1576539028.159 [Default:B.GoToSurface] Stopped
2019-12-16T23:30:28.159Z,1576539028.159 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-12-16T23:30:28.159Z,1576539028.159 [Default:CheckIn] Stopped
2019-12-16T23:30:28.159Z,1576539028.159 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-12-16T23:30:28.159Z,1576539028.159 [Default:CheckIn:Read_GPS] Stopped
2019-12-16T23:30:28.161Z,1576539028.161 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-12-16T23:30:28.162Z,1576539028.162 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-12-16T23:30:28.162Z,1576539028.162 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-12-16T23:30:28.162Z,1576539028.162 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-12-16T23:30:28.163Z,1576539028.163 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-12-16T23:30:28.163Z,1576539028.163 [BuoyancyServo](INFO): Powering down
2019-12-16T23:30:28.177Z,1576539028.177 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-12-16T23:30:28.177Z,1576539028.177 [ElevatorServo](INFO): Powering down
2019-12-16T23:30:28.178Z,1576539028.178 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-12-16T23:30:28.178Z,1576539028.178 [MassServo](INFO): Powering down
2019-12-16T23:30:28.179Z,1576539028.179 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-12-16T23:30:28.179Z,1576539028.179 [RudderServo](INFO): Powering down
2019-12-16T23:30:28.179Z,1576539028.179 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-12-16T23:30:28.180Z,1576539028.180 [ThrusterServo](INFO): Powering down
2019-12-16T23:30:28.180Z,1576539028.180 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-12-16T23:30:28.181Z,1576539028.181 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-12-16T23:30:28.181Z,1576539028.181 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-12-16T23:30:28.181Z,1576539028.181 [CBIT](DEBUG): Powering off loads.
2019-12-16T23:30:28.193Z,1576539028.193 [CBIT](DEBUG): Disabling WDT.
2019-12-16T23:30:28.205Z,1576539028.205 [CBIT](DEBUG): Opening all GF detection circuits.
2019-12-16T23:30:28.206Z,1576539028.206 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.291Z,1576539028.291 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.297Z,1576539028.297 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.331Z,1576539028.331 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.335Z,1576539028.335 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.373Z,1576539028.373 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-12-16T23:30:28.472Z,1576539028.472 [logger ThreadHandler](INFO): Thread cancelled.