Closed Bug 1643947 Opened 5 years ago Closed 5 years ago

Perma wpt win32-debug WebRTC TEST-UNEXPECTED-<fail>| /webrtc/webrtc/<test>.https.html | <random_fail>

Categories

(Core :: WebRTC: Networking, defect, P3)

Product:
Core
Component:
WebRTC: Networking
Version:
79 Branch
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1643058

People

(Reporter: malexandru, Assigned: bwc, NeedInfo)

References

Details

(Keywords: intermittent-failure)

Failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=305340012&repo=autoland&lineNumber=63296

Raw log: https://firefoxci.taskcluster-artifacts.net/NQ68pyWzRkedEX24DliOeA/0/public/logs/live_backing.log

[task 2020-06-06T18:08:20.824Z] 18:08:20     INFO - PID 4000 | [Child 6904, Socket Thread] WARNING: MediaPipeline Transport failed. This is not properly cleaned up yet: file /builds/worker/checkouts/gecko/media/webrtc/signaling/src/mediapipeline/MediaPipeline.cpp, line 428
[task 2020-06-06T18:08:20.824Z] 18:08:20     INFO - PID 4000 | [Child 6904, Socket Thread] WARNING: MediaPipeline Transport failed. This is not properly cleaned up yet: file /builds/worker/checkouts/gecko/media/webrtc/signaling/src/mediapipeline/MediaPipeline.cpp, line 428
[task 2020-06-06T18:08:20.825Z] 18:08:20     INFO - PID 4000 | [Child 6904, Socket Thread] WARNING: MediaPipeline Transport failed. This is not properly cleaned up yet: file /builds/worker/checkouts/gecko/media/webrtc/signaling/src/mediapipeline/MediaPipeline.cpp, line 428
[task 2020-06-06T18:08:20.825Z] 18:08:20     INFO - PID 4000 | (ice/INFO) ICE-PEER(PC:1591466889863000 (id=36507222060 url=https://web-platform.test:8443/webrtc/RTCRtpSender-replaceTrack.https.html):default): all checks completed success=0 fail=1
[task 2020-06-06T18:08:21.440Z] 18:08:21     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:22.440Z] 18:08:22     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:23.440Z] 18:08:23     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:24.440Z] 18:08:24     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:24.955Z] 18:08:24     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 14EEFA80
[task 2020-06-06T18:08:25.438Z] 18:08:25     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:26.437Z] 18:08:26     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:27.438Z] 18:08:27     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:27.737Z] 18:08:27     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 236C6CD0
[task 2020-06-06T18:08:27.792Z] 18:08:27     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 236C7310
[task 2020-06-06T18:08:27.792Z] 18:08:27     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 236C8A80
[task 2020-06-06T18:08:28.435Z] 18:08:28     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:29.055Z] 18:08:29     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 236C7E00
[task 2020-06-06T18:08:29.075Z] 18:08:29     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 236C7F90
[task 2020-06-06T18:08:29.115Z] 18:08:29     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 236C8120
[task 2020-06-06T18:08:29.434Z] 18:08:29     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:30.435Z] 18:08:30     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:31.395Z] 18:08:31     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 008DE690
[task 2020-06-06T18:08:31.434Z] 18:08:31     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:32.435Z] 18:08:32     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:32.455Z] 18:08:32     INFO - PID 4000 | [Child 6904: Socket Thread]: D/DataChannel Deleting DataChannelConnection 14EEF440
[task 2020-06-06T18:08:33.435Z] 18:08:33     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:34.435Z] 18:08:34     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:35.435Z] 18:08:35     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:36.435Z] 18:08:36     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:37.434Z] 18:08:37     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:38.435Z] 18:08:38     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:39.435Z] 18:08:39     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:39.590Z] 18:08:39     INFO - 
[task 2020-06-06T18:08:39.590Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack on closed connection should reject with InvalidStateError 
[task 2020-06-06T18:08:39.590Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack with track of different kind should reject with TypeError 
[task 2020-06-06T18:08:39.590Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack on stopped sender should reject with InvalidStateError 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack on sender with null track and not set to session description should resolve with sender.track set to given track 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack on sender not set to session description should resolve with sender.track set to given track 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack(null) on sender not set to session description should resolve with sender.track set to null 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack(null) on sender set to session description should resolve with sender.track set to null 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack on sender with stopped track and and set to session description should resolve with sender.track set to given track 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-PASS | /webrtc/RTCRtpSender-replaceTrack.https.html | Calling replaceTrack on sender with similar track and and set to session description should resolve with sender.track set to new track 
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCRtpSender-replaceTrack.https.html | ReplaceTrack transmits the new track not the old track - Test timed out
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-INFO | expected FAIL
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCRtpSender-replaceTrack.https.html | expected OK
[task 2020-06-06T18:08:39.591Z] 18:08:39     INFO - TEST-INFO took 30640ms
[task 2020-06-06T18:08:39.611Z] 18:08:39     INFO - PID 4000 | 1591466919621	Marionette	INFO	Stopped listening on port 52326
[task 2020-06-06T18:08:39.780Z] 18:08:39     INFO - PID 4000 | [Child 6904: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2100: CloseInt: Closing PeerConnectionImpl 6f847965202caf04; ending call
[task 2020-06-06T18:08:39.780Z] 18:08:39     INFO - PID 4000 | [Child 6904: Main Thread]: I/jsep [1591466889859000 (id=36507222060 url=https://web-platform.test:8443/webrtc/RTCRtpSender-replaceTrack.https.html)]: stable -> closed
[task 2020-06-06T18:08:39.781Z] 18:08:39     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2735: GetStats: Found no pipelines matching selector.
[task 2020-06-06T18:08:39.781Z] 18:08:39     INFO - PID 4000 | [Child 6904: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2100: CloseInt: Closing PeerConnectionImpl 8fe3041f1bba5b78; ending call
[task 2020-06-06T18:08:39.781Z] 18:08:39     INFO - PID 4000 | [Child 6904: Main Thread]: I/jsep [1591466889863000 (id=36507222060 url=https://web-platform.test:8443/webrtc/RTCRtpSender-replaceTrack.https.html)]: stable -> closed
[task 2020-06-06T18:08:39.808Z] 18:08:39     INFO - PID 4000 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-06T18:08:39.915Z] 18:08:39     INFO - PID 4000 | [Child 4112, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-06T18:08:39.934Z] 18:08:39     INFO - PID 4000 | [Child 4760, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-06T18:08:39.954Z] 18:08:39     INFO - PID 4000 | [2020-06-06T18:08:39Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2020-06-06T18:08:39.954Z] 18:08:39     INFO - PID 4000 | [2020-06-06T18:08:39Z WARN  xulstore::persist] tried to remove key that isn't in the store
[task 2020-06-06T18:08:40.089Z] 18:08:40     INFO - PID 4000 | [Child 6904: Main Thread]: D/DataChannel Shutting down SCTP
[task 2020-06-06T18:08:47.356Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp, line 470
[task 2020-06-06T18:08:47.356Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: '!ipcActor->SendAccumulateChildHistograms(histogramsToSend)', file /builds/worker/checkouts/gecko/toolkit/components/telemetry/core/ipc/TelemetryIPCAccumulator.cpp, line 279
[task 2020-06-06T18:08:47.357Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp, line 470
[task 2020-06-06T18:08:47.357Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: '!ipcActor->SendAccumulateChildKeyedHistograms(keyedHistogramsToSend)', file /builds/worker/checkouts/gecko/toolkit/components/telemetry/core/ipc/TelemetryIPCAccumulator.cpp, line 283
[task 2020-06-06T18:08:47.357Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp, line 470
[task 2020-06-06T18:08:47.357Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: '!ipcActor->SendRecordDiscardedData(discardedData)', file /builds/worker/checkouts/gecko/toolkit/components/telemetry/core/ipc/TelemetryIPCAccumulator.cpp, line 298
[task 2020-06-06T18:08:47.392Z] 18:08:47     INFO - PID 4000 | Timecard created 1591466889.858000
[task 2020-06-06T18:08:47.392Z] 18:08:47     INFO - PID 4000 |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2020-06-06T18:08:47.417Z] 18:08:47     INFO - PID 4000 | =====================================================================================================================
[task 2020-06-06T18:08:47.417Z] 18:08:47     INFO - PID 4000 |     0.000000 |    0.000000 | Constructor Completed          | PeerConnectionImpl.cpp:332   | PeerConnectionImpl
[task 2020-06-06T18:08:47.418Z] 18:08:47     INFO - PID 4000 |     0.001000 |    0.001000 | Initializing PC Ctx            | PeerConnectionImpl.cpp:458   | Initialize
[task 2020-06-06T18:08:47.418Z] 18:08:47     INFO - PID 4000 |     0.025000 |    0.024000 | Create Offer                   | PeerConnectionImpl.cpp:1239  | CreateOffer
[task 2020-06-06T18:08:47.418Z] 18:08:47     INFO - PID 4000 |     0.033000 |    0.008000 | Set Local Description          | PeerConnectionImpl.cpp:1308  | SetLocalDescription
[task 2020-06-06T18:08:47.419Z] 18:08:47     INFO - PID 4000 |     0.067000 |    0.034000 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2509  | IceGatheringStateChange
[task 2020-06-06T18:08:47.419Z] 18:08:47     INFO - PID 4000 |     0.075000 |    0.008000 | Ice gathering state: complete  | PeerConnectionImpl.cpp:2512  | IceGatheringStateChange
[task 2020-06-06T18:08:47.419Z] 18:08:47     INFO - PID 4000 |     0.078000 |    0.003000 | Set Remote Description         | PeerConnectionImpl.cpp:1395  | SetRemoteDescription
[task 2020-06-06T18:08:47.420Z] 18:08:47     INFO - PID 4000 |     0.091000 |    0.013000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.420Z] 18:08:47     INFO - PID 4000 |     0.092000 |    0.001
[task 2020-06-06T18:08:47.420Z] 18:08:47     INFO - PID 4000 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-06T18:08:47.420Z] 18:08:47     INFO - PID 4000 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-06T18:08:47.420Z] 18:08:47     INFO - PID 4000 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-06-06T18:08:47.421Z] 18:08:47     INFO - PID 4000 | 000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.421Z] 18:08:47     INFO - PID 4000 |     0.093000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.421Z] 18:08:47     INFO - PID 4000 |    37.531000 |   37.438000 | Destructor Invoked             | PeerConnectionImpl.cpp:341   | ~PeerConnectionImpl
[task 2020-06-06T18:08:47.421Z] 18:08:47     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:362: PeerConnectionCtx is already gone. Ignoring...
[task 2020-06-06T18:08:47.422Z] 18:08:47     INFO - PID 4000 | [Child 6904: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:366: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for 6f847965202caf04
[task 2020-06-06T18:08:47.422Z] 18:08:47     INFO - PID 4000 | Timecard created 1591466889.861000
[task 2020-06-06T18:08:47.422Z] 18:08:47     INFO - PID 4000 |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2020-06-06T18:08:47.422Z] 18:08:47     INFO - PID 4000 | ======================================================================================================================
[task 2020-06-06T18:08:47.422Z] 18:08:47     INFO - PID 4000 |     0.001000 |    0.001000 | Constructor Completed          | PeerConnectionImpl.cpp:332   | PeerConnectionImpl
[task 2020-06-06T18:08:47.423Z] 18:08:47     INFO - PID 4000 |     0.002000 |    0.001000 | Initializing PC Ctx            | PeerConnectionImpl.cpp:458   | Initialize
[task 2020-06-06T18:08:47.423Z] 18:08:47     INFO - PID 4000 |     0.038000 |    0.036000 | Set Remote Description         | PeerConnectionImpl.cpp:1395  | SetRemoteDescription
[task 2020-06-06T18:08:47.423Z] 18:08:47     INFO - PID 4000 |     0.056000 |    0.018000 | Create Answer                  | PeerConnectionImpl.cpp:1270  | CreateAnswer
[task 2020-06-06T18:08:47.423Z] 18:08:47     INFO - PID 4000 |     0.059000 |    0.003000 | Set Local Description          | PeerConnectionImpl.cpp:1308  | SetLocalDescription
[task 2020-06-06T18:08:47.423Z] 18:08:47     INFO - PID 4000 |     0.074000 |    0.015000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |     0.081000 |    0.007000 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2509  | IceGatheringStateChange
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |     0.084000 |    0.003000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |     0.085000 |    0.001000 | Ice gathering state: complete  | PeerConnectionImpl.cpp:2512  | IceGatheringStateChange
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |     0.089000 |    0.004000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |     0.090000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |     0.091000 |    0.001000 | Add Ice Candidate              | PeerConnectionImpl.cpp:1532  | AddIceCandidate
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |    10.594000 |   10.503000 | Ice state: failed              | PeerConnectionImpl.cpp:2463  | IceConnectionStateChange
[task 2020-06-06T18:08:47.424Z] 18:08:47     INFO - PID 4000 |    37.542000 |   26.948000 | Destructor Invoked             | PeerConnectionImpl.cpp:341   | ~PeerConnectionImpl
[task 2020-06-06T18:08:47.425Z] 18:08:47     INFO - PID 4000 | [Child 6904: Main Thread]: E/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:362: PeerConnectionCtx is already gone. Ignoring...
[task 2020-06-06T18:08:47.425Z] 18:08:47     INFO - PID 4000 | [Child 6904: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:366: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for 8fe3041f1bba5b78
[task 2020-06-06T18:08:47.440Z] 18:08:47     INFO - PID 4000 | [Child 4672, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-06T18:08:47.535Z] 18:08:47     INFO - PID 4000 | [Child 6904, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-06T18:08:47.595Z] 18:08:47     INFO - PID 4000 | [Child 1288, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-06T18:08:47.752Z] 18:08:47     INFO - PID 4000 | [Parent 6004, Main Thread] WARNING: NS_ENSURE_TRUE(mDB) failed: file /builds/worker/checkouts/gecko/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1279
[task 2020-06-06T18:08:47.788Z] 18:08:47     INFO - PID 4000 | [Parent 6004, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp, line 228
[task 2020-06-06T18:08:47.788Z] 18:08:47     INFO - PID 4000 | [Parent 6004, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp, line 255
[task 2020-06-06T18:08:48.409Z] 18:08:48     INFO - PID 4000 | [Parent 6004, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-06-06T18:08:48.556Z] 18:08:48     INFO - Browser exited with return code 0
[task 2020-06-06T18:08:48.556Z] 18:08:48     INFO - PROCESS LEAKS c:\users\task_1591464516\appdata\local\temp\tmpcllkyo\runtests_leaks_1548.log
Pushed by malexandru@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/8de074feb3c8 Update expectation for RTCRtpSender-replaceTrack.https.html on win7 debug. a=fix

Nico, James,
We are seeing perma failing wpt tests that appear after updating their expectations.
(see) https://treeherder.mozilla.org/#/jobs?repo=autoland&group_state=expanded&fromchange=a47141066d20ec88ac1e52040fcbc9175ed713af&searchStr=windows%2C7%2Cdebug%2Cweb%2Cplatform%2Ctests%2Ctest-windows7-32%2Fdebug-web-platform-tests-e10s-4%2Cw%28wpt4%29&tochange=8de074feb3c80fc1b867cdd6f2c5e061c6b104c3

Initially the expectancies for https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=305335803&repo=autoland&lineNumber=15155
were updated in https://hg.mozilla.org/integration/autoland/rev/fa3520edbda79451389e6dac5b1e581ec2c932b6

After that, these failures started appearing https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=305338175&repo=autoland&lineNumber=15149
which were updated in https://hg.mozilla.org/integration/autoland/rev/8de074feb3c80fc1b867cdd6f2c5e061c6b104c3

And finally created these:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=305345445&repo=autoland&lineNumber=65674

Originally the regressions were caused by Bug 1643452:
https://bugzilla.mozilla.org/show_bug.cgi?id=1643452#a160243_601025

Could you please take a look?

Flags: needinfo?(na-g)
Flags: needinfo?(james)
Summary: Perma TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCRtpSender-replaceTrack.https.html | ReplaceTrack transmits the new track not the old track - Test timed out | expected OK → Perma TEST-UNEXPECTED-<fail>| /webrtc/webrtc/RTCRtpTransceiver.https.html | <random_fail>

https://hg.mozilla.org/mozilla-central/rev/8de074feb3c8

Status: NEW → RESOLVED
Closed: 5 years ago
status-firefox79: --- → fixed
Resolution: --- → FIXED
Target Milestone: --- → mozilla79
Status: RESOLVED → REOPENED
status-firefox79: fixed → ---
Resolution: FIXED → ---
Target Milestone: mozilla79 → ---

Another win32-debug WebRTC problem.

Flags: needinfo?(james) → needinfo?(docfaraday)

Maybe caused by the same thing that caused bug 1641974 (ie; mDNS lookups taking forever)? I'll investigate over in bug 1643058.

Assignee: nobody → docfaraday
Severity: -- → S3
Component: web-platform-tests → WebRTC: Networking
Flags: needinfo?(docfaraday)
Priority: -- → P3
Product: Testing → Core
See Also: → 1643058, 1641974

The failure changed files this time:
https://treeherder.mozilla.org/#/jobs?repo=autoland&group_state=expanded&fromchange=f05a0084c5f20abf47fa332ab5ec5c953ba48eb1&searchStr=windows%2C7%2Cdebug%2Cweb%2Cplatform%2Ctests%2Ctest-windows7-32%2Fdebug-web-platform-tests-e10s-4%2Cw%28wpt4%29&tochange=4fdcaa5d6ec3368c91b8639bcc73b29425fc05ec

Now failing on RTCRtpReceiver-getSynchronizationSources.https.html as well.

Should we modify the summary to represent all the wpt perma failures on Windows 7 debug? (since there are a couple of duplicates if that's the case)

Flags: needinfo?(docfaraday)

Yes, let's do that, because I think there is a common cause here.

Flags: needinfo?(docfaraday)
Summary: Perma TEST-UNEXPECTED-<fail>| /webrtc/webrtc/RTCRtpTransceiver.https.html | <random_fail> → Perma TEST-UNEXPECTED-<fail>| /webrtc/webrtc/<test>.https.html | <random_fail>
Summary: Perma TEST-UNEXPECTED-<fail>| /webrtc/webrtc/<test>.https.html | <random_fail> → Perma wpt win32-debug WebRTC TEST-UNEXPECTED-<fail>| /webrtc/webrtc/<test>.https.html | <random_fail>

Patches on bug 1643058 might solve this.

See Also: → 1645663

Please wait until bug 1643058 lands before messing with the expectations on this.

Status: REOPENED → RESOLVED
Closed: 5 years ago → 5 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.