Closed Bug 1673122 Opened 4 years ago Closed 4 years ago

Intermittent test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_restore_with_restart | IOError: Process has been unexpectedly closed (Exit code: 0) (Reason: Process unexpectedly quit without restarting (exit code: 0))

Categories

(Testing :: Firefox UI Tests, defect, P5)

Product:
Testing
Component:
Firefox UI Tests
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

...
[task 2020-10-23T22:43:47.044Z] 22:43:47     INFO -  [Child 3252, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2020-10-23T22:43:47.071Z] 22:43:47     INFO -  [Child 3252, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4287
[task 2020-10-23T22:43:47.246Z] 22:43:47     INFO -  1603493027232	Marionette	TRACE	Received observer notification xpcom-will-shutdown
[task 2020-10-23T22:43:47.246Z] 22:43:47     INFO -  1603493027232	Marionette	DEBUG	Marionette stopped listening
[task 2020-10-23T22:43:47.368Z] 22:43:47     INFO -  [RDD 5700, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4287
[task 2020-10-23T22:43:49.068Z] 22:43:49     INFO -  [Parent 4052, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2020-10-23T22:43:49.135Z] 22:43:49     INFO -  [Parent 4052, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4287
[task 2020-10-23T22:43:49.375Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: Failed to acquire a DXGI adapter for enumerating outputs.: file /builds/worker/checkouts/gecko/gfx/thebes/DeviceManagerDx.cpp:158
[task 2020-10-23T22:43:49.375Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: Failed to acquire a DXGI adapter for checking hardware stretching support.: file /builds/worker/checkouts/gecko/gfx/thebes/DeviceManagerDx.cpp:219
[task 2020-10-23T22:43:49.375Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: DWM not enabled, falling back to software vsync: file /builds/worker/checkouts/gecko/gfx/thebes/gfxWindowsPlatform.cpp:1945
[task 2020-10-23T22:43:49.390Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:902
[task 2020-10-23T22:43:49.417Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: 'NS_FAILED(GetAccentColor(unused))', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:486
[task 2020-10-23T22:43:49.572Z] 22:43:49     INFO -  1603493029562	Marionette	TRACE	Marionette enabled
[task 2020-10-23T22:43:49.572Z] 22:43:49     INFO -  1603493029563	Marionette	TRACE	Received observer notification profile-after-change
[task 2020-10-23T22:43:49.607Z] 22:43:49     INFO -  1603493029597	Marionette	TRACE	Received observer notification command-line-startup
[task 2020-10-23T22:43:49.665Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4282
[task 2020-10-23T22:43:49.912Z] 22:43:49     INFO -  [5256, Main Thread] WARNING: 'NS_FAILED(targetPrincipal->GetAsciiOrigin(targetOrigin))', file /builds/worker/checkouts/gecko/toolkit/components/antitracking/AntiTrackingUtils.cpp:347
[task 2020-10-23T22:43:50.069Z] 22:43:50     INFO -  [Parent 5256, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4280
[task 2020-10-23T22:46:54.233Z] 22:46:54     INFO -  Exiting due to channel error.
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO - TEST-UNEXPECTED-ERROR | testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_restore_with_restart | IOError: Process has been unexpectedly closed (Exit code: 0) (Reason: Process unexpectedly quit without restarting (exit code: 0))
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO - Traceback (most recent call last):
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 196, in run
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -     testMethod()
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\tests\firefox-ui\tests\testing\firefox-ui\tests\functional\sessionstore\test_restore_windows_after_restart_and_quit.py", line 77, in test_restore_with_restart
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -     self.marionette.restart(in_app=True)
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_driver\decorators.py", line 36, in _
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -     m._handle_socket_failure()
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_driver\marionette.py", line 683, in _handle_socket_failure
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -     reraise(IOError, IOError(message.format(returncode=returncode, reason=exc)), tb)
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_driver\decorators.py", line 26, in _
[task 2020-10-23T22:46:56.528Z] 22:46:56     INFO -     return func(*args, **kwargs)
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1048, in restart
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO -     reraise(exc_cls, exc_cls(msg.format(self.instance.runner.returncode)), tb)
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1031, in restart
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO -     check_process_status=False)
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO -   File "Z:\task_1603492605\build\venv\lib\site-packages\marionette_driver\marionette.py", line 574, in raise_for_port
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO -     self.host, self.port))
[task 2020-10-23T22:46:56.529Z] 22:46:56     INFO - TEST-INFO took 203182ms
[task 2020-10-23T22:46:56.529Z] 22:46:56    ERROR - test_end for testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_restore_with_restart logged while not in progress. Logged with data: {"status": "ERROR", "extra": {"class_name": "test_restore_windows_after_restart_and_quit.TestSessionStoreDisabled", "method_name": "test_restore_with_restart"}, "expected": "PASS", "test": "testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_restore_with_restart", "message": "InvalidSessionIdException: Please start a session", "stack": "Traceback (most recent call last):\n  File \"Z:\\task_1603492605\\build\\venv\\lib\\site-packages\\marionette_harness\\marionette_test\\testcases.py\", line 227, in run\n    self.tearDown()\n  File \"Z:\\task_1603492605\\build\\tests\\firefox-ui\\tests\\testing\\firefox-ui\\tests\\functional\\sessionstore\\session_store_test_case.py\", line 72, in tearDown\n    super(SessionStoreTestCase, self).tearDown()\n  File \"Z:\\task_1603492605\\build\\venv\\lib\\site-packages\\marionette_harness\\runner\\mixins\\window_manager.py\", line 25, in tearDown\n    if len(self.marionette.chrome_window_handles) > len(self.start_windows):\n  File \"Z:\\task_1603492605\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py\", line 1263, in chrome_window_handles\n    return self._send_message(\"WebDriver:GetChromeWindowHandles\")\n  File \"Z:\\task_1603492605\\build\\venv\\lib\\site-packages\\marionette_driver\\decorators.py\", line 26, in _\n    return func(*args, **kwargs)\n  File \"Z:\\task_1603492605\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py\", line 592, in _send_message\n    raise errors.InvalidSessionIdException(\"Please start a session\")\n"}

There is a crash / unexpected exit during the start-up of Firefox when doing the restart.

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

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