Closed Bug 1924138 Opened 15 days ago Closed 12 days ago

Intermittent [tier 2] /webdriver/tests/bidi/network/response_completed/response_completed.py | test_url_with_fragment - AssertionError

Categories

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

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1921712

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: tszentpeteri [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=477831639&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Ngmh4ubbTDq2ab-qcWCf-A/runs/0/artifacts/public/logs/live_backing.log


[task 2024-10-11T11:55:24.631Z] 11:55:24     INFO - TEST-PASS | /webdriver/tests/bidi/network/response_completed/response_completed.py | test_serviceworker_request 
[task 2024-10-11T11:55:24.631Z] 11:55:24     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/network/response_completed/response_completed.py | test_url_with_fragment - AssertionError
[task 2024-10-11T11:55:24.631Z] 11:55:24     INFO - url = <function url.<locals>.url at 0x0000018D6353CE00>
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO - wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x0000018D6353D300>
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO - wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x0000018D6353E200>
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO - fetch = <function fetch.<locals>.fetch at 0x0000018D6353FB00>
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO - setup_network_test = <function setup_network_test.<locals>._setup_network_test at 0x0000018D636080E0>
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO - current_time = <function current_time.<locals>.current_time at 0x0000018D63609620>
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO - 
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -     @pytest.mark.asyncio
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -     async def test_url_with_fragment(
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -         url, wait_for_event, wait_for_future_safe, fetch, setup_network_test, current_time
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -     ):
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -         fragment_url = url(f"{PAGE_EMPTY_HTML}#foo")
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -     
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -         network_events = await setup_network_test(events=[RESPONSE_COMPLETED_EVENT])
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -         events = network_events[RESPONSE_COMPLETED_EVENT]
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -     
[task 2024-10-11T11:55:24.632Z] 11:55:24     INFO -         on_response_completed = wait_for_event(RESPONSE_COMPLETED_EVENT)
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -     
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         # Record the time range for the request to assert the timing info.
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         time_start = await current_time()
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -     
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         await fetch(fragment_url, method="GET")
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         await wait_for_future_safe(on_response_completed)
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -     
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         time_end = await current_time()
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         time_range = number_interval(time_start, time_end)
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -     
[task 2024-10-11T11:55:24.633Z] 11:55:24     INFO -         assert len(events) == 1
[task 2024-10-11T11:55:24.659Z] 11:55:24     INFO -         expected   = {'connectEnd': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.659Z] 11:55:24     INFO -  'connectStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.659Z] 11:55:24     INFO -  'dnsEnd': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'dnsStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'fetchStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'redirectEnd': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'redirectStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'requestStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'requestTime': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'responseEnd': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'responseStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>,
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -  'tlsStart': <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>}
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -         key        = 'requestTime'
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO - tests\web-platform\tests\webdriver\tests\bidi\__init__.py:10: in recursive_compare
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -     expected(actual)
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -         actual     = 1728647723329
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -         expected   = <function assert_timing_info.<locals>.assert_timing at 0x0000018D63609F80>
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO - tests\web-platform\tests\webdriver\tests\bidi\network\__init__.py:55: in assert_timing
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -     expected_time_range(actual + time_origin)
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -         actual     = 1728647723329
[task 2024-10-11T11:55:24.660Z] 11:55:24     INFO -         expected_time_range = <function number_interval.<locals>._ at 0x0000018D63608220>
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO -         time_origin = 0
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - 
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - actual = 1728647723329
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - 
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO -     def _(actual: Any) -> None:
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO -         any_number(actual)
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - >       assert start <= actual <= end
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - E       AssertionError
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - 
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - actual     = 1728647723329
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - end        = 1728647723358
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - start      = 1728647723330
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - 
[task 2024-10-11T11:55:24.661Z] 11:55:24     INFO - tests\web-platform\tests\webdriver\tests\bidi\__init__.py:81: AssertionError
[task 2024-10-11T11:55:24.662Z] 11:55:24     INFO - ....
[task 2024-10-11T11:55:24.662Z] 11:55:24     INFO - TEST-OK | /webdriver/tests/bidi/network/response_completed/response_completed.py | took 9823ms
[task 2024-10-11T11:55:34.620Z] 11:55:34  WARNING - Forcibly terminating runner process
[task 2024-10-11T11:55:34.629Z] 11:55:34     INFO - Starting WebDriver: D:\task_172864678477221\fetches\geckodriver.exe --host 127.0.0.1 --port 0 -vv --binary D:\task_172864678477221\build\application\firefox\firefox.exe
[task 2024-10-11T11:55:34.732Z] 11:55:34     INFO - PID 10044 | 1728647734642	geckodriver	INFO	Listening on 127.0.0.1:53074
[task 2024-10-11T11:55:34.734Z] 11:55:34     INFO - Webdriver started successfully.
[task 2024-10-11T11:55:34.735Z] 11:55:34     INFO - Starting runner
[task 2024-10-11T11:55:35.432Z] 11:55:35     INFO - TEST-START | /webdriver/tests/bidi/network/response_completed/response_completed_cached.py
Status: NEW → RESOLVED
Closed: 12 days ago
Duplicate of bug: 1921712
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.