Bug 1499825 Comment 14 Edit History

Note: The actual edited comment in the bug view page will always show the original commenter’s name and original timestamp.

Original comment by
on 
(In reply to rex from comment #13)

> Created attachment 9034842 [details]
> log.txt-main.9860
> 
> Aha! I started the log right before attempting to connect to CNN.com, received the "can't connect to the server" page, and stopped logging.


Thank you.

Looks like your local resolver has an issue:

2019-01-07 22:07:23.681 ⁃ nsHttpChannel ⁃ 7f7450f0a800 ⁃ finished ⁃ status=804b001e ⁃ http-status=n/a ⁃ url=https://www.cnn.com/
2019-01-07 22:07:23.691 ⁃ nsSocketTransport ⁃ 7f74521a4c00 ⁃ released ⁃ origin=www.cnn.com:443
2019-01-07 22:07:23.691473 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport creating nsSocketTransport @0x7f74521a4c00
2019-01-07 22:07:23.691482 UTC - [Parent 9860: Socket Thread]: E/nsSocketTransport nsSocketTransport::Init [this=0x7f74521a4c00 host=www.cnn.com:443 origin=www.cnn.com:443 proxy=:0]
2019-01-07 22:07:23.691500 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::SetConnectionFlags 0x7f74521a4c00 flags=0
  flags = 0
2019-01-07 22:07:23.691525 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OpenOutputStream [this=0x7f74521a4c00 flags=2]
2019-01-07 22:07:23.691533 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::PostEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
2019-01-07 22:07:23.691557 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OpenInputStream [this=0x7f74521a4c00 flags=2]
2019-01-07 22:07:23.691565 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::PostEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
nsHalfOpenSocket @7f7454d67ae0 --> nsSocketTransport @7f74521a4c00
2019-01-07 22:07:23.692309 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OnSocketEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
2019-01-07 22:07:23.692324 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::ResolveHost [this=0x7f74521a4c00 www.cnn.com:443]
2019-01-07 22:07:23.692335 UTC - [Parent 9860: Socket Thread]: E/nsSocketTransport nsSocketTransport::SendStatus [this=0x7f74521a4c00 status=804b0003]
  804b0003 = STATUS_RESOLVING
2019-01-07 22:07:23.692 ⁃ nsHostResolver ⁃ log.txt-main!nsHostResolver::service ⁃ service
2019-01-07 22:07:23.692387 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver Resolving host [www.cnn.com] type 0. [this=0x7f748678ceb0]
2019-01-07 22:07:23.692414 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver   No usable record in cache for host [www.cnn.com] type 0.
2019-01-07 22:07:23.692460 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver   DNS thread counters: total=2 any-live=0 idle=2 pending=1
2019-01-07 22:07:23.692484 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver   DNS lookup for host [www.cnn.com] blocking pending 'getaddrinfo' or trr query: callback [0x7f7454e6b700]
2019-01-07 22:07:23.692506 UTC - [Parent 9860: DNS Resolver #2]: E/nsHostResolver DNS lookup thread - Calling getaddrinfo for host [www.cnn.com].
2019-01-07 22:07:23.692511 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OnSocketEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
2019-01-07 22:07:23.692641 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver Calling 'res_ninit'.
2019-01-07 22:07:23.692738 UTC - [Parent 9860: DNS Resolver #2]: E/nsHostResolver DNS lookup thread - lookup completed for host [www.cnn.com]: failure: unknown host.
2019-01-07 22:07:23.692771 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver nsHostResolver::CompleteLookup www.cnn.com (nil) 804B001E trr=0 stillResolving=0
2019-01-07 22:07:23.692822 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver nsHostResolver record 0x7f7466ac4580 new gencnt
2019-01-07 22:07:23.692849 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver Caching host [www.cnn.com] negative record for 60 seconds.
2019-01-07 22:07:23.692903 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver CompleteLookup: www.cnn.com has NO address
2019-01-07 22:07:23.692939 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver nsHostResolver record 0x7f7466ac4580 calling back dns users
2019-01-07 22:07:23.693519 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OnLookupComplete: this=0x7f74521a4c00 status 804b001e.


I can see "DNS lookup thread - lookup completed for host [www.cnn.com]: failure: unknown host." from the call to getaddrinfo, which is even called twice (getaddrinfo, res_ninit, getaddrinfo).

If you open a terminal (command prompt) and do `nslookup www.cnn.com` what result do you get?

What exactly is your local DNS setting?
Revision 1 by
on 
(In reply to rex from comment #13)

> Created attachment 9034842 [details]
> log.txt-main.9860
> 
> Aha! I started the log right before attempting to connect to CNN.com, received the "can't connect to the server" page, and stopped logging.


Thank you.

Looks like your local resolver has an issue:

```
2019-01-07 22:07:23.681 ⁃ nsHttpChannel ⁃ 7f7450f0a800 ⁃ finished ⁃ status=804b001e ⁃ http-status=n/a ⁃ url=https://www.cnn.com/
2019-01-07 22:07:23.691 ⁃ nsSocketTransport ⁃ 7f74521a4c00 ⁃ released ⁃ origin=www.cnn.com:443
2019-01-07 22:07:23.691473 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport creating nsSocketTransport @0x7f74521a4c00
2019-01-07 22:07:23.691482 UTC - [Parent 9860: Socket Thread]: E/nsSocketTransport nsSocketTransport::Init [this=0x7f74521a4c00 host=www.cnn.com:443 origin=www.cnn.com:443 proxy=:0]
2019-01-07 22:07:23.691500 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::SetConnectionFlags 0x7f74521a4c00 flags=0
  flags = 0
2019-01-07 22:07:23.691525 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OpenOutputStream [this=0x7f74521a4c00 flags=2]
2019-01-07 22:07:23.691533 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::PostEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
2019-01-07 22:07:23.691557 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OpenInputStream [this=0x7f74521a4c00 flags=2]
2019-01-07 22:07:23.691565 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::PostEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
nsHalfOpenSocket @7f7454d67ae0 --> nsSocketTransport @7f74521a4c00
2019-01-07 22:07:23.692309 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OnSocketEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
2019-01-07 22:07:23.692324 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::ResolveHost [this=0x7f74521a4c00 www.cnn.com:443]
2019-01-07 22:07:23.692335 UTC - [Parent 9860: Socket Thread]: E/nsSocketTransport nsSocketTransport::SendStatus [this=0x7f74521a4c00 status=804b0003]
  804b0003 = STATUS_RESOLVING
2019-01-07 22:07:23.692 ⁃ nsHostResolver ⁃ log.txt-main!nsHostResolver::service ⁃ service
2019-01-07 22:07:23.692387 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver Resolving host [www.cnn.com] type 0. [this=0x7f748678ceb0]
2019-01-07 22:07:23.692414 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver   No usable record in cache for host [www.cnn.com] type 0.
2019-01-07 22:07:23.692460 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver   DNS thread counters: total=2 any-live=0 idle=2 pending=1
2019-01-07 22:07:23.692484 UTC - [Parent 9860: Socket Thread]: D/nsHostResolver   DNS lookup for host [www.cnn.com] blocking pending 'getaddrinfo' or trr query: callback [0x7f7454e6b700]
2019-01-07 22:07:23.692506 UTC - [Parent 9860: DNS Resolver #2]: E/nsHostResolver DNS lookup thread - Calling getaddrinfo for host [www.cnn.com].
2019-01-07 22:07:23.692511 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OnSocketEvent [this=0x7f74521a4c00 type=0 status=0 param=(nil)]
2019-01-07 22:07:23.692641 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver Calling 'res_ninit'.
2019-01-07 22:07:23.692738 UTC - [Parent 9860: DNS Resolver #2]: E/nsHostResolver DNS lookup thread - lookup completed for host [www.cnn.com]: failure: unknown host.
2019-01-07 22:07:23.692771 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver nsHostResolver::CompleteLookup www.cnn.com (nil) 804B001E trr=0 stillResolving=0
2019-01-07 22:07:23.692822 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver nsHostResolver record 0x7f7466ac4580 new gencnt
2019-01-07 22:07:23.692849 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver Caching host [www.cnn.com] negative record for 60 seconds.
2019-01-07 22:07:23.692903 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver CompleteLookup: www.cnn.com has NO address
2019-01-07 22:07:23.692939 UTC - [Parent 9860: DNS Resolver #2]: D/nsHostResolver nsHostResolver record 0x7f7466ac4580 calling back dns users
2019-01-07 22:07:23.693519 UTC - [Parent 9860: Socket Thread]: D/nsSocketTransport nsSocketTransport::OnLookupComplete: this=0x7f74521a4c00 status 804b001e.
```


I can see "DNS lookup thread - lookup completed for host [www.cnn.com]: failure: unknown host." from the call to getaddrinfo, which is even called twice (getaddrinfo, res_ninit, getaddrinfo).

If you open a terminal (command prompt) and do `nslookup www.cnn.com` what result do you get?

What exactly is your local DNS setting?

Back to Bug 1499825 Comment 14