1389037 - Getting connection timeouts after downloading some Blobs and switching tab

Status: RESOLVED WORKSFORME

(Core :: Networking: HTTP, defect, P2)

Description

[Martin Vobruba]

User Agent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/59.0.3071.115 Safari/537.36

Steps to reproduce:

1) Go to https://stat-info.cz/firefox.html
2) Select 2MB Blob size and 8000+ Blobs
3) Wait for downloading of ~1000 Blobs at least
4) Try to open new tab and navigate to some URL


Actual results:

I was doing some tests because of bug #1373222 on Mac OSX 10.12.6 and I recorder this weird behavior: https://youtu.be/daUd3NKAm5g

In time ~20:30 I tried to open new tab, navigated to amazon website and suddenly my internet connection stopped working in Firefox (watch the connection speed meter) and I get connection timeout for every website I try (see ~23:40).

At the end of the video ~25:00 Firefox tries to check for updates but it seems not working either.


Expected results:

No connection problems

Comment 1

[Martin Vobruba]

Reproduced also in Firefox 56.0b1 on Mac OSX 10.12.6

Comment 2

[u408661]

ni? Jason to find someone who can look at this

Comment 3

[Firefox Bug Husbandry Bot]

Bulk change to priority: https://bugzilla.mozilla.org/show_bug.cgi?id=1399258

Comment 4

[Jason Duell]

swu: any chance you can find someone to try to duplicate this?  If this is common we'll need to fix soon.

Comment 5

[Shian-Yow Wu [:swu]]

Kershaw can take a look at it.

Comment 6

[Kershaw Chang [:kershaw]]

I've tried several times, but without luck to reproduce this.

Hi Martin,

Could you try to reproduce this again and also get the http log? It'd be great if we can have the log to take a look.
https://developer.mozilla.org/en-US/docs/Mozilla/Debugging/HTTP_logging

Thanks.

Comment 7

[Martin Vobruba]

Attachment: HTTP log (zipped)

Is this the log you need?

Comment 8

[Kershaw Chang [:kershaw]]

I saw a lot of "PR_Poll error [-5987] os error [22]" in the http log, and it looks like there is no new http request being created.

Dragana, do you have any idea?

Comment 9

[Dragana Damjanovic [:dragana]]

code 22 is is:

#define EINVAL          22      /* Invalid argument */

for some reason the poll argument is not correct.

It would be good to capture when this occurs for the first time and to see why poll parameters are wrong.

Can you also urn on nspr io logging:

export NSPR_LOG_MODULES=timestamp,io:5
export NSPR_LOG_FILE=/tmp/nspr_log.txt

The nspr does not log a lot, so it may be that I do not see anything :(. But if will be a good next step to take a look at this log.

Martin, can you reproduce the issue with nspr logging as well? Thank you!

Comment 10

[Martin Vobruba]

I've reproduced it again, nspr log file was created but nothing was written to it.

Commands I used:

export MOZ_LOG=timestamp,rotate:200,nsHttp:5,nsSocketTransport:5,nsStreamPump:5,nsHostResolver:5
export MOZ_LOG_FILE=~/Desktop/FF/log.txt
export NSPR_LOG_MODULES=timestamp,io:5
export NSPR_LOG_FILE=~/Desktop/FF/nspr_log.txt
cd /Applications/Firefox.app/Contents/MacOS
./firefox-bin

Comment 11

[Dragana Damjanovic [:dragana]]

My apologies I forgot that that nspr logging only works on debug build.

Do you mind downloading debug build from:
https://queue.taskcluster.net/v1/task/Y992JAGOQUG_tFjW--dssg/runs/0/artifacts/public/build/target.dmg

you can also start it with '-P' to create a new profile so that it is not using your old profile.

Comment 12

[Martin Vobruba]

Reproduced with the nightly debug build but nspr log is still empty.

export MOZ_LOG=timestamp,rotate:200,nsHttp:5,nsSocketTransport:5,nsStreamPump:5,nsHostResolver:5
export MOZ_LOG_FILE=~/Desktop/FF/log.txt
export NSPR_LOG_MODULES=timestamp,io:5
export NSPR_LOG_FILE=~/Desktop/FF/nspr_log.txt
cd /Applications/NightlyDebug.app/Contents/MacOS/
./firefox-bin -P

Am I doing something wrong?

Here you can download log files from my test: https://mab.to/GvqkQjf5H

Comment 13

[Martin Vobruba]

Looks like I can't reproduce the issue anymore after upgrading macOS to 10.13.1.

Comment 14

[Dragana Damjanovic [:dragana]]

I cannot conclude anything from the log and the issue is not reproducible.

Comment 15

[Martin Vobruba]

Hi, I can reproduce the issue again (FF 60.0.1, macOS 10.13.4). This time I can reproduce it not even on a real Mac but also using macOS installed in VirtualBox.

Steps to reproduce:

1) Open tab #1 and navigate to https://stat-info.cz/firefox.html
2) Configure the test:
 - Blob URL: leave unchanged (I use URL from local network for higher download speed)
 - Blob size: 2 MB
 - Count: 5 000 Blobs
3) Start test!
4) Open tab #2 and navigate to some random URL (I use https://www.wikipedia.org )
5) Switch to tab #1 and wait until you download 1000-1500 Blobs
6) Switch to tab #2 and reload it. FF is from now unable to create any connection for some period of time. Tab #2 will end with timeout and after that the download will continue until another reload.

Comment 16

[Daniel Stenberg [:bagder]]

Martin, do you happen to know if you're downloading all those blobs over HTTP/2?

Comment 17

[Martin Vobruba]

My test from local network is over HTTP/1.1

Comment 18

[Honza Bambas (:mayhemer)]

https://stat-info.cz is h2.

Comment 19

[Martin Vobruba]

Just to clarify. Blobs will be downloaded over HTTP/2 if you leave Blob URL unchanged. My tests on local network were over HTTP/1. In both cases I can reproduce the issue.

Comment 20

[Dragana Damjanovic [:dragana]]

I can reproduce this. I will try to debug it.

Comment 21

[Kershaw Chang [:kershaw]]

Not actively working on this one.
I was wondering if we still have this issue.

Comment 22

[Kershaw Chang [:kershaw]]

I've tested this again, but I still can't reproduce this.
Martin, are you still able to reproduce this? If yes, could you try to record the http log again?
Thanks.

Comment 23

[Martin Vobruba]

I can't reproduce this issue anymore using Firefox version 113.0 on macOS 13.3.1 (a).

Comment 24

[Kershaw Chang [:kershaw]]

(In reply to Martin Vobruba from comment #23)

I can't reproduce this issue anymore using Firefox version 113.0 on macOS 13.3.1 (a).

Thanks.