1665021 - Intermittent /webdriver/tests/element_click/navigate.py | <test> - AssertionError: assert 'http://web-p...e=text%2Fhtml' == 'http://web-pl...rt/input.html'

Status: RESOLVED FIXED

(Remote Protocol :: Marionette, defect, P5)

Description

[Treeherder Bug Filer]

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

---

>[task 2020-09-15T09:39:26.358Z] 09:39:26     INFO - TEST-PASS | /webdriver/tests/element_click/navigate.py | test_numbers_link 
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/element_click/navigate.py | test_multi_line_link - AssertionError: assert 'http://web-p...e=text%2Fhtml' == 'http://web-pl...rt/input.html'
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO - session = <Session 8b4e5339-3b9b-4bcc-b3f3-c3667b9010a3>
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO - server_config = {'_logger_name': 'web-platform-tests', 'aliases': [], 'all_domains': {'': {'': 'web-platform.test', 'nonexistent': 'no...j6ds53lwwkrqhv28a.not-web-platform.test', 'nonexistent.not-web-platform.test', 'www2.not-web-platform.test', ...], ...}
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO - 
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -     def test_multi_line_link(session, server_config):
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -         link = "/webdriver/tests/element_click/support/input.html"
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -         session.url = inline("""
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -             <p style="background-color: yellow; width: 50px;">
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -                 <a href={url}>Helloooooooooooooooooooo Worlddddddddddddddd</a>
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -             </p>""".format(url=link))
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -         element = session.find.css("a", all=False)
[task 2020-09-15T09:39:26.359Z] 09:39:26     INFO -         response = element_click(session, element)
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO -         assert_success(response)
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO -         host = server_config["browser_host"]
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO -         port = server_config["ports"]["http"][0]
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO -     
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO - >       assert session.url == "http://{host}:{port}{url}".format(host=host, port=port, url=link)
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO - E       AssertionError: assert 'http://web-p...e=text%2Fhtml' == 'http://web-pl...rt/input.html'
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO - E         - http://web-platform.test:8000/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%0A++++++++%3Cp+style%3D%22background-color%3A+yellow%3B+width%3A+50px%3B%22%3E%0A++++++++++++%3Ca+href%3D%2Fwebdriver%2Ftests%2Felement_click%2Fsupport%2Finput.html%3EHelloooooooooooooooooooo+Worlddddddddddddddd%3C%2Fa%3E%0A++++++++%3C%2Fp%3E&charset=UTF-8&mime=text%2Fhtml
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO - E         + http://web-platform.test:8000/webdriver/tests/element_click/support/input.html
[task 2020-09-15T09:39:26.360Z] 09:39:26     INFO - ```

Comment 1

[Henrik Skupin [:whimboo][⌚️UTC+2]]

Looks similar to bug 1665022 where the click didn't trigger a navigation:

[task 2020-09-15T09:39:24.871Z] 09:39:24     INFO - PID 1036 | 1600162764859	Marionette	DEBUG	0 -> [0,614,"WebDriver:ElementClick",{"id":"4bf9d8aa-65d9-46da-8e54-272acd18dbd9"}]
[task 2020-09-15T09:39:24.886Z] 09:39:24     INFO - PID 1036 | 1600162764872	Marionette	TRACE	Using browsing context 20
[task 2020-09-15T09:39:25.121Z] 09:39:25     INFO - PID 1036 | 1600162765094	Marionette	TRACE	Canceled page load listener because no navigation has been detected
[task 2020-09-15T09:39:25.121Z] 09:39:25     INFO - PID 1036 | 1600162765095	Marionette	DEBUG	0 <- [1,614,null,{"value":null}]

As such the former URL is still open and causes a mismatch for the assertion. Maybe a side-effect of my patch on bug 1612831. Lets observe the next days how often it happens.

Comment 2

[Intermittent Failures Robot]

12 failures in 3760 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 9
• mozilla-central: 1
• try: 2

Platform breakdown:

• windows7-32: 6
• linux1804-64-qr: 2
• linux1804-64: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1665021&startday=2020-09-14&endday=2020-09-20&tree=all

Comment 3

[Henrik Skupin [:whimboo][⌚️UTC+2]]

The click doesn't seem to have triggered a navigation, which means we need a fix for bug 1394354.

Comment 4

[Intermittent Failures Robot]

2 failures in 4019 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1
• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1
• windows7-32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1665021&startday=2020-09-21&endday=2020-09-27&tree=all

Comment 5

[Henrik Skupin [:whimboo][⌚️UTC+2]]

(In reply to Henrik Skupin (:whimboo) [⌚️UTC+2] from comment #3)

The click doesn't seem to have triggered a navigation, which means we need a fix for bug 1394354.

And that was indeed the case. Since the bug got fixed there was no more such failure.

Comment 6

[BMO Automation]

Moving bug to Remote Protocol::Marionette component per bug 1815831.