1578507 - Intermittent netwerk/test/browser/browser_cross_process_redirect.js | leaked 1 docShell(s) until shutdown

Status: RESOLVED FIXED

(Core :: Networking, defect, P2)

Description

[Treeherder Bug Filer]

Filed by: nerli [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=264783274&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/eFF0KYGTTNe9nYZRNhQG4g/runs/0/artifacts/public/logs/live_backing.log

---

[task 2019-09-03T17:59:52.164Z] 17:59:52 INFO - GECKO(1909) | => mAllocCount: 146721
[task 2019-09-03T17:59:52.164Z] 17:59:52 INFO - GECKO(1909) | => mReallocCount: 3
[task 2019-09-03T17:59:52.164Z] 17:59:52 INFO - GECKO(1909) | => mFreeCount: 146721
[task 2019-09-03T17:59:52.165Z] 17:59:52 INFO - GECKO(1909) | => mShareCount: 176256
[task 2019-09-03T17:59:52.168Z] 17:59:52 INFO - GECKO(1909) | => mAdoptCount: 2912
[task 2019-09-03T17:59:52.168Z] 17:59:52 INFO - GECKO(1909) | => mAdoptFreeCount: 3124
[task 2019-09-03T17:59:52.168Z] 17:59:52 INFO - GECKO(1909) | => Process ID: 1909, Thread ID: 4604151232
[task 2019-09-03T17:59:52.291Z] 17:59:52 INFO - TEST-INFO | Main app process: exit 0
[task 2019-09-03T17:59:52.291Z] 17:59:52 ERROR - TEST-UNEXPECTED-FAIL | netwerk/test/browser/browser_cross_process_redirect.js | leaked 1 docShell(s) until shutdown
[task 2019-09-03T17:59:52.291Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_cross_process_redirect.js | docShell(s) leaked: [pid = 1920] [id = {45e60599-da45-914c-b238-65fea664cb94}]
[task 2019-09-03T17:59:52.291Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_cross_process_redirect.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_cross_process_redirect.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_about_cache.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_about_cache.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_cookie_sync_across_tabs.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_cookie_sync_across_tabs.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_post_file.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_post_file.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.292Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_resource_navigation.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.293Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_resource_navigation.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.293Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_test_favicon.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.293Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_test_favicon.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.293Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_test_io_activity.js | This test created 0 hidden window(s)
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - TEST-INFO | netwerk/test/browser/browser_test_io_activity.js | This test created 1 hidden docshell(s)
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - runtests.py | Application ran for: 0:00:28.964776
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - zombiecheck | Reading PID log: /var/folders/g3/y3shk2v57mdbc0wpymgr90dm000017/T/tmp6WjsTVpidlog
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1910
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1911
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1912
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1913
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1914
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1915
[task 2019-09-03T17:59:52.294Z] 17:59:52 INFO - ==> process 1909 launched child process 1916
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1917
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1918
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1919
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1920
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1921
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1922
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1923
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1924
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1925
[task 2019-09-03T17:59:52.295Z] 17:59:52 INFO - ==> process 1909 launched child process 1926

Comment 1

[Intermittent Failures Robot]

1 failures in 4408 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• macosx1014-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578507&startday=2019-09-02&endday=2019-09-08&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 4637 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1

Platform breakdown:

• linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578507&startday=2019-09-09&endday=2019-09-15&tree=all

Comment 3

[Intermittent Failures Robot]

38 failures in 4292 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

This is the #39 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 29
• mozilla-central: 5
• try: 3
• mozilla-inbound: 1

Platform breakdown:

• windows10-64-qr: 17
• macosx1014-64: 19
• linux64: 1
• windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578507&startday=2019-09-30&endday=2019-10-06&tree=all

Comment 4

[Honza Bambas (:mayhemer)]

Junior, can you also set a priority please?

Comment 5

[Intermittent Failures Robot]

33 failures in 3801 pushes (0.009 failures/push) were associated with this bug in the last 7 days.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-inbound: 1
• autoland: 27
• mozilla-central: 2
• try: 3

Platform breakdown:

• macosx1014-64: 16
• windows10-64-qr: 17

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578507&startday=2019-10-07&endday=2019-10-13&tree=all

Comment 6

[Junior [inactive]]

It's going much higher.
P2 since it should be a misbehavior of test.

I grep the process Id of this and found:

18413:[task 2019-10-06T02:19:22.561Z] 02:19:22     INFO - GECKO(1960) | Completed ShutdownLeaks collections in process 1971
18501:[task 2019-10-06T02:19:26.505Z] 02:19:26     INFO - GECKO(1960) | [Child 1971, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/workspace/build/src/widget/cocoa/nsAppShell.mm, line 725
18504:[task 2019-10-06T02:19:26.532Z] 02:19:26     INFO - GECKO(1960) | --DOCSHELL 0x11a808800 == 1 [pid = 1971] [id = {6bcacd3e-a184-8f40-afee-674d9842b2a7}] [url = https://example.com/browser/netwerk/test/browser/dummy.html]
18505:[task 2019-10-06T02:19:26.557Z] 02:19:26     INFO - GECKO(1960) | --DOCSHELL 0x11a81b000 == 0 [pid = 1971] [id = {1617597e-84c7-f140-90b8-b82c6ca5f8dc}] [url = about:blank]
18515:[task 2019-10-06T02:19:26.595Z] 02:19:26     INFO - GECKO(1960) | --DOMWINDOW == 1 (0x11a84e5c0) [pid = 1971] [serial = 7] [outer = 0x0] [url = about:blank]
18516:[task 2019-10-06T02:19:26.596Z] 02:19:26     INFO - GECKO(1960) | --DOMWINDOW == 0 (0x11b84bc00) [pid = 1971] [serial = 9] [outer = 0x0] [url = about:blank]
18527:[task 2019-10-06T02:19:26.637Z] 02:19:26     INFO - GECKO(1960) |  => Process ID: 1971, Thread ID: 4323403200
18569:[task 2019-10-06T02:19:28.256Z] 02:19:28     INFO - TEST-INFO | netwerk/test/browser/browser_cross_process_redirect.js | docShell(s) leaked: [pid = 1971] [id = {6bcacd3e-a184-8f40-afee-674d9842b2a7}]

Looks like we're release the window successfully, however we end the test too early.
What do you think, valentin?

Comment 7

[Valentin Gosu [:valentin] (he/him)]

This test was supposed to be removed in bug 1576714, but it was backed out.
I'll submit a patch to remove it right away.

Comment 8

[Nika Layzell [:nika] (ni? for response)]

Attachment: Bug 1578507 - Remove browser_cross_process_redirect test

This test was originally written to test HTTPResponseProcessSelection before it
was hooked up into the process switch machinery. It hooks into some parts of the
process switch process which should probably be removed in the future (such as
overriding the child listener component registration), and is broken under
fission anyway.

Comment 9

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/193087eca4e8
Remove browser_cross_process_redirect test r=valentin

Comment 10

[Natalia Csoregi [:nataliaCs]]

https://hg.mozilla.org/mozilla-central/rev/193087eca4e8

Comment 11

[Intermittent Failures Robot]

9 failures in 3964 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 6
• try: 2
• mozilla-beta: 1

Platform breakdown:

• macosx1014-64: 6
• windows10-64-qr: 2
• linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1578507&startday=2019-10-14&endday=2019-10-20&tree=all