Closed Bug 1727523 Opened 4 years ago Closed 4 years ago

Intermittent [tier 2] /webdriver/tests/minimize_window/user_prompts.py | test_dismiss[capabilities0-confirm-False] - AssertionError: unknown error (500): Failed to decode response from marionette

Tracking

(Not tracked)

Status:

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: assertion, intermittent-failure)

Treeherder Bug Filer

Reporter

Description

•

4 years ago

treeherder

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

[task 2021-08-25T11:02:23.239Z] 11:02:23     INFO - TEST-START | /webdriver/tests/delete_cookie/user_prompts.py
[task 2021-08-25T11:02:23.240Z] 11:02:23     INFO - PID 2516 | [Child 3116, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-25T11:02:23.241Z] 11:02:23     INFO - PID 2516 | [Child 3116, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-25T11:02:23.242Z] 11:02:23     INFO - PID 2516 | [Child 3116, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-08-25T11:02:23.306Z] 11:02:23     INFO - PID 2516 | DEBUG: Adding blocker ContentParent: id=181ab7c4000 for phase xpcom-will-shutdown
[task 2021-08-25T11:02:23.307Z] 11:02:23     INFO - PID 2516 | DEBUG: Adding blocker ContentParent: id=181ab7c4000 for phase profile-before-change
[task 2021-08-25T11:02:23.320Z] 11:02:23     INFO - PID 2516 | DEBUG: Adding blocker ContentParent: id=181ab7c7000 for phase xpcom-will-shutdown
[task 2021-08-25T11:02:23.322Z] 11:02:23     INFO - STDOUT: ============================= test session starts =============================
[task 2021-08-25T11:02:23.323Z] 11:02:23     INFO - STDOUT: platform win32 -- Python 3.9.5, pytest-6.1.1, py-1.5.2, pluggy-unknown -- Z:\task_162988783314579\build\venv\Scripts\python.exe
[task 2021-08-25T11:02:23.324Z] 11:02:23     INFO - PID 2516 | DEBUG: Adding blocker ContentParent: id=181ab7c7000 for phase profile-before-change
[task 2021-08-25T11:02:23.326Z] 11:02:23     INFO - STDOUT: rootdir: Z:\task_162988783314579\build
[task 2021-08-25T11:02:23.326Z] 11:02:23     INFO - STDOUT: plugins: asyncio-0.14.0
<...>
[task 2021-08-25T11:14:27.988Z] 11:14:27     INFO - PID 3536 | 1629890067971	webdriver::server	DEBUG	-> POST /session/44cdbf19-0e4a-4c5e-b3ad-7c1595c53210/frame {"id": null}
[task 2021-08-25T11:14:27.989Z] 11:14:27     INFO - PID 3536 | 1629890067972	Marionette	DEBUG	0 -> [0,228,"WebDriver:SwitchToFrame",{"id":null}]
[task 2021-08-25T11:14:27.990Z] 11:14:27     INFO - PID 3536 | 1629890067974	Marionette	DEBUG	0 <- [1,228,null,{"value":null}]
[task 2021-08-25T11:14:27.990Z] 11:14:27     INFO - PID 3536 | 1629890067974	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2021-08-25T11:14:27.991Z] 11:14:27     INFO - STDOUT: ================================== FAILURES ===================================
[task 2021-08-25T11:14:27.992Z] 11:14:27     INFO - STDOUT: __________________ test_dismiss[capabilities0-confirm-False] __________________
[task 2021-08-25T11:14:27.993Z] 11:14:27     INFO - STDOUT: check_user_prompt_closed_without_exception = <function check_user_prompt_closed_without_exception.<locals>.check_user_prompt_closed_without_exception at 0x0000029671C678B0>
[task 2021-08-25T11:14:27.993Z] 11:14:27     INFO - STDOUT: dialog_type = 'confirm', retval = False
[task 2021-08-25T11:14:27.994Z] 11:14:27     INFO - STDOUT:     @pytest.mark.capabilities({"unhandledPromptBehavior": "dismiss"})
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_accept[capabilities0-alert-None] 
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_accept[capabilities0-confirm-True] 
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_accept[capabilities0-prompt-] 
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_accept_and_notify[capabilities0-alert-None] 
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_accept_and_notify[capabilities0-confirm-True] 
[task 2021-08-25T11:14:28.000Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_accept_and_notify[capabilities0-prompt-] 
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO - TEST-PASS | /webdriver/tests/minimize_window/user_prompts.py | test_dismiss[capabilities0-alert-None] 
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/minimize_window/user_prompts.py | test_dismiss[capabilities0-confirm-False] - AssertionError: unknown error (500): Failed to decode response from marionette
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO - check_user_prompt_closed_without_exception = <function check_user_prompt_closed_without_exception.<locals>.check_user_prompt_closed_without_exception at 0x0000029671C678B0>
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO - dialog_type = 'confirm', retval = False
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO -     @pytest.mark.capabilities({"unhandledPromptBehavior": "dismiss"})
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO -     @pytest.mark.parametrize("dialog_type, retval", [
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO -         ("alert", None),
[task 2021-08-25T11:14:28.001Z] 11:14:28     INFO -         ("confirm", False),
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -         ("prompt", None),
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -     ])
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -     def test_dismiss(check_user_prompt_closed_without_exception, dialog_type, retval):
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - >       check_user_prompt_closed_without_exception(dialog_type, retval)
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - check_user_prompt_closed_without_exception = <function check_user_prompt_closed_without_exception.<locals>.check_user_prompt_closed_without_exception at 0x0000029671C678B0>
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - dialog_type = 'confirm'
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - retval     = False
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - tests\web-platform\tests\webdriver\tests\minimize_window\user_prompts.py:88: 
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - tests\web-platform\tests\webdriver\tests\minimize_window\user_prompts.py:21: in check_user_prompt_closed_without_exception
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -     assert_success(response)
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -         create_dialog = <function create_dialog.<locals>.create_dialog at 0x0000029671BB5F70>
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -         dialog_type = 'confirm'
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -         response   = <Response status=500 error=<UnknownErrorException http_status=500>>
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -         retval     = False
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO -         session    = <Session b1901edf-ab29-4ce5-8e2e-186651b1f61a>
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2021-08-25T11:14:28.002Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - response = <Response status=500 error=<UnknownErrorException http_status=500>>
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - value = None
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -     def assert_success(response, value=None):
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         """
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         Verify that the provided webdriver.Response instance described
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         a valid success response as defined by `dfn-send-a-response` and
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         the provided response value.
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -     
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         :param response: ``webdriver.Response`` instance.
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         :param value: Expected value of the response body, if any.
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO -         """
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - >       assert response.status == 200, str(response.error)
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - E       AssertionError: unknown error (500): Failed to decode response from marionette
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - E         
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - E       assert 500 == 200
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - E         +500
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - E         -200
[task 2021-08-25T11:14:28.003Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.004Z] 11:14:28     INFO - response   = <Response status=500 error=<UnknownErrorException http_status=500>>
[task 2021-08-25T11:14:28.004Z] 11:14:28     INFO - value      = None
[task 2021-08-25T11:14:28.004Z] 11:14:28     INFO - 
[task 2021-08-25T11:14:28.004Z] 11:14:28     INFO - tests\web-platform\tests\webdriver\tests\support\asserts.py:69: AssertionError
[task 2021-08-25T11:14:28.011Z] 11:14:28     INFO - ..........
[task 2021-08-25T11:14:28.011Z] 11:14:28     INFO - TEST-OK | /webdriver/tests/minimize_window/user_prompts.py | took 152158ms
[task 2021-08-25T11:14:28.011Z] 11:14:28     INFO - Restarting browser for new test group
[task 2021-08-25T11:14:38.011Z] 11:14:38  WARNING - Forcibly terminating runner process
[task 2021-08-25T11:14:38.016Z] 11:14:38     INFO - Starting runner
[task 2021-08-25T11:14:39.263Z] 11:14:39     INFO - PID 7484 | 1629890078765	geckodriver	INFO	Listening on 127.0.0.1:60289
[task 2021-08-25T11:14:39.266Z] 11:14:39     INFO - WebDriver HTTP server listening at http://127.0.0.1:60289/
[task 2021-08-25T11:14:39.268Z] 11:14:39     INFO - TEST-START | /webdriver/tests/new_window/new.py

Comment hidden (Intermittent Failures Robot)

BugBot [:suhaib / :marco/ :calixte]

Comment 2

•

4 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED

Closed: 4 years ago

Resolution: --- → INCOMPLETE

BMO Automation

Comment 3

•

3 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.

Bugzilla

Intermittent [tier 2] /webdriver/tests/minimize_window/user_prompts.py | test_dismiss[capabilities0-confirm-False] - AssertionError: unknown error (500): Failed to decode response from marionette

Categories

(Remote Protocol :: Marionette, defect, P5)

Tracking

(Not tracked)

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: assertion, intermittent-failure)

Crash Data

Security

(public)

User Story

Description

Comment 1

Comment 2

Comment 3