Closed Bug 1827187 Opened 2 years ago Closed 1 year ago

Intermittent [tier 2] testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestNavigate.test_navigate_to_same_image_document_twice | marionette_driver.errors.NoSuchWindowException: Browsing context has been discarded

Categories

(Testing :: Marionette Client and Harness, defect, P5)

Product:
Testing
Component:
Marionette Client and Harness
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2023-04-10T10:12:50.071Z] 10:12:50     INFO -  TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestNavigate.test_navigate_to_same_image_document_twice
[task 2023-04-10T10:19:16.200Z] 10:19:16     INFO -  Failed to gather test failure debug: Process has been unexpectedly closed (Exit code: 0) (Reason: Connection timed out after 360.0s)
[task 2023-04-10T10:19:16.211Z] 10:19:16    ERROR -  TEST-UNEXPECTED-ERROR | testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestNavigate.test_navigate_to_same_image_document_twice | marionette_driver.errors.NoSuchWindowException: Browsing context has been discarded
[task 2023-04-10T10:19:16.211Z] 10:19:16     INFO -  stacktrace:
[task 2023-04-10T10:19:16.212Z] 10:19:16     INFO -  	RemoteError@chrome://remote/content/shared/RemoteError.sys.mjs:8:8
[task 2023-04-10T10:19:16.212Z] 10:19:16     INFO -  	WebDriverError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:183:5
[task 2023-04-10T10:19:16.212Z] 10:19:16     INFO -  	NoSuchWindowError@chrome://remote/content/shared/webdriver/Errors.sys.mjs:468:5
[task 2023-04-10T10:19:16.212Z] 10:19:16     INFO -  	assert.that/<@chrome://remote/content/shared/webdriver/Assert.sys.mjs:485:13
[task 2023-04-10T10:19:16.213Z] 10:19:16     INFO -  	assert.open@chrome://remote/content/shared/webdriver/Assert.sys.mjs:147:4
[task 2023-04-10T10:19:16.213Z] 10:19:16     INFO -  	GeckoDriver.prototype.getTitle@chrome://remote/content/marionette/driver.sys.mjs:886:15
[task 2023-04-10T10:19:16.213Z] 10:19:16     INFO -  	despatch@chrome://remote/content/marionette/server.sys.mjs:304:40
[task 2023-04-10T10:19:16.213Z] 10:19:16     INFO -  	execute@chrome://remote/content/marionette/server.sys.mjs:275:16
[task 2023-04-10T10:19:16.213Z] 10:19:16     INFO -  	onPacket/<@chrome://remote/content/marionette/server.sys.mjs:248:20
[task 2023-04-10T10:19:16.214Z] 10:19:16     INFO -  	onPacket@chrome://remote/content/marionette/server.sys.mjs:249:9
[task 2023-04-10T10:19:16.214Z] 10:19:16     INFO -  	_onJSONObjectReady/<@chrome://remote/content/marionette/transport.sys.mjs:496:20
[task 2023-04-10T10:19:16.215Z] 10:19:16     INFO -  Traceback (most recent call last):
[task 2023-04-10T10:19:16.215Z] 10:19:16     INFO -    File "Z:\task_168112029886659\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 198, in run
[task 2023-04-10T10:19:16.215Z] 10:19:16     INFO -      testMethod()
[task 2023-04-10T10:19:16.215Z] 10:19:16     INFO -    File "Z:\task_168112029886659\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_navigation.py", line 214, in test_navigate_to_same_image_document_twice
[task 2023-04-10T10:19:16.216Z] 10:19:16     INFO -      self.assertIn("black.png", self.marionette.title)
[task 2023-04-10T10:19:16.216Z] 10:19:16     INFO -    File "Z:\task_168112029886659\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1427, in title
[task 2023-04-10T10:19:16.216Z] 10:19:16     INFO -      return self._send_message("WebDriver:GetTitle", key="value")
[task 2023-04-10T10:19:16.216Z] 10:19:16     INFO -    File "Z:\task_168112029886659\build\venv\lib\site-packages\marionette_driver\decorators.py", line 24, in _
[task 2023-04-10T10:19:16.217Z] 10:19:16     INFO -      return func(*args, **kwargs)
[task 2023-04-10T10:19:16.217Z] 10:19:16     INFO -    File "Z:\task_168112029886659\build\venv\lib\site-packages\marionette_driver\marionette.py", line 703, in _send_message
[task 2023-04-10T10:19:16.217Z] 10:19:16     INFO -      self._handle_error(err)
[task 2023-04-10T10:19:16.217Z] 10:19:16     INFO -    File "Z:\task_168112029886659\build\venv\lib\site-packages\marionette_driver\marionette.py", line 715, in _handle_error
[task 2023-04-10T10:19:16.218Z] 10:19:16     INFO -      raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2023-04-10T10:19:16.218Z] 10:19:16     INFO -  TEST-INFO took 386129ms
[task 2023-04-10T10:19:16.220Z] 10:19:16     INFO -  test_end for testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestNavigate.test_navigate_to_same_image_document_twice logged while not in progress. Logged with data: {"message": "marionette_driver.errors.InvalidSessionIdException: Please start a session", "expected": "PASS", "stack": "Traceback (most recent call last):\n  File \"Z:\\task_168112029886659\\build\\venv\\lib\\site-packages\\marionette_harness\\marionette_test\\testcases.py\", line 231, in run\n    self.tearDown()\n  File \"Z:\\task_168112029886659\\build\\tests\\marionette\\tests\\testing\\marionette\\harness\\marionette_harness\\tests\\unit\\test_navigation.py\", line 63, in tearDown\n    self.marionette.timeout.reset()\n  File \"Z:\\task_168112029886659\\build\\venv\\lib\\site-packages\\marionette_driver\\timeout.py\", line 101, in reset\n    self.script = DEFAULT_SCRIPT_TIMEOUT\n  File \"Z:\\task_168112029886659\\build\\venv\\lib\\site-packages\\marionette_driver\\timeout.py\", line 54, in script\n    self._set(\"script\", sec)\n  File \"Z:\\task_168112029886659\\build\\venv\\lib\\site-packages\\marionette_driver\\timeout.py\", line 30, in _set\n    self._marionette._send_message(\"WebDriver:SetTimeouts\", {name: ms})\n  File \"Z:\\task_168112029886659\\build\\venv\\lib\\site-packages\\marionette_driver\\decorators.py\", line 24, in _\n    return func(*args, **kwargs)\n  File \"Z:\\task_168112029886659\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py\", line 693, in _send_message\n    raise errors.InvalidSessionIdException(\"Please start a session\")\n", "extra": {"class_name": "test_navigation.TestNavigate", "method_name": "test_navigate_to_same_image_document_twice"}, "test": "testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestNavigate.test_navigate_to_same_image_document_twice", "status": "ERROR"}
[task 2023-04-10T10:19:16.220Z] 10:19:16     INFO -  TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_navigation.py TestNavigate.test_no_hang_when_navigating_after_closing_original_tab

We seem to have lost any kind of logging after a shutdown of Firefox:
https://treeherder.mozilla.org/logviewer?job_id=411822509&repo=autoland&lineNumber=44177-44211

Some other tests were still successful but then this timeout happens. There is no helpful log output that could help to identify this issue. It also happened once so far so we have to observe for now if it happens again.

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

Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.