1845127 - Intermittent devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | single tracking bug

Reporter

Description

•

3 years ago

treeherder

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=423647240&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/CX42t9XeQdK_B4RMAV_7GQ/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/CX42t9XeQdK_B4RMAV_7GQ/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2023-07-24T11:45:59.426Z] 11:45:59     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 15 (14135a400) [pid = 2947] [serial = 13] [outer = 0] [url = about:blank]
[task 2023-07-24T11:45:59.430Z] 11:45:59     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (12feb9800) [pid = 2947] [serial = 6] [outer = 0] [url = about:blank]
[task 2023-07-24T11:45:59.543Z] 11:45:59     INFO - GECKO(2947) | [Child 2948: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (11fa98c00) [pid = 2948] [serial = 13] [outer = 0] [url = moz-extension://e70afef2-3823-4f4d-85a7-066717a902be/_generated_background_page.html]
[task 2023-07-24T11:46:09.214Z] 11:46:09     INFO - GECKO(2947) | 2023-07-24 11:46:09.213 firefox[2947:40374] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightlydebug.savedState/window_1.data: No such file or directory (2)
[task 2023-07-24T11:46:10.424Z] 11:46:10     INFO - GECKO(2947) | [WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2023-07-24T11:46:10.443Z] 11:46:10     INFO - GECKO(2947) | console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.sys.mjs", 324))
[task 2023-07-24T11:47:17.117Z] 11:47:17     INFO - TEST-INFO | started process screencapture
[task 2023-07-24T11:47:17.238Z] 11:47:17     INFO - TEST-INFO | screencapture: exit 0
[task 2023-07-24T11:47:17.238Z] 11:47:17     INFO - Buffered messages logged at 11:45:44
[task 2023-07-24T11:47:17.239Z] 11:47:17     INFO - Entering test bound 
[task 2023-07-24T11:47:17.239Z] 11:47:17     INFO - Adding a new tab with URL: data:text/html;charset=utf8,<!DOCTYPE html>Web Console CSP too many reports test
[task 2023-07-24T11:47:17.239Z] 11:47:17     INFO - Tab added and finished loading
[task 2023-07-24T11:47:17.240Z] 11:47:17     INFO - Opening the toolbox
[task 2023-07-24T11:47:17.240Z] 11:47:17     INFO - Buffered messages logged at 11:45:45
[task 2023-07-24T11:47:17.241Z] 11:47:17     INFO - Console message: Invalid chrome URI (need path): chrome://devtools/
[task 2023-07-24T11:47:17.241Z] 11:47:17     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-07-24T11:47:17.242Z] 11:47:17     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-07-24T11:47:17.242Z] 11:47:17     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-07-24T11:47:17.243Z] 11:47:17     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-07-24T11:47:17.243Z] 11:47:17     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-07-24T11:47:17.244Z] 11:47:17     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-07-24T11:47:17.244Z] 11:47:17     INFO - Console message: [JavaScript Error: "Error: Can't find profile directory." {file: "resource://gre/modules/XULStore.sys.mjs" line: 60}]
[task 2023-07-24T11:47:17.244Z] 11:47:17     INFO - load@resource://gre/modules/XULStore.sys.mjs:60:15
[task 2023-07-24T11:47:17.244Z] 11:47:17     INFO - XULStore@resource://gre/modules/XULStore.sys.mjs:17:10
[task 2023-07-24T11:47:17.245Z] 11:47:17     INFO - 
[task 2023-07-24T11:47:17.245Z] 11:47:17     INFO - Toolbox opened and focused
[task 2023-07-24T11:47:17.245Z] 11:47:17     INFO - Load a page with CSP warnings.
[task 2023-07-24T11:47:17.246Z] 11:47:17     INFO - Navigating to "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html"
[task 2023-07-24T11:47:17.246Z] 11:47:17     INFO - Waiting for page to be loaded…
[task 2023-07-24T11:47:17.246Z] 11:47:17     INFO - Buffered messages logged at 11:45:46
[task 2023-07-24T11:47:17.247Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 0);"}]
[task 2023-07-24T11:47:17.247Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 1);"}]
[task 2023-07-24T11:47:17.248Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 2);"}]
[task 2023-07-24T11:47:17.249Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 3);"}]
[task 2023-07-24T11:47:17.249Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 4);"}]
[task 2023-07-24T11:47:17.249Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 5);"}]
[task 2023-07-24T11:47:17.250Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 6);"}]
[task 2023-07-24T11:47:17.250Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 7);"}]
[task 2023-07-24T11:47:17.251Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 8);"}]
[task 2023-07-24T11:47:17.251Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 9);"}]
[task 2023-07-24T11:47:17.251Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: Prevented too many CSP reports from being sent within a short period of time." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18}]
[task 2023-07-24T11:47:17.252Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 10);"}]
[task 2023-07-24T11:47:17.252Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 11);"}]
[task 2023-07-24T11:47:17.253Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 12);"}]
[task 2023-07-24T11:47:17.253Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 13);"}]
[task 2023-07-24T11:47:17.253Z] 11:47:17     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 14);"}]
[task 2023-07-24T11:47:17.254Z] 11:47:17     INFO - Matched a message with text: "Content-Security-Policy: Prevented too many CSP reports from being sent within a short period of time.", all messages received.
[task 2023-07-24T11:47:17.254Z] 11:47:17     INFO - Buffered messages finished
[task 2023-07-24T11:47:17.254Z] 11:47:17     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | Test timed out - 
[task 2023-07-24T11:47:17.254Z] 11:47:17     INFO - GECKO(2947) | [Parent 2947, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1711
[task 2023-07-24T11:47:17.763Z] 11:47:17     INFO - Removing tab.
[task 2023-07-24T11:47:17.763Z] 11:47:17     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2023-07-24T11:47:17.783Z] 11:47:17     INFO - Got event: 'TabClose' on [object XULElement].
[task 2023-07-24T11:47:17.796Z] 11:47:17     INFO - GECKO(2947) | [Parent 2947, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:163
[task 2023-07-24T11:47:17.797Z] 11:47:17     INFO - GECKO(2947) | [Parent 2947, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:163
[task 2023-07-24T11:47:17.801Z] 11:47:17     INFO - Tab removed and finished closing
[task 2023-07-24T11:47:17.826Z] 11:47:17     INFO - GECKO(2947) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'DevToolsFrame'
[task 2023-07-24T11:47:17.838Z] 11:47:17     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2023-07-24T11:47:17.841Z] 11:47:17     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2023-07-24T11:47:18.037Z] 11:47:18     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 143239c00 == 6 [pid = 2947] [id = 6] [url = chrome://devtools/content/webconsole/index.html]
[task 2023-07-24T11:47:18.038Z] 11:47:18     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10d8d6800 == 5 [pid = 2947] [id = 5] [url = about:devtools-toolbox]
[task 2023-07-24T11:47:18.043Z] 11:47:18     INFO - GECKO(2947) | [Child 2955: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 113959800 == 0 [pid = 2955] [id = 0] [url = https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html]
[task 2023-07-24T11:47:18.072Z] 11:47:18     INFO - GECKO(2947) | [Child 2955: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (1139a63e0) [pid = 2955] [serial = 1] [outer = 0] [url = https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html]
[task 2023-07-24T11:47:18.073Z] 11:47:18     INFO - GECKO(2947) | [Child 2955: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (11395c000) [pid = 2955] [serial = 3] [outer = 0] [url = https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html]
[task 2023-07-24T11:47:18.246Z] 11:47:18     INFO - GECKO(2947) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2023-07-24T11:47:18.247Z] 11:47:18     INFO - GECKO(2947) | MEMORY STAT | vsize 8073MB | residentFast 462MB | heapAllocated 188MB
[task 2023-07-24T11:47:18.248Z] 11:47:18     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | took 94073ms
[task 2023-07-24T11:47:18.256Z] 11:47:18     INFO - GECKO(2947) | [Child 2949: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 10ab42800 == 2 [pid = 2949] [id = 2]
[task 2023-07-24T11:47:18.257Z] 11:47:18     INFO - GECKO(2947) | [Child 2949: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (10a943200) [pid = 2949] [serial = 8] [outer = 0]
[task 2023-07-24T11:47:18.257Z] 11:47:18     INFO - GECKO(2947) | [Child 2949: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (10ab42c00) [pid = 2949] [serial = 9] [outer = 10a943200]
[task 2023-07-24T11:47:18.280Z] 11:47:18     INFO - checking window state
[task 2023-07-24T11:47:18.317Z] 11:47:18     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 15 (12bb33400) [pid = 2947] [serial = 17] [outer = 132274980]
[task 2023-07-24T11:47:18.350Z] 11:47:18     INFO - GECKO(2947) | [WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2023-07-24T11:47:18.383Z] 11:47:18     INFO - GECKO(2947) | [Child 2951: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 106f60800 == 0 [pid = 2951] [id = 0] [url = about:blank]
[task 2023-07-24T11:47:18.387Z] 11:47:18     INFO - GECKO(2947) | [Child 2949: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11e4ac800 == 1 [pid = 2949] [id = 1] [url = data:text/html;charset=utf8,<!DOCTYPE html>Web Console CSP too many reports test]
[task 2023-07-24T11:47:18.412Z] 11:47:18     INFO - GECKO(2947) | [Child 2949: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (11e4adc00) [pid = 2949] [serial = 7] [outer = 0] [url = data:text/html;charset=utf8,<!DOCTYPE html>Web Console CSP too many reports test]
[task 2023-07-24T11:47:18.412Z] 11:47:18     INFO - GECKO(2947) | [Child 2949: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (10abf27a0) [pid = 2949] [serial = 5] [outer = 0] [url = data:text/html;charset=utf8,<!DOCTYPE html>Web Console CSP too many reports test]
[task 2023-07-24T11:47:18.426Z] 11:47:18     INFO - GECKO(2947) | [Child 2954: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 121b61c00 == 0 [pid = 2954] [id = 0] [url = about:newtab]
[task 2023-07-24T11:47:18.472Z] 11:47:18     INFO - GECKO(2947) | [Child 2954: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (11ce572e0) [pid = 2954] [serial = 1] [outer = 0] [url = about:newtab]
[task 2023-07-24T11:47:18.473Z] 11:47:18     INFO - GECKO(2947) | [Child 2954: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (121b69800) [pid = 2954] [serial = 3] [outer = 0] [url = about:newtab]
[task 2023-07-24T11:47:19.471Z] 11:47:19     INFO - GECKO(2947) | [Child 2951: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (106f67000) [pid = 2951] [serial = 2] [outer = 0] [url = about:blank]
[task 2023-07-24T11:47:19.471Z] 11:47:19     INFO - GECKO(2947) | [Child 2951: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (106d5a2e0) [pid = 2951] [serial = 1] [outer = 0] [url = about:blank]
[task 2023-07-24T11:47:20.678Z] 11:47:20     INFO - GECKO(2947) | Completed ShutdownLeaks collections in process 2951
[task 2023-07-24T11:47:20.683Z] 11:47:20     INFO - GECKO(2947) | Completed ShutdownLeaks collections in process 2954
[task 2023-07-24T11:47:20.702Z] 11:47:20     INFO - GECKO(2947) | Completed ShutdownLeaks collections in process 2949
[task 2023-07-24T11:47:20.834Z] 11:47:20     INFO - GECKO(2947) | Completed ShutdownLeaks collections in process 2948
[task 2023-07-24T11:47:20.865Z] 11:47:20     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (1320ab800) [pid = 2947] [serial = 9] [outer = 0] [url = about:blank]
[task 2023-07-24T11:47:21.460Z] 11:47:21     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 15 (123018800) [pid = 2947] [serial = 18] [outer = 132274980]
[task 2023-07-24T11:47:21.527Z] 11:47:21     INFO - GECKO(2947) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/fn/jpjnpp817tg6r6w_7zq4f_0c000014/T/tmpw9dkrbwx.mozrunner/runtests_leaks_tab_pid3010.log
[task 2023-07-24T11:47:21.607Z] 11:47:21     INFO - GECKO(2947) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/fn/jpjnpp817tg6r6w_7zq4f_0c000014/T/tmpw9dkrbwx.mozrunner/runtests_leaks_tab_pid3011.log
[task 2023-07-24T11:47:21.667Z] 11:47:21     INFO - GECKO(2947) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/fn/jpjnpp817tg6r6w_7zq4f_0c000014/T/tmpw9dkrbwx.mozrunner/runtests_leaks_tab_pid3012.log
[task 2023-07-24T11:47:23.937Z] 11:47:23     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (12bb33400) [pid = 2947] [serial = 17] [outer = 0] [url = about:blank]
[task 2023-07-24T11:47:24.523Z] 11:47:24     INFO - GECKO(2947) | Completed ShutdownLeaks collections in process 2947
[task 2023-07-24T11:47:24.524Z] 11:47:24     INFO - TEST-START | Shutdown
[task 2023-07-24T11:47:24.524Z] 11:47:24     INFO - Browser Chrome Test Summary
[task 2023-07-24T11:47:24.524Z] 11:47:24     INFO - Passed:  1
[task 2023-07-24T11:47:24.525Z] 11:47:24     INFO - Failed:  1
[task 2023-07-24T11:47:24.525Z] 11:47:24     INFO - Todo:    0
[task 2023-07-24T11:47:24.526Z] 11:47:24     INFO - Mode:    e10s
[task 2023-07-24T11:47:24.526Z] 11:47:24     INFO - *** End BrowserChrome Test Results ***
[task 2023-07-24T11:47:24.561Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.561Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.564Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.568Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.579Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.579Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.589Z] 11:47:24     INFO - GECKO(2947) | [Child 2948, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Conduits, ConduitClosed) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-07-24T11:47:24.597Z] 11:47:24     INFO - GECKO(2947) | [Parent 2947: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 12feb7c00 == 4 [pid = 2947] [id = 2] [url = chrome://extensions/content/dummy.xhtml]
[task 2023-07-24T11:47:24.597Z] 11:47:24     INFO - GECKO(2947) | [WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2023-07-24T11:47:24.651Z] 11:47:24     INFO - GECKO(2947) | 1690199244650	Marionette	TRACE	Received observer notification quit-application
[task 2023-07-24T11:47:24.651Z] 11:47:24     INFO - GECKO(2947) | 1690199244651	Marionette	INFO	Stopped listening on port 2828
[task 2023-07-24T11:47:24.653Z] 11:47:24     INFO - GECKO(2947) | 1690199244652	Marionette	DEBUG	Marionette stopped listening
[task 2023-07-24T11:47:24.701Z] 11:47:24     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | Uncaught exception received from previously timed out test bound  - at resource://testing-common/BrowserTestUtils.sys.mjs:519 - Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - Stack trace:
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - listener@resource://testing-common/BrowserTestUtils.sys.mjs:519:15
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - EventListener.handleEvent*browserLoaded/<@resource://testing-common/BrowserTestUtils.sys.mjs:534:27
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - browserLoaded@resource://testing-common/BrowserTestUtils.sys.mjs:484:12
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - navigateTo@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:566:44
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - async*@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js:37:9
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - async*handleTask@chrome://mochikit/content/browser-test.js:1131:26
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1345:14
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1120:14
[task 2023-07-24T11:47:24.702Z] 11:47:24     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13
[task 2023-07-24T11:47:24.712Z] 11:47:24     INFO - GECKO(2947) | [Parent 2947, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371
[task 2023-07-24T11:47:24.715Z] 11:47:24     INFO - GECKO(2947) | [Child 2948: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10a754800 == 4 [pid = 2948] [id = 4] [url = moz-extension://7880a356-0616-4df1-b48d-2bfca59756ae/_generated_background_page.html]
[task 2023-07-24T11:47:24.716Z] 11:47:24     INFO - GECKO(2947) | [Child 2948: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10a753c00 == 3 [pid = 2948] [id = 3] [url = moz-extension://becfece1-43d4-4fc4-bb43-6e0ff15bc8c6/_generated_background_page.html]
[task 2023-07-24T11:47:24.716Z] 11:47:24     INFO - GECKO(2947) | [Child 2948: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10a752000 == 2 [pid = 2948] [id = 1] [url = moz-extension://a358b57c-6eb8-469b-8091-c57bb955fcb3/_generated_background_page.html]
[task 2023-07-24T11:47:24.717Z] 11:47:24     INFO - GECKO(2947) | [Child 2948: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 120e57800 == 1 [pid = 2948] [id = 5] [url = moz-extension://056922fa-8331-42e0-86c7-f94f34322764/_generated_background_page.html]
[task 2023-07-24T11:47:24.717Z] 11:47:24     INFO - GECKO(2947) | [Child 2948: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 10a74f800 == 0 [pid = 2948] [id = 0] [url = moz-extension://39c8c875-9db0-4685-beaf-20c88f8599fa/_generated_background_page.html]

BugBot [:suhaib / :marco]

Comment 1

•

3 years ago

:tschuster, since you are the author of the regressor, bug 1839165, could you take a look?

For more information, please visit BugBot documentation.

Flags: needinfo?(tschuster)

Iulian Moraru

Comment 2

•

3 years ago

This started to fail on tier 1: https://treeherder.mozilla.org/logviewer?job_id=423852127&repo=mozilla-central&lineNumber=22673

Summary: Intermittent TV devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | Test timed out - → Intermittent devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | Test timed out -

Tom Schuster

Comment 3

•

3 years ago

Seems like the test code change in bug 1839165 comment 9 was not enough. I do see

[task 2023-07-24T11:47:17.254Z] 11:47:17     INFO - Matched a message with text: "Content-Security-Policy: Prevented too many CSP reports from being sent within a short period of time.", all messages received.

I think await waitFor(() => findMessageByType(hud, CSP_VIOLATION_MSG, ".error")); might be going wrong? Is it possible we are trying to find the CSP violation error after the "too many" error?

Probably the easiest solution is just stop looking for the violation message and only match on the "too many" error.

Flags: needinfo?(tschuster)

Tom Schuster

Updated

•

3 years ago

Flags: needinfo?(nchevobbe)

Nicolas Chevobbe [:nchevobbe]

Comment 4

•

3 years ago

erf

Maybe try to use findMessageVirtualizedByType instead of findMessageByType ? I can see a lot of network error messages which could make the virtualization kick in ?

Flags: needinfo?(nchevobbe)

Tom Schuster

Updated

•

3 years ago

Assignee: nobody → tschuster

Comment hidden (Intermittent Failures Robot)

Tom Schuster

Updated

•

3 years ago

Keywords: leave-open

Tom Schuster

Comment 7

•

3 years ago

Attached file Bug 1845127 - Await both messages. r?nchevobbe — Details

Pulsebot

Comment 8

•

3 years ago

Pushed by tschuster@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/8f6a0dbe36b0 Await both messages. r=nchevobbe,devtools-reviewers

Iulian Moraru

Comment 9

•

3 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/8f6a0dbe36b0

Tom Schuster

Comment 10

•

3 years ago

I don't think the fix actually worked, but at least we might have some new hints in the the log.

Load a page with CSP warnings.
Navigating to "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html"
Waiting for page to be loaded…
Buffered messages logged at 01:39:03
Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”)." {file: "https://example.com/browser/devtools/client/webconsole/test/browser/test-csp-many-errors.html" line: 18 column: 8 source: "background-color: rgb(0, 0, 0);"}]
... snip ...
Matched a message with text: "Content-Security-Policy: The page’s settings blocked the loading of a resource at inline (“style-src”).", all messages received.
Matched a message with text: "Content-Security-Policy: Prevented too many CSP reports from being sent within a short period of time.", all messages received.
Got violation message.
Got too many reports message.
Buffered messages finished

We never get the Waiting for console messages. info message. So to me it seems like await navigateTo(TEST_VIOLATIONS) doesn't finish in time. Maybe the page load gets stuck somehow?

BugBot [:suhaib / :marco]

Comment 11

•

3 years ago

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

status-firefox116: --- → unaffected

status-firefox117: --- → affected

status-firefox118: --- → affected

status-firefox-esr102: --- → unaffected

status-firefox-esr115: --- → unaffected

Comment hidden (Intermittent Failures Robot)

Joel Maher ( :jmaher ) (UTC -8)

Updated

•

3 years ago

Keywords: intermittent-testcase

Summary: Intermittent devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | Test timed out - → Intermittent devtools/client/webconsole/test/browser/browser_webconsole_csp_too_many_reports.js | single tracking bug

Comment hidden (Intermittent Failures Robot)

	1proc	1proc-s	1proc-swr	a11y-checks	a11y-checks-s	a11y-checks-swr	a11y-checks-swr-s	condprof	condprof-s	fis	fis-hv	fis-hv-s	fis-s	headless	headless-s	http2	http3	mda-gpu	msix	msix-s	no_variant	nofis	nofis-aab	nofis-s	nofis-ship	nofis-ship-s	nofis-spi	nofis-swr	nofis-swr-s	nogpu	nogpu-s	s	spi	spi-nw	spi-nw-1proc	spi-nw-nofis	spi-nw-nofis-s	spi-nw-s	spi-s	swr	swr-s	wr-dc1-p	xorig	xorig-s
linux1804-64-qr/opt				1
windows11-64-2009-qr/debug																					1

	a11y-checks	a11y-checks-s	no_variant
linux1804-64-qr/opt	1
linux1804-64-shippable-qr/opt		2
macosx1015-64-qr/opt			1
windows11-64-2009-qr/debug			1

	1proc	1proc-s	1proc-swr	a11y-checks	a11y-checks-s	a11y-checks-swr	a11y-checks-swr-s	condprof-s	fis	fis-hv	fis-hv-s	fis-s	headless	headless-s	http2	http3	msix	msix-s	no_variant	nofis	nofis-aab	nofis-s	nofis-ship	nofis-ship-s	nofis-spi	nofis-swr	nogpu	nogpu-s	s	spi	spi-nw	spi-nw-1proc	spi-nw-cf	spi-nw-nofis	spi-nw-s	swr	swr-s	vt	vt-s	wmfme	wmfme-s	xorig	xorig-s
linux1804-64-shippable-qr/opt																													1
windows11-64-2009-qr/debug																			1

	no_variant
linux1804-64-shippable-qr/opt	1
macosx1470-64/debug	1
macosx1470-64/opt	1
windows11-64-2009-qr/debug	1

	a11y-checks	no_variant
linux1804-64-qr/-/opt	1	1
windows11-64-2009-qr/-/opt		1
windows11-64-2009-qr/-/debug		2

	a11y-checks	no_variant
linux1804-64-qr--/opt	1
linux1804-64-tsan-qr--/opt		2
macosx1015-64-qr--/debug		2
macosx1015-64-qr--/opt		1
windows11-64-2009-ccov-qr--/opt		1
windows11-64-2009-qr--/debug		3

	no_variant
linux1804-64-tsan-qr--/opt	2
windows11-64-24h2--/debug	5

	a11y-checks	no_variant
linux1804-64-qr--/opt	1	1
linux1804-64-tsan-qr--/opt		1
macosx1470-64--/opt		1
windows11-64-24h2--/debug		1

	no_variant
macosx1470-64-devedition--/opt	1
windows11-64-24h2--/debug	2
windows11-64-24h2-devedition--/opt	1

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

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown:

Platform and build breakdown:

Table

For more details, see:

Summary

Repository breakdown: