Open Bug 1394984 Opened 2 years ago Updated 3 days ago

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

Categories

(WebExtensions :: Untriaged, defect, P5)

defect

Tracking

(Not tracked)

REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure, leave-open, Whiteboard: [stockwell disabled])

Attachments

(1 file)

Product: Toolkit → WebExtensions
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: Last year
Resolution: --- → INCOMPLETE
This is still happening.

Recent failure: https://treeherder.mozilla.org/logviewer.html#?job_id=203494383&repo=autoland&lineNumber=2404

14:42:39     INFO - Entering test bound test_sessions_tab_value_persistence
14:42:39     INFO - Testing for persistence of set tab values.
14:42:39     INFO - Extension loaded
14:42:39     INFO - Buffered messages logged at 14:41:54
14:42:39     INFO - Test that two different tabs hold different values for a given key.
14:42:39     INFO - Buffered messages finished
14:42:39     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Test timed out - 
14:42:39     INFO - Not taking screenshot here: see the one that was previously logged
14:42:39     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | no tasks awaiting on messages - Got ["testComplete"], expected []
14:42:39     INFO - Stack trace:
14:42:39     INFO - chrome://mochikit/content/browser-test.js:test_is:1295
14:42:39     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:31
14:42:39     INFO - chrome://mochikit/content/browser-test.js:nextTest:695
14:42:39     INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1190
14:42:39     INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1152
14:42:39     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:986
14:42:39     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:795
14:42:39     INFO - Not taking screenshot here: see the one that was previously logged
14:42:39     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Extension left running at test shutdown -
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: REOPENED → RESOLVED
Closed: Last yearLast year
Resolution: --- → INCOMPLETE

In the last 7 days there were 33 failures associated with this bug.
Occurs on:

  • linux64
  • linux64-ccov
  • linux64-shippable
  • windows10-64
Flags: needinfo?(jmathies)

In the last 7 days there have been 56 occurrences on linux 64, mac osx 64, windows 64 debug and opt.

Recent failure: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=257609025&repo=mozilla-central&lineNumber=32590

23:58:21 INFO - TEST-START | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js
23:58:22 INFO - GECKO(7712) | [Parent 8084, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file z:/build/build/src/widget/PuppetWidget.cpp, line 1096
23:58:22 INFO - GECKO(7712) | ++DOCSHELL 000001EFAF8B3000 == 6 [pid = 2520] [id = {184a7418-100a-400b-bb3d-fd39d6b15113}]
23:58:22 INFO - GECKO(7712) | ++DOMWINDOW == 16 (000001EFAF8893E0) [pid = 2520] [serial = 1324] [outer = 0000000000000000]
23:58:22 INFO - GECKO(7712) | [Child 2520, Main Thread] WARNING: Fallback to BasicLayerManager: file z:/build/build/src/dom/ipc/BrowserChild.cpp, line 2613
23:58:22 INFO - GECKO(7712) | [Child 2520, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
23:58:22 INFO - GECKO(7712) | ++DOMWINDOW == 17 (000001EFAF83A000) [pid = 2520] [serial = 1325] [outer = 000001EFAF8893E0]
23:58:22 INFO - GECKO(7712) | [Child 2520, Main Thread] WARNING: NS_ENSURE_SUCCESS(mStatus, this) failed with result 0x80004005: file z:/build/build/src/obj-firefox/dist/include\nsIURIMutator.h, line 489
23:58:22 INFO - GECKO(7712) | ++DOMWINDOW == 18 (000001EFAF846800) [pid = 2520] [serial = 1326] [outer = 000001EFAF8893E0]
23:58:23 INFO - GECKO(7712) | --DOMWINDOW == 17 (000001EFB167A400) [pid = 2520] [serial = 1317] [outer = 0000000000000000] [url = moz-extension://c0016520-6f47-497b-92d9-bf4d9923c798/_generated_background_page.html]
23:58:23 INFO - GECKO(7712) | --DOMWINDOW == 16 (000001EFAADD9000) [pid = 2520] [serial = 1319] [outer = 0000000000000000] [url = about:blank]
23:58:23 INFO - GECKO(7712) | --DOCSHELL 000001EFAAD74000 == 5 [pid = 2520] [id = {ddb6ce09-1d59-4111-8d54-90802521695a}] [url = moz-extension://f1f219f6-d6d0-4e6c-b53f-b2b10fbb7233/_generated_background_page.html]
23:58:23 INFO - GECKO(7712) | --DOCSHELL 0000020D320B9000 == 3 [pid = 10308] [id = {96c02584-32d8-4f73-b5ec-84270372b297}] [url = http://example.com/?changedTab]
23:58:23 INFO - GECKO(7712) | --DOCSHELL 0000020D324B7000 == 2 [pid = 10308] [id = {1c6ad7d9-0958-4cf6-a42f-6d2ffdd6f92b}] [url = about:blank?1]
23:58:23 INFO - GECKO(7712) | --DOCSHELL 0000020D2BC76000 == 1 [pid = 10308] [id = {1a163ffe-71aa-428e-a79b-8d1e4e05afaa}] [url = http://example.com/?changedTab]
23:58:23 INFO - GECKO(7712) | --DOCSHELL 0000020D324B4800 == 0 [pid = 10308] [id = {b8710f57-2a1b-471e-9226-c0214d77da4f}] [url = about:blank?0]
23:58:23 INFO - GECKO(7712) | --DOMWINDOW == 14 (0000020D32045020) [pid = 10308] [serial = 68] [outer = 0000000000000000] [url = about:blank]
23:58:23 INFO - GECKO(7712) | --DOMWINDOW == 13 (0000020D32046E20) [pid = 10308] [serial = 77] [outer = 0000000000000000] [url = about:blank?0]
...
23:59:01 INFO - GECKO(7712) | --DOMWINDOW == 15 (000002B0B8B37400) [pid = 8084] [serial = 502] [outer = 0000000000000000] [url = about:blank]
23:59:01 INFO - GECKO(7712) | --DOMWINDOW == 14 (000002B0AED45000) [pid = 8084] [serial = 520] [outer = 0000000000000000] [url = about:blank]
23:59:51 INFO - TEST-INFO | started process screenshot
23:59:51 INFO - TEST-INFO | screenshot: exit 0
23:59:51 INFO - Buffered messages logged at 23:58:21
23:59:51 INFO - Entering test bound test_sessions_tab_value
23:59:51 INFO - Testing set/get/deleteTabValue.
23:59:51 INFO - Extension loaded
23:59:51 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 112}]
23:59:51 INFO - Buffered messages logged at 23:58:27
23:59:51 INFO - Test that setting, getting and deleting tab value behaves properly when value is type "string"
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Value for key 'tabkey1' should be 'Tab Value'. - Expected: Tab Value, Actual: Tab Value -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | typeof value should be '${valueType}'. - Expected: string, Actual: string -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Key has been deleted and value for key "tabkey1" should be 'undefined'. - Expected: undefined, Actual: undefined -
23:59:51 INFO - Buffered messages logged at 23:58:28
23:59:51 INFO - Test that setting, getting and deleting tab value behaves properly when value is type "number"
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Value for key 'tabkey2' should be '25'. - Expected: 25, Actual: 25 -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | typeof value should be '${valueType}'. - Expected: number, Actual: number -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Key has been deleted and value for key "tabkey2" should be 'undefined'. - Expected: undefined, Actual: undefined -
23:59:51 INFO - Test that setting, getting and deleting tab value behaves properly when value is type "object"
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Value for key 'tabkey3' should be 'Tab Value'. - Expected: Tab Value, Actual: Tab Value -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Key has been deleted and value for key "tabkey3" should be 'undefined'. - Expected: undefined, Actual: undefined -
23:59:51 INFO - Console message: [JavaScript Warning: "Sending message that cannot be cloned. Are you trying to send an XPCOM object?" {file: "resource://gre/modules/ExtensionChild.jsm" line: 1237}]
23:59:51 INFO - Test that setting, getting and deleting tab value behaves properly when value is type "function"
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Value for key 'tabkey4' is non-JSON-able and should be 'null'. - Expected: null, Actual: null -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Key has been deleted and value for key "tabkey4" should be 'undefined'. - Expected: undefined, Actual: undefined -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Attempting to remove a non-existent key should not fail. -
23:59:51 INFO - TEST-PASS | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Testing completed for set/get/deleteTabValue. -
23:59:51 INFO - Leaving test bound test_sessions_tab_value
23:59:51 INFO - Entering test bound test_sessions_tab_value_persistence
23:59:51 INFO - Testing for persistence of set tab values.
23:59:51 INFO - Extension loaded
23:59:51 INFO - Test that two different tabs hold different values for a given key.
23:59:51 INFO - Buffered messages finished
23:59:51 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Test timed out -
23:59:51 INFO - Not taking screenshot here: see the one that was previously logged
23:59:51 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | no tasks awaiting on messages - Got ["testComplete"], expected []
23:59:51 INFO - Stack trace:
23:59:51 INFO - chrome://mochikit/content/browser-test.js:test_is:1591
23:59:51 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:31
23:59:51 INFO - chrome://mochikit/content/browser-test.js:nextTest:856
23:59:51 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1467
23:59:51 INFO - setTimeout handler
chrome://mochikit/content/browser-test.js:Tester_execTest:1414
23:59:51 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1209
23:59:51 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
23:59:51 INFO - Not taking screenshot here: see the one that was previously logged
23:59:51 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Extension left running at test shutdown -
23:59:51 INFO - Stack trace:
23:59:51 INFO - chrome://mochikit/content/browser-test.js:test_ok:1576
23:59:51 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:109
23:59:51 INFO - chrome://mochikit/content/browser-test.js:nextTest:856
23:59:51 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1467
23:59:51 INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1414
23:59:51 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1209
23:59:51 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
23:59:52 INFO - GECKO(7712) | MEMORY STAT | vsize 2104977MB | vsizeMaxContiguous 65012246MB | residentFast 629MB | heapAllocated 142MB
23:59:52 INFO - TEST-OK | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | took 90184ms
23:59:52 INFO - Not taking screenshot here: see the one that was previously logged
23:59:52 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/test-oop-extensions/browser_ext_sessions_window_tab_value.js | Found a tab after previous test timed out: http://example.com/ -
23:59:52 INFO - GECKO(7712) | [Parent 8084, Main Thread] WARNING: Constructing RangeBoundary with invalid value: 'mRef || aOffset == 0', file z:/build/build/src/obj-firefox/dist/include\mozilla/RangeBoundary.h, line 79
23:59:52 INFO - GECKO(7712) | [Parent 8084, Main Thread] WARNING: Constructing RangeBoundary with invalid value: 'mRef || aOffset == 0', file z:/build/build/src/obj-firefox/dist/include\mozilla/RangeBoundary.h, line 79
23:59:52 INFO - GECKO(7712) | [Child 10880, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
23:59:52 INFO - GECKO(7712) | ++DOCSHELL 0000020D2BC74000 == 1 [pid = 10308] [id = {d0242593-a7a2-4cf1-a75f-89c13e25e73f}]
23:59:52 INFO - GECKO(7712) | ++DOMWINDOW == 1 (0000020D32045020) [pid = 10308] [serial = 83] [outer = 0000000000000000]
23:59:52 INFO - GECKO(7712) | [Child 10308, Main Thread] WARNING: No active window: file z:/build/build/src/js/xpconnect/src/XPCJSContext.cpp, line 662
23:59:52 INFO - GECKO(7712) | ++DOMWINDOW == 2 (0000020D2BCD9000) [pid = 10308] [serial = 84] [outer = 0000020D32045020]
23:59:52 INFO - checking window state
23:59:52 INFO - GECKO(7712) | JavaScript error: resource://testing-common/PromiseTestUtils.jsm, line 112: uncaught exception: Object

Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Attachment #9079898 - Attachment description: Bug 1394984 - disable browser_ext_sessions_window_tab_value.js on win10-64, linux64, mac10-64 debug for frequent failures. r=jmaher → Bug 1394984 - browser_ext_sessions_window_tab_value.js disabled on debug builds on all platforms due to high frequency failures. r=jmaher
Pushed by dvarga@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/56b159475971
browser_ext_sessions_window_tab_value.js disabled on debug builds on all platforms due to high frequency failures. r=jmaher

Over the last 7 days there are 38 failures on this bug. These happen on linux64, linux64-ccov, linux64-shippable, macosx1014-64, windows10-64-ccov, windows10-64-qr, windows7-32, windows7-32-shippable

Here is the latest failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=259104396&repo=autoland&lineNumber=3612

Flags: needinfo?(jmathies)
You need to log in before you can comment on or make changes to this bug.