Closed Bug 1466350 Opened 8 years ago Closed 7 years ago

Intermittent dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | Test timed out.

Categories

(Core :: WebRTC, defect, P5)

Product:
Core
Component:
WebRTC
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: apavel [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=181525514&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/ebjH_sFXSWi0EXEiH9wUXw/runs/0/artifacts/public/logs/live_backing.log [task 2018-06-02T15:10:27.780Z] 15:10:27 INFO - CLINE-NO-DEFAULT-ADDR-SDP: "audio 42730 UDP/TLS/RTP/SAVPF 109 9 0 8 101\r\nc=IN IP4 172.17.0.4\r\na=candidate:0 1 UDP 2122187007 172.17.0.4 48763 typ host\r\na=candidate:4 1 UDP 2122252543 fd15:4ba5:5a2b:100a:0:242:ac11:4 54956 typ host\r\na=candidate:8 1 TCP 2105458943 172.17.0.4 9 typ host tcptype active\r\na=candidate:10 1 TCP 2105524479 fd15:4ba5:5a2b:100a:0:242:ac11:4 9 typ host tcptype active\r\na=candidate:0 2 UDP 2122187006 172.17.0.4 59518 typ host\r\na=candidate:4 2 UDP 2122252542 fd15:4ba5:5a2b:100a:0:242:ac11:4 41601 typ host\r\na=candidate:8 2 TCP 2105458942 172.17.0.4 9 typ host tcptype active\r\na=candidate:10 2 TCP 2105524478 fd15:4ba5:5a2b:100a:0:242:ac11:4 9 typ host tcptype active\r\na=candidate:1 1 UDP 1685987327 172.17.0.4 55599 typ srflx raddr 172.17.0.4 rport 48763\r\na=candidate:3 1 UDP 92151295 172.17.0.4 42730 typ relay raddr 172.17.0.4 rport 42730\r\na=candidate:1 2 UDP 1685987326 172.17.0.4 57863 typ srflx raddr 172.17.0.4 rport 59518\r\na=candidate:3 2 UDP 92151294 172.17.0.4 59801 typ relay raddr 172.17.0.4 rport 59801\r\na=candidate:9 1 UDP 8265727 172.17.0.4 46766 typ relay raddr 172.17.0.4 rport 46766\r\na=sendrecv\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2/recvonly urn:ietf:params:rtp-hdrext:csrc-audio-level\r\na=extmap:3 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1\r\na=fmtp:101 0-15\r\na=ice-pwd:b4d628dedb4f025de8e66163e8f438f1\r\na=ice-ufrag:097665f7\r\na=mid:sdparta_0\r\na=msid:{50e686b0-98b6-408d-a00e-6840fc578446} {ab7a8cf1-0b95-4374-a4ca-d42e9eea8275}\r\na=rtcp:59801 IN IP4 172.17.0.4\r\na=rtcp-mux\r\na=rtpmap:109 opus/48000/2\r\na=rtpmap:9 G722/8000/1\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:101 telephone-event/8000\r\na=setup:actpass\r\na=ssrc:2540654365 cname:{2e873daf-6887-47d9-b4f3-54770132da40}\r\n" [task 2018-06-02T15:10:27.783Z] 15:10:27 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | pcLocal: SDP contains non-zero IP c line [task 2018-06-02T15:10:27.800Z] 15:10:27 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | SDP MLine Index needs to exist [task 2018-06-02T15:10:27.803Z] 15:10:27 INFO - pcLocal: iceCandidate = {"candidate":"candidate:9 2 UDP 8265726 172.17.0.4 57619 typ relay raddr 172.17.0.4 rport 57619","sdpMid":"sdparta_0","sdpMLineIndex":0} [task 2018-06-02T15:10:27.809Z] 15:10:27 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | ICE candidate contains candidate [task 2018-06-02T15:10:27.812Z] 15:10:27 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | SDP mid not empty [task 2018-06-02T15:10:27.829Z] 15:10:27 INFO - CLINE-NO-DEFAULT-ADDR-SDP: "audio 42730 UDP/TLS/RTP/SAVPF 109 9 0 8 101\r\nc=IN IP4 172.17.0.4\r\na=candidate:0 1 UDP 2122187007 172.17.0.4 48763 typ host\r\na=candidate:4 1 UDP 2122252543 fd15:4ba5:5a2b:100a:0:242:ac11:4 54956 typ host\r\na=candidate:8 1 TCP 2105458943 172.17.0.4 9 typ host tcptype active\r\na=candidate:10 1 TCP 2105524479 fd15:4ba5:5a2b:100a:0:242:ac11:4 9 typ host tcptype active\r\na=candidate:0 2 UDP 2122187006 172.17.0.4 59518 typ host\r\na=candidate:4 2 UDP 2122252542 fd15:4ba5:5a2b:100a:0:242:ac11:4 41601 typ host\r\na=candidate:8 2 TCP 2105458942 172.17.0.4 9 typ host tcptype active\r\na=candidate:10 2 TCP 2105524478 fd15:4ba5:5a2b:100a:0:242:ac11:4 9 typ host tcptype active\r\na=candidate:1 1 UDP 1685987327 172.17.0.4 55599 typ srflx raddr 172.17.0.4 rport 48763\r\na=candidate:3 1 UDP 92151295 172.17.0.4 42730 typ relay raddr 172.17.0.4 rport 42730\r\na=candidate:1 2 UDP 1685987326 172.17.0.4 57863 typ srflx raddr 172.17.0.4 rport 59518\r\na=candidate:3 2 UDP 92151294 172.17.0.4 59801 typ relay raddr 172.17.0.4 rport 59801\r\na=candidate:9 1 UDP 8265727 172.17.0.4 46766 typ relay raddr 172.17.0.4 rport 46766\r\na=candidate:9 2 UDP 8265726 172.17.0.4 57619 typ relay raddr 172.17.0.4 rport 57619\r\na=sendrecv\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2/recvonly urn:ietf:params:rtp-hdrext:csrc-audio-level\r\na=extmap:3 urn:ietf:params:rtp-hdrext:sdes:mid\r\na=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1\r\na=fmtp:101 0-15\r\na=ice-pwd:b4d628dedb4f025de8e66163e8f438f1\r\na=ice-ufrag:097665f7\r\na=mid:sdparta_0\r\na=msid:{50e686b0-98b6-408d-a00e-6840fc578446} {ab7a8cf1-0b95-4374-a4ca-d42e9eea8275}\r\na=rtcp:59801 IN IP4 172.17.0.4\r\na=rtcp-mux\r\na=rtpmap:109 opus/48000/2\r\na=rtpmap:9 G722/8000/1\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:101 telephone-event/8000\r\na=setup:actpass\r\na=ssrc:2540654365 cname:{2e873daf-6887-47d9-b4f3-54770132da40}\r\n" [task 2018-06-02T15:10:27.831Z] 15:10:27 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | pcLocal: SDP contains non-zero IP c line [task 2018-06-02T15:10:27.833Z] 15:10:27 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | SDP MLine Index needs to exist [task 2018-06-02T15:10:27.836Z] 15:10:27 INFO - Buffered messages finished [task 2018-06-02T15:10:27.887Z] 15:10:27 INFO - TEST-UNEXPECTED-FAIL | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | Test timed out. [task 2018-06-02T15:10:27.888Z] 15:10:27 INFO - reportError@SimpleTest/TestRunner.js:121:7 [task 2018-06-02T15:10:27.891Z] 15:10:27 INFO - TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7 [task 2018-06-02T15:10:27.894Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.896Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.898Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.900Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.902Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.904Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.906Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.908Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.911Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.913Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.918Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.921Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.924Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.926Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.929Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.933Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.938Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.943Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.954Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.955Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.967Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.974Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.976Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.976Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.978Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.978Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.982Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.983Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.984Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.990Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.996Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.997Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:27.999Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.003Z] 15:10:27 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.005Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.016Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.018Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.020Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.022Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.023Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.027Z] 15:10:28 INFO - setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5 [task 2018-06-02T15:10:28.028Z] 15:10:28 INFO - TestRunner.runTests@SimpleTest/TestRunner.js:380:5 [task 2018-06-02T15:10:28.032Z] 15:10:28 INFO - RunSet.runtests@SimpleTest/setup.js:194:3 [task 2018-06-02T15:10:28.040Z] 15:10:28 INFO - RunSet.runall@SimpleTest/setup.js:173:5 [task 2018-06-02T15:10:28.042Z] 15:10:28 INFO - hookupTests@SimpleTest/setup.js:266:5 [task 2018-06-02T15:10:28.048Z] 15:10:28 INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5 [task 2018-06-02T15:10:28.050Z] 15:10:28 INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11 [task 2018-06-02T15:10:28.056Z] 15:10:28 INFO - EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3 [task 2018-06-02T15:10:28.060Z] 15:10:28 INFO - hookup@SimpleTest/setup.js:246:5 [task 2018-06-02T15:10:28.062Z] 15:10:28 INFO - EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true:11:1 [task 2018-06-02T15:10:28.067Z] 15:10:28 INFO - GECKO(2983) | MEMORY STAT | vsize 1854MB | residentFast 185MB | heapAllocated 25MB [task 2018-06-02T15:10:28.070Z] 15:10:28 INFO - TEST-OK | dom/media/tests/mochitest/test_peerConnection_basicAudioNATSrflx.html | took 328969ms
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.