Closed Bug 1912541 Opened 10 months ago Closed 10 months ago

Intermittent /webdriver/tests/bidi/browsing_context/capture_screenshot/frame.py | test_iframe - setup error: asyncio.exceptions.CancelledError

Categories

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

defect

Tracking

(Not tracked)

RESOLVED DUPLICATE of bug 1774392

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2024-08-09T21:12:01.189Z] 21:12:01     INFO - STDOUT: self = <StreamReader eof limit=32768 transport=<_SelectorSocketTransport closed fd=12>>
[task 2024-08-09T21:12:01.190Z] 21:12:01     INFO - STDOUT: func_name = 'readuntil'
[task 2024-08-09T21:12:01.191Z] 21:12:01     INFO - STDOUT:     async def _wait_for_data(self, func_name):
[task 2024-08-09T21:12:01.191Z] 21:12:01     INFO - STDOUT:         """Wait until feed_data() or feed_eof() is called.
[task 2024-08-09T21:12:01.192Z] 21:12:01     INFO - STDOUT:     
[task 2024-08-09T21:12:01.193Z] 21:12:01     INFO - STDOUT:         If stream was paused, automatically resume it.
[task 2024-08-09T21:12:01.194Z] 21:12:01     INFO - STDOUT:         """
[task 2024-08-09T21:12:01.194Z] 21:12:01     INFO - STDOUT:         # StreamReader uses a future to link the protocol feed_data() method
[task 2024-08-09T21:12:01.195Z] 21:12:01     INFO - STDOUT:         # to a read coroutine. Running two read coroutines at the same time
[task 2024-08-09T21:12:01.196Z] 21:12:01     INFO - STDOUT:         # would have an unexpected behaviour. It would not possible to know
[task 2024-08-09T21:12:01.197Z] 21:12:01     INFO - STDOUT:         # which coroutine would get the next data.
[task 2024-08-09T21:12:01.197Z] 21:12:01     INFO - STDOUT:         if self._waiter is not None:
[task 2024-08-09T21:12:01.198Z] 21:12:01     INFO - STDOUT:             raise RuntimeError(
[task 2024-08-09T21:12:01.199Z] 21:12:01     INFO - STDOUT:                 f'{func_name}() called while another coroutine is '
[task 2024-08-09T21:12:01.199Z] 21:12:01     INFO - STDOUT:                 f'already waiting for incoming data')
[task 2024-08-09T21:12:01.200Z] 21:12:01     INFO - STDOUT:     
[task 2024-08-09T21:12:01.201Z] 21:12:01     INFO - STDOUT:         assert not self._eof, '_wait_for_data after EOF'
[task 2024-08-09T21:12:01.201Z] 21:12:01     INFO - STDOUT:     
[task 2024-08-09T21:12:01.202Z] 21:12:01     INFO - STDOUT:         # Waiting for data while paused will make deadlock, so prevent it.
[task 2024-08-09T21:12:01.203Z] 21:12:01     INFO - STDOUT:         # This is essential for readexactly(n) for case when n > self._limit.
[task 2024-08-09T21:12:01.204Z] 21:12:01     INFO - STDOUT:         if self._paused:
[task 2024-08-09T21:12:01.204Z] 21:12:01     INFO - STDOUT:             self._paused = False
[task 2024-08-09T21:12:01.205Z] 21:12:01     INFO - STDOUT:             self._transport.resume_reading()
[task 2024-08-09T21:12:01.206Z] 21:12:01     INFO - STDOUT:     
[task 2024-08-09T21:12:01.206Z] 21:12:01     INFO - STDOUT:         self._waiter = self._loop.create_future()
[task 2024-08-09T21:12:01.246Z] 21:12:01     INFO - 
[task 2024-08-09T21:12:01.246Z] 21:12:01     INFO - TEST-UNEXPECTED-ERROR | /webdriver/tests/bidi/browsing_context/capture_screenshot/frame.py | test_iframe - setup error: asyncio.exceptions.CancelledError
[task 2024-08-09T21:12:01.246Z] 21:12:01     INFO - self = <websockets.legacy.client.Connect object at 0x7f9ac30bfe80>
[task 2024-08-09T21:12:01.247Z] 21:12:01     INFO - 
[task 2024-08-09T21:12:01.247Z] 21:12:01     INFO -     async def __await_impl_timeout__(self) -> WebSocketClientProtocol:
[task 2024-08-09T21:12:01.247Z] 21:12:01     INFO -         async with asyncio_timeout(self.open_timeout):
[task 2024-08-09T21:12:01.247Z] 21:12:01     INFO - >           return await self.__await_impl__()
[task 2024-08-09T21:12:01.247Z] 21:12:01     INFO - 
[task 2024-08-09T21:12:01.248Z] 21:12:01     INFO - self       = <websockets.legacy.client.Connect object at 0x7f9ac30bfe80>
[task 2024-08-09T21:12:01.248Z] 21:12:01     INFO - 
[task 2024-08-09T21:12:01.248Z] 21:12:01     INFO - tests/web-platform/tests/tools/third_party/websockets/src/websockets/legacy/client.py:647: 
[task 2024-08-09T21:12:01.248Z] 21:12:01     INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[task 2024-08-09T21:12:01.248Z] 21:12:01     INFO - tests/web-platform/tests/tools/third_party/websockets/src/websockets/legacy/client.py:654: in __await_impl__
[task 2024-08-09T21:12:01.249Z] 21:12:01     INFO -     await protocol.handshake(
[task 2024-08-09T21:12:01.249Z] 21:12:01     INFO -         _protocol  = <websockets.legacy.client.WebSocketClientProtocol object at 0x7f9ac3107700>
[task 2024-08-09T21:12:01.249Z] 21:12:01     INFO -         _transport = <_SelectorSocketTransport closed fd=16>
[task 2024-08-09T21:12:01.249Z] 21:12:01     INFO -         protocol   = <websockets.legacy.client.WebSocketClientProtocol object at 0x7f9ac3107700>
[task 2024-08-09T21:12:01.249Z] 21:12:01     INFO -         redirects  = 0
[task 2024-08-09T21:12:01.250Z] 21:12:01     INFO -         self       = <websockets.legacy.client.Connect object at 0x7f9ac30bfe80>
[task 2024-08-09T21:12:01.250Z] 21:12:01     INFO - tests/web-platform/tests/tools/third_party/websockets/src/websockets/legacy/client.py:319: in handshake
[task 2024-08-09T21:12:01.250Z] 21:12:01     INFO -     status_code, response_headers = await self.read_http_response()
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         available_extensions = [<websockets.extensions.permessage_deflate.ClientPerMessageDeflateFactory object at 0x7f9ac30bf880>]
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         available_subprotocols = None
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         extensions_header = 'permessage-deflate; client_max_window_bits'
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         extra_headers = None
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         key        = 'A3Zhw3WSOwcesuOqGeSHLQ=='
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         origin     = None
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         request_headers = Headers([('Host', '127.0.0.1:9222'), ('Upgrade', 'websocket'), ('Connection', 'Upgrade'), ('Sec-WebSocket-Key', 'A3Zhw3WSOwcesuOqGeSHLQ=='), ('Sec-WebSocket-Version', '13'), ('Sec-WebSocket-Extensions', 'permessage-deflate; client_max_window_bits'), ('User-Agent', 'Python/3.8 websockets/12.0')])
[task 2024-08-09T21:12:01.251Z] 21:12:01     INFO -         self       = <websockets.legacy.client.WebSocketClientProtocol object at 0x7f9ac3107700>
[task 2024-08-09T21:12:01.252Z] 21:12:01     INFO -         wsuri      = WebSocketURI(secure=False, host='127.0.0.1', port=9222, path='/session/5af68660-2c64-4590-ae71-1b3a61cdd51c', query='', username=None, password=None)
[task 2024-08-09T21:12:01.252Z] 21:12:01     INFO - tests/web-platform/tests/tools/third_party/websockets/src/websockets/legacy/client.py:139: in read_http_response
[task 2024-08-09T21:12:01.252Z] 21:12:01     INFO -     status_code, reason, headers = await read_response(self.reader)
[task 2024-08-09T21:12:01.252Z] 21:12:01     INFO -         self       = <websockets.legacy.client.WebSocketClientProtocol object at 0x7f9ac3107700>
Status: NEW → RESOLVED
Closed: 10 months ago
Duplicate of bug: 1774392
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.