Closed Bug 1856375 Opened 1 year ago Closed 1 year ago

Intermittent devtools/client/webconsole/test/browser/browser_webconsole_network_messages_openinnet.js | single tracking bug

Categories

(DevTools :: Console, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


[task 2023-10-02T12:00:21.482Z] 12:00:21     INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_network_messages_openinnet.js
[task 2023-10-02T12:00:21.556Z] 12:00:21     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 11cdb6800 == 2 [pid = 4341] [id = 45]
[task 2023-10-02T12:00:21.557Z] 12:00:21     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (10133ef20) [pid = 4341] [serial = 136] [outer = 0]
[task 2023-10-02T12:00:21.557Z] 12:00:21     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (11cdb6c00) [pid = 4341] [serial = 137] [outer = 10133ef20]
[task 2023-10-02T12:00:21.678Z] 12:00:21     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (11cdb8000) [pid = 4341] [serial = 138] [outer = 10133ef20]
[task 2023-10-02T12:00:21.991Z] 12:00:21     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 133b6a800 == 7 [pid = 4318] [id = 314]
[task 2023-10-02T12:00:21.992Z] 12:00:21     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 22 (136ae0e20) [pid = 4318] [serial = 768] [outer = 0]
[task 2023-10-02T12:00:21.992Z] 12:00:21     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 23 (13d484800) [pid = 4318] [serial = 769] [outer = 136ae0e20]
[task 2023-10-02T12:00:22.022Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 24 (12f3d5800) [pid = 4318] [serial = 770] [outer = 136ae0e20]
[task 2023-10-02T12:00:22.167Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 13e859c00 == 8 [pid = 4318] [id = 315]
[task 2023-10-02T12:00:22.168Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 25 (13bd81d40) [pid = 4318] [serial = 771] [outer = 0]
[task 2023-10-02T12:00:22.168Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 26 (13e85f400) [pid = 4318] [serial = 772] [outer = 13bd81d40]
[task 2023-10-02T12:00:22.178Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:182
[task 2023-10-02T12:00:22.178Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/chrome/nsChromeProtocolHandler.cpp:73
[task 2023-10-02T12:00:22.252Z] 12:00:22     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 105b78800 == 1 [pid = 4341] [id = 44] [url = data:text/html;charset=UTF-8,%3Chtml%3E%3Chead%3E%3Cmeta%20charset%3D%22utf8%22%3E%3C%2Fhead%3E%3Cbody%3EFetch%201%3Cscript%3Ewindow.parent.location.href%20%3D%20%22http%3A%2F%2Flocalhost%3A49810%2Fredirect.html%22%3B%3C%2Fscript%3E%3C%2Fbody%3E%3C%2Fhtml%3E]
[task 2023-10-02T12:00:22.252Z] 12:00:22     INFO - GECKO(4318) | [Parent 4318, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1235
[task 2023-10-02T12:00:22.504Z] 12:00:22     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (10133e980) [pid = 4341] [serial = 133] [outer = 0] [url = data:text/html;charset=UTF-8,%3Chtml%3E%3Chead%3E%3Cmeta%20charset%3D%22utf8%22%3E%3C%2Fhead%3E%3Cbody%3EFetch%201%3Cscript%3Ewindow.parent.location.href%20%3D%20%22http%3A%2F%2Flocalhost%3A49810%2Fredirect.html%22%3B%3C%2Fscript%3E%3C%2Fbody%3E%3C%2Fhtml%3E]
[task 2023-10-02T12:00:22.546Z] 12:00:22     INFO - GECKO(4318) | must wait for focus
[task 2023-10-02T12:00:22.567Z] 12:00:22     INFO - GECKO(4318) | [Child 4613: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10f23d800 == 0 [pid = 4613] [id = 2] [url = data:text/html;charset=UTF-8,%3Chtml%3E%3Chead%3E%3Cmeta%20charset%3D%22utf8%22%3E%3C%2Fhead%3E%3Cbody%3EFetch%202%3Cscript%3Edocument.write(%22JS%20activated%22)%3C%2Fscript%3E%3C%2Fbody%3E%3C%2Fhtml%3E]
[task 2023-10-02T12:00:22.914Z] 12:00:22     INFO - GECKO(4318) | [Child 4613: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (10ec3e980) [pid = 4613] [serial = 7] [outer = 0] [url = data:text/html;charset=UTF-8,%3Chtml%3E%3Chead%3E%3Cmeta%20charset%3D%22utf8%22%3E%3C%2Fhead%3E%3Cbody%3EFetch%202%3Cscript%3Edocument.write(%22JS%20activated%22)%3C%2Fscript%3E%3C%2Fbody%3E%3C%2Fhtml%3E]
<...>
[task 2023-10-02T12:00:39.231Z] 12:00:39     INFO - GECKO(4318) | [Child 4321: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (117da4400) [pid = 4321] [serial = 147] [outer = 0] [url = about:blank]
[task 2023-10-02T12:01:51.680Z] 12:01:51     INFO - TEST-INFO | started process screencapture
[task 2023-10-02T12:01:51.804Z] 12:01:51     INFO - TEST-INFO | screencapture: exit 0
[task 2023-10-02T12:01:51.804Z] 12:01:51     INFO - Buffered messages logged at 12:00:21
[task 2023-10-02T12:01:51.804Z] 12:01:51     INFO - Entering test bound task
[task 2023-10-02T12:01:51.805Z] 12:01:51     INFO - Adding a new tab with URL: data:text/html;charset=utf8,<!DOCTYPE html>Test that 'Open in Network Panel' context menu item opens the selected request in netmonitor panel.
[task 2023-10-02T12:01:51.805Z] 12:01:51     INFO - Tab added and finished loading
[task 2023-10-02T12:01:51.805Z] 12:01:51     INFO - Opening the toolbox
[task 2023-10-02T12:01:51.805Z] 12:01:51     INFO - Buffered messages logged at 12:00:22
[task 2023-10-02T12:01:51.806Z] 12:01:51     INFO - Console message: Invalid chrome URI (need path): chrome://devtools/
[task 2023-10-02T12:01:51.806Z] 12:01:51     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/customElements.js" line: 499 column: 24 source: "display: none !important"}]
[task 2023-10-02T12:01:51.807Z] 12:01:51     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/customElements.js" line: 499}]
[task 2023-10-02T12:01:51.807Z] 12:01:51     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2023-10-02T12:01:51.808Z] 12:01:51     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/customElements.js" line: 499 column: 24 source: "display: none !important"}]
[task 2023-10-02T12:01:51.808Z] 12:01:51     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/customElements.js" line: 499}]
[task 2023-10-02T12:01:51.809Z] 12:01:51     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2023-10-02T12:01:51.809Z] 12:01:51     INFO - Buffered messages finished
[task 2023-10-02T12:01:51.809Z] 12:01:51     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_network_messages_openinnet.js | Test timed out - 
[task 2023-10-02T12:01:52.431Z] 12:01:52     INFO - Removing tab.
[task 2023-10-02T12:01:52.432Z] 12:01:52     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2023-10-02T12:01:52.455Z] 12:01:52     INFO - Got event: 'TabClose' on [object XULElement].
[task 2023-10-02T12:01:52.461Z] 12:01:52     INFO - GECKO(4318) | [Parent 4318, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:163
[task 2023-10-02T12:01:52.462Z] 12:01:52     INFO - GECKO(4318) | [Parent 4318, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:163
[task 2023-10-02T12:01:52.466Z] 12:01:52     INFO - Tab removed and finished closing
[task 2023-10-02T12:01:52.488Z] 12:01:52     INFO - GECKO(4318) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'DevToolsFrame'
[task 2023-10-02T12:01:52.496Z] 12:01:52     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2023-10-02T12:01:52.498Z] 12:01:52     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_network_messages_openinnet.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2023-10-02T12:01:52.510Z] 12:01:52     INFO - GECKO(4318) | [Parent 4318, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp:1863
[task 2023-10-02T12:01:52.540Z] 12:01:52     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 13e859c00 == 6 [pid = 4318] [id = 315] [url = chrome://devtools/content/webconsole/index.html]
[task 2023-10-02T12:01:52.554Z] 12:01:52     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 133b6a800 == 5 [pid = 4318] [id = 314] [url = about:devtools-toolbox]
[task 2023-10-02T12:01:52.738Z] 12:01:52     INFO - GECKO(4318) | MEMORY STAT | vsize 8436MB | residentFast 649MB | heapAllocated 226MB
[task 2023-10-02T12:01:52.739Z] 12:01:52     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_network_messages_openinnet.js | took 91256ms
[task 2023-10-02T12:01:52.747Z] 12:01:52     INFO - GECKO(4318) | [Child 4321: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 117da4c00 == 1 [pid = 4321] [id = 65]
[task 2023-10-02T12:01:52.747Z] 12:01:52     INFO - GECKO(4318) | [Child 4321: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (10be3e5c0) [pid = 4321] [serial = 148] [outer = 0]
[task 2023-10-02T12:01:52.748Z] 12:01:52     INFO - GECKO(4318) | [Child 4321: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (117da6000) [pid = 4321] [serial = 149] [outer = 10be3e5c0]
[task 2023-10-02T12:01:52.766Z] 12:01:52     INFO - checking window state
[task 2023-10-02T12:01:52.767Z] 12:01:52     INFO - GECKO(4318) | must wait for focus
[task 2023-10-02T12:01:52.852Z] 12:01:52     INFO - GECKO(4318) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/l0/7cv3q2qj29s1l25858nqp614000014/T/tmpwrtusez7.mozrunner/runtests_leaks_tab_pid5065.log
[task 2023-10-02T12:01:52.909Z] 12:01:52     INFO - GECKO(4318) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/l0/7cv3q2qj29s1l25858nqp614000014/T/tmpwrtusez7.mozrunner/runtests_leaks_tab_pid5066.log
[task 2023-10-02T12:01:52.972Z] 12:01:52     INFO - GECKO(4318) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/l0/7cv3q2qj29s1l25858nqp614000014/T/tmpwrtusez7.mozrunner/runtests_leaks_tab_pid5067.log
[task 2023-10-02T12:01:57.222Z] 12:01:57     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (136ae0e20) [pid = 4318] [serial = 768] [outer = 0] [url = about:devtools-toolbox]
[task 2023-10-02T12:01:57.222Z] 12:01:57     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (13bd81d40) [pid = 4318] [serial = 771] [outer = 0] [url = chrome://devtools/content/webconsole/index.html]
[task 2023-10-02T12:02:00.970Z] 12:02:00     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11cdb6800 == 0 [pid = 4341] [id = 45] [url = data:text/html;charset=utf8,<!DOCTYPE html>Test that 'Open in Network Panel' context menu item opens the selected request in netmonitor panel.]
[task 2023-10-02T12:02:01.259Z] 12:02:01     INFO - GECKO(4318) | [Child 4327: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 1257efc00 == 0 [pid = 4327] [id = 60] [url = about:blank]
[task 2023-10-02T12:02:01.605Z] 12:02:01     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (13e85f400) [pid = 4318] [serial = 772] [outer = 0] [url = about:blank]
[task 2023-10-02T12:02:01.606Z] 12:02:01     INFO - GECKO(4318) | [Parent 4318: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (12f3d5800) [pid = 4318] [serial = 770] [outer = 0] [url = about:devtools-toolbox]
[task 2023-10-02T12:02:06.054Z] 12:02:06     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10133ef20) [pid = 4341] [serial = 136] [outer = 0] [url = data:text/html;charset=utf8,<!DOCTYPE html>Test that 'Open in Network Panel' context menu item opens the selected request in netmonitor panel.]
[task 2023-10-02T12:02:06.090Z] 12:02:06     INFO - GECKO(4318) | [Child 4327: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (11993f2e0) [pid = 4327] [serial = 129] [outer = 0] [url = about:blank]
[task 2023-10-02T12:02:10.660Z] 12:02:10     INFO - GECKO(4318) | [Child 4341: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (11cdb8000) [pid = 4341] [serial = 138] [outer = 0] [url = data:text/html;charset=utf8,<!DOCTYPE html>Test that 'Open in Network Panel' context menu item opens the selected request in netmonitor panel.]
[task 2023-10-02T12:02:10.741Z] 12:02:10     INFO - GECKO(4318) | [Child 4327: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (1257f0000) [pid = 4327] [serial = 130] [outer = 0] [url = about:blank]
[task 2023-10-02T12:08:20.825Z] 12:08:20     INFO - TEST-UNEXPECTED-TIMEOUT | devtools/client/webconsole/test/browser/browser_webconsole_network_messages_openinnet.js (finished) | application timed out after 370 seconds with no output
[task 2023-10-02T12:08:20.825Z] 12:08:20     INFO - TEST-INFO 
[task 2023-10-02T12:08:20.826Z] 12:08:20     INFO - Buffered messages finished
[task 2023-10-02T12:08:20.826Z] 12:08:20  WARNING - Force-terminating active process(es).
[task 2023-10-02T12:08:20.826Z] 12:08:20     INFO - Determining child pids from psutil...
[task 2023-10-02T12:08:20.828Z] 12:08:20     INFO - [4319, 4320, 4321, 4326, 4327, 4329, 4341, 4613, 4614, 4929, 5065, 5066, 5067]
[task 2023-10-02T12:08:20.828Z] 12:08:20     INFO - ==> process 4318 launched child process 4319
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.