Closed Bug 1699906 Opened 4 years ago Closed 4 years ago

Intermittent /websockets/opening-handshake/002.html?wpt_flags=h2 | Reached error page: about:neterror?e=networkProtocolError&u=https%3A//web-platform.test%3A9000/websockets/opening-handshake/002.html%3Fwpt_flags%3Dh2&c=UTF-8&d=Firefox%20has%20exp

Categories

(Core :: Networking: WebSockets, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2021-03-20T09:49:55.100Z] 09:49:55     INFO - PID 15339 | [Child 19685: Socket Thread]: D/mtransport NrIceCtx(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec)/STREAM(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0) : parsing trickle candidate candidate:2 1 TCP 2105458943 172.17.0.4 9 typ host tcptype active
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - Traceback (most recent call last):
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 791, in run_func
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -     self.result = True, self.func(self.protocol, self.url, self.timeout)
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 912, in do_testharness
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -     protocol.marionette.navigate(url)
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 1516, in navigate
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -     self._send_message("WebDriver:Navigate", {"url": url})
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -     return func(*args, **kwargs)
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 629, in _send_message
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -     self._handle_error(err)
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 651, in _handle_error
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING -     raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - marionette_driver.errors.UnknownException: Reached error page: about:neterror?e=networkProtocolError&u=https%3A//web-platform.test%3A9000/websockets/opening-handshake/002.html%3Fwpt_flags%3Dh2&c=UTF-8&d=Firefox%20has%20experienced%20a%20network%20protocol%20violation%20that%20cannot%20be%20repaired.
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - stacktrace:
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - 	WebDriverError@chrome://marionette/content/error.js:181:5
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - 	UnknownError@chrome://marionette/content/error.js:488:5
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - 	checkReadyState@chrome://marionette/content/navigate.js:62:24
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - 	onNavigation@chrome://marionette/content/navigate.js:308:39
[task 2021-03-20T09:49:55.108Z] 09:49:55  WARNING - 	emit@resource://gre/modules/EventEmitter.jsm:160:20
[task 2021-03-20T09:49:55.109Z] 09:49:55  WARNING - 	receiveMessage@chrome://marionette/content/actors/MarionetteEventsParent.jsm:40:25
[task 2021-03-20T09:49:55.109Z] 09:49:55  WARNING - 
[task 2021-03-20T09:49:55.109Z] 09:49:55  WARNING - 
[task 2021-03-20T09:49:55.112Z] 09:49:55     INFO - TEST-UNEXPECTED-ERROR | /websockets/opening-handshake/002.html?wpt_flags=h2 | Reached error page: about:neterror?e=networkProtocolError&u=https%3A//web-platform.test%3A9000/websockets/opening-handshake/002.html%3Fwpt_flags%3Dh2&c=UTF-8&d=Firefox%20has%20experienced%20a%20network%20protocol%20violation%20that%20cannot%20be%20repaired.
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - Traceback (most recent call last):
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 791, in run_func
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -     self.result = True, self.func(self.protocol, self.url, self.timeout)
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -   File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 912, in do_testharness
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -     protocol.marionette.navigate(url)
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 1516, in navigate
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -     self._send_message("WebDriver:Navigate", {"url": url})
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/decorators.py", line 27, in _
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -     return func(*args, **kwargs)
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 629, in _send_message
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -     self._handle_error(err)
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -   File "/builds/worker/workspace/build/venv/lib/python3.6/site-packages/marionette_driver/marionette.py", line 651, in _handle_error
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO -     raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - marionette_driver.errors.UnknownException: Reached error page: about:neterror?e=networkProtocolError&u=https%3A//web-platform.test%3A9000/websockets/opening-handshake/002.html%3Fwpt_flags%3Dh2&c=UTF-8&d=Firefox%20has%20experienced%20a%20network%20protocol%20violation%20that%20cannot%20be%20repaired.
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - stacktrace:
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 	WebDriverError@chrome://marionette/content/error.js:181:5
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 	UnknownError@chrome://marionette/content/error.js:488:5
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 	checkReadyState@chrome://marionette/content/navigate.js:62:24
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 	onNavigation@chrome://marionette/content/navigate.js:308:39
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 	emit@resource://gre/modules/EventEmitter.jsm:160:20
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 	receiveMessage@chrome://marionette/content/actors/MarionetteEventsParent.jsm:40:25
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - 
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - TEST-INFO took 912ms
[task 2021-03-20T09:49:55.113Z] 09:49:55     INFO - PID 15339 | [Child 19685: Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:75: OnStunAddrsAvailable: receiving (5) stun addrs
[task 2021-03-20T09:49:55.117Z] 09:49:55     INFO - PID 15339 | (ice/ERR) ICE(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec): peer (PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec:default), stream(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0 - 5d3d1eeb:0cf4efba4cc13d1ac1bd4f1a5fc314c7) tried to trickle ICE in inappropriate state 4
[task 2021-03-20T09:49:55.118Z] 09:49:55     INFO - PID 15339 | [Child 19685: Socket Thread]: D/mtransport Trickle candidate is redundant for stream 'PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0' because it is completed: candidate:2 1 TCP 2105458943 172.17.0.4 9 typ host tcptype active
[task 2021-03-20T09:49:55.119Z] 09:49:55     INFO - PID 15339 | (ice/WARNING) ICE(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec): peer (PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec:default) has no stream matching stream PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0 - 0c9bf4e3:b9e517a058bbdaeb883ca974c4f056d6
[task 2021-03-20T09:49:55.122Z] 09:49:55     INFO - PID 15339 | [Child 19685: Socket Thread]: D/mtransport NrIceCtx(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec)/STREAM(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0) : parsing trickle candidate candidate:1 1 UDP 2122252543 fd15:4ba5:5a2b:100a:0:242:ac11:4 50140 typ host
[task 2021-03-20T09:49:55.123Z] 09:49:55     INFO - PID 15339 | (ice/ERR) ICE(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec): peer (PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec:default), stream(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0 - 5d3d1eeb:0cf4efba4cc13d1ac1bd4f1a5fc314c7) tried to trickle ICE in inappropriate state 4
[task 2021-03-20T09:49:55.125Z] 09:49:55     INFO - PID 15339 | [Child 19685: Socket Thread]: D/mtransport Trickle candidate is redundant for stream 'PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0' because it is completed: candidate:1 1 UDP 2122252543 fd15:4ba5:5a2b:100a:0:242:ac11:4 50140 typ host
[task 2021-03-20T09:49:55.128Z] 09:49:55     INFO - PID 15339 | (ice/WARNING) ICE(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec): peer (PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec:default) has no stream matching stream PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0 - 0c9bf4e3:b9e517a058bbdaeb883ca974c4f056d6
[task 2021-03-20T09:49:55.131Z] 09:49:55     INFO - PID 15339 | [Child 19685: Socket Thread]: D/mtransport NrIceCtx(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec)/STREAM(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0) : parsing trickle candidate candidate:3 1 TCP 2105524479 fd15:4ba5:5a2b:100a:0:242:ac11:4 9 typ host tcptype active
[task 2021-03-20T09:49:55.132Z] 09:49:55     INFO - PID 15339 | [Child 19685: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 7f70413f5890
[task 2021-03-20T09:49:55.137Z] 09:49:55     INFO - PID 15339 | (ice/ERR) ICE(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec): peer (PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec:default), stream(PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0 - 5d3d1eeb:0cf4efba4cc13d1ac1bd4f1a5fc314c7) tried to trickle ICE in inappropriate state 4
[task 2021-03-20T09:49:55.142Z] 09:49:55     INFO - PID 15339 | [Child 19685: Socket Thread]: D/mtransport Trickle candidate is redundant for stream 'PC:{16ac38a6-1cab-4c2e-8e76-ebeaa9a69a44} 1616233794597904 (id=34359738376 url=https://web-platform.test:8443/webrtc/RTCPeerConnec transport-id=transport_0' because it is completed: candidate:3 1 TCP 2105524479 fd15:4ba5:5a2b:100a:0:242:ac11:4 9 typ host tcptype active```
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.