Issue 243080 in chromium: Socket hanging/pending issue

[chro...@googlecode.com]

Status: Unconfirmed
Owner: ----
Labels: Cr-Internals-Network Pri-2 Via-Wizard Type-Bug OS-Windows

New issue 243080 by keith.ca...@gmail.com: Socket hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

UserAgent: Mozilla/5.0 (Windows NT 6.1; WOW64; rv:21.0) Gecko/20100101
Firefox/21.0

Example URL:

Steps to reproduce the problem:
1. Navigate to a page with multiple image requests. We've seen this on
pages under https://limeade.com, which requires credentials
2. With some regularity, the page will stop responding. Dev tools shows
(pending) for a certain set of image requests. Those will never complete.
No images after that point will successfully download.

What is the expected behavior?

What went wrong?
Watching net-internals, the consistent error message on these failing
requests is:
URL_REQUEST_BLOCKED_ON_DELEGATE

The other one frequently seen is:
SOCKET_POOL_STALLED_MAX_SOCKETS_PER_GROUP

Reproduced this on Windows 7 & Mac, Chrome versions > 26, including 27,
28.0.1500.20 m, and the 28-dev version (as of 5/22/2013). Reproduced in
Incognito mode, as well.

An example of a failed request from net-internals events:
1614: URL_REQUEST
https://limeade.com/resized-image.ashx/__size/64x64/__key/CommunityServer-Components-SelectableAvatars/ab311774-4c5a-487c-ba35-798ac7dc626b/avatar.png
Start Time: 2013-05-21 12:27:09.133

t=1369164429133 [st= 0] +REQUEST_ALIVE [dt=?]
t=1369164429134 [st= 1] +URL_REQUEST_START_JOB [dt=?]
--> load_flags = 134349056 (ENABLE_LOAD_TIMING
| MAYBE_USER_GESTURE | VERIFY_EV_CERT)
--> method = "GET"
--> priority = 1
--> url
= "https://limeade.com/resized-image.ashx/__size/64x64/__key/CommunityServer-Components-SelectableAvatars/ab311774-4c5a-487c-ba35-798ac7dc626b/avatar.png"
t=1369164429134 [st= 1] HTTP_CACHE_GET_BACKEND [dt=0]
t=1369164429134 [st= 1] HTTP_CACHE_OPEN_ENTRY [dt=0]
t=1369164429134 [st= 1] HTTP_CACHE_ADD_TO_ENTRY [dt=0]
t=1369164429134 [st= 1] HTTP_CACHE_READ_INFO [dt=0]
t=1369164429134 [st= 1] +HTTP_STREAM_REQUEST [dt=510]
t=1369164429644 [st=511] HTTP_STREAM_REQUEST_BOUND_TO_JOB
--> source_dependency = 1616
(HTTP_STREAM_JOB)
t=1369164429644 [st=511] -HTTP_STREAM_REQUEST
t=1369164429644 [st=511] +HTTP_TRANSACTION_SEND_REQUEST [dt=0]
t=1369164429644 [st=511] HTTP_TRANSACTION_SEND_REQUEST_HEADERS
--> GET
/resized-image.ashx/__size/64x64/__key/CommunityServer-Components-SelectableAvatars/ab311774-4c5a-487c-ba35-798ac7dc626b/avatar.png
HTTP/1.1
Host: limeade.com
Connection: keep-alive
User-Agent: Mozilla/5.0 (Windows NT
6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/27.0.1453.93
Safari/537.36
Accept: */*
Referer:
https://limeade.com/Challenges/71295/default.aspx
Accept-Encoding: gzip,deflate,sdch
Accept-Language: en-US,en;q=0.8
Cookie: [1132 bytes were stripped]
t=1369164429644 [st=511] -HTTP_TRANSACTION_SEND_REQUEST
t=1369164429644 [st=511] +HTTP_TRANSACTION_READ_HEADERS [dt=104]
t=1369164429644 [st=511] HTTP_STREAM_PARSER_READ_HEADERS [dt=103]
t=1369164429747 [st=614] HTTP_TRANSACTION_READ_RESPONSE_HEADERS
--> HTTP/1.1 301 Moved Permanently
Cache-Control: public,
no-cache="Set-Cookie"
Expires: Wed, 22 May 2013 19:28:36 GMT
Last-Modified: Tue, 21 May 2013
19:28:36 GMT
ETag: 635047613169143445
Location:
/cfs-filesystemfile.ashx/__key/CommunityServer-Components-SelectableAvatars/ab311774-4c5a-487c-ba35-798ac7dc626b/avatar.png_2D00_64x64.png
Server: Microsoft-IIS/7.5
Telligent-Evolution: 5.5.134.25133
Set-Cookie: [174 bytes were stripped]
X-AspNet-Version: 4.0.30319
WSN: LIMEADEWEB4
X-Powered-By: ASP.NET
Date: Tue, 21 May 2013 19:28:36 GMT
Content-Length: 0
t=1369164429748 [st=615] -HTTP_TRANSACTION_READ_HEADERS
t=1369164429748 [st=615] HTTP_CACHE_WRITE_INFO [dt=0]
t=1369164429748 [st=615] HTTP_CACHE_WRITE_DATA [dt=0]
t=1369164429748 [st=615] HTTP_CACHE_WRITE_INFO [dt=0]
t=1369164429748 [st=615] +URL_REQUEST_BLOCKED_ON_DELEGATE [dt=?]

Did this work before? Yes First noticed mid-April, 2013.

Chrome version: 26.0.1410.64, 26.0.1410.65, 27.0.1453.93 m, 28.0.1500.20
dev-m Channel: stable
OS Version: 6.1 (Windows 7, Windows Server 2008 R2)

This started being noticed around 1 month ago, but has been seen more
recently. The website unfortunately requires a login - we'd be happy to
share desktops or whatever we can to debug.

The image requests that fail are from one of two domains - amazon
cloudfront or our domain. The ones on our domain are from CommunityServer,
and those issue 301's after doing a path lookup. More suspicious of the 301
requests. The page intermittently works fine.

I can produce more net-internals exports if necessary. Thanks.

Attachments:
net-internals-log (4).zip 130 KB

--
You received this message because this project is configured to send all
issue notifications to this address.
You may adjust your notification preferences at:
https://code.google.com/hosting/settings

[chro...@googlecode.com]

Updates:
Labels: Needs-Feedback

Comment #2 on issue 243080 by smok...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

(No comment was entered for this change.)

[chro...@googlecode.com]

Comment #3 on issue 243080 by keith.ca...@gmail.com: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

Sure - thanks for the response. I'll contact you directly with a login
after we've set up a demo site. Should be able to get that to you when I'm
back in the office Tuesday.

[chro...@googlecode.com]

Updates:
Status: Untriaged

Comment #10 on issue 243080 by smok...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

Changing the status as per comment 7

[chro...@googlecode.com]

Comment #11 on issue 243080 by mme...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

This dropped of my radar for a while, and now I can no longer repro on M28
stable or M29 dev. I'm assuming the underlying page was changed, as
opposed to the underlying issue being fixed.

[chro...@googlecode.com]

Comment #13 on issue 243080 by keith.ca...@gmail.com: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

@mmenke - We did patch our code to remove some of the 301 calls. That seems
to be mitigating the issue for us. Before that change went in (2 weeks
ago), the 301's were still causing fairly frequent browser hangs.

[chro...@googlecode.com]

Comment #14 on issue 243080 by cvillaro...@gmail.com: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

I have the same problem in http://uptz.net.ve select "clientes" and then
press the orange buttom "conoce nuestros clientes" as you can see in the
debugger such actions cause URL_REQUEST_BLOCKED_ON_DELEGATE and does no
retrive the server data

any idea?

[chro...@googlecode.com]

Comment #16 on issue 243080 by cvillaro...@gmail.com: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

I have disabled all extensions, however the problem persists, any other
suggestions?

[chro...@googlecode.com]

Comment #18 on issue 243080 by cvillaro...@gmail.com: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

The File.

Attachments:
net-internals-log.json 30.5 KB

[chro...@googlecode.com]

Comment #20 on issue 243080 by cvillaro...@gmail.com: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

I do not know why you can't see the URL_REQUEST_BLOCKED_ON_DELEGATE.
Regularly it happens and the ajax requests are canceled. Sometimes I
recibe this one too:

http://uptz.net.ve/service.php/?json=get_category_posts&id=33
Start Time: 2013-09-16 16:43:36.334

t=1379366016334 [st=0] +REQUEST_ALIVE [dt=1]
t=1379366016335 [st=1] +URL_REQUEST_START_JOB [dt=0]
--> load_flags = 167903488 (ENABLE_LOAD_TIMING |
IGNORE_LIMITS | MAYBE_USER_GESTURE | VERIFY_EV_CERT)

--> method = "GET"
--> priority = 1
--> url

= "http://uptz.net.ve/service.php/?json=get_category_posts&id=33"
t=1379366016335 [st=1] HTTP_CACHE_GET_BACKEND [dt=0]
t=1379366016335 [st=1] HTTP_CACHE_OPEN_ENTRY [dt=0]
t=1379366016335 [st=1] HTTP_CACHE_ADD_TO_ENTRY [dt=0]
t=1379366016335 [st=1] HTTP_CACHE_READ_INFO [dt=0]
t=1379366016335 [st=1] CANCELLED
t=1379366016335 [st=1] -URL_REQUEST_START_JOB
--> net_error = -3 (ERR_ABORTED)
t=1379366016335 [st=1] -REQUEST_ALIVE

[chro...@googlecode.com]

Comment #22 on issue 243080 by cvillaro...@gmail.com: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

thanks! mmenke

[chro...@googlecode.com]

Updates:
Status: Assigned
Owner: mme...@chromium.org
Labels: M-33

Comment #23 on issue 243080 by d...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

Can you just update the bug with any follow up actions? Thanks!

[chro...@googlecode.com]

Updates:
Owner: ---
Labels: -M-33 Cr-Platform-DevTools

Comment #24 on issue 243080 by mme...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

Ideally we'd expose this failure via devtools - I have no idea how
difficult it would be.

[chro...@googlecode.com]

Updates:
Owner: eus...@chromium.org

Comment #26 on issue 243080 by eus...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

(No comment was entered for this change.)

[chro...@googlecode.com]

Comment #27 on issue 243080 by oscar.ba...@digitaldialogue.com.au: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

On Chrome 32, I am seeing the same issue as @bnferguson - blank
URL_REQUESTs begin to appear after a while. Disabling all extensions
doesn't help.

[chro...@googlecode.com]

Comment #28 on issue 243080 by mme...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

Oscar: Could you please follow the instructions here and upload the log
dump?
https://sites.google.com/a/chromium.org/dev/for-testers/providing-network-details
(As a reminder, net-internals must be open while reproducing the issue).

Thanks!

[chro...@googlecode.com]

Comment #29 on issue 243080 by oscar.ba...@digitaldialogue.com.au: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

@mmenke See attached.
I've attached some screenshots as well, from the net-internals waterfall
view and the devtools.

One thing I noticed is that if I restart Chrome then I can't reproduce the
issue straight away. It definitely occurs after the browser has been open
for a few days.
Originally we had this issue on a local site (and reproduced it on multiple
machines). We've now deployed that site to a remote server and the issue
still occurs (again, reproduced on multiple machines). I can provide a link
to the site via email if you'd like.

Attachments:
net-internals-log.json 154 KB
net-internals.jpg 307 KB
devtools.jpg 41.4 KB

[chro...@googlecode.com]

Comment #30 on issue 243080 by eus...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

Recently we've fixed bug with canceled requests in DevTools.

Oscar: please, could you check that those requests still reported
as "(pending)"?

[chro...@googlecode.com]

Comment #32 on issue 243080 by oscar.ba...@digitaldialogue.com.au: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

For what version of Chrome is this DevTools bug fixed (and is there a link
to the bug report)?

I'm currently on 32.0.1700.107 and the requests still get stuck on pending.

[chro...@googlecode.com]

Comment #33 on issue 243080 by mme...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

There's a 6 week release cycle. This will be in Chrome 34, which should be
out in very roughly 6-8 weeks.

[chro...@googlecode.com]

Comment #34 on issue 243080 by oscar.ba...@digitaldialogue.com.au: Socket
hanging/pending issue
http://code.google.com/p/chromium/issues/detail?id=243080

Thanks for the info. I can't reproduce it in Chrome 34.

[chro...@googlecode.com]

Updates:
Status: Fixed
Labels: -Via-Wizard -OS-Windows -Needs-Feedback

Comment #35 on issue 243080 by eus...@chromium.org: Socket hanging/pending
issue
http://code.google.com/p/chromium/issues/detail?id=243080

(No comment was entered for this change.)

[chro...@googlecode.com]

Comment #36 on issue 243080 by jus...@ziibra.com: Socket hanging/pending
issue
https://code.google.com/p/chromium/issues/detail?id=243080

I am getting the same issues on our site with multiple large image and
video loads. Has this issue reappeared. Using Chrome Version 37.0.2062.124
on Windows 8.

[chro...@googlecode.com]

Comment #37 on issue 243080 by sezerdul...@gmail.com: Socket
hanging/pending issue
https://code.google.com/p/chromium/issues/detail?id=243080

anyone solved this issue?