Closed
Bug 1953796
Opened 1 month ago
Closed 3 days ago
Intermittent /webdriver/tests/classic/execute_script/execute.py | test_abort_by_user_prompt_twice[prompt] - webdriver.error.TimeoutException: timeout (500): Timed out after 5.0 seconds with message: Second alert has not been opened
Categories
(Remote Protocol :: Marionette, defect, P5)
Remote Protocol
Marionette
Tracking
(Not tracked)
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: sstanca [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=498961194&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/X2uj7k6cRSGovkmJjnhsVA/runs/0/artifacts/public/logs/live_backing.log
[task 2025-03-13T12:58:59.950Z] 12:58:59 INFO - TEST-PASS | /webdriver/tests/classic/execute_script/execute.py | test_abort_by_user_prompt_twice[confirm]
[task 2025-03-13T12:58:59.950Z] 12:58:59 INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/classic/execute_script/execute.py | test_abort_by_user_prompt_twice[prompt] - webdriver.error.TimeoutException: timeout (500): Timed out after 5.0 seconds with message: Second alert has not been opened
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - session = <Session c835630b-958a-4848-88f4-4c3cde51eb81>, dialog_type = 'prompt'
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - @pytest.mark.parametrize("dialog_type", ["alert", "confirm", "prompt"])
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - def test_abort_by_user_prompt_twice(session, dialog_type):
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - response = execute_script(
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - session, "window.{0}('Hello'); window.{0}('Bye'); return 1;".format(dialog_type))
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - assert_success(response, None)
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - session.alert.accept()
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - # The first alert has been accepted by the user prompt handler, the second
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - # alert will still be opened because the current step isn't aborted.
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - wait = Poll(
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - session,
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - timeout=5,
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - message="Second alert has not been opened",
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - ignored_exceptions=NoSuchAlertException
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - )
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - > text = wait.until(lambda s: s.alert.text)
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - dialog_type = 'prompt'
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - response = <Response: status=200 body={"value": null}>
[task 2025-03-13T12:58:59.951Z] 12:58:59 INFO - session = <Session c835630b-958a-4848-88f4-4c3cde51eb81>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - wait = <tests.support.sync.Poll object at 0x7f86852dedc0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/webdriver/tests/classic/execute_script/execute.py:110:
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/webdriver/tests/support/sync.py:142: in until
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - raise self.exc_cls(message=message).with_traceback(tb)
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - _ = <NoSuchAlertException http_status=404>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - condition = <function test_abort_by_user_prompt_twice.<locals>.<lambda> at 0x7f86852eadc0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - elapsed = 5.0
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - end = 1741870738.7082498
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - interval_new = 0.09130716323852539
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - message = 'Timed out after 5.0 seconds with message: Second alert has not been opened'
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - next = 1741870738.7151082
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - rv = None
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - self = <tests.support.sync.Poll object at 0x7f86852dedc0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - start = 1741870733.7082498
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tb = <traceback object at 0x7f868527c980>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/webdriver/tests/support/sync.py:118: in until
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - rv = condition(self.session)
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - _ = <NoSuchAlertException http_status=404>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - condition = <function test_abort_by_user_prompt_twice.<locals>.<lambda> at 0x7f86852eadc0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - elapsed = 5.0
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - end = 1741870738.7082498
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - interval_new = 0.09130716323852539
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - message = 'Timed out after 5.0 seconds with message: Second alert has not been opened'
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - next = 1741870738.7151082
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - rv = None
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - self = <tests.support.sync.Poll object at 0x7f86852dedc0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - start = 1741870733.7082498
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tb = <traceback object at 0x7f868527c980>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/webdriver/tests/classic/execute_script/execute.py:110: in <lambda>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - text = wait.until(lambda s: s.alert.text)
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - s = <Session c835630b-958a-4848-88f4-4c3cde51eb81>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:22: in inner
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - return func(self, *args, **kwargs)
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - args = ()
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - func = <function UserPrompt.text at 0x7f8685ff60d0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - kwargs = {}
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - self = <webdriver.client.UserPrompt object at 0x7f86852d94f0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - session = <Session c835630b-958a-4848-88f4-4c3cde51eb81>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:423: in text
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - return self.session.send_session_command("GET", "alert/text")
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - self = <webdriver.client.UserPrompt object at 0x7f86852d94f0>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:603: in send_session_command
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - return self.send_command(method, url, body, timeout)
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - body = None
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - method = 'GET'
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - self = <Session c835630b-958a-4848-88f4-4c3cde51eb81>
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - timeout = None
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - uri = 'alert/text'
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - url = 'session/c835630b-958a-4848-88f4-4c3cde51eb81/alert/text'
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2025-03-13T12:58:59.952Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - self = <Session c835630b-958a-4848-88f4-4c3cde51eb81>, method = 'GET'
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - url = 'session/c835630b-958a-4848-88f4-4c3cde51eb81/alert/text', body = None
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - timeout = None
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - def send_command(self, method, url, body=None, timeout=None):
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - """
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - Send a command to the remote end and validate its success.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - :param method: HTTP method to use in request.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - :param uri: "Command part" of the HTTP request URL,
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - e.g. `window/rect`.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - :param body: Optional body of the HTTP request.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - :return: `None` if the HTTP response body was empty, otherwise
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - the `value` field returned after parsing the response
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - body as JSON.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - :raises error.WebDriverException: If the remote end returns
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - an error.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - :raises ValueError: If the response body does not contain a
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - `value` key.
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - """
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - response = self.transport.send(
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - method, url, body,
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2025-03-13T12:58:59.953Z] 12:58:59 INFO - session=self, timeout=timeout)
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - if response.status != 200:
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - err = error.from_response(response)
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - if isinstance(err, error.InvalidSessionIdException):
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - # The driver could have already been deleted the session.
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - self.session_id = None
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - > raise err
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - E webdriver.error.TimeoutException: timeout (500): Timed out after 5.0 seconds with message: Second alert has not been opened
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - body = None
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - err = <NoSuchAlertException http_status=404>
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - method = 'GET'
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - response = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - self = <Session c835630b-958a-4848-88f4-4c3cde51eb81>
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - timeout = None
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - url = 'session/c835630b-958a-4848-88f4-4c3cde51eb81/alert/text'
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO -
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:567: TimeoutException
[task 2025-03-13T12:58:59.954Z] 12:58:59 INFO - TEST-OK | /webdriver/tests/classic/execute_script/execute.py | took 17912ms
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 3•3 days ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 3 days ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•