Closed
Bug 1825928
Opened 3 years ago
Closed 3 years ago
Intermittent [tier 2] /webrtc/legacy/RTCRtpTransceiver-with-OfferToReceive-options.https.html | single tracking bug
Categories
(Core :: WebRTC, defect, P5)
Core
WebRTC
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=411050948&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ZqrKJXJFRN-oVH9ktvCrLQ/runs/0/artifacts/public/logs/live_backing.log
[task 2023-04-01T11:02:11.587Z] 11:02:11 INFO - TEST-START | /webrtc/legacy/RTCRtpTransceiver-with-OfferToReceive-options.https.html
[task 2023-04-01T11:02:11.589Z] 11:02:11 INFO - Setting pref media.navigator.permission.disabled to true
[task 2023-04-01T11:02:11.595Z] 11:02:11 INFO - Setting pref media.navigator.streams.fake to true
[task 2023-04-01T11:02:11.604Z] 11:02:11 INFO - Setting pref privacy.resistFingerprinting.reduceTimerPrecision.jitter to true
[task 2023-04-01T11:02:11.613Z] 11:02:11 INFO - Setting pref privacy.reduceTimerPrecision to true
[task 2023-04-01T11:02:11.622Z] 11:02:11 INFO - Setting pref media.peerconnection.ice.trickle_grace_period to 5000
[task 2023-04-01T11:02:11.632Z] 11:02:11 INFO - Setting pref media.peerconnection.ice.obfuscate_host_addresses to true
[task 2023-04-01T11:02:11.640Z] 11:02:11 INFO - Setting pref media.peerconnection.allow_old_setParameters to true
[task 2023-04-01T11:02:11.656Z] 11:02:11 INFO - Setting pref media.navigator.permission.disabled to true
[task 2023-04-01T11:02:11.672Z] 11:02:11 INFO - Setting pref media.navigator.streams.fake to true
[task 2023-04-01T11:02:11.687Z] 11:02:11 INFO - Setting pref privacy.resistFingerprinting.reduceTimerPrecision.jitter to false
[task 2023-04-01T11:02:11.716Z] 11:02:11 INFO - Setting pref privacy.reduceTimerPrecision to false
[task 2023-04-01T11:02:11.732Z] 11:02:11 INFO - Setting pref media.peerconnection.ice.trickle_grace_period to 10000
[task 2023-04-01T11:02:11.747Z] 11:02:11 INFO - Setting pref media.peerconnection.ice.obfuscate_host_addresses to false
[task 2023-04-01T11:02:11.763Z] 11:02:11 INFO - Setting pref media.peerconnection.allow_old_setParameters to false
[task 2023-04-01T11:02:11.777Z] 11:02:11 INFO - Closing window 3ed3f5da-b096-4c3e-b902-57d66a7d9333
[task 2023-04-01T11:02:18.278Z] 11:02:18 INFO - PID 21334 | [Child 21653: Main Thread]: D/DataChannel 7f17019d4240: Close()ing 7f170279bba0
[task 2023-04-01T11:02:18.278Z] 11:02:18 INFO - PID 21334 | [Child 21653: Main Thread]: D/DataChannel 7f1700b71be0: Close()ing 7f1700b159e0
[task 2023-04-01T11:02:18.299Z] 11:02:18 INFO - PID 21334 | Timecard created 1680346931.284567
[task 2023-04-01T11:02:18.299Z] 11:02:18 INFO - PID 21334 | Timestamp | Delta | Event | File | Function
[task 2023-04-01T11:02:18.299Z] 11:02:18 INFO - PID 21334 | ====================================================================================================================================
[task 2023-04-01T11:02:18.299Z] 11:02:18 INFO - PID 21334 | 0.000211 | 0.000211 | Constructor Completed | PeerConnectionImpl.cpp:376 | PeerConnectionImpl
[task 2023-04-01T11:02:18.299Z] 11:02:18 INFO - PID 21334 | 0.001142 | 0.000931 | Initializing PC Ctx | PeerConnectionImpl.cpp:461 | Initialize
[task 2023-04-01T11:02:18.300Z] 11:02:18 INFO - PID 21334 | 0.020181 | 0.019039 | Create Offer | PeerConnectionImpl.cpp:1574 | CreateOffer
[task 2023-04-01T11:02:18.301Z] 11:02:18 INFO - PID 21334 | 0.022981 | 0.002800 | Set Local Description | PeerConnectionImpl.cpp:1684 | SetLocalDescription
[task 2023-04-01T11:02:18.302Z] 11:02:18 INFO - PID 21334 | 0.041929 | 0.018948 | Set Remote Description | PeerConnectionImpl.cpp:1794 | SetRemoteDescription
[task 2023-04-01T11:02:18.302Z] 11:02:18 INFO - PID 21334 | 0.043776 | 0.001847 | Ice gathering state: gathering | PeerConnectionImpl.cpp:3437 | IceGatheringStateChange
[task 2023-04-01T11:02:18.305Z] 11:02:18 INFO - PID 21334 | 0.044000 | 0.000224 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.306Z] 11:02:18 INFO - PID 21334 | 0.044107 | 0.000107 | Send Ice Candidate to content | PeerConnectionImpl.cpp:3328 | SendLocalIceCandidateToContent
[task 2023-04-01T11:02:18.307Z] 11:02:18 INFO - PID 21334 | 0.044607 | 0.000500 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.307Z] 11:02:18 INFO - PID 21334 | 0.044660 | 0.000053 | Send Ice Candidate to content | PeerConnectionImpl.cpp:3328 | SendLocalIceCandidateToContent
[task 2023-04-01T11:02:18.308Z] 11:02:18 INFO - PID 21334 | 0.044938 | 0.000278 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.308Z] 11:02:18 INFO - PID 21334 | 0.044985 | 0.000047 | Send Ice Candidate to content | PeerConnectionImpl.cpp:3328 | SendLocalIceCandidateToContent
[task 2023-04-01T11:02:18.308Z] 11:02:18 INFO - PID 21334 | 0.045171 | 0.000186 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.308Z] 11:02:18 INFO - PID 21334 | 0.045218 | 0.000047 | Send Ice Candidate to content | PeerConnectionImpl.cpp:3328 | SendLocalIceCandidateToContent
[task 2023-04-01T11:02:18.313Z] 11:02:18 INFO - PID 21334 | 0.047667 | 0.002449 | Create Offer | PeerConnectionImpl.cpp:1574 | CreateOffer
[task 2023-04-01T11:02:18.313Z] 11:02:18 INFO - PID 21334 | 0.048702 | 0.001035 | Close | PeerConnectionImpl.cpp:2601 | Close
[task 2023-04-01T11:02:18.313Z] 11:02:18 INFO - PID 21334 | 0.056008 | 0.007306 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | 0.056018 | 0.000010 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | 0.056028 | 0.000010 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | 0.056036 | 0.000008 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | 0.056044 | 0.000008 | Ice Candidate gathered | PeerConnectionImpl.cpp:3264 | CandidateReady
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | 7.011159 | 6.955115 | Destructor Invoked | PeerConnectionImpl.cpp:393 | ~PeerConnectionImpl
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | 7.011159 | 0.000000 | {746b73fb-bafe-4323-bd82-8807da497854} | PeerConnectionImpl.cpp:394 | ~PeerConnectionImpl
[task 2023-04-01T11:02:18.314Z] 11:02:18 INFO - PID 21334 | [Child 21653: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:401: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {746b73fb-bafe-4323-bd82-8807da497854}
[task 2023-04-01T11:02:18.315Z] 11:02:18 INFO - PID 21334 | Timecard created 1680346931.038123
<...>
[task 2023-04-01T11:02:18.454Z] 11:02:18 INFO - PID 21334 | [Child 21653: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:401: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {acc61d9f-d086-4b96-a18d-de4179aac224}
[task 2023-04-01T11:02:18.454Z] 11:02:18 INFO - PID 21334 | Timecard created 1680346931.473871
[task 2023-04-01T11:02:18.455Z] 11:02:18 INFO - PID 21334 | Timestamp | Delta | Event | File | Function
[task 2023-04-01T11:02:18.455Z] 11:02:18 INFO - PID 21334 | =========================================================================================================================
[task 2023-04-01T11:02:18.456Z] 11:02:18 INFO - PID 21334 | 0.000378 | 0.000378 | Constructor Completed | PeerConnectionImpl.cpp:376 | PeerConnectionImpl
[task 2023-04-01T11:02:18.456Z] 11:02:18 INFO - PID 21334 | 0.000787 | 0.000409 | Initializing PC Ctx | PeerConnectionImpl.cpp:461 | Initialize
[task 2023-04-01T11:02:18.457Z] 11:02:18 INFO - PID 21334 | 0.072760 | 0.071973 | Create Offer | PeerConnectionImpl.cpp:1574 | CreateOffer
[task 2023-04-01T11:02:18.457Z] 11:02:18 INFO - PID 21334 | 0.075411 | 0.002651 | Close | PeerConnectionImpl.cpp:2601 | Close
[task 2023-04-01T11:02:18.458Z] 11:02:18 INFO - PID 21334 | 6.828311 | 6.752900 | Destructor Invoked | PeerConnectionImpl.cpp:393 | ~PeerConnectionImpl
[task 2023-04-01T11:02:18.458Z] 11:02:18 INFO - PID 21334 | 6.828311 | 0.000000 | {c89e8136-8053-46e6-a00b-bbd274d43c62} | PeerConnectionImpl.cpp:394 | ~PeerConnectionImpl
[task 2023-04-01T11:02:18.459Z] 11:02:18 INFO - PID 21334 | [Child 21653: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:401: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {c89e8136-8053-46e6-a00b-bbd274d43c62}
[task 2023-04-01T11:02:18.459Z] 11:02:18 INFO - PID 21334 | [Child 21653: Socket Thread]: I/mtransport NrIceCtx(PC:{3e35a388-e762-4965-8f97-af1a0750d06c} 1680346931198412 (id=6442450950 url=http://web-platform.test:8000/webrtc/legacy/RTCPeerConnection-createOffer-offerToReceive.html)): Destroy
[task 2023-04-01T11:02:18.460Z] 11:02:18 INFO - PID 21334 | [Child 21653: Socket Thread]: I/mtransport NrIceCtx(PC:{ca780e74-2b82-45e5-b47c-73e5ce202c09} 1680346931416656 (id=6442450950 url=http://web-platform.test:8000/webrtc/legacy/RTCPeerConnection-createOffer-offerToReceive.html)): Destroy
[task 2023-04-01T11:02:27.625Z] 11:02:27 INFO - PID 21334 | ALSA lib seq_hw.c:466:(snd_seq_hw_open) open /dev/snd/seq failed: No such file or directory
[task 2023-04-01T11:02:31.857Z] 11:02:31 INFO - PID 21334 | console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.sys.mjs", 324))
[task 2023-04-01T11:02:46.577Z] 11:02:46 INFO - Got timeout in harness
[task 2023-04-01T11:02:46.579Z] 11:02:46 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/legacy/RTCRtpTransceiver-with-OfferToReceive-options.https.html | TestRunner hit external timeout (this may indicate a hang)
[task 2023-04-01T11:02:46.579Z] 11:02:46 INFO - TEST-INFO took 35008ms
[task 2023-04-01T11:03:57.641Z] 11:03:57 INFO - Browser exited with return code -15
[task 2023-04-01T11:03:57.733Z] 11:03:57 CRITICAL - Loading initial page https://web-platform.test:8443/testharness_runner.html failed. Ensure that the there are no other programs bound to this port and that your firewall rules or network setup does not prevent access.
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - Traceback (most recent call last):
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 166, in load_runner
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - self.dismiss_alert(lambda: self.marionette.navigate(url))
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 214, in dismiss_alert
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - f()
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 166, in <lambda>
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - self.dismiss_alert(lambda: self.marionette.navigate(url))
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/marionette.py", line 1632, in navigate
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - self._send_message("WebDriver:Navigate", {"url": url})
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/decorators.py", line 34, in _
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - m._handle_socket_failure()
[task 2023-04-01T11:03:57.735Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/marionette.py", line 747, in _handle_socket_failure
[task 2023-04-01T11:03:57.736Z] 11:03:57 CRITICAL - reraise(exc_cls, exc, tb)
[task 2023-04-01T11:03:57.736Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/tests/web-platform/tests/tools/third_party/six/six.py", line 703, in reraise
[task 2023-04-01T11:03:57.736Z] 11:03:57 CRITICAL - raise value
[task 2023-04-01T11:03:57.736Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/decorators.py", line 24, in _
[task 2023-04-01T11:03:57.736Z] 11:03:57 CRITICAL - return func(*args, **kwargs)
[task 2023-04-01T11:03:57.737Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/marionette.py", line 696, in _send_message
[task 2023-04-01T11:03:57.737Z] 11:03:57 CRITICAL - msg = self.client.request(name, params)
[task 2023-04-01T11:03:57.737Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/transport.py", line 381, in request
[task 2023-04-01T11:03:57.738Z] 11:03:57 CRITICAL - return self.receive()
[task 2023-04-01T11:03:57.738Z] 11:03:57 CRITICAL - File "/builds/worker/workspace/build/venv/lib/python3.7/site-packages/marionette_driver/transport.py", line 228, in receive
[task 2023-04-01T11:03:57.739Z] 11:03:57 CRITICAL - raise socket.error("No data received over socket")
[task 2023-04-01T11:03:57.739Z] 11:03:57 CRITICAL - OSError: No data received over socket
[task 2023-04-01T11:03:57.739Z] 11:03:57 CRITICAL -
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•