Closed Bug 1629147 Opened 5 years ago Closed 4 years ago

Intermittent Wd test_abort_by_user_prompt<random> | NoSuchAlertException: no such alert (404):

Categories

(Remote Protocol :: Marionette, defect, P5)

Version 3
defect

Tracking

(firefox76 unaffected, firefox77 wontfix, firefox78 fixed)

RESOLVED FIXED
mozilla78
Tracking Status
firefox76 --- unaffected
firefox77 --- wontfix
firefox78 --- fixed

People

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

References

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell unknown])

Filed by: ncsoregi [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=297171376&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KVtLZE-iRoCMyedEDITJQQ/runs/0/artifacts/public/logs/live_backing.log


[task 2020-04-10T18:37:49.186Z] 18:37:49 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_override_listeners
[task 2020-04-10T18:37:49.186Z] 18:37:49 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[alert]
[task 2020-04-10T18:37:49.186Z] 18:37:49 INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[confirm] - NoSuchAlertException: no such alert (404):
[task 2020-04-10T18:37:49.186Z] 18:37:49 INFO - session = <Session f3274fab-b3a1-284c-9c00-461789fb1e2e>
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - dialog_type = 'confirm'
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO -
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - @pytest.mark.parametrize("dialog_type", ["alert", "confirm", "prompt"])
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - def test_abort_by_user_prompt(session, dialog_type):
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - response = execute_script(
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - session, "window.{}('Hello'); return 1;".format(dialog_type))
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - assert_success(response, None)
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO -
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - > session.alert.accept()
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO -
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - dialog_type = 'confirm'
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - response = <Responsetatus=200 body={"value": null}>
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - session = <Session f3274fab-b3a1-284c-9c00-461789fb1e2e>
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO -
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - tests/web-platform/tests/webdriver/tests/execute_script/execute.py:56:
[task 2020-04-10T18:37:49.187Z] 18:37:49 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _

Caused by:

JavaScript error: resource://gre/modules/Prompter.jsm, line 642: NS_ERROR_NOT_AVAILABLE: prompt aborted by user

Summary: Intermittent /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[confirm] - NoSuchAlertException: no such alert (404): → Intermittent /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt<random> - NoSuchAlertException: no such alert (404):
Summary: Intermittent /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt<random> - NoSuchAlertException: no such alert (404): → Intermittent Wd | test_abort_by_user_prompt<random> - NoSuchAlertException: no such alert (404):
Summary: Intermittent Wd | test_abort_by_user_prompt<random> - NoSuchAlertException: no such alert (404): → Intermittent Wd test_abort_by_user_prompt<random> | NoSuchAlertException: no such alert (404):

There are 37 total failures in the last 7 days with a spike starting on the 24th, on

  • macosx1014-64 debug
  • windows10-64-ccov opt
  • linux1804-64 debug

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=299669793&repo=mozilla-central&lineNumber=13296

[task 2020-04-27T22:15:52.730Z] 22:15:52 INFO - TEST-START | /webdriver/tests/execute_script/execute.py
[task 2020-04-27T22:15:52.774Z] 22:15:52 INFO - STDOUT: ============================= test session starts ==============================
[task 2020-04-27T22:15:52.781Z] 22:15:52 INFO - STDOUT: platform darwin -- Python 2.7.16, pytest-unknown, py-1.5.2, pluggy-0.5.3.dev -- /Users/cltbld/tasks/task_1588025450/build/venv/bin/python
[task 2020-04-27T22:15:52.781Z] 22:15:52 INFO - STDOUT: rootdir: /Users/cltbld/tasks/task_1588025450/build, inifile:
[task 2020-04-27T22:15:52.781Z] 22:15:52 INFO - STDOUT: collecting ...
[task 2020-04-27T22:15:52.793Z] 22:15:52 INFO - STDOUT: collected 10 items
[task 2020-04-27T22:15:52.794Z] 22:15:52 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/execute_script/execute.py::test_null_parameter_value
[task 2020-04-27T22:15:52.806Z] 22:15:52 INFO - STDOUT: PASSED
[task 2020-04-27T22:15:52.906Z] 22:15:52 INFO - PID 1637 | 1588025752792 webdriver::server DEBUG -> POST /session/aa68d529-5142-5541-862a-2efa04f0402a/window/rect {"width": 800, "height": 600}
[task 2020-04-27T22:15:52.906Z] 22:15:52 INFO - PID 1637 | 1588025752793 Marionette DEBUG 0 -> [0,262,"WebDriver:SetWindowRect",{"height":600,"width":800}]
[task 2020-04-27T22:15:52.907Z] 22:15:52 INFO - PID 1637 | 1588025752795 Marionette DEBUG 0 <- [1,262,null,{"x":100,"y":100,"width":800,"height":600}]
[task 2020-04-27T22:15:52.907Z] 22:15:52 INFO - PID 1637 | 1588025752795 webdriver::server DEBUG <- 200 OK {"value":{"x":100,"y":100,"width":800,"height":600}}
[task 2020-04-27T22:15:52.907Z] 22:15:52 INFO - PID 1637 | 1588025752797 webdriver::server DEBUG -> POST /session/aa68d529-5142-5541-862a-2efa04f0402a/window/rect {"y": 100, "x": 100}
[task 2020-04-27T22:15:52.908Z] 22:15:52 INFO - PID 1637 | 1588025752798 Marionette DEBUG 0 -> [0,263,"WebDriver:SetWindowRect",{"x":100,"y":100}]
[task 2020-04-27T22:15:52.908Z] 22:15:52 INFO - PID 1637 | 1588025752799 Marionette DEBUG 0 <- [1,263,null,{"x":100,"y":100,"width":800,"height":600}]
[task 2020-04-27T22:15:52.908Z] 22:15:52 INFO - PID 1637 | 1588025752800 webdriver::server DEBUG <- 200 OK {"value":{"x":100,"y":100,"width":800,"height":600}}
[task 2020-04-27T22:15:52.909Z] 22:15:52 INFO - PID 1637 | 1588025752802 webdriver::server DEBUG -> POST /session/aa68d529-5142-5541-862a-2efa04f0402a/execute/sync
[task 2020-04-27T22:15:52.909Z] 22:15:52 INFO - PID 1637 | 1588025752802 webdriver::server DEBUG <- 400 Bad Request {"value":{"error":"invalid argument","message":"Failed to decode request as JSON: ","stacktrace":"Syntax error at :1:0"}}

[task 2020-04-27T22:15:55.598Z] 22:15:55 INFO - STDOUT: _______________________ test_abort_by_user_prompt[alert] _______________________
[task 2020-04-27T22:15:55.606Z] 22:15:55 INFO - STDOUT: session = <Session aa68d529-5142-5541-862a-2efa04f0402a>, dialog_type = 'alert'
[task 2020-04-27T22:15:55.606Z] 22:15:55 INFO - STDOUT: @pytest.mark.parametrize("dialog_type", ["alert", "confirm", "prompt"])
[task 2020-04-27T22:15:55.607Z] 22:15:55 INFO - STDOUT: def test_abort_by_user_prompt(session, dialog_type):
[task 2020-04-27T22:15:55.607Z] 22:15:55 INFO - STDOUT: response = execute_script(
[task 2020-04-27T22:15:55.607Z] 22:15:55 INFO - STDOUT: session, "window.{}('Hello'); return 1;".format(dialog_type))
[task 2020-04-27T22:15:55.608Z] 22:15:55 INFO - STDOUT: assert_success(response, None)
[task 2020-04-27T22:15:55.608Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.609Z] 22:15:55 INFO - STDOUT: > session.alert.accept()
[task 2020-04-27T22:15:55.609Z] 22:15:55 INFO - STDOUT: dialog_type = 'alert'
[task 2020-04-27T22:15:55.609Z] 22:15:55 INFO - STDOUT: response = <Responsetatus=200 body={"value": null}>
[task 2020-04-27T22:15:55.610Z] 22:15:55 INFO - STDOUT: session = <Session aa68d529-5142-5541-862a-2efa04f0402a>
[task 2020-04-27T22:15:55.610Z] 22:15:55 INFO - STDOUT: tests/web-platform/tests/webdriver/tests/execute_script/execute.py
[task 2020-04-27T22:15:55.610Z] 22:15:55 INFO - STDOUT: :56:
[task 2020-04-27T22:15:55.610Z] 22:15:55 INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2020-04-27T22:15:55.611Z] 22:15:55 INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/client.py
[task 2020-04-27T22:15:55.611Z] 22:15:55 INFO - STDOUT: :19: in inner
[task 2020-04-27T22:15:55.611Z] 22:15:55 INFO - STDOUT: return func(self, *args, **kwargs)
[task 2020-04-27T22:15:55.611Z] 22:15:55 INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/client.py
[task 2020-04-27T22:15:55.611Z] 22:15:55 INFO - STDOUT: :356: in accept
[task 2020-04-27T22:15:55.612Z] 22:15:55 INFO - STDOUT: self.session.send_session_command("POST", "alert/accept")
[task 2020-04-27T22:15:55.612Z] 22:15:55 INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/client.py
[task 2020-04-27T22:15:55.612Z] 22:15:55 INFO - STDOUT: :513: in send_session_command
[task 2020-04-27T22:15:55.612Z] 22:15:55 INFO - STDOUT: return self.send_command(method, url, body, timeout)
[task 2020-04-27T22:15:55.613Z] 22:15:55 INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2020-04-27T22:15:55.619Z] 22:15:55 INFO - STDOUT: self = <Session aa68d529-5142-5541-862a-2efa04f0402a>, method = 'POST'
[task 2020-04-27T22:15:55.619Z] 22:15:55 INFO - STDOUT: url = 'session/aa68d529-5142-5541-862a-2efa04f0402a/alert/accept', body = None
[task 2020-04-27T22:15:55.619Z] 22:15:55 INFO - STDOUT: timeout = None
[task 2020-04-27T22:15:55.619Z] 22:15:55 INFO - STDOUT: def send_command(self, method, url, body=None, timeout=None):
[task 2020-04-27T22:15:55.620Z] 22:15:55 INFO - STDOUT: """
[task 2020-04-27T22:15:55.620Z] 22:15:55 INFO - STDOUT: Send a command to the remote end and validate its success.
[task 2020-04-27T22:15:55.620Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.620Z] 22:15:55 INFO - STDOUT: :param method: HTTP method to use in request.
[task 2020-04-27T22:15:55.620Z] 22:15:55 INFO - STDOUT: :param uri: "Command part" of the HTTP request URL,
[task 2020-04-27T22:15:55.621Z] 22:15:55 INFO - STDOUT: e.g. window/rect.
[task 2020-04-27T22:15:55.621Z] 22:15:55 INFO - STDOUT: :param body: Optional body of the HTTP request.
[task 2020-04-27T22:15:55.621Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.621Z] 22:15:55 INFO - STDOUT: :return: None if the HTTP response body was empty, otherwise
[task 2020-04-27T22:15:55.621Z] 22:15:55 INFO - STDOUT: the value field returned after parsing the response
[task 2020-04-27T22:15:55.622Z] 22:15:55 INFO - STDOUT: body as JSON.
[task 2020-04-27T22:15:55.622Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.622Z] 22:15:55 INFO - STDOUT: :raises error.WebDriverException: If the remote end returns
[task 2020-04-27T22:15:55.622Z] 22:15:55 INFO - STDOUT: an error.
[task 2020-04-27T22:15:55.623Z] 22:15:55 INFO - STDOUT: :raises ValueError: If the response body does not contain a
[task 2020-04-27T22:15:55.623Z] 22:15:55 INFO - STDOUT: value key.
[task 2020-04-27T22:15:55.623Z] 22:15:55 INFO - STDOUT: """
[task 2020-04-27T22:15:55.623Z] 22:15:55 INFO - STDOUT: response = self.transport.send(
[task 2020-04-27T22:15:55.623Z] 22:15:55 INFO - STDOUT: method, url, body,
[task 2020-04-27T22:15:55.624Z] 22:15:55 INFO - STDOUT: encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2020-04-27T22:15:55.624Z] 22:15:55 INFO - STDOUT: session=self, timeout=timeout)
[task 2020-04-27T22:15:55.624Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.624Z] 22:15:55 INFO - STDOUT: if response.status != 200:
[task 2020-04-27T22:15:55.624Z] 22:15:55 INFO - STDOUT: err = error.from_response(response)
[task 2020-04-27T22:15:55.625Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.627Z] 22:15:55 INFO - STDOUT: if isinstance(err, error.InvalidSessionIdException):
[task 2020-04-27T22:15:55.627Z] 22:15:55 INFO - STDOUT: # The driver could have already been deleted the session.
[task 2020-04-27T22:15:55.627Z] 22:15:55 INFO - STDOUT: self.session_id = None
[task 2020-04-27T22:15:55.627Z] 22:15:55 INFO - STDOUT:
[task 2020-04-27T22:15:55.627Z] 22:15:55 INFO - STDOUT: > raise err
[task 2020-04-27T22:15:55.628Z] 22:15:55 INFO - STDOUT: E NoSuchAlertException: no such alert (404):
[task 2020-04-27T22:15:55.628Z] 22:15:55 INFO - STDOUT: E
[task 2020-04-27T22:15:55.628Z] 22:15:55 INFO - STDOUT: E Remote-end stacktrace:
[task 2020-04-27T22:15:55.628Z] 22:15:55 INFO - STDOUT: E
[task 2020-04-27T22:15:55.638Z] 22:15:55 INFO - STDOUT: E WebDriverError@chrome://marionette/content/error.js:175:5
[task 2020-04-27T22:15:55.638Z] 22:15:55 INFO - STDOUT: E NoSuchAlertError@chrome://marionette/content/error.js:376:5
[task 2020-04-27T22:15:55.638Z] 22:15:55 INFO - STDOUT: E GeckoDriver.prototype._checkIfAlertIsPresent@chrome://marionette/content/driver.js:3388:11
[task 2020-04-27T22:15:55.638Z] 22:15:55 INFO - STDOUT: E GeckoDriver.prototype.acceptDialog@chrome://marionette/content/driver.js:3318:8
[task 2020-04-27T22:15:55.638Z] 22:15:55 INFO - STDOUT: E despatch@chrome://marionette/content/server.js:305:40
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: E execute@chrome://marionette/content/server.js:275:16
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: E onPacket/<@chrome://marionette/content/server.js:248:20
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: E onPacket@chrome://marionette/content/server.js:249:9
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: E _onJSONObjectReady/<@chrome://marionette/content/transport.js:501:20
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: body = None
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: err = <NoSuchAlertException http_status=404>
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: method = 'POST'
[task 2020-04-27T22:15:55.639Z] 22:15:55 INFO - STDOUT: response = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: self = <Session aa68d529-5142-5541-862a-2efa04f0402a>
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: timeout = None
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: url = 'session/aa68d529-5142-5541-862a-2efa04f0402a/alert/accept'
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/client.py
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: :477: NoSuchAlertException
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: =============================== warnings summary ===============================
[task 2020-04-27T22:15:55.640Z] 22:15:55 INFO - STDOUT: <undetermined location>
[task 2020-04-27T22:15:55.641Z] 22:15:55 INFO - STDOUT: Module already imported so cannot be rewritten: mozlog
[task 2020-04-27T22:15:55.641Z] 22:15:55 INFO - STDOUT: Module already imported so cannot be rewritten: tests.support.fixtures
[task 2020-04-27T22:15:55.641Z] 22:15:55 INFO - STDOUT: -- Docs: http://doc.pytest.org/en/latest/warnings.html
[task 2020-04-27T22:15:55.641Z] 22:15:55 INFO - STDOUT: ================ 1 failed, 9 passed, 2 warnings in 2.85 seconds ================
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_null_parameter_value
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_no_browsing_context
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_ending_comment
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - TEST-PASS | /webdriver/tests/execute_script/execute.py | test_override_listeners
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/execute_script/execute.py | test_abort_by_user_prompt[alert] - NoSuchAlertException: no such alert (404):
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - session = <Session aa68d529-5142-5541-862a-2efa04f0402a>, dialog_type = 'alert'
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - @pytest.mark.parametrize("dialog_type", ["alert", "confirm", "prompt"])
[task 2020-04-27T22:15:55.734Z] 22:15:55 INFO - def test_abort_by_user_prompt(session, dialog_type):
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO - response = execute_script(
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO - session, "window.{}('Hello'); return 1;".format(dialog_type))
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO - assert_success(response, None)
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO - > session.alert.accept()
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.735Z] 22:15:55 INFO - dialog_type = 'alert'
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - response = <Responsetatus=200 body={"value": null}>
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - session = <Session aa68d529-5142-5541-862a-2efa04f0402a>
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - tests/web-platform/tests/webdriver/tests/execute_script/execute.py:56:
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:19: in inner
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - return func(self, *args, **kwargs)
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:356: in accept
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - self.session.send_session_command("POST", "alert/accept")
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:513: in send_session_command
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - return self.send_command(method, url, body, timeout)
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - self = <Session aa68d529-5142-5541-862a-2efa04f0402a>, method = 'POST'
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - url = 'session/aa68d529-5142-5541-862a-2efa04f0402a/alert/accept', body = None
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - timeout = None
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - def send_command(self, method, url, body=None, timeout=None):
[task 2020-04-27T22:15:55.736Z] 22:15:55 INFO - """
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - Send a command to the remote end and validate its success.
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - :param method: HTTP method to use in request.
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - :param uri: "Command part" of the HTTP request URL,
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - e.g. window/rect.
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - :param body: Optional body of the HTTP request.
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - :return: None if the HTTP response body was empty, otherwise
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - the value field returned after parsing the response
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - body as JSON.
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - :raises error.WebDriverException: If the remote end returns
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - an error.
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - :raises ValueError: If the response body does not contain a
[task 2020-04-27T22:15:55.737Z] 22:15:55 INFO - value key.
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - """
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - response = self.transport.send(
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - method, url, body,
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - encoder=protocol.Encoder, decoder=protocol.Decoder,
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - session=self, timeout=timeout)
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - if response.status != 200:
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - err = error.from_response(response)
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - if isinstance(err, error.InvalidSessionIdException):
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - # The driver could have already been deleted the session.
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - self.session_id = None
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - > raise err
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - E NoSuchAlertException: no such alert (404):
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - E
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - E Remote-end stacktrace:
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - E
[task 2020-04-27T22:15:55.738Z] 22:15:55 INFO - E WebDriverError@chrome://marionette/content/error.js:175:5
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E NoSuchAlertError@chrome://marionette/content/error.js:376:5
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E GeckoDriver.prototype._checkIfAlertIsPresent@chrome://marionette/content/driver.js:3388:11
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E GeckoDriver.prototype.acceptDialog@chrome://marionette/content/driver.js:3318:8
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E despatch@chrome://marionette/content/server.js:305:40
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E execute@chrome://marionette/content/server.js:275:16
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E onPacket/<@chrome://marionette/content/server.js:248:20
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E onPacket@chrome://marionette/content/server.js:249:9
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - E _onJSONObjectReady/<@chrome://marionette/content/transport.js:501:20
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - body = None
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - err = <NoSuchAlertException http_status=404>
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - method = 'POST'
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - response = <Response status=404 error=<NoSuchAlertException http_status=404>>
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - self = <Session aa68d529-5142-5541-862a-2efa04f0402a>
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - timeout = None
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO - url = 'session/aa68d529-5142-5541-862a-2efa04f0402a/alert/accept'
[task 2020-04-27T22:15:55.739Z] 22:15:55 INFO -
[task 2020-04-27T22:15:55.740Z] 22:15:55 INFO - tests/web-platform/tests/tools/webdriver/webdriver/client.py:477: NoSuchAlertException
[task 2020-04-27T22:15:55.740Z] 22:15:55 INFO - ..
[task 2020-04-27T22:15:55.740Z] 22:15:55 INFO - TEST-OK | /webdriver/tests/execute_script/execute.py | took 2983ms

Henrik can you assign someone to take a look?

Flags: needinfo?(hskupin)
Whiteboard: [stockwell needswork:owner]

Andreea, this is all blocked by bug 1631362 (as it can be seen on the dependency list). Note that there are also several other Marionette and Webdriver tests that are failing due to that regression. Not sure if that is something we should consider to backout.

Flags: needinfo?(hskupin) → needinfo?(apavel)

I would opt for a backout given the number of regressions and the failure rate in this bug.
Aryx, do you agree?

Flags: needinfo?(apavel) → needinfo?(aryx.bugmail)

Can we please move that discussion to bug 1631362? Paul also added a comment late yesterday I haven't had a change to look at.

Will follow progress there.

Flags: needinfo?(aryx.bugmail)

No more failures since the patch on bug 1631362 got landed.

Assignee: nobody → pbz
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla78

(In reply to Andreea Pavel [:apavel] from comment #16)

Still occurs on beta: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=303422710&repo=mozilla-beta&lineNumber=19510

Yes, because the patch on bug 1631362 hasn't been uplifted to beta and also won't be. It means we have to live with those failures for the remaining beta releases and the final release of Firefox 77. Also see the firefox77 flag set to wontfix.

Flags: needinfo?(hskupin)
See Also: → 1657095

Whimboo, should we reopen this bug?
There have been recent appearances similar to the general failure summary presented here.
Examples:
https://treeherder.mozilla.org/logviewer?job_id=321746009&repo=autoland&lineNumber=82189
https://treeherder.mozilla.org/logviewer?job_id=321749138&repo=autoland&lineNumber=82419

Flags: needinfo?(hskupin)
See Also: → 1677347

(In reply to Alexandru Michis [:malexandru] from comment #21)

Whimboo, should we reopen this bug?
There have been recent appearances similar to the general failure summary presented here.
Examples:
https://treeherder.mozilla.org/logviewer?job_id=321746009&repo=autoland&lineNumber=82189
https://treeherder.mozilla.org/logviewer?job_id=321749138&repo=autoland&lineNumber=82419

No, this has been fixed a long time ago and as such shouldn't be reopened. Instead use a new bug please.

Flags: needinfo?(hskupin)
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.