Closed
Bug 1808493
Opened 3 years ago
Closed 3 years ago
Intermittent /webrtc/protocol/ice-ufragpwd.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: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=401301826&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/LTcAzxuWTOaymuSmm3NGPA/runs/0/artifacts/public/logs/live_backing.log
[task 2023-01-04T07:07:13.104Z] 07:07:13 INFO - ...
[task 2023-01-04T07:07:13.104Z] 07:07:13 INFO - TEST-OK | /webrtc/protocol/ice-state.https.html | took 12195ms
[task 2023-01-04T07:07:13.105Z] 07:07:13 INFO - TEST-START | /webrtc/protocol/ice-ufragpwd.html
[task 2023-01-04T07:07:13.107Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(tW6U): setting pair to state WAITING: tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)
[task 2023-01-04T07:07:13.115Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(tW6U): setting pair to state CANCELLED: tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)
[task 2023-01-04T07:07:13.116Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(YFZd): triggered check on YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.117Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(YFZd): setting pair to state FROZEN: YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.118Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/CAND-PAIR(YFZd): Pairing candidate IP4:172.17.0.4:56029/UDP (7e7e00ff):IP4:172.17.0.4:58489/UDP (7e7e00ff) priority=9114723795305497087 (7e7e00fffcfc01ff)
[task 2023-01-04T07:07:13.119Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) CAND-PAIR(YFZd): Adding pair to check list and trigger check queue: YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.120Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(YFZd): setting pair to state WAITING: YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.121Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(YFZd): setting pair to state CANCELLED: YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.132Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (stun/INFO) STUN-CLIENT(YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)): Received response; processing
[task 2023-01-04T07:07:13.136Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(YFZd): setting pair to state SUCCEEDED: YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.137Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 535595e9:07cd15973e32032bfc886023aaa7468e)/COMP(1)/CAND-PAIR(YFZd): nominated pair is YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.137Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 535595e9:07cd15973e32032bfc886023aaa7468e)/COMP(1)/CAND-PAIR(YFZd): cancelling all pairs but YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.138Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 535595e9:07cd15973e32032bfc886023aaa7468e)/COMP(1)/CAND-PAIR(YFZd): cancelling FROZEN/WAITING pair YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host) in trigger check queue because CAND-PAIR(YFZd) was nominated.
[task 2023-01-04T07:07:13.138Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(YFZd): setting pair to state CANCELLED: YFZd|IP4:172.17.0.4:56029/UDP|IP4:172.17.0.4:58489/UDP(host(IP4:172.17.0.4:56029/UDP)|candidate:0 1 UDP 2122187007 172.17.0.4 58489 typ host)
[task 2023-01-04T07:07:13.138Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 535595e9:07cd15973e32032bfc886023aaa7468e)/COMP(1)/CAND-PAIR(XBhG): cancelling FROZEN/WAITING pair XBhG|IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:41311/UDP|IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:37420/UDP(host(IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:41311/UDP)|candidate:1 1 UDP 2122252543 fd15:4ba5:5a2b:100a:0:242:ac11:4 37420 typ host) because CAND-PAIR(YFZd) was nominated.
[task 2023-01-04T07:07:13.139Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(XBhG): setting pair to state CANCELLED: XBhG|IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:41311/UDP|IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:37420/UDP(host(IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:41311/UDP)|candidate:1 1 UDP 2122252543 fd15:4ba5:5a2b:100a:0:242:ac11:4 37420 typ host)
[task 2023-01-04T07:07:13.140Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/ICE-STREAM(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 535595e9:07cd15973e32032bfc886023aaa7468e): all active components have nominated candidate pairs
[task 2023-01-04T07:07:13.140Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default): all checks completed success=1 fail=0
[task 2023-01-04T07:07:13.141Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) cancelling grace period timer
[task 2023-01-04T07:07:13.142Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (stun/INFO) STUN-CLIENT(tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)): Received response; processing
[task 2023-01-04T07:07:13.142Z] 07:07:13 INFO - Setting pref media.navigator.permission.disabled to true
[task 2023-01-04T07:07:13.142Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(tW6U): setting pair to state SUCCEEDED: tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)
[task 2023-01-04T07:07:13.143Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 8029835d:585b323bb2257335c3c423aa63e683b2)/COMP(1)/CAND-PAIR(tW6U): nominated pair is tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)
[task 2023-01-04T07:07:13.152Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 8029835d:585b323bb2257335c3c423aa63e683b2)/COMP(1)/CAND-PAIR(tW6U): cancelling all pairs but tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)
[task 2023-01-04T07:07:13.153Z] 07:07:13 INFO - Setting pref media.navigator.streams.fake to true
[task 2023-01-04T07:07:13.153Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 8029835d:585b323bb2257335c3c423aa63e683b2)/COMP(1)/CAND-PAIR(tW6U): cancelling FROZEN/WAITING pair tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx) in trigger check queue because CAND-PAIR(tW6U) was nominated.
[task 2023-01-04T07:07:13.154Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(tW6U): setting pair to state CANCELLED: tW6U|IP4:172.17.0.4:58489/UDP|IP4:172.17.0.4:56029/UDP(host(IP4:172.17.0.4:58489/UDP)|prflx)
[task 2023-01-04T07:07:13.155Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/ICE-STREAM(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 8029835d:585b323bb2257335c3c423aa63e683b2): all active components have nominated candidate pairs
[task 2023-01-04T07:07:13.156Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default): all checks completed success=1 fail=0
[task 2023-01-04T07:07:13.161Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) cancelling grace period timer
[task 2023-01-04T07:07:13.163Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default), stream(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 8029835d:585b323bb2257335c3c423aa63e683b2) tried to trickle ICE in inappropriate state 4
[task 2023-01-04T07:07:13.164Z] 07:07:13 INFO - Setting pref privacy.resistFingerprinting.reduceTimerPrecision.jitter to true
[task 2023-01-04T07:07:13.165Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default), stream(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 8029835d:585b323bb2257335c3c423aa63e683b2) tried to trickle ICE in inappropriate state 4
[task 2023-01-04T07:07:13.166Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (generic/INFO) Exit UDP socket connected
[task 2023-01-04T07:07:13.167Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/WARNING) /builds/worker/checkouts/gecko/dom/media/webrtc/transport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:639 function nr_socket_multi_tcp_listen failed with error 3
[task 2023-01-04T07:07:13.169Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/WARNING) ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): failed to create passive TCP host candidate: 3
[task 2023-01-04T07:07:13.170Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/WARNING) /builds/worker/checkouts/gecko/dom/media/webrtc/transport/third_party/nICEr/src/net/nr_socket_multi_tcp.c:639 function nr_socket_multi_tcp_listen failed with error 3
[task 2023-01-04T07:07:13.171Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/WARNING) ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): failed to create passive TCP host candidate: 3
[task 2023-01-04T07:07:13.172Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) starting grace period timer for 10000 ms
[task 2023-01-04T07:07:13.174Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/NOTICE) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) no streams with non-empty check lists
[task 2023-01-04T07:07:13.174Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/NOTICE) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) no streams with pre-answer requests
[task 2023-01-04T07:07:13.175Z] 07:07:13 INFO - Setting pref privacy.reduceTimerPrecision to true
[task 2023-01-04T07:07:13.176Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) no checks to start, but gathering is not done yet, cancelling grace period timer
[task 2023-01-04T07:07:13.177Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) starting grace period timer for 10000 ms
[task 2023-01-04T07:07:13.178Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): Starting check timer for stream.
[task 2023-01-04T07:07:13.178Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default): no FROZEN/WAITING pairs for PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9
[task 2023-01-04T07:07:13.179Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/NOTICE) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) is now checking
[task 2023-01-04T07:07:13.180Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) pairing local trickle ICE candidate host(IP4:172.17.0.4:51654/UDP)
[task 2023-01-04T07:07:13.181Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(hqxl): setting pair to state FROZEN: hqxl|IP4:172.17.0.4:51654/UDP|IP4:203.0.113.100:10100/UDP(host(IP4:172.17.0.4:51654/UDP)|candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host)
[task 2023-01-04T07:07:13.181Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/CAND-PAIR(hqxl): Pairing candidate IP4:172.17.0.4:51654/UDP (7e7e00ff):IP4:203.0.113.100:10100/UDP (7e0000ff) priority=9079257948239954430 (7e0000fffcfc01fe)
[task 2023-01-04T07:07:13.182Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): Starting check timer for stream.
[task 2023-01-04T07:07:13.183Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(hqxl): setting pair to state WAITING: hqxl|IP4:172.17.0.4:51654/UDP|IP4:203.0.113.100:10100/UDP(host(IP4:172.17.0.4:51654/UDP)|candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host)
[task 2023-01-04T07:07:13.184Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(hqxl): setting pair to state IN_PROGRESS: hqxl|IP4:172.17.0.4:51654/UDP|IP4:203.0.113.100:10100/UDP(host(IP4:172.17.0.4:51654/UDP)|candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host)
[task 2023-01-04T07:07:13.185Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) pairing local trickle ICE candidate host(IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:47603/UDP)
[task 2023-01-04T07:07:13.185Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) pairing local trickle ICE candidate host(IP4:172.17.0.4:56630/TCP) active
[task 2023-01-04T07:07:13.186Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) pairing local trickle ICE candidate host(IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:49204/TCP) active
[task 2023-01-04T07:07:13.187Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): All candidates initialized
[task 2023-01-04T07:07:13.188Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default): no FROZEN/WAITING pairs for PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9
[task 2023-01-04T07:07:13.189Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): peer (PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default) Trickle grace period is over; marking every component with only failed pairs as failed.
[task 2023-01-04T07:07:13.189Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (stun/INFO) STUN-CLIENT(hqxl|IP4:172.17.0.4:51654/UDP|IP4:203.0.113.100:10100/UDP(host(IP4:172.17.0.4:51654/UDP)|candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host)): Timed out
[task 2023-01-04T07:07:13.190Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/CAND-PAIR(hqxl): setting pair to state FAILED: hqxl|IP4:172.17.0.4:51654/UDP|IP4:203.0.113.100:10100/UDP(host(IP4:172.17.0.4:51654/UDP)|candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host)
[task 2023-01-04T07:07:13.191Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9)/COMP(1): All pairs are failed, and grace period has elapsed. Marking component as failed.
[task 2023-01-04T07:07:13.192Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): state dump
[task 2023-01-04T07:07:13.194Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): Local component 1 - dumping candidates
[task 2023-01-04T07:07:13.195Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9)/CAND(srsy): host(IP4:172.17.0.4:51654/UDP)
[task 2023-01-04T07:07:13.195Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9)/CAND(Avfn): host(IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:47603/UDP)
[task 2023-01-04T07:07:13.196Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9)/CAND(jeP2): host(IP4:172.17.0.4:56630/TCP) active
[task 2023-01-04T07:07:13.197Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9)/CAND(10bz): host(IP6:[fd15:4ba5:5a2b:100a:0:242:ac11:4]:49204/TCP) active
[task 2023-01-04T07:07:13.198Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default)/STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): state dump
[task 2023-01-04T07:07:13.199Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) CAND-PAIR(hqxl): pair hqxl|IP4:172.17.0.4:51654/UDP|IP4:203.0.113.100:10100/UDP(host(IP4:172.17.0.4:51654/UDP)|candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host): state=FAILED, priority=0x7e0000fffcfc01fe
[task 2023-01-04T07:07:13.200Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9): Remote component 1 in state 3 - dumping candidates
[task 2023-01-04T07:07:13.201Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport (ice/ERR) ICE(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-)/ICE-STREAM(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0 - 7a9e8375:22e857dae0af0a0c0309b7868a3886d9)/CAND(z8l1): candidate:1 1 udp 2113929471 203.0.113.100 10100 typ host
[task 2023-01-04T07:07:13.201Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: D/mtransport Flow[transport_0(none)]; Layer[ice]: ICE Failed(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice- transport-id=transport_0,1)
[task 2023-01-04T07:07:13.202Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: E/mtransport /builds/worker/checkouts/gecko/dom/media/webrtc/transport/transportlayerice.cpp:145: Flow[transport_0(none)]; Layer[ice]: state 1->5
[task 2023-01-04T07:07:13.203Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: E/mtransport Flow[transport_0(none)]; Layer[dtls]: Lower layer experienced an error
[task 2023-01-04T07:07:13.203Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: E/mtransport /builds/worker/checkouts/gecko/dom/media/webrtc/transport/transportlayerdtls.cpp:869: Flow[transport_0(none)]; Layer[dtls]: state 1->5
[task 2023-01-04T07:07:13.204Z] 07:07:13 INFO - PID 9543 | [Child 10250: Socket Thread]: E/mtransport /builds/worker/checkouts/gecko/dom/media/webrtc/transport/transportlayersrtp.cpp:173: Flow[transport_0(none)]; Layer[srtp]: state 1->5
[task 2023-01-04T07:07:13.204Z] 07:07:13 INFO - PID 9543 | (ice/INFO) ICE-PEER(PC:{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-:default): all checks completed success=0 fail=1
[task 2023-01-04T07:07:13.205Z] 07:07:13 INFO - PID 9543 | [Child 10250: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2248: Close: Closing PeerConnectionImpl {6164292a-fd2b-49eb-89c9-d32412fea072}; ending call
[task 2023-01-04T07:07:13.206Z] 07:07:13 INFO - PID 9543 | [Child 10250: Main Thread]: I/jsep [{6164292a-fd2b-49eb-89c9-d32412fea072} 1672816021887046 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-]: stable -> closed
[task 2023-01-04T07:07:13.206Z] 07:07:13 INFO - PID 9543 | [Child 10250: GraphRunner]: E/signaling [GraphRunner|WebrtcAudioSessionConduit] AudioConduit.cpp:484: GetAudioFrame Engine not Receiving
[task 2023-01-04T07:07:13.224Z] 07:07:13 INFO - PID 9543 | [Child 10250: GraphRunner]: E/signaling [GraphRunner|WebrtcAudioSessionConduit] AudioConduit.cpp:484: GetAudioFrame Engine not Receiving
[task 2023-01-04T07:07:13.226Z] 07:07:13 INFO - Setting pref media.peerconnection.ice.trickle_grace_period to 5000
[task 2023-01-04T07:07:13.226Z] 07:07:13 INFO - Setting pref media.peerconnection.ice.obfuscate_host_addresses to true
[task 2023-01-04T07:07:13.226Z] 07:07:13 INFO - Setting pref media.peerconnection.allow_old_setParameters to true
[task 2023-01-04T07:07:13.226Z] 07:07:13 INFO - Setting pref media.navigator.permission.disabled to true
[task 2023-01-04T07:07:13.226Z] 07:07:13 INFO - Setting pref media.navigator.streams.fake to true
[task 2023-01-04T07:07:13.226Z] 07:07:13 INFO - Setting pref privacy.resistFingerprinting.reduceTimerPrecision.jitter to false
[task 2023-01-04T07:07:13.227Z] 07:07:13 INFO - Setting pref privacy.reduceTimerPrecision to false
[task 2023-01-04T07:07:13.240Z] 07:07:13 INFO - Setting pref media.peerconnection.ice.trickle_grace_period to 10000
[task 2023-01-04T07:07:13.269Z] 07:07:13 INFO - Setting pref media.peerconnection.ice.obfuscate_host_addresses to false
[task 2023-01-04T07:07:13.282Z] 07:07:13 INFO - Setting pref media.peerconnection.allow_old_setParameters to false
[task 2023-01-04T07:07:13.291Z] 07:07:13 INFO - Closing window 6034c522-77f6-49ca-823f-c7fd5c03d239
[task 2023-01-04T07:07:13.451Z] 07:07:13 INFO - PID 9543 | Timecard created 1672816021.885676
[task 2023-01-04T07:07:13.453Z] 07:07:13 INFO - PID 9543 | Timestamp | Delta | Event | File | Function
[task 2023-01-04T07:07:13.455Z] 07:07:13 INFO - PID 9543 | ====================================================================================================================================
[task 2023-01-04T07:07:13.464Z] 07:07:13 INFO - PID 9543 | 0.000540 | 0.000540 | Constructor Completed | PeerConnectionImpl.cpp:367 | PeerConnectionImpl
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.001399 | 0.000859 | Initializing PC Ctx | PeerConnectionImpl.cpp:456 | Initialize
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.006750 | 0.005351 | Set Remote Description | PeerConnectionImpl.cpp:1751 | SetRemoteDescription
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.014234 | 0.007484 | Create Answer | PeerConnectionImpl.cpp:1568 | CreateAnswer
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.014981 | 0.000747 | Set Local Description | PeerConnectionImpl.cpp:1641 | SetLocalDescription
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.017840 | 0.002859 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.019062 | 0.001222 | Ice gathering state: gathering | PeerConnectionImpl.cpp:3056 | IceGatheringStateChange
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.019448 | 0.000386 | Ice state: checking | PeerConnectionImpl.cpp:2980 | IceConnectionStateChange
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.019576 | 0.000128 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.019615 | 0.000039 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.465Z] 07:07:13 INFO - PID 9543 | 0.019755 | 0.000140 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.466Z] 07:07:13 INFO - PID 9543 | 0.019787 | 0.000032 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.466Z] 07:07:13 INFO - PID 9543 | 0.019877 | 0.000090 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.466Z] 07:07:13 INFO - PID 9543 | 0.019906 | 0.000029 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.472Z] 07:07:13 INFO - PID 9543 | 0.019987 | 0.000081 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.477Z] 07:07:13 INFO - PID 9543 | 0.020019 | 0.000032 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.478Z] 07:07:13 INFO - PID 9543 | 0.020109 | 0.000090 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.479Z] 07:07:13 INFO - PID 9543 | 0.020136 | 0.000027 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.480Z] 07:07:13 INFO - PID 9543 | 0.020219 | 0.000083 | Ice gathering state: complete | PeerConnectionImpl.cpp:3059 | IceGatheringStateChange
[task 2023-01-04T07:07:13.480Z] 07:07:13 INFO - PID 9543 | 11.120486 | 11.100267 | Ice state: failed | PeerConnectionImpl.cpp:2990 | IceConnectionStateChange
[task 2023-01-04T07:07:13.481Z] 07:07:13 INFO - PID 9543 | 11.126177 | 0.005691 | Close | PeerConnectionImpl.cpp:2236 | Close
[task 2023-01-04T07:07:13.482Z] 07:07:13 INFO - PID 9543 | 11.564466 | 0.438289 | Destructor Invoked | PeerConnectionImpl.cpp:384 | ~PeerConnectionImpl
[task 2023-01-04T07:07:13.483Z] 07:07:13 INFO - PID 9543 | 11.564467 | 0.000001 | {6164292a-fd2b-49eb-89c9-d32412fea072} | PeerConnectionImpl.cpp:385 | ~PeerConnectionImpl
[task 2023-01-04T07:07:13.484Z] 07:07:13 INFO - PID 9543 | [Child 10250: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:392: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {6164292a-fd2b-49eb-89c9-d32412fea072}
[task 2023-01-04T07:07:13.485Z] 07:07:13 INFO - PID 9543 | Timecard created 1672816021.619041
[task 2023-01-04T07:07:13.485Z] 07:07:13 INFO - PID 9543 | Timestamp | Delta | Event | File | Function
[task 2023-01-04T07:07:13.486Z] 07:07:13 INFO - PID 9543 | =========[Child 10250: Socket Thread]: I/mtransport NrIceCtx(PC:{55d1cce6-c137-43f5-83f5-a60f24715da1} 1672816021619461 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): Destroy
[task 2023-01-04T07:07:13.486Z] 07:07:13 INFO - PID 9543 | ===============================================================================[Child 10250: Socket Thread]: I/mtransport NrIceCtx(PC:{dd307349-01d5-4251-8a32-176472705e2b} 1672816021849637 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): Destroy
[task 2023-01-04T07:07:13.487Z] 07:07:13 INFO - PID 9543 | ============================================
[task 2023-01-04T07:07:13.487Z] 07:07:13 INFO - PID 9543 | 0.000078 | 0.000078 | Constructor Completed | PeerConnectionImpl.cpp:367 | PeerConnectionImpl
[task 2023-01-04T07:07:13.487Z] 07:07:13 INFO - PID 9543 | 0.000443 | 0.000365 | Initializing PC Ctx | PeerConnectionImpl.cpp:456 | Initialize
[task 2023-01-04T07:07:13.488Z] 07:07:13 INFO - PID 9543 | 0.027396 | 0.026953 | Set Remote Description | PeerConnectionImpl.cpp:1751 | SetRemoteDescription
[task 2023-01-04T07:07:13.488Z] 07:07:13 INFO - PID 9543 | 0.039761 | 0.012365 | Create Answer | PeerConnectionImpl.cpp:1568 | CreateAnswer
[task 2023-01-04T07:07:13.489Z] 07:07:13 INFO - PID 9543 | 0.062090 | 0.022329 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.489Z] 07:07:13 INFO - PID 9543 | 0.083207 | 0.021117 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.490Z] 07:07:13 INFO - PID 9543 | 0.088552 | 0.005345 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.490Z] 07:07:13 INFO - PID 9543 | 0.088902 | 0.000350 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.491Z] 07:07:13 INFO - PID 9543 | 0.089045 | 0.000143 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.491Z] 07:07:13 INFO - PID 9543 | 0.089152 | 0.000107 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.492Z] 07:07:13 INFO - PID 9543 | 0.089252 | 0.000100 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.492Z] 07:07:13 INFO - PID 9543 | 0.089350 | 0.000098 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.493Z] 07:07:13 INFO - PID 9543 | 0.089478 | 0.000128 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.493Z] 07:07:13 INFO - PID 9543 | 0.089744 | 0.000266 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:13.494Z] 07:07:13 INFO - PID 9543 | 0.090016 | 0.000272 | Set Local Description | PeerConnectionImpl.cpp:1641 | SetLocalDescription
[task 2023-01-04T07:07:13.495Z] 07:07:13 INFO - PID 9543 | 0.115126 | 0.025110 | Ice gathering state: gathering | PeerConnectionImpl.cpp:3056 | IceGatheringStateChange
[task 2023-01-04T07:07:13.495Z] 07:07:13 INFO - PID 9543 | 0.115326 | 0.000200 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.496Z] 07:07:13 INFO - PID 9543 | 0.115393 | 0.000067 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.496Z] 07:07:13 INFO - PID 9543 | 0.116384 | 0.000991 | Ice state: checking | PeerConnectionImpl.cpp:2980 | IceConnectionStateChange
[task 2023-01-04T07:07:13.497Z] 07:07:13 INFO - PID 9543 | 0.116575 | 0.000191 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.497Z] 07:07:13 INFO - PID 9543 | 0.116634 | 0.000059 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.498Z] 07:07:13 INFO - PID 9543 | 0.117211 | 0.000577 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.498Z] 07:07:13 INFO - PID 9543 | 0.117264 | 0.000053 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.499Z] 07:07:13 INFO - PID 9543 | 0.117642 | 0.000378 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.499Z] 07:07:13 INFO - PID 9543 | 0.117756 | 0.000114 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.500Z] 07:07:13 INFO - PID 9543 | 0.118353 | 0.000597 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:13.501Z] 07:07:13 INFO - PID 9543 | 0.118405 | 0.000052 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:13.501Z] 07:07:13 INFO - PID 9543 | 0.118724 | 0.000319 | Ice gathering state: complete | PeerConnectionImpl.cpp:3059 | IceGatheringStateChange
[task 2023-01-04T07:07:13.502Z] 07:07:13 INFO - PID 9543 | 0.119187 | 0.000463 | Ice state: connected | PeerConnectionImpl.cpp:2983 | IceConnectionStateChange
[task 2023-01-04T07:07:13.502Z] 07:07:13 INFO - PID 9543 | 0.228836 | 0.109649 | Close | PeerConnectionImpl.cpp:2236 | Close
[task 2023-01-04T07:07:13.503Z] 07:07:13 INFO - PID 9543 | 11.833342 | 11.604506 | Destructor Invoked | PeerConnectionImpl.cpp:384 | ~PeerConnectionImpl
[task 2023-01-04T07:07:13.503Z] 07:07:13 INFO - PID 9543 | 11.833342 | 0.000000 | {55d1cce6-c137-43f5-83f5-a60f24715da1} | PeerConnectionImpl.cpp:385 | ~PeerConnectionImpl
[task 2023-01-04T07:07:13.504Z] 07:07:13 INFO - PID 9543 | [Child 10250: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:392: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {55d1cce6-c137-43f5-83f5-a60f24715da1}
[task 2023-01-04T07:07:13.504Z] 07:07:13 INFO - PID 9543 | Timecard created 1672816021.849044
[task 2023-01-04T07:07:17.543Z] 07:07:17 INFO - PID 9543 | Timecard created 1672816021.600242
[task 2023-01-04T07:07:17.544Z] 07:07:17 INFO - PID 9543 | Timestamp | Delta | Event | File | Function
[task 2023-01-04T07:07:17.545Z] 07:07:17 INFO - PID 9543 | [Child 10250: Socket Thread]: I/mtransport NrIceCtx(PC:{4eaae08c-9c08-4c5f-bdbf-592e33f26539} 1672816021602675 (id=17179869190 url=https://web-platform.test:8443/webrtc/protocol/ice-): Destroy
[task 2023-01-04T07:07:17.545Z] 07:07:17 INFO - PID 9543 | ====================================================================================================================================
[task 2023-01-04T07:07:17.546Z] 07:07:17 INFO - PID 9543 | 0.001410 | 0.001410 | Constructor Completed | PeerConnectionImpl.cpp:367 | PeerConnectionImpl
[task 2023-01-04T07:07:17.547Z] 07:07:17 INFO - PID 9543 | 0.002484 | 0.001074 | Initializing PC Ctx | PeerConnectionImpl.cpp:456 | Initialize
[task 2023-01-04T07:07:17.547Z] 07:07:17 INFO - PID 9543 | 0.035326 | 0.032842 | Deferring CreateOffer (not ready) | PeerConnectionImpl.cpp:1519 | CreateOffer
[task 2023-01-04T07:07:17.548Z] 07:07:17 INFO - PID 9543 | 0.035437 | 0.000111 | Create Offer | PeerConnectionImpl.cpp:1531 | CreateOffer
[task 2023-01-04T07:07:17.548Z] 07:07:17 INFO - PID 9543 | 0.042558 | 0.007121 | Set Local Description | PeerConnectionImpl.cpp:1641 | SetLocalDescription
[task 2023-01-04T07:07:17.549Z] 07:07:17 INFO - PID 9543 | 0.062092 | 0.019534 | Ice gathering state: gathering | PeerConnectionImpl.cpp:3056 | IceGatheringStateChange
[task 2023-01-04T07:07:17.549Z] 07:07:17 INFO - PID 9543 | 0.062457 | 0.000365 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.550Z] 07:07:17 INFO - PID 9543 | 0.062529 | 0.000072 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.551Z] 07:07:17 INFO - PID 9543 | 0.063498 | 0.000969 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.552Z] 07:07:17 INFO - PID 9543 | 0.063562 | 0.000064 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.552Z] 07:07:17 INFO - PID 9543 | 0.064146 | 0.000584 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.553Z] 07:07:17 INFO - PID 9543 | 0.064197 | 0.000051 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.554Z] 07:07:17 INFO - PID 9543 | 0.065971 | 0.001774 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.554Z] 07:07:17 INFO - PID 9543 | 0.066861 | 0.000890 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.555Z] 07:07:17 INFO - PID 9543 | 0.067644 | 0.000783 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.555Z] 07:07:17 INFO - PID 9543 | 0.067844 | 0.000200 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.556Z] 07:07:17 INFO - PID 9543 | 0.068571 | 0.000727 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.556Z] 07:07:17 INFO - PID 9543 | 0.068637 | 0.000066 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.557Z] 07:07:17 INFO - PID 9543 | 0.076283 | 0.007646 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.557Z] 07:07:17 INFO - PID 9543 | 0.076369 | 0.000086 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.558Z] 07:07:17 INFO - PID 9543 | 0.077495 | 0.001126 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.559Z] 07:07:17 INFO - PID 9543 | 0.077594 | 0.000099 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.559Z] 07:07:17 INFO - PID 9543 | 0.078111 | 0.000517 | Ice Candidate gathered | PeerConnectionImpl.cpp:2886 | CandidateReady
[task 2023-01-04T07:07:17.560Z] 07:07:17 INFO - PID 9543 | 0.078165 | 0.000054 | Send Ice Candidate to content | PeerConnectionImpl.cpp:2950 | SendLocalIceCandidateToContent
[task 2023-01-04T07:07:17.561Z] 07:07:17 INFO - PID 9543 | 0.078740 | 0.000575 | Ice gathering state: complete | PeerConnectionImpl.cpp:3059 | IceGatheringStateChange
[task 2023-01-04T07:07:17.561Z] 07:07:17 INFO - PID 9543 | 0.097961 | 0.019221 | Set Remote Description | PeerConnectionImpl.cpp:1751 | SetRemoteDescription
[task 2023-01-04T07:07:17.561Z] 07:07:17 INFO - PID 9543 | 0.134937 | 0.036976 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:17.562Z] 07:07:17 INFO - PID 9543 | 0.137846 | 0.002909 | Ice state: checking | PeerConnectionImpl.cpp:2980 | IceConnectionStateChange
[task 2023-01-04T07:07:17.562Z] 07:07:17 INFO - PID 9543 | 0.138182 | 0.000336 | Ice state: connected | PeerConnectionImpl.cpp:2983 | IceConnectionStateChange
[task 2023-01-04T07:07:17.563Z] 07:07:17 INFO - PID 9543 | 0.245898 | 0.107716 | Add Ice Candidate | PeerConnectionImpl.cpp:1867 | AddIceCandidate
[task 2023-01-04T07:07:17.563Z] 07:07:17 INFO - PID 9543 | 0.247103 | 0.001205 | Close | PeerConnectionImpl.cpp:2236 | Close
[task 2023-01-04T07:07:17.564Z] 07:07:17 INFO - PID 9543 | 15.942477 | 15.695374 | Destructor Invoked | PeerConnectionImpl.cpp:384 | ~PeerConnectionImpl
[task 2023-01-04T07:07:17.565Z] 07:07:17 INFO - PID 9543 | 15.942478 | 0.000001 | {4eaae08c-9c08-4c5f-bdbf-592e33f26539} | PeerConnectionImpl.cpp:385 | ~PeerConnectionImpl
[task 2023-01-04T07:07:17.565Z] 07:07:17 INFO - PID 9543 | [Child 10250: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:392: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {4eaae08c-9c08-4c5f-bdbf-592e33f26539}
[task 2023-01-04T07:09:28.078Z] 07:09:28 INFO - Got timeout in harness
[task 2023-01-04T07:09:28.080Z] 07:09:28 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/protocol/ice-ufragpwd.html | TestRunner hit external timeout (this may indicate a hang)
[task 2023-01-04T07:09:28.080Z] 07:09:28 INFO - TEST-INFO took 135015ms
[task 2023-01-04T07:10:39.140Z] 07:10:39 INFO - Browser exited with return code -15
| 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 auto_nag 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
•