1533497 - Intermittent browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Test timed out -

Status: RESOLVED INCOMPLETE

(WebExtensions :: Untriaged, defect, P5)

Description

[Treeherder Bug Filer]

#[markdown(off)]
Filed by: nerli [at] mozilla.com

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

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

18:12:06 INFO - TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js
18:12:06 INFO - GECKO(4660) | Extension error: Error: Incorrect argument types for menus.getTargetElement. moz-extension://4b915374-08a4-4cc1-92ff-29431e5f7797/sidebar.js 4
18:12:06 INFO - GECKO(4660) | [[Exception stack
18:12:06 INFO - GECKO(4660) | sidebarJs/<@moz-extension://4b915374-08a4-4cc1-92ff-29431e5f7797/sidebar.js:4:32
18:12:06 INFO - GECKO(4660) | Current stack
18:12:06 INFO - GECKO(4660) | applySafeWithoutClone@resource://gre/modules/ExtensionCommon.jsm:541:133
18:12:06 INFO - GECKO(4660) | fire@resource://gre/modules/ExtensionChild.jsm:994:41
18:12:06 INFO - GECKO(4660) | receiveMessage@resource://gre/modules/ExtensionChild.jsm:997:38
18:12:06 INFO - GECKO(4660) | _callHandlers/<@resource://gre/modules/MessageChannel.jsm:876:29
18:12:06 INFO - GECKO(4660) | _callHandlers@resource://gre/modules/MessageChannel.jsm:875:14
18:12:06 INFO - GECKO(4660) | _handleMessage/deferred.promise<@resource://gre/modules/MessageChannel.jsm:952:12
18:12:06 INFO - GECKO(4660) | _handleMessage@resource://gre/modules/MessageChannel.jsm:949:24
18:12:06 INFO - GECKO(4660) | receiveMessage/<@resource://gre/modules/MessageChannel.jsm:218:14
18:12:06 INFO - GECKO(4660) | receiveMessage@resource://gre/modules/MessageChannel.jsm:211:10
18:12:06 INFO - GECKO(4660) | MessageListener.receiveMessage*FilteringMessageManager@resource://gre/modules/MessageChannel.jsm:201:25
18:12:06 INFO - GECKO(4660) | get@resource://gre/modules/MessageChannel.jsm:436:14
18:12:06 INFO - GECKO(4660) | addListener@resource://gre/modules/MessageChannel.jsm:763:28
18:12:06 INFO - GECKO(4660) | ExtensionGlobal@resource://gre/modules/ExtensionProcessScript.jsm:62:20
18:12:06 INFO - GECKO(4660) | init/<@resource://gre/modules/ExtensionProcessScript.jsm:125:42
18:12:06 INFO - GECKO(4660) | @data:,
18:12:06 INFO - GECKO(4660) | Components.utils.import("resource://gre/modules/Services.jsm");
18:12:06 INFO - GECKO(4660) | Services.obs.notifyObservers(this, "tab-content-frameloader-created", "");
18:12:06 INFO - GECKO(4660) | :1:89
18:12:06 INFO - GECKO(4660) | ]]
18:12:51 INFO - TEST-INFO | started process screenshot
18:12:51 INFO - TEST-INFO | screenshot: exit 0
18:12:51 INFO - Buffered messages logged at 18:12:06
18:12:51 INFO - Entering test bound getTargetElement_in_extension_tab
18:12:51 INFO - Extension loaded
18:12:51 INFO - Console message: Warning: attempting to write 17674 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.
18:12:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | should not get element of tab content in background - Expected: null, Actual: null -
18:12:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | should get element in tab content - Expected: BUTTON, Actual: BUTTON -
18:12:51 INFO - Leaving test bound getTargetElement_in_extension_tab
18:12:51 INFO - Entering test bound getTargetElement_in_extension_tab_on_click
18:12:51 INFO - Extension loaded
18:12:51 INFO - Console message: Warning: attempting to write 17754 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.
18:12:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | should get element in tab content on click - Expected: BUTTON, Actual: BUTTON -
18:12:51 INFO - Console message: Ignoring response to aborted listener for 1079
18:12:51 INFO - Leaving test bound getTargetElement_in_extension_tab_on_click
18:12:51 INFO - Entering test bound getTargetElement_in_browserAction_popup
18:12:51 INFO - Extension loaded
18:12:51 INFO - Console message: Warning: attempting to write 17834 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.
18:12:51 INFO - Console message: Warning: attempting to write 10686 bytes to preference browser.uiCustomization.state. 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.
18:12:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Expect widget not to be overflowed -
18:12:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | should not get element of popup content in background - Expected: null, Actual: null -
18:12:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | should get element in popup content - Expected: BUTTON, Actual: BUTTON -
18:12:51 INFO - Leaving test bound getTargetElement_in_browserAction_popup
18:12:51 INFO - Entering test bound getTargetElement_in_sidebar_panel
18:12:51 INFO - Extension loaded
18:12:51 INFO - Console message: Warning: attempting to write 17932 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.
18:12:51 INFO - Console message: [JavaScript Error: "Incorrect argument types for menus.getTargetElement." {file: "moz-extension://4b915374-08a4-4cc1-92ff-29431e5f7797/sidebar.js" line: 4}]
18:12:51 INFO - makeError@resource://gre/modules/Schemas.jsm:459:14
18:12:51 INFO - throwError@resource://gre/modules/Schemas.jsm:2190:19
18:12:51 INFO - checkParameters@resource://gre/modules/Schemas.jsm:2247:12
18:12:51 INFO - stub@resource://gre/modules/Schemas.jsm:2370:28
18:12:51 INFO - sidebarJs/<@moz-extension://4b915374-08a4-4cc1-92ff-29431e5f7797/sidebar.js:4:32
18:12:51 INFO - applySafeWithoutClone@resource://gre/modules/ExtensionCommon.jsm:539:24
18:12:51 INFO - fire@resource://gre/modules/ExtensionChild.jsm:994:41
18:12:51 INFO - receiveMessage@resource://gre/modules/ExtensionChild.jsm:997:38
18:12:51 INFO - _callHandlers/<@resource://gre/modules/MessageChannel.jsm:876:29
18:12:51 INFO - _callHandlers@resource://gre/modules/MessageChannel.jsm:875:14
18:12:51 INFO - _handleMessage/deferred.promise<@resource://gre/modules/MessageChannel.jsm:952:12
18:12:51 INFO - _handleMessage@resource://gre/modules/MessageChannel.jsm:949:24
18:12:51 INFO - receiveMessage/<@resource://gre/modules/MessageChannel.jsm:218:14
18:12:51 INFO - receiveMessage@resource://gre/modules/MessageChannel.jsm:211:10
18:12:51 INFO - MessageListener.receiveMessage*FilteringMessageManager@resource://gre/modules/MessageChannel.jsm:201:25
18:12:51 INFO - get@resource://gre/modules/MessageChannel.jsm:436:14
18:12:51 INFO - addListener@resource://gre/modules/MessageChannel.jsm:763:28
18:12:51 INFO - ExtensionGlobal@resource://gre/modules/ExtensionProcessScript.jsm:62:20
18:12:51 INFO - init/<@resource://gre/modules/ExtensionProcessScript.jsm:125:42
18:12:51 INFO - @data:,
18:12:51 INFO - Components.utils.import("resource://gre/modules/Services.jsm");
18:12:51 INFO -
18:12:51 INFO - Services.obs.notifyObservers(this, "tab-content-frameloader-created", "");
18:12:51 INFO - :1:89
18:12:51 INFO -
18:12:51 INFO - Buffered messages finished
18:12:51 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Test timed out -
18:12:51 INFO - Not taking screenshot here: see the one that was previously logged
18:12:51 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | no tasks awaiting on messages - Got ["done"], expected []
18:12:51 INFO - Stack trace:
18:12:51 INFO - chrome://mochikit/content/browser-test.js:test_is:1315
18:12:51 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:31
18:12:51 INFO - chrome://mochikit/content/browser-test.js:nextTest:705
18:12:51 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1202
18:12:51 INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1164
18:12:51 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:995
18:12:51 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
18:12:51 INFO - Not taking screenshot here: see the one that was previously logged
18:12:51 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Extension left running at test shutdown -
18:12:51 INFO - Stack trace:
18:12:51 INFO - chrome://mochikit/content/browser-test.js:test_ok:1304
18:12:51 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:109
18:12:51 INFO - chrome://mochikit/content/browser-test.js:nextTest:705
18:12:51 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1202
18:12:51 INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1164
18:12:51 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:995
18:12:51 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
18:12:51 INFO - Console message: Warning: attempting to write 17834 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.
18:12:51 INFO - GECKO(4660) | MEMORY STAT | vsize 1187MB | vsizeMaxContiguous 129MB | residentFast 453MB | heapAllocated 137MB

Comment 1

[Intermittent Failures Robot]

1 failures in 2818 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-03-04&endday=2019-03-10&tree=all

Comment 2

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 3

[Bogdan Tara[:bogdan_tara | bogdant]]

This is still happening.

Recent failure: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=252426354&repo=autoland&lineNumber=3172

08:16:16 INFO - TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js
08:16:16 INFO - GECKO(10316) | JavaScript error: resource:///actors/ContextMenuChild.jsm, line 483: TypeError: doc is null
08:16:16 INFO - GECKO(10316) | JavaScript error: resource:///actors/ContextMenuChild.jsm, line 483: TypeError: doc is null
08:17:01 INFO - TEST-INFO | started process screenshot
08:17:01 INFO - TEST-INFO | screenshot: exit 0
08:17:01 INFO - Buffered messages logged at 08:16:16
08:17:01 INFO - Entering test bound getTargetElement_in_extension_tab
08:17:01 INFO - Extension loaded
08:17:01 INFO - Console message: Warning: attempting to write 18213 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.
08:17:01 INFO - Console message: [JavaScript Error: "TypeError: doc is null" {file: "resource:///actors/ContextMenuChild.jsm" line: 483}]
08:17:01 INFO - Console message: [JavaScript Error: "TypeError: doc is null" {file: "resource:///actors/ContextMenuChild.jsm" line: 483}]
08:17:01 INFO - Buffered messages finished
08:17:01 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Test timed out -
08:17:01 INFO - Not taking screenshot here: see the one that was previously logged
08:17:01 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Extension left running at test shutdown -
08:17:01 INFO - Stack trace:
08:17:01 INFO - chrome://mochikit/content/browser-test.js:test_ok:1313
08:17:01 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:109
08:17:01 INFO - chrome://mochikit/content/browser-test.js:nextTest:714
08:17:01 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1211
08:17:01 INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1173
08:17:01 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1004
08:17:01 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
08:17:01 INFO - GECKO(10316) | JavaScript error: resource://testing-common/PromiseTestUtils.jsm, line 110: uncaught exception: Object
08:17:01 INFO - GECKO(10316) | MEMORY STAT | vsize 2104826MB | vsizeMaxContiguous 65343475MB | residentFast 597MB | heapAllocated 157MB
08:17:01 INFO - TEST-OK | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | took 45078ms
08:17:01 INFO - Not taking screenshot here: see the one that was previously logged
08:17:01 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Found a tab after previous test timed out: moz-extension://d22cbe82-288c-4fe4-8d25-4fa49fe9fb56/tab.html -
08:17:01 INFO - checking window state
08:17:01 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 110}]

Comment 4

[Intermittent Failures Robot]

1 failures in 2581 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-06-17&endday=2019-06-23&tree=all

Comment 5

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 6

[Cristian Brindusan [:cbrindusan]]

New occurrence:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=266140669&repo=mozilla-beta&lineNumber=3418

Comment 7

[Intermittent Failures Robot]

1 failures in 4637 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform breakdown:

• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-09-09&endday=2019-09-15&tree=all

Comment 8

[Intermittent Failures Robot]

1 failures in 4350 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• macosx1014-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-09-16&endday=2019-09-22&tree=all

Comment 9

[Intermittent Failures Robot]

1 failures in 3801 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform breakdown:

• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-10-07&endday=2019-10-13&tree=all

Comment 10

[Intermittent Failures Robot]

2 failures in 4314 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 2

Platform breakdown:

• windows10-64-devedition: 1
• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-10-28&endday=2019-11-03&tree=all

Comment 11

[Intermittent Failures Robot]

1 failures in 4207 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2019-11-11&endday=2019-11-17&tree=all

Comment 12

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Comment 13

[Bogdan Tara[:bogdan_tara | bogdant]]

This is still happening.

Recent failure: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=299142436&repo=mozilla-esr68&lineNumber=3879

01:39:42     INFO - TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js
01:39:42     INFO - GECKO(9860) | JavaScript error: resource:///actors/ContextMenuChild.jsm, line 536: TypeError: doc is null
01:40:27     INFO - TEST-INFO | started process screenshot
01:40:27     INFO - TEST-INFO | screenshot: exit 0
01:40:27     INFO - Buffered messages logged at 01:39:42
01:40:27     INFO - Entering test bound getTargetElement_in_extension_tab
01:40:27     INFO - Extension loaded
01:40:27     INFO - Console message: Warning: attempting to write 18213 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.
01:40:27     INFO - Console message: [JavaScript Error: "TypeError: doc is null" {file: "resource:///actors/ContextMenuChild.jsm" line: 536}]
01:40:27     INFO - Buffered messages finished
01:40:27     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Test timed out - 
01:40:27     INFO - Not taking screenshot here: see the one that was previously logged
01:40:27     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Extension left running at test shutdown - 
01:40:27     INFO - Stack trace:
01:40:27     INFO - chrome://mochikit/content/browser-test.js:test_ok:1587
01:40:27     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:109
01:40:27     INFO - chrome://mochikit/content/browser-test.js:nextTest:867
01:40:27     INFO - GECKO(9860) | MEMORY STAT | vsize 2104895MB | vsizeMaxContiguous 65343488MB | residentFast 592MB | heapAllocated 159MB
01:40:27     INFO - TEST-OK | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | took 45101ms
01:40:27     INFO - Not taking screenshot here: see the one that was previously logged
01:40:27     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_extension.js | Found a tab after previous test timed out: moz-extension://49f6bd5e-a78b-4676-906c-fb8a44d4784a/tab.html - 
01:40:27     INFO - checking window state
01:40:27     INFO - TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_shadow.js
01:40:27     INFO - GECKO(9860) | MEMORY STAT | vsize 2104895MB | vsizeMaxContiguous 65343488MB | residentFast 594MB | heapAllocated 162MB
01:40:27     INFO - TEST-OK | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_menus_targetElement_shadow.js | took 335ms

Comment 14

[Intermittent Failures Robot]

1 failures in 5582 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-esr68: 1

Platform breakdown:

• windows10-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1533497&startday=2020-04-20&endday=2020-04-26&tree=all

Comment 15

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.