Intermittent TV devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | leaked 2 window(s) until shutdown [url = about:blank]
Categories
(DevTools :: Inspector, defect, P5)
Tracking
(Not tracked)
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=315316343&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/J_n34n7RT2OkHF-7U5e2iA/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/J_n34n7RT2OkHF-7U5e2iA/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2020-09-10T12:53:46.977Z] 12:53:46 INFO - TEST-START | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js
[task 2020-09-10T12:53:47.308Z] 12:53:47 INFO - GECKO(2704) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1599739080\appdata\local\temp\tmptclotc.mozrunner\runtests_leaks_tab_pid5992.log
[task 2020-09-10T12:53:47.308Z] 12:53:47 INFO - GECKO(2704) | [5992, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-10T12:53:47.449Z] 12:53:47 INFO - GECKO(2704) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-10T12:53:47.529Z] 12:53:47 INFO - GECKO(2704) | [Child 5036, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:53:47.549Z] 12:53:47 INFO - GECKO(2704) | [Child 5036, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:53:47.596Z] 12:53:47 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 013B5800 == 1 [pid = 5992] [id = {406c5052-2b22-46a9-bd1e-ff946dcd19d6}]
[task 2020-09-10T12:53:47.596Z] 12:53:47 INFO - GECKO(2704) | [Child 5992, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 902
[task 2020-09-10T12:53:47.596Z] 12:53:47 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (0130B9B0) [pid = 5992] [serial = 1] [outer = 00000000]
[task 2020-09-10T12:53:47.599Z] 12:53:47 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (074B7400) [pid = 5992] [serial = 2] [outer = 0130B9B0]
[task 2020-09-10T12:53:47.674Z] 12:53:47 INFO - GECKO(2704) | [Child 5992, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp, line 486
[task 2020-09-10T12:53:47.709Z] 12:53:47 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (074BC400) [pid = 5992] [serial = 3] [outer = 0130B9B0]
[task 2020-09-10T12:53:48.124Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 108F2000 == 6 [pid = 4520] [id = {ee09b5a0-2277-4f1e-9cbb-1fd517c719a6}]
[task 2020-09-10T12:53:48.124Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 14 (154D7EF0) [pid = 4520] [serial = 14] [outer = 00000000]
[task 2020-09-10T12:53:48.179Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 15 (14E99000) [pid = 4520] [serial = 15] [outer = 154D7EF0]
[task 2020-09-10T12:53:48.218Z] 12:53:48 INFO - GECKO(2704) | [Child 5992, Main Thread] WARNING: Scrolled rect smaller than scrollport?: file /builds/worker/checkouts/gecko/layout/generic/nsGfxScrollFrame.cpp, line 6801
[task 2020-09-10T12:53:48.237Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 16 (180BE800) [pid = 4520] [serial = 16] [outer = 154D7EF0]
[task 2020-09-10T12:53:48.352Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp, line 3779
[task 2020-09-10T12:53:48.607Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 15A53000 == 7 [pid = 4520] [id = {52d9ad61-2da8-4a0d-96a2-bb9c3c3108f2}]
[task 2020-09-10T12:53:48.607Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 17 (154D69B0) [pid = 4520] [serial = 17] [outer = 00000000]
[task 2020-09-10T12:53:48.607Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 18 (28780400) [pid = 4520] [serial = 18] [outer = 154D69B0]
[task 2020-09-10T12:53:48.942Z] 12:53:48 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004001 (NS_ERROR_NOT_IMPLEMENTED): file /builds/worker/checkouts/gecko/dom/xul/nsXULPrototypeCache.cpp, line 238
[task 2020-09-10T12:53:49.789Z] 12:53:49 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 29323400 == 8 [pid = 4520] [id = {197cdf28-b1f6-4880-b35e-0bdb0a1800e2}]
[task 2020-09-10T12:53:49.789Z] 12:53:49 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 19 (2A01B9A0) [pid = 4520] [serial = 19] [outer = 00000000]
[task 2020-09-10T12:53:49.789Z] 12:53:49 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 20 (29327000) [pid = 4520] [serial = 20] [outer = 2A01B9A0]
[task 2020-09-10T12:53:49.956Z] 12:53:49 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_GRIDS"
[task 2020-09-10T12:53:49.976Z] 12:53:49 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2020-09-10T12:53:50.335Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_GRIDS"
[task 2020-09-10T12:53:50.378Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2020-09-10T12:53:50.401Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2020-09-10T12:53:50.476Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2020-09-10T12:53:50.611Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2020-09-10T12:53:50.671Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2020-09-10T12:53:50.698Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2020-09-10T12:53:50.905Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2020-09-10T12:53:50.920Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2020-09-10T12:53:50.935Z] 12:53:50 INFO - GECKO(2704) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2020-09-10T12:53:51.655Z] 12:53:51 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 00AA6C00 == 0 [pid = 4248] [id = {ba09470b-ee3e-4433-a51b-0fd62a6ec0a2}] [url = about:blank]
[task 2020-09-10T12:53:52.613Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 19 (190A4400) [pid = 4520] [serial = 10] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:52.613Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 18 (00A06DE0) [pid = 4520] [serial = 1] [outer = 00000000] [url = chrome://gfxsanity/content/sanityparent.html]
[task 2020-09-10T12:53:52.613Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 17 (0F34B400) [pid = 4520] [serial = 2] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:52.613Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 16 (14E99000) [pid = 4520] [serial = 15] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:52.668Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp, line 172
[task 2020-09-10T12:53:52.668Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp, line 172
[task 2020-09-10T12:53:52.695Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: Not resolving response because actor is dead.: file /builds/worker/workspace/obj-build/ipc/ipdl/PContentParent.cpp, line 12489
[task 2020-09-10T12:53:52.696Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 15A53000 == 7 [pid = 4520] [id = {52d9ad61-2da8-4a0d-96a2-bb9c3c3108f2}] [url = chrome://devtools/content/inspector/index.xhtml]
[task 2020-09-10T12:53:52.696Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 29323400 == 6 [pid = 4520] [id = {197cdf28-b1f6-4880-b35e-0bdb0a1800e2}] [url = chrome://devtools/content/inspector/markup/markup.xhtml]
[task 2020-09-10T12:53:52.759Z] 12:53:52 INFO - GECKO(2704) | MEMORY STAT | vsize 866MB | vsizeMaxContiguous 657MB | residentFast 283MB | heapAllocated 108MB
[task 2020-09-10T12:53:52.759Z] 12:53:52 INFO - TEST-OK | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | took 5778ms
[task 2020-09-10T12:53:52.769Z] 12:53:52 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 00AB0400 == 1 [pid = 4248] [id = {30d6a68b-20b4-436d-b05a-ee19bbff0a65}]
[task 2020-09-10T12:53:52.769Z] 12:53:52 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (00A0BDF0) [pid = 4248] [serial = 5] [outer = 00000000]
[task 2020-09-10T12:53:52.769Z] 12:53:52 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (06BAA800) [pid = 4248] [serial = 6] [outer = 00A0BDF0]
[task 2020-09-10T12:53:52.804Z] 12:53:52 INFO - checking window state
[task 2020-09-10T12:53:52.859Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 17 (14CDC800) [pid = 4520] [serial = 21] [outer = 14A488A0]
[task 2020-09-10T12:53:52.878Z] 12:53:52 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4270
[task 2020-09-10T12:53:53.008Z] 12:53:53 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (00AB0800) [pid = 4248] [serial = 2] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.071Z] 12:53:53 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (06BB5400) [pid = 4248] [serial = 4] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.071Z] 12:53:53 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (00A0B8A0) [pid = 4248] [serial = 1] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.071Z] 12:53:53 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (06BAF400) [pid = 4248] [serial = 3] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.126Z] 12:53:53 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 06AC3800 == 1 [pid = 1560] [id = {e649a8f3-e085-433d-a797-d9b2ab11bb43}] [url = about:blank]
[task 2020-09-10T12:53:53.126Z] 12:53:53 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 009AFC00 == 0 [pid = 1560] [id = {6e7de1d5-389f-41e7-b9ad-2ee39ca3afde}] [url = chrome://gfxsanity/content/sanitytest.html]
[task 2020-09-10T12:53:53.127Z] 12:53:53 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 013B5800 == 0 [pid = 5992] [id = {406c5052-2b22-46a9-bd1e-ff946dcd19d6}] [url = data:text/html;charset=utf-8,<h1>foo</h1><span>bar</span>]
[task 2020-09-10T12:53:53.182Z] 12:53:53 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (009BA400) [pid = 1560] [serial = 2] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.241Z] 12:53:53 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (0090B8A0) [pid = 1560] [serial = 1] [outer = 00000000] [url = chrome://gfxsanity/content/sanitytest.html]
[task 2020-09-10T12:53:53.241Z] 12:53:53 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (0090BBD0) [pid = 1560] [serial = 4] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.262Z] 12:53:53 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (074B7400) [pid = 5992] [serial = 2] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.263Z] 12:53:53 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (06FE7C00) [pid = 6052] [serial = 8] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.264Z] 12:53:53 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (06FE5400) [pid = 6052] [serial = 6] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.264Z] 12:53:53 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 9 (06FE2800) [pid = 6052] [serial = 4] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.264Z] 12:53:53 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (00BDFC00) [pid = 6052] [serial = 2] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.279Z] 12:53:53 INFO - GECKO(2704) | [Child 5148: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (00AAAC00) [pid = 5148] [serial = 2] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:53.346Z] 12:53:53 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (0130B9B0) [pid = 5992] [serial = 1] [outer = 00000000] [url = data:text/html;charset=utf-8,<h1>foo</h1><span>bar</span>]
[task 2020-09-10T12:53:53.346Z] 12:53:53 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 7 (00B0B240) [pid = 6052] [serial = 3] [outer = 00000000] [url = moz-extension://991d6ad1-8d7a-4e7e-89eb-aaf44918d1d6/_generated_background_page.html]
[task 2020-09-10T12:53:53.346Z] 12:53:53 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 06FE1000 == 3 [pid = 6052] [id = {0df9872a-706b-4408-ac7d-89467d7eabe2}] [url = moz-extension://991d6ad1-8d7a-4e7e-89eb-aaf44918d1d6/_generated_background_page.html]
[task 2020-09-10T12:53:53.401Z] 12:53:53 INFO - GECKO(2704) | [Child 5148: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 00AA1400 == 0 [pid = 5148] [id = {9bb99bcc-71b9-4c21-ac87-a6ece1f59005}] [url = about:newtab]
[task 2020-09-10T12:53:53.401Z] 12:53:53 INFO - GECKO(2704) | [Child 5148: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (00A0B8A0) [pid = 5148] [serial = 1] [outer = 00000000] [url = about:newtab]
[task 2020-09-10T12:53:53.876Z] 12:53:53 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 108F2000 == 5 [pid = 4520] [id = {ee09b5a0-2277-4f1e-9cbb-1fd517c719a6}] [url = about:devtools-toolbox]
[task 2020-09-10T12:53:54.489Z] 12:53:54 INFO - GECKO(2704) | [Child 5148: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (06ECA800) [pid = 5148] [serial = 3] [outer = 00000000] [url = about:newtab]
[task 2020-09-10T12:53:54.557Z] 12:53:54 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 6 (08B76C00) [pid = 6052] [serial = 10] [outer = 00000000] [url = moz-extension://991d6ad1-8d7a-4e7e-89eb-aaf44918d1d6/_generated_background_page.html]
[task 2020-09-10T12:53:54.557Z] 12:53:54 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (06AC9400) [pid = 1560] [serial = 5] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:54.558Z] 12:53:54 INFO - GECKO(2704) | [Child 1560: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (06AC7400) [pid = 1560] [serial = 3] [outer = 00000000] [url = chrome://gfxsanity/content/sanitytest.html]
[task 2020-09-10T12:53:54.593Z] 12:53:54 INFO - GECKO(2704) | [Child 5992: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (074BC400) [pid = 5992] [serial = 3] [outer = 00000000] [url = data:text/html;charset=utf-8,<h1>foo</h1><span>bar</span>]
[task 2020-09-10T12:53:55.722Z] 12:53:55 INFO - GECKO(2704) | Completed ShutdownLeaks collections in process 5148
[task 2020-09-10T12:53:55.749Z] 12:53:55 INFO - GECKO(2704) | Completed ShutdownLeaks collections in process 4248
[task 2020-09-10T12:53:55.784Z] 12:53:55 INFO - GECKO(2704) | Completed ShutdownLeaks collections in process 1560
[task 2020-09-10T12:53:55.939Z] 12:53:55 INFO - GECKO(2704) | Completed ShutdownLeaks collections in process 6052
[task 2020-09-10T12:53:55.999Z] 12:53:55 INFO - GECKO(2704) | Completed ShutdownLeaks collections in process 5992
[task 2020-09-10T12:53:56.266Z] 12:53:56 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 16 (180C2800) [pid = 4520] [serial = 8] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:53:57.113Z] 12:53:57 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 17 (0F33E800) [pid = 4520] [serial = 22] [outer = 14A488A0]
[task 2020-09-10T12:53:57.180Z] 12:53:57 INFO - GECKO(2704) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1599739080\appdata\local\temp\tmptclotc.mozrunner\runtests_leaks_tab_pid5132.log
[task 2020-09-10T12:53:57.180Z] 12:53:57 INFO - GECKO(2704) | [5132, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-10T12:53:59.795Z] 12:53:59 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 16 (14CDC800) [pid = 4520] [serial = 21] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:00.615Z] 12:54:00 INFO - GECKO(2704) | Completed ShutdownLeaks collections in process 4520
[task 2020-09-10T12:54:00.615Z] 12:54:00 INFO - TEST-START | Shutdown
[task 2020-09-10T12:54:00.616Z] 12:54:00 INFO - Browser Chrome Test Summary
[task 2020-09-10T12:54:00.616Z] 12:54:00 INFO - Passed: 5
[task 2020-09-10T12:54:00.616Z] 12:54:00 INFO - Failed: 0
[task 2020-09-10T12:54:00.616Z] 12:54:00 INFO - Todo: 0
[task 2020-09-10T12:54:00.616Z] 12:54:00 INFO - Mode: e10s
[task 2020-09-10T12:54:00.616Z] 12:54:00 INFO - *** End BrowserChrome Test Results ***
[task 2020-09-10T12:54:00.705Z] 12:54:00 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11E22C00 == 4 [pid = 4520] [id = {f7a48a90-85e9-487b-a56e-d3cd60dd268f}] [url = chrome://extensions/content/dummy.xhtml]
[task 2020-09-10T12:54:00.861Z] 12:54:00 INFO - GECKO(2704) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-10T12:54:00.861Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 06FE6400 == 2 [pid = 6052] [id = {2ba4c43d-985e-4e82-a511-e2905ac42c89}] [url = moz-extension://f5e2ad82-63dd-47a0-883f-56376c314d14/_generated_background_page.html]
[task 2020-09-10T12:54:00.861Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 06FE3C00 == 1 [pid = 6052] [id = {1b7482e1-df7d-4811-9338-18ff7caf9207}] [url = moz-extension://1feb9b5d-2c3c-4b36-82e3-08f5f887b9fe/_generated_background_page.html]
[task 2020-09-10T12:54:00.861Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 00BD5C00 == 0 [pid = 6052] [id = {72ea9214-94ca-480e-b35e-70ddb20e25a5}] [url = moz-extension://8bece935-4611-48c4-8763-7f78c6ed77b6/_generated_background_page.html]
[task 2020-09-10T12:54:00.880Z] 12:54:00 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111 (NS_ERROR_NOT_AVAILABLE): file /builds/worker/checkouts/gecko/netwerk/cache/nsApplicationCacheService.cpp, line 161
[task 2020-09-10T12:54:00.980Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (00B0BCE0) [pid = 6052] [serial = 7] [outer = 00000000] [url = moz-extension://f5e2ad82-63dd-47a0-883f-56376c314d14/_generated_background_page.html]
[task 2020-09-10T12:54:00.980Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (00B0B8A0) [pid = 6052] [serial = 1] [outer = 00000000] [url = moz-extension://8bece935-4611-48c4-8763-7f78c6ed77b6/_generated_background_page.html]
[task 2020-09-10T12:54:00.980Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (00B0BBD0) [pid = 6052] [serial = 5] [outer = 00000000] [url = moz-extension://1feb9b5d-2c3c-4b36-82e3-08f5f887b9fe/_generated_background_page.html]
[task 2020-09-10T12:54:00.980Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (08B78800) [pid = 6052] [serial = 11] [outer = 00000000] [url = moz-extension://1feb9b5d-2c3c-4b36-82e3-08f5f887b9fe/_generated_background_page.html]
[task 2020-09-10T12:54:00.981Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (08B6E800) [pid = 6052] [serial = 9] [outer = 00000000] [url = moz-extension://8bece935-4611-48c4-8763-7f78c6ed77b6/_generated_background_page.html]
[task 2020-09-10T12:54:00.981Z] 12:54:00 INFO - GECKO(2704) | [Child 6052: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (0A01B000) [pid = 6052] [serial = 12] [outer = 00000000] [url = moz-extension://f5e2ad82-63dd-47a0-883f-56376c314d14/_generated_background_page.html]
[task 2020-09-10T12:54:00.996Z] 12:54:00 INFO - GECKO(2704) | [Child 6052, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:01.016Z] 12:54:01 INFO - GECKO(2704) | [Child 6052, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:01.036Z] 12:54:01 INFO - GECKO(2704) | [2020-09-10T12:54:01Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-09-10T12:54:01.036Z] 12:54:01 INFO - GECKO(2704) | [2020-09-10T12:54:01Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-09-10T12:54:01.279Z] 12:54:01 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 180C1C00 == 3 [pid = 4520] [id = {aa9df8d9-2cf1-426b-9b6e-49c398d4f4ed}] [url = chrome://mochikit/content/browser-harness.xhtml]
[task 2020-09-10T12:54:01.279Z] 12:54:01 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 15330000 == 2 [pid = 4520] [id = {bc954ff6-b58a-4e65-887a-af8d9c45fef0}] [url = about:blank]
[task 2020-09-10T12:54:01.282Z] 12:54:01 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 180BD000 == 1 [pid = 4520] [id = {7df1b213-301f-450e-8eec-f029bcad9903}] [url = resource://gre-resources/hiddenWindow.html]
[task 2020-09-10T12:54:01.322Z] 12:54:01 INFO - GECKO(2704) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-10T12:54:01.323Z] 12:54:01 INFO - GECKO(2704) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-10T12:54:01.323Z] 12:54:01 INFO - GECKO(2704) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-10T12:54:01.351Z] 12:54:01 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 00AB0400 == 0 [pid = 4248] [id = {30d6a68b-20b4-436d-b05a-ee19bbff0a65}] [url = about:blank]
[task 2020-09-10T12:54:01.371Z] 12:54:01 INFO - GECKO(2704) | [Child 5132, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:01.386Z] 12:54:01 INFO - GECKO(2704) | [Child 1560, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:01.392Z] 12:54:01 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (00A0BDF0) [pid = 4248] [serial = 5] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:01.392Z] 12:54:01 INFO - GECKO(2704) | [Child 4248: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (06BAA800) [pid = 4248] [serial = 6] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:01.399Z] 12:54:01 INFO - GECKO(2704) | [Child 5132, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:01.414Z] 12:54:01 INFO - GECKO(2704) | [Child 4248, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:01.414Z] 12:54:01 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 108ED000 == 0 [pid = 4520] [id = {77f949fe-335b-477f-a2ad-af13067dfd8e}] [url = chrome://browser/content/browser.xhtml]
[task 2020-09-10T12:54:01.430Z] 12:54:01 INFO - GECKO(2704) | [Child 1560, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:01.447Z] 12:54:01 INFO - GECKO(2704) | [Child 4248, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:01.447Z] 12:54:01 INFO - GECKO(2704) | [Child 5148, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:01.462Z] 12:54:01 INFO - GECKO(2704) | [Child 5148, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:01.477Z] 12:54:01 INFO - GECKO(2704) | [Child 5992, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:01.496Z] 12:54:01 INFO - GECKO(2704) | [Child 5992, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:01.675Z] 12:54:01 INFO - GECKO(2704) | 1599742441666 Marionette TRACE Received observer notification xpcom-will-shutdown
[task 2020-09-10T12:54:01.675Z] 12:54:01 INFO - GECKO(2704) | 1599742441666 Marionette INFO Stopped listening on port 2828
[task 2020-09-10T12:54:01.675Z] 12:54:01 INFO - GECKO(2704) | 1599742441666 Marionette DEBUG Marionette stopped listening
[task 2020-09-10T12:54:02.942Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 15 (154D69B0) [pid = 4520] [serial = 17] [outer = 00000000] [url = chrome://devtools/content/inspector/index.xhtml]
[task 2020-09-10T12:54:02.942Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (2A01B9A0) [pid = 4520] [serial = 19] [outer = 00000000] [url = chrome://devtools/content/inspector/markup/markup.xhtml]
[task 2020-09-10T12:54:02.942Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (154D7EF0) [pid = 4520] [serial = 14] [outer = 00000000] [url = about:devtools-toolbox]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (180BE800) [pid = 4520] [serial = 16] [outer = 00000000] [url = about:devtools-toolbox]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (108EA400) [pid = 4520] [serial = 4] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (00A05BD0) [pid = 4520] [serial = 3] [outer = 00000000] [url = chrome://browser/content/browser.xhtml]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 9 (15475670) [pid = 4520] [serial = 12] [outer = 00000000] [url = chrome://mochikit/content/browser-harness.xhtml]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (190AB800) [pid = 4520] [serial = 13] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 7 (00A06230) [pid = 4520] [serial = 5] [outer = 00000000] [url = chrome://extensions/content/dummy.xhtml]
[task 2020-09-10T12:54:02.949Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 6 (14F0E400) [pid = 4520] [serial = 6] [outer = 00000000] [url = chrome://extensions/content/dummy.xhtml]
[task 2020-09-10T12:54:02.950Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (15475120) [pid = 4520] [serial = 9] [outer = 00000000] [url = resource://gre-resources/hiddenWindow.html]
[task 2020-09-10T12:54:02.950Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (14A488A0) [pid = 4520] [serial = 7] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:02.950Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (0F33E800) [pid = 4520] [serial = 22] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:02.957Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (190B1800) [pid = 4520] [serial = 11] [outer = 00000000] [url = resource://gre-resources/hiddenWindow.html]
[task 2020-09-10T12:54:02.957Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (29327000) [pid = 4520] [serial = 20] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:02.957Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (28780400) [pid = 4520] [serial = 18] [outer = 00000000] [url = about:blank]
[task 2020-09-10T12:54:02.992Z] 12:54:02 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-10T12:54:03.053Z] 12:54:03 INFO - GECKO(2704) | [Parent 4520, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-10T12:54:03.108Z] 12:54:03 INFO - TEST-INFO | Main app process: exit 0
[task 2020-09-10T12:54:03.108Z] 12:54:03 INFO - TEST-INFO | Confirming we saw 19 DOCSHELL created and 19 destroyed log strings.
[task 2020-09-10T12:54:03.109Z] 12:54:03 INFO - TEST-INFO | Confirming we saw 51 DOMWINDOW created and 51 destroyed log strings.
[task 2020-09-10T12:54:03.109Z] 12:54:03 ERROR - TEST-UNEXPECTED-FAIL | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | leaked 2 window(s) until shutdown [url = about:blank]
[task 2020-09-10T12:54:03.110Z] 12:54:03 ERROR - TEST-UNEXPECTED-FAIL | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | leaked 2 window(s) until shutdown [url = about:devtools-toolbox]
[task 2020-09-10T12:54:03.110Z] 12:54:03 ERROR - TEST-UNEXPECTED-FAIL | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | leaked 1 window(s) until shutdown [url = chrome://devtools/content/inspector/index.xhtml]
[task 2020-09-10T12:54:03.110Z] 12:54:03 ERROR - TEST-UNEXPECTED-FAIL | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | leaked 1 window(s) until shutdown [url = chrome://devtools/content/inspector/markup/markup.xhtml]
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - TEST-INFO | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | windows(s) leaked: [pid = 4520] [serial = 20], [pid = 4520] [serial = 17], [pid = 4520] [serial = 19], [pid = 4520] [serial = 16], [pid = 4520] [serial = 18], [pid = 4520] [serial = 14]
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - TEST-INFO | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | This test created 1 hidden window(s)
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - TEST-INFO | devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js | This test created 1 hidden docshell(s)
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - runtests.py | Application ran for: 0:00:22.754000
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - zombiecheck | Reading PID log: c:\users\task_1599739080\appdata\local\temp\tmp6op4zcpidlog
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - ==> process 4520 launched child process 1560 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.0.1930471943\1797504548" -childID 1 -isForBrowser -prefsHandle 1568 -prefMapHandle 1544 -prefsLen 1 -prefMapSize 241657 -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 2228 tab)
[task 2020-09-10T12:54:03.111Z] 12:54:03 INFO - ==> process 4520 launched child process 4248 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.6.2076270774\1958725083" -childID 2 -isForBrowser -prefsHandle 4488 -prefMapHandle 4484 -prefsLen 451 -prefMapSize 241657 -noScache -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 4500 tab)
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - ==> process 4520 launched child process 6052 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.12.104559740\899524066" -childID 3 -isForBrowser -prefsHandle 4640 -prefMapHandle 4636 -prefsLen 491 -prefMapSize 241657 -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 4652 tab)
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - ==> process 4520 launched child process 5148 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.18.912830589\925322666" -childID 4 -isForBrowser -prefsHandle 3596 -prefMapHandle 3616 -prefsLen 9701 -prefMapSize 241657 -noScache -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 3500 tab)
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - ==> process 4520 launched child process 5036 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.24.882161958\302689189" -childID 5 -isForBrowser -prefsHandle 2860 -prefMapHandle 2896 -prefsLen 10762 -prefMapSize 241657 -noScache -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 3248 tab)
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - ==> process 4520 launched child process 5992 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.30.1858209386\1758552524" -childID 6 -isForBrowser -prefsHandle 3464 -prefMapHandle 3784 -prefsLen 11059 -prefMapSize 241657 -noScache -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 4244 tab)
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - ==> process 4520 launched child process 5132 ("Z:\task_1599739080\build\application\firefox\firefox.exe" -contentproc --channel="4520.36.734455036\60318513" -childID 7 -isForBrowser -prefsHandle 4008 -prefMapHandle 4248 -prefsLen 11445 -prefMapSize 241657 -noScache -parentBuildID 20200910120532 -appdir "Z:\task_1599739080\build\application\firefox\browser" - 4520 "\.\pipe\gecko-crash-server-pipe.4520" 2024 tab)
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 6052
[task 2020-09-10T12:54:03.112Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 5992
[task 2020-09-10T12:54:03.113Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 5132
[task 2020-09-10T12:54:03.113Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 5036
[task 2020-09-10T12:54:03.113Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 4248
[task 2020-09-10T12:54:03.113Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 1560
[task 2020-09-10T12:54:03.113Z] 12:54:03 INFO - zombiecheck | Checking for orphan process with PID: 5148
[task 2020-09-10T12:54:03.120Z] 12:54:03 INFO - Stopping web server
[task 2020-09-10T12:54:03.135Z] 12:54:03 INFO - Stopping web socket server
[task 2020-09-10T12:54:03.162Z] 12:54:03 INFO - Stopping ssltunnel
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - leakcheck | Processing log file c:\users\task_1599739080\appdata\local\temp\tmptclotc.mozrunner\runtests_leaks.log
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 4000 bytes
[task 2020-09-10T12:54:03.197Z] 12:54:03 INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2020-09-10T12:54:03.198Z] 12:54:03 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 1000 bytes
[task 2020-09-10T12:54:03.198Z] 12:54:03 INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2020-09-10T12:54:03.198Z] 12:54:03 INFO - leakcheck | Processing leak log file c:\users\task_1599739080\appdata\local\temp\tmptclotc.mozrunner\runtests_leaks.log
<...>
[task 2020-09-10T12:54:03.228Z] 12:54:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-09-10T12:54:03.228Z] 12:54:03 INFO - leakcheck | Processing leak log file c:\users\task_1599739080\appdata\local\temp\tmptclotc.mozrunner\runtests_leaks_tab_pid6052.log
[task 2020-09-10T12:54:03.229Z] 12:54:03 INFO -
[task 2020-09-10T12:54:03.229Z] 12:54:03 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 6052
[task 2020-09-10T12:54:03.229Z] 12:54:03 INFO -
[task 2020-09-10T12:54:03.229Z] 12:54:03 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-09-10T12:54:03.229Z] 12:54:03 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-09-10T12:54:03.229Z] 12:54:03 INFO - 0 |TOTAL | 25 0| 101404 0|
[task 2020-09-10T12:54:03.232Z] 12:54:03 INFO -
[task 2020-09-10T12:54:03.232Z] 12:54:03 INFO - nsTraceRefcnt::DumpStatistics: 905 entries
[task 2020-09-10T12:54:03.232Z] 12:54:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-09-10T12:54:03.232Z] 12:54:03 INFO - runtests.py | Running tests: end.
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Buffered messages finished
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - TEST-INFO | checking window state
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Browser Chrome Test Summary
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Passed: 55
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Failed: 4
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Todo: 0
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Mode: e10s
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - *** End BrowserChrome Test Results ***
[task 2020-09-10T12:54:03.299Z] 12:54:03 INFO - Buffered messages finished
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - SUITE-END | took 23s
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - SUITE-START | Running 1 tests
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - :::
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - ::: Test verification summary for:
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - :::
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - ::: devtools/client/inspector/test/browser_inspector_breadcrumbs_highlight_hover.js
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - :::
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - ::: 1. Run each test 10 times in one browser. : Pass
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - ::: 2. Run each test 5 times in a new browser each time. : FAIL
[task 2020-09-10T12:54:03.300Z] 12:54:03 INFO - ::: 3. Run each test 10 times in one browser, in chaos mode. : not run / incomplete
[task 2020-09-10T12:54:03.301Z] 12:54:03 INFO - ::: 4. Run each test 5 times in a new browser each time, in chaos mode. : not run / incomplete
[task 2020-09-10T12:54:03.301Z] 12:54:03 INFO - :::
[task 2020-09-10T12:54:03.301Z] 12:54:03 INFO - ::: Test verification FAILED!
[task 2020-09-10T12:54:03.301Z] 12:54:03 INFO - :::
[task 2020-09-10T12:54:03.301Z] 12:54:03 INFO - Buffered messages finished
[task 2020-09-10T12:54:03.301Z] 12:54:03 INFO - SUITE-END | took 0s
[task 2020-09-10T12:54:03.339Z] 12:54:03 INFO - Return code: 0
[task 2020-09-10T12:54:03.340Z] 12:54:03 INFO - TinderboxPrint: mochitest-mochitest-devtools-chrome<br/>11/0/0
[task 2020-09-10T12:54:03.340Z] 12:54:03 ERROR - # TBPL FAILURE #
[task 2020-09-10T12:54:03.340Z] 12:54:03 WARNING - setting return code to 2
[task 2020-09-10T12:54:03.340Z] 12:54:03 ERROR - TinderboxPrint: Per-test run of ...\browser_inspector_breadcrumbs_highlight_hover.js<br/>: FAILURE
[task 2020-09-10T12:54:03.340Z] 12:54:03 INFO - Running command: ['Z:\task_1599739080\build\venv\Scripts\python', '-u', 'Z:\task_1599739080\build\tests\mochitest\runtests.py', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--appname=Z:\task_1599739080\build\application\firefox\firefox.exe', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=Z:\task_1599739080\build\symbols', '--certificate-path=tests/certs', '--quiet', '--log-raw=Z:\task_1599739080\build\blobber_upload_dir\mochitest-devtools-chrome-test4_raw.log', '--log-errorsummary=Z:\task_1599739080\build\blobber_upload_dir\mochitest-devtools-chrome-test4_errorsummary.log', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--log-raw=-', '--flavor=browser', '--subsuite=devtools', '--chunk-by-runtime', '--verify-max-time=900', '--verify', u'devtools/client/inspector/test/browser_inspector_highlighter-01.js'] in Z:\task_1599739080\build
[task 2020-09-10T12:54:03.340Z] 12:54:03 INFO - Copy/paste: Z:\task_1599739080\build\venv\Scripts\python -u Z:\task_1599739080\build\tests\mochitest\runtests.py --setpref=media.peerconnection.mtransport_process=false --setpref=network.process.enabled=false --appname=Z:\task_1599739080\build\application\firefox\firefox.exe --utility-path=tests/bin --extra-profile-file=tests/bin/plugins --symbols-path=Z:\task_1599739080\build\symbols --certificate-path=tests/certs --quiet --log-raw=Z:\task_1599739080\build\blobber_upload_dir\mochitest-devtools-chrome-test4_raw.log --log-errorsummary=Z:\task_1599739080\build\blobber_upload_dir\mochitest-devtools-chrome-test4_errorsummary.log --screenshot-on-fail --cleanup-crashes --marionette-startup-timeout=180 --log-raw=- --flavor=browser --subsuite=devtools --chunk-by-runtime --verify-max-time=900 --verify devtools/client/inspector/test/browser_inspector_highlighter-01.js
[task 2020-09-10T12:54:03.340Z] 12:54:03 INFO - Using env: (same as previous command)
[task 2020-09-10T12:54:03.341Z] 12:54:03 INFO - Calling ['Z:\task_1599739080\build\venv\Scripts\python', '-u', 'Z:\task_1599739080\build\tests\mochitest\runtests.py', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--appname=Z:\task_1599739080\build\application\firefox\firefox.exe', '--utility-path=tests/bin', '--extra-profile-file=tests/bin/plugins', '--symbols-path=Z:\task_1599739080\build\symbols', '--certificate-path=tests/certs', '--quiet', '--log-raw=Z:\task_1599739080\build\blobber_upload_dir\mochitest-devtools-chrome-test4_raw.log', '--log-errorsummary=Z:\task_1599739080\build\blobber_upload_dir\mochitest-devtools-chrome-test4_errorsummary.log', '--screenshot-on-fail', '--cleanup-crashes', '--marionette-startup-timeout=180', '--log-raw=-', '--flavor=browser', '--subsuite=devtools', '--chunk-by-runtime', '--verify-max-time=900', '--verify', u'devtools/client/inspector/test/browser_inspector_highlighter-01.js'] with output_timeout 1000
[task 2020-09-10T12:54:03.825Z] 12:54:03 INFO - :::
[task 2020-09-10T12:54:03.825Z] 12:54:03 INFO - ::: Running test verification step "1. Run each test 10 times in one browser."...
| Comment hidden (Intermittent Failures Robot) |
Comment 2•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Description
•