1867779 - Intermittent /webdriver/tests/bidi/browsing_context/traverse_history/delta.py | single tracking bug

Status: RESOLVED FIXED

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

Description

[Treeherder Bug Filer]

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

---

[task 2023-12-01T12:14:18.412Z] 12:14:18     INFO - TEST-PASS | /webdriver/tests/bidi/browsing_context/traverse_history/delta.py | test_delta_forward_and_back 
[task 2023-12-01T12:14:18.412Z] 12:14:18     INFO - TEST-PASS | /webdriver/tests/bidi/browsing_context/traverse_history/delta.py | test_navigate_in_the_same_document 
[task 2023-12-01T12:14:18.412Z] 12:14:18     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/browsing_context/traverse_history/delta.py | test_history_push_state - AssertionError: assert 'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#bar' == 'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#foo'
[task 2023-12-01T12:14:18.413Z] 12:14:18     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f0e1b2a5d90>
[task 2023-12-01T12:14:18.413Z] 12:14:18     INFO - new_tab = {'context': '86b5fc55-7f34-4e75-85e5-0353731529f4'}
[task 2023-12-01T12:14:18.413Z] 12:14:18     INFO - url = <function url.<locals>.url at 0x7f0e1a9ede60>
[task 2023-12-01T12:14:18.413Z] 12:14:18     INFO - 
[task 2023-12-01T12:14:18.414Z] 12:14:18     INFO -     async def test_history_push_state(bidi_session, new_tab, url):
[task 2023-12-01T12:14:18.414Z] 12:14:18     INFO -         page_url = url("/webdriver/tests/bidi/browsing_context/support/empty.html")
[task 2023-12-01T12:14:18.414Z] 12:14:18     INFO -         await bidi_session.browsing_context.navigate(
[task 2023-12-01T12:14:18.414Z] 12:14:18     INFO -             context=new_tab["context"], url=page_url, wait="complete"
[task 2023-12-01T12:14:18.415Z] 12:14:18     INFO -         )
[task 2023-12-01T12:14:18.415Z] 12:14:18     INFO -         assert await get_url_for_context(bidi_session, new_tab["context"]) == page_url
[task 2023-12-01T12:14:18.415Z] 12:14:18     INFO -     
[task 2023-12-01T12:14:18.416Z] 12:14:18     INFO -         pages = [
[task 2023-12-01T12:14:18.416Z] 12:14:18     INFO -             f"{page_url}#foo",
[task 2023-12-01T12:14:18.416Z] 12:14:18     INFO -             f"{page_url}#bar",
[task 2023-12-01T12:14:18.416Z] 12:14:18     INFO -         ]
[task 2023-12-01T12:14:18.417Z] 12:14:18     INFO -         for page in pages:
[task 2023-12-01T12:14:18.417Z] 12:14:18     INFO -             await bidi_session.script.call_function(
[task 2023-12-01T12:14:18.417Z] 12:14:18     INFO -                 function_declaration="""(url) => {
[task 2023-12-01T12:14:18.417Z] 12:14:18     INFO -                     history.pushState(null, null, url);
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -                 }""",
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -                 arguments=[
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -                     {"type": "string", "value": page},
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -                 ],
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -                 await_promise=False,
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -                 target=ContextTarget(new_tab["context"]),
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -             )
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -             assert await get_url_for_context(bidi_session, new_tab["context"]) == page
[task 2023-12-01T12:14:18.418Z] 12:14:18     INFO -     
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO -         await bidi_session.browsing_context.traverse_history(
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO -             context=new_tab["context"], delta=-1
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO -         )
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO -     
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO - >       assert await get_url_for_context(bidi_session, new_tab["context"]) == pages[0]
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO - E       AssertionError: assert 'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#bar' == 'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#foo'
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO - E         - https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#foo
[task 2023-12-01T12:14:18.419Z] 12:14:18     INFO - E         ?                                                                                         ^^^
[task 2023-12-01T12:14:18.420Z] 12:14:18     INFO - E         + https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#bar
[task 2023-12-01T12:14:18.420Z] 12:14:18     INFO - E         ?                                                                                         ^^^
[task 2023-12-01T12:14:18.420Z] 12:14:18     INFO - 
[task 2023-12-01T12:14:18.420Z] 12:14:18     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f0e1b2a5d90>
[task 2023-12-01T12:14:18.420Z] 12:14:18     INFO - new_tab    = {'context': '86b5fc55-7f34-4e75-85e5-0353731529f4'}
[task 2023-12-01T12:14:18.421Z] 12:14:18     INFO - page       = 'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#bar'
[task 2023-12-01T12:14:18.421Z] 12:14:18     INFO - page_url   = 'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html'
[task 2023-12-01T12:14:18.421Z] 12:14:18     INFO - pages      = ['https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#foo',
[task 2023-12-01T12:14:18.421Z] 12:14:18     INFO -  'https://web-platform.test:8443/webdriver/tests/bidi/browsing_context/support/empty.html#bar']
[task 2023-12-01T12:14:18.421Z] 12:14:18     INFO - url        = <function url.<locals>.url at 0x7f0e1a9ede60>
[task 2023-12-01T12:14:18.422Z] 12:14:18     INFO - 
[task 2023-12-01T12:14:18.422Z] 12:14:18     INFO - tests/web-platform/tests/webdriver/tests/bidi/browsing_context/traverse_history/delta.py:122: AssertionError
[task 2023-12-01T12:14:18.422Z] 12:14:18     INFO - ..
[task 2023-12-01T12:14:18.422Z] 12:14:18     INFO - TEST-OK | /webdriver/tests/bidi/browsing_context/traverse_history/delta.py | took 9181ms
[task 2023-12-01T12:14:18.423Z] 12:14:18     INFO - PID 10866 | 1701432858390	webdriver::server	DEBUG	-> GET /status
[task 2023-12-01T12:14:18.423Z] 12:14:18     INFO - PID 10866 | 1701432858390	webdriver::server	DEBUG	<- 200 OK {"value":{"message":"","ready":true}}
[task 2023-12-01T12:14:18.424Z] 12:14:18     INFO - PROCESS LEAKS /tmp/tmppvd3xjw5.mozrunner/runtests_leaks_1835.log
[task 2023-12-01T12:14:18.424Z] 12:14:18     INFO - leakcheck | Processing log file /tmp/tmppvd3xjw5.mozrunner/runtests_leaks_1835.log for scope /webdriver/tests/bidi/browsing_context/traverse_history
[task 2023-12-01T12:14:18.425Z] 12:14:18     INFO - TEST-INFO | leakcheck | default process: leak threshold set at 2867200 bytes
[task 2023-12-01T12:14:18.426Z] 12:14:18     INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes
[task 2023-12-01T12:14:18.426Z] 12:14:18     INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2023-12-01T12:14:18.427Z] 12:14:18     INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 10000 bytes
[task 2023-12-01T12:14:18.428Z] 12:14:18     INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2023-12-01T12:14:18.428Z] 12:14:18     INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2023-12-01T12:14:18.429Z] 12:14:18     INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2023-12-01T12:14:18.429Z] 12:14:18     INFO - TEST-INFO | leakcheck | sandboxbroker process: leak threshold set at 0 bytes
[task 2023-12-01T12:14:18.430Z] 12:14:18     INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2023-12-01T12:14:18.431Z] 12:14:18     INFO - TEST-INFO | leakcheck | utility process: leak threshold set at 0 bytes
[task 2023-12-01T12:14:18.432Z] 12:14:18     INFO - leakcheck | Processing leak log file /tmp/tmppvd3xjw5.mozrunner/runtests_leaks_1835_tab_pid11060.log
[task 2023-12-01T12:14:18.432Z] 12:14:18     INFO - TEST-PASS | leakcheck | tab no leaks detected!

Comment 1

[Cosmin Sabou [:CosminS]]

Seems to be coming from Bug 1866463. Linux only so far.

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 11
• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-qr: 2
  • debug: 1
  • opt: 1
• linux1804-64-tsan-qr: 9
  • opt: 9
• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2023-11-27&endday=2023-12-03&tree=all

Comment 3

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

It looks like that all the failures so far only happen on Linux, and no other platform.

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 8
• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-tsan-qr: 8
  • opt: 8
• linux1804-64-qr: 2
  • debug: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2023-12-04&endday=2023-12-10&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1
• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2023-12-11&endday=2023-12-17&tree=all

Comment 6

[Intermittent Failures Robot]

4 failures in 3349 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 1
• autoland: 3

Platform and build breakdown:

• linux1804-64-tsan-qr: 2
  • opt: 2
• linux1804-64-asan-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2023-12-18&endday=2023-12-24&tree=all

Comment 7

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

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

It looks like that all the failures so far only happen on Linux, and no other platform.

Beside that it seems as well that only slow running builds (debug, asan, tsan, and maybe ccov) are affected.

Comment 8

[Intermittent Failures Robot]

1 failures in 1162 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2023-12-25&endday=2023-12-31&tree=all

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• try: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2024-01-01&endday=2024-01-07&tree=all

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 1
  • opt: 1
• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2024-01-08&endday=2024-01-14&tree=all

Comment 11

[Intermittent Failures Robot]

3 failures in 3599 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1
• linux1804-64-tsan-qr: 1
  • opt: 1
• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2024-01-15&endday=2024-01-21&tree=all

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• linux1804-64-qr: 1
  • debug: 1
• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2024-01-22&endday=2024-01-28&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• mozilla-release: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1
• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1867779&startday=2024-01-29&endday=2024-02-04&tree=all

Comment 14

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

No more failures visible since bug 1877096 has been landed. Marking as fixed.