2019-08-27T22:27:40.796Z,1566944860.796 [DataOverHttps](INFO): Received command:restart logs
2019-08-27T22:27:40.837Z,1566944860.837 [CommandLine](IMPORTANT): got command restart logs
2019-08-27T22:28:23.018Z,1566944903.018 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T22:28:23.018Z,1566944903.018 [Default:CheckIn:C.Wait] Stopped
2019-08-27T22:28:23.018Z,1566944903.018 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T22:28:23.018Z,1566944903.018 [Default:CheckIn:D] Running Loop=1
2019-08-27T22:28:23.421Z,1566944903.421 [Default:CheckIn:D] Stopped
2019-08-27T22:28:23.421Z,1566944903.421 [Default:CheckIn:E] Running Loop=1
2019-08-27T22:28:23.831Z,1566944903.831 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 34.167289 min 
2019-08-27T22:28:23.831Z,1566944903.831 [Default:CheckIn:E] Stopped
2019-08-27T22:28:23.831Z,1566944903.831 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T22:28:23.831Z,1566944903.831 [Default:CheckIn] Stopped
2019-08-27T22:28:23.831Z,1566944903.831 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T22:28:23.832Z,1566944903.832 [Default:CheckIn](INFO): Running loop #7
2019-08-27T22:28:23.832Z,1566944903.832 [Default:CheckIn] Running Loop=7
2019-08-27T22:28:23.832Z,1566944903.832 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T22:28:23.832Z,1566944903.832 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T22:28:25.428Z,1566944905.428 [NAL9602](DEBUG): Fix Requested
2019-08-27T22:28:25.827Z,1566944905.827 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222559.00,A,4142.04979,N,08314.85904,W,7.814,321.45,270819,,,D*72
2019-08-27T22:28:25.829Z,1566944905.829 [NAL9602](INFO): GPS fix at 20190827T222559: (41.700830, -83.247651)
2019-08-27T22:28:25.852Z,1566944905.852 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T22:28:25.852Z,1566944905.852 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T22:28:33.300Z,1566944913.300 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190827T010912/Courier0247.lzma
2019-08-27T22:28:34.107Z,1566944914.107 [DataOverHttps](INFO): Moved sent file to Logs/20190827T010912/Courier0247.lzma.bak
2019-08-27T22:28:34.107Z,1566944914.107 [DataOverHttps](INFO): SBD MOMSN=11704530
2019-08-27T22:28:36.333Z,1566944916.333 [NAL9602](INFO): SBD MO Status=0, MOMSN=34028, MT Status=0, MTMSN=0
2019-08-27T22:28:36.333Z,1566944916.333 [NAL9602](INFO): No messages in MT queue
2019-08-27T22:28:51.224Z,1566944931.224 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190827T222740/Courier0000.lzma
2019-08-27T22:28:52.030Z,1566944932.030 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0000.lzma.bak
2019-08-27T22:28:52.030Z,1566944932.030 [DataOverHttps](INFO): SBD MOMSN=11704532
2019-08-27T22:29:05.276Z,1566944945.276 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190827T222740/Courier0003.lzma
2019-08-27T22:29:06.082Z,1566944946.082 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0003.lzma.bak
2019-08-27T22:29:06.082Z,1566944946.082 [DataOverHttps](INFO): SBD MOMSN=11704536
2019-08-27T22:29:07.052Z,1566944947.052 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T22:29:18.092Z,1566944958.092 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20190827T010912/Express0248.lzma
2019-08-27T22:29:18.899Z,1566944958.899 [DataOverHttps](INFO): Moved sent file to Logs/20190827T010912/Express0248.lzma.bak
2019-08-27T22:29:18.899Z,1566944958.899 [DataOverHttps](INFO): SBD MOMSN=11704538
2019-08-27T22:29:30.854Z,1566944970.854 [DataOverHttps](INFO): Sending 336 bytes from file Logs/20190827T222740/Express0001.lzma
2019-08-27T22:29:32.859Z,1566944972.859 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0001.lzma.bak
2019-08-27T22:29:32.859Z,1566944972.859 [DataOverHttps](INFO): SBD MOMSN=11704541
2019-08-27T22:29:44.484Z,1566944984.484 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Express0004.lzma
2019-08-27T22:29:45.290Z,1566944985.290 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0004.lzma.bak
2019-08-27T22:29:45.290Z,1566944985.290 [DataOverHttps](INFO): SBD MOMSN=11704545
2019-08-27T22:29:47.083Z,1566944987.083 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T22:29:47.083Z,1566944987.083 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T22:29:47.083Z,1566944987.083 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T22:34:47.633Z,1566945287.633 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T22:34:47.634Z,1566945287.634 [Default:CheckIn:C.Wait] Stopped
2019-08-27T22:34:47.634Z,1566945287.634 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T22:34:47.634Z,1566945287.634 [Default:CheckIn:D] Running Loop=1
2019-08-27T22:34:48.029Z,1566945288.029 [Default:CheckIn:D] Stopped
2019-08-27T22:34:48.029Z,1566945288.029 [Default:CheckIn:E] Running Loop=1
2019-08-27T22:34:48.436Z,1566945288.436 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 40.577421 min 
2019-08-27T22:34:48.436Z,1566945288.436 [Default:CheckIn:E] Stopped
2019-08-27T22:34:48.436Z,1566945288.436 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T22:34:48.436Z,1566945288.436 [Default:CheckIn] Stopped
2019-08-27T22:34:48.437Z,1566945288.437 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T22:34:48.437Z,1566945288.437 [Default:CheckIn](INFO): Running loop #8
2019-08-27T22:34:48.437Z,1566945288.437 [Default:CheckIn] Running Loop=8
2019-08-27T22:34:48.437Z,1566945288.437 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T22:34:48.437Z,1566945288.437 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T22:34:50.045Z,1566945290.045 [NAL9602](DEBUG): Fix Requested
2019-08-27T22:34:50.442Z,1566945290.442 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223223.00,A,4142.70163,N,08315.62427,W,8.747,316.32,270819,,,A*7A
2019-08-27T22:34:50.445Z,1566945290.445 [NAL9602](INFO): GPS fix at 20190827T223223: (41.711694, -83.260405)
2019-08-27T22:34:50.471Z,1566945290.471 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T22:34:50.471Z,1566945290.471 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T22:34:57.924Z,1566945297.924 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0006.lzma
2019-08-27T22:34:58.730Z,1566945298.730 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0006.lzma.bak
2019-08-27T22:34:58.730Z,1566945298.730 [DataOverHttps](INFO): SBD MOMSN=11704579
2019-08-27T22:35:12.048Z,1566945312.048 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0007.lzma
2019-08-27T22:35:12.854Z,1566945312.854 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0007.lzma.bak
2019-08-27T22:35:12.854Z,1566945312.854 [DataOverHttps](INFO): SBD MOMSN=11704583
2019-08-27T22:35:14.719Z,1566945314.719 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T22:35:14.720Z,1566945314.720 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T22:35:14.720Z,1566945314.720 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T22:35:19.139Z,1566945319.139 [NAL9602](INFO): SBD MO Status=2, MOMSN=34029, MT Status=2, MTMSN=0
2019-08-27T22:35:19.139Z,1566945319.139 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-27T22:35:36.497Z,1566945336.497 [NAL9602](INFO): SBD MO Status=2, MOMSN=34029, MT Status=2, MTMSN=0
2019-08-27T22:35:36.497Z,1566945336.497 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-27T22:36:16.095Z,1566945376.095 [NAL9602](INFO): SBD MO Status=0, MOMSN=34029, MT Status=0, MTMSN=0
2019-08-27T22:36:16.095Z,1566945376.095 [NAL9602](INFO): No messages in MT queue
2019-08-27T22:36:46.791Z,1566945406.791 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T22:37:21.877Z,1566945441.877 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-27T22:40:15.299Z,1566945615.299 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T22:40:15.299Z,1566945615.299 [Default:CheckIn:C.Wait] Stopped
2019-08-27T22:40:15.299Z,1566945615.299 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T22:40:15.300Z,1566945615.300 [Default:CheckIn:D] Running Loop=1
2019-08-27T22:40:15.681Z,1566945615.681 [Default:CheckIn:D] Stopped
2019-08-27T22:40:15.681Z,1566945615.681 [Default:CheckIn:E] Running Loop=1
2019-08-27T22:40:16.092Z,1566945616.092 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.038285 min 
2019-08-27T22:40:16.092Z,1566945616.092 [Default:CheckIn:E] Stopped
2019-08-27T22:40:16.092Z,1566945616.092 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T22:40:16.092Z,1566945616.092 [Default:CheckIn] Stopped
2019-08-27T22:40:16.092Z,1566945616.092 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T22:40:16.092Z,1566945616.092 [Default:CheckIn](INFO): Running loop #9
2019-08-27T22:40:16.093Z,1566945616.093 [Default:CheckIn] Running Loop=9
2019-08-27T22:40:16.093Z,1566945616.093 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T22:40:16.093Z,1566945616.093 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T22:40:17.696Z,1566945617.696 [NAL9602](DEBUG): Fix Requested
2019-08-27T22:40:18.085Z,1566945618.085 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223751.00,A,4143.28008,N,08316.53053,W,18.117,308.61,270819,,,A*47
2019-08-27T22:40:18.087Z,1566945618.087 [NAL9602](INFO): GPS fix at 20190827T223751: (41.721335, -83.275509)
2019-08-27T22:40:18.119Z,1566945618.119 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T22:40:18.119Z,1566945618.119 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T22:40:24.256Z,1566945624.256 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0009.lzma
2019-08-27T22:40:25.062Z,1566945625.062 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0009.lzma.bak
2019-08-27T22:40:25.062Z,1566945625.062 [DataOverHttps](INFO): SBD MOMSN=11704596
2019-08-27T22:40:28.595Z,1566945628.595 [NAL9602](INFO): SBD MO Status=0, MOMSN=34030, MT Status=0, MTMSN=0
2019-08-27T22:40:28.595Z,1566945628.595 [NAL9602](INFO): No messages in MT queue
2019-08-27T22:40:38.428Z,1566945638.428 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0010.lzma
2019-08-27T22:40:39.234Z,1566945639.234 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0010.lzma.bak
2019-08-27T22:40:39.234Z,1566945639.234 [DataOverHttps](INFO): SBD MOMSN=11704600
2019-08-27T22:40:41.151Z,1566945641.151 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T22:40:41.151Z,1566945641.151 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T22:40:41.151Z,1566945641.151 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T22:40:59.296Z,1566945659.296 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T22:42:33.041Z,1566945753.041 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-27T22:42:33.042Z,1566945753.042 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-27T22:42:33.043Z,1566945753.043 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2019-08-27T22:42:33.045Z,1566945753.045 [BPC1](INFO): Received data from all battery sticks.
2019-08-27T22:45:41.717Z,1566945941.717 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T22:45:41.718Z,1566945941.718 [Default:CheckIn:C.Wait] Stopped
2019-08-27T22:45:41.718Z,1566945941.718 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T22:45:41.719Z,1566945941.719 [Default:CheckIn:D] Running Loop=1
2019-08-27T22:45:42.124Z,1566945942.124 [Default:CheckIn:D] Stopped
2019-08-27T22:45:42.124Z,1566945942.124 [Default:CheckIn:E] Running Loop=1
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 51.478996 min 
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn:E] Stopped
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn] Stopped
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn](INFO): Running loop #10
2019-08-27T22:45:42.522Z,1566945942.522 [Default:CheckIn] Running Loop=10
2019-08-27T22:45:42.523Z,1566945942.523 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T22:45:42.523Z,1566945942.523 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T22:45:44.136Z,1566945944.136 [NAL9602](DEBUG): Fix Requested
2019-08-27T22:45:44.527Z,1566945944.527 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224317.00,A,4144.45720,N,08318.04607,W,18.039,319.24,270819,,,D*45
2019-08-27T22:45:44.530Z,1566945944.530 [NAL9602](INFO): GPS fix at 20190827T224317: (41.740953, -83.300768)
2019-08-27T22:45:44.575Z,1566945944.575 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T22:45:44.575Z,1566945944.575 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T22:45:50.556Z,1566945950.556 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20190827T222740/Courier0012.lzma
2019-08-27T22:45:52.776Z,1566945952.776 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0012.lzma.bak
2019-08-27T22:45:52.777Z,1566945952.777 [DataOverHttps](INFO): SBD MOMSN=11704620
2019-08-27T22:46:04.552Z,1566945964.552 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0013.lzma
2019-08-27T22:46:05.358Z,1566945965.358 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0013.lzma.bak
2019-08-27T22:46:05.358Z,1566945965.358 [DataOverHttps](INFO): SBD MOMSN=11704623
2019-08-27T22:46:07.175Z,1566945967.175 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T22:46:07.176Z,1566945967.176 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T22:46:07.176Z,1566945967.176 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T22:46:32.597Z,1566945992.597 [NAL9602](INFO): SBD MO Status=0, MOMSN=34031, MT Status=0, MTMSN=0
2019-08-27T22:46:32.597Z,1566945992.597 [NAL9602](INFO): No messages in MT queue
2019-08-27T22:47:03.299Z,1566946023.299 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T22:51:07.748Z,1566946267.748 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T22:51:07.748Z,1566946267.748 [Default:CheckIn:C.Wait] Stopped
2019-08-27T22:51:07.748Z,1566946267.748 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T22:51:07.748Z,1566946267.748 [Default:CheckIn:D] Running Loop=1
2019-08-27T22:51:08.153Z,1566946268.153 [Default:CheckIn:D] Stopped
2019-08-27T22:51:08.153Z,1566946268.153 [Default:CheckIn:E] Running Loop=1
2019-08-27T22:51:08.567Z,1566946268.567 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 56.912805 min 
2019-08-27T22:51:08.567Z,1566946268.567 [Default:CheckIn:E] Stopped
2019-08-27T22:51:08.567Z,1566946268.567 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T22:51:08.567Z,1566946268.567 [Default:CheckIn] Stopped
2019-08-27T22:51:08.568Z,1566946268.568 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T22:51:08.568Z,1566946268.568 [Default:CheckIn](INFO): Running loop #11
2019-08-27T22:51:08.568Z,1566946268.568 [Default:CheckIn] Running Loop=11
2019-08-27T22:51:08.568Z,1566946268.568 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T22:51:08.568Z,1566946268.568 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T22:51:10.156Z,1566946270.156 [NAL9602](DEBUG): Fix Requested
2019-08-27T22:51:10.555Z,1566946270.555 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,224842.00,A,4145.67096,N,08319.52108,W,18.156,317.35,270819,,,D*49
2019-08-27T22:51:10.557Z,1566946270.557 [NAL9602](INFO): GPS fix at 20190827T224842: (41.761183, -83.325351)
2019-08-27T22:51:10.580Z,1566946270.580 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T22:51:10.580Z,1566946270.580 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T22:51:17.640Z,1566946277.639 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190827T222740/Courier0015.lzma
2019-08-27T22:51:18.450Z,1566946278.450 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0015.lzma.bak
2019-08-27T22:51:18.451Z,1566946278.451 [DataOverHttps](INFO): SBD MOMSN=11704635
2019-08-27T22:51:30.688Z,1566946290.688 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0016.lzma
2019-08-27T22:51:31.494Z,1566946291.494 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0016.lzma.bak
2019-08-27T22:51:31.494Z,1566946291.494 [DataOverHttps](INFO): SBD MOMSN=11704638
2019-08-27T22:51:33.244Z,1566946293.244 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T22:51:33.244Z,1566946293.244 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T22:51:33.244Z,1566946293.244 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T22:52:01.089Z,1566946321.089 [NAL9602](INFO): SBD MO Status=2, MOMSN=34032, MT Status=2, MTMSN=0
2019-08-27T22:52:01.089Z,1566946321.089 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-27T22:52:38.683Z,1566946358.683 [NAL9602](INFO): SBD MO Status=0, MOMSN=34032, MT Status=0, MTMSN=0
2019-08-27T22:52:38.683Z,1566946358.683 [NAL9602](INFO): No messages in MT queue
2019-08-27T22:53:09.383Z,1566946389.383 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T22:56:33.850Z,1566946593.850 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T22:56:33.850Z,1566946593.850 [Default:CheckIn:C.Wait] Stopped
2019-08-27T22:56:33.850Z,1566946593.850 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T22:56:33.850Z,1566946593.850 [Default:CheckIn:D] Running Loop=1
2019-08-27T22:56:34.238Z,1566946594.238 [Default:CheckIn:D] Stopped
2019-08-27T22:56:34.238Z,1566946594.238 [Default:CheckIn:E] Running Loop=1
2019-08-27T22:56:34.642Z,1566946594.642 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 62.347563 min 
2019-08-27T22:56:34.642Z,1566946594.642 [Default:CheckIn:E] Stopped
2019-08-27T22:56:34.642Z,1566946594.642 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T22:56:34.642Z,1566946594.642 [Default:CheckIn] Stopped
2019-08-27T22:56:34.642Z,1566946594.642 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T22:56:34.642Z,1566946594.642 [Default:CheckIn](INFO): Running loop #12
2019-08-27T22:56:34.643Z,1566946594.643 [Default:CheckIn] Running Loop=12
2019-08-27T22:56:34.643Z,1566946594.643 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T22:56:34.643Z,1566946594.643 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T22:56:36.245Z,1566946596.245 [NAL9602](DEBUG): Fix Requested
2019-08-27T22:56:36.640Z,1566946596.640 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225408.00,A,4146.88254,N,08321.03253,W,18.311,317.43,270819,,,D*46
2019-08-27T22:56:36.642Z,1566946596.642 [NAL9602](INFO): GPS fix at 20190827T225408: (41.781376, -83.350542)
2019-08-27T22:56:36.684Z,1566946596.684 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T22:56:36.684Z,1566946596.684 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T22:56:53.628Z,1566946613.628 [NAL9602](INFO): SBD MO Status=0, MOMSN=34033, MT Status=0, MTMSN=0
2019-08-27T22:56:53.628Z,1566946613.628 [NAL9602](INFO): No messages in MT queue
2019-08-27T22:57:02.695Z,1566946622.695 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0018.lzma
2019-08-27T22:57:03.495Z,1566946623.495 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0018.lzma.bak
2019-08-27T22:57:03.495Z,1566946623.495 [DataOverHttps](INFO): SBD MOMSN=11704685
2019-08-27T22:57:15.564Z,1566946635.564 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0019.lzma
2019-08-27T22:57:16.370Z,1566946636.370 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0019.lzma.bak
2019-08-27T22:57:16.370Z,1566946636.370 [DataOverHttps](INFO): SBD MOMSN=11704688
2019-08-27T22:57:18.304Z,1566946638.304 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T22:57:18.304Z,1566946638.304 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T22:57:18.304Z,1566946638.304 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T22:57:24.338Z,1566946644.338 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:02:18.916Z,1566946938.916 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:02:18.916Z,1566946938.916 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:02:18.916Z,1566946938.916 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:02:18.916Z,1566946938.916 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:02:19.309Z,1566946939.309 [Default:CheckIn:D] Stopped
2019-08-27T23:02:19.309Z,1566946939.309 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 68.098755 min 
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn:E] Stopped
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn] Stopped
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn](INFO): Running loop #13
2019-08-27T23:02:19.714Z,1566946939.714 [Default:CheckIn] Running Loop=13
2019-08-27T23:02:19.715Z,1566946939.715 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:02:19.715Z,1566946939.715 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:02:21.317Z,1566946941.317 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:02:21.705Z,1566946941.705 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225952.00,A,4148.20126,N,08322.58039,W,18.505,316.78,270819,,,D*47
2019-08-27T23:02:21.707Z,1566946941.707 [NAL9602](INFO): GPS fix at 20190827T225952: (41.803354, -83.376340)
2019-08-27T23:02:21.736Z,1566946941.736 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:02:21.736Z,1566946941.736 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:02:30.500Z,1566946950.500 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0021.lzma
2019-08-27T23:02:32.764Z,1566946952.764 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0021.lzma.bak
2019-08-27T23:02:32.764Z,1566946952.764 [DataOverHttps](INFO): SBD MOMSN=11704712
2019-08-27T23:02:37.867Z,1566946957.867 [NAL9602](INFO): SBD MO Status=0, MOMSN=34034, MT Status=0, MTMSN=0
2019-08-27T23:02:37.867Z,1566946957.867 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:02:44.412Z,1566946964.412 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0022.lzma
2019-08-27T23:02:45.218Z,1566946965.218 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0022.lzma.bak
2019-08-27T23:02:45.218Z,1566946965.218 [DataOverHttps](INFO): SBD MOMSN=11704715
2019-08-27T23:02:47.207Z,1566946967.207 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:02:47.208Z,1566946967.208 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:02:47.208Z,1566946967.208 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:03:08.585Z,1566946988.585 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:07:47.797Z,1566947267.797 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:07:47.797Z,1566947267.797 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:07:47.797Z,1566947267.797 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:07:47.797Z,1566947267.797 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:07:48.190Z,1566947268.190 [Default:CheckIn:D] Stopped
2019-08-27T23:07:48.190Z,1566947268.190 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.580111 min 
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn:E] Stopped
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn] Stopped
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn](INFO): Running loop #14
2019-08-27T23:07:48.594Z,1566947268.594 [Default:CheckIn] Running Loop=14
2019-08-27T23:07:48.595Z,1566947268.595 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:07:48.595Z,1566947268.595 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:07:50.200Z,1566947270.200 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:07:50.597Z,1566947270.597 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230521.00,A,4149.41120,N,08324.01841,W,14.423,315.41,270819,,,D*46
2019-08-27T23:07:50.599Z,1566947270.599 [NAL9602](INFO): GPS fix at 20190827T230521: (41.823520, -83.400307)
2019-08-27T23:07:50.622Z,1566947270.622 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:07:50.622Z,1566947270.622 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:07:56.472Z,1566947276.472 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0024.lzma
2019-08-27T23:07:57.278Z,1566947277.278 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0024.lzma.bak
2019-08-27T23:07:57.278Z,1566947277.278 [DataOverHttps](INFO): SBD MOMSN=11704726
2019-08-27T23:08:09.952Z,1566947289.952 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20190827T222740/Express0025.lzma
2019-08-27T23:08:10.758Z,1566947290.758 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0025.lzma.bak
2019-08-27T23:08:10.758Z,1566947290.758 [DataOverHttps](INFO): SBD MOMSN=11704729
2019-08-27T23:08:12.459Z,1566947292.459 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:08:12.459Z,1566947292.459 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:08:12.459Z,1566947292.459 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:08:39.079Z,1566947319.079 [NAL9602](INFO): SBD MO Status=2, MOMSN=34035, MT Status=2, MTMSN=0
2019-08-27T23:08:39.079Z,1566947319.079 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-27T23:09:03.319Z,1566947343.319 [NAL9602](INFO): SBD MO Status=0, MOMSN=34035, MT Status=0, MTMSN=0
2019-08-27T23:09:03.319Z,1566947343.319 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:09:34.015Z,1566947374.015 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:13:13.009Z,1566947593.009 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:13:13.009Z,1566947593.009 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:13:13.009Z,1566947593.009 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:13:13.009Z,1566947593.009 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:13:13.411Z,1566947593.411 [Default:CheckIn:D] Stopped
2019-08-27T23:13:13.411Z,1566947593.411 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:13:13.820Z,1566947593.820 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 79.000448 min 
2019-08-27T23:13:13.820Z,1566947593.820 [Default:CheckIn:E] Stopped
2019-08-27T23:13:13.820Z,1566947593.820 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:13:13.820Z,1566947593.820 [Default:CheckIn] Stopped
2019-08-27T23:13:13.820Z,1566947593.820 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:13:13.820Z,1566947593.820 [Default:CheckIn](INFO): Running loop #15
2019-08-27T23:13:13.821Z,1566947593.821 [Default:CheckIn] Running Loop=15
2019-08-27T23:13:13.821Z,1566947593.821 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:13:13.821Z,1566947593.821 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:13:15.428Z,1566947595.428 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:13:15.818Z,1566947595.818 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231045.00,A,4149.70560,N,08324.70317,W,1.866,235.82,270819,,,D*79
2019-08-27T23:13:15.820Z,1566947595.820 [NAL9602](INFO): GPS fix at 20190827T231045: (41.828427, -83.411720)
2019-08-27T23:13:15.856Z,1566947595.856 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:13:15.856Z,1566947595.856 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:13:21.696Z,1566947601.696 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0027.lzma
2019-08-27T23:13:22.502Z,1566947602.502 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0027.lzma.bak
2019-08-27T23:13:22.502Z,1566947602.502 [DataOverHttps](INFO): SBD MOMSN=11704755
2019-08-27T23:13:27.547Z,1566947607.547 [NAL9602](INFO): SBD MO Status=0, MOMSN=34036, MT Status=0, MTMSN=0
2019-08-27T23:13:27.547Z,1566947607.547 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:13:34.524Z,1566947614.524 [DataOverHttps](INFO): Sending 134 bytes from file Logs/20190827T222740/Express0028.lzma
2019-08-27T23:13:35.330Z,1566947615.330 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0028.lzma.bak
2019-08-27T23:13:35.330Z,1566947615.330 [DataOverHttps](INFO): SBD MOMSN=11704758
2019-08-27T23:13:37.283Z,1566947617.283 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:13:37.283Z,1566947617.283 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:13:37.283Z,1566947617.283 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:13:58.235Z,1566947638.235 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:18:37.832Z,1566947917.832 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:18:37.832Z,1566947917.832 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:18:37.832Z,1566947917.832 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:18:37.832Z,1566947917.832 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:18:38.235Z,1566947918.235 [Default:CheckIn:D] Stopped
2019-08-27T23:18:38.236Z,1566947918.236 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:18:38.640Z,1566947918.640 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.414193 min 
2019-08-27T23:18:38.640Z,1566947918.640 [Default:CheckIn:E] Stopped
2019-08-27T23:18:38.640Z,1566947918.640 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:18:38.640Z,1566947918.640 [Default:CheckIn] Stopped
2019-08-27T23:18:38.640Z,1566947918.640 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:18:38.640Z,1566947918.640 [Default:CheckIn](INFO): Running loop #16
2019-08-27T23:18:38.641Z,1566947918.641 [Default:CheckIn] Running Loop=16
2019-08-27T23:18:38.641Z,1566947918.641 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:18:38.641Z,1566947918.641 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:18:40.244Z,1566947920.244 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:18:40.633Z,1566947920.633 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231610.00,A,4149.69718,N,08324.71284,W,0.039,230.49,270819,,,D*71
2019-08-27T23:18:40.636Z,1566947920.636 [NAL9602](INFO): GPS fix at 20190827T231610: (41.828286, -83.411881)
2019-08-27T23:18:40.663Z,1566947920.663 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:18:40.663Z,1566947920.663 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:18:46.512Z,1566947926.512 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0030.lzma
2019-08-27T23:18:47.318Z,1566947927.318 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0030.lzma.bak
2019-08-27T23:18:47.318Z,1566947927.318 [DataOverHttps](INFO): SBD MOMSN=11704779
2019-08-27T23:19:00.119Z,1566947940.119 [NAL9602](INFO): SBD MO Status=0, MOMSN=34037, MT Status=0, MTMSN=0
2019-08-27T23:19:00.119Z,1566947940.119 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:19:01.924Z,1566947941.924 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20190827T222740/Express0031.lzma
2019-08-27T23:19:02.741Z,1566947942.741 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0031.lzma.bak
2019-08-27T23:19:02.741Z,1566947942.741 [DataOverHttps](INFO): SBD MOMSN=11704782
2019-08-27T23:19:04.603Z,1566947944.603 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:19:04.604Z,1566947944.604 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:19:04.604Z,1566947944.604 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:19:30.819Z,1566947970.819 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:24:05.161Z,1566948245.161 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:24:05.161Z,1566948245.161 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:24:05.162Z,1566948245.162 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:24:05.162Z,1566948245.162 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:24:05.561Z,1566948245.561 [Default:CheckIn:D] Stopped
2019-08-27T23:24:05.562Z,1566948245.562 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 89.869629 min 
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn:E] Stopped
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn] Stopped
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn](INFO): Running loop #17
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn] Running Loop=17
2019-08-27T23:24:05.972Z,1566948245.972 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:24:05.973Z,1566948245.973 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:24:07.580Z,1566948247.580 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:24:07.965Z,1566948247.965 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232136.00,A,4149.69204,N,08324.70841,W,0.019,163.00,270819,,,D*71
2019-08-27T23:24:07.967Z,1566948247.967 [NAL9602](INFO): GPS fix at 20190827T232136: (41.828201, -83.411807)
2019-08-27T23:24:08.011Z,1566948248.011 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:24:08.011Z,1566948248.011 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:24:13.860Z,1566948253.860 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0033.lzma
2019-08-27T23:24:14.666Z,1566948254.666 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0033.lzma.bak
2019-08-27T23:24:14.666Z,1566948254.666 [DataOverHttps](INFO): SBD MOMSN=11704835
2019-08-27T23:24:28.264Z,1566948268.264 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20190827T222740/Express0034.lzma
2019-08-27T23:24:29.070Z,1566948269.070 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0034.lzma.bak
2019-08-27T23:24:29.070Z,1566948269.070 [DataOverHttps](INFO): SBD MOMSN=11704840
2019-08-27T23:24:31.111Z,1566948271.111 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:24:31.111Z,1566948271.111 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:24:31.111Z,1566948271.111 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:24:53.291Z,1566948293.291 [NAL9602](INFO): SBD MO Status=0, MOMSN=34038, MT Status=0, MTMSN=0
2019-08-27T23:24:53.291Z,1566948293.291 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:25:23.984Z,1566948323.984 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:29:31.667Z,1566948571.667 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:29:31.667Z,1566948571.667 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:29:31.667Z,1566948571.667 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:29:31.668Z,1566948571.668 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:29:32.073Z,1566948572.073 [Default:CheckIn:D] Stopped
2019-08-27T23:29:32.073Z,1566948572.073 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:29:32.475Z,1566948572.475 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 95.311483 min 
2019-08-27T23:29:32.475Z,1566948572.475 [Default:CheckIn:E] Stopped
2019-08-27T23:29:32.475Z,1566948572.475 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:29:32.475Z,1566948572.475 [Default:CheckIn] Stopped
2019-08-27T23:29:32.476Z,1566948572.476 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:29:32.476Z,1566948572.476 [Default:CheckIn](INFO): Running loop #18
2019-08-27T23:29:32.476Z,1566948572.476 [Default:CheckIn] Running Loop=18
2019-08-27T23:29:32.476Z,1566948572.476 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:29:32.476Z,1566948572.476 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:29:34.077Z,1566948574.077 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:29:34.473Z,1566948574.473 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232702.00,A,4149.69218,N,08324.70851,W,0.039,163.00,270819,,,D*7E
2019-08-27T23:29:34.475Z,1566948574.475 [NAL9602](INFO): GPS fix at 20190827T232702: (41.828203, -83.411809)
2019-08-27T23:29:34.503Z,1566948574.503 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:29:34.503Z,1566948574.503 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:29:40.356Z,1566948580.356 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0036.lzma
2019-08-27T23:29:41.162Z,1566948581.162 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0036.lzma.bak
2019-08-27T23:29:41.162Z,1566948581.162 [DataOverHttps](INFO): SBD MOMSN=11704983
2019-08-27T23:29:53.208Z,1566948593.208 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190827T222740/Express0037.lzma
2019-08-27T23:29:54.014Z,1566948594.014 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0037.lzma.bak
2019-08-27T23:29:54.014Z,1566948594.014 [DataOverHttps](INFO): SBD MOMSN=11704986
2019-08-27T23:29:55.915Z,1566948595.915 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:29:55.916Z,1566948595.916 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:29:55.916Z,1566948595.916 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:29:57.915Z,1566948597.915 [NAL9602](INFO): SBD MO Status=0, MOMSN=34039, MT Status=0, MTMSN=0
2019-08-27T23:29:57.915Z,1566948597.915 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:30:28.603Z,1566948628.603 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:34:56.503Z,1566948896.503 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:34:56.503Z,1566948896.503 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:34:56.503Z,1566948896.503 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:34:56.504Z,1566948896.504 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:34:56.905Z,1566948896.905 [Default:CheckIn:D] Stopped
2019-08-27T23:34:56.905Z,1566948896.905 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:34:57.306Z,1566948897.306 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 100.725342 min 
2019-08-27T23:34:57.306Z,1566948897.306 [Default:CheckIn:E] Stopped
2019-08-27T23:34:57.306Z,1566948897.306 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:34:57.306Z,1566948897.306 [Default:CheckIn] Stopped
2019-08-27T23:34:57.306Z,1566948897.306 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:34:57.307Z,1566948897.307 [Default:CheckIn](INFO): Running loop #19
2019-08-27T23:34:57.307Z,1566948897.307 [Default:CheckIn] Running Loop=19
2019-08-27T23:34:57.307Z,1566948897.307 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:34:57.307Z,1566948897.307 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:34:58.913Z,1566948898.913 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:34:59.305Z,1566948899.305 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233227.00,A,4149.69295,N,08324.70760,W,0.039,163.00,270819,,,D*75
2019-08-27T23:34:59.307Z,1566948899.307 [NAL9602](INFO): GPS fix at 20190827T233227: (41.828216, -83.411793)
2019-08-27T23:34:59.336Z,1566948899.336 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:34:59.336Z,1566948899.336 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:35:07.248Z,1566948907.248 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190827T222740/Courier0039.lzma
2019-08-27T23:35:08.054Z,1566948908.054 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0039.lzma.bak
2019-08-27T23:35:08.054Z,1566948908.054 [DataOverHttps](INFO): SBD MOMSN=11705028
2019-08-27T23:35:15.870Z,1566948915.870 [NAL9602](INFO): SBD MO Status=0, MOMSN=34040, MT Status=0, MTMSN=0
2019-08-27T23:35:15.871Z,1566948915.871 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:35:21.760Z,1566948921.760 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190827T222740/Express0040.lzma
2019-08-27T23:35:22.566Z,1566948922.566 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0040.lzma.bak
2019-08-27T23:35:22.566Z,1566948922.566 [DataOverHttps](INFO): SBD MOMSN=11705031
2019-08-27T23:35:24.387Z,1566948924.387 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:35:24.388Z,1566948924.388 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:35:24.388Z,1566948924.388 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:35:46.575Z,1566948946.575 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:40:24.949Z,1566949224.949 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:40:24.949Z,1566949224.949 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:40:24.949Z,1566949224.949 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:40:24.950Z,1566949224.950 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:40:25.359Z,1566949225.359 [Default:CheckIn:D] Stopped
2019-08-27T23:40:25.359Z,1566949225.359 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:40:25.754Z,1566949225.754 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 106.199585 min 
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn:E] Stopped
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn] Stopped
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn](INFO): Running loop #20
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn] Running Loop=20
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:40:25.755Z,1566949225.755 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:40:27.364Z,1566949227.365 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:40:27.763Z,1566949227.763 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233755.00,A,4149.67425,N,08324.70605,W,0.019,159.14,270819,,,D*7A
2019-08-27T23:40:27.776Z,1566949227.776 [NAL9602](INFO): GPS fix at 20190827T233755: (41.827904, -83.411767)
2019-08-27T23:40:27.799Z,1566949227.799 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:40:27.799Z,1566949227.799 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:40:29.783Z,1566949229.783 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-27T23:40:39.568Z,1566949239.568 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0042.lzma
2019-08-27T23:40:40.374Z,1566949240.374 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0042.lzma.bak
2019-08-27T23:40:40.374Z,1566949240.374 [DataOverHttps](INFO): SBD MOMSN=11705059
2019-08-27T23:40:54.100Z,1566949254.100 [DataOverHttps](INFO): Sending 129 bytes from file Logs/20190827T222740/Express0043.lzma
2019-08-27T23:40:54.907Z,1566949254.907 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0043.lzma.bak
2019-08-27T23:40:54.907Z,1566949254.907 [DataOverHttps](INFO): SBD MOMSN=11705066
2019-08-27T23:40:56.909Z,1566949256.909 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:40:56.910Z,1566949256.910 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:40:56.910Z,1566949256.910 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:41:03.323Z,1566949263.323 [NAL9602](INFO): SBD MO Status=2, MOMSN=34041, MT Status=0, MTMSN=0
2019-08-27T23:41:03.323Z,1566949263.323 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-27T23:41:22.303Z,1566949282.303 [NAL9602](INFO): SBD MO Status=2, MOMSN=34041, MT Status=2, MTMSN=0
2019-08-27T23:41:22.303Z,1566949282.303 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-27T23:41:29.569Z,1566949289.569 [NAL9602](INFO): SBD MO Status=0, MOMSN=34041, MT Status=0, MTMSN=0
2019-08-27T23:41:29.569Z,1566949289.569 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:42:00.277Z,1566949320.277 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:45:57.495Z,1566949557.495 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:45:57.495Z,1566949557.495 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:45:57.495Z,1566949557.495 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:45:57.495Z,1566949557.495 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:45:57.884Z,1566949557.884 [Default:CheckIn:D] Stopped
2019-08-27T23:45:57.884Z,1566949557.884 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 111.741667 min 
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn:E] Stopped
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn] Stopped
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn](INFO): Running loop #21
2019-08-27T23:45:58.278Z,1566949558.278 [Default:CheckIn] Running Loop=21
2019-08-27T23:45:58.279Z,1566949558.279 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:45:58.279Z,1566949558.279 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:45:59.885Z,1566949559.885 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:46:00.274Z,1566949560.274 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234327.00,A,4149.67509,N,08324.70864,W,0.039,159.14,270819,,,D*78
2019-08-27T23:46:00.276Z,1566949560.276 [NAL9602](INFO): GPS fix at 20190827T234327: (41.827918, -83.411811)
2019-08-27T23:46:00.299Z,1566949560.299 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:46:00.299Z,1566949560.299 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:46:02.310Z,1566949562.310 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-27T23:46:06.264Z,1566949566.264 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190827T222740/Courier0045.lzma
2019-08-27T23:46:07.070Z,1566949567.070 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0045.lzma.bak
2019-08-27T23:46:07.070Z,1566949567.070 [DataOverHttps](INFO): SBD MOMSN=11705093
2019-08-27T23:46:13.605Z,1566949573.605 [NAL9602](INFO): SBD MO Status=0, MOMSN=34042, MT Status=0, MTMSN=0
2019-08-27T23:46:13.605Z,1566949573.605 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:46:21.000Z,1566949581.000 [DataOverHttps](INFO): Sending 118 bytes from file Logs/20190827T222740/Express0046.lzma
2019-08-27T23:46:22.550Z,1566949582.550 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0046.lzma.bak
2019-08-27T23:46:22.550Z,1566949582.550 [DataOverHttps](INFO): SBD MOMSN=11705096
2019-08-27T23:46:23.895Z,1566949583.895 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:46:23.895Z,1566949583.895 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:46:23.895Z,1566949583.895 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:46:44.341Z,1566949604.341 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:50:18.117Z,1566949818.117 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-27T23:50:18.118Z,1566949818.118 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-27T23:50:18.119Z,1566949818.119 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2019-08-27T23:50:18.121Z,1566949818.121 [BPC1](INFO): Received data from all battery sticks.
2019-08-27T23:51:24.395Z,1566949884.395 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:51:24.395Z,1566949884.395 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:51:24.396Z,1566949884.396 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:51:24.396Z,1566949884.396 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:51:24.808Z,1566949884.808 [Default:CheckIn:D] Stopped
2019-08-27T23:51:24.808Z,1566949884.808 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:51:25.199Z,1566949885.199 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 117.190405 min 
2019-08-27T23:51:25.199Z,1566949885.199 [Default:CheckIn:E] Stopped
2019-08-27T23:51:25.199Z,1566949885.199 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:51:25.199Z,1566949885.199 [Default:CheckIn] Stopped
2019-08-27T23:51:25.199Z,1566949885.199 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:51:25.200Z,1566949885.200 [Default:CheckIn](INFO): Running loop #22
2019-08-27T23:51:25.200Z,1566949885.200 [Default:CheckIn] Running Loop=22
2019-08-27T23:51:25.200Z,1566949885.200 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:51:25.200Z,1566949885.200 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:51:26.813Z,1566949886.813 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:51:27.205Z,1566949887.205 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,234853.00,A,4149.67514,N,08324.70903,W,0.214,323.82,270819,,,A*74
2019-08-27T23:51:27.208Z,1566949887.208 [NAL9602](INFO): GPS fix at 20190827T234853: (41.827919, -83.411817)
2019-08-27T23:51:27.239Z,1566949887.239 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:51:27.239Z,1566949887.239 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:51:28.425Z,1566949888.425 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-27T23:51:33.124Z,1566949893.124 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20190827T222740/Courier0048.lzma
2019-08-27T23:51:33.930Z,1566949893.930 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0048.lzma.bak
2019-08-27T23:51:33.930Z,1566949893.930 [DataOverHttps](INFO): SBD MOMSN=11705143
2019-08-27T23:51:45.960Z,1566949905.960 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190827T222740/Express0049.lzma
2019-08-27T23:51:46.766Z,1566949906.766 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0049.lzma.bak
2019-08-27T23:51:46.766Z,1566949906.766 [DataOverHttps](INFO): SBD MOMSN=11705146
2019-08-27T23:51:48.644Z,1566949908.644 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:51:48.644Z,1566949908.644 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:51:48.644Z,1566949908.644 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:51:56.691Z,1566949916.691 [NAL9602](INFO): SBD MO Status=0, MOMSN=34043, MT Status=0, MTMSN=0
2019-08-27T23:51:56.691Z,1566949916.691 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:52:27.411Z,1566949947.411 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-27T23:56:49.215Z,1566950209.215 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-27T23:56:49.215Z,1566950209.215 [Default:CheckIn:C.Wait] Stopped
2019-08-27T23:56:49.215Z,1566950209.215 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-27T23:56:49.217Z,1566950209.217 [Default:CheckIn:D] Running Loop=1
2019-08-27T23:56:49.622Z,1566950209.622 [Default:CheckIn:D] Stopped
2019-08-27T23:56:49.622Z,1566950209.622 [Default:CheckIn:E] Running Loop=1
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 122.603971 min 
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn:E] Stopped
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn] Stopped
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn](INFO): Running loop #23
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn] Running Loop=23
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-27T23:56:50.023Z,1566950210.023 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-27T23:56:51.628Z,1566950211.628 [NAL9602](DEBUG): Fix Requested
2019-08-27T23:56:52.017Z,1566950212.017 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235418.00,A,4149.67989,N,08324.71044,W,0.194,262.10,270819,,,A*71
2019-08-27T23:56:52.019Z,1566950212.019 [NAL9602](INFO): GPS fix at 20190827T235418: (41.827998, -83.411841)
2019-08-27T23:56:52.047Z,1566950212.047 [Default:CheckIn:Read_GPS] Stopped
2019-08-27T23:56:52.047Z,1566950212.047 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-27T23:56:54.049Z,1566950214.049 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-27T23:56:57.960Z,1566950217.960 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0051.lzma
2019-08-27T23:56:58.766Z,1566950218.766 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0051.lzma.bak
2019-08-27T23:56:58.766Z,1566950218.766 [DataOverHttps](INFO): SBD MOMSN=11705182
2019-08-27T23:57:12.228Z,1566950232.228 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190827T222740/Express0052.lzma
2019-08-27T23:57:13.037Z,1566950233.037 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0052.lzma.bak
2019-08-27T23:57:13.037Z,1566950233.037 [DataOverHttps](INFO): SBD MOMSN=11705185
2019-08-27T23:57:15.091Z,1566950235.091 [Default:CheckIn:Read_Iridium] Stopped
2019-08-27T23:57:15.092Z,1566950235.092 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-27T23:57:15.092Z,1566950235.092 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-27T23:57:41.319Z,1566950261.319 [NAL9602](INFO): SBD MO Status=0, MOMSN=34044, MT Status=0, MTMSN=0
2019-08-27T23:57:41.319Z,1566950261.319 [NAL9602](INFO): No messages in MT queue
2019-08-27T23:58:12.021Z,1566950292.021 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:02:15.663Z,1566950535.663 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:02:15.663Z,1566950535.663 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:02:15.663Z,1566950535.663 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:02:15.663Z,1566950535.663 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:02:16.051Z,1566950536.051 [Default:CheckIn:D] Stopped
2019-08-28T00:02:16.051Z,1566950536.051 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:02:16.460Z,1566950536.460 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 128.044450 min 
2019-08-28T00:02:16.460Z,1566950536.460 [Default:CheckIn:E] Stopped
2019-08-28T00:02:16.460Z,1566950536.460 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:02:16.460Z,1566950536.460 [Default:CheckIn] Stopped
2019-08-28T00:02:16.460Z,1566950536.460 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:02:16.460Z,1566950536.460 [Default:CheckIn](INFO): Running loop #24
2019-08-28T00:02:16.461Z,1566950536.461 [Default:CheckIn] Running Loop=24
2019-08-28T00:02:16.461Z,1566950536.461 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:02:16.461Z,1566950536.461 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:02:18.069Z,1566950538.069 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:02:18.460Z,1566950538.460 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235943.00,A,4149.67686,N,08324.70289,W,0.311,297.63,270819,,,A*71
2019-08-28T00:02:18.462Z,1566950538.462 [NAL9602](INFO): GPS fix at 20190827T235943: (41.827948, -83.411715)
2019-08-28T00:02:18.485Z,1566950538.485 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:02:18.485Z,1566950538.485 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:02:20.487Z,1566950540.487 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-28T00:02:24.368Z,1566950544.368 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0054.lzma
2019-08-28T00:02:25.174Z,1566950545.174 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0054.lzma.bak
2019-08-28T00:02:25.174Z,1566950545.174 [DataOverHttps](INFO): SBD MOMSN=11705202
2019-08-28T00:02:37.200Z,1566950557.200 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20190827T222740/Express0055.lzma
2019-08-28T00:02:38.006Z,1566950558.006 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0055.lzma.bak
2019-08-28T00:02:38.006Z,1566950558.006 [DataOverHttps](INFO): SBD MOMSN=11705205
2019-08-28T00:02:39.871Z,1566950559.871 [NAL9602](INFO): SBD MO Status=2, MOMSN=34045, MT Status=2, MTMSN=0
2019-08-28T00:02:39.871Z,1566950559.871 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:02:39.923Z,1566950559.923 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:02:39.923Z,1566950559.923 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:02:39.923Z,1566950559.923 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:02:59.261Z,1566950579.261 [NAL9602](INFO): SBD MO Status=0, MOMSN=34045, MT Status=0, MTMSN=0
2019-08-28T00:02:59.261Z,1566950579.261 [NAL9602](INFO): No messages in MT queue
2019-08-28T00:03:29.965Z,1566950609.965 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:07:40.474Z,1566950860.474 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:07:40.474Z,1566950860.474 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:07:40.474Z,1566950860.474 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:07:40.474Z,1566950860.474 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:07:40.879Z,1566950860.879 [Default:CheckIn:D] Stopped
2019-08-28T00:07:40.879Z,1566950860.879 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:07:41.292Z,1566950861.292 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 133.458252 min 
2019-08-28T00:07:41.292Z,1566950861.292 [Default:CheckIn:E] Stopped
2019-08-28T00:07:41.292Z,1566950861.292 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:07:41.292Z,1566950861.292 [Default:CheckIn] Stopped
2019-08-28T00:07:41.297Z,1566950861.297 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:07:41.297Z,1566950861.297 [Default:CheckIn](INFO): Running loop #25
2019-08-28T00:07:41.297Z,1566950861.297 [Default:CheckIn] Running Loop=25
2019-08-28T00:07:41.297Z,1566950861.297 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:07:41.297Z,1566950861.297 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:07:42.884Z,1566950862.884 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:07:43.275Z,1566950863.275 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,000508.00,A,4149.67807,N,08324.71304,W,0.350,347.71,280819,,,A*71
2019-08-28T00:07:43.277Z,1566950863.277 [NAL9602](INFO): GPS fix at 20190828T000508: (41.827968, -83.411884)
2019-08-28T00:07:43.300Z,1566950863.300 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:07:43.300Z,1566950863.300 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:07:45.299Z,1566950865.299 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-28T00:07:50.372Z,1566950870.372 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0057.lzma
2019-08-28T00:07:51.182Z,1566950871.182 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0057.lzma.bak
2019-08-28T00:07:51.182Z,1566950871.182 [DataOverHttps](INFO): SBD MOMSN=11705232
2019-08-28T00:08:04.516Z,1566950884.516 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20190827T222740/Express0058.lzma
2019-08-28T00:08:05.322Z,1566950885.322 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0058.lzma.bak
2019-08-28T00:08:05.322Z,1566950885.322 [DataOverHttps](INFO): SBD MOMSN=11705235
2019-08-28T00:08:06.707Z,1566950886.707 [NAL9602](INFO): SBD MO Status=2, MOMSN=34046, MT Status=2, MTMSN=0
2019-08-28T00:08:06.707Z,1566950886.707 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:08:07.159Z,1566950887.159 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:08:07.159Z,1566950887.159 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:08:07.159Z,1566950887.159 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:08:16.821Z,1566950896.821 [NAL9602](INFO): SBD MO Status=0, MOMSN=34046, MT Status=0, MTMSN=0
2019-08-28T00:08:16.822Z,1566950896.822 [NAL9602](INFO): No messages in MT queue
2019-08-28T00:08:47.507Z,1566950927.507 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:13:07.710Z,1566951187.710 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:13:07.710Z,1566951187.710 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:13:07.710Z,1566951187.710 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:13:07.711Z,1566951187.711 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:13:08.116Z,1566951188.116 [Default:CheckIn:D] Stopped
2019-08-28T00:13:08.116Z,1566951188.116 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:13:08.526Z,1566951188.526 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 138.912191 min 
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn:E] Stopped
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn] Stopped
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn](INFO): Running loop #26
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn] Running Loop=26
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:13:08.527Z,1566951188.527 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:13:10.125Z,1566951190.125 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:13:10.513Z,1566951190.513 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001035.00,A,4149.67983,N,08324.70688,W,0.117,347.71,280819,,,A*77
2019-08-28T00:13:10.516Z,1566951190.516 [NAL9602](INFO): GPS fix at 20190828T001035: (41.827997, -83.411781)
2019-08-28T00:13:10.544Z,1566951190.544 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:13:10.544Z,1566951190.544 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:13:12.543Z,1566951192.543 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-28T00:13:16.456Z,1566951196.456 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190827T222740/Courier0060.lzma
2019-08-28T00:13:17.262Z,1566951197.262 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0060.lzma.bak
2019-08-28T00:13:17.262Z,1566951197.262 [DataOverHttps](INFO): SBD MOMSN=11705252
2019-08-28T00:13:30.548Z,1566951210.548 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20190827T222740/Express0061.lzma
2019-08-28T00:13:31.354Z,1566951211.354 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0061.lzma.bak
2019-08-28T00:13:31.354Z,1566951211.354 [DataOverHttps](INFO): SBD MOMSN=11705257
2019-08-28T00:13:33.167Z,1566951213.167 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:13:33.168Z,1566951213.168 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:13:33.168Z,1566951213.168 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:13:39.601Z,1566951219.601 [NAL9602](INFO): SBD MO Status=0, MOMSN=34047, MT Status=0, MTMSN=0
2019-08-28T00:13:39.601Z,1566951219.601 [NAL9602](INFO): No messages in MT queue
2019-08-28T00:14:10.306Z,1566951250.306 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:18:33.739Z,1566951513.739 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:18:33.739Z,1566951513.739 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:18:33.739Z,1566951513.739 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:18:33.741Z,1566951513.741 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:18:34.135Z,1566951514.135 [Default:CheckIn:D] Stopped
2019-08-28T00:18:34.135Z,1566951514.135 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:18:34.548Z,1566951514.548 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 144.345850 min 
2019-08-28T00:18:34.548Z,1566951514.548 [Default:CheckIn:E] Stopped
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn] Stopped
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn](INFO): Running loop #27
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn] Running Loop=27
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:18:34.549Z,1566951514.549 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:18:36.153Z,1566951516.153 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:18:36.543Z,1566951516.543 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,001600.00,A,4149.67873,N,08324.70554,W,0.175,347.71,280819,,,A*7F
2019-08-28T00:18:36.546Z,1566951516.546 [NAL9602](INFO): GPS fix at 20190828T001600: (41.827979, -83.411759)
2019-08-28T00:18:36.569Z,1566951516.569 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:18:36.569Z,1566951516.569 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:18:38.165Z,1566951518.165 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-28T00:18:51.028Z,1566951531.028 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0063.lzma
2019-08-28T00:18:51.834Z,1566951531.834 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0063.lzma.bak
2019-08-28T00:18:51.834Z,1566951531.834 [DataOverHttps](INFO): SBD MOMSN=11705297
2019-08-28T00:18:57.563Z,1566951537.563 [NAL9602](INFO): SBD MO Status=2, MOMSN=34048, MT Status=2, MTMSN=0
2019-08-28T00:18:57.563Z,1566951537.563 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:19:06.652Z,1566951546.652 [DataOverHttps](INFO): Sending 121 bytes from file Logs/20190827T222740/Express0064.lzma
2019-08-28T00:19:07.458Z,1566951547.458 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0064.lzma.bak
2019-08-28T00:19:07.459Z,1566951547.459 [DataOverHttps](INFO): SBD MOMSN=11705302
2019-08-28T00:19:09.739Z,1566951549.739 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:19:09.740Z,1566951549.740 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:19:09.740Z,1566951549.740 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:19:56.549Z,1566951596.549 [NAL9602](INFO): SBD MO Status=2, MOMSN=34048, MT Status=2, MTMSN=0
2019-08-28T00:19:56.549Z,1566951596.549 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:20:14.733Z,1566951614.733 [NAL9602](INFO): SBD MO Status=0, MOMSN=34048, MT Status=0, MTMSN=0
2019-08-28T00:20:14.733Z,1566951614.733 [NAL9602](INFO): No messages in MT queue
2019-08-28T00:20:45.440Z,1566951645.440 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:24:10.292Z,1566951850.292 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:24:10.292Z,1566951850.292 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:24:10.292Z,1566951850.292 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:24:10.293Z,1566951850.293 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:24:10.700Z,1566951850.700 [Default:CheckIn:D] Stopped
2019-08-28T00:24:10.700Z,1566951850.700 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:24:11.099Z,1566951851.099 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 149.955273 min 
2019-08-28T00:24:11.099Z,1566951851.099 [Default:CheckIn:E] Stopped
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn] Stopped
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn](INFO): Running loop #28
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn] Running Loop=28
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:24:11.100Z,1566951851.100 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:24:12.708Z,1566951852.708 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:24:13.101Z,1566951853.101 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002136.00,A,4149.72552,N,08324.92087,W,4.043,317.48,280819,,,A*7C
2019-08-28T00:24:13.103Z,1566951853.103 [NAL9602](INFO): GPS fix at 20190828T002136: (41.828759, -83.415348)
2019-08-28T00:24:13.135Z,1566951853.135 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:24:13.135Z,1566951853.135 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:24:14.715Z,1566951854.715 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-28T00:24:26.480Z,1566951866.480 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0066.lzma
2019-08-28T00:24:27.286Z,1566951867.286 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0066.lzma.bak
2019-08-28T00:24:27.286Z,1566951867.286 [DataOverHttps](INFO): SBD MOMSN=11705326
2019-08-28T00:24:34.917Z,1566951874.917 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:24:34.917Z,1566951874.917 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:24:41.560Z,1566951881.560 [DataOverHttps](INFO): Sending 136 bytes from file Logs/20190827T222740/Express0067.lzma
2019-08-28T00:24:42.373Z,1566951882.373 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0067.lzma.bak
2019-08-28T00:24:42.373Z,1566951882.373 [DataOverHttps](INFO): SBD MOMSN=11705332
2019-08-28T00:24:44.243Z,1566951884.243 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:24:44.244Z,1566951884.244 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:24:44.244Z,1566951884.244 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:26:04.597Z,1566951964.597 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:26:04.597Z,1566951964.597 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:28:26.805Z,1566952106.805 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:28:26.805Z,1566952106.805 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:29:10.033Z,1566952150.033 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:29:10.033Z,1566952150.033 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:29:15.285Z,1566952155.285 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T00:29:44.803Z,1566952184.803 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:29:44.803Z,1566952184.803 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:29:44.803Z,1566952184.803 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:29:44.804Z,1566952184.804 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:29:45.211Z,1566952185.211 [Default:CheckIn:D] Stopped
2019-08-28T00:29:45.211Z,1566952185.211 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:29:45.620Z,1566952185.620 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 155.530452 min 
2019-08-28T00:29:45.620Z,1566952185.620 [Default:CheckIn:E] Stopped
2019-08-28T00:29:45.620Z,1566952185.620 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:29:45.620Z,1566952185.620 [Default:CheckIn] Stopped
2019-08-28T00:29:45.620Z,1566952185.620 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:29:45.620Z,1566952185.620 [Default:CheckIn](INFO): Running loop #29
2019-08-28T00:29:45.621Z,1566952185.621 [Default:CheckIn] Running Loop=29
2019-08-28T00:29:45.621Z,1566952185.621 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:29:45.621Z,1566952185.621 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:29:45.989Z,1566952185.989 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:29:47.216Z,1566952187.217 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:29:47.610Z,1566952187.610 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002710.00,A,4150.86037,N,08325.02106,W,57.266,27.21,280819,,,A*77
2019-08-28T00:29:47.612Z,1566952187.612 [NAL9602](INFO): GPS fix at 20190828T002710: (41.847673, -83.417018)
2019-08-28T00:29:47.635Z,1566952187.635 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:29:47.635Z,1566952187.635 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:29:49.228Z,1566952189.228 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-28T00:30:18.308Z,1566952218.308 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-08-28T00:30:18.824Z,1566952218.824 [NAL9602](FAULT): received: 
2019-08-28T00:30:18.825Z,1566952218.825 [NAL9602] Data Fault, FailCount= 1
2019-08-28T00:30:18.825Z,1566952218.825 [NAL9602](ERROR): Data Fault
2019-08-28T00:30:18.878Z,1566952218.878 [CBIT](ERROR): Data Fault in component: NAL9602
2019-08-28T00:30:18.944Z,1566952218.944 [NAL9602](INFO): Powering down
2019-08-28T00:30:19.741Z,1566952219.741 [CBIT](INFO): Clearing failed state for component NAL9602
2019-08-28T00:30:19.741Z,1566952219.741 [NAL9602] No Fault, FailCount= 1
2019-08-28T00:30:23.540Z,1566952223.540 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190827T222740/Courier0069.lzma
2019-08-28T00:30:24.347Z,1566952224.347 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0069.lzma.bak
2019-08-28T00:30:24.347Z,1566952224.347 [DataOverHttps](INFO): SBD MOMSN=11705371
2019-08-28T00:30:36.612Z,1566952236.612 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190827T222740/Express0070.lzma
2019-08-28T00:30:37.418Z,1566952237.418 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0070.lzma.bak
2019-08-28T00:30:37.419Z,1566952237.419 [DataOverHttps](INFO): SBD MOMSN=11705376
2019-08-28T00:30:39.143Z,1566952239.143 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:30:39.144Z,1566952239.144 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:30:39.144Z,1566952239.144 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:30:49.197Z,1566952249.197 [NAL9602](INFO): Powering up NAL9602
2019-08-28T00:31:00.105Z,1566952260.105 [NAL9602](INFO): NAL9602 initialized
2019-08-28T00:31:31.219Z,1566952291.219 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:35:39.721Z,1566952539.721 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:35:39.721Z,1566952539.721 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:35:39.721Z,1566952539.721 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:35:39.721Z,1566952539.721 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:35:40.131Z,1566952540.131 [Default:CheckIn:D] Stopped
2019-08-28T00:35:40.131Z,1566952540.131 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:35:40.529Z,1566952540.529 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 161.445785 min 
2019-08-28T00:35:40.529Z,1566952540.529 [Default:CheckIn:E] Stopped
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn] Stopped
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn](INFO): Running loop #30
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn] Running Loop=30
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:35:40.530Z,1566952540.530 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:35:42.129Z,1566952542.129 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:35:42.522Z,1566952542.522 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,003303.00,A,4155.80598,N,08321.51179,W,60.706,12.85,280819,,,A*76
2019-08-28T00:35:42.524Z,1566952542.524 [NAL9602](INFO): GPS fix at 20190828T003303: (41.930100, -83.358530)
2019-08-28T00:35:42.550Z,1566952542.550 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:35:42.550Z,1566952542.550 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:35:45.026Z,1566952545.026 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T00:35:46.919Z,1566952546.919 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0072.lzma
2019-08-28T00:35:47.730Z,1566952547.730 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0072.lzma.bak
2019-08-28T00:35:47.730Z,1566952547.730 [DataOverHttps](INFO): SBD MOMSN=11705473
2019-08-28T00:36:02.688Z,1566952562.688 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20190827T222740/Express0073.lzma
2019-08-28T00:36:03.494Z,1566952563.494 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0073.lzma.bak
2019-08-28T00:36:03.494Z,1566952563.494 [DataOverHttps](INFO): SBD MOMSN=11705484
2019-08-28T00:36:05.262Z,1566952565.262 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:36:05.262Z,1566952565.262 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:36:05.262Z,1566952565.262 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:36:15.727Z,1566952575.727 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:40:48.641Z,1566952848.641 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T00:41:05.835Z,1566952865.835 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:41:05.835Z,1566952865.835 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:41:05.835Z,1566952865.835 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:41:05.836Z,1566952865.836 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:41:06.243Z,1566952866.243 [Default:CheckIn:D] Stopped
2019-08-28T00:41:06.243Z,1566952866.243 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:41:06.645Z,1566952866.645 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 166.880990 min 
2019-08-28T00:41:06.645Z,1566952866.645 [Default:CheckIn:E] Stopped
2019-08-28T00:41:06.645Z,1566952866.645 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:41:06.645Z,1566952866.645 [Default:CheckIn] Stopped
2019-08-28T00:41:06.646Z,1566952866.646 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:41:06.646Z,1566952866.646 [Default:CheckIn](INFO): Running loop #31
2019-08-28T00:41:06.646Z,1566952866.646 [Default:CheckIn] Running Loop=31
2019-08-28T00:41:06.646Z,1566952866.646 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:41:06.646Z,1566952866.646 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:41:08.236Z,1566952868.237 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:41:08.631Z,1566952868.631 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,003829.00,A,4200.67157,N,08320.46613,W,62.806,330.00,280819,,,A*47
2019-08-28T00:41:08.634Z,1566952868.634 [NAL9602](INFO): GPS fix at 20190828T003829: (42.011193, -83.341102)
2019-08-28T00:41:08.671Z,1566952868.671 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:41:08.671Z,1566952868.671 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:41:15.472Z,1566952875.472 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0075.lzma
2019-08-28T00:41:16.278Z,1566952876.278 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0075.lzma.bak
2019-08-28T00:41:16.278Z,1566952876.278 [DataOverHttps](INFO): SBD MOMSN=11705539
2019-08-28T00:41:34.081Z,1566952894.081 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:41:34.082Z,1566952894.082 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:41:45.764Z,1566952905.764 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190827T222740/Express0076.lzma
2019-08-28T00:41:46.570Z,1566952906.570 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0076.lzma.bak
2019-08-28T00:41:46.570Z,1566952906.570 [DataOverHttps](INFO): SBD MOMSN=11705549
2019-08-28T00:41:48.263Z,1566952908.263 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:41:48.264Z,1566952908.264 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:41:48.264Z,1566952908.264 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:41:52.263Z,1566952912.263 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:41:52.263Z,1566952912.263 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:42:08.425Z,1566952928.425 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:42:08.426Z,1566952928.426 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:42:35.495Z,1566952955.495 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:42:35.495Z,1566952955.495 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:42:53.673Z,1566952973.673 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:42:53.673Z,1566952973.673 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:43:11.453Z,1566952991.453 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:43:11.453Z,1566952991.453 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:43:36.089Z,1566953016.089 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:43:36.089Z,1566953016.089 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:43:54.673Z,1566953034.673 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:43:54.674Z,1566953034.674 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:44:11.243Z,1566953051.243 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:44:11.243Z,1566953051.243 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:44:19.725Z,1566953059.725 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:44:19.725Z,1566953059.725 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:44:26.993Z,1566953066.993 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:44:26.993Z,1566953066.993 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:44:35.487Z,1566953075.487 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:44:35.487Z,1566953075.487 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:46:03.145Z,1566953163.145 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:46:03.145Z,1566953163.145 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:46:10.841Z,1566953170.841 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T00:46:41.527Z,1566953201.527 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:46:48.823Z,1566953208.823 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:46:48.823Z,1566953208.823 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:46:48.823Z,1566953208.823 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:46:48.823Z,1566953208.823 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:46:49.232Z,1566953209.232 [Default:CheckIn:D] Stopped
2019-08-28T00:46:49.232Z,1566953209.232 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:46:49.628Z,1566953209.628 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 172.597461 min 
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn:E] Stopped
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn] Stopped
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn](INFO): Running loop #32
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn] Running Loop=32
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:46:49.629Z,1566953209.629 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:46:51.233Z,1566953211.233 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:46:51.626Z,1566953211.626 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,004413.00,A,4206.27874,N,08322.64218,W,62.767,359.39,280819,,,A*4F
2019-08-28T00:46:51.628Z,1566953211.628 [NAL9602](INFO): GPS fix at 20190828T004413: (42.104646, -83.377370)
2019-08-28T00:46:51.651Z,1566953211.651 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:46:51.651Z,1566953211.651 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:46:59.672Z,1566953219.672 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0078.lzma
2019-08-28T00:47:00.478Z,1566953220.478 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0078.lzma.bak
2019-08-28T00:47:00.478Z,1566953220.478 [DataOverHttps](INFO): SBD MOMSN=11705561
2019-08-28T00:47:13.236Z,1566953233.236 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20190827T222740/Express0079.lzma
2019-08-28T00:47:14.042Z,1566953234.042 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0079.lzma.bak
2019-08-28T00:47:14.042Z,1566953234.042 [DataOverHttps](INFO): SBD MOMSN=11705564
2019-08-28T00:47:15.903Z,1566953235.903 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:47:15.903Z,1566953235.903 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:47:15.903Z,1566953235.903 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:47:20.715Z,1566953240.715 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:47:20.715Z,1566953240.715 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:47:42.529Z,1566953262.529 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:47:42.529Z,1566953262.529 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:49:19.489Z,1566953359.489 [NAL9602](INFO): SBD MO Status=2, MOMSN=34049, MT Status=2, MTMSN=0
2019-08-28T00:49:19.489Z,1566953359.489 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T00:51:54.226Z,1566953514.226 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T00:52:16.470Z,1566953536.470 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:52:16.470Z,1566953536.470 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:52:16.471Z,1566953536.471 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:52:16.471Z,1566953536.471 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:52:16.874Z,1566953536.874 [Default:CheckIn:D] Stopped
2019-08-28T00:52:16.874Z,1566953536.874 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:52:17.290Z,1566953537.290 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 178.058171 min 
2019-08-28T00:52:17.290Z,1566953537.290 [Default:CheckIn:E] Stopped
2019-08-28T00:52:17.290Z,1566953537.290 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:52:17.290Z,1566953537.290 [Default:CheckIn] Stopped
2019-08-28T00:52:17.291Z,1566953537.291 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:52:17.291Z,1566953537.291 [Default:CheckIn](INFO): Running loop #33
2019-08-28T00:52:17.291Z,1566953537.291 [Default:CheckIn] Running Loop=33
2019-08-28T00:52:17.291Z,1566953537.291 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:52:17.291Z,1566953537.291 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:52:18.877Z,1566953538.876 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:52:19.270Z,1566953539.270 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,004940.00,A,4211.91452,N,08323.31716,W,62.689,358.72,280819,,,A*42
2019-08-28T00:52:19.272Z,1566953539.272 [NAL9602](INFO): GPS fix at 20190828T004940: (42.198575, -83.388619)
2019-08-28T00:52:19.303Z,1566953539.303 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:52:19.303Z,1566953539.303 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:52:26.576Z,1566953546.576 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190827T222740/Courier0081.lzma
2019-08-28T00:52:27.382Z,1566953547.382 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0081.lzma.bak
2019-08-28T00:52:27.382Z,1566953547.382 [DataOverHttps](INFO): SBD MOMSN=11705581
2019-08-28T00:52:39.948Z,1566953559.948 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190827T222740/Express0082.lzma
2019-08-28T00:52:40.754Z,1566953560.754 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0082.lzma.bak
2019-08-28T00:52:40.755Z,1566953560.755 [DataOverHttps](INFO): SBD MOMSN=11705584
2019-08-28T00:52:42.767Z,1566953562.767 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:52:42.767Z,1566953562.767 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:52:42.767Z,1566953562.767 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:52:51.991Z,1566953571.991 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T00:57:43.307Z,1566953863.307 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T00:57:43.307Z,1566953863.307 [Default:CheckIn:C.Wait] Stopped
2019-08-28T00:57:43.307Z,1566953863.307 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T00:57:43.308Z,1566953863.308 [Default:CheckIn:D] Running Loop=1
2019-08-28T00:57:43.774Z,1566953863.774 [Default:CheckIn:D] Stopped
2019-08-28T00:57:43.775Z,1566953863.775 [Default:CheckIn:E] Running Loop=1
2019-08-28T00:57:44.118Z,1566953864.118 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 183.506510 min 
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn:E] Stopped
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn] Stopped
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn](INFO): Running loop #34
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn] Running Loop=34
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T00:57:44.119Z,1566953864.119 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T00:57:45.720Z,1566953865.720 [NAL9602](DEBUG): Fix Requested
2019-08-28T00:57:46.110Z,1566953866.110 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,005506.00,A,4213.20496,N,08328.32560,W,63.078,269.36,280819,,,A*4C
2019-08-28T00:57:46.112Z,1566953866.112 [NAL9602](INFO): GPS fix at 20190828T005506: (42.220083, -83.472093)
2019-08-28T00:57:46.135Z,1566953866.135 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T00:57:46.135Z,1566953866.135 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T00:57:52.692Z,1566953872.692 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0084.lzma
2019-08-28T00:57:53.498Z,1566953873.498 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0084.lzma.bak
2019-08-28T00:57:53.498Z,1566953873.498 [DataOverHttps](INFO): SBD MOMSN=11705600
2019-08-28T00:57:58.282Z,1566953878.282 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-28T00:57:58.282Z,1566953878.282 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-28T00:57:58.283Z,1566953878.283 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2019-08-28T00:57:58.285Z,1566953878.285 [BPC1](INFO): Received data from all battery sticks.
2019-08-28T00:58:05.624Z,1566953885.624 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20190827T222740/Express0085.lzma
2019-08-28T00:58:06.430Z,1566953886.430 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0085.lzma.bak
2019-08-28T00:58:06.431Z,1566953886.431 [DataOverHttps](INFO): SBD MOMSN=11705604
2019-08-28T00:58:08.356Z,1566953888.356 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T00:58:08.356Z,1566953888.356 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T00:58:08.356Z,1566953888.356 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T00:58:16.844Z,1566953896.844 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-08-28T00:58:16.917Z,1566953896.917 [NAL9602](FAULT): received: 
+CSQ:0

OK049, 2, 0, 0, 0

OK
2019-08-28T00:58:16.917Z,1566953896.917 [NAL9602] Data Fault, FailCount= 1
2019-08-28T00:58:16.917Z,1566953896.917 [NAL9602](ERROR): Data Fault
2019-08-28T00:58:17.008Z,1566953897.008 [CBIT](ERROR): Data Fault in component: NAL9602
2019-08-28T00:58:17.218Z,1566953897.218 [NAL9602](INFO): Powering down
2019-08-28T00:58:18.077Z,1566953898.077 [CBIT](INFO): Clearing failed state for component NAL9602
2019-08-28T00:58:18.077Z,1566953898.077 [NAL9602] No Fault, FailCount= 1
2019-08-28T00:58:47.522Z,1566953927.522 [NAL9602](INFO): Powering up NAL9602
2019-08-28T00:58:58.437Z,1566953938.437 [NAL9602](INFO): NAL9602 initialized
2019-08-28T00:59:29.535Z,1566953969.535 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:03:08.935Z,1566954188.935 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:03:08.935Z,1566954188.935 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:03:08.935Z,1566954188.935 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:03:08.936Z,1566954188.936 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:03:09.344Z,1566954189.344 [Default:CheckIn:D] Stopped
2019-08-28T01:03:09.344Z,1566954189.344 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:03:09.746Z,1566954189.746 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 188.932666 min 
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn:E] Stopped
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn] Stopped
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn](INFO): Running loop #35
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn] Running Loop=35
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:03:09.747Z,1566954189.747 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:03:11.344Z,1566954191.344 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:03:11.738Z,1566954191.738 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010030.00,A,4213.90576,N,08335.51081,W,62.825,269.89,280819,,,A*4A
2019-08-28T01:03:11.740Z,1566954191.740 [NAL9602](INFO): GPS fix at 20190828T010030: (42.231763, -83.591847)
2019-08-28T01:03:11.763Z,1566954191.763 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:03:11.763Z,1566954191.763 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:03:13.360Z,1566954193.360 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T01:03:17.161Z,1566954197.161 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:03:44.056Z,1566954224.056 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:03:47.865Z,1566954227.865 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:04:18.569Z,1566954258.569 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:04:49.273Z,1566954289.273 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:05:19.977Z,1566954319.977 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:05:22.401Z,1566954322.401 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.071945
2019-08-28T01:05:51.329Z,1566954351.329 [NAL9602](INFO): SBD MO Status=1, MOMSN=34049, MT Status=0, MTMSN=0
2019-08-28T01:05:51.377Z,1566954351.377 [NAL9602](INFO): Sent 81 bytes from file Logs/20190827T222740/Courier0087.lzma
2019-08-28T01:05:51.377Z,1566954351.377 [NAL9602](INFO): Packets left to send: 0
2019-08-28T01:05:53.105Z,1566954353.105 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:06:03.125Z,1566954363.125 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:06:03.125Z,1566954363.125 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:06:23.809Z,1566954383.809 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:06:28.880Z,1566954388.880 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:06:28.880Z,1566954388.880 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:06:54.513Z,1566954414.513 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:07:09.277Z,1566954429.277 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002964
2019-08-28T01:07:14.347Z,1566954434.347 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:07:14.347Z,1566954434.347 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:07:18.252Z,1566954438.252 [DataOverHttps](INFO): Sending 180 bytes from file Logs/20190827T222740/Express0088.lzma
2019-08-28T01:07:19.058Z,1566954439.058 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0088.lzma.bak
2019-08-28T01:07:19.058Z,1566954439.058 [DataOverHttps](INFO): SBD MOMSN=11705641
2019-08-28T01:07:20.847Z,1566954440.847 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:07:20.848Z,1566954440.848 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:07:20.848Z,1566954440.848 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:07:45.049Z,1566954465.049 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:11:11.554Z,1566954671.554 [CBIT](IMPORTANT): Beginning ground fault scan
2019-08-28T01:11:22.442Z,1566954682.442 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.001544
CHAN A1 (24V): 0.012141
CHAN A2 (12V): 0.008567
CHAN A3 (5V): -0.000061
CHAN B0 (3.3V): -0.000321
CHAN B1 (3.15aV): -0.000132
CHAN B2 (3.15bV): -0.000740
CHAN B3 (GND): -0.002617
OPEN: 0.007713
Full Scale Calc: 4.765 mA, -1.589 mA
2019-08-28T01:12:21.415Z,1566954741.415 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:12:21.415Z,1566954741.415 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:12:21.415Z,1566954741.415 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:12:21.416Z,1566954741.416 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:12:21.835Z,1566954741.835 [Default:CheckIn:D] Stopped
2019-08-28T01:12:21.835Z,1566954741.835 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 198.140853 min 
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn:E] Stopped
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn] Stopped
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn](INFO): Running loop #36
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn] Running Loop=36
2019-08-28T01:12:22.225Z,1566954742.225 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:12:22.226Z,1566954742.226 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:12:23.828Z,1566954743.828 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:12:24.223Z,1566954744.223 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,010943.00,A,4213.50682,N,08344.22020,W,40.704,160.46,280819,,,A*4F
2019-08-28T01:12:24.225Z,1566954744.225 [NAL9602](INFO): GPS fix at 20190828T010943: (42.225114, -83.737003)
2019-08-28T01:12:24.248Z,1566954744.248 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:12:24.248Z,1566954744.248 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:12:36.008Z,1566954756.008 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0090.lzma
2019-08-28T01:12:36.814Z,1566954756.814 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0090.lzma.bak
2019-08-28T01:12:36.815Z,1566954756.815 [DataOverHttps](INFO): SBD MOMSN=11705683
2019-08-28T01:12:48.929Z,1566954768.929 [DataOverHttps](INFO): Sending 421 bytes from file Logs/20190827T222740/Express0091.lzma
2019-08-28T01:12:49.734Z,1566954769.734 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0091.lzma.bak
2019-08-28T01:12:49.735Z,1566954769.735 [DataOverHttps](INFO): SBD MOMSN=11705688
2019-08-28T01:12:51.735Z,1566954771.735 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:12:51.736Z,1566954771.736 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:12:51.736Z,1566954771.736 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:13:07.034Z,1566954787.034 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:13:07.034Z,1566954787.034 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:13:22.806Z,1566954802.806 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:13:22.806Z,1566954802.806 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:14:01.581Z,1566954841.581 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:14:01.581Z,1566954841.581 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:14:31.071Z,1566954871.071 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:14:31.071Z,1566954871.071 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:14:48.845Z,1566954888.845 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:14:48.846Z,1566954888.846 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:15:12.289Z,1566954912.289 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:15:12.289Z,1566954912.289 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:16:12.477Z,1566954972.477 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:16:12.477Z,1566954972.477 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:16:55.297Z,1566955015.297 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:16:55.297Z,1566955015.297 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:17:14.287Z,1566955034.287 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:17:14.287Z,1566955034.287 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:17:29.636Z,1566955049.636 [NAL9602](INFO): SBD MO Status=2, MOMSN=34050, MT Status=2, MTMSN=0
2019-08-28T01:17:29.637Z,1566955049.637 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:17:30.046Z,1566955050.046 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T01:17:52.294Z,1566955072.294 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:17:52.294Z,1566955072.294 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:17:52.294Z,1566955072.294 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:17:52.295Z,1566955072.295 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:17:52.703Z,1566955072.703 [Default:CheckIn:D] Stopped
2019-08-28T01:17:52.703Z,1566955072.703 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:17:53.087Z,1566955073.087 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 203.655306 min 
2019-08-28T01:17:53.087Z,1566955073.087 [Default:CheckIn:E] Stopped
2019-08-28T01:17:53.087Z,1566955073.087 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:17:53.087Z,1566955073.087 [Default:CheckIn] Stopped
2019-08-28T01:17:53.087Z,1566955073.087 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:17:53.088Z,1566955073.088 [Default:CheckIn](INFO): Running loop #37
2019-08-28T01:17:53.088Z,1566955073.088 [Default:CheckIn] Running Loop=37
2019-08-28T01:17:53.088Z,1566955073.088 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:17:53.088Z,1566955073.088 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:17:54.700Z,1566955074.700 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:17:55.099Z,1566955075.099 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011513.00,A,4212.99559,N,08344.18913,W,0.428,78.07,280819,,,A*42
2019-08-28T01:17:55.101Z,1566955075.101 [NAL9602](INFO): GPS fix at 20190828T011513: (42.216593, -83.736486)
2019-08-28T01:17:55.123Z,1566955075.123 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:17:55.123Z,1566955075.123 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:18:01.088Z,1566955081.088 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0093.lzma
2019-08-28T01:18:01.894Z,1566955081.894 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0093.lzma.bak
2019-08-28T01:18:01.895Z,1566955081.895 [DataOverHttps](INFO): SBD MOMSN=11705728
2019-08-28T01:18:18.424Z,1566955098.424 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20190827T222740/Express0094.lzma
2019-08-28T01:18:19.230Z,1566955099.230 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0094.lzma.bak
2019-08-28T01:18:19.231Z,1566955099.231 [DataOverHttps](INFO): SBD MOMSN=11705731
2019-08-28T01:18:21.060Z,1566955101.060 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:18:21.065Z,1566955101.065 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:18:21.065Z,1566955101.065 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:18:27.076Z,1566955107.076 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:23:21.641Z,1566955401.641 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:23:21.642Z,1566955401.642 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:23:21.642Z,1566955401.642 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:23:21.642Z,1566955401.642 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:23:22.047Z,1566955402.047 [Default:CheckIn:D] Stopped
2019-08-28T01:23:22.047Z,1566955402.047 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:23:22.451Z,1566955402.451 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 209.144385 min 
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn:E] Stopped
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn] Stopped
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn](INFO): Running loop #38
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn] Running Loop=38
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:23:22.452Z,1566955402.452 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:23:24.049Z,1566955404.049 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:23:24.450Z,1566955404.450 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012042.00,A,4212.98600,N,08344.18680,W,0.136,78.07,280819,,,A*41
2019-08-28T01:23:24.452Z,1566955404.452 [NAL9602](INFO): GPS fix at 20190828T012042: (42.216433, -83.736447)
2019-08-28T01:23:24.495Z,1566955404.495 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:23:24.495Z,1566955404.495 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:23:30.344Z,1566955410.344 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0096.lzma
2019-08-28T01:23:31.150Z,1566955411.150 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0096.lzma.bak
2019-08-28T01:23:31.150Z,1566955411.150 [DataOverHttps](INFO): SBD MOMSN=11705758
2019-08-28T01:23:45.680Z,1566955425.680 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20190827T222740/Express0097.lzma
2019-08-28T01:23:46.486Z,1566955426.486 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0097.lzma.bak
2019-08-28T01:23:46.487Z,1566955426.487 [DataOverHttps](INFO): SBD MOMSN=11705762
2019-08-28T01:23:48.327Z,1566955428.327 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:23:48.327Z,1566955428.327 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:23:48.328Z,1566955428.328 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:24:20.197Z,1566955460.197 [NAL9602](INFO): SBD MO Status=1, MOMSN=34050, MT Status=0, MTMSN=0
2019-08-28T01:24:20.197Z,1566955460.197 [NAL9602](INFO): No messages in MT queue
2019-08-28T01:24:50.906Z,1566955490.906 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:28:48.899Z,1566955728.899 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:28:48.899Z,1566955728.899 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:28:48.899Z,1566955728.899 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:28:48.900Z,1566955728.900 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:28:49.320Z,1566955729.320 [Default:CheckIn:D] Stopped
2019-08-28T01:28:49.320Z,1566955729.320 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:28:49.709Z,1566955729.709 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 214.598926 min 
2019-08-28T01:28:49.709Z,1566955729.709 [Default:CheckIn:E] Stopped
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn] Stopped
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn](INFO): Running loop #39
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn] Running Loop=39
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:28:49.710Z,1566955729.710 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:28:51.312Z,1566955731.312 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:28:51.709Z,1566955731.709 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,012609.00,A,4212.99200,N,08344.18522,W,0.078,78.07,280819,,,D*48
2019-08-28T01:28:51.711Z,1566955731.711 [NAL9602](INFO): GPS fix at 20190828T012609: (42.216533, -83.736420)
2019-08-28T01:28:51.739Z,1566955731.739 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:28:51.739Z,1566955731.739 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:28:57.684Z,1566955737.684 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0099.lzma
2019-08-28T01:28:58.490Z,1566955738.490 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0099.lzma.bak
2019-08-28T01:28:58.491Z,1566955738.491 [DataOverHttps](INFO): SBD MOMSN=11705781
2019-08-28T01:29:10.576Z,1566955750.576 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190827T222740/Express0100.lzma
2019-08-28T01:29:12.654Z,1566955752.654 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0100.lzma.bak
2019-08-28T01:29:12.654Z,1566955752.654 [DataOverHttps](INFO): SBD MOMSN=11705784
2019-08-28T01:29:14.759Z,1566955754.759 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:29:14.760Z,1566955754.760 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:29:14.760Z,1566955754.760 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:29:18.783Z,1566955758.783 [NAL9602](INFO): SBD MO Status=2, MOMSN=34051, MT Status=2, MTMSN=0
2019-08-28T01:29:18.783Z,1566955758.783 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:29:32.508Z,1566955772.508 [NAL9602](INFO): SBD MO Status=2, MOMSN=34051, MT Status=2, MTMSN=0
2019-08-28T01:29:32.508Z,1566955772.508 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:30:22.601Z,1566955822.601 [NAL9602](INFO): SBD MO Status=2, MOMSN=34051, MT Status=2, MTMSN=0
2019-08-28T01:30:22.601Z,1566955822.601 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:32:05.221Z,1566955925.221 [NAL9602](INFO): SBD MO Status=2, MOMSN=34051, MT Status=2, MTMSN=0
2019-08-28T01:32:05.221Z,1566955925.221 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:32:31.078Z,1566955951.078 [NAL9602](INFO): SBD MO Status=2, MOMSN=34051, MT Status=2, MTMSN=0
2019-08-28T01:32:31.079Z,1566955951.079 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:32:48.053Z,1566955968.053 [NAL9602](INFO): SBD MO Status=2, MOMSN=34051, MT Status=2, MTMSN=0
2019-08-28T01:32:48.053Z,1566955968.053 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-28T01:33:54.293Z,1566956034.293 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T01:34:15.335Z,1566956055.335 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:34:15.335Z,1566956055.335 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:34:15.335Z,1566956055.335 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:34:15.336Z,1566956055.336 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:34:15.735Z,1566956055.735 [Default:CheckIn:D] Stopped
2019-08-28T01:34:15.735Z,1566956055.735 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:34:16.134Z,1566956056.134 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 220.039193 min 
2019-08-28T01:34:16.134Z,1566956056.134 [Default:CheckIn:E] Stopped
2019-08-28T01:34:16.134Z,1566956056.134 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:34:16.134Z,1566956056.134 [Default:CheckIn] Stopped
2019-08-28T01:34:16.134Z,1566956056.134 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:34:16.134Z,1566956056.134 [Default:CheckIn](INFO): Running loop #40
2019-08-28T01:34:16.135Z,1566956056.135 [Default:CheckIn] Running Loop=40
2019-08-28T01:34:16.135Z,1566956056.135 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:34:16.135Z,1566956056.135 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:34:17.741Z,1566956057.741 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:34:18.147Z,1566956058.147 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013135.00,A,4212.98381,N,08344.18236,W,0.564,0.00,280819,,,A*7F
2019-08-28T01:34:18.149Z,1566956058.149 [NAL9602](INFO): GPS fix at 20190828T013135: (42.216397, -83.736373)
2019-08-28T01:34:18.219Z,1566956058.219 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:34:18.219Z,1566956058.219 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:34:21.815Z,1566956061.815 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190827T222740/Courier0102.lzma
2019-08-28T01:34:22.655Z,1566956062.655 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0102.lzma.bak
2019-08-28T01:34:22.655Z,1566956062.655 [DataOverHttps](INFO): SBD MOMSN=11705815
2019-08-28T01:34:34.704Z,1566956074.704 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20190827T222740/Express0103.lzma
2019-08-28T01:34:35.510Z,1566956075.510 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0103.lzma.bak
2019-08-28T01:34:35.511Z,1566956075.511 [DataOverHttps](INFO): SBD MOMSN=11705818
2019-08-28T01:34:37.223Z,1566956077.223 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:34:37.223Z,1566956077.223 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:34:37.224Z,1566956077.224 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:34:50.929Z,1566956090.929 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:39:37.786Z,1566956377.786 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:39:37.786Z,1566956377.786 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:39:37.786Z,1566956377.786 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:39:37.787Z,1566956377.787 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:39:38.196Z,1566956378.196 [Default:CheckIn:D] Stopped
2019-08-28T01:39:38.196Z,1566956378.196 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 225.413525 min 
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn:E] Stopped
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn] Stopped
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn](INFO): Running loop #41
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn] Running Loop=41
2019-08-28T01:39:38.591Z,1566956378.591 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:39:38.592Z,1566956378.592 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:39:40.201Z,1566956380.201 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:39:40.599Z,1566956380.599 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013657.00,A,4212.97183,N,08344.20480,W,0.156,215.01,280819,,,D*74
2019-08-28T01:39:40.601Z,1566956380.601 [NAL9602](INFO): GPS fix at 20190828T013657: (42.216197, -83.736747)
2019-08-28T01:39:40.624Z,1566956380.624 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:39:40.624Z,1566956380.624 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:39:46.624Z,1566956386.624 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0105.lzma
2019-08-28T01:39:47.430Z,1566956387.430 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0105.lzma.bak
2019-08-28T01:39:47.431Z,1566956387.431 [DataOverHttps](INFO): SBD MOMSN=11705836
2019-08-28T01:39:59.508Z,1566956399.508 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20190827T222740/Express0106.lzma
2019-08-28T01:40:00.315Z,1566956400.315 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0106.lzma.bak
2019-08-28T01:40:00.315Z,1566956400.315 [DataOverHttps](INFO): SBD MOMSN=11705840
2019-08-28T01:40:02.043Z,1566956402.043 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:40:02.043Z,1566956402.043 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:40:02.043Z,1566956402.043 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:44:43.202Z,1566956683.202 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T01:45:02.633Z,1566956702.633 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:45:02.633Z,1566956702.633 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:45:02.633Z,1566956702.633 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:45:02.634Z,1566956702.634 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:45:03.023Z,1566956703.023 [Default:CheckIn:D] Stopped
2019-08-28T01:45:03.023Z,1566956703.023 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 230.827327 min 
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn:E] Stopped
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn] Stopped
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn](INFO): Running loop #42
2019-08-28T01:45:03.419Z,1566956703.419 [Default:CheckIn] Running Loop=42
2019-08-28T01:45:03.420Z,1566956703.420 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:45:03.420Z,1566956703.420 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:45:05.029Z,1566956705.029 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:45:05.427Z,1566956705.427 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,014221.00,A,4212.99179,N,08344.18432,W,0.952,189.44,280819,,,A*71
2019-08-28T01:45:05.440Z,1566956705.440 [NAL9602](INFO): GPS fix at 20190828T014221: (42.216530, -83.736405)
2019-08-28T01:45:05.463Z,1566956705.463 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:45:05.463Z,1566956705.463 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:45:11.400Z,1566956711.400 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190827T222740/Courier0108.lzma
2019-08-28T01:45:12.206Z,1566956712.206 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Courier0108.lzma.bak
2019-08-28T01:45:12.207Z,1566956712.207 [DataOverHttps](INFO): SBD MOMSN=11705867
2019-08-28T01:45:25.448Z,1566956725.448 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20190827T222740/Express0109.lzma
2019-08-28T01:45:26.254Z,1566956726.254 [DataOverHttps](INFO): Moved sent file to Logs/20190827T222740/Express0109.lzma.bak
2019-08-28T01:45:26.255Z,1566956726.255 [DataOverHttps](INFO): SBD MOMSN=11705870
2019-08-28T01:45:28.099Z,1566956728.099 [Default:CheckIn:Read_Iridium] Stopped
2019-08-28T01:45:28.099Z,1566956728.099 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-28T01:45:28.100Z,1566956728.100 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-28T01:45:37.750Z,1566956737.750 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-28T01:49:36.677Z,1566956976.677 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:50:07.381Z,1566957007.381 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:50:28.669Z,1566957028.669 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-28T01:50:28.669Z,1566957028.669 [Default:CheckIn:C.Wait] Stopped
2019-08-28T01:50:28.669Z,1566957028.669 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-28T01:50:28.669Z,1566957028.669 [Default:CheckIn:D] Running Loop=1
2019-08-28T01:50:29.059Z,1566957029.059 [Default:CheckIn:D] Stopped
2019-08-28T01:50:29.059Z,1566957029.059 [Default:CheckIn:E] Running Loop=1
2019-08-28T01:50:29.458Z,1566957029.458 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 236.261247 min 
2019-08-28T01:50:29.458Z,1566957029.458 [Default:CheckIn:E] Stopped
2019-08-28T01:50:29.458Z,1566957029.458 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-28T01:50:29.458Z,1566957029.458 [Default:CheckIn] Stopped
2019-08-28T01:50:29.458Z,1566957029.458 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-28T01:50:29.458Z,1566957029.458 [Default:CheckIn](INFO): Running loop #43
2019-08-28T01:50:29.459Z,1566957029.459 [Default:CheckIn] Running Loop=43
2019-08-28T01:50:29.459Z,1566957029.459 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-28T01:50:29.459Z,1566957029.459 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-28T01:50:31.065Z,1566957031.065 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:50:38.085Z,1566957038.085 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:51:02.157Z,1566957062.157 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-08-28T01:51:02.241Z,1566957062.241 [NAL9602](FAULT): received: 
+CSQ:0

OK051, 2, 0, 0, 0

OK
2019-08-28T01:51:02.241Z,1566957062.241 [NAL9602] Data Fault, FailCount= 1
2019-08-28T01:51:02.241Z,1566957062.241 [NAL9602](ERROR): Data Fault
2019-08-28T01:51:02.299Z,1566957062.299 [CBIT](ERROR): Data Fault in component: NAL9602
2019-08-28T01:51:02.563Z,1566957062.563 [NAL9602](INFO): Powering down
2019-08-28T01:51:03.399Z,1566957063.399 [CBIT](INFO): Clearing failed state for component NAL9602
2019-08-28T01:51:03.400Z,1566957063.400 [NAL9602] No Fault, FailCount= 1
2019-08-28T01:51:08.789Z,1566957068.789 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:51:32.863Z,1566957092.863 [NAL9602](INFO): Powering up NAL9602
2019-08-28T01:51:39.493Z,1566957099.493 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:51:41.917Z,1566957101.917 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.183792
2019-08-28T01:51:43.776Z,1566957103.776 [NAL9602](INFO): NAL9602 initialized
2019-08-28T01:51:44.588Z,1566957104.588 [NAL9602](DEBUG): Fix Requested
2019-08-28T01:52:40.497Z,1566957160.497 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:53:11.201Z,1566957191.201 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:53:41.905Z,1566957221.905 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:54:12.609Z,1566957252.609 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:54:43.313Z,1566957283.313 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:55:14.017Z,1566957314.017 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:55:29.634Z,1566957329.634 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-08-28T01:50:29.5Z
2019-08-28T01:55:29.635Z,1566957329.635 [Default:CheckIn:Read_GPS] Stopped
2019-08-28T01:55:29.635Z,1566957329.635 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-28T01:55:34.052Z,1566957334.052 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-28T01:55:44.721Z,1566957344.721 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:56:15.425Z,1566957375.425 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:56:46.129Z,1566957406.129 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:57:16.833Z,1566957436.833 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:57:47.537Z,1566957467.537 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:58:18.241Z,1566957498.241 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:58:48.945Z,1566957528.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:59:19.649Z,1566957559.649 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T01:59:50.369Z,1566957590.369 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:00:21.081Z,1566957621.081 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:00:51.785Z,1566957651.785 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:01:22.489Z,1566957682.489 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:01:53.197Z,1566957713.197 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:02:23.901Z,1566957743.901 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:02:54.605Z,1566957774.605 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:03:25.369Z,1566957805.369 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:03:56.073Z,1566957836.073 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:04:26.777Z,1566957866.777 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:04:57.489Z,1566957897.489 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:05:28.193Z,1566957928.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:05:39.310Z,1566957939.310 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C4.
2019-08-28T02:05:39.311Z,1566957939.311 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-28T02:05:39.311Z,1566957939.311 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2019-08-28T02:05:39.314Z,1566957939.314 [BPC1](INFO): Received data from all battery sticks.
2019-08-28T02:05:58.897Z,1566957958.897 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:06:29.621Z,1566957989.621 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:07:00.325Z,1566958020.325 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:07:31.061Z,1566958051.061 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:08:01.773Z,1566958081.773 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:08:32.477Z,1566958112.477 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:09:03.181Z,1566958143.181 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:09:33.885Z,1566958173.885 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:10:04.589Z,1566958204.589 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:10:35.293Z,1566958235.293 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-28T02:10:37.455Z,1566958237.455 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-08-28T02:10:37.455Z,1566958237.455 [DropWeight] Hardware Fault, FailCount= 1
2019-08-28T02:10:37.455Z,1566958237.455 [DropWeight](ERROR): Hardware Fault
2019-08-28T02:10:38.037Z,15669582