1595948 - Intermittent browser/components/extensions/test/browser/browser_ext_tabs_query.js | should have two | three tabs - Expected: X, Actual: Y -

Status: RESOLVED INCOMPLETE

(WebExtensions :: Untriaged, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2019-11-12T22:42:26.033Z] 22:42:26 INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_tabs_query.js
[task 2019-11-12T22:42:28.228Z] 22:42:28 INFO - GECKO(1731) | JavaScript error: moz-extension://d97e7288-92a2-b048-842b-5f9234c00fa4/%7B067caa59-98bf-9b4a-8fa4-751ea2a82bb3%7D.js, line 16: TypeError: tabs[1] is undefined
[task 2019-11-12T22:42:28.228Z] 22:42:28 INFO - TEST-INFO | started process screencapture
[task 2019-11-12T22:42:28.367Z] 22:42:28 INFO - TEST-INFO | screencapture: exit 0
[task 2019-11-12T22:42:28.367Z] 22:42:28 INFO - Buffered messages logged at 22:42:26
[task 2019-11-12T22:42:28.367Z] 22:42:28 INFO - Entering test bound
[task 2019-11-12T22:42:28.367Z] 22:42:28 INFO - Extension loaded
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - Console message: Warning: attempting to write 30918 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 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | should have three tabs - Expected: 3, Actual: 3 -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | first tab blank - Expected: about:blank, Actual: about:blank -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 active -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 1 inactive -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 unpinned -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 1 unpinned -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 url correct - Expected: about:robots, Actual: about:robots -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 1 url correct - Expected: about:config, Actual: about:config -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 status correct - Expected: complete, Actual: complete -
[task 2019-11-12T22:42:28.368Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 1 status correct - Expected: complete, Actual: complete -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 title correct - Expected: Gort! Klaatu barada nikto!, Actual: Gort! Klaatu barada nikto! -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | about:blank query finds one tab - Expected: 1, Actual: 1 -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | with the correct url - Expected: about:blank, Actual: about:blank -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tabs.query -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | test result correct -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - Buffered messages logged at 22:42:28
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - Extension loaded
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - Console message: Warning: attempting to write 30998 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 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | should have three tabs - Expected: 3, Actual: 3 -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 url correct - Expected: http://example.com/, Actual: http://example.com/ -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 1 url correct - Expected: http://example.net/, Actual: http://example.net/ -
[task 2019-11-12T22:42:28.369Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 2 url correct - Expected: http://test1.example.org/MochiKit/, Actual: http://test1.example.org/MochiKit/ -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tabs.query -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | test result correct -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - Extension loaded
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - Console message: Warning: attempting to write 31078 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 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | should have one tab - Expected: 1, Actual: 1 -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 url correct - Expected: http://test1.example.org/MochiKit/, Actual: http://test1.example.org/MochiKit/ -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tabs.query -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | test result correct -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - Extension loaded
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - Console message: Warning: attempting to write 31158 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 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | should have two tabs - Expected: 2, Actual: 2 -
[task 2019-11-12T22:42:28.370Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 url correct - Expected: http://example.com/, Actual: http://example.com/ -
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 1 url correct - Expected: http://test1.example.org/MochiKit/, Actual: http://test1.example.org/MochiKit/ -
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tabs.query -
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | test result correct -
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - Extension loaded
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - Console message: Warning: attempting to write 31238 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 2019-11-12T22:42:28.371Z] 22:42:28 INFO - Buffered messages finished
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_query.js | should have two tabs - Expected: 1, Actual: 2 -
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - Stack trace:
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - chrome://mochikit/content/browser-test.js:test_ok:1299
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testHandler:59
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:testResult:73
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - resource://specialpowers/SpecialPowersChild.jsm:listener:2051
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - resource://specialpowers/SpecialPowersChild.jsm:loadExtension/<:1993
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - resource://specialpowers/SpecialPowersChild.jsm:receiveMessage:242
[task 2019-11-12T22:42:28.371Z] 22:42:28 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_tabs_query.js | tab 0 title correct - Expected: mochitest index /, Actual: mochitest index / -
[task 2019-11-12T22:42:28.372Z] 22:42:28 INFO - Console message: [JavaScript Error: "TypeError: tabs[1] is undefined" {file: "moz-extension://d97e7288-92a2-b048-842b-5f9234c00fa4/%7B067caa59-98bf-9b4a-8fa4-751ea2a82bb3%7D.js" line: 16}]
[task 2019-11-12T22:43:11.166Z] 22:43:11 INFO - Longer timeout required, waiting longer... Remaining timeouts: 1
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_query.js | Test timed out -
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_query.js | Extension left running at test shutdown -
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - Stack trace:
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - chrome://mochikit/content/browser-test.js:test_ok:1299
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:109
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - chrome://mochikit/content/browser-test.js:nextTest:577
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1190
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - setTimeout handlerchrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest_setTimeoutShim:686
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1158
[task 2019-11-12T22:43:56.247Z] 22:43:56 INFO - setTimeout handlerchrome://mochikit/content/browser-test.js:Tester_execTest:1137
[task 2019-11-12T22:43:56.248Z] 22:43:56 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:932
[task 2019-11-12T22:43:56.248Z] 22:43:56 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:805
[task 2019-11-12T22:43:56.278Z] 22:43:56 INFO - GECKO(1731) | MEMORY STAT | vsize 8281MB | residentFast 884MB | heapAllocated 196MB
[task 2019-11-12T22:43:56.278Z] 22:43:56 INFO - TEST-OK | browser/components/extensions/test/browser/browser_ext_tabs_query.js | took 90221ms
[task 2019-11-12T22:43:56.279Z] 22:43:56 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-11-12T22:43:56.279Z] 22:43:56 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_query.js | Found a tab after previous test timed out: http://test1.example.org/MochiKit/ -
[task 2019-11-12T22:43:56.279Z] 22:43:56 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-11-12T22:43:56.280Z] 22:43:56 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_query.js | Found a tab after previous test timed out: http://example.net/ -
[task 2019-11-12T22:43:56.284Z] 22:43:56 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-11-12T22:43:56.284Z] 22:43:56 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_tabs_query.js | Found a tab after previous test timed out: http://example.com/ -
[task 2019-11-12T22:43:56.329Z] 22:43:56 INFO - checking window state

Comment 1

[Intermittent Failures Robot]

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

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 30
• try: 3
• mozilla-central: 5

Platform breakdown:

• macosx1014-64-shippable: 6
• windows10-64-qr: 9
• macosx1014-64: 2
• windows10-64: 12
• windows7-32: 2
• linux64: 4
• windows10-64-shippable: 1
• windows7-32-shippable: 1
• windows10-64-shippable-qr: 1

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

Comment 2

[Intermittent Failures Robot]

9 failures in 5444 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 5
• mozilla-central: 3
• try: 1

Platform breakdown:

• windows10-64: 2
• macosx1014-64-shippable: 2
• macosx1014-64-devedition: 1
• windows10-64-qr: 2
• android-hw-p2-8-0-arm7-api-16-qr: 1
• windows7-32-shippable: 1

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

Comment 3

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

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