Closed Bug 1611037 Opened 4 years ago Closed 4 years ago

Intermittent browser/components/extensions/test/browser/browser_ext_menus_events_after_context_destroy.js | Uncaught exception - [Exception... "Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIDOMWindowUtils.sendMouseEvent]" nsresult:

Categories

(WebExtensions :: Untriaged, defect, P5)

Product:
WebExtensions
Component:
Untriaged
Type:
defect

Tracking

(firefox74 fixed)

Status:
RESOLVED FIXED
Milestone:
mozilla74
Tracking Flags:
Tracking Status
firefox74 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: rpl)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Attachments

(1 file)

Bug 1611037 - Fix browser_ext_menus_events_after_context_destroy intermittency. r?robwu!
47 bytes, text/x-phabricator-request
Details | Review

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

[task 2020-01-23T02:03:22.539Z] 02:03:22 INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_menus_events_after_context_destroy.js
[task 2020-01-23T02:03:22.704Z] 02:03:22 INFO - TEST-INFO | started process screenshot
[task 2020-01-23T02:03:22.784Z] 02:03:22 INFO - TEST-INFO | screenshot: exit 0
[task 2020-01-23T02:03:22.785Z] 02:03:22 INFO - Buffered messages logged at 02:03:22
[task 2020-01-23T02:03:22.785Z] 02:03:22 INFO - Entering test bound test_subscribed_events_fired_after_context_destroy
[task 2020-01-23T02:03:22.785Z] 02:03:22 INFO - Extension loaded
[task 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Console message: Warning: attempting to write 16858 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 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Loading extension page in a tab
[task 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Console message: [JavaScript Error: "An unsupported character encoding was declared for the HTML document using a meta tag. The declaration was ignored." {file: "moz-extension://c02763da-bd67-4c49-9022-6a2e840f7b27/page.html" line: 2}]
[task 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Loading extension page in another tab
[task 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Console message: [JavaScript Error: "An unsupported character encoding was declared for the HTML document using a meta tag. The declaration was ignored." {file: "moz-extension://c02763da-bd67-4c49-9022-6a2e840f7b27/page.html" line: 2}]
[task 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Select the first tab
[task 2020-01-23T02:03:22.786Z] 02:03:22 INFO - Remove the second tab
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - Open a context menu and expect menu.onShown to be fired
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - Buffered messages finished
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_menus_events_after_context_destroy.js | Uncaught exception - [Exception... "Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIDOMWindowUtils.sendMouseEvent]" nsresult: "0x80004005 (NS_ERROR_FAILURE)" location: "JS frame :: chrome://mochikit/content/tests/SimpleTest/EventUtils.js :: synthesizeMouseAtPoint :: line 530" data: no]
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - Stack trace:
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - synthesizeMouseAtPoint@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:530:32
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - synthesizeMouse@resource://testing-common/BrowserTestUtilsChild.jsm:299:32
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - receiveMessage@resource://testing-common/BrowserTestUtilsChild.jsm:144:21
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - JSWindowActor querysendQuery@resource://testing-common/BrowserTestUtils.jsm:2283:18
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - synthesizeMouse@resource://testing-common/BrowserTestUtils.jsm:1486:17
[task 2020-01-23T02:03:22.787Z] 02:03:22 INFO - synthesizeMouseAtCenter@resource://testing-common/BrowserTestUtils.jsm:1567:29
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - openContextMenu@chrome://mochitests/content/browser/browser/components/extensions/test/browser/head.js:516:26
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - test_subscribed_events_fired_after_context_destroy@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_menus_events_after_context_destroy.js:55:9
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - AsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1062:34
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1097:11
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:925:14
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:808:67
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - Leaving test bound test_subscribed_events_fired_after_context_destroy
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_menus_events_after_context_destroy.js | Extension left running at test shutdown -
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - Stack trace:
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - chrome://mochikit/content/browser-test.js:test_ok:1292
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:109
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - chrome://mochikit/content/browser-test.js:nextTest:570
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - chrome://mochikit/content/browser-test.js:testScope/test_finish/<:1457
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - chrome://mochikit/content/browser-test.js:run:1372
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - GECKO(3424) | MEMORY STAT | vsize 2104668MB | vsizeMaxContiguous 65252846MB | residentFast 784MB | heapAllocated 453MB
[task 2020-01-23T02:03:22.788Z] 02:03:22 INFO - TEST-OK | browser/components/extensions/test/browser/browser_ext_menus_events_after_context_destroy.js | took 233ms

Has Regression Range: --- → yes
Keywords: regression

This seems to have started with the changes from bug 1602384.
luca, could you, please, take a look?

Flags: needinfo?(lgreco)

(In reply to Bogdan Tara[:bogdan_tara | bogdant] from comment #1)

This seems to have started with the changes from bug 1602384.
luca, could you, please, take a look?

yeah, that's a new test introduced in Bug 1602384.
The patch didn't actually regressed an existing test, but these failures show that the new test case can currently fail intermittently because of BrowserTestUtils.synthesizeMouse throwing.

There is a call to await window.promiseDocumentFlushed(() => {}); in the test case that was meant to prevent it (I added it when I saw the error triggered locally once), but it seems to not be enough and it was likely just making it a bit less frequent (because of the little additional latency it does introduce, but not enough to fix the intermittency on an higher number of runs :-( )

I just checked that I can also trigger this failure locally by using --verify and I'm looking into it.

Assignee: nobody → lgreco
Status: NEW → ASSIGNED
Flags: needinfo?(lgreco)
Pushed by luca.greco@alcacoop.it:
https://hg.mozilla.org/integration/autoland/rev/c31128151a25
Fix browser_ext_menus_events_after_context_destroy intermittency. r=robwu

https://hg.mozilla.org/mozilla-central/rev/c31128151a25

Status: ASSIGNED → RESOLVED
Closed: 4 years ago
status-firefox74: --- → fixed
Resolution: --- → FIXED
Target Milestone: --- → mozilla74
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: