Closed Bug 1559836 Opened 5 months ago Closed 5 months ago

Intermittent /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt_twice[confirm] - NoSuchAlertException: no such alert (404):

Categories

(Testing :: geckodriver, defect, P5)

Version 3
defect

Tracking

(firefox-esr60 unaffected, firefox67 unaffected, firefox67.0.1 unaffected, firefox68 unaffected, firefox69 fixed)

RESOLVED FIXED
mozilla69
Tracking Status
firefox-esr60 --- unaffected
firefox67 --- unaffected
firefox67.0.1 --- unaffected
firefox68 --- unaffected
firefox69 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: whimboo)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

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


[task 2019-06-17T19:52:49.483Z] 19:52:49 INFO - TEST-START | /webdriver/tests/execute_script/execute.py
[task 2019-06-17T19:52:51.800Z] 19:52:51 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_no_browsing_context
[task 2019-06-17T19:52:51.800Z] 19:52:51 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_ending_comment
[task 2019-06-17T19:52:51.800Z] 19:52:51 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[alert]
[task 2019-06-17T19:52:51.800Z] 19:52:51 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[confirm]
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[prompt]
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt_twice[alert]
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt_twice[confirm] - NoSuchAlertException: no such alert (404):
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - session = <Session 5e3647fc-dc31-438e-94ce-746d46b0cf24>
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - dialog_type = 'confirm'
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - @pytest.mark.parametrize("dialog_type", ["alert", "confirm", "prompt"])
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - def test_abort_by_user_prompt_twice(session, dialog_type):
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - response = execute_script(
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - session, "window.{0}('Hello'); window.{0}('Bye'); return 1;".format(dialog_type))
[task 2019-06-17T19:52:51.801Z] 19:52:51 INFO - assert_success(response, None)
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - session.alert.accept()
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - # The first alert has been accepted by the user prompt handler, the second one remains.
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - # FIXME: this is how browsers currently work, but the spec should clarify if this is the
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - # expected behavior, see https://github.com/w3c/webdriver/issues/1153.
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - > assert session.alert.text == "Bye"
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - dialog_type = 'confirm'
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - response = <Responsetatus=200 body={"value": null}>
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - session = <Session 5e3647fc-dc31-438e-94ce-746d46b0cf24>
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.802Z] 19:52:51 INFO - tests/web-platform/tests/webdriver/tests/execute_script/execute.py:55:
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:20: in inner
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - return func(self, *args, **kwargs)
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:354: in text
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - return self.session.send_session_command("GET", "alert/text")
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:508: in send_session_command
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - return self.send_command(method, url, body)
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2019-06-17T19:52:51.803Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - self = <Session 5e3647fc-dc31-438e-94ce-746d46b0cf24>, method = 'GET'
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - url = 'session/5e3647fc-dc31-438e-94ce-746d46b0cf24/alert/text', body = None
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - def send_command(self, method, url, body=None):
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - """
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - Send a command to the remote end and validate its success.
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - :param method: HTTP method to use in request.
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - :param uri: "Command part" of the HTTP request URL,
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - e.g. window/rect.
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO - :param body: Optional body of the HTTP request.
[task 2019-06-17T19:52:51.804Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - :return: None if the HTTP response body was empty, otherwise
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - the value field returned after parsing the response
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - body as JSON.
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - :raises error.WebDriverException: If the remote end returns
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - an error.
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - :raises ValueError: If the response body does not contain a
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - value key.
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - """
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - response = self.transport.send(
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - method, url, body,
[task 2019-06-17T19:52:51.805Z] 19:52:51 INFO - encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - session=self)
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - if response.status != 200:
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - err = error.from_response(response)
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - if isinstance(err, error.InvalidSessionIdException):
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - # The driver could have already been deleted the session.
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - self.session_id = None
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - > raise err
[task 2019-06-17T19:52:51.806Z] 19:52:51 INFO - E NoSuchAlertException: no such alert (404):
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E Remote-end stacktrace:
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E WebDriverError@chrome://marionette/content/error.js:179:5
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E NoSuchAlertError@chrome://marionette/content/error.js:378:5
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E GeckoDriver.prototype._checkIfAlertIsPresent@chrome://marionette/content/driver.js:3262:11
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E GeckoDriver.prototype.getTextFromDialog@chrome://marionette/content/driver.js:3212:8
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E despatch@chrome://marionette/content/server.js:289:40
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E execute@chrome://marionette/content/server.js:262:16
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E onPacket/<@chrome://marionette/content/server.js:235:20
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E onPacket@chrome://marionette/content/server.js:236:9
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO - E _onJSONObjectReady/<@chrome://marionette/content/transport.js:492:20
[task 2019-06-17T19:52:51.807Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO - body = None
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO - err = <NoSuchAlertException http_status=404>
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO - method = 'GET'
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO - response = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO - self = <Session 5e3647fc-dc31-438e-94ce-746d46b0cf24>
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO - url = 'session/5e3647fc-dc31-438e-94ce-746d46b0cf24/alert/text'
[task 2019-06-17T19:52:51.808Z] 19:52:51 INFO -
[task 2019-06-17T19:52:51.809Z] 19:52:51 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:472: NoSuchAlertException
[task 2019-06-17T19:52:51.809Z] 19:52:51 INFO - .
[task 2019-06-17T19:52:51.809Z] 19:52:51 INFO - TEST-OK | /webdriver/tests/execute_script/execute.py | took 2281ms
[task 2019-06-17T19:52:51.837Z] 19:52:51 INFO - Closing logging queue
[task 2019-06-17T19:52:51.838Z] 19:52:51 INFO - queue closed
[task 2019-06-17T19:52:51.838Z] 19:52:51 INFO - Starting runner
[task 2019-06-17T19:52:51.862Z] 19:52:51 INFO - PID 6265 | 1560801171852 webdriver::httpapi DEBUG Creating routes
[task 2019-06-17T19:52:51.863Z] 19:52:51 INFO - PID 6265 | 1560801171859 geckodriver DEBUG Listening on 127.0.0.1:4446
[task 2019-06-17T19:52:52.354Z] 19:52:52 INFO - WebDriver HTTP server listening at http://127.0.0.1:4446/

Looks like this was caused by Bug 1487358 landing here: https://hg.mozilla.org/integration/autoland/rev/64f906609a52251f39b6c6d0202f7ad47fe5a37e
Henrik, could you please take a look over this? It has 19 failures so far on linux64 debug and asan.

Flags: needinfo?(hskupin)
Regressed by: 1487358

We will partly backout bug 1487358 to fix this issue.

Flags: needinfo?(hskupin)
Status: NEW → RESOLVED
Closed: 5 months ago
Resolution: --- → FIXED
Assignee: nobody → hskupin
Target Milestone: --- → mozilla69
You need to log in before you can comment on or make changes to this bug.