Issue 146646 in chromium: SOCKET_POOL_STALLED_MAX_SOCKETS causing timeouts with spdy proxy

[chro...@googlecode.com]

Status: Unconfirmed
Owner: ----
Labels: OS-Linux Area-Undefined Type-Bug Pri-2

New issue 146646 by sgade...@google.com: SOCKET_POOL_STALLED_MAX_SOCKETS
causing timeouts with spdy proxy
http://code.google.com/p/chromium/issues/detail?id=146646

Chrome Version : 22.0.1229.26
OS Version: Mac OS X Mountain Lion
URLs (if applicable) :

What steps will reproduce the problem?
1. Set browser to a SPDY proxy.
2. Open tabs, with gmail, calendar, google groups, plus.google.com and few
others.
3. Close Chrome make sure you reopen the browser with the previously opened
tabs.
4. Open Chrome and a new tab go to any url watch Chrome just hanging
at 'Sending request...'


What is the expected result?

Open web page quickly.


What happens instead?
Page hangs at 'sending request.'

Following is the Chrome:net-internals output captured when it happens.

t=1346882567119 [st=0] +HTTP_STREAM_JOB [dt=1]
--> original_url = "https://cs.corp.google.com/"
--> url = "https://cs.corp.google.com/"
t=1346882567119 [st=0] +PROXY_SERVICE [dt=1]
t=1346882567119 [st=0] SUBMITTED_TO_RESOLVER_THREAD
--> thread_number = 1
t=1346882567120 [st=1] PROXY_SERVICE_RESOLVED_PROXY_LIST
--> pac_string = "HTTPS
spdy-proxy.ext.google.com:443"
t=1346882567120 [st=1] -PROXY_SERVICE
t=1346882567120 [st=1] HOST_RESOLVER_IMPL [dt=0]
--> source_dependency = 8332
(HOST_RESOLVER_IMPL_REQUEST)
t=1346882567120 [st=1] +SOCKET_POOL_CONNECTING_N_SOCKETS [dt=0]
--> num_sockets = 1
t=1346882567120 [st=1] SOCKET_POOL_STALLED_MAX_SOCKETS
t=1346882567120 [st=1] -SOCKET_POOL_CONNECTING_N_SOCKETS
t=1346882567120 [st=1] -HTTP_STREAM_JOB

transport_socket_pool 0 0 0 256 6 0
ssl_socket_pool 0 0 0 256 6 0
spdy-proxy.ext.google.com:443 (http_proxy_socket_pool) 32 0
0 32 6 0
spdy-proxy.ext.google.com:443
(http_proxy_socket_pool)->transport_socket_pool 0 0 0
32 6 0
spdy-proxy.ext.google.com:443 (http_proxy_socket_pool)->ssl_socket_pool
1 0 0 32 6 0
spdy-proxy.ext.google.com:443
(http_proxy_socket_pool)->ssl_socket_pool->transport_socket_pool 1
0 0 32 6 0
spdy-proxy.ext.google.com:443 (socks_socket_pool) 0 0
0 32 6 0
spdy-proxy.ext.google.com:443
(socks_socket_pool)->transport_socket_pool 0 0 0
32 6 0
spdy-proxy.ext.google.com:443 (ssl_socket_pool_for_proxies) 32
0 0 32 6 0
spdy-proxy.ext.google.com:6121 (http_proxy_socket_pool) 2 0
0 32 6 0
spdy-proxy.ext.google.com:6121
(http_proxy_socket_pool)->transport_socket_pool 0 0 0
32 6 0
spdy-proxy.ext.google.com:6121
(http_proxy_socket_pool)->ssl_socket_pool 1 0 0
32 6 0
spdy-proxy.ext.google.com:6121
(http_proxy_socket_pool)->ssl_socket_pool->transport_socket_pool 1
0 0 32 6 0
spdy-proxy.ext.google.com:6121 (socks_socket_pool) 0 0
0 32 6 0
spdy-proxy.ext.google.com:6121
(socks_socket_pool)->transport_socket_pool 0 0 0
32 6 0
spdy-proxy.ext.google.com:6121 (ssl_socket_pool_for_proxies) 1
0 0 32 6 0

spdy-proxy.ext.google.com:443 (http_proxy_socket_pool)
Name Pending Top Priority Active Idle Connect Jobs Backup
Job Stalled
ssl/0.drive.google.com:443 0 - 1 0 0
false false
ssl/accounts.google.com:443 0 - 1 0 0
false false
ssl/ad.doubleclick.net:443 0 - 1 0 0
false false
ssl/apis.google.com:443 0 - 0 0 0 false
false
ssl/b.corp.google.com:443 0 - 1 0 0
false false
ssl/chatenabled.mail.google.com:443 0 - 1 0
0 false false
ssl/clients2.google.com:443 0 - 1 0 0
false false
ssl/clients2.googleusercontent.com:443 0 - 1 0
0 false false
ssl/clients4.google.com:443 0 - 1 0 0
false false
ssl/critique.corp.google.com:443 0 - 1 0
0 false false
ssl/csi.gstatic.com:443 0 - 1 0 0 false
false
ssl/docs.google.com:443 0 - 1 0 0 false
false
ssl/drive.google.com:443 0 - 1 0 0
false false
ssl/fonts.googleapis.com:443 0 - 1 0 0
false false
ssl/googleads.g.doubleclick.net:443 0 - 1 0
0 false false
ssl/groups.google.com:443 0 - 1 0 0
false false
ssl/images-oz-opensocial.googleusercontent.com:443 0 -
0 0 0 false false
ssl/images1-focus-opensocial.googleusercontent.com:443 0 -
1 0 0 false false
ssl/images1-hangout-opensocial.googleusercontent.com:443 0
- 0 0 0 false false
ssl/images2-focus-opensocial.googleusercontent.com:443 0 -
1 0 0 false false
ssl/images2-hangout-opensocial.googleusercontent.com:443 0
- 0 0 0 false false
ssl/images3-hangout-opensocial.googleusercontent.com:443 0
- 0 0 0 false false
ssl/lh3.googleusercontent.com:443 0 - 1 0
0 false false
ssl/lh4.googleusercontent.com:443 0 - 1 0
0 false false
ssl/lh5.googleusercontent.com:443 0 - 1 0
0 false false
ssl/lh6.googleusercontent.com:443 0 - 1 0
0 false false
ssl/mail-attachment.googleusercontent.com:443 0 - 1
0 0 false false
ssl/mail.google.com:443 0 - 1 0 0 false
false
ssl/plus.google.com:443 0 - 1 0 0 false
false
ssl/plus.sandbox.google.com:443 0 - 1 0 0
false false
ssl/remedyweb.corp.google.com:443 0 - 0 0
0 false false
ssl/s2.googleusercontent.com:443 0 - 1 0
0 false false
ssl/ssl.google-analytics.com:443 0 - 1 0
0 false false
ssl/ssl.gstatic.com:443 0 - 1 0 0 false
false
ssl/static.googleusercontent.com:443 0 - 1 0
0 false false
ssl/talkgadget.google.com:443 0 - 1 0 0
false false
ssl/www.corp.google.com:443 0 - 0 0 0
false false
ssl/www.google.com:443 0 - 1 0 0 false
false
ssl/www.googleadservices.com:443 0 - 1 0
0 false false


spdy-proxy.ext.google.com:443 (ssl_socket_pool_for_proxies)
Name Pending Top Priority Active Idle Connect Jobs Backup
Job Stalled
ssl/0.drive.google.com:443 0 - 1 0 0
false false
ssl/accounts.google.com:443 0 - 1 0 0
false false
ssl/ad.doubleclick.net:443 0 - 1 0 0
false false
ssl/b.corp.google.com:443 0 - 1 0 0
false false
ssl/chatenabled.mail.google.com:443 0 - 1 0
0 false false
ssl/clients2.google.com:443 0 - 1 0 0
false false
ssl/clients2.googleusercontent.com:443 0 - 1 0
0 false false
ssl/clients4.google.com:443 0 - 1 0 0
false false
ssl/critique.corp.google.com:443 0 - 1 0
0 false false
ssl/cs.corp.google.com:443 1 4 0 0 0
false true
ssl/csi.gstatic.com:443 0 - 1 0 0 false
false
ssl/docs.google.com:443 0 - 1 0 0 false
false
ssl/drive.google.com:443 0 - 1 0 0
false false
ssl/fonts.googleapis.com:443 0 - 1 0 0
false false
ssl/gg.google.com:443 0 - 1 0 0 false
false
ssl/googleads.g.doubleclick.net:443 0 - 1 0
0 false false
ssl/groups.google.com:443 0 - 1 0 0
false false
ssl/images1-focus-opensocial.googleusercontent.com:443 0 -
1 0 0 false false
ssl/images2-focus-opensocial.googleusercontent.com:443 0 -
1 0 0 false false
ssl/lh3.googleusercontent.com:443 0 - 1 0
0 false false
ssl/lh4.googleusercontent.com:443 0 - 1 0
0 false false
ssl/lh5.googleusercontent.com:443 1 1 0 0
0 false true
ssl/lh6.googleusercontent.com:443 0 - 1 0
0 false false
ssl/mail-attachment.googleusercontent.com:443 0 - 1
0 0 false false
ssl/mail.google.com:443 0 - 1 0 0 false
false
ssl/p5-fc6jmsjnohb6k-p6jcgad2pyb5bq54-497819-i1-v6exp3-v4.metric.gstatic.com:443
1
1 0 0 0 false true
ssl/p5-fc6jmsjnohb6k-p6jcgad2pyb5bq54-497819-i2-v6exp3-ds.metric.gstatic.com:443
1
1 0 0 0 false true
ssl/p5-fc6jmsjnohb6k-p6jcgad2pyb5bq54-497819-s1-v6exp3-v4.metric.gstatic.com:443
1
1 0 0 0 false true
ssl/p5-mpv2skx64hy52-wtn54ojck25zmoy3-239684-i1-v6exp3-v4.metric.gstatic.com:443
1
1 0 0 0 false true
ssl/p5-mpv2skx64hy52-wtn54ojck25zmoy3-239684-i2-v6exp3-ds.metric.gstatic.com:443
1
1 0 0 0 false true
ssl/p5-mpv2skx64hy52-wtn54ojck25zmoy3-239684-s1-v6exp3-v4.metric.gstatic.com:443
1
1 0 0 0 false true
ssl/plus.google.com:443 0 - 1 0 0 false
false
ssl/plus.sandbox.google.com:443 0 - 1 0 0
false false
ssl/remedyweb.corp.google.com:443 1 1 0 0
0 false true
ssl/s2.googleusercontent.com:443 0 - 1 0
0 false false
ssl/ssl.google-analytics.com:443 0 - 1 0
0 false false
ssl/ssl.gstatic.com:443 0 - 1 0 0 false
false
ssl/static.googleusercontent.com:443 0 - 1 0
0 false false
ssl/talkgadget.google.com:443 0 - 1 0 0
false false
ssl/www.google.com:443 0 - 1 0 0 false
false
ssl/www.googleadservices.com:443 0 - 1 0
0 false false

[chro...@googlecode.com]

Comment #1 on issue 146646 by b...@google.com:

SOCKET_POOL_STALLED_MAX_SOCKETS causing timeouts with spdy proxy
http://code.google.com/p/chromium/issues/detail?id=146646

As above showing the multiple sockets to the HTTPS proxy, while SPDY was
enabled

Attachments:
net-internals-log.json 286 KB

[chro...@googlecode.com]

Updates:
Status: Assigned
Owner: will...@chromium.org
Labels: -Area-Undefined Area-Internals Internals-Network

Comment #2 on issue 146646 by w...@chromium.org:

SOCKET_POOL_STALLED_MAX_SOCKETS causing timeouts with spdy proxy
http://code.google.com/p/chromium/issues/detail?id=146646

willchan: could you take a look at this? Thanks.

[chro...@googlecode.com]

Updates:
Labels: -Internals-Network Internals-Network-SPDY

Comment #3 on issue 146646 by will...@chromium.org:

SOCKET_POOL_STALLED_MAX_SOCKETS causing timeouts with spdy proxy
http://code.google.com/p/chromium/issues/detail?id=146646

It looks to me like
https://code.google.com/p/chromium/issues/detail?id=92244 is the root
cause. In addiction, it's quite sad to me that we aren't doing a better job
doing SPDY connection sharing. This looks sad :(