Closed
Bug 1749516
Opened 3 years ago
Closed 3 years ago
Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_profile_management.py TestSwitchProfileWithoutWorkspace.test_replace_with_external_profile | OSError: Process has been unexpectedly closed (Exit code: 572) (Reason: Process
Categories
(Testing :: Marionette Client and Harness, defect, P5)
Testing
Marionette Client and Harness
Tracking
(Not tracked)
RESOLVED
DUPLICATE
of bug 1382162
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=363711519&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/AUPZSUqWQAWuxQr17fj4sA/runs/0/artifacts/public/logs/live_backing.log
[task 2022-01-11T12:49:43.901Z] 12:49:43 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_profile_management.py TestSwitchProfileWithoutWorkspace.test_replace_with_external_profile
[task 2022-01-11T12:49:43.902Z] 12:49:43 INFO - 1641905383902 Marionette DEBUG Accepted connection 2 from 127.0.0.1:52802
[task 2022-01-11T12:49:43.903Z] 12:49:43 INFO - 1641905383903 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-01-11T12:49:43.904Z] 12:49:43 INFO - 1641905383904 RemoteAgent TRACE Initial navigation already completed
[task 2022-01-11T12:49:43.905Z] 12:49:43 INFO - 1641905383905 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"4cf11b17-1ece-47f4-a73d-b553d9c8b9a1","capabilities":{"browserName":"firefox","browserVersion":"98.0" ... 0.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2022-01-11T12:49:43.907Z] 12:49:43 INFO - 1641905383907 Marionette DEBUG 2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2022-01-11T12:49:43.908Z] 12:49:43 INFO - 1641905383907 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2022-01-11T12:49:43.909Z] 12:49:43 INFO - 1641905383908 Marionette DEBUG 2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2022-01-11T12:49:43.909Z] 12:49:43 INFO - 1641905383909 Marionette DEBUG 2 <- [1,3,null,{"value":null}]
[task 2022-01-11T12:49:43.909Z] 12:49:43 INFO - 1641905383909 Marionette DEBUG 2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2022-01-11T12:49:43.909Z] 12:49:43 INFO - 1641905383909 Marionette DEBUG 2 <- [1,4,null,{"value":null}]
[task 2022-01-11T12:49:44.000Z] 12:49:44 INFO - Application command: C:\Users\task_1641901393\build\application\firefox\firefox.exe -no-remote -marionette --wait-for-browser -profile C:\Users\task_1641901393\AppData\Local\Temp\tmpjxz4kfd5external
[task 2022-01-11T12:49:44.204Z] 12:49:44 INFO - !!!! UntrustedModulesProcessor::SendGetModulesTrust for Socket - 40
[task 2022-01-11T12:49:44.204Z] 12:49:44 INFO - !!!! UntrustedModulesProcessor::SendGetModulesTrust for Socket - 1
[task 2022-01-11T12:49:44.204Z] 12:49:44 INFO - !!!! UntrustedModulesProcessor::SendGetModulesTrust for Socket - 1
[task 2022-01-11T12:49:44.205Z] 12:49:44 INFO - !!!! UntrustedModulesProcessor::SendGetModulesTrust for Socket - 1
[task 2022-01-11T12:49:44.205Z] 12:49:44 INFO - !!!! UntrustedModulesProcessor::SendGetModulesTrust for Socket - 1
[task 2022-01-11T12:56:57.690Z] 12:56:57 ERROR - TEST-UNEXPECTED-ERROR | testing/marionette/harness/marionette_harness/tests/unit/test_profile_management.py TestSwitchProfileWithoutWorkspace.test_replace_with_external_profile | OSError: Process has been unexpectedly closed (Exit code: 572) (Reason: Process killed because the connection to Marionette server is lost. Check gecko.log for errors (Reason: Connection timed out after 360.0s))
[task 2022-01-11T12:56:57.690Z] 12:56:57 INFO - Traceback (most recent call last):
[task 2022-01-11T12:56:57.691Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 202, in run
[task 2022-01-11T12:56:57.691Z] 12:56:57 INFO - testMethod()
[task 2022-01-11T12:56:57.691Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\tests\marionette\tests\testing\marionette\harness\marionette_harness\tests\unit\test_profile_management.py", line 209, in test_replace_with_external_profile
[task 2022-01-11T12:56:57.692Z] 12:56:57 INFO - self.marionette.start_session()
[task 2022-01-11T12:56:57.692Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\decorators.py", line 37, in _
[task 2022-01-11T12:56:57.692Z] 12:56:57 INFO - m._handle_socket_failure()
[task 2022-01-11T12:56:57.692Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\marionette.py", line 757, in _handle_socket_failure
[task 2022-01-11T12:56:57.693Z] 12:56:57 INFO - IOError, IOError(message.format(returncode=returncode, reason=exc)), tb
[task 2022-01-11T12:56:57.693Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\six.py", line 702, in reraise
[task 2022-01-11T12:56:57.693Z] 12:56:57 INFO - raise value.with_traceback(tb)
[task 2022-01-11T12:56:57.693Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\decorators.py", line 27, in _
[task 2022-01-11T12:56:57.694Z] 12:56:57 INFO - return func(*args, **kwargs)
[task 2022-01-11T12:56:57.694Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1228, in start_session
[task 2022-01-11T12:56:57.694Z] 12:56:57 INFO - resp = self._send_message("WebDriver:NewSession", capabilities)
[task 2022-01-11T12:56:57.694Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\decorators.py", line 37, in _
[task 2022-01-11T12:56:57.695Z] 12:56:57 INFO - m._handle_socket_failure()
[task 2022-01-11T12:56:57.695Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\marionette.py", line 757, in _handle_socket_failure
[task 2022-01-11T12:56:57.695Z] 12:56:57 INFO - IOError, IOError(message.format(returncode=returncode, reason=exc)), tb
[task 2022-01-11T12:56:57.695Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\six.py", line 702, in reraise
[task 2022-01-11T12:56:57.696Z] 12:56:57 INFO - raise value.with_traceback(tb)
[task 2022-01-11T12:56:57.696Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\decorators.py", line 27, in _
[task 2022-01-11T12:56:57.696Z] 12:56:57 INFO - return func(*args, **kwargs)
[task 2022-01-11T12:56:57.696Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\marionette.py", line 660, in _send_message
[task 2022-01-11T12:56:57.697Z] 12:56:57 INFO - msg = self.client.request(name, params)
[task 2022-01-11T12:56:57.697Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\transport.py", line 383, in request
[task 2022-01-11T12:56:57.697Z] 12:56:57 INFO - return self.receive()
[task 2022-01-11T12:56:57.697Z] 12:56:57 INFO - File "C:\Users\task_1641901393\build\venv\lib\site-packages\marionette_driver\transport.py", line 221, in receive
[task 2022-01-11T12:56:57.697Z] 12:56:57 INFO - "Connection timed out after {}s".format(self.socket_timeout)
[task 2022-01-11T12:56:57.698Z] 12:56:57 INFO - TEST-INFO took 433788ms
|
||
Comment 1•3 years ago
|
||
Firefox failed to startup and as such Marionette client killed the application after around 7 minutes of inactivity.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → DUPLICATE
|
||
Updated•2 years ago
|
Product: Testing → Remote Protocol
|
|
||
Comment 2•2 years ago
|
||
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
You need to log in
before you can comment on or make changes to this bug.
Description
•