Closed Bug 1681933 Opened 4 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCPeerConnection-helper-test.html | Setting up a connection using helpers and defaults should work - Test timed out | expected OK

Categories

(Core :: WebRTC, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2020-12-11T11:28:56.158Z] 11:28:56     INFO - TEST-START | /webrtc/RTCPeerConnection-helper-test.html
[task 2020-12-11T11:29:06.174Z] 11:29:06     INFO - PID 1116 | Timecard created 1607686136.104149
[task 2020-12-11T11:29:06.174Z] 11:29:06     INFO - PID 1116 |  Timestamp   | Delta       | Event                 | File                         | Function
[task 2020-12-11T11:29:06.174Z] 11:29:06     INFO - PID 1116 | ========================================================================================================
[task 2020-12-11T11:29:06.174Z] 11:29:06     INFO - PID 1116 |     0.000055 |    0.000055 | Constructor Completed | PeerConnectionImpl.cpp:326   | PeerConnectionImpl
[task 2020-12-11T11:29:06.175Z] 11:29:06     INFO - PID 1116 |     0.000613 |    0.000558 | Initializing PC Ctx   | PeerConnectionImpl.cpp:444   | Initialize
[task 2020-12-11T11:29:06.175Z] 11:29:06     INFO - PID 1116 |    10.053015 |   10.052402 | Destructor Invoked    | PeerConnectionImpl.cpp:335   | ~PeerConnectionImpl
[task 2020-12-11T11:29:06.175Z] 11:29:06     INFO - PID 1116 | [Child 1129: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:360: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {6f16d8dc-cbbb-aa40-a23a-7c99b95676d6}
[task 2020-12-11T11:29:06.366Z] 11:29:06     INFO - PID 1116 | (ice/INFO) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect): peer (PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect:default) Trickle grace period is over; marking every component with only failed pairs as failed.
[task 2020-12-11T11:29:06.366Z] 11:29:06     INFO - 
[task 2020-12-11T11:29:06.366Z] 11:29:06     INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCPeerConnection-helper-test.html | Setting up a connection using helpers and defaults should work - Test timed out
[task 2020-12-11T11:29:06.367Z] 11:29:06     INFO - PID 1116 | (ice/INFO) ICE-PEER(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect:default)/STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411)/COMP(1): All pairs are failed, and grace period has elapsed. Marking component as failed.
[task 2020-12-11T11:29:06.367Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411): state dump
[task 2020-12-11T11:29:06.367Z] 11:29:06     INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCPeerConnection-helper-test.html | expected OK
[task 2020-12-11T11:29:06.367Z] 11:29:06     INFO - TEST-INFO took 10209ms
[task 2020-12-11T11:29:06.370Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411): Local component 1 - dumping candidates
[task 2020-12-11T11:29:06.371Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411)/CAND(DEv8): host(IP4:10.49.56.53:53863/UDP)
[task 2020-12-11T11:29:06.371Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411)/CAND(k3ya): host(IP4:10.49.56.53:50514/TCP) active
[task 2020-12-11T11:29:06.375Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411): Local component 2 - dumping candidates
[task 2020-12-11T11:29:06.375Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411)/CAND(oP84): host(IP4:10.49.56.53:64913/UDP)
[task 2020-12-11T11:29:06.377Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411)/CAND(N4ec): host(IP4:10.49.56.53:64130/TCP) active
[task 2020-12-11T11:29:06.377Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE-PEER(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect:default)/STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411): state dump
[task 2020-12-11T11:29:06.377Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411): Remote component 1 in state 3 - dumping candidates
[task 2020-12-11T11:29:06.386Z] 11:29:06     INFO - PID 1116 | (ice/ERR) ICE(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect)/ICE-STREAM(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect transport-id=transport_0 - f2dba097:06b874751454fd76bd201bcab5601411): Remote component 2 in state 0 - dumping candidates
[task 2020-12-11T11:29:06.386Z] 11:29:06     INFO - PID 1116 | [Child 1129: Socket Thread]: D/mtransport NrIceCtx(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect): state 0->4
[task 2020-12-11T11:29:06.386Z] 11:29:06     INFO - PID 1116 | [Child 1129: Socket Thread]: D/mtransport NrIceCtx(PC:{0dbdd242-5440-f549-95b6-99f533d6b905} 1607686136295562 (id=17179869188 url=http://web-platform.test:8000/webrtc/RTCPeerConnect): dumping r_log ringbuffer...
[task 2020-12-11T11:29:06.386Z] 11:29:06     INFO - PID 1116 | [Child 1129: Socket Thread]: D/mtransport (registry/INFO) insert 'ice' (registry) succeeded: ice```
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.