Closed Bug 1816955 Opened 2 years ago Closed 2 years ago

High frequency /webdriver/tests/get_active_element/get.py | test_success_input , test_success_input_non_interactable - AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body>

Categories

(Remote Protocol :: Marionette, defect, P5)

defect

Tracking

(firefox-esr102 unaffected, firefox110 unaffected, firefox111 unaffected, firefox112 fixed)

RESOLVED FIXED
112 Branch
Tracking Status
firefox-esr102 --- unaffected
firefox110 --- unaffected
firefox111 --- unaffected
firefox112 --- fixed

People

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

References

(Regression)

Details

(Keywords: assertion, intermittent-failure, regression, Whiteboard: [retriggered], [wptsync upstream])

Attachments

(1 file)

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


[task 2023-02-15T15:44:14.881Z] 15:44:14     INFO - PID 15255 | JavaScript error: resource://gre/modules/AsyncShutdown.sys.mjs, line 727: Error: Phase "profile-before-change" is finished, it is too late to register completion condition "OS.File: flush I/O queued before profileBeforeChange"
[task 2023-02-15T15:44:14.993Z] 15:44:14     INFO - PID 15255 | 1676475854993	geckodriver::browser	DEBUG	Browser process stopped: exit status: 0
[task 2023-02-15T15:44:14.994Z] 15:44:14     INFO - PID 15255 | 1676475854993	webdriver::server	DEBUG	<- 200 OK {"value":null}
[task 2023-02-15T15:44:14.997Z] 15:44:14     INFO - STDOUT: =================================== FAILURES ===================================
[task 2023-02-15T15:44:15.004Z] 15:44:15     INFO - STDOUT: ______________________________ test_success_input ______________________________
[task 2023-02-15T15:44:15.004Z] 15:44:15     INFO - STDOUT: session = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.005Z] 15:44:15     INFO - STDOUT: inline = <function inline.<locals>.inline at 0x7f42146a58c8>
[task 2023-02-15T15:44:15.005Z] 15:44:15     INFO - STDOUT:     def test_success_input(session, inline):
[task 2023-02-15T15:44:15.005Z] 15:44:15     INFO - STDOUT:         session.url = inline("""
[task 2023-02-15T15:44:15.006Z] 15:44:15     INFO - STDOUT:             <body>
[task 2023-02-15T15:44:15.006Z] 15:44:15     INFO - STDOUT:                 <h1>Heading</h1>
[task 2023-02-15T15:44:15.006Z] 15:44:15     INFO - STDOUT:                 <input autofocus />
[task 2023-02-15T15:44:15.006Z] 15:44:15     INFO - STDOUT:                 <input style="opacity: 0" />
[task 2023-02-15T15:44:15.007Z] 15:44:15     INFO - STDOUT:                 <p>Another element</p>
[task 2023-02-15T15:44:15.007Z] 15:44:15     INFO - STDOUT:             </body>""")
[task 2023-02-15T15:44:15.007Z] 15:44:15     INFO - STDOUT:     
[task 2023-02-15T15:44:15.007Z] 15:44:15     INFO - STDOUT:         response = get_active_element(session)
[task 2023-02-15T15:44:15.008Z] 15:44:15     INFO - STDOUT:         element = assert_success(response)
[task 2023-02-15T15:44:15.008Z] 15:44:15     INFO - STDOUT: >       assert_is_active_element(session, element)
[task 2023-02-15T15:44:15.008Z] 15:44:15     INFO - STDOUT: element    = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.008Z] 15:44:15     INFO - STDOUT: inline     = <function inline.<locals>.inline at 0x7f42146a58c8>
[task 2023-02-15T15:44:15.009Z] 15:44:15     INFO - STDOUT: response   = <[ValueError('Sign not allowed in string format specifier',) raised in repr()] Response object at 0x7f42146ac6a0>
[task 2023-02-15T15:44:15.009Z] 15:44:15     INFO - STDOUT: session    = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.009Z] 15:44:15     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/get_active_element/get.py
[task 2023-02-15T15:44:15.009Z] 15:44:15     INFO - STDOUT: :62: 
[task 2023-02-15T15:44:15.010Z] 15:44:15     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-02-15T15:44:15.010Z] 15:44:15     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/support/asserts.py
[task 2023-02-15T15:44:15.011Z] 15:44:15     INFO - STDOUT: :144: in assert_is_active_element
[task 2023-02-15T15:44:15.011Z] 15:44:15     INFO - STDOUT:     assert_same_element(session, element, from_js)
[task 2023-02-15T15:44:15.012Z] 15:44:15     INFO - STDOUT:         element    = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.012Z] 15:44:15     INFO - STDOUT:         from_js    = <Element 9d0fe99b-5f0a-4831-97a5-090b6d9df00c>
[task 2023-02-15T15:44:15.013Z] 15:44:15     INFO - STDOUT:         session    = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.014Z] 15:44:15     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-02-15T15:44:15.015Z] 15:44:15     INFO - STDOUT: session = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.016Z] 15:44:15     INFO - STDOUT: a = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.016Z] 15:44:15     INFO - STDOUT: b = <Element 9d0fe99b-5f0a-4831-97a5-090b6d9df00c>
[task 2023-02-15T15:44:15.017Z] 15:44:15     INFO - STDOUT:     def assert_same_element(session, a, b):
[task 2023-02-15T15:44:15.018Z] 15:44:15     INFO - STDOUT:         """Verify that two element references describe the same element."""
[task 2023-02-15T15:44:15.018Z] 15:44:15     INFO - STDOUT:         if isinstance(a, dict):
[task 2023-02-15T15:44:15.019Z] 15:44:15     INFO - STDOUT:             assert Element.identifier in a, "Actual value does not describe an element"
[task 2023-02-15T15:44:15.019Z] 15:44:15     INFO - STDOUT:             a_id = a[Element.identifier]
[task 2023-02-15T15:44:15.028Z] 15:44:15     INFO - STDOUT:         elif isinstance(a, Element):
[task 2023-02-15T15:44:15.028Z] 15:44:15     INFO - STDOUT:             a_id = a.id
[task 2023-02-15T15:44:15.029Z] 15:44:15     INFO - STDOUT:         else:
[task 2023-02-15T15:44:15.029Z] 15:44:15     INFO - STDOUT:             raise AssertionError("Actual value is not a dictionary or web element")
[task 2023-02-15T15:44:15.030Z] 15:44:15     INFO - STDOUT:     
[task 2023-02-15T15:44:15.031Z] 15:44:15     INFO - STDOUT:         if isinstance(b, dict):
[task 2023-02-15T15:44:15.032Z] 15:44:15     INFO - STDOUT:             assert Element.identifier in b, "Expected value does not describe an element"
[task 2023-02-15T15:44:15.033Z] 15:44:15     INFO - STDOUT:             b_id = b[Element.identifier]
[task 2023-02-15T15:44:15.033Z] 15:44:15     INFO - STDOUT:         elif isinstance(b, Element):
[task 2023-02-15T15:44:15.034Z] 15:44:15     INFO - STDOUT:             b_id = b.id
[task 2023-02-15T15:44:15.035Z] 15:44:15     INFO - STDOUT:         else:
[task 2023-02-15T15:44:15.036Z] 15:44:15     INFO - STDOUT:             raise AssertionError("Expected value is not a dictionary or web element")
[task 2023-02-15T15:44:15.037Z] 15:44:15     INFO - STDOUT:     
[task 2023-02-15T15:44:15.038Z] 15:44:15     INFO - STDOUT:         if a_id == b_id:
[task 2023-02-15T15:44:15.040Z] 15:44:15     INFO - STDOUT:             return
[task 2023-02-15T15:44:15.041Z] 15:44:15     INFO - STDOUT:     
[task 2023-02-15T15:44:15.041Z] 15:44:15     INFO - STDOUT:         message = ("Expected element references to describe the same element, " +
[task 2023-02-15T15:44:15.042Z] 15:44:15     INFO - STDOUT:                    "but they did not.")
[task 2023-02-15T15:44:15.043Z] 15:44:15     INFO - STDOUT:     
[task 2023-02-15T15:44:15.044Z] 15:44:15     INFO - STDOUT:         # Attempt to provide more information, accounting for possible errors such
[task 2023-02-15T15:44:15.045Z] 15:44:15     INFO - STDOUT:         # as stale element references or not visible elements.
[task 2023-02-15T15:44:15.046Z] 15:44:15     INFO - STDOUT:         try:
[task 2023-02-15T15:44:15.047Z] 15:44:15     INFO - STDOUT:             a_markup = session.execute_script("return arguments[0].outerHTML;", args=(a,))
[task 2023-02-15T15:44:15.048Z] 15:44:15     INFO - STDOUT:             b_markup = session.execute_script("return arguments[0].outerHTML;", args=(b,))
[task 2023-02-15T15:44:15.048Z] 15:44:15     INFO - STDOUT:             message += " Actual: `%s`. Expected: `%s`." % (a_markup, b_markup)
[task 2023-02-15T15:44:15.049Z] 15:44:15     INFO - STDOUT:         except WebDriverException:
[task 2023-02-15T15:44:15.050Z] 15:44:15     INFO - STDOUT:             pass
[task 2023-02-15T15:44:15.051Z] 15:44:15     INFO - STDOUT:     
[task 2023-02-15T15:44:15.052Z] 15:44:15     INFO - STDOUT: >       raise AssertionError(message)
[task 2023-02-15T15:44:15.053Z] 15:44:15     INFO - STDOUT: E       AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body>
[task 2023-02-15T15:44:15.053Z] 15:44:15     INFO - STDOUT: E                   <h1>Heading</h1>
[task 2023-02-15T15:44:15.054Z] 15:44:15     INFO - STDOUT: E                   <input autofocus="">
[task 2023-02-15T15:44:15.055Z] 15:44:15     INFO - STDOUT: E                   <input style="opacity: 0">
[task 2023-02-15T15:44:15.056Z] 15:44:15     INFO - STDOUT: E                   <p>Another element</p>
[task 2023-02-15T15:44:15.057Z] 15:44:15     INFO - STDOUT: E               </body>`. Expected: `<input autofocus="">`.
[task 2023-02-15T15:44:15.058Z] 15:44:15     INFO - STDOUT: a          = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.059Z] 15:44:15     INFO - STDOUT: a_id       = '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'
[task 2023-02-15T15:44:15.059Z] 15:44:15     INFO - STDOUT: a_markup   = ('<body>\n'
[task 2023-02-15T15:44:15.059Z] 15:44:15     INFO -  '            <h1>Heading</h1>\n'
[task 2023-02-15T15:44:15.059Z] 15:44:15     INFO -  '            <input autofocus="">\n'
[task 2023-02-15T15:44:15.060Z] 15:44:15     INFO -  '            <input style="opacity: 0">\n'
[task 2023-02-15T15:44:15.060Z] 15:44:15     INFO -  '            <p>Another element</p>\n'
[task 2023-02-15T15:44:15.060Z] 15:44:15     INFO -  '        </body>')
[task 2023-02-15T15:44:15.060Z] 15:44:15     INFO - STDOUT: b          = <Element 9d0fe99b-5f0a-4831-97a5-090b6d9df00c>
[task 2023-02-15T15:44:15.061Z] 15:44:15     INFO - STDOUT: b_id       = '9d0fe99b-5f0a-4831-97a5-090b6d9df00c'
[task 2023-02-15T15:44:15.061Z] 15:44:15     INFO - STDOUT: b_markup   = '<input autofocus="">'
[task 2023-02-15T15:44:15.061Z] 15:44:15     INFO - STDOUT: message    = ('Expected element references to describe the same element, but they did not. '
[task 2023-02-15T15:44:15.061Z] 15:44:15     INFO -  'Actual: `<body>\n'
[task 2023-02-15T15:44:15.061Z] 15:44:15     INFO -  '            <h1>Heading</h1>\n'
[task 2023-02-15T15:44:15.062Z] 15:44:15     INFO -  '            <input autofocus="">\n'
[task 2023-02-15T15:44:15.062Z] 15:44:15     INFO -  '            <input style="opacity: 0">\n'
[task 2023-02-15T15:44:15.062Z] 15:44:15     INFO -  '            <p>Another element</p>\n'
[task 2023-02-15T15:44:15.062Z] 15:44:15     INFO -  '        </body>`. Expected: `<input autofocus="">`.')
[task 2023-02-15T15:44:15.062Z] 15:44:15     INFO - STDOUT: session    = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.062Z] 15:44:15     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/support/asserts.py
[task 2023-02-15T15:44:15.063Z] 15:44:15     INFO - STDOUT: :180: AssertionError
[task 2023-02-15T15:44:15.063Z] 15:44:15     INFO - STDOUT: =========================== short test summary info ============================
[task 2023-02-15T15:44:15.063Z] 15:44:15     INFO - STDOUT: FAILED tests/web-platform/tests/webdriver/tests/get_active_element/get.py::test_success_input
[task 2023-02-15T15:44:15.064Z] 15:44:15     INFO - STDOUT: ========================= 1 failed, 7 passed in 4.75s ==========================
[task 2023-02-15T15:44:15.064Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.064Z] 15:44:15     INFO - TEST-PASS | /webdriver/tests/get_active_element/get.py | test_no_top_browsing_context 
[task 2023-02-15T15:44:15.064Z] 15:44:15     INFO - TEST-PASS | /webdriver/tests/get_active_element/get.py | test_no_browsing_context 
[task 2023-02-15T15:44:15.064Z] 15:44:15     INFO - TEST-PASS | /webdriver/tests/get_active_element/get.py | test_no_such_element 
[task 2023-02-15T15:44:15.064Z] 15:44:15     INFO - TEST-PASS | /webdriver/tests/get_active_element/get.py | test_success_document 
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/get_active_element/get.py | test_success_input - AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body>
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO - session = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO - inline = <function inline.<locals>.inline at 0x7f42146a58c8>
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO -     def test_success_input(session, inline):
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO -         session.url = inline("""
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO -             <body>
[task 2023-02-15T15:44:15.065Z] 15:44:15     INFO -                 <h1>Heading</h1>
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -                 <input autofocus />
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -                 <input style="opacity: 0" />
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -                 <p>Another element</p>
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -             </body>""")
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -     
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -         response = get_active_element(session)
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO -         element = assert_success(response)
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO - >       assert_is_active_element(session, element)
[task 2023-02-15T15:44:15.066Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - element    = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - inline     = <function inline.<locals>.inline at 0x7f42146a58c8>
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - response   = <[ValueError('Sign not allowed in string format specifier',) raised in repr()] Response object at 0x7f42146ac6a0>
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - session    = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - tests/web-platform/tests/webdriver/tests/get_active_element/get.py:62: 
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO - tests/web-platform/tests/webdriver/tests/support/asserts.py:144: in assert_is_active_element
[task 2023-02-15T15:44:15.067Z] 15:44:15     INFO -     assert_same_element(session, element, from_js)
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         element    = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         from_js    = <Element 9d0fe99b-5f0a-4831-97a5-090b6d9df00c>
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         session    = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO - session = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO - a = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO - b = <Element 9d0fe99b-5f0a-4831-97a5-090b6d9df00c>
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -     def assert_same_element(session, a, b):
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         """Verify that two element references describe the same element."""
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         if isinstance(a, dict):
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -             assert Element.identifier in a, "Actual value does not describe an element"
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -             a_id = a[Element.identifier]
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         elif isinstance(a, Element):
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -             a_id = a.id
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -         else:
[task 2023-02-15T15:44:15.068Z] 15:44:15     INFO -             raise AssertionError("Actual value is not a dictionary or web element")
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -     
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         if isinstance(b, dict):
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             assert Element.identifier in b, "Expected value does not describe an element"
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             b_id = b[Element.identifier]
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         elif isinstance(b, Element):
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             b_id = b.id
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         else:
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             raise AssertionError("Expected value is not a dictionary or web element")
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -     
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         if a_id == b_id:
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             return
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -     
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         message = ("Expected element references to describe the same element, " +
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -                    "but they did not.")
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -     
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         # Attempt to provide more information, accounting for possible errors such
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         # as stale element references or not visible elements.
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         try:
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             a_markup = session.execute_script("return arguments[0].outerHTML;", args=(a,))
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             b_markup = session.execute_script("return arguments[0].outerHTML;", args=(b,))
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             message += " Actual: `%s`. Expected: `%s`." % (a_markup, b_markup)
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -         except WebDriverException:
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -             pass
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -     
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - >       raise AssertionError(message)
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - E       AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body>
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - E                   <h1>Heading</h1>
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - E                   <input autofocus="">
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - E                   <input style="opacity: 0">
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - E                   <p>Another element</p>
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - E               </body>`. Expected: `<input autofocus="">`.
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - a          = {'element-6066-11e4-a52e-4f735466cecf': '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'}
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - a_id       = '7447c3d9-9cb9-4381-8a90-0f2dab8ec90d'
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO - a_markup   = ('<body>\n'
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -  '            <h1>Heading</h1>\n'
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -  '            <input autofocus="">\n'
[task 2023-02-15T15:44:15.069Z] 15:44:15     INFO -  '            <input style="opacity: 0">\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '            <p>Another element</p>\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '        </body>')
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - b          = <Element 9d0fe99b-5f0a-4831-97a5-090b6d9df00c>
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - b_id       = '9d0fe99b-5f0a-4831-97a5-090b6d9df00c'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - b_markup   = '<input autofocus="">'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - message    = ('Expected element references to describe the same element, but they did not. '
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  'Actual: `<body>\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '            <h1>Heading</h1>\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '            <input autofocus="">\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '            <input style="opacity: 0">\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '            <p>Another element</p>\n'
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO -  '        </body>`. Expected: `<input autofocus="">`.')
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - session    = <Session 14fd5d54-68f5-46fb-a72c-3106581deb9f>
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - 
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - tests/web-platform/tests/webdriver/tests/support/asserts.py:180: AssertionError
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - ...
[task 2023-02-15T15:44:15.070Z] 15:44:15     INFO - TEST-OK | /webdriver/tests/get_active_element/get.py | took 4969ms
[task 2023-02-15T15:44:15.071Z] 15:44:15     INFO - PID 15255 | 1676475855014	webdriver::server	DEBUG	-> GET /status
[task 2023-02-15T15:44:15.071Z] 15:44:15     INFO - PID 15255 | 1676475855014	webdriver::server	DEBUG	<- 200 OK {"value":{"message":"","ready":true}}
[task 2023-02-15T15:44:15.078Z] 15:44:15     INFO - Closing logging queue
[task 2023-02-15T15:44:15.079Z] 15:44:15     INFO - queue closed
[task 2023-02-15T15:44:15.090Z] 15:44:15     INFO - PID 15508 | 1676475855088	geckodriver	INFO	Listening on 127.0.0.1:52728
[task 2023-02-15T15:44:15.090Z] 15:44:15     INFO - Starting runner
[task 2023-02-15T15:44:15.302Z] 15:44:15     INFO - TEST-START | /webdriver/tests/get_active_element/user_prompts.py

@Emilio, can you look into this failures? Seems to be coming from bug 1807003
It looks like to be high frequency

Flags: needinfo?(emilio)

Are you sure it doesn't come from bug 1444491? That changes autofocus. Bug 1807003 only changes animations and that test doesn't have any.

Flags: needinfo?(emilio) → needinfo?(smolnar)

(In reply to Emilio Cobos Álvarez (:emilio) from comment #2)

Are you sure it doesn't come from bug 1444491? That changes autofocus. Bug 1807003 only changes animations and that test doesn't have any.

@emilio, I think you are right.
The failure rate spiked after bug 1444491 relanded. Thank you for looking into this.

@Sean, can you look into this failure?

Flags: needinfo?(smolnar) → needinfo?(sefeng)

Looking; My guess is we need to do a rAF somewhere to ensure the autofocus candidates are flushed.

Regressed by: 1444491

Need to call rAF to ensure autofocus candidates are flushed.

Assignee: nobody → sefeng
Status: NEW → ASSIGNED
Flags: needinfo?(sefeng)
Summary: Intermittent /webdriver/tests/get_active_element/get.py | test_success_input - AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body> → High frequency /webdriver/tests/get_active_element/get.py | test_success_input - AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body>
Whiteboard: [retriggered]
Summary: High frequency /webdriver/tests/get_active_element/get.py | test_success_input - AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body> → High frequency /webdriver/tests/get_active_element/get.py | test_success_input , test_success_input_non_interactable - AssertionError: Expected element references to describe the same element, but they did not. Actual: `<body>

This is the same as bug 1817124 and we should get it fixed over there.

Depends on: 1817124
No longer depends on: 1817124
Pushed by sefeng@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/089fb3167ff4
Fix the intermittent webdriver/tests/get_active_element/get.py r=emilio,webdriver-reviewers,whimboo
Created web-platform-tests PR https://github.com/web-platform-tests/wpt/pull/38592 for changes under testing/web-platform/tests
Whiteboard: [retriggered] → [retriggered], [wptsync upstream]
Status: ASSIGNED → RESOLVED
Closed: 2 years ago
Resolution: --- → FIXED
Target Milestone: --- → 112 Branch
Upstream PR merged by moz-wptsync-bot
Moving bug to Remote Protocol::Marionette component per bug 1815831.
Component: geckodriver → Marionette
Product: Testing → Remote Protocol

Set release status flags based on info from the regressing bug 1444491

You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: