Closed Bug 1842129 Opened 1 year ago Closed 14 days ago

Intermittent browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | single tracking bug

Categories

(Firefox :: Tabbed Browser, defect, P5)

Product:
Firefox
Component:
Tabbed Browser
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE
Tracking Flags:
Tracking Status
firefox-esr102 --- unaffected
firefox-esr115 --- unaffected
firefox115 --- unaffected
firefox116 --- unaffected
firefox117 --- wontfix

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, intermittent-testcase, regression, Whiteboard: [stockwell unknown])

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

[task 2023-07-07T01:18:00.051Z] 01:18:00     INFO - TEST-START | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js
[task 2023-07-07T01:18:00.485Z] 01:18:00     INFO - GECKO(5151) | 1688692680484	Marionette	TRACE	Received observer notification browser-delayed-startup-finished
[task 2023-07-07T01:18:01.546Z] 01:18:01     INFO - GECKO(5151) | must wait for focus
[task 2023-07-07T01:18:01.834Z] 01:18:01     INFO - TEST-INFO | started process screentopng
[task 2023-07-07T01:18:02.206Z] 01:18:02     INFO - TEST-INFO | screentopng: exit 0
[task 2023-07-07T01:18:02.206Z] 01:18:02     INFO - Buffered messages logged at 01:18:00
[task 2023-07-07T01:18:02.206Z] 01:18:02     INFO - Entering test bound test_recently_closed_tabs_nonprivate
[task 2023-07-07T01:18:02.206Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Expect 0 closed tabs for this window - 
[task 2023-07-07T01:18:02.207Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Got expected openedTabs length - 
[task 2023-07-07T01:18:02.208Z] 01:18:02     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://example.com/" line: 0}]
[task 2023-07-07T01:18:02.209Z] 01:18:02     INFO - Buffered messages logged at 01:18:01
[task 2023-07-07T01:18:02.211Z] 01:18:02     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://example.org/" line: 0}]
[task 2023-07-07T01:18:02.212Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Got expected openedTabs length - 
[task 2023-07-07T01:18:02.213Z] 01:18:02     INFO - Checking the menuitem is initially disabled in both windows
[task 2023-07-07T01:18:02.213Z] 01:18:02     INFO - checkMenu:, waiting for menuShown
[task 2023-07-07T01:18:02.214Z] 01:18:02     INFO - Buffered messages finished
[task 2023-07-07T01:18:02.226Z] 01:18:02     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Recently closed tabs menu item is disabled - false == true - {"filename":"chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js","name":"checkMenu","sourceId":666,"lineNumber":41,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js","name":"test_recently_closed_tabs_nonprivate","sourceId":666,"lineNumber":95,"columnNumber":11,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1131,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1203,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1345,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1120,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":555,"lineNumber":1056,"columnNumber":13,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"nextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"Tester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"async*test_recently_closed_tabs_nonprivate@chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:95:11\nasync*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"checkMenu@chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:41:10\nasync*test_recently_closed_tabs_nonprivate@chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:95:11\nasync*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-07-07T01:18:02.227Z] 01:18:02     INFO - Stack trace:
[task 2023-07-07T01:18:02.228Z] 01:18:02     INFO - chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:checkMenu:41
[task 2023-07-07T01:18:02.228Z] 01:18:02     INFO - chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:test_recently_closed_tabs_nonprivate:95
[task 2023-07-07T01:18:02.229Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:handleTask:1131
[task 2023-07-07T01:18:02.229Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1203
[task 2023-07-07T01:18:02.230Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1345
[task 2023-07-07T01:18:02.235Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-07-07T01:18:02.242Z] 01:18:02     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-07-07T01:18:02.243Z] 01:18:02     INFO - checkMenu:, waiting for menuHidden
[task 2023-07-07T01:18:02.244Z] 01:18:02     INFO - checkMenu:, menuHidden, returning
[task 2023-07-07T01:18:02.245Z] 01:18:02     INFO - GECKO(5151) | must wait for focus
[task 2023-07-07T01:18:02.246Z] 01:18:02     INFO - checkMenu:, waiting for menuShown
[task 2023-07-07T01:18:02.310Z] 01:18:02     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-07T01:18:02.312Z] 01:18:02     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Recently closed tabs menu item is disabled - false == true - {"filename":"chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js","name":"checkMenu","sourceId":666,"lineNumber":41,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js","name":"test_recently_closed_tabs_nonprivate","sourceId":666,"lineNumber":95,"columnNumber":11,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1131,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1203,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1345,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1120,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":555,"lineNumber":1056,"columnNumber":13,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"nextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"Tester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"async*test_recently_closed_tabs_nonprivate@chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:95:11\nasync*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"checkMenu@chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:41:10\nasync*test_recently_closed_tabs_nonprivate@chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:95:11\nasync*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nTester_execTest@chrome://mochikit/content/browser-test.js:1345:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-07-07T01:18:02.319Z] 01:18:02     INFO - Stack trace:
[task 2023-07-07T01:18:02.321Z] 01:18:02     INFO - chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:checkMenu:41
[task 2023-07-07T01:18:02.321Z] 01:18:02     INFO - chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:test_recently_closed_tabs_nonprivate:95
[task 2023-07-07T01:18:02.321Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:handleTask:1131
[task 2023-07-07T01:18:02.321Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1203
[task 2023-07-07T01:18:02.321Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1345
[task 2023-07-07T01:18:02.321Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-07-07T01:18:02.322Z] 01:18:02     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-07-07T01:18:02.322Z] 01:18:02     INFO - checkMenu:, waiting for menuHidden
[task 2023-07-07T01:18:02.322Z] 01:18:02     INFO - checkMenu:, menuHidden, returning
[task 2023-07-07T01:18:02.451Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Tab was found in the openedTabs array - 
[task 2023-07-07T01:18:02.453Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Got expected openedTabs length - 
[task 2023-07-07T01:18:02.456Z] 01:18:02     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-07T01:18:02.458Z] 01:18:02     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Expect closed tab count of 1 after closing a tab - Got 2, expected 1
[task 2023-07-07T01:18:02.458Z] 01:18:02     INFO - Stack trace:
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:test_is:1608
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochitests/content/browser/browser/base/content/test/menubar/browser_history_recently_closed_tabs.js:test_recently_closed_tabs_nonprivate:102
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:handleTask:1131
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1203
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1345
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-07-07T01:18:02.459Z] 01:18:02     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-07-07T01:18:02.460Z] 01:18:02     INFO - GECKO(5151) | must wait for focus
[task 2023-07-07T01:18:02.591Z] 01:18:02     INFO - checkMenu:, waiting for menuShown
[task 2023-07-07T01:18:02.680Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Recently closed tabs menu item is not disabled - false == false - 
[task 2023-07-07T01:18:02.685Z] 01:18:02     INFO - checkMenu:, waiting for menuHidden
[task 2023-07-07T01:18:02.689Z] 01:18:02     INFO - checkMenu:, menuHidden, returning
[task 2023-07-07T01:18:02.690Z] 01:18:02     INFO - GECKO(5151) | must wait for focus
[task 2023-07-07T01:18:02.772Z] 01:18:02     INFO - checkMenu:, waiting for menuShown
[task 2023-07-07T01:18:02.870Z] 01:18:02     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Recently closed tabs menu item is not disabled - false == false - 
[task 2023-07-07T01:18:02.873Z] 01:18:02     INFO - checkMenu:, waiting for menuHidden
[task 2023-07-07T01:18:02.876Z] 01:18:02     INFO - checkMenu:, menuHidden, returning
[task 2023-07-07T01:18:02.877Z] 01:18:02     INFO - clean up opened window
[task 2023-07-07T01:18:02.941Z] 01:18:02     INFO - starting tab cleanup
[task 2023-07-07T01:18:03.053Z] 01:18:03     INFO - TEST-PASS | browser/base/content/test/menubar/browser_history_recently_closed_tabs.js | Tab was found in the openedTabs array -

The Bugbug bot thinks this bug should belong to the 'Firefox::Tabbed Browser' component, and is moving the bug to that component. Please correct in case you think the bot is wrong.

Component: General → Tabbed Browser
Keywords: regression
Regressed by: 1819675

Set release status flags based on info from the regressing bug 1819675

:sfoster, since you are the author of the regressor, bug 1819675, could you take a look?

For more information, please visit BugBot documentation.

status-firefox115: --- → unaffected
status-firefox116: --- → unaffected
status-firefox117: --- → affected
status-firefox-esr102: --- → unaffected
status-firefox-esr115: --- → unaffected
Flags: needinfo?(sfoster)

Thanks for the flag. This is a new test that opens menus and windows and other intermittent-prone actions, so occasional failures are probably expected. I'd like to wait a bit to see if the intermitency rate rise to a level of concern.

Flags: needinfo?(sfoster)

There have been 41 total failures in the last 7 days.
There are:

  • 22 failures on linux1804-64-qr opt and debug
  • 19 failures on linux1804-64-shippable-qr opt

Recent failure log.

Whiteboard: [stockwell needswork:owner]

There have been 44 total failures in the last 7 days.
There are:

  • 1 failure on linux1804-64-asan-qr opt
  • 23 failures on linux1804-64-qr opt
  • 20 failures on linux1804-64-shippable-qr opt

Recent failure log.

Dao, as the owner of this component, can you help us assign the bug to someone? Thank you.

Flags: needinfo?(dao+bmo)

Cancelling the needinfo based on Comment 4.

Flags: needinfo?(dao+bmo)

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

Status: NEW → RESOLVED
Closed: 1 year ago
status-firefox117: affected → wontfix
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=450699020&repo=autoland

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 1 year ago → 7 months ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=454136315&repo=autoland

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 7 months ago → 3 months ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=470757307&repo=autoland

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 3 months ago → 2 months ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=476354061&repo=mozilla-esr128

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 2 months ago → 14 days ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.