1738913 - Intermittent TEST-UNEXPECTED-TIMEOUT | /video-rvfc/request-video-frame-callback-webrtc.https.html | expected ERROR

Reporter

Description

•

3 years ago

treeherder

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

Andreas Pehrson [:pehrsons]

Comment 1

•

3 years ago

Tests are run concurrently here but these lines look interesting:

[task 2021-11-01T16:16:59.893Z] 16:16:59 [task 2021-11-01T16:16:59.894Z] 16:16:59 [task 2021-11-01T16:16:59.895Z] 16:16:59 [task 2021-11-01T16:16:59.895Z] 16:16:59 [task 2021-11-01T16:16:59.898Z] 16:16:59 [task 2021-11-01T16:16:59.899Z] 16:16:59 [task 2021-11-01T16:16:59.914Z] 16:16:59 [task 2021-11-01T16:16:59.914Z] 16:16:59 [task 2021-11-01T16:16:59.915Z] 16:16:59 [task 2021-11-01T16:16:59.915Z] 16:16:59 [task 2021-11-01T16:16:59.916Z] 16:16:59 [task 2021-11-01T16:16:59.917Z] 16:16:59 [task 2021-11-01T16:16:59.917Z] 16:16:59 [task 2021-11-01T16:16:59.918Z] 16:16:59 [task 2021-11-01T16:16:59.919Z] 16:16:59 [task 2021-11-01T16:16:59.920Z] 16:16:59 [task 2021-11-01T16:16:59.920Z] 16:16:59 [task 2021-11-01T16:16:59.921Z] 16:16:59 [task 2021-11-01T16:16:59.922Z] 16:16:59 [task 2021-11-01T16:16:59.923Z] 16:16:59 [task 2021-11-01T16:16:59.924Z] 16:16:59 [task 2021-11-01T16:16:59.924Z] 16:16:59 [task 2021-11-01T16:16:59.925Z] 16:16:59 [task 2021-11-01T16:16:59.926Z] 16:16:59 [task 2021-11-01T16:16:59.927Z] 16:16:59 [task 2021-11-01T16:16:59.927Z] 16:16:59 [task 2021-11-01T16:16:59.928Z] 16:16:59 [task 2021-11-01T16:16:59.929Z] 16:16:59 [task 2021-11-01T16:16:59.930Z] 16:16:59 [task 2021-11-01T16:16:59.931Z] 16:16:59 [task 2021-11-01T16:16:59.931Z] 16:16:59 [task 2021-11-01T16:16:59.932Z] 16:16:59 [task 2021-11-01T16:16:59.933Z] 16:16:59 [task 2021-11-01T16:16:59.933Z] 16:16:59 [task 2021-11-01T16:16:59.935Z] 16:16:59 [task 2021-11-01T16:16:59.938Z] 16:16:59 [task 2021-11-01T16:16:59.939Z] 16:16:59 [task 2021-11-01T16:16:59.940Z] 16:16:59 [task 2021-11-01T16:16:59.941Z] 16:16:59 [task 2021-11-01T16:16:59.942Z] 16:16:59 [task 2021-11-01T16:16:59.943Z] 16:16:59 [task 2021-11-01T16:16:59.944Z] 16:16:59 [task 2021-11-01T16:16:59.945Z] 16:16:59 [task 2021-11-01T16:16:59.946Z] 16:16:59 [task 2021-11-01T16:16:59.947Z] 16:16:59 [task 2021-11-01T16:16:59.948Z] 16:16:59 [task 2021-11-01T16:16:59.949Z] 16:16:59 [task 2021-11-01T16:16:59.950Z] 16:16:59 [task 2021-11-01T16:16:59.951Z] 16:16:59 [task 2021-11-01T16:16:59.952Z] 16:16:59 [task 2021-11-01T16:16:59.953Z] 16:16:59 [task 2021-11-01T16:16:59.954Z] 16:16:59 [task 2021-11-01T16:16:59.955Z] 16:16:59 [task 2021-11-01T16:16:59.955Z] 16:16:59 [task 2021-11-01T16:16:59.956Z] 16:16:59 [task 2021-11-01T16:16:59.957Z] 16:16:59 [task 2021-11-01T16:16:59.958Z] 16:16:59 [task 2021-11-01T16:16:59.959Z] 16:16:59 [task 2021-11-01T16:16:59.960Z] 16:16:59 [task 2021-11-01T16:16:59.960Z] 16:16:59 [task 2021-11-01T16:16:59.961Z] 16:16:59 [task 2021-11-01T16:16:59.962Z] 16:16:59 [task 2021-11-01T16:16:59.963Z] 16:16:59 [task 2021-11-01T16:16:59.963Z] 16:16:59 [task 2021-11-01T16:16:59.964Z] 16:16:59 [task 2021-11-01T16:16:59.965Z] 16:16:59 [task 2021-11-01T16:16:59.965Z] 16:16:59 [task 2021-11-01T16:16:59.966Z] 16:16:59 [task 2021-11-01T16:16:59.967Z] 16:16:59 [task 2021-11-01T16:16:59.967Z] 16:16:59 [task 2021-11-01T16:16:59.968Z] 16:16:59 [task 2021-11-01T16:16:59.969Z] 16:16:59 [task 2021-11-01T16:16:59.969Z] 16:16:59 [task 2021-11-01T16:16:59.970Z] 16:16:59 [task 2021-11-01T16:16:59.971Z] 16:16:59 [task 2021-11-01T16:16:59.971Z] 16:16:59 [task 2021-11-01T16:16:59.972Z] 16:16:59 [task 2021-11-01T16:16:59.973Z] 16:16:59 [task 2021-11-01T16:16:59.973Z] 16:16:59 [task 2021-11-01T16:16:59.974Z] 16:16:59 [task 2021-11-01T16:16:59.974Z] 16:16:59 [task 2021-11-01T16:16:59.975Z] 16:16:59 [task 2021-11-01T16:16:59.976Z] 16:16:59 [task 2021-11-01T16:16:59.976Z] 16:16:59 [task 2021-11-01T16:16:59.977Z] 16:16:59 [task 2021-11-01T16:16:59.978Z] 16:16:59 [task 2021-11-01T16:16:59.978Z] 16:16:59 [task 2021-11-01T16:16:59.979Z] 16:16:59 [task 2021-11-01T16:16:59.979Z] 16:16:59 [task 2021-11-01T16:16:59.980Z] 16:16:59 [task 2021-11-01T16:16:59.980Z] 16:16:59 [task 2021-11-01T16:16:59.981Z] 16:16:59 [task 2021-11-01T16:16:59.982Z] 16:16:59 [task 2021-11-01T16:16:59.982Z] 16:16:59 [task 2021-11-01T16:16:59.983Z] 16:16:59 [task 2021-11-01T16:16:59.983Z] 16:16:59 [task 2021-11-01T16:16:59.984Z] 16:16:59 [task 2021-11-01T16:16:59.984Z] 16:16:59 [task 2021-11-01T16:16:59.985Z] 16:16:59 [task 2021-11-01T16:16:59.985Z] 16:16:59 [task 2021-11-01T16:16:59.986Z] 16:16:59 [task 2021-11-01T16:16:59.987Z] 16:16:59 [task 2021-11-01T16:16:59.988Z] 16:16:59 [task 2021-11-01T16:16:59.989Z] 16:16:59 [task 2021-11-01T16:16:59.989Z] 16:16:59 [task 2021-11-01T16:16:59.990Z] 16:16:59 [task 2021-11-01T16:16:59.991Z] 16:16:59 [task 2021-11-01T16:16:59.991Z] 16:16:59 [task 2021-11-01T16:16:59.991Z] 16:16:59 [task 2021-11-01T16:16:59.992Z] 16:16:59 [task 2021-11-01T16:16:59.993Z] 16:16:59 [task 2021-11-01T16:16:59.993Z] 16:16:59 [task 2021-11-01T16:16:59.994Z] 16:16:59 [task 2021-11-01T16:16:59.994Z] 16:16:59 [task 2021-11-01T16:16:59.995Z] 16:16:59 [task 2021-11-01T16:16:59.996Z] 16:16:59 [task 2021-11-01T16:17:00.006Z] 16:17:00 [task 2021-11-01T16:17:00.008Z] 16:17:00 [task 2021-11-01T16:17:00.008Z] 16:17:00 [task 2021-11-01T16:17:00.013Z] 16:17:00 INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:332: PeerConnectionImpl: PeerConnectionImpl constructor for
INFO - PID 2033 | (unknown/INFO) insert '' (registry) succeeded:
INFO - PID 2033 | (registry/INFO) Initialized registry
INFO - PID 2033 | [Parent 2033: Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:332: PeerConnectionImpl: PeerConnectionImpl constructor for
INFO - PID 2033 | [Parent 2033: Socket Thread]: D/mtransport NrIceCtx static call to find local stun addresses
INFO - PID 2033 | (registry/INFO) insert 'ice' (registry) succeeded: ice
INFO - PID 2033 | (registry/INFO) insert 'ice.pref' (registry) succeeded: ice.pref
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type' (registry) succeeded: ice.pref.type
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.srv_rflx' (UCHAR) succeeded: 0x64
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.peer_rflx' (UCHAR) succeeded: 0x6e
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:76: OnStunAddrsAvailable: receiving (11) stun addrs
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.host' (UCHAR) succeeded: 0x7e
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.relayed' (UCHAR) succeeded: 0x05
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.srv_rflx_tcp' (UCHAR) succeeded: 0x63
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.peer_rflx_tcp' (UCHAR) succeeded: 0x6d
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.host_tcp' (UCHAR) succeeded: 0x7d
INFO - PID 2033 | (registry/INFO) insert 'ice.pref.type.relayed_tcp' (UCHAR) succeeded: 0x00
INFO - PID 2033 | (registry/INFO) insert 'stun' (registry) succeeded: stun
INFO - PID 2033 | (registry/INFO) insert 'stun.client' (registry) succeeded: stun.client
INFO - PID 2033 | (registry/INFO) insert 'stun.client.maximum_transmits' (UINT4) succeeded: 7
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|PeerConnectionMedia] PeerConnectionMedia.cpp:76: OnStunAddrsAvailable: receiving (11) stun addrs
INFO - PID 2033 | (registry/INFO) insert 'ice.trickle_grace_period' (UINT4) succeeded: 5000
INFO - PID 2033 | (registry/INFO) insert 'ice.tcp' (registry) succeeded: ice.tcp
INFO - PID 2033 | (registry/INFO) insert 'ice.tcp.so_sock_count' (INT4) succeeded: 0
INFO - PID 2033 | (registry/INFO) insert 'ice.tcp.listen_backlog' (INT4) succeeded: 10
INFO - PID 2033 | (registry/INFO) insert 'ice.tcp.disable' (char) succeeded: \000
INFO - PID 2033 | (registry/INFO) insert 'ice.forced_interface_name' (string) succeeded:
INFO - PID 2033 | (registry/INFO) insert 'ice.udp' (registry) succeeded: ice.udp
INFO - PID 2033 | (registry/INFO) insert 'ice.udp.use_nr_resolver' (char) succeeded: \001
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 11492d350
INFO - PID 2033 | [Child 2045: Main Thread]: I/jsep [{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi]: stable -> have-local-offer
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 11492d580
INFO - PID 2033 | [Child 2045: Main Thread]: I/jsep [{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi]: stable -> have-remote-offer
INFO - PID 2033 | [Parent 2033, Socket Thread] WARNING: Cannot PR_Connect: file /builds/worker/checkouts/gecko/netwerk/base/nsUDPSocket.cpp:655
INFO - PID 2033 | [Parent 2033, Socket Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:294
INFO - PID 2033 | (generic/ERR) UDP socket error:Internal error at /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:249 this=0x114647400
INFO - PID 2033 | (ice/ERR) ICE(PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): failed to find default addresses
INFO - PID 2033 | (generic/ERR) getifaddrs error e = 1
INFO - PID 2033 | [Child 2045: Socket Thread]: E/mtransport ICE FAILED: Couldn't gather ICE candidates for 'PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi', error=3
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport NrIceCtx(PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): state 0->4
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport NrIceCtx(PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): dumping r_log ringbuffer...
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice' (registry) succeeded: ice
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref' (registry) succeeded: ice.pref
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type' (registry) succeeded: ice.pref.type
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.srv_rflx' (UCHAR) succeeded: 0x64
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.peer_rflx' (UCHAR) succeeded: 0x6e
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.host' (UCHAR) succeeded: 0x7e
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.relayed' (UCHAR) succeeded: 0x05
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.srv_rflx_tcp' (UCHAR) succeeded: 0x63
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.peer_rflx_tcp' (UCHAR) succeeded: 0x6d
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.host_tcp' (UCHAR) succeeded: 0x7d
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.relayed_tcp' (UCHAR) succeeded: 0x00
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'stun' (registry) succeeded: stun
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'stun.client' (registry) succeeded: stun.client
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'stun.client.maximum_transmits' (UINT4) succeeded: 7
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.trickle_grace_period' (UINT4) succeeded: 5000
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp' (registry) succeeded: ice.tcp
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp.so_sock_count' (INT4) succeeded: 0
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp.listen_backlog' (INT4) succeeded: 10
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp.disable' (char) succeeded: \000
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.forced_interface_name' (string) succeeded:
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.udp' (registry) succeeded: ice.udp
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.udp.use_nr_resolver' (char) succeeded: \001
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (generic/ERR) UDP socket error:Internal error at /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:249 this=114647400
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): failed to find default addresses
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (generic/ERR) getifaddrs error e = 1
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 11492d9e0
INFO - PID 2033 | [Child 2045: Main Thread]: I/jsep [{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi]: have-remote-offer -> stable
INFO - PID 2033 | [Parent 2033, Socket Thread] WARNING: Cannot PR_Connect: file /builds/worker/checkouts/gecko/netwerk/base/nsUDPSocket.cpp:655
INFO - PID 2033 | [Parent 2033, Socket Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:294
INFO - PID 2033 | (generic/ERR) UDP socket error:Internal error at /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:249 this=0x114647400
INFO - PID 2033 | (ice/ERR) ICE(PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): failed to find default addresses
INFO - PID 2033 | [Child 2045: Main Thread]: I/signaling [main|sdp_config] sdp_config.c:86: SDP: Initialized config pointer: 11492dcf0
INFO - PID 2033 | (generic/ERR) getifaddrs error e = 1
INFO - PID 2033 | [Child 2045: Socket Thread]: E/mtransport ICE FAILED: Couldn't gather ICE candidates for 'PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi', error=3
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport NrIceCtx(PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): state 0->4
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport NrIceCtx(PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): dumping r_log ringbuffer...
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice' (registry) succeeded: ice
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref' (registry) succeeded: ice.pref
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type' (registry) succeeded: ice.pref.type
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.srv_rflx' (UCHAR) succeeded: 0x64
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.peer_rflx' (UCHAR) succeeded: 0x6e
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.host' (UCHAR) succeeded: 0x7e
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.relayed' (UCHAR) succeeded: 0x05
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.srv_rflx_tcp' (UCHAR) succeeded: 0x63
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.peer_rflx_tcp' (UCHAR) succeeded: 0x6d
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.host_tcp' (UCHAR) succeeded: 0x7d
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.pref.type.relayed_tcp' (UCHAR) succeeded: 0x00
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'stun' (registry) succeeded: stun
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'stun.client' (registry) succeeded: stun.client
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'stun.client.maximum_transmits' (UINT4) succeeded: 7
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.trickle_grace_period' (UINT4) succeeded: 5000
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp' (registry) succeeded: ice.tcp
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp.so_sock_count' (INT4) succeeded: 0
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp.listen_backlog' (INT4) succeeded: 10
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.tcp.disable' (char) succeeded: \000
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.forced_interface_name' (string) succeeded:
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.udp' (registry) succeeded: ice.udp
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (registry/INFO) insert 'ice.udp.use_nr_resolver' (char) succeeded: \001
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (generic/ERR) UDP socket error:Internal error at /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:249 this=114647400
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): failed to find default addresses
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (generic/ERR) getifaddrs error e = 1
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (generic/ERR) UDP socket error:Internal error at /builds/worker/checkouts/gecko/dom/network/UDPSocketParent.cpp:249 this=114647400
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): failed to find default addresses
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport (generic/ERR) getifaddrs error e = 1
INFO - PID 2033 | [Child 2045: Main Thread]: I/jsep [{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi]: have-local-offer -> stable
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport Setting up DTLS as client
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport Setting DTLS1.3 supported_versions workaround
INFO - PID 2033 | [Child 2045: Socket Thread]: E/mtransport Couldn't disable 'PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi transport-id=transport_0':2
INFO - PID 2033 | [Child 2045: Socket Thread]: E/mtransport ICE FAILED: Couldn't pair candidates on PC:{6039ddc3-bf6d-409f-8d5a-1c4b73684c43} 1635783419897348 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi
INFO - PID 2033 | [Child 2045: Socket Thread]: E/signaling [Socket Thread|MediaTransportHandler] MediaTransportHandler.cpp:934: operator(): couldn't start checks
INFO - PID 2033 | [Child 2045: Socket Thread]: D/mtransport Setting up DTLS as server
INFO - PID 2033 | [Child 2045: Socket Thread]: E/mtransport ICE FAILED: Couldn't pair candidates on PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi
INFO - PID 2033 | [Child 2045: Socket Thread]: E/signaling [Socket Thread|MediaTransportHandler] MediaTransportHandler.cpp:934: operator(): couldn't start checks
INFO - PID 2033 | (ice/WARNING) ICE(PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi): peer (PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi:default) has no stream matching stream PC:{5f0d5cd7-f99a-49c1-a8fe-19f40f6520fd} 1635783419893409 (id=6442450958 url=https://web-platform.test:8443/video-rvfc/request-vi transport-id=transport_1 - c5711d2d:e6b6a34621b347b91b5b6298393bc8bd
INFO - PID 2033 | [Child 2045: libwebrtcModuleThread]: E/signaling [libwebrtcModuleThread|WebrtcAudioSessionConduit] AudioConduit.cpp:668: AudioConduit 114bfdb00: RTCP RR Packet Send Failed
INFO - PID 2033 | [Child 2045: libwebrtcModuleThread]: E/signaling [libwebrtcModuleThread|WebrtcVideoSessionConduit] VideoConduit.cpp:1661: VideoConduit 114bd7400: RTCP RR Packet Send Failed
INFO - PID 2033 | [Child 2045: libwebrtcModuleThread]: E/signaling [libwebrtcModuleThread|WebrtcAudioSessionConduit] AudioConduit.cpp:668: AudioConduit 11462eb00: RTCP RR Packet Send Failed
INFO - PID 2033 | [Child 2045: libwebrtcModuleThread]: E/signaling [libwebrtcModuleThread|WebrtcVideoSessionConduit] VideoConduit.cpp:1661: VideoConduit 114bd6800: RTCP RR Packet Send Failed

An ICE gathering problem?

BugBot [:suhaib / :marco/ :calixte]

Comment 2

•

3 years ago

Set release status flags based on info from the regressing bug 1654112

status-firefox94: --- → unaffected

status-firefox95: --- → unaffected

status-firefox96: --- → affected

status-firefox-esr91: --- → unaffected

Comment hidden (Intermittent Failures Robot)

BugBot [:suhaib / :marco/ :calixte]

Comment 4

•

3 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED

Closed: 3 years ago

Resolution: --- → INCOMPLETE

BMO Automation

Updated

•

3 years ago

Has Regression Range: --- → yes

Treeherder Bug Filer

Reporter

Comment 5

•

2 years ago

treeherder

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=373721707&repo=try

Status: RESOLVED → REOPENED

Resolution: INCOMPLETE → ---

Comment hidden (Intermittent Failures Robot)

BugBot [:suhaib / :marco/ :calixte]

Comment 7

•

2 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: REOPENED → RESOLVED

Closed: 3 years ago → 2 years ago

Resolution: --- → INCOMPLETE

Treeherder Bug Filer

Reporter

Comment 8

•

2 years ago

treeherder

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=384378173&repo=autoland

Status: RESOLVED → REOPENED

Resolution: INCOMPLETE → ---

Comment hidden (Intermittent Failures Robot)

BugBot [:suhaib / :marco/ :calixte]

Comment 10

•

2 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: REOPENED → RESOLVED

Closed: 2 years ago → 2 years ago

Resolution: --- → INCOMPLETE

Bugzilla

Quick Search

Intermittent TEST-UNEXPECTED-TIMEOUT | /video-rvfc/request-video-frame-callback-webrtc.https.html | expected ERROR

Categories

(Core :: WebRTC, defect, P5)

Tracking

()

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Crash Data

Security

(public)

User Story

Description

Comment 1

Comment 2

Comment 3

Comment 4

Updated

Comment 5

Comment 6

Comment 7

Comment 8

Comment 9

Comment 10