Open Bug 1823742 Opened 2 years ago Updated 1 year ago

Intermittent dom/workers/test/browser_worker_use_counters.js | single tracking bug

Categories

(Core :: DOM: Workers, defect, P5)

defect

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, intermittent-testcase)

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


[task 2023-03-21T16:39:55.695Z] 16:39:55     INFO - GECKO(2519) | [Child 2681, Main Thread] WARNING: IPC message 'PSessionStore::Msg_SessionStoreUpdate' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:504
[task 2023-03-21T16:39:57.152Z] 16:39:57     INFO - TEST-INFO | started process screentopng
[task 2023-03-21T16:39:57.472Z] 16:39:57     INFO - TEST-INFO | screentopng: exit 0
[task 2023-03-21T16:39:57.472Z] 16:39:57     INFO - Buffered messages logged at 16:39:50
[task 2023-03-21T16:39:57.472Z] 16:39:57     INFO - Entering test bound test_dedicated_worker
[task 2023-03-21T16:39:57.472Z] 16:39:57     INFO - checking CONSOLE_LOG use counters for DEDICATED worker
[task 2023-03-21T16:39:57.472Z] 16:39:57     INFO - Buffered messages finished
[task 2023-03-21T16:39:57.473Z] 16:39:57     INFO - TEST-UNEXPECTED-FAIL | dom/workers/test/browser_worker_use_counters.js | histogram CONSOLE_LOG counts for DEDICATED worker are correct - Got +0, expected 1
[task 2023-03-21T16:39:57.473Z] 16:39:57     INFO - Stack trace:
[task 2023-03-21T16:39:57.473Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:test_is:1512
[task 2023-03-21T16:39:57.473Z] 16:39:57     INFO - chrome://mochitests/content/browser/dom/workers/test/browser_worker_use_counters.js:check_use_counter_worker:73
[task 2023-03-21T16:39:57.473Z] 16:39:57     INFO - chrome://mochitests/content/browser/dom/workers/test/browser_worker_use_counters.js:test_dedicated_worker:87
[task 2023-03-21T16:39:57.473Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:handleTask:1039
[task 2023-03-21T16:39:57.474Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1111
[task 2023-03-21T16:39:57.474Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1253
[task 2023-03-21T16:39:57.474Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1028
[task 2023-03-21T16:39:57.474Z] 16:39:57     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1053
[task 2023-03-21T16:39:57.475Z] 16:39:57     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-03-21T16:39:57.477Z] 16:39:57     INFO - TEST-UNEXPECTED-FAIL | dom/workers/test/browser_worker_use_counters.js | DEDICATED worker counts are correct - 
[task 2023-03-21T16:39:57.478Z] 16:39:57     INFO - Stack trace:
[task 2023-03-21T16:39:57.478Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:test_ok:1484
[task 2023-03-21T16:39:57.478Z] 16:39:57     INFO - chrome://mochitests/content/browser/dom/workers/test/browser_worker_use_counters.js:check_use_counter_worker:80
[task 2023-03-21T16:39:57.478Z] 16:39:57     INFO - chrome://mochitests/content/browser/dom/workers/test/browser_worker_use_counters.js:test_dedicated_worker:87
[task 2023-03-21T16:39:57.478Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:handleTask:1039
[task 2023-03-21T16:39:57.480Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1111
[task 2023-03-21T16:39:57.481Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1253
[task 2023-03-21T16:39:57.482Z] 16:39:57     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1028
[task 2023-03-21T16:39:57.483Z] 16:39:57     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1053
[task 2023-03-21T16:39:57.487Z] 16:39:57     INFO - Leaving test bound test_dedicated_worker
[task 2023-03-21T16:39:57.488Z] 16:39:57     INFO - Entering test bound test_shared_worker
[task 2023-03-21T16:39:57.488Z] 16:39:57     INFO - checking CONSOLE_LOG use counters for SHARED worker
[task 2023-03-21T16:39:57.489Z] 16:39:57     INFO - GECKO(2519) | [Child 2836: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7fd8e442bc00 == 2 [pid = 2836] [id = 1]
[task 2023-03-21T16:39:57.490Z] 16:39:57     INFO - GECKO(2519) | [Child 2836: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7fd8e9739850) [pid = 2836] [serial = 3] [outer = 0]
[task 2023-03-21T16:39:57.490Z] 16:39:57     INFO - GECKO(2519) | [Child 2836: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7fd8e442c400) [pid = 2836] [serial = 4] [outer = 7fd8e9739850]
[task 2023-03-21T16:39:57.490Z] 16:39:57     INFO - GECKO(2519) | [Child 2681, Main Thread] WARNING: IPC message 'PSessionStore::Msg_SessionStoreUpdate' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:504
[task 2023-03-21T16:39:57.532Z] 16:39:57     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f995333a400 == 1 [pid = 3312] [id = 0]
[task 2023-03-21T16:39:57.532Z] 16:39:57     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f9958439470) [pid = 3312] [serial = 1] [outer = 0]
[task 2023-03-21T16:39:57.535Z] 16:39:57     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f995333ac00) [pid = 3312] [serial = 2] [outer = 7f9958439470]
[task 2023-03-21T16:39:57.732Z] 16:39:57     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f995333d400) [pid = 3312] [serial = 3] [outer = 7f9958439470]
[task 2023-03-21T16:39:57.950Z] 16:39:57     INFO - GECKO(2519) | [Child 3312, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/toolkit/xre/nsXREDirProvider.cpp:475
[task 2023-03-21T16:39:58.096Z] 16:39:58     INFO - GECKO(2519) | [Child 3312, DOM Worker] WARNING: Console.maxLogLevelPref is not supported on workers!: file /builds/worker/checkouts/gecko/dom/console/Console.cpp:2862
[task 2023-03-21T16:39:58.356Z] 16:39:58     INFO - GECKO(2519) | [Parent 2519, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-03-21T16:39:58.369Z] 16:39:58     INFO - GECKO(2519) | [Parent 2519, Compositor] WARNING: IPC Connection Error: [Parent][PCompositorManagerParent] RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1927
[task 2023-03-21T16:39:58.398Z] 16:39:58     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f995333a400 == 0 [pid = 3312] [id = 0] [url = https://example.com/browser/dom/workers/test/file_use_counter_worker.html]
[task 2023-03-21T16:39:58.422Z] 16:39:58     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f9958439470) [pid = 3312] [serial = 1] [outer = 0] [url = https://example.com/browser/dom/workers/test/file_use_counter_worker.html]
[task 2023-03-21T16:39:58.425Z] 16:39:58     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f995333ac00) [pid = 3312] [serial = 2] [outer = 0] [url = about:blank]
[task 2023-03-21T16:39:58.426Z] 16:39:58     INFO - GECKO(2519) | [Child 3312: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f995333d400) [pid = 3312] [serial = 3] [outer = 0] [url = https://example.com/browser/dom/workers/test/file_use_counter_worker.html]
[task 2023-03-21T16:39:58.429Z] 16:39:58     INFO - GECKO(2519) | [Child 3312, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3396
[task 2023-03-21T16:39:58.433Z] 16:39:58     INFO - GECKO(2519) | [Child 3312, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2023-03-21T16:39:58.442Z] 16:39:58     INFO - GECKO(2519) | [Child 3312, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4689
[task 2023-03-21T16:39:58.465Z] 16:39:58     INFO - TEST-PASS | dom/workers/test/browser_worker_use_counters.js | histogram CONSOLE_LOG counts for SHARED worker are correct - 
[task 2023-03-21T16:39:58.469Z] 16:39:58     INFO - TEST-PASS | dom/workers/test/browser_worker_use_counters.js | SHARED worker counts are correct - 
[task 2023-03-21T16:39:58.469Z] 16:39:58     INFO - Leaving test bound test_shared_worker
You need to log in before you can comment on or make changes to this bug.