Closed Bug 1838712 Opened 3 years ago Closed 2 years ago

Intermittent docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | single tracking bug

Categories

(Core :: DOM: Navigation, defect, P5)

Product:
Core
Component:
DOM: Navigation
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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

TEST-PASS | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | Should have gotten the right referrer set - "https://example.com/browser/" == "https://example.com/browser/" - 
[task 2023-06-15T16:13:09.647Z] 16:13:09     INFO - Buffered messages logged at 16:12:26
[task 2023-06-15T16:13:09.655Z] 16:13:09     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/browser/docshell/test/browser/dummy_iframe_page.html" line: 0}]
[task 2023-06-15T16:13:09.655Z] 16:13:09     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/browser/docshell/test/browser/dummy_page.html?sub_entry=0" line: 0}]
[task 2023-06-15T16:13:09.655Z] 16:13:09     INFO - Buffered messages finished
[task 2023-06-15T16:13:09.655Z] 16:13:09     INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | Test timed out - 
[task 2023-06-15T16:13:15.061Z] 16:13:15     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-15T16:13:15.061Z] 16:13:15     INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | waiting for vsync to be disabled - timed out after 50 tries. - false == true - {"filename":"chrome://mochikit/content/browser-test.js","name":"ensureVsyncDisabled","sourceId":539,"lineNumber":603,"columnNumber":19,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest","sourceId":539,"lineNumber":768,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"timeoutFn","sourceId":539,"lineNumber":1437,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":539,"lineNumber":1379,"columnNumber":45,"sourceLine":"","asyncCause":"setTimeout handler","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":564,"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":"setTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\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":"timeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\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":"ensureVsyncDisabled@chrome://mochikit/content/browser-test.js:603:19\nasync*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-15T16:13:15.061Z] 16:13:15     INFO - Stack trace:
[task 2023-06-15T16:13:15.061Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:ensureVsyncDisabled:603
[task 2023-06-15T16:13:15.061Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:nextTest:768
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1437
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1379
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | vsync remained enabled at the end of the test. Is there an animation still running? Consider talking to the performance team for tips to solve this. - false == true - {"filename":"chrome://mochikit/content/browser-test.js","name":"ensureVsyncDisabled","sourceId":539,"lineNumber":604,"columnNumber":19,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest","sourceId":539,"lineNumber":768,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"timeoutFn","sourceId":539,"lineNumber":1437,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":539,"lineNumber":1379,"columnNumber":45,"sourceLine":"","asyncCause":"setTimeout handler","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":564,"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":"setTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\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":"timeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\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":"ensureVsyncDisabled@chrome://mochikit/content/browser-test.js:604:19\nasync*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - Stack trace:
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:ensureVsyncDisabled:604
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:nextTest:768
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1437
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1379
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-06-15T16:13:15.069Z] 16:13:15     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-06-15T16:13:15.100Z] 16:13:15     INFO - GECKO(3232) | MEMORY STAT | vsize 1351MB | vsizeMaxContiguous 139MB | residentFast 456MB | heapAllocated 368MB
[task 2023-06-15T16:13:15.100Z] 16:13:15     INFO - TEST-OK | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | took 50521ms
[task 2023-06-15T16:13:15.109Z] 16:13:15     INFO - checking window state
[task 2023-06-15T16:13:15.109Z] 16:13:15     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-15T16:13:15.109Z] 16:13:15     INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | Found a browser window after previous test timed out - 
[task 2023-06-15T16:13:15.109Z] 16:13:15     INFO - GECKO(3232) | must wait for focus
[task 2023-06-15T16:13:15.156Z] 16:13:15     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js | Uncaught exception received from previously timed out test bound target_to_new_blank_browser - at resource://testing-common/BrowserTestUtils.sys.mjs:522 - Error: The window unloaded while we were waiting for the browser to load - this should never happen.
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - Stack trace:
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - listener@resource://testing-common/BrowserTestUtils.sys.mjs:522:15
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - EventListener.handleEvent*browserLoaded/<@resource://testing-common/BrowserTestUtils.sys.mjs:537:27
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - browserLoaded@resource://testing-common/BrowserTestUtils.sys.mjs:487:12
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - target_to_new_blank_browser@chrome://mochitests/content/browser/docshell/test/browser/browser_targetTopLevelLinkClicksToBlank.js:70:26
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - async*handleTask@chrome://mochikit/content/browser-test.js:1131:26
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1203:18
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1345:14
[task 2023-06-15T16:13:15.164Z] 16:13:15     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1120:14

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

Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=435808283&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: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=457914883&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: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.