1752843 - Intermittent devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_devtoolstoolbox_navigate_reload_button.js | leaked 2 window(s) until shutdown [url = about:devtools-toolbox?id=373&type=tab]

Status: RESOLVED FIXED

(DevTools :: about:debugging, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=366176264&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/AHiGezO4TUKneU1gCOFESQ/runs/0/artifacts/public/logs/live_backing.log

---

[task 2022-01-31T14:09:41.739Z] 14:09:41     INFO - TEST-START | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_workers_remote_runtime.js
[task 2022-01-31T14:09:41.765Z] 14:09:41     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 12b368000 == 16 [pid = 2533] [id = 261]
[task 2022-01-31T14:09:41.766Z] 14:09:41     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 83 (127b1f580) [pid = 2533] [serial = 725] [outer = 0]
[task 2022-01-31T14:09:41.766Z] 14:09:41     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 84 (1301b4800) [pid = 2533] [serial = 726] [outer = 127b1f580]
[task 2022-01-31T14:09:41.777Z] 14:09:41     INFO - GECKO(2533) | [Parent 2533, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-01-31T14:09:41.810Z] 14:09:41     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 85 (1383cec00) [pid = 2533] [serial = 727] [outer = 127b1f580]
[task 2022-01-31T14:09:41.821Z] 14:09:41     INFO - GECKO(2533) | [Parent 2533, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1180
[task 2022-01-31T14:09:42.436Z] 14:09:42     INFO - GECKO(2533) | console.log: MOCKED METHOD once
[task 2022-01-31T14:09:42.437Z] 14:09:42     INFO - GECKO(2533) | console.log: MOCKED METHOD registerListener with mock scanner
<...>
[task 2022-01-31T14:09:56.604Z] 14:09:56     INFO - GECKO(2533) | [Child 2753, Main Thread] WARNING: IPC message 'PIdleScheduler::Msg_DoneGC' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:499
[task 2022-01-31T14:09:56.608Z] 14:09:56     INFO - GECKO(2533) | [Child 2753, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4448
[task 2022-01-31T14:09:56.676Z] 14:09:56     INFO - GECKO(2533) | [Parent 2533, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:362
[task 2022-01-31T14:09:56.678Z] 14:09:56     INFO - GECKO(2533) | [Parent 2533, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:820
[task 2022-01-31T14:09:56.696Z] 14:09:56     INFO - GECKO(2533) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-31T14:09:58.286Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (1323f2740) [pid = 2533] [serial = 245] [outer = 0] [url = about:devtools-toolbox?id=373&type=tab]
[task 2022-01-31T14:09:58.286Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (12b705740) [pid = 2533] [serial = 249] [outer = 0] [url = chrome://devtools/content/inspector/index.xhtml]
[task 2022-01-31T14:09:58.289Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (1396bf800) [pid = 2533] [serial = 248] [outer = 0] [url = about:devtools-toolbox?id=373&type=tab]
[task 2022-01-31T14:09:58.289Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (127b0bc00) [pid = 2533] [serial = 4] [outer = 0] [url = about:blank]
[task 2022-01-31T14:09:58.290Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 9 (10f720900) [pid = 2533] [serial = 3] [outer = 0] [url = chrome://browser/content/browser.xhtml]
[task 2022-01-31T14:09:58.290Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (1335cd200) [pid = 2533] [serial = 9] [outer = 0] [url = chrome://mochikit/content/browser-harness.xhtml]
[task 2022-01-31T14:09:58.291Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 7 (132e17000) [pid = 2533] [serial = 10] [outer = 0] [url = about:blank]
[task 2022-01-31T14:09:58.291Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 6 (11012c000) [pid = 2533] [serial = 729] [outer = 0] [url = about:blank]
[task 2022-01-31T14:09:58.292Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (12a049400) [pid = 2533] [serial = 6] [outer = 0] [url = chrome://extensions/content/dummy.xhtml]
[task 2022-01-31T14:09:58.292Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (10f720c80) [pid = 2533] [serial = 5] [outer = 0] [url = chrome://extensions/content/dummy.xhtml]
[task 2022-01-31T14:09:58.293Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (10f734400) [pid = 2533] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-01-31T14:09:58.293Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (10f720040) [pid = 2533] [serial = 1] [outer = 0] [url = chrome://browser/content/hiddenWindowMac.xhtml]
[task 2022-01-31T14:09:58.294Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (129173e40) [pid = 2533] [serial = 7] [outer = 0] [url = about:blank]
[task 2022-01-31T14:09:58.301Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (13c76e400) [pid = 2533] [serial = 250] [outer = 0] [url = about:blank]
[task 2022-01-31T14:09:58.317Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3351
[task 2022-01-31T14:09:58.363Z] 14:09:58     INFO - GECKO(2533) | [Parent 2533, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4448
[task 2022-01-31T14:09:58.383Z] 14:09:58     INFO - TEST-INFO | Main app process: exit 0
[task 2022-01-31T14:09:58.384Z] 14:09:58     INFO - TEST-INFO | Confirming we saw 404 DOCSHELL created and 404 destroyed log strings.
[task 2022-01-31T14:09:58.384Z] 14:09:58     INFO - TEST-INFO | Confirming we saw 1068 DOMWINDOW created and 1068 destroyed log strings.
[task 2022-01-31T14:09:58.385Z] 14:09:58    ERROR - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_devtoolstoolbox_navigate_reload_button.js | leaked 2 window(s) until shutdown [url = about:devtools-toolbox?id=373&type=tab]
[task 2022-01-31T14:09:58.385Z] 14:09:58    ERROR - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_devtoolstoolbox_navigate_reload_button.js | leaked 1 window(s) until shutdown [url = chrome://devtools/content/inspector/index.xhtml]
[task 2022-01-31T14:09:58.386Z] 14:09:58    ERROR - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_devtoolstoolbox_navigate_reload_button.js | leaked 1 window(s) until shutdown [url = about:blank]
[task 2022-01-31T14:09:58.386Z] 14:09:58     INFO - TEST-INFO | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_devtoolstoolbox_navigate_reload_button.js | windows(s) leaked: [pid = 2533] [serial = 249], [pid = 2533] [serial = 245], [pid = 2533] [serial = 248], [pid = 2533] [serial = 250]
[task 2022-01-31T14:09:58.387Z] 14:09:58     INFO - TEST-INFO | devtools/client/aboutdebugging/test/browser/browser_aboutdebugging_devtoolstoolbox_navigate_reload_button.js | This test created 0 hidden window(s)

Comment 1

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

Any insight what started these failures?

Comment 2

[Narcis Beleuzu [:NarcisB]]

Backfill points to Bug 1751373.
Jan , can you please take a look?

Comment 3

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

That's 1 out of 12 tasks failing - not significant enough to identify the regressing change. But the previous commit modifies aboutdebugging which this test tests.

Comment 4

[Intermittent Failures Robot]

49 failures in 3165 pushes (0.015 failures/push) were associated with this bug in the last 7 days.

This is the #17 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: 36
• mozilla-central: 12
• try: 1

Platform and build breakdown:

• macosx1015-64-qr: 18
  • debug: 18
• windows10-64-2004-qr: 31
  • debug: 31

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1752843&startday=2022-01-31&endday=2022-02-06&tree=all

Comment 5

[Julian Descottes [:jdescottes]]

Attachment: Bug 1752843 - [devtools] Wait for toolbox panels reload and properly close tabs

After fixing the initial failing test by both waiting for DevTools reload propertly and closing all debug tabs, the following test started failing.
Waiting for DevTools to properly update in this test seems to fix the intermittent(s?).

Comment 6

[BugBot [:suhaib / :marco/ :calixte]]

Set release status flags based on info from the regressing bug 1752546

Comment 7

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/f9980efe8889
[devtools] Wait for toolbox panels reload and properly close tabs r=Honza

Comment 8

[Sandor Molnar[:smolnar]]

https://hg.mozilla.org/mozilla-central/rev/f9980efe8889

Comment 9

[Ryan VanderMeulen [:RyanVM]]

https://hg.mozilla.org/releases/mozilla-beta/rev/bb453c1bbc7e

Comment 10

[Intermittent Failures Robot]

10 failures in 3711 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1
• autoland: 9

Platform and build breakdown:

• macosx1015-64-qr: 4
  • debug: 4
• windows10-64-2004-qr: 6
  • debug: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1752843&startday=2022-02-07&endday=2022-02-13&tree=all