Closed Bug 1518883 Opened 8 months ago Closed 8 months ago

Intermittent browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | Expected only extension menu items - ["context-openlinkintab","context-openlinkinusercontext-menu","context-openlink"

Categories

(WebExtensions :: Untriaged, defect, P5)

defect

Tracking

(firefox66 fixed)

RESOLVED FIXED
mozilla66
Tracking Status
firefox66 --- fixed

People

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

References

Details

(Keywords: intermittent-failure, Whiteboard: [retriggered])

Attachments

(1 file)

Filed by: cbrindusan [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=220874572&repo=autoland

https://queue.taskcluster.net/v1/task/E_xYTV8QQguqKsQShgPs6A/runs/0/artifacts/public/logs/live_backing.log

[task 2019-01-09T18:16:54.270Z] 18:16:54 INFO - TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js
[task 2019-01-09T18:16:54.270Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xdc097800 == 6 [pid = 2296] [id = {b2706996-497e-4f64-a012-3d453c30a770}]
[task 2019-01-09T18:16:54.271Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 15 (0xe1a061c0) [pid = 2296] [serial = 15] [outer = (nil)]
[task 2019-01-09T18:16:54.271Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 16 (0xdd890400) [pid = 2296] [serial = 16] [outer = 0xe1a061c0]
[task 2019-01-09T18:16:54.271Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 2 (0xe79bd400) [pid = 2491] [serial = 2] [outer = 0xf716dd90]
[task 2019-01-09T18:16:54.271Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: '!mSelection', file /builds/worker/workspace/build/src/editor/libeditor/EditorBase.cpp, line 4823
[task 2019-01-09T18:16:54.272Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: '!editActionData.CanHandle()', file /builds/worker/workspace/build/src/editor/libeditor/EditorBase.cpp, line 1250
[task 2019-01-09T18:16:54.273Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 17 (0xdd895000) [pid = 2296] [serial = 17] [outer = 0xe1a061c0]
[task 2019-01-09T18:16:54.273Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, StreamTrans #41] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 372
[task 2019-01-09T18:16:54.273Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 1010
[task 2019-01-09T18:16:54.274Z] 18:16:54 INFO - GECKO(2296) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpQtl_sD.mozrunner/runtests_leaks_tab_pid2517.log
[task 2019-01-09T18:16:54.274Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xe0ad2c00 == 7 [pid = 2296] [id = {044be8a9-efb1-4814-8e29-1dc181c3edc2}]
[task 2019-01-09T18:16:54.275Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 18 (0xe1a06420) [pid = 2296] [serial = 18] [outer = (nil)]
[task 2019-01-09T18:16:54.275Z] 18:16:54 INFO - GECKO(2296) | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-01-09T18:16:54.276Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/nsContentUtils.cpp, line 3748
[task 2019-01-09T18:16:54.277Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Error loading theme icon 'edit-clear' for stock: : 'glib warning', file /builds/worker/workspace/build/src/toolkit/xre/nsSigHandlers.cpp, line 135
[task 2019-01-09T18:16:54.277Z] 18:16:54 INFO - GECKO(2296) | (firefox:2296): Gtk-WARNING **: Error loading theme icon 'edit-clear' for stock:
[task 2019-01-09T18:16:54.277Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 23 (0xe7bb8400) [pid = 2370] [serial = 27] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.278Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 22 (0xe739a000) [pid = 2370] [serial = 24] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.279Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 21 (0xe789e000) [pid = 2370] [serial = 25] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.280Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 20 (0xe7897800) [pid = 2370] [serial = 19] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.281Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 19 (0xe7397800) [pid = 2370] [serial = 20] [outer = (nil)] [url = moz-extension://e58a43ab-c4c5-42cf-9ac5-d8fe765b5b25/sidebar.html]
[task 2019-01-09T18:16:54.281Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 18 (0xe84c9000) [pid = 2370] [serial = 22] [outer = (nil)] [url = http://mochi.test:8888/?sidebar]
[task 2019-01-09T18:16:54.282Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 17 (0xe7392000) [pid = 2370] [serial = 14] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.282Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 16 (0xe7393400) [pid = 2370] [serial = 15] [outer = (nil)] [url = moz-extension://598790fe-dada-478c-b246-4102c533e8b9/_generated_background_page.html]
[task 2019-01-09T18:16:54.284Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 15 (0xe7396000) [pid = 2370] [serial = 17] [outer = (nil)] [url = http://mochi.test:8888/?background]
[task 2019-01-09T18:16:54.285Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 14 (0xe7898800) [pid = 2370] [serial = 8] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.286Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 13 (0xe78a1c00) [pid = 2370] [serial = 12] [outer = (nil)] [url = moz-extension://da3bc560-b896-4acc-9613-3cc60ad8302f/_generated_background_page.html]
[task 2019-01-09T18:16:54.286Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 12 (0xe7bc0800) [pid = 2370] [serial = 5] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.287Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 11 (0xf7197000) [pid = 2370] [serial = 6] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.287Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 10 (0xe7897c00) [pid = 2370] [serial = 7] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.288Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 19 (0xe3ea0c00) [pid = 2296] [serial = 19] [outer = 0xe1a06420]
[task 2019-01-09T18:16:54.288Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 226
[task 2019-01-09T18:16:54.289Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 226
[task 2019-01-09T18:16:54.289Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Found a principal with no URI, assuming third-party request: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 226
[task 2019-01-09T18:16:54.290Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 20 (0xdecb6400) [pid = 2296] [serial = 20] [outer = 0xe1a06420]
[task 2019-01-09T18:16:54.291Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 3 (0xe7bb8800) [pid = 2389] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.291Z] 18:16:54 INFO - GECKO(2296) | --DOCSHELL 0xe7769400 == 0 [pid = 2389] [id = {1be72dd9-abc1-4202-b65b-bb04bf3e6a4d}]
[task 2019-01-09T18:16:54.292Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 2 (0xf706dd90) [pid = 2389] [serial = 1] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.293Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/worker/workspace/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 318
[task 2019-01-09T18:16:54.294Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Need TabChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1083
[task 2019-01-09T18:16:54.295Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xe7392000 == 7 [pid = 2370] [id = {fe522f10-fe03-488d-aa90-0ae62aa1ab1b}]
[task 2019-01-09T18:16:54.295Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 11 (0xf716f120) [pid = 2370] [serial = 32] [outer = (nil)]
[task 2019-01-09T18:16:54.296Z] 18:16:54 INFO - GECKO(2296) | [Child 2370, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/TabChild.cpp, line 2564
[task 2019-01-09T18:16:54.297Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 12 (0xe7395800) [pid = 2370] [serial = 33] [outer = 0xf716f120]
[task 2019-01-09T18:16:54.298Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 13 (0xe789b400) [pid = 2370] [serial = 34] [outer = 0xf716f120]
[task 2019-01-09T18:16:54.299Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Content used context-fill-opacity when not in a context element: file /builds/worker/workspace/build/src/layout/svg/nsSVGUtils.cpp, line 1497
[task 2019-01-09T18:16:54.299Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xe789c800 == 8 [pid = 2370] [id = {ccc57e73-5e2f-4d0d-8270-8ffceb335a71}]
[task 2019-01-09T18:16:54.300Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 14 (0xf716f970) [pid = 2370] [serial = 35] [outer = (nil)]
[task 2019-01-09T18:16:54.300Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 15 (0xe78a1c00) [pid = 2370] [serial = 36] [outer = 0xf716f970]
[task 2019-01-09T18:16:54.301Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 16 (0xe7bb8000) [pid = 2370] [serial = 37] [outer = 0xf716f970]
[task 2019-01-09T18:16:54.302Z] 18:16:54 INFO - GECKO(2296) | --DOCSHELL 0xe7390000 == 7 [pid = 2370] [id = {8d803197-b0a0-4f4b-a43e-25c6f816fd1d}]
[task 2019-01-09T18:16:54.304Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 15 (0xf71707b0) [pid = 2370] [serial = 29] [outer = (nil)] [url = http://mochi.test:8888/?browser_action_popup]
[task 2019-01-09T18:16:54.304Z] 18:16:54 INFO - GECKO(2296) | --DOCSHELL 0xe7395400 == 6 [pid = 2370] [id = {0c3ece84-f551-43c6-bb65-33290adddcb3}]
[task 2019-01-09T18:16:54.306Z] 18:16:54 INFO - GECKO(2296) | --DOCSHELL 0xe84c4000 == 5 [pid = 2370] [id = {47cc7437-0915-4138-a529-67aa823221b7}]
[task 2019-01-09T18:16:54.306Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 14 (0xf7170420) [pid = 2370] [serial = 23] [outer = (nil)] [url = moz-extension://5bcc961d-6c3d-4874-87a7-977e8f53145c/popup.html]
[task 2019-01-09T18:16:54.307Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x80004005: file /builds/worker/workspace/build/src/docshell/shistory/nsSHistory.cpp, line 1198
[task 2019-01-09T18:16:54.308Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x80004005: file /builds/worker/workspace/build/src/docshell/shistory/nsSHistory.cpp, line 1198
[task 2019-01-09T18:16:54.308Z] 18:16:54 INFO - GECKO(2296) | [Child 2370, Main Thread] WARNING: NS_ENSURE_TRUE(mDoneSetup) failed: file /builds/worker/workspace/build/src/editor/composer/nsEditingSession.cpp, line 1209
[task 2019-01-09T18:16:54.309Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xdec88800 == 8 [pid = 2296] [id = {3d3be840-ddea-4a6f-9d7b-5a990a8c3026}]
[task 2019-01-09T18:16:54.309Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 21 (0xe66e0a10) [pid = 2296] [serial = 21] [outer = (nil)]
[task 2019-01-09T18:16:54.310Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 22 (0xe0a2a000) [pid = 2296] [serial = 22] [outer = 0xe66e0a10]
[task 2019-01-09T18:16:54.310Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/workspace/build/src/dom/quota/ActorsParent.cpp, line 7108
[task 2019-01-09T18:16:54.310Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/workspace/build/src/dom/quota/ActorsParent.cpp, line 7108
[task 2019-01-09T18:16:54.311Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/workspace/build/src/dom/quota/ActorsParent.cpp, line 7108
[task 2019-01-09T18:16:54.311Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, QuotaManager IO] WARNING: 'NS_FAILED(directory->GetDirectoryEntries(getter_AddRefs(entries)))', file /builds/worker/workspace/build/src/dom/quota/ActorsParent.cpp, line 7108
[task 2019-01-09T18:16:54.313Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 23 (0xdecb7400) [pid = 2296] [serial = 23] [outer = 0xe66e0a10]
[task 2019-01-09T18:16:54.314Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 2 (0xe78bc800) [pid = 2466] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.316Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 1 (0xe77ca000) [pid = 2389] [serial = 4] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.317Z] 18:16:54 INFO - GECKO(2296) | --DOMWINDOW == 0 (0xe7bb7c00) [pid = 2389] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-01-09T18:16:54.319Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xdcfe1c00 == 9 [pid = 2296] [id = {a16b4122-cb53-420f-9381-b1d0ed4435ac}]
[task 2019-01-09T18:16:54.320Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 24 (0xe66e0c70) [pid = 2296] [serial = 24] [outer = (nil)]
[task 2019-01-09T18:16:54.321Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/nsContentUtils.cpp, line 3748
[task 2019-01-09T18:16:54.323Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 25 (0xe5d2d800) [pid = 2296] [serial = 25] [outer = 0xe66e0c70]
[task 2019-01-09T18:16:54.324Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Content used context-fill-opacity when not in a context element: file /builds/worker/workspace/build/src/layout/svg/nsSVGUtils.cpp, line 1497
[task 2019-01-09T18:16:54.326Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111: file /builds/worker/workspace/build/src/netwerk/protocol/res/SubstitutingProtocolHandler.cpp, line 318
[task 2019-01-09T18:16:54.328Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Need TabChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1083
[task 2019-01-09T18:16:54.329Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xe7399800 == 6 [pid = 2370] [id = {cf9bc9a7-d5a4-493a-a122-b51b266cd56d}]
[task 2019-01-09T18:16:54.330Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 15 (0xf716fd00) [pid = 2370] [serial = 38] [outer = (nil)]
[task 2019-01-09T18:16:54.332Z] 18:16:54 INFO - GECKO(2296) | [Child 2370, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/TabChild.cpp, line 2564
[task 2019-01-09T18:16:54.333Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 16 (0xe789bc00) [pid = 2370] [serial = 39] [outer = 0xf716fd00]
[task 2019-01-09T18:16:54.334Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 17 (0xe78a0c00) [pid = 2370] [serial = 40] [outer = 0xf716fd00]
[task 2019-01-09T18:16:54.336Z] 18:16:54 INFO - GECKO(2296) | ++DOCSHELL 0xe7bbd000 == 7 [pid = 2370] [id = {387ef727-6d34-4ca2-8ba9-57a04ed29603}]
[task 2019-01-09T18:16:54.340Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 18 (0xf7170680) [pid = 2370] [serial = 41] [outer = (nil)]
[task 2019-01-09T18:16:54.341Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 19 (0xe7bc0800) [pid = 2370] [serial = 42] [outer = 0xf7170680]
[task 2019-01-09T18:16:54.342Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: Content used context-fill-opacity when not in a context element: file /builds/worker/workspace/build/src/layout/svg/nsSVGUtils.cpp, line 1497
[task 2019-01-09T18:16:54.344Z] 18:16:54 INFO - GECKO(2296) | ++DOMWINDOW == 20 (0xe84c5000) [pid = 2370] [serial = 43] [outer = 0xf7170680]
[task 2019-01-09T18:16:54.345Z] 18:16:54 INFO - GECKO(2296) | JavaScript error: resource:///actors/ContextMenuChild.jsm, line 478: TypeError: doc is null
[task 2019-01-09T18:16:54.347Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, StreamTrans #49] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 372
[task 2019-01-09T18:16:54.348Z] 18:16:54 INFO - GECKO(2296) | [Parent 2296, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 1010
[task 2019-01-09T18:16:54.349Z] 18:16:54 INFO - TEST-INFO | started process screentopng
[task 2019-01-09T18:16:54.840Z] 18:16:54 INFO - TEST-INFO | screentopng: exit 0
[task 2019-01-09T18:16:54.842Z] 18:16:54 INFO - Buffered messages logged at 18:15:16
[task 2019-01-09T18:16:54.843Z] 18:16:54 INFO - Entering test bound test_tab_options_popups
[task 2019-01-09T18:16:54.846Z] 18:16:54 INFO - Extension loaded
[task 2019-01-09T18:16:54.848Z] 18:16:54 INFO - Buffered messages logged at 18:15:22
[task 2019-01-09T18:16:54.850Z] 18:16:54 INFO - Global property added while loading chrome://browser/content/nsContextMenu.js: gContextMenuContentData
[task 2019-01-09T18:16:54.852Z] 18:16:54 INFO - Global property added while loading chrome://browser/content/nsContextMenu.js: SpellCheckHelper
[task 2019-01-09T18:16:54.854Z] 18:16:54 INFO - Global property added while loading chrome://browser/content/nsContextMenu.js: LoginHelper
[task 2019-01-09T18:16:54.855Z] 18:16:54 INFO - Global property added while loading chrome://browser/content/nsContextMenu.js: LoginManagerContextMenu
[task 2019-01-09T18:16:54.856Z] 18:16:54 INFO - Global property added while loading chrome://browser/content/nsContextMenu.js: DevToolsShim
[task 2019-01-09T18:16:54.860Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-openlinkintab should not be hidden -
[task 2019-01-09T18:16:54.862Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-openlinkintab should not be disabled -
[task 2019-01-09T18:16:54.863Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-openlinkprivate should not be hidden -
[task 2019-01-09T18:16:54.865Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-openlinkprivate should not be disabled -
[task 2019-01-09T18:16:54.866Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-copylink should not be hidden -
[task 2019-01-09T18:16:54.868Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-copylink should not be disabled -
[task 2019-01-09T18:16:54.869Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-openlinkinusercontext-menu should not be hidden -
[task 2019-01-09T18:16:54.871Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | context-openlinkinusercontext-menu should not be disabled -
[task 2019-01-09T18:16:54.880Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | Got a targetElementId in the menu details -
[task 2019-01-09T18:16:54.882Z] 18:16:54 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | Got the expected menu details from menus.onShown - {"menuIds":["anypage"],"contexts":["link","all"],"viewType":"undefined","frameId":0,"editable":false,"linkText":"options page link","linkUrl":"http://mochi.test:8888/","pageUrl":"moz-extension://4b10e735-03d2-4634-83e3-959977bd6646/options.html"} deepEqual {"menuIds":["anypage"],"contexts":["link","all"],"viewType":"undefined","frameId":0,"editable":false,"linkText":"options page link","linkUrl":"http://mochi.test:8888/","pageUrl":"moz-extension://4b10e735-03d2-4634-83e3-959977bd6646/options.html"} -
[task 2019-01-09T18:16:54.883Z] 18:16:54 INFO - Leaving test bound test_tab_options_popups
[task 2019-01-09T18:16:54.884Z] 18:16:54 INFO - Entering test bound overrideContext_in_options_page
[task 2019-01-09T18:16:54.886Z] 18:16:54 INFO - Buffered messages logged at 18:15:23
[task 2019-01-09T18:16:54.887Z] 18:16:54 INFO - Extension loaded
[task 2019-01-09T18:16:54.888Z] 18:16:54 INFO - Buffered messages logged at 18:15:26
[task 2019-01-09T18:16:54.890Z] 18:16:54 INFO - Console message: [JavaScript Error: "TypeError: doc is null" {file: "resource:///actors/ContextMenuChild.jsm" line: 478}]
[task 2019-01-09T18:16:54.891Z] 18:16:54 INFO - Buffered messages finished
[task 2019-01-09T18:16:54.892Z] 18:16:54 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js | Expected only extension menu items - ["context-openlinkintab","context-openlinkinusercontext-menu","context-openlink","context-openlinkprivate","context-sep-open","context-bookmarklink","context-savelink","context-savelinktopocket","context-copylink","context-searchselect","context-sep-sendlinktodevice","context-sendlinktodevice","","5c0c1fa470041f957a883c14709b947b98703dd8_temporary-addon-menuitem-2"] deepEqual ["5c0c1fa470041f957a883c14709b947b98703dd8_temporary-addon-menuitem-_bg_1_1","5c0c1fa470041f957a883c14709b947b98703dd8_temporary-addon-menuitem-_bg_1_2"] - JS frame :: chrome://mochitests/content/browser/browser/components/extensions/test/browser/test-oop-extensions/browser_ext_optionsPage_popups.js :: overrideContext_in_options_page :: line 186

This patch applies the following small change to the openContextMenuInOptionsPage test helper:

Instead of using BrowserTestUtils.synthesizeMouseAtCenter, the new version of the test helper
triggers a contextmenu event directly on the target element, to prevent intermittent failures
on debug builds (especially linux32-debug).

The intermittent failures seem to be originated by an unexpected behavior of DOMWindowUtils's
sendMouseEvent method, which is randomly triggering mouse events targeting the entire HTML document
instead of the intended DOMElement (despites the EventUtils.js "synthesizeMouseAtPoint" method is
computing the same `left` and `top` position in both the cases).

It seems that there could be some timing reasons behind the issue, because the intermittency
is reduced by adding an arbitrary long delay before triggering the mouse event.
Assignee: nobody → lgreco
Status: NEW → ASSIGNED
Flags: needinfo?(lgreco)
Pushed by luca.greco@alcacoop.it:
https://hg.mozilla.org/integration/autoland/rev/5fd809e7035d
Fix browser_ext_optionsPage_popups.js high intermittency on linux32-debug. r=mixedpuppy
See Also: → 1519808
Status: ASSIGNED → RESOLVED
Closed: 8 months ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla66

Will manual validation be required for this bug? if so please specify some steps to correctly test the fix.

Flags: needinfo?(lgreco)

Setting qe-verify-, as this is a test-only change.

Flags: needinfo?(lgreco) → qe-verify-
You need to log in before you can comment on or make changes to this bug.