Intermittent toolkit/components/extensions/test/mochitest/test_ext_listener_proxies.html | Test timed out. - | Extension left running at test shutdown
Categories
(WebExtensions :: General, defect, P5)
Tracking
(Not tracked)
People
(Reporter: intermittent-bug-filer, Unassigned)
References
(Blocks 1 open bug)
Details
(Keywords: intermittent-failure)
Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=347882315&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/SUQUA-3XRsi68FPB3pg86A/runs/1/artifacts/public/logs/live_backing.log
[task 2021-08-09T21:19:18.327Z] 21:19:18 INFO - TEST-START | toolkit/components/extensions/test/mochitest/test_ext_listener_proxies.html
[task 2021-08-09T21:19:18.431Z] 21:19:18 INFO - GECKO(1891) | [Child 3895, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-08-09T21:19:18.459Z] 21:19:18 INFO - GECKO(1891) | [Child 3895, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-08-09T21:19:18.499Z] 21:19:18 INFO - GECKO(1891) | [Parent 1891, Main Thread] WARNING: WebProgress Ignored: no longer current window global: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:2978
[task 2021-08-09T21:19:18.948Z] 21:19:18 INFO - GECKO(1891) | Console message: Warning: attempting to write 6193 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-08-09T21:19:18.987Z] 21:19:18 INFO - GECKO(1891) | [Child 1986, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2857
[task 2021-08-09T21:19:19.510Z] 21:19:19 INFO - GECKO(1891) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp499g4kel.mozrunner/runtests_leaks_tab_pid3999.log
[task 2021-08-09T21:19:19.512Z] 21:19:19 INFO - GECKO(1891) | [3999, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:250
[task 2021-08-09T21:19:19.543Z] 21:19:19 INFO - GECKO(1891) | [Child 3999, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:619
[task 2021-08-09T21:21:28.500Z] 21:21:28 INFO - GECKO(1891) | Console message: [JavaScript Error: "Failed to fetch data from Contile server: NetworkError when attempting to fetch resource." {file: "resource://activity-stream/lib/TopSitesFeed.jsm" line: 200}]
[task 2021-08-09T21:21:28.500Z] 21:21:28 INFO - GECKO(1891) | _fetchSites@resource://activity-stream/lib/TopSitesFeed.jsm:200:10
[task 2021-08-09T21:24:32.462Z] 21:24:32 INFO - TEST-INFO | started process screentopng
[task 2021-08-09T21:24:32.607Z] 21:24:32 INFO - TEST-INFO | screentopng: exit 0
[task 2021-08-09T21:24:32.608Z] 21:24:32 INFO - Buffered messages logged at 21:19:18
[task 2021-08-09T21:24:32.609Z] 21:24:32 INFO - add_task | Entering test test_listener_proxies
[task 2021-08-09T21:24:32.609Z] 21:24:32 INFO - Extension loaded
[task 2021-08-09T21:24:32.609Z] 21:24:32 INFO - Buffered messages finished
[task 2021-08-09T21:24:32.609Z] 21:24:32 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_listener_proxies.html | Test timed out. -
[task 2021-08-09T21:24:33.690Z] 21:24:33 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-09T21:24:33.692Z] 21:24:33 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/extensions/test/mochitest/test_ext_listener_proxies.html | Extension left running at test shutdown
[task 2021-08-09T21:24:33.692Z] 21:24:33 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2021-08-09T21:24:33.692Z] 21:24:33 INFO - ExtensionTestUtils.loadExtension/<@SimpleTest/ExtensionTestUtils.js:117:18
[task 2021-08-09T21:24:33.692Z] 21:24:33 INFO - executeCleanupFunction@SimpleTest/SimpleTest.js:1487:13
[task 2021-08-09T21:24:33.693Z] 21:24:33 INFO - SimpleTest.finish@SimpleTest/SimpleTest.js:1501:3
[task 2021-08-09T21:24:33.693Z] 21:24:33 INFO - @SimpleTest/SimpleTest.js:2141:16
[task 2021-08-09T21:24:33.717Z] 21:24:33 INFO - GECKO(1891) | [Child 1986, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:40
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | Console message: [JavaScript Error: "sendRemoveListener on closed conduit 79f3b3822b89614836af8f7f2e5f015f77ed200b@temporary-addon.274877907574" {file: "resource://gre/modules/ConduitsChild.jsm" line: 108}]
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | _send@resource://gre/modules/ConduitsChild.jsm:108:13
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:663:34
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:891:40
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | getAPI/register/<.storage.onChanged@chrome://extensions/content/child/ext-storage.js:332:22
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionCommon.jsm:2534:7
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | revoke@resource://gre/modules/ExtensionCommon.jsm:2556:12
[task 2021-08-09T21:24:33.790Z] 21:24:33 INFO - GECKO(1891) | close@resource://gre/modules/ExtensionCommon.jsm:2561:10
[task 2021-08-09T21:24:33.791Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionCommon.jsm:922:11
[task 2021-08-09T21:24:33.800Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:261:11
[task 2021-08-09T21:24:33.800Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:298:11
[task 2021-08-09T21:24:33.801Z] 21:24:33 INFO - GECKO(1891) | destroyExtensionContext@resource://gre/modules/ExtensionPageChild.jsm:482:15
[task 2021-08-09T21:24:33.801Z] 21:24:33 INFO - GECKO(1891) | observe@resource://gre/modules/ExtensionPageChild.jsm:395:12
[task 2021-08-09T21:24:33.801Z] 21:24:33 INFO - GECKO(1891) | Console message: [JavaScript Error: "sendRemoveListener on closed conduit 79f3b3822b89614836af8f7f2e5f015f77ed200b@temporary-addon.274877907574" {file: "resource://gre/modules/ConduitsChild.jsm" line: 108}]
[task 2021-08-09T21:24:33.802Z] 21:24:33 INFO - GECKO(1891) | _send@resource://gre/modules/ConduitsChild.jsm:108:13
[task 2021-08-09T21:24:33.805Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:663:34
[task 2021-08-09T21:24:33.805Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:891:40
[task 2021-08-09T21:24:33.805Z] 21:24:33 INFO - GECKO(1891) | getAPI/register/<.storage.onChanged@chrome://extensions/content/child/ext-storage.js:332:22
[task 2021-08-09T21:24:33.806Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionCommon.jsm:2534:7
[task 2021-08-09T21:24:33.807Z] 21:24:33 INFO - GECKO(1891) | revoke@resource://gre/modules/ExtensionCommon.jsm:2556:12
[task 2021-08-09T21:24:33.808Z] 21:24:33 INFO - GECKO(1891) | close@resource://gre/modules/ExtensionCommon.jsm:2561:10
[task 2021-08-09T21:24:33.809Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionCommon.jsm:922:11
[task 2021-08-09T21:24:33.810Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:261:11
[task 2021-08-09T21:24:33.812Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:298:11
[task 2021-08-09T21:24:33.813Z] 21:24:33 INFO - GECKO(1891) | destroyExtensionContext@resource://gre/modules/ExtensionPageChild.jsm:482:15
[task 2021-08-09T21:24:33.814Z] 21:24:33 INFO - GECKO(1891) | observe@resource://gre/modules/ExtensionPageChild.jsm:395:12
[task 2021-08-09T21:24:33.814Z] 21:24:33 INFO - GECKO(1891) | Console message: [JavaScript Error: "sendRemoveListener on closed conduit 79f3b3822b89614836af8f7f2e5f015f77ed200b@temporary-addon.274877907574" {file: "resource://gre/modules/ConduitsChild.jsm" line: 108}]
[task 2021-08-09T21:24:33.815Z] 21:24:33 INFO - GECKO(1891) | _send@resource://gre/modules/ConduitsChild.jsm:108:13
[task 2021-08-09T21:24:33.815Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:663:34
[task 2021-08-09T21:24:33.816Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:891:40
[task 2021-08-09T21:24:33.817Z] 21:24:33 INFO - GECKO(1891) | getAPI/register/<.storage.onChanged@chrome://extensions/content/child/ext-storage.js:332:22
[task 2021-08-09T21:24:33.817Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionCommon.jsm:2534:7
[task 2021-08-09T21:24:33.818Z] 21:24:33 INFO - GECKO(1891) | revoke@resource://gre/modules/ExtensionCommon.jsm:2556:12
[task 2021-08-09T21:24:33.819Z] 21:24:33 INFO - GECKO(1891) | close@resource://gre/modules/ExtensionCommon.jsm:2561:10
[task 2021-08-09T21:24:33.820Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionCommon.jsm:922:11
[task 2021-08-09T21:24:33.820Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:261:11
[task 2021-08-09T21:24:33.821Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:298:11
[task 2021-08-09T21:24:33.822Z] 21:24:33 INFO - GECKO(1891) | destroyExtensionContext@resource://gre/modules/ExtensionPageChild.jsm:482:15
[task 2021-08-09T21:24:33.823Z] 21:24:33 INFO - GECKO(1891) | observe@resource://gre/modules/ExtensionPageChild.jsm:395:12
[task 2021-08-09T21:24:33.824Z] 21:24:33 INFO - GECKO(1891) | Console message: [JavaScript Error: "sendRemoveListener on closed conduit 79f3b3822b89614836af8f7f2e5f015f77ed200b@temporary-addon.274877907574" {file: "resource://gre/modules/ConduitsChild.jsm" line: 108}]
[task 2021-08-09T21:24:33.824Z] 21:24:33 INFO - GECKO(1891) | _send@resource://gre/modules/ConduitsChild.jsm:108:13
[task 2021-08-09T21:24:33.825Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:663:34
[task 2021-08-09T21:24:33.826Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionChild.jsm:891:40
[task 2021-08-09T21:24:33.827Z] 21:24:33 INFO - GECKO(1891) | getAPI/register/<.storage.onChanged@chrome://extensions/content/child/ext-storage.js:332:22
[task 2021-08-09T21:24:33.828Z] 21:24:33 INFO - GECKO(1891) | removeListener@resource://gre/modules/ExtensionCommon.jsm:2534:7
[task 2021-08-09T21:24:33.828Z] 21:24:33 INFO - GECKO(1891) | revoke@resource://gre/modules/ExtensionCommon.jsm:2556:12
[task 2021-08-09T21:24:33.829Z] 21:24:33 INFO - GECKO(1891) | close@resource://gre/modules/ExtensionCommon.jsm:2561:10
[task 2021-08-09T21:24:33.830Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionCommon.jsm:922:11
[task 2021-08-09T21:24:33.831Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:261:11
[task 2021-08-09T21:24:33.832Z] 21:24:33 INFO - GECKO(1891) | unload@resource://gre/modules/ExtensionPageChild.jsm:298:11
[task 2021-08-09T21:24:33.832Z] 21:24:33 INFO - GECKO(1891) | destroyExtensionContext@resource://gre/modules/ExtensionPageChild.jsm:482:15
[task 2021-08-09T21:24:33.833Z] 21:24:33 INFO - GECKO(1891) | observe@resource://gre/modules/ExtensionPageChild.jsm:395:12
[task 2021-08-09T21:24:33.834Z] 21:24:33 INFO - GECKO(1891) | Console message: Warning: attempting to write 6095 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-08-09T21:24:33.850Z] 21:24:33 INFO - GECKO(1891) | MEMORY STAT | vsize 2523MB | residentFast 145MB | heapAllocated 8MB
[task 2021-08-09T21:24:33.866Z] 21:24:33 INFO - TEST-OK | toolkit/components/extensions/test/mochitest/test_ext_listener_proxies.html | took 315541ms
[task 2021-08-09T21:24:33.903Z] 21:24:33 INFO - GECKO(1891) | [Parent 1891, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-09T21:24:33.916Z] 21:24:33 INFO - GECKO(1891) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-08-09T21:24:34.018Z] 21:24:34 INFO - TEST-START | toolkit/components/extensions/test/mochitest/test_ext_new_tab_processType.html
Comment hidden (Intermittent Failures Robot) |
Comment 2•4 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Comment 3•4 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=356088689&repo=autoland&lineNumber=14564
Comment hidden (Intermittent Failures Robot) |
Comment 5•4 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Reporter | ||
Comment 6•3 years ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=376325461&repo=mozilla-central
Comment hidden (Intermittent Failures Robot) |
Comment 8•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Reporter | ||
Comment 9•3 years ago
|
||
treeherder |
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=384068815&repo=autoland
Comment hidden (Intermittent Failures Robot) |
Updated•3 years ago
|
Description
•