Open Bug 1836198 Opened 1 years ago Updated 6 days ago

Intermittent browser/components/sessionstore/test/browser_closed_tabs_windows.js | single tracking bug

Categories

(Firefox :: Session Restore, defect, P5)

defect

Tracking

()

REOPENED

People

(Reporter: intermittent-bug-filer, Assigned: sfoster, NeedInfo)

References

Details

(Keywords: intermittent-failure, intermittent-testcase, leave-open, Whiteboard: [fidefe-firefox-view][stockwell disabled])

Attachments

(2 files)

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


[task 2023-06-01T04:40:40.008Z] 04:40:40     INFO - TEST-START | browser/components/sessionstore/test/browser_closed_tabs_windows.js
[task 2023-06-01T04:40:40.832Z] 04:40:40     INFO - GECKO(28193) | 1685594440830	Marionette	TRACE	Received observer notification browser-delayed-startup-finished
[task 2023-06-01T04:40:41.212Z] 04:40:41     INFO - GECKO(28193) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-06-01T04:40:41.215Z] 04:40:41     INFO - GECKO(28193) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-06-01T04:40:41.235Z] 04:40:41     INFO - GECKO(28193) | console.error: Translations: (new Error("Unable to retrieve the translation models.", "resource://gre/actors/TranslationsParent.sys.mjs", 887))
[task 2023-06-01T04:40:41.244Z] 04:40:41     INFO - GECKO(28193) | console.error: Translations: (new Error("Unable to retrieve the translation models.", "resource://gre/actors/TranslationsParent.sys.mjs", 887))
[task 2023-06-01T04:40:41.674Z] 04:40:41     INFO - TEST-INFO | started process screentopng
[task 2023-06-01T04:40:42.238Z] 04:40:42     INFO - TEST-INFO | screentopng: exit 0
[task 2023-06-01T04:40:42.240Z] 04:40:42     INFO - Buffered messages logged at 04:40:40
[task 2023-06-01T04:40:42.240Z] 04:40:42     INFO - Entering setup bound testSetup
[task 2023-06-01T04:40:42.240Z] 04:40:42     INFO - Buffered messages logged at 04:40:41
[task 2023-06-01T04:40:42.241Z] 04:40:42     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/#1" line: 0}]
[task 2023-06-01T04:40:42.241Z] 04:40:42     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/#0" line: 0}]
[task 2023-06-01T04:40:42.241Z] 04:40:42     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/#2" line: 0}]
[task 2023-06-01T04:40:42.241Z] 04:40:42     INFO - TEST-PASS | browser/components/sessionstore/test/browser_closed_tabs_windows.js | all tabs were restored - 
[task 2023-06-01T04:40:42.244Z] 04:40:42     INFO - TEST-PASS | browser/components/sessionstore/test/browser_closed_tabs_windows.js | there are no tabs left needing restore - 
[task 2023-06-01T04:40:42.247Z] 04:40:42     INFO - Leaving setup bound testSetup
[task 2023-06-01T04:40:42.247Z] 04:40:42     INFO - Entering test bound test_ClosedTabMethods
[task 2023-06-01T04:40:42.247Z] 04:40:42     INFO - TEST-PASS | browser/components/sessionstore/test/browser_closed_tabs_windows.js | We expect [object Object],[object Object] open browser windows - 2 == 2 - 
[task 2023-06-01T04:40:42.247Z] 04:40:42     INFO - window 0: https://example.org/#1
[task 2023-06-01T04:40:42.247Z] 04:40:42     INFO - Buffered messages finished
[task 2023-06-01T04:40:42.291Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | getClosedTabDataForWindow() for window 0 returned the expected number of objects - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2367,"lineNumber":133,"columnNumber":12,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1133,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1205,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1347,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1122,"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:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:133:12\nhandleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.291Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.291Z] 04:40:42     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:133
[task 2023-06-01T04:40:42.291Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:handleTask:1133
[task 2023-06-01T04:40:42.292Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1205
[task 2023-06-01T04:40:42.292Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1347
[task 2023-06-01T04:40:42.292Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1122
[task 2023-06-01T04:40:42.292Z] 04:40:42     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-01T04:40:42.293Z] 04:40:42     INFO - window 1: https://example.com/#0
[task 2023-06-01T04:40:42.295Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.310Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | getClosedTabDataForWindow() for window 1 returned the expected number of objects - 1 == 2 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2367,"lineNumber":133,"columnNumber":12,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1133,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1205,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1347,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1122,"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:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:133:12\nhandleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.310Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.310Z] 04:40:42     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:133
[task 2023-06-01T04:40:42.310Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:handleTask:1133
[task 2023-06-01T04:40:42.311Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1205
[task 2023-06-01T04:40:42.311Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1347
[task 2023-06-01T04:40:42.312Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1122
[task 2023-06-01T04:40:42.312Z] 04:40:42     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-01T04:40:42.313Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.325Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | 2 closed tab for this window - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2367,"lineNumber":142,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1133,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1205,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1347,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1122,"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:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:142:10\nhandleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:142
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:handleTask:1133
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1205
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1347
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1122
[task 2023-06-01T04:40:42.326Z] 04:40:42     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-01T04:40:42.328Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.340Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | 1 closed tab for this window - 1 == 2 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2367,"lineNumber":145,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1133,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1205,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1347,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1122,"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:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:145:10\nhandleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.340Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.340Z] 04:40:42     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:145
[task 2023-06-01T04:40:42.341Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:handleTask:1133
[task 2023-06-01T04:40:42.341Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1205
[task 2023-06-01T04:40:42.341Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1347
[task 2023-06-01T04:40:42.342Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1122
[task 2023-06-01T04:40:42.342Z] 04:40:42     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-01T04:40:42.344Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.395Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | Now theres one closed tab - 1 == 0 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2367,"lineNumber":153,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1133,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1205,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1347,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1122,"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:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:153:10\nasync*handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.396Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.396Z] 04:40:42     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:153
[task 2023-06-01T04:40:42.396Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:handleTask:1133
[task 2023-06-01T04:40:42.397Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1205
[task 2023-06-01T04:40:42.397Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1347
[task 2023-06-01T04:40:42.398Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1122
[task 2023-06-01T04:40:42.399Z] 04:40:42     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-01T04:40:42.400Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.437Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | Theres still one closed tab in the 2nd window - 1 == 2 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2367,"lineNumber":158,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":528,"lineNumber":1133,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":528,"lineNumber":1205,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":528,"lineNumber":1347,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":528,"lineNumber":1122,"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:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:158:10\nasync*handleTask@chrome://mochikit/content/browser-test.js:1133:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1122:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.437Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.437Z] 04:40:42     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:158
[task 2023-06-01T04:40:42.438Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:handleTask:1133
[task 2023-06-01T04:40:42.438Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1205
[task 2023-06-01T04:40:42.438Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1347
[task 2023-06-01T04:40:42.439Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1122
[task 2023-06-01T04:40:42.439Z] 04:40:42     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-01T04:40:42.440Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.442Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | Uncaught exception in test bound test_ClosedTabMethods - [Exception... "Invalid index: not in the closed tabs"  nsresult: "0x80070057 (NS_ERROR_ILLEGAL_VALUE)"  location: "JS frame :: resource:///modules/sessionstore/SessionStore.sys.mjs :: ssi_forgetClosedTab :: line 3429"  data: no]
[task 2023-06-01T04:40:42.442Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.442Z] 04:40:42     INFO - ssi_forgetClosedTab@resource:///modules/sessionstore/SessionStore.sys.mjs:3429:24
[task 2023-06-01T04:40:42.443Z] 04:40:42     INFO - ss_forgetClosedTab@resource:///modules/sessionstore/SessionStore.sys.mjs:374:33
[task 2023-06-01T04:40:42.443Z] 04:40:42     INFO - test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:167:16
[task 2023-06-01T04:40:42.444Z] 04:40:42     INFO - async*handleTask@chrome://mochikit/content/browser-test.js:1133:26
[task 2023-06-01T04:40:42.444Z] 04:40:42     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1205:18
[task 2023-06-01T04:40:42.444Z] 04:40:42     INFO - async*Tester_execTest@chrome://mochikit/content/browser-test.js:1347:14
[task 2023-06-01T04:40:42.444Z] 04:40:42     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1122:14
[task 2023-06-01T04:40:42.445Z] 04:40:42     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13
[task 2023-06-01T04:40:42.447Z] 04:40:42     INFO - Leaving test bound test_ClosedTabMethods
[task 2023-06-01T04:40:42.447Z] 04:40:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:42.464Z] 04:40:42     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | A promise chain failed to handle a rejection: sessionstore-closed-objects-changed observer not removed before the end of test - stack: topicObserved/</<@resource://testing-common/TestUtils.sys.mjs:180:15
[task 2023-06-01T04:40:42.464Z] 04:40:42     INFO - ensureDOMPromiseRejectionsProcessed@resource://testing-common/PromiseTestUtils.sys.mjs:115:17
[task 2023-06-01T04:40:42.464Z] 04:40:42     INFO - nextTest@chrome://mochikit/content/browser-test.js:767:29
[task 2023-06-01T04:40:42.464Z] 04:40:42     INFO - async*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1796:25
[task 2023-06-01T04:40:42.465Z] 04:40:42     INFO - run@chrome://mochikit/content/browser-test.js:1716:9
[task 2023-06-01T04:40:42.465Z] 04:40:42     INFO - Rejection date: Thu Jun 01 2023 04:40:42 GMT+0000 (Coordinated Universal Time) - false == true - {"filename":"resource://testing-common/PromiseTestUtils.sys.mjs","name":"assertNoUncaughtRejections","sourceId":564,"lineNumber":266,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest","sourceId":528,"lineNumber":768,"columnNumber":29,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"testScope/test_finish/<","sourceId":528,"lineNumber":1796,"columnNumber":25,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"run","sourceId":528,"lineNumber":1716,"columnNumber":9,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"run@chrome://mochikit/content/browser-test.js:1716:9\n","nativeSavedFrame":{}},"formattedStack":"async*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1796:25\nrun@chrome://mochikit/content/browser-test.js:1716:9\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"nextTest@chrome://mochikit/content/browser-test.js:768:29\nasync*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1796:25\nrun@chrome://mochikit/content/browser-test.js:1716:9\n","nativeSavedFrame":{}},"formattedStack":"assertNoUncaughtRejections@resource://testing-common/PromiseTestUtils.sys.mjs:266:14\nnextTest@chrome://mochikit/content/browser-test.js:768:29\nasync*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1796:25\nrun@chrome://mochikit/content/browser-test.js:1716:9\n","nativeSavedFrame":{}}
[task 2023-06-01T04:40:42.465Z] 04:40:42     INFO - Stack trace:
[task 2023-06-01T04:40:42.465Z] 04:40:42     INFO - resource://testing-common/PromiseTestUtils.sys.mjs:assertNoUncaughtRejections:266
[task 2023-06-01T04:40:42.465Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:nextTest:768
[task 2023-06-01T04:40:42.466Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:testScope/test_finish/<:1796
[task 2023-06-01T04:40:42.466Z] 04:40:42     INFO - chrome://mochikit/content/browser-test.js:run:1716
[task 2023-06-01T04:40:42.469Z] 04:40:42     INFO - GECKO(28193) | JavaScript error: resource://testing-common/TestUtils.sys.mjs, line 180: uncaught exception: sessionstore-closed-objects-changed observer not removed before the end of test
[task 2023-06-01T04:40:42.476Z] 04:40:42     INFO - Console message: [JavaScript Error: "uncaught exception: sessionstore-closed-objects-changed observer not removed before the end of test" {file: "resource://testing-common/TestUtils.sys.mjs" line: 180}]
[task 2023-06-01T04:40:42.477Z] 04:40:42     INFO - GECKO(28193) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-06-01T04:40:42.480Z] 04:40:42     INFO - GECKO(28193) | console.error: Translations: (new Error("Unable to retrieve the translation models.", "resource://gre/actors/TranslationsParent.sys.mjs", 887))
[task 2023-06-01T04:40:42.481Z] 04:40:42     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/#closed0" line: 0}]
[task 2023-06-01T04:40:42.659Z] 04:40:42     INFO - GECKO(28193) | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-06-01T04:40:42.680Z] 04:40:42     INFO - GECKO(28193) | console.error: Translations: (new Error("Unable to retrieve the translation models.", "resource://gre/actors/TranslationsParent.sys.mjs", 887))
[task 2023-06-01T04:40:43.051Z] 04:40:43     INFO - GECKO(28193) | MEMORY STAT | vsize 11824MB | residentFast 696MB | heapAllocated 394MB
[task 2023-06-01T04:40:43.052Z] 04:40:43     INFO - TEST-OK | browser/components/sessionstore/test/browser_closed_tabs_windows.js | took 3044ms
[task 2023-06-01T04:40:43.082Z] 04:40:43     INFO - checking window state
[task 2023-06-01T04:40:43.083Z] 04:40:43     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-01T04:40:43.085Z] 04:40:43     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | Found an unexpected browser window at the end of test run - 
[task 2023-06-01T04:40:43.086Z] 04:40:43     INFO - GECKO(28193) | must wait for focus

Hi, I think this might be caused by Bug 1819675 but I am not sure, Sam can you please take a look?https://hg.mozilla.org/integration/autoland/rev/dff93b6ca833d54cd8e2b41a4fa6827334d26b7d

Flags: needinfo?(sfoster)

This test was introduced in the first patch on Bug 1819675. If its not failing too often I'd like to sit on this as the subsequent patches in this series will need to touch both the implementation under test and the tests themselves.

Flags: needinfo?(sfoster)

Update

There have been 34 failures within the last 7 days:

  • 18 failures on Linux 18.04 x64 WebRender opt
  • 16 failures on Linux 18.04 x64 WebRender Shippable opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=422478404&repo=autoland&lineNumber=5779

Whiteboard: [stockwell needswork:owner]

Looks like this is failing pretty often now. I'll take a look.

Assignee: nobody → sfoster
Status: NEW → ASSIGNED

Update

There have been 33 total failures within the last 7 days:

  • 14 failures on Linux 18.04 x64 WebRender opt
  • 19 failures on Linux 18.04 x64 WebRender Shippable opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=424263817&repo=mozilla-central&lineNumber=11170

Update

There have been 30 failures within the last 7 days:

  • 10 failures on Linux 18.04 x64 WebRender opt
  • 20 failures on Linux 18.04 x64 WebRender Shippable opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=425823665&repo=mozilla-central&lineNumber=10891

Update:
There have been 57 failures within the last 7 days:
• 3 failures on Linux 18.04 x64 WebRender asan opt
• 6 failures on Linux 18.04 x64 WebRender debug
• 21 failures on Linux 18.04 x64 WebRender opt
• 9 failures on Linux 18.04 x64 WebRender Shippable opt
• 2 failures on Linux 18.04 x64 WebRender tsan opt
• 4 failures on OS X 10.15 WebRender debug
• 4 failures on OS X 10.15 WebRender opt
• 2 failures on OS X 10.15 WebRender Shippable opt
• 2 failures on OS X 11 WebRender Shippable opt
• 1 failures on Windows 11 x86 22H2 WebRender opt
• 1 failures on Windows 11 x64 22H2 WebRender opt
• 2 failures on Windows 11 x64 22H2 WebRender Shippable opt
*Recent failure log:*https://treeherder.mozilla.org/logviewer?job_id=428622365&repo=autoland&lineNumber=17332

[task 2023-09-10T23:38:51.316Z] 23:38:51     INFO - TEST-PASS | browser/components/sessionstore/test/browser_closed_tabs_windows.js | Theres still one closed tab in the 2nd window - 1 == 1 - 
[task 2023-09-10T23:38:51.320Z] 23:38:51     INFO - Buffered messages finished
[task 2023-09-10T23:38:51.324Z] 23:38:51     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | Theres a total for 2 closed tabs - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2706,"lineNumber":187,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":539,"lineNumber":1131,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":539,"lineNumber":1203,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":539,"lineNumber":1345,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":539,"lineNumber":1120,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":566,"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":"async*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":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nasync*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":"async*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nasync*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":{}},"caller":null,"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:187:10\nasync*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nasync*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":{}}
[task 2023-09-10T23:38:51.331Z] 23:38:51     INFO - Stack trace:
[task 2023-09-10T23:38:51.331Z] 23:38:51     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:187
[task 2023-09-10T23:38:51.332Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:handleTask:1131
[task 2023-09-10T23:38:51.332Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1203
[task 2023-09-10T23:38:51.333Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1345
[task 2023-09-10T23:38:51.334Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-09-10T23:38:51.334Z] 23:38:51     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-09-10T23:38:51.335Z] 23:38:51     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-09-10T23:38:51.339Z] 23:38:51     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | We get the right number of tab entries from getClosedTabData() - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2706,"lineNumber":193,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":539,"lineNumber":1131,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":539,"lineNumber":1203,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":539,"lineNumber":1345,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":539,"lineNumber":1120,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":566,"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":"async*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":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nasync*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":"async*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nasync*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":{}},"caller":null,"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:193:10\nasync*handleTask@chrome://mochikit/content/browser-test.js:1131:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18\nasync*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":{}}
[task 2023-09-10T23:38:51.340Z] 23:38:51     INFO - Stack trace:
[task 2023-09-10T23:38:51.340Z] 23:38:51     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:193
[task 2023-09-10T23:38:51.341Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:handleTask:1131
[task 2023-09-10T23:38:51.341Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1203
[task 2023-09-10T23:38:51.342Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1345
[task 2023-09-10T23:38:51.342Z] 23:38:51     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-09-10T23:38:51.343Z] 23:38:51     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-09-10T23:38:51.343Z] 23:38:51     INFO - GECKO(4589) | [Child 9952, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:658
[task 2023-09-10T23:38:51.344Z] 23:38:51     INFO - TEST-PASS | browser/components/sessionstore/test/browser_closed_tabs_windows.js | The first window has closed tabs after forgetting the last tab - 0 == 0 - 
Whiteboard: [stockwell unknown] → [stockwell needswork:owner]

Hi Sam! Can you please take another look at this?
Thank you!

Flags: needinfo?(sfoster)

(In reply to Iulian Moraru from comment #23)

Hi Sam! Can you please take another look at this?

Thanks, I'm looking into this.

Flags: needinfo?(sfoster)
Pushed by sfoster@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/826e9fd4dadf Add coverage for pref'd off closedTabsFromClosedWindows, clarify assertion messages.r=dao,sessionstore-reviewers,sclements
Status: ASSIGNED → RESOLVED
Closed: 1 year ago
Resolution: --- → FIXED
Target Milestone: --- → 119 Branch

Hi Sam! Can you please take another look at this?
New failure [here]( 2 closed tab for this window - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_window)

  • failure log
    The failure line that I've mentioned in Comment 22 TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | 2 closed tab for this window - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js"<...> it is still happening as you can see in the log, only this time it's not the first failure line...now the first failure line that appears(at least in this case) is TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | The first tab of the first window we restored is current - "https://example.org/#win-1-tab-0" == "https://example.com/#win-0-tab-0" - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":,<...>
    Thank you!
Status: RESOLVED → REOPENED
Flags: needinfo?(sfoster)
Resolution: FIXED → ---
Target Milestone: 119 Branch → ---

(In reply to Iulian Moraru from comment #32)

Hi Sam! Can you please take another look at this?

Yes. I think I have a better idea of what's going on now with the improved logs/assertion messages.

Flags: needinfo?(sfoster)
Whiteboard: [stockwell disable-recommended] → [stockwell disable-recommended] [fidefe-firefox-view]
Whiteboard: [stockwell disable-recommended] [fidefe-firefox-view] → [stockwell needswork:owner][fidefe-firefox-view]

Update

There have been 30 total failures within the last 7 days:

[task 2023-12-24T15:52:22.554Z] 15:52:22     INFO - TEST-PASS | browser/components/sessionstore/test/browser_closed_tabs_windows.js | We expect [object Object],[object Object] open browser windows - 2 == 2 - 
[task 2023-12-24T15:52:22.554Z] 15:52:22     INFO - After setup, current tab URI: https://example.org/#win-1-tab-0
[task 2023-12-24T15:52:22.554Z] 15:52:22     INFO - Buffered messages finished
[task 2023-12-24T15:52:22.562Z] 15:52:22     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | The first tab of the first window we restored is current - "https://example.org/#win-1-tab-0" == "https://example.com/#win-0-tab-0" - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2757,"lineNumber":117,"columnNumber":10,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":555,"lineNumber":1138,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":555,"lineNumber":1210,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":555,"lineNumber":1352,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":555,"lineNumber":1127,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":579,"lineNumber":1058,"columnNumber":13,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"nextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1210:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"handleTask@chrome://mochikit/content/browser-test.js:1138:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1210:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:117:10\nhandleTask@chrome://mochikit/content/browser-test.js:1138:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1210:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}}
[task 2023-12-24T15:52:22.562Z] 15:52:22     INFO - Stack trace:
[task 2023-12-24T15:52:22.562Z] 15:52:22     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:117
[task 2023-12-24T15:52:22.563Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:handleTask:1138
[task 2023-12-24T15:52:22.563Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1210
[task 2023-12-24T15:52:22.563Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1352
[task 2023-12-24T15:52:22.563Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1127
[task 2023-12-24T15:52:22.563Z] 15:52:22     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2023-12-24T15:52:22.563Z] 15:52:22     INFO - window 0: https://example.org/#win-1-tab-0
[task 2023-12-24T15:52:22.564Z] 15:52:22     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-12-24T15:52:22.583Z] 15:52:22     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_closed_tabs_windows.js | getClosedTabDataForWindow() for open window 0 returned the expected number of objects - 2 == 1 - {"filename":"chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js","name":"test_ClosedTabMethods","sourceId":2757,"lineNumber":127,"columnNumber":12,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"handleTask","sourceId":555,"lineNumber":1138,"columnNumber":26,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"_runTaskBasedTest","sourceId":555,"lineNumber":1210,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":555,"lineNumber":1352,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":555,"lineNumber":1127,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":579,"lineNumber":1058,"columnNumber":13,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"nextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"async*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1210:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"handleTask@chrome://mochikit/content/browser-test.js:1138:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1210:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}},"formattedStack":"test_ClosedTabMethods@chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:127:12\nhandleTask@chrome://mochikit/content/browser-test.js:1138:26\n_runTaskBasedTest@chrome://mochikit/content/browser-test.js:1210:18\nasync*Tester_execTest@chrome://mochikit/content/browser-test.js:1352:14\nnextTest/<@chrome://mochikit/content/browser-test.js:1127:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13\n","nativeSavedFrame":{}}
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - Stack trace:
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - chrome://mochitests/content/browser/browser/components/sessionstore/test/browser_closed_tabs_windows.js:test_ClosedTabMethods:127
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:handleTask:1138
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1210
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1352
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1127
[task 2023-12-24T15:52:22.584Z] 15:52:22     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2023-12-24T15:52:22.585Z] 15:52:22     INFO - window 1: https://example.com/#win-0-tab-0
[task 2023-12-24T15:52:22.585Z] 15:52:22     INFO - Not taking screenshot here: see the one that was previously logged

Sam, are you still looking into this?
Thank you.

Whiteboard: [fidefe-firefox-view][stockwell unknown] → [fidefe-firefox-view][stockwell needswork]

Update

There have been 31 failures within the last 7 days:

  • 9 failures on Linux 18.04 x64 WebRender opt
  • 22 failures on Linux 18.04 x64 WebRender Shippable opt

Recent log: https://treeherder.mozilla.org/logviewer?job_id=444026798&repo=mozilla-central&lineNumber=9114

Sarah, can you help us assign this to someone, if Sam doesn't have time to look into this?
Thank you.

Flags: needinfo?(sclements)
Whiteboard: [fidefe-firefox-view][stockwell unknown] → [fidefe-firefox-view][stockwell needswork:owner]

I'll forward this to Sam, who's assigned to it.

Flags: needinfo?(sclements) → needinfo?(sfoster)
Keywords: leave-open
Pushed by smolnar@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/a51b43bfc473 Disable browser_closed_tabs_windows.js on Linux !debug for frequent failures. DONTBUILD
Whiteboard: [fidefe-firefox-view][stockwell disable-recommended] → [fidefe-firefox-view][stockwell disabled]
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: