Closed Bug 1767587 Opened 2 years ago Closed 2 years ago

Intermittent TV devtools/client/styleeditor/test/browser_styleeditor_filter.js | leaked 2 window(s) until shutdown [url = about:devtools-toolbox]

Categories

(DevTools :: Style Editor, defect, P5)

Product:
DevTools
Component:
Style Editor
Type:
defect

Tracking

(firefox-esr91 unaffected, firefox100 unaffected, firefox101 unaffected, firefox102 affected)

Status:
RESOLVED INCOMPLETE
Tracking Flags:
Tracking Status
firefox-esr91 --- unaffected
firefox100 --- unaffected
firefox101 --- unaffected
firefox102 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=376770894&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TXfFyHR0R5iPe07nSrjjuQ/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TXfFyHR0R5iPe07nSrjjuQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2022-05-04T06:37:37.521Z] 06:37:37     INFO - GECKO(1552) | [Parent 1552: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (117ccdc00) [pid = 1552] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-05-04T06:37:37.522Z] 06:37:37     INFO - GECKO(1552) | [Parent 1552: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10a73c820) [pid = 1552] [serial = 8] [outer = 0] [url = about:blank]
[task 2022-05-04T06:37:37.522Z] 06:37:37     INFO - GECKO(1552) | [Parent 1552: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (13fcfba90) [pid = 1552] [serial = 165] [outer = 0] [url = about:devtools-toolbox]
[task 2022-05-04T06:37:37.536Z] 06:37:37     INFO - GECKO(1552) | [Parent 1552, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-05-04T06:37:37.548Z] 06:37:37     INFO - GECKO(1552) | [Parent 1552, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-05-04T06:37:37.566Z] 06:37:37     INFO - GECKO(1552) | [Parent 1552, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4571
[task 2022-05-04T06:37:37.586Z] 06:37:37     INFO - TEST-INFO | Main app process: exit 0
[task 2022-05-04T06:37:37.587Z] 06:37:37     INFO - TEST-INFO | Confirming we saw 114 DOCSHELL created and 114 destroyed log strings.
[task 2022-05-04T06:37:37.587Z] 06:37:37     INFO - TEST-INFO | Confirming we saw 280 DOMWINDOW created and 280 destroyed log strings.
[task 2022-05-04T06:37:37.588Z] 06:37:37    ERROR - TEST-UNEXPECTED-FAIL | devtools/client/styleeditor/test/browser_styleeditor_filter.js | leaked 2 window(s) until shutdown [url = about:devtools-toolbox]
[task 2022-05-04T06:37:37.588Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | windows(s) leaked: [pid = 1552] [serial = 165], [pid = 1552] [serial = 167]
[task 2022-05-04T06:37:37.589Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.589Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.589Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.590Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.590Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.591Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.591Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.591Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.592Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.592Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.593Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.593Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.594Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.594Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.595Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.595Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.596Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.596Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.596Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 0 hidden window(s)
[task 2022-05-04T06:37:37.597Z] 06:37:37     INFO - TEST-INFO | devtools/client/styleeditor/test/browser_styleeditor_filter.js | This test created 1 hidden docshell(s)
[task 2022-05-04T06:37:37.597Z] 06:37:37     INFO - runtests.py | Application ran for: 0:08:39.585926
[task 2022-05-04T06:37:37.598Z] 06:37:37     INFO - zombiecheck | Reading PID log: /var/folders/ph/mplszy552x733kh_2m2kvx0h000014/T/tmptx9kba00pidlog
[task 2022-05-04T06:37:37.598Z] 06:37:37     INFO - ==> process 1552 launched child process 1561
[task 2022-05-04T06:37:37.598Z] 06:37:37     INFO - ==> process 1552 launched child process 1566
[task 2022-05-04T06:37:37.599Z] 06:37:37     INFO - ==> process 1552 launched child process 1571
[task 2022-05-04T06:37:37.599Z] 06:37:37     INFO - ==> process 1552 launched child process 1572
[task 2022-05-04T06:37:37.599Z] 06:37:37     INFO - ==> process 1552 launched child process 1573
[task 2022-05-04T06:37:37.599Z] 06:37:37     INFO - ==> process 1552 launched child process 1574
[task 2022-05-04T06:37:37.600Z] 06:37:37     INFO - ==> process 1552 launched child process 1579
[task 2022-05-04T06:37:37.600Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1571
[task 2022-05-04T06:37:37.600Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1572
[task 2022-05-04T06:37:37.601Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1573
[task 2022-05-04T06:37:37.601Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1574
[task 2022-05-04T06:37:37.601Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1579
[task 2022-05-04T06:37:37.602Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1561
[task 2022-05-04T06:37:37.602Z] 06:37:37     INFO - zombiecheck | Checking for orphan process with PID: 1566
[task 2022-05-04T06:37:37.602Z] 06:37:37     INFO - Stopping web server
[task 2022-05-04T06:37:37.603Z] 06:37:37     INFO - Server shut down.
[task 2022-05-04T06:37:37.683Z] 06:37:37     INFO - Web server killed.
[task 2022-05-04T06:37:37.683Z] 06:37:37     INFO - Stopping web socket server
[task 2022-05-04T06:37:37.770Z] 06:37:37     INFO - Stopping ssltunnel
[task 2022-05-04T06:37:37.840Z] 06:37:37     INFO - leakcheck | Processing log file /var/folders/ph/mplszy552x733kh_2m2kvx0h000014/T/tmpvy75eata.mozrunner/runtests_leaks.log
[task 2022-05-04T06:37:37.840Z] 06:37:37     INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.841Z] 06:37:37     INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.841Z] 06:37:37     INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2022-05-04T06:37:37.841Z] 06:37:37     INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.842Z] 06:37:37     INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.842Z] 06:37:37     INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.843Z] 06:37:37     INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.843Z] 06:37:37     INFO - TEST-INFO | leakcheck | sandboxbroker process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.843Z] 06:37:37     INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.844Z] 06:37:37     INFO - TEST-INFO | leakcheck | utility process: leak threshold set at 0 bytes
[task 2022-05-04T06:37:37.844Z] 06:37:37     INFO - leakcheck | Processing leak log file /var/folders/ph/mplszy552x733kh_2m2kvx0h000014/T/tmpvy75eata.mozrunner/runtests_leaks_tab_pid1561.log
[task 2022-05-04T06:37:37.844Z] 06:37:37     INFO - TEST-PASS | leakcheck | tab no leaks detected!

:nchevobbe, since you are the author of the regressor, bug 1470781, could you take a look?
For more information, please visit auto_nag documentation.

Flags: needinfo?(nchevobbe)
Has Regression Range: --- → yes

I wasn't able to find what's causing this. I cleaned any references I added, and even more, without any luck.
It's only happening on OSX, only in TV jobs, and I can't reproduce locally (neither could jdescottes)

Flags: needinfo?(nchevobbe)

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

status-firefox100: --- → unaffected
status-firefox101: --- → unaffected
status-firefox102: --- → affected
status-firefox-esr91: --- → unaffected

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.