1910126 - Intermittent /webdriver/tests/bidi/network/fetch_error/fetch_error.py | test_navigation_id - webdriver.bidi.error.UnknownErrorException: unknown error (Error: Address rejected)

Status: RESOLVED FIXED

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

Description

[Treeherder Bug Filer]

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

---

[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - TEST-PASS | /webdriver/tests/bidi/network/fetch_error/fetch_error.py | test_iframe_load 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - TEST-UNEXPECTED-FAIL | /webdriver/tests/bidi/network/fetch_error/fetch_error.py | test_navigation_id - webdriver.bidi.error.UnknownErrorException: unknown error (Error: Address rejected)
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f86acffe520>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - top_context = {'children': [{'children': [], 'context': '4294967297', 'originalOpener': None, 'url': 'about:blank', ...}], 'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037', 'originalOpener': None, 'parent': None, ...}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x7f86ad8e53a0>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - url = <function url.<locals>.url at 0x7f86ad8e8550>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - fetch = <function fetch.<locals>.fetch at 0x7f86ad8e8790>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - setup_network_test = <function setup_network_test.<locals>._setup_network_test at 0x7f86ad8e8dc0>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x7f86ad8e8820>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     @pytest.mark.asyncio
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     async def test_navigation_id(
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         bidi_session,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         top_context,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         wait_for_event,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         url,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         fetch,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         setup_network_test,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         wait_for_future_safe,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     ):
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - >       await setup_network_test(events=[FETCH_ERROR_EVENT])
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f86acffe520>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - fetch      = <function fetch.<locals>.fetch at 0x7f86ad8e8790>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - setup_network_test = <function setup_network_test.<locals>._setup_network_test at 0x7f86ad8e8dc0>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - top_context = {'children': [{'children': [],
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'context': '4294967297',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'originalOpener': None,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'url': 'about:blank',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'userContext': 'default'}],
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'originalOpener': None,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'parent': None,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Ciframe+src%3D%27https%3A%2F%2Fnot_a_valid_url.test%2F%27%3E%3C%2Fiframe%3E&mime=text%2Fhtml&charset=UTF-8',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'userContext': 'default'}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - url        = <function url.<locals>.url at 0x7f86ad8e8550>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x7f86ad8e53a0>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x7f86ad8e8820>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - tests/web-platform/tests/webdriver/tests/bidi/network/fetch_error/fetch_error.py:127: 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - tests/web-platform/tests/webdriver/tests/support/fixtures_bidi.py:645: in _setup_network_test
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     await bidi_session.browsing_context.navigate(
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f86acffe520>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         contexts   = None
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         events     = ['network.fetchError']
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         listeners  = []
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         on_response_completed = <Future pending>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         subscribe_events = <function subscribe_events.<locals>.subscribe_events at 0x7f86ad8e8d30>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         test_url   = 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html'
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         top_context = {'children': [{'children': [],
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'context': '4294967297',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'originalOpener': None,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'url': 'about:blank',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -                'userContext': 'default'}],
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'originalOpener': None,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'parent': None,
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Ciframe+src%3D%27https%3A%2F%2Fnot_a_valid_url.test%2F%27%3E%3C%2Fiframe%3E&mime=text%2Fhtml&charset=UTF-8',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'userContext': 'default'}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x7f86ad8e53a0>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x7f86ad8e8820>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - self = <webdriver.bidi.modules.browsing_context.BrowsingContext object at 0x7f86acffe400>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - kwargs = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037', 'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html', 'wait': 'complete'}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - raw_result = False
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - params = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037', 'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html', 'wait': 'complete'}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - mod_name = 'browsingContext', cmd_name = 'browsingContext.navigate'
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - future = <Future finished exception=UnknownErrorException(unknown error, Error: Address rejected, onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - )>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     @functools.wraps(params_fn)
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     async def inner(self: Any, **kwargs: Any) -> Any:
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         raw_result = kwargs.pop("raw_result", False)
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         params = remove_undefined(params_fn(self, **kwargs))
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         # Convert the classname and the method name to a bidi command name
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         mod_name = owner.__name__[0].lower() + owner.__name__[1:]
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         if hasattr(owner, "prefix"):
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -             mod_name = f"{owner.prefix}:{mod_name}"
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         cmd_name = f"{mod_name}.{to_camelcase(name)}"
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -     
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -         future = await self.session.send_command(cmd_name, params)
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - >       result = await future
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - E       webdriver.bidi.error.UnknownErrorException: unknown error (Error: Address rejected)
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - E       
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - E       Remote-end stacktrace:
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - E       
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - E       onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - cmd_name   = 'browsingContext.navigate'
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - future     = <Future finished exception=UnknownErrorException(unknown error, Error: Address rejected, onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - )>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - kwargs     = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'wait': 'complete'}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - mod_name   = 'browsingContext'
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - name       = 'navigate'
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - owner      = <class 'webdriver.bidi.modules.browsing_context.BrowsingContext'>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - params     = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html',
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO -  'wait': 'complete'}
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - params_fn  = <function BrowsingContext.navigate at 0x7f86ada6b430>
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - raw_result = False
[task 2024-07-26T14:25:30.894Z] 14:25:30     INFO - result_fn  = <function BrowsingContext._navigate at 0x7f86ada6b4c0>
[task 2024-07-26T14:25:30.895Z] 14:25:30     INFO - self       = <webdriver.bidi.modules.browsing_context.BrowsingContext object at 0x7f86acffe400>
[task 2024-07-26T14:25:30.895Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.895Z] 14:25:30     INFO - tests/web-platform/tests/tools/webdriver/webdriver/bidi/modules/_module.py:76: UnknownErrorException
[task 2024-07-26T14:25:30.897Z] 14:25:30     INFO - .........
[task 2024-07-26T14:25:30.897Z] 14:25:30     INFO - TEST-OK | /webdriver/tests/bidi/network/fetch_error/fetch_error.py | took 11878ms
[task 2024-07-26T14:25:30.898Z] 14:25:30     INFO - Restarting browser for new test group
[task 2024-07-26T14:25:30.902Z] 14:25:30     INFO - PID 2124 | 1722003930897	webdriver::server	DEBUG	-> GET /status
[task 2024-07-26T14:25:30.903Z] 14:25:30     INFO - PID 2124 | 1722003930897	webdriver::server	DEBUG	<- 200 OK {"value":{"message":"","ready":true}}
[task 2024-07-26T14:25:30.936Z] 14:25:30     INFO - STDOUT: =================================== FAILURES ===================================
[task 2024-07-26T14:25:30.937Z] 14:25:30     INFO - STDOUT: ______________________________ test_navigation_id ______________________________
[task 2024-07-26T14:25:30.937Z] 14:25:30     INFO - STDOUT: bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f86acffe520>
[task 2024-07-26T14:25:30.937Z] 14:25:30     INFO - STDOUT: top_context = {'children': [{'children': [], 'context': '4294967297', 'originalOpener': None, 'url': 'about:blank', ...}], 'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037', 'originalOpener': None, 'parent': None, ...}
[task 2024-07-26T14:25:30.938Z] 14:25:30     INFO - STDOUT: wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x7f86ad8e53a0>
[task 2024-07-26T14:25:30.938Z] 14:25:30     INFO - STDOUT: url = <function url.<locals>.url at 0x7f86ad8e8550>
[task 2024-07-26T14:25:30.938Z] 14:25:30     INFO - STDOUT: fetch = <function fetch.<locals>.fetch at 0x7f86ad8e8790>
[task 2024-07-26T14:25:30.938Z] 14:25:30     INFO - STDOUT: setup_network_test = <function setup_network_test.<locals>._setup_network_test at 0x7f86ad8e8dc0>
[task 2024-07-26T14:25:30.939Z] 14:25:30     INFO - STDOUT: wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x7f86ad8e8820>
[task 2024-07-26T14:25:30.939Z] 14:25:30     INFO - STDOUT:     @pytest.mark.asyncio
[task 2024-07-26T14:25:30.939Z] 14:25:30     INFO - STDOUT:     async def test_navigation_id(
[task 2024-07-26T14:25:30.940Z] 14:25:30     INFO - STDOUT:         bidi_session,
[task 2024-07-26T14:25:30.940Z] 14:25:30     INFO - STDOUT:         top_context,
[task 2024-07-26T14:25:30.940Z] 14:25:30     INFO - STDOUT:         wait_for_event,
[task 2024-07-26T14:25:30.940Z] 14:25:30     INFO - STDOUT:         url,
[task 2024-07-26T14:25:30.941Z] 14:25:30     INFO - STDOUT:         fetch,
[task 2024-07-26T14:25:30.941Z] 14:25:30     INFO - STDOUT:         setup_network_test,
[task 2024-07-26T14:25:30.941Z] 14:25:30     INFO - STDOUT:         wait_for_future_safe,
[task 2024-07-26T14:25:30.941Z] 14:25:30     INFO - STDOUT:     ):
[task 2024-07-26T14:25:30.942Z] 14:25:30     INFO - STDOUT: >       await setup_network_test(events=[FETCH_ERROR_EVENT])
[task 2024-07-26T14:25:30.942Z] 14:25:30     INFO - STDOUT: bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f86acffe520>
[task 2024-07-26T14:25:30.942Z] 14:25:30     INFO - STDOUT: fetch      = <function fetch.<locals>.fetch at 0x7f86ad8e8790>
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO - STDOUT: setup_network_test = <function setup_network_test.<locals>._setup_network_test at 0x7f86ad8e8dc0>
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO - STDOUT: top_context = {'children': [{'children': [],
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -                'context': '4294967297',
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -                'originalOpener': None,
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -                'url': 'about:blank',
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -                'userContext': 'default'}],
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -  'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -  'originalOpener': None,
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -  'parent': None,
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Ciframe+src%3D%27https%3A%2F%2Fnot_a_valid_url.test%2F%27%3E%3C%2Fiframe%3E&mime=text%2Fhtml&charset=UTF-8',
[task 2024-07-26T14:25:30.943Z] 14:25:30     INFO -  'userContext': 'default'}
[task 2024-07-26T14:25:30.944Z] 14:25:30     INFO - STDOUT: url        = <function url.<locals>.url at 0x7f86ad8e8550>
[task 2024-07-26T14:25:30.944Z] 14:25:30     INFO - STDOUT: wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x7f86ad8e53a0>
[task 2024-07-26T14:25:30.944Z] 14:25:30     INFO - STDOUT: wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x7f86ad8e8820>
[task 2024-07-26T14:25:30.944Z] 14:25:30     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/bidi/network/fetch_error/fetch_error.py
[task 2024-07-26T14:25:30.945Z] 14:25:30     INFO - STDOUT: :127: 
[task 2024-07-26T14:25:30.945Z] 14:25:30     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2024-07-26T14:25:30.945Z] 14:25:30     INFO - STDOUT: tests/web-platform/tests/webdriver/tests/support/fixtures_bidi.py
[task 2024-07-26T14:25:30.945Z] 14:25:30     INFO - STDOUT: :645: in _setup_network_test
[task 2024-07-26T14:25:30.946Z] 14:25:30     INFO - STDOUT:     await bidi_session.browsing_context.navigate(
[task 2024-07-26T14:25:30.946Z] 14:25:30     INFO - STDOUT:         bidi_session = <webdriver.bidi.client.BidiSession object at 0x7f86acffe520>
[task 2024-07-26T14:25:30.946Z] 14:25:30     INFO - STDOUT:         contexts   = None
[task 2024-07-26T14:25:30.946Z] 14:25:30     INFO - STDOUT:         events     = ['network.fetchError']
[task 2024-07-26T14:25:30.947Z] 14:25:30     INFO - STDOUT:         listeners  = []
[task 2024-07-26T14:25:30.947Z] 14:25:30     INFO - STDOUT:         on_response_completed = <Future pending>
[task 2024-07-26T14:25:30.947Z] 14:25:30     INFO - STDOUT:         subscribe_events = <function subscribe_events.<locals>.subscribe_events at 0x7f86ad8e8d30>
[task 2024-07-26T14:25:30.947Z] 14:25:30     INFO - STDOUT:         test_url   = 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html'
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO - STDOUT:         top_context = {'children': [{'children': [],
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -                'context': '4294967297',
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -                'originalOpener': None,
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -                'url': 'about:blank',
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -                'userContext': 'default'}],
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -  'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -  'originalOpener': None,
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -  'parent': None,
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/support/inline.py?doc=%3C%21doctype+html%3E%0A%3Cmeta+charset%3DUTF-8%3E%0A%3Ciframe+src%3D%27https%3A%2F%2Fnot_a_valid_url.test%2F%27%3E%3C%2Fiframe%3E&mime=text%2Fhtml&charset=UTF-8',
[task 2024-07-26T14:25:30.948Z] 14:25:30     INFO -  'userContext': 'default'}
[task 2024-07-26T14:25:30.949Z] 14:25:30     INFO - STDOUT:         wait_for_event = <function wait_for_event.<locals>.wait_for_event at 0x7f86ad8e53a0>
[task 2024-07-26T14:25:30.949Z] 14:25:30     INFO - STDOUT:         wait_for_future_safe = <function wait_for_future_safe.<locals>.wait_for_future_safe at 0x7f86ad8e8820>
[task 2024-07-26T14:25:30.949Z] 14:25:30     INFO - STDOUT: _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2024-07-26T14:25:30.949Z] 14:25:30     INFO - STDOUT: self = <webdriver.bidi.modules.browsing_context.BrowsingContext object at 0x7f86acffe400>
[task 2024-07-26T14:25:30.950Z] 14:25:30     INFO - STDOUT: kwargs = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037', 'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html', 'wait': 'complete'}
[task 2024-07-26T14:25:30.950Z] 14:25:30     INFO - STDOUT: raw_result = False
[task 2024-07-26T14:25:30.950Z] 14:25:30     INFO - STDOUT: params = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037', 'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html', 'wait': 'complete'}
[task 2024-07-26T14:25:30.950Z] 14:25:30     INFO - STDOUT: mod_name = 'browsingContext', cmd_name = 'browsingContext.navigate'
[task 2024-07-26T14:25:30.951Z] 14:25:30     INFO - STDOUT: future = <Future finished exception=UnknownErrorException(unknown error, Error: Address rejected, onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.951Z] 14:25:30     INFO - )>
[task 2024-07-26T14:25:30.951Z] 14:25:30     INFO - STDOUT:     @functools.wraps(params_fn)
[task 2024-07-26T14:25:30.951Z] 14:25:30     INFO - STDOUT:     async def inner(self: Any, **kwargs: Any) -> Any:
[task 2024-07-26T14:25:30.951Z] 14:25:30     INFO - STDOUT:         raw_result = kwargs.pop("raw_result", False)
[task 2024-07-26T14:25:30.952Z] 14:25:30     INFO - STDOUT:         params = remove_undefined(params_fn(self, **kwargs))
[task 2024-07-26T14:25:30.952Z] 14:25:30     INFO - STDOUT:     
[task 2024-07-26T14:25:30.952Z] 14:25:30     INFO - STDOUT:         # Convert the classname and the method name to a bidi command name
[task 2024-07-26T14:25:30.953Z] 14:25:30     INFO - STDOUT:         mod_name = owner.__name__[0].lower() + owner.__name__[1:]
[task 2024-07-26T14:25:30.953Z] 14:25:30     INFO - STDOUT:         if hasattr(owner, "prefix"):
[task 2024-07-26T14:25:30.953Z] 14:25:30     INFO - STDOUT:             mod_name = f"{owner.prefix}:{mod_name}"
[task 2024-07-26T14:25:30.953Z] 14:25:30     INFO - STDOUT:         cmd_name = f"{mod_name}.{to_camelcase(name)}"
[task 2024-07-26T14:25:30.953Z] 14:25:30     INFO - STDOUT:     
[task 2024-07-26T14:25:30.953Z] 14:25:30     INFO - STDOUT:         future = await self.session.send_command(cmd_name, params)
[task 2024-07-26T14:25:30.954Z] 14:25:30     INFO - STDOUT: >       result = await future
[task 2024-07-26T14:25:30.954Z] 14:25:30     INFO - STDOUT: E       webdriver.bidi.error.UnknownErrorException: unknown error (Error: Address rejected)
[task 2024-07-26T14:25:30.954Z] 14:25:30     INFO - STDOUT: E       
[task 2024-07-26T14:25:30.954Z] 14:25:30     INFO - STDOUT: E       Remote-end stacktrace:
[task 2024-07-26T14:25:30.955Z] 14:25:30     INFO - STDOUT: E       
[task 2024-07-26T14:25:30.955Z] 14:25:30     INFO - STDOUT: E       onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.955Z] 14:25:30     INFO - STDOUT: cmd_name   = 'browsingContext.navigate'
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO - STDOUT: future     = <Future finished exception=UnknownErrorException(unknown error, Error: Address rejected, onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO - )>
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO - STDOUT: kwargs     = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html',
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO -  'wait': 'complete'}
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO - STDOUT: mod_name   = 'browsingContext'
[task 2024-07-26T14:25:30.956Z] 14:25:30     INFO - STDOUT: name       = 'navigate'
[task 2024-07-26T14:25:30.957Z] 14:25:30     INFO - STDOUT: owner      = <class 'webdriver.bidi.modules.browsing_context.BrowsingContext'>
[task 2024-07-26T14:25:30.957Z] 14:25:30     INFO - STDOUT: params     = {'context': 'e120dad4-dfb5-45a4-937f-9256cf7a0037',
[task 2024-07-26T14:25:30.957Z] 14:25:30     INFO -  'url': 'https://web-platform.test:8443/webdriver/tests/bidi/network/support/empty.html',
[task 2024-07-26T14:25:30.957Z] 14:25:30     INFO -  'wait': 'complete'}
[task 2024-07-26T14:25:30.957Z] 14:25:30     INFO - STDOUT: params_fn  = <function BrowsingContext.navigate at 0x7f86ada6b430>
[task 2024-07-26T14:25:30.958Z] 14:25:30     INFO - STDOUT: raw_result = False
[task 2024-07-26T14:25:30.958Z] 14:25:30     INFO - STDOUT: result_fn  = <function BrowsingContext._navigate at 0x7f86ada6b4c0>
[task 2024-07-26T14:25:30.958Z] 14:25:30     INFO - STDOUT: self       = <webdriver.bidi.modules.browsing_context.BrowsingContext object at 0x7f86acffe400>
[task 2024-07-26T14:25:30.959Z] 14:25:30     INFO - STDOUT: tests/web-platform/tests/tools/webdriver/webdriver/bidi/modules/_module.py
[task 2024-07-26T14:25:30.959Z] 14:25:30     INFO - STDOUT: :76: UnknownErrorException
[task 2024-07-26T14:25:30.959Z] 14:25:30     INFO - STDOUT: ---------------------------- Captured log teardown -----------------------------
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO - STDOUT: ERROR    asyncio:base_events.py:1692 Task exception was never retrieved
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO - future: <Task finished name='Task-56' coro=<wait_for_event.<locals>.wait_for_event.<locals>.on_event() done, defined at /builds/worker/workspace/build/tests/web-platform/tests/webdriver/tests/support/fixtures_bidi.py:136> exception=ValueError('list.remove(x): x not in list')>
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO - Traceback (most recent call last):
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO -   File "/builds/worker/workspace/build/tests/web-platform/tests/webdriver/tests/support/fixtures_bidi.py", line 137, in on_event
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO -     remove_listener()
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/webdriver/webdriver/bidi/client.py", line 235, in <lambda>
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO -     return lambda: self.event_listeners[name].remove(fn)
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO - ValueError: list.remove(x): x not in list
[task 2024-07-26T14:25:30.960Z] 14:25:30     INFO - STDOUT: =========================== short test summary info ============================
[task 2024-07-26T14:25:30.961Z] 14:25:30     INFO - STDOUT: FAILED tests/web-platform/tests/webdriver/tests/bidi/network/fetch_error/fetch_error.py::test_navigation_id - webdriver.bidi.error.UnknownErrorException: unknown error (Error: Address rejected)
[task 2024-07-26T14:25:30.961Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.961Z] 14:25:30     INFO - Remote-end stacktrace:
[task 2024-07-26T14:25:30.961Z] 14:25:30     INFO - 
[task 2024-07-26T14:25:30.961Z] 14:25:30     INFO - onLocationChange@chrome://remote/content/shared/Navigate.sys.mjs:359:26
[task 2024-07-26T14:25:30.961Z] 14:25:30     INFO - STDOUT: ======================== 1 failed, 12 passed in 11.69s =========================
[task 2024-07-26T14:25:30.962Z] 14:25:30     INFO - Closing logging queue
[task 2024-07-26T14:25:30.962Z] 14:25:30     INFO - queue closed
[task 2024-07-26T14:25:31.017Z] 14:25:31     INFO - Starting WebDriver: /builds/worker/fetches/geckodriver --host 127.0.0.1 --port 0 -vv
[task 2024-07-26T14:25:31.122Z] 14:25:31     INFO - PID 2191 | 1722003931021	geckodriver	INFO	Listening on 127.0.0.1:37136
[task 2024-07-26T14:25:31.122Z] 14:25:31     INFO - Webdriver started successfully.
[task 2024-07-26T14:25:31.123Z] 14:25:31     INFO - Starting runner
[task 2024-07-26T14:25:31.374Z] 14:25:31     INFO - TEST-START | /webdriver/tests/bidi/network/set_cache_behavior/contexts.py

Comment 1

[tszentpeteri]

Could you please take a look?

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 3

[Julian Descottes [:jdescottes]]

Thanks for the ping. With my patch, the fetchError event is emitted a bit earlier and it seems that the failed navigation from the test running right before test_navigation_id (ie test_iframe_load) pollutes the navigation listener and fails the new navigation.

I think we should fix it for now by isolating the two tests, and file a follow up to see if we can improve the navigation logic here.

Comment 4

[Julian Descottes [:jdescottes]]

Maybe we can just wait for the navigation to complete in the previous test, because only the iframe should fail to load, not the actual page.

https://treeherder.mozilla.org/jobs?repo=try&revision=d622f4382c8c451aca1bba9c3a937f10baa7b6b1

Edit: this didn't work, trying another approach

Comment 5

[Julian Descottes [:jdescottes]]

Attachment: Bug 1910126 - [wdspec] Use new tabs for each bidi fetchError test

Using a dedicated tab for each test should avoid side effects between tests.

Comment 6

[Julian Descottes [:jdescottes]]

Try seems green with this patch

Comment 7

[Intermittent Failures Robot]

27 failures in 760 pushes (0.036 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 26
• mozilla-central: 1

Platform and build breakdown:

• android-em-7-0-x86_64-qr: 26
  • debug: 20
  • debug-isolated-process: 6
• android-em-7-0-x86_64-lite-qr: 1
  • opt: 1

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

Comment 8

[Intermittent Failures Robot]

51 failures in 4124 pushes (0.012 failures/push) were associated with this bug in the last 7 days.

This is the #44 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-central: 8
• try: 3
• autoland: 40

Platform and build breakdown:

• android-em-7-0-x86_64-shippable-qr: 4
  • opt: 4
• android-em-7-0-x86_64-qr: 43
  • debug-isolated-process: 17
  • debug: 25
  • opt: 1
• android-em-7-0-x86_64-shippable-lite-qr: 2
  • opt: 2
• android-em-7-0-x86_64-lite-qr: 2
  • opt: 2

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

Comment 9

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/bb3ee1769df4
[wdspec] Use new tabs for each bidi fetchError test r=webdriver-reviewers,Sasha

Comment 10

[Web Platform Test Sync Bot [:wpt-sync] (Matrix: #interop:mozilla.org)]

Created web-platform-tests PR https://github.com/web-platform-tests/wpt/pull/47327 for changes under testing/web-platform/tests

Comment 11

[Iulian Moraru]

https://hg.mozilla.org/mozilla-central/rev/bb3ee1769df4

Comment 12

[Web Platform Test Sync Bot [:wpt-sync] (Matrix: #interop:mozilla.org)]

Upstream PR merged by moz-wptsync-bot

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

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

Platform and build breakdown:

• android-em-7-0-x86_64-shippable-lite-qr: 2
  • opt: 2
• android-em-7-0-x86_64-qr: 2
  • debug-isolated-process: 1
  • debug: 1

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