Closed
Bug 1736836
Opened 4 years ago
Closed 4 years ago
Intermittent /webdriver/tests/find_element/user_prompts.py | test_default[alert-None] - setup error: webdriver.error.TimeoutException: timeout (500): No connection could be made because the target machine actively refused it. (os error 10061)
Categories
(Remote Protocol :: Marionette, defect, P5)
Remote Protocol
Marionette
Tracking
(Not tracked)
RESOLVED
DUPLICATE
of bug 1630132
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=355432002&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/QEnsfkadQTyfRQco2B4Uog/runs/0/artifacts/public/logs/live_backing.log
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - TEST-PASS | /webdriver/tests/find_element/user_prompts.py | test_ignore[capabilities0-prompt]
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - TEST-UNEXPECTED-ERROR | /webdriver/tests/find_element/user_prompts.py | test_default[alert-None] - setup error: webdriver.error.TimeoutException: timeout (500): No connection could be made because the target machine actively refused it. (os error 10061)
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - args = ()
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - kwargs = {'capabilities': {}, 'configuration': {'capabilities': {'moz:firefoxOptions': {'args': ['--profile', 'C:\\Users\\task_... 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}}, 'host': '127.0.0.1', 'port': 53380}}
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - request = <SubRequest 'session' for <Function test_default[alert-None]>>
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - setup = <function pytest_fixture_setup.<locals>.wrapper.<locals>.setup at 0x000001D736B05E50>
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO - finalizer = <function pytest_fixture_setup.<locals>.wrapper.<locals>.finalizer at 0x000001D736B05160>
[task 2021-10-20T11:51:39.409Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - def wrapper(*args, **kwargs):
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - loop = fixture_stripper.get_and_strip_from(FixtureStripper.EVENT_LOOP, kwargs)
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - request = fixture_stripper.get_and_strip_from(FixtureStripper.REQUEST, kwargs)
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - gen_obj = generator(*args, **kwargs)
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - async def setup():
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - res = await gen_obj.__anext__()
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - return res
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - def finalizer():
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - """Yield again, to finalize."""
[task 2021-10-20T11:51:39.410Z] 11:51:39 INFO - async def async_finalizer():
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - try:
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - await gen_obj.__anext__()
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - except StopAsyncIteration:
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - pass
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - else:
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - msg = "Async generator fixture didn't stop."
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - msg += "Yield only once."
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - raise ValueError(msg)
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - loop.run_until_complete(async_finalizer())
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - request.addfinalizer(finalizer)
[task 2021-10-20T11:51:39.411Z] 11:51:39 INFO - > return loop.run_until_complete(setup())
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - args = ()
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - finalizer = <function pytest_fixture_setup.<locals>.wrapper.<locals>.finalizer at 0x000001D736B05160>
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - fixture_stripper = <pytest_asyncio.plugin.FixtureStripper object at 0x000001D736B2E670>
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - gen_obj = <async_generator object session at 0x000001D736B054C0>
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - generator = <function session at 0x000001D7369D7550>
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - kwargs = {'capabilities': {},
[task 2021-10-20T11:51:39.412Z] 11:51:39 INFO - 'configuration': {'capabilities': {'moz:firefoxOptions': {'args': ['--profile',
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - 'C:\\Users\\task_163472611968090\\AppData\\Local\\Temp\\tmplvx99gfz.mozrunner'],
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}},
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - 'host': '127.0.0.1',
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - 'port': 53380}}
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - loop = <ProactorEventLoop running=False closed=False debug=False>
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - request = <SubRequest 'session' for <Function test_default[alert-None]>>
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - setup = <function pytest_fixture_setup.<locals>.wrapper.<locals>.setup at 0x000001D736B05E50>
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - tests\web-platform\tests\tools\third_party\pytest-asyncio\pytest_asyncio\plugin.py:127:
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - c:\mozilla-build\python3\lib\asyncio\base_events.py:642: in run_until_complete
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - return future.result()
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - future = <Task finished name='Task-109' coro=<pytest_fixture_setup.<locals>.wrapper.<locals>.setup() done, defined at Z:\task_163472611968090\build\tests\web-platform\tests\tools\third_party\pytest-asyncio\pytest_asyncio\plugin.py:109> exception=<TimeoutException http_status=500>>
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - new_task = True
[task 2021-10-20T11:51:39.413Z] 11:51:39 INFO - self = <ProactorEventLoop running=False closed=False debug=False>
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - tests\web-platform\tests\tools\third_party\pytest-asyncio\pytest_asyncio\plugin.py:110: in setup
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - res = await gen_obj.__anext__()
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - gen_obj = <async_generator object session at 0x000001D736B054C0>
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - tests\web-platform\tests\webdriver\tests\support\fixtures.py:121: in session
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - _current_session.start()
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - capabilities = {}
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - caps = {'alwaysMatch': {'moz:firefoxOptions': {'args': ['--profile',
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - 'C:\\Users\\task_163472611968090\\AppData\\Local\\Temp\\tmplvx99gfz.mozrunner'],
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}}}
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - configuration = {'capabilities': {'moz:firefoxOptions': {'args': ['--profile',
[task 2021-10-20T11:51:39.414Z] 11:51:39 INFO - 'C:\\Users\\task_163472611968090\\AppData\\Local\\Temp\\tmplvx99gfz.mozrunner'],
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}},
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - 'host': '127.0.0.1',
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - 'port': 53380}
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - tests\web-platform\tests\tools\webdriver\webdriver\client.py:554: in start
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - value = self.send_command("POST", "session", body=body)
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - body = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'args': ['--profile',
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - 'C:\\Users\\task_163472611968090\\AppData\\Local\\Temp\\tmplvx99gfz.mozrunner'],
[task 2021-10-20T11:51:39.415Z] 11:51:39 INFO - 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}}}}
[task 2021-10-20T11:51:39.416Z] 11:51:39 INFO - self = <Session (disconnected)>
[task 2021-10-20T11:51:39.416Z] 11:51:39 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2021-10-20T11:51:39.416Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.416Z] 11:51:39 INFO - self = <Session (disconnected)>, method = 'POST', url = 'session'
[task 2021-10-20T11:51:39.416Z] 11:51:39 INFO - body = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'args': ['--profile', 'C:\\Users\\task_163472611968090\\AppDa...ocal\\Temp\\tmplvx99gfz.mozrunner'], 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}}}}
[task 2021-10-20T11:51:39.416Z] 11:51:39 INFO - timeout = None
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO - def send_command(self, method, url, body=None, timeout=None):
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO - """
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO - Send a command to the remote end and validate its success.
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO - :param method: HTTP method to use in request.
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO - :param uri: "Command part" of the HTTP request URL,
[task 2021-10-20T11:51:39.417Z] 11:51:39 INFO - e.g. `window/rect`.
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - :param body: Optional body of the HTTP request.
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - :return: `None` if the HTTP response body was empty, otherwise
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - the `value` field returned after parsing the response
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - body as JSON.
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - :raises error.WebDriverException: If the remote end returns
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - an error.
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - :raises ValueError: If the response body does not contain a
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - `value` key.
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - """
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - response = self.transport.send(
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - method, url, body,
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - session=self, timeout=timeout)
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - if response.status != 200:
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO - err = error.from_response(response)
[task 2021-10-20T11:51:39.418Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - if isinstance(err, error.InvalidSessionIdException):
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - # The driver could have already been deleted the session.
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - self.session_id = None
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - > raise err
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - E webdriver.error.TimeoutException: timeout (500): No connection could be made because the target machine actively refused it. (os error 10061)
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - body = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'args': ['--profile',
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - 'C:\\Users\\task_163472611968090\\AppData\\Local\\Temp\\tmplvx99gfz.mozrunner'],
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - 'binary': 'Z:\\task_163472611968090\\build\\application\\firefox\\firefox.exe'}}}}
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - err = <TimeoutException http_status=500>
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - method = 'POST'
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - response = <Response status=500 error=<TimeoutException http_status=500>>
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - self = <Session (disconnected)>
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - timeout = None
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - url = 'session'
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO -
[task 2021-10-20T11:51:39.419Z] 11:51:39 INFO - tests\web-platform\tests\tools\webdriver\webdriver\client.py:618: TimeoutException
[task 2021-10-20T11:51:39.420Z] 11:51:39 INFO - ..
[task 2021-10-20T11:51:39.420Z] 11:51:39 INFO - TEST-OK | /webdriver/tests/find_element/user_prompts.py | took 176083ms
[task 2021-10-20T11:51:39.420Z] 11:51:39 INFO - Restarting browser for new test group
[task 2021-10-20T11:51:49.414Z] 11:51:49 WARNING - Forcibly terminating runner process
[task 2021-10-20T11:51:49.419Z] 11:51:49 INFO - Starting runner
[task 2021-10-20T11:51:50.808Z] 11:51:50 INFO - PID 2428 | 1634730710304 geckodriver INFO Listening on 127.0.0.1:54631
[task 2021-10-20T11:51:50.811Z] 11:51:50 INFO - WebDriver HTTP server listening at http://127.0.0.1:54631/
[task 2021-10-20T11:51:50.813Z] 11:51:50 INFO - TEST-START | /webdriver/tests/find_elements/find.py
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → DUPLICATE
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 3•2 years ago
|
||
Moving bug to Remote Protocol::Marionette component per bug 1815831.
Component: geckodriver → Marionette
Product: Testing → Remote Protocol
You need to log in
before you can comment on or make changes to this bug.
Description
•