Closed Bug 1573522 Opened 6 years ago Closed 6 years ago

Intermittent Tier 2 /webdriver/tests/get_element_tag_name/user_prompts.py | test_accept[capabilities0-alert-None] - setup error

Categories

(Remote Protocol :: Marionette, defect, P5)

Product:
Remote Protocol
Component:
Marionette
Version:
Version 3
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED DUPLICATE of bug 1498944

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=261306888&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/CJSrx2qlQYG2_Fv_8P777Q/runs/0/artifacts/public/logs/live_backing.log

[task 2019-08-13T11:22:51.067Z] 11:22:51 INFO - STDOUT: =================================== ERRORS ====================================
[task 2019-08-13T11:22:51.068Z] 11:22:51 INFO - STDOUT: ___________ ERROR at setup of test_accept[capabilities0-alert-None] ___________
[task 2019-08-13T11:22:51.069Z] 11:22:51 INFO - STDOUT: capabilities = {'unhandledPromptBehavior': 'accept'}
[task 2019-08-13T11:22:51.071Z] 11:22:51 INFO - STDOUT: configuration = {'capabilities': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firefox.exe', 'prefs'...platform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}}, 'host': '127.0.0.1', 'port': 52149}
[task 2019-08-13T11:22:51.072Z] 11:22:51 INFO - PID 3920 | 1565695371052 Marionette DEBUG 0 -> [0,70,"WebDriver:SwitchToFrame",{}]
[task 2019-08-13T11:22:51.073Z] 11:22:51 INFO - STDOUT: request = <SubRequest 'session' for <Function 'test_accept[capabilities0-alert-None]'>>
[task 2019-08-13T11:22:51.075Z] 11:22:51 INFO - PID 3920 | 1565695371054 Marionette DEBUG 0 <- [1,70,null,{"value":null}]
[task 2019-08-13T11:22:51.076Z] 11:22:51 INFO - STDOUT: @pytest.fixture(scope="function")
[task 2019-08-13T11:22:51.077Z] 11:22:51 INFO - PID 3920 | 1565695371055 webdriver::server DEBUG <- 200 OK {"value":null}
[task 2019-08-13T11:22:51.079Z] 11:22:51 INFO - STDOUT: def session(capabilities, configuration, request):
[task 2019-08-13T11:22:51.080Z] 11:22:51 INFO - STDOUT: """Create and start a session for a test that does not itself test session creation.
[task 2019-08-13T11:22:51.081Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.083Z] 11:22:51 INFO - STDOUT: By default the session will stay open after each test, but we always try to start a
[task 2019-08-13T11:22:51.084Z] 11:22:51 INFO - STDOUT: new one and assume that if that fails there is already a valid session. This makes it
[task 2019-08-13T11:22:51.086Z] 11:22:51 INFO - STDOUT: possible to recover from some errors that might leave the session in a bad state, but
[task 2019-08-13T11:22:51.088Z] 11:22:51 INFO - STDOUT: does not demand that we start a new session per test."""
[task 2019-08-13T11:22:51.089Z] 11:22:51 INFO - STDOUT: global _current_session
[task 2019-08-13T11:22:51.090Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.091Z] 11:22:51 INFO - STDOUT: # Update configuration capabilities with custom ones from the
[task 2019-08-13T11:22:51.092Z] 11:22:51 INFO - STDOUT: # capabilities fixture, which can be set by tests
[task 2019-08-13T11:22:51.092Z] 11:22:51 INFO - STDOUT: caps = copy.deepcopy(configuration["capabilities"])
[task 2019-08-13T11:22:51.093Z] 11:22:51 INFO - STDOUT: caps.update(capabilities)
[task 2019-08-13T11:22:51.093Z] 11:22:51 INFO - STDOUT: caps = {"alwaysMatch": caps}
[task 2019-08-13T11:22:51.093Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.093Z] 11:22:51 INFO - STDOUT: # If there is a session with different capabilities active, end it now
[task 2019-08-13T11:22:51.094Z] 11:22:51 INFO - STDOUT: if _current_session is not None and (
[task 2019-08-13T11:22:51.094Z] 11:22:51 INFO - STDOUT: caps != _current_session.requested_capabilities):
[task 2019-08-13T11:22:51.094Z] 11:22:51 INFO - STDOUT: _current_session.end()
[task 2019-08-13T11:22:51.094Z] 11:22:51 INFO - STDOUT: _current_session = None
[task 2019-08-13T11:22:51.094Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.095Z] 11:22:51 INFO - STDOUT: if _current_session is None:
[task 2019-08-13T11:22:51.095Z] 11:22:51 INFO - STDOUT: _current_session = webdriver.Session(
[task 2019-08-13T11:22:51.096Z] 11:22:51 INFO - STDOUT: configuration["host"],
[task 2019-08-13T11:22:51.097Z] 11:22:51 INFO - STDOUT: configuration["port"],
[task 2019-08-13T11:22:51.098Z] 11:22:51 INFO - STDOUT: capabilities=caps)
[task 2019-08-13T11:22:51.100Z] 11:22:51 INFO - STDOUT: try:
[task 2019-08-13T11:22:51.100Z] 11:22:51 INFO - STDOUT: > _current_session.start()
[task 2019-08-13T11:22:51.101Z] 11:22:51 INFO - STDOUT: capabilities = {'unhandledPromptBehavior': 'accept'}
[task 2019-08-13T11:22:51.101Z] 11:22:51 INFO - STDOUT: caps = {'alwaysMatch': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firefox.exe', 'prefs':...latform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}, 'unhandledPromptBehavior': 'accept'}}
[task 2019-08-13T11:22:51.101Z] 11:22:51 INFO - STDOUT: configuration = {'capabilities': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firefox.exe', 'prefs'...platform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}}, 'host': '127.0.0.1', 'port': 52149}
[task 2019-08-13T11:22:51.102Z] 11:22:51 INFO - STDOUT: request = <SubRequest 'session' for <Function 'test_accept[capabilities0-alert-None]'>>
[task 2019-08-13T11:22:51.103Z] 11:22:51 INFO - STDOUT: tests\web-platform\tests\webdriver\tests\support\fixtures.py
[task 2019-08-13T11:22:51.104Z] 11:22:51 INFO - STDOUT: :150:
[task 2019-08-13T11:22:51.105Z] 11:22:51 INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2019-08-13T11:22:51.106Z] 11:22:51 INFO - STDOUT: tests\web-platform\tests\tools\webdriver\webdriver\client.py
[task 2019-08-13T11:22:51.106Z] 11:22:51 INFO - STDOUT: :429: in start
[task 2019-08-13T11:22:51.106Z] 11:22:51 INFO - STDOUT: value = self.send_command("POST", "session", body=body)
[task 2019-08-13T11:22:51.107Z] 11:22:51 INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2019-08-13T11:22:51.112Z] 11:22:51 INFO - STDOUT: self = <Session (disconnected)>, method = 'POST', url = 'session'
[task 2019-08-13T11:22:51.114Z] 11:22:51 INFO - STDOUT: body = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firef...atform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}, 'unhandledPromptBehavior': 'accept'}}}
[task 2019-08-13T11:22:51.115Z] 11:22:51 INFO - STDOUT: def send_command(self, method, url, body=None):
[task 2019-08-13T11:22:51.117Z] 11:22:51 INFO - STDOUT: """
[task 2019-08-13T11:22:51.118Z] 11:22:51 INFO - STDOUT: Send a command to the remote end and validate its success.
[task 2019-08-13T11:22:51.119Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.120Z] 11:22:51 INFO - STDOUT: :param method: HTTP method to use in request.
[task 2019-08-13T11:22:51.120Z] 11:22:51 INFO - STDOUT: :param uri: "Command part" of the HTTP request URL,
[task 2019-08-13T11:22:51.120Z] 11:22:51 INFO - STDOUT: e.g. window/rect.
[task 2019-08-13T11:22:51.121Z] 11:22:51 INFO - STDOUT: :param body: Optional body of the HTTP request.
[task 2019-08-13T11:22:51.122Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.123Z] 11:22:51 INFO - STDOUT: :return: None if the HTTP response body was empty, otherwise
[task 2019-08-13T11:22:51.123Z] 11:22:51 INFO - STDOUT: the value field returned after parsing the response
[task 2019-08-13T11:22:51.123Z] 11:22:51 INFO - STDOUT: body as JSON.
[task 2019-08-13T11:22:51.124Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.125Z] 11:22:51 INFO - STDOUT: :raises error.WebDriverException: If the remote end returns
[task 2019-08-13T11:22:51.126Z] 11:22:51 INFO - STDOUT: an error.
[task 2019-08-13T11:22:51.126Z] 11:22:51 INFO - STDOUT: :raises ValueError: If the response body does not contain a
[task 2019-08-13T11:22:51.126Z] 11:22:51 INFO - STDOUT: value key.
[task 2019-08-13T11:22:51.131Z] 11:22:51 INFO - STDOUT: """
[task 2019-08-13T11:22:51.131Z] 11:22:51 INFO - STDOUT: response = self.transport.send(
[task 2019-08-13T11:22:51.131Z] 11:22:51 INFO - STDOUT: method, url, body,
[task 2019-08-13T11:22:51.132Z] 11:22:51 INFO - STDOUT: encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2019-08-13T11:22:51.132Z] 11:22:51 INFO - STDOUT: session=self)
[task 2019-08-13T11:22:51.133Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.135Z] 11:22:51 INFO - STDOUT: if response.status != 200:
[task 2019-08-13T11:22:51.136Z] 11:22:51 INFO - STDOUT: err = error.from_response(response)
[task 2019-08-13T11:22:51.137Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.137Z] 11:22:51 INFO - STDOUT: if isinstance(err, error.InvalidSessionIdException):
[task 2019-08-13T11:22:51.137Z] 11:22:51 INFO - STDOUT: # The driver could have already been deleted the session.
[task 2019-08-13T11:22:51.139Z] 11:22:51 INFO - STDOUT: self.session_id = None
[task 2019-08-13T11:22:51.139Z] 11:22:51 INFO - STDOUT:
[task 2019-08-13T11:22:51.139Z] 11:22:51 INFO - STDOUT: > raise err
[task 2019-08-13T11:22:51.141Z] 11:22:51 INFO - STDOUT: E UnknownErrorException: unknown error (500): connection refused
[task 2019-08-13T11:22:51.143Z] 11:22:51 INFO - STDOUT: body = {'capabilities': {'alwaysMatch': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firef...atform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}, 'unhandledPromptBehavior': 'accept'}}}
[task 2019-08-13T11:22:51.143Z] 11:22:51 INFO - STDOUT: err = <UnknownErrorException http_status=500>
[task 2019-08-13T11:22:51.143Z] 11:22:51 INFO - STDOUT: method = 'POST'
[task 2019-08-13T11:22:51.144Z] 11:22:51 INFO - STDOUT: response = <Response status=500 error=<UnknownErrorException http_status=500>>
[task 2019-08-13T11:22:51.146Z] 11:22:51 INFO - STDOUT: self = <Session (disconnected)>
[task 2019-08-13T11:22:51.147Z] 11:22:51 INFO - STDOUT: url = 'session'
[task 2019-08-13T11:22:51.149Z] 11:22:51 INFO - STDOUT: tests\web-platform\tests\tools\webdriver\webdriver\client.py
[task 2019-08-13T11:22:51.150Z] 11:22:51 INFO - STDOUT: :480: UnknownErrorException
[task 2019-08-13T11:22:51.152Z] 11:22:51 INFO - STDOUT: ============================== warnings summary ===============================
[task 2019-08-13T11:22:51.153Z] 11:22:51 INFO - STDOUT: <undetermined location>
[task 2019-08-13T11:22:51.153Z] 11:22:51 INFO - STDOUT: Module already imported so cannot be rewritten: mozlog
[task 2019-08-13T11:22:51.154Z] 11:22:51 INFO - STDOUT: Module already imported so cannot be rewritten: tests.support.fixtures
[task 2019-08-13T11:22:51.156Z] 11:22:51 INFO - STDOUT: -- Docs: http://doc.pytest.org/en/latest/warnings.html
[task 2019-08-13T11:22:51.156Z] 11:22:51 INFO - STDOUT: ============== 17 passed, 2 warnings, 1 error in 104.49 seconds ===============
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - TEST-UNEXPECTED-ERROR | /webdriver/tests/get_element_tag_name/user_prompts.py | test_accept[capabilities0-alert-None] - setup error
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - capabilities = {'unhandledPromptBehavior': 'accept'}
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - configuration = {'capabilities': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firefox.exe', 'prefs'...platform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}}, 'host': '127.0.0.1', 'port': 52149}
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - request = <SubRequest 'session' for <Function 'test_accept[capabilities0-alert-None]'>>
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - @pytest.fixture(scope="function")
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - def session(capabilities, configuration, request):
[task 2019-08-13T11:22:51.167Z] 11:22:51 INFO - """Create and start a session for a test that does not itself test session creation.
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - By default the session will stay open after each test, but we always try to start a
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - new one and assume that if that fails there is already a valid session. This makes it
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - possible to recover from some errors that might leave the session in a bad state, but
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - does not demand that we start a new session per test."""
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - global _current_session
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - # Update configuration capabilities with custom ones from the
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - # capabilities fixture, which can be set by tests
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - caps = copy.deepcopy(configuration["capabilities"])
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - caps.update(capabilities)
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - caps = {"alwaysMatch": caps}
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.168Z] 11:22:51 INFO - # If there is a session with different capabilities active, end it now
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - if _current_session is not None and (
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - caps != _current_session.requested_capabilities):
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - _current_session.end()
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - _current_session = None
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - if _current_session is None:
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - _current_session = webdriver.Session(
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - configuration["host"],
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - configuration["port"],
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - capabilities=caps)
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - try:
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - > _current_session.start()
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - capabilities = {'unhandledPromptBehavior': 'accept'}
[task 2019-08-13T11:22:51.169Z] 11:22:51 INFO - caps = {'alwaysMatch': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firefox.exe', 'prefs':...latform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}, 'unhandledPromptBehavior': 'accept'}}
[task 2019-08-13T11:22:51.170Z] 11:22:51 INFO - configuration = {'capabilities': {'moz:firefoxOptions': {'binary': 'Z:\task_1565691502\build\application\firefox\firefox.exe', 'prefs'...platform.test,www2.www.not-web-platform.test', 'network.process.enabled': False}}}, 'host': '127.0.0.1', 'port': 52149}
[task 2019-08-13T11:22:51.170Z] 11:22:51 INFO - request = <SubRequest 'session' for <Function 'test_accept[capabilities0-alert-None]'>>
[task 2019-08-13T11:22:51.170Z] 11:22:51 INFO -
[task 2019-08-13T11:22:51.170Z] 11:22:51 INFO - tests\web-platform\tests\webdriver\tests\support\fixtures.py:150:
[task 2019-08-13T11:22:51.170Z] 11:22:51 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _

There was no marionette-startup-requested notification.

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → DUPLICATE
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.