Open Bug 1918610 Opened 2 months ago Updated 5 days ago

Intermittent [tier 2] /webdriver/tests/bidi/input/perform_actions/pointer_mouse_drag.py | test_drag_and_drop[20-0-0] - assert (55 + 20) == 55

Categories

(Remote Protocol :: WebDriver BiDi, defect, P5)

defect

Tracking

(firefox-esr115 unaffected, firefox-esr128 unaffected, firefox130 unaffected, firefox131 unaffected, firefox132 affected, firefox133 affected)

REOPENED
Tracking Status
firefox-esr115 --- unaffected
firefox-esr128 --- unaffected
firefox130 --- unaffected
firefox131 --- unaffected
firefox132 --- affected
firefox133 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug, Regression)

Details

(Keywords: intermittent-failure, regression)

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


[task 2024-09-13T08:48:15.583Z] 08:48:15     INFO - PID 2171 | 1726217295575	RemoteAgent	DEBUG	Resetting recommended pref widget.windows.window_occlusion_tracking.enabled
[task 2024-09-13T08:48:15.584Z] 08:48:15     INFO - PID 2171 | 1726217295575	RemoteAgent	DEBUG	Resetting recommended pref permissions.isolateBy.userContext
[task 2024-09-13T08:48:15.584Z] 08:48:15     INFO - PID 2171 | 1726217295575	RemoteAgent	TRACE	Received observer notification quit-application
[task 2024-09-13T08:48:15.585Z] 08:48:15     INFO - PID 2171 | 1726217295575	Marionette	DEBUG	Marionette stopped listening
[task 2024-09-13T08:48:15.586Z] 08:48:15     INFO - PID 2171 | 1726217295575	Marionette	DEBUG	0 <- [1,338,null,{"cause":"shutdown","forced":false,"in_app":true}]
[task 2024-09-13T08:48:15.594Z] 08:48:15     INFO - PID 2171 | 1726217295592	RemoteAgent	TRACE	MessageHandler WINDOW_GLOBAL for session 563f4d51-a7f1-4494-a6f8-51cf8cbddfc5 is being destroyed
[task 2024-09-13T08:48:15.594Z] 08:48:15     INFO - PID 2171 | 1726217295592	RemoteAgent	TRACE	Unregistered MessageHandler WINDOW_GLOBAL for session 563f4d51-a7f1-4494-a6f8-51cf8cbddfc5
[task 2024-09-13T08:48:15.595Z] 08:48:15     INFO - PID 2171 | 1726217295593	webdriver::server	DEBUG	Teardown session
[task 2024-09-13T08:48:15.601Z] 08:48:15     INFO - PID 2171 | 1726217295600	Marionette	DEBUG	Closed connection 0
[task 2024-09-13T08:48:15.829Z] 08:48:15     INFO - PID 2171 | 1726217295827	geckodriver::browser	DEBUG	Browser process stopped: exit status: 0
[task 2024-09-13T08:48:15.829Z] 08:48:15     INFO - PID 2171 | 1726217295828	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2024-09-13T08:48:15.833Z] 08:48:15     INFO - STDOUT: =================================== FAILURES ===================================
[task 2024-09-13T08:48:15.834Z] 08:48:15     INFO - STDOUT: __________________________ test_drag_and_drop[20-0-0] __________________________
[task 2024-09-13T08:48:15.835Z] 08:48:15     INFO - STDOUT: bidi_session = <webdriver.bidi.client.BidiSession object at 0x10a638550>
[task 2024-09-13T08:48:15.836Z] 08:48:15     INFO - STDOUT: top_context = {'children': [], 'context': '32903261-106d-4caa-8cfb-433bb22aef57', 'originalOpener': None, 'parent': None, ...}
[task 2024-09-13T08:48:15.837Z] 08:48:15     INFO - STDOUT: get_element = <function get_element.<locals>.get_element at 0x10a395580>
[task 2024-09-13T08:48:15.838Z] 08:48:15     INFO - STDOUT: load_static_test_page = <function load_static_test_page.<locals>.load_static_test_page at 0x10a394d60>
[task 2024-09-13T08:48:15.838Z] 08:48:15     INFO - STDOUT: dx = 20, dy = 0, drag_duration = 0
[task 2024-09-13T08:48:15.839Z] 08:48:15     INFO - STDOUT:     @pytest.mark.parametrize("drag_duration", [0, 300, 800])
[task 2024-09-13T08:48:15.840Z] 08:48:15     INFO - STDOUT:     @pytest.mark.parametrize(
[task 2024-09-13T08:48:15.841Z] 08:48:15     INFO - STDOUT:         "dx, dy", [(20, 0), (0, 15), (10, 15), (-20, 0), (10, -15), (-10, -15)]
[task 2024-09-13T08:48:15.841Z] 08:48:15     INFO - STDOUT:     )
[task 2024-09-13T08:48:15.842Z] 08:48:15     INFO - STDOUT:     async def test_drag_and_drop(
[task 2024-09-13T08:48:15.843Z] 08:48:15     INFO - STDOUT:         bidi_session,
[task 2024-09-13T08:48:15.844Z] 08:48:15     INFO - STDOUT:         top_context,
[task 2024-09-13T08:48:15.844Z] 08:48:15     INFO - STDOUT:         get_element,
[task 2024-09-13T08:48:15.845Z] 08:48:15     INFO - STDOUT:         load_static_test_page,
[task 2024-09-13T08:48:15.846Z] 08:48:15     INFO - STDOUT:         dx,
[task 2024-09-13T08:48:15.846Z] 08:48:15     INFO - STDOUT:         dy,
[task 2024-09-13T08:48:15.847Z] 08:48:15     INFO - STDOUT:         drag_duration,
[task 2024-09-13T08:48:15.848Z] 08:48:15     INFO - STDOUT:     ):
[task 2024-09-13T08:48:15.854Z] 08:48:15     INFO - 
[task 2024-09-13T08:48:15.854Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_middle_click 
[task 2024-09-13T08:48:15.854Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_click_element_center 
[task 2024-09-13T08:48:15.854Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_click_element_in_shadow_tree[outer-open] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_click_element_in_shadow_tree[outer-closed] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_click_element_in_shadow_tree[inner-open] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_click_element_in_shadow_tree[inner-closed] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_click_navigation 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_move_to_position_in_viewport[default value] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_move_to_position_in_viewport[x] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-PASS | /webdriver/tests/bidi/input/perform_actions/pointer_mouse.py | test_move_to_position_in_viewport[y] 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/input/perform_actions/pointer_mouse_drag.py | test_drag_and_drop[20-0-0] - assert (55 + 20) == 55
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x10a638550>
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - top_context = {'children': [], 'context': '32903261-106d-4caa-8cfb-433bb22aef57', 'originalOpener': None, 'parent': None, ...}
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - get_element = <function get_element.<locals>.get_element at 0x10a395580>
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - load_static_test_page = <function load_static_test_page.<locals>.load_static_test_page at 0x10a394d60>
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - dx = 20, dy = 0, drag_duration = 0
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO - 
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -     @pytest.mark.parametrize("drag_duration", [0, 300, 800])
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -     @pytest.mark.parametrize(
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -         "dx, dy", [(20, 0), (0, 15), (10, 15), (-20, 0), (10, -15), (-10, -15)]
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -     )
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -     async def test_drag_and_drop(
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -         bidi_session,
[task 2024-09-13T08:48:15.855Z] 08:48:15     INFO -         top_context,
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         get_element,
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         load_static_test_page,
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         dx,
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         dy,
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         drag_duration,
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -     ):
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         await load_static_test_page(page="test_actions.html")
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -     
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         drag_target = await get_element("#dragTarget")
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         initial_rect = await get_element_rect(
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -             bidi_session, context=top_context, element=drag_target
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         )
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         initial_center = await get_inview_center_bidi(
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -             bidi_session, context=top_context, element=drag_target
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -         )
[task 2024-09-13T08:48:15.856Z] 08:48:15     INFO -     
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         # Conclude chain with extra move to allow time for last queued
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         # coordinate-update of drag_target and to test that drag_target is "dropped".
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         actions = Actions()
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         (
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             actions.add_pointer()
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             .pointer_move(x=0, y=0, origin=get_element_origin(drag_target))
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             .pointer_down(button=0)
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             .pointer_move(dx, dy, duration=drag_duration, origin="pointer")
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             .pointer_up(button=0)
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             .pointer_move(80, 50, duration=100, origin="pointer")
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         )
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -     
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         await bidi_session.input.perform_actions(
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -             actions=actions, context=top_context["context"]
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         )
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -     
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         # mouseup that ends the drag is at the expected destination
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         events = await get_events(bidi_session, top_context["context"])
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         e = events[1]
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         assert e["type"] == "mouseup"
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         assert e["pageX"] == pytest.approx(initial_center["x"] + dx, abs=1.0)
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         assert e["pageY"] == pytest.approx(initial_center["y"] + dy, abs=1.0)
[task 2024-09-13T08:48:15.857Z] 08:48:15     INFO -         # check resulting location of the dragged element
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -         final_rect = await get_element_rect(
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -             bidi_session, context=top_context, element=drag_target
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -         )
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - >       assert initial_rect["x"] + dx == final_rect["x"]
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - E       assert (55 + 20) == 55
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - 
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - actions    = <webdriver.bidi.modules.input.Actions object at 0x10a429090>
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x10a638550>
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - drag_duration = 0
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - drag_target = {'sharedId': '1365f4c6-6a0e-4d4f-8e07-ac75e29d67e0',
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -  'type': 'node',
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -  'value': {'attributes': {'class': 'block', 'id': 'dragTarget'},
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -            'childNodeCount': 0,
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -            'localName': 'div',
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -            'namespaceURI': 'http://www.w3.org/1999/xhtml',
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -            'nodeType': 1,
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO -            'shadowRoot': None}}
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - dx         = 20
[task 2024-09-13T08:48:15.858Z] 08:48:15     INFO - dy         = 0
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO - e          = {'altKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'button': 0,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'buttons': 0,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'ctrlKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'metaKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'pageX': 78,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'pageY': 303,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'shiftKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'target': 'dragArea',
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  'type': 'mouseup'}
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO - events     = [{'altKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'button': 0,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'buttons': 0,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'ctrlKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'metaKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'pageX': 58,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'pageY': 303,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'shiftKey': False,
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'target': 'dragTarget',
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -   'type': 'mousemove'},
[task 2024-09-13T08:48:15.859Z] 08:48:15     INFO -  {'altKey': False,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'button': 0,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'buttons': 0,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'ctrlKey': False,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'metaKey': False,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'pageX': 78,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'pageY': 303,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'shiftKey': False,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'target': 'dragArea',
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -   'type': 'mouseup'}]
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO - final_rect = {'bottom': 306.8999938964844,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'height': 7,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'left': 55,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'right': 62,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'top': 299.8999938964844,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'width': 7,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'x': 55,
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO -  'y': 299.8999938964844}
[task 2024-09-13T08:48:15.860Z] 08:48:15     INFO - get_element = <function get_element.<locals>.get_element at 0x10a395580>
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO - initial_center = {'x': 58.5, 'y': 303.3999938964844}
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO - initial_rect = {'bottom': 306.8999938964844,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'height': 7,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'left': 55,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'right': 62,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'top': 299.8999938964844,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'width': 7,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'x': 55,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'y': 299.8999938964844}
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO - load_static_test_page = <function load_static_test_page.<locals>.load_static_test_page at 0x10a394d60>
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO - top_context = {'children': [],
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'context': '32903261-106d-4caa-8cfb-433bb22aef57',
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'originalOpener': None,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'parent': None,
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'url': 'about:blank',
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO -  'userContext': 'default'}
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO - 
[task 2024-09-13T08:48:15.861Z] 08:48:15     INFO - tests/web-platform/tests/webdriver/tests/bidi/input/perform_actions/pointer_mouse_drag.py:61: AssertionError
[task 2024-09-13T08:48:15.892Z] 08:48:15     INFO - ....................
[task 2024-09-13T08:48:15.892Z] 08:48:15     INFO - TEST-OK | /webdriver/tests/bidi/input/perform_actions/pointer_mouse_drag.py | took 17461ms
Status: NEW → RESOLVED
Closed: 2 months ago
Resolution: --- → FIXED

I'm going to land this patch from bug 1904665 again. These particular tests might not be fixed yet and could start to happen again as Tier 3 failure once bug 1904671 is landed. I'll not reopen yet but will do if that is the case.

Depends on: 1904671

It's indeed not fixed and fails sporadically on MacOS only as it looks like. I'm checking test results from the last 2 weeks now.

Status: RESOLVED → REOPENED
Resolution: FIXED → ---
Target Milestone: 132 Branch → ---
No longer depends on: 1904859
You need to log in before you can comment on or make changes to this bug.