WebRTC: Audio is "Inactive" when Responding to SDP Offer from Browser
Luke McGartland
luke.mcgartland at gmail.com
Sat Oct 24 15:28:51 UTC 2020
I'm working on learning webrtcbin and gstreamer in Rust. I've successfully
been able to send a video stream to the web browser client. However,
getting the audio to come through continues to baffle me. Any and all help
would be greatly appreciated.
In general, I'm following
https://github.com/centricular/gstwebrtc-demos/blob/master/sendrecv/ as an
example and using the Rust backend. Instead of making the offer from the
server, I actually initiate a recvonly SDP offer from the client (Chrome).
I'm using v0.15 of the Rust Bindings (v0.16 did not solve this either) and
running v1.18 of GStreamer in a container (I've also tried v1.16 and that
did not solve things, but would welcome advice on which release to pair
with the bindings properly).
(Full logs with GST_DEBUG=3,webrtc*:7 on are attached at bottom).
*In summary, here is the pipeline:*
videotestsrc pattern=ball is-live=true ! vp8enc deadline=1 ! rtpvp8pay
pt=96 ! webrtcbin. \
audiotestsrc is-live=true ! opusenc ! rtpopuspay pt=97 ! webrtcbin. \
webrtcbin name=webrtcbin
*Here is my SDP offer that I send from Chrome:*
v=0
o=- 450776629876255560 3 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1
a=msid-semantic: WMS
m=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:JU/P
a=ice-pwd:TwQ3gTRoX/4EeBLk/VEd3DuU
a=ice-options:trickle
a=fingerprint:sha-256
C1:FF:37:89:F0:84:B7:8D:AF:69:24:C4:1D:77:E0:B7:11:A2:B0:8A:75:AB:D9:F6:67:3A:BD:43:85:74:CB:BA
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122 102 121 127 120 125 107
108 109 124 119 123 118 114 115 116
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:JU/P
a=ice-pwd:TwQ3gTRoX/4EeBLk/VEd3DuU
a=ice-options:trickle
a=fingerprint:sha-256
C1:FF:37:89:F0:84:B7:8D:AF:69:24:C4:1D:77:E0:B7:11:A2:B0:8A:75:AB:D9:F6:67:3A:BD:43:85:74:CB:BA
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:122 VP9/90000
a=rtcp-fb:122 goog-remb
a=rtcp-fb:122 transport-cc
a=rtcp-fb:122 ccm fir
a=rtcp-fb:122 nack
a=rtcp-fb:122 nack pli
a=fmtp:122 profile-id=1
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 H264/90000
a=rtcp-fb:124 goog-remb
a=rtcp-fb:124 transport-cc
a=rtcp-fb:124 ccm fir
a=rtcp-fb:124 nack
a=rtcp-fb:124 nack pli
a=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033
a=rtpmap:119 rtx/90000
a=fmtp:119 apt=124
a=rtpmap:123 H264/90000
a=rtcp-fb:123 goog-remb
a=rtcp-fb:123 transport-cc
a=rtcp-fb:123 ccm fir
a=rtcp-fb:123 nack
a=rtcp-fb:123 nack pli
a=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033
a=rtpmap:118 rtx/90000
a=fmtp:118 apt=123
a=rtpmap:114 red/90000
a=rtpmap:115 rtx/90000
a=fmtp:115 apt=114
a=rtpmap:116 ulpfec/90000
*In response, I get back this SDP answer:*
v=0
o=- 450776629876255560 3 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1
m=audio 9 UDP/TLS/RTP/SAVPF 111
c=IN IP4 0.0.0.0
a=ice-ufrag:bXg2gVATyBFsqyxzOR1ewruZUwQwUOQ5
a=ice-pwd:ivjkDOOiymRHUA0wkgYVs9cJEK88zoVi
a=mid:0
a=rtcp-mux
a=setup:active
a=rtpmap:111 OPUS/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=inactive
a=fingerprint:sha-256
C7:D4:3C:CA:67:8D:E5:59:47:0C:21:7D:9E:DE:53:1E:F3:08:16:52:7A:10:9C:EE:EB:BB:73:0A:72:6C:DF:6E
m=video 9 UDP/TLS/RTP/SAVPF 96
c=IN IP4 0.0.0.0
a=ice-ufrag:bXg2gVATyBFsqyxzOR1ewruZUwQwUOQ5
a=ice-pwd:ivjkDOOiymRHUA0wkgYVs9cJEK88zoVi
a=mid:1
a=rtcp-mux
a=setup:active
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 nack pli
a=rtcp-fb:96 ccm fir
a=framerate:30
a=ssrc:1290502017 msid:user2307279746 at host-5afdf240 webrtctransceiver0
a=ssrc:1290502017 cname:user2307279746 at host-5afdf240
a=sendonly
a=fingerprint:sha-256
C7:D4:3C:CA:67:8D:E5:59:47:0C:21:7D:9E:DE:53:1E:F3:08:16:52:7A:10:9C:EE:EB:BB:73:0A:72:6C:DF:6E
I can confirm in the browser that a video track is added to my remote media
stream and plays back in a <video> element. However, the audio track never
arrives.
I see that audio track is set to "inactive" instead of "sendonly" in the
response unlike the video track. The audio track also appears to be missing
the ssrc attributes.
What's strange is that if I send another SDP offer from the same browser
session after the video is already playing, I get this SDP answer back from
the server:
v=0
o=- 3882210396617362357 3 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1
m=video 9 UDP/TLS/RTP/SAVPF 96
c=IN IP4 0.0.0.0
a=ice-ufrag:TwzdS7bSlrKTWJhUpcj0+ypaa92FQnLp
a=ice-pwd:GXOUkZtGt+JGPyZmaQn2ZWg9+UUdrtL6
a=mid:0
a=rtcp-mux
a=setup:active
a=rtpmap:96 VP8/90000
a=framerate:30
a=ssrc:422817870 msid:user2542828131 at host-8f3a122d webrtctransceiver0
a=ssrc:422817870 cname:user2542828131 at host-8f3a122d
a=sendonly
a=fingerprint:sha-256
6F:CE:BF:8A:1A:92:34:4F:D1:26:C9:13:78:79:AB:AE:1B:28:C1:02:B5:5F:66:C1:9B:B5:BB:E4:77:22:1E:90
m=audio 9 UDP/TLS/RTP/SAVPF 97
c=IN IP4 0.0.0.0
a=ice-ufrag:TwzdS7bSlrKTWJhUpcj0+ypaa92FQnLp
a=ice-pwd:GXOUkZtGt+JGPyZmaQn2ZWg9+UUdrtL6
a=mid:1
a=rtcp-mux
a=setup:active
a=rtpmap:97 OPUS/48000/2
a=fmtp:97 sprop-maxcapturerate=48000;sprop-stereo=0
a=ssrc:4187272436 msid:user2542828131 at host-8f3a122d webrtctransceiver1
a=ssrc:4187272436 cname:user2542828131 at host-8f3a122d
a=sendonly
a=fingerprint:sha-256
6F:CE:BF:8A:1A:92:34:4F:D1:26:C9:13:78:79:AB:AE:1B:28:C1:02:B5:5F:66:C1:9B:B5:BB:E4:77:22:1E:90
However, this triggers an error in Chrome because the m-lines are in the
opposite order.
setRemoteDescription DOMException: Failed to execute 'setRemoteDescription'
on 'RTCPeerConnection': Failed to set remote answer sdp: The order of
m-lines in answer doesn't match order in offer. Rejecting answer.
Any help would be greatly appreciated. I'm new to this community but I see
a lot of potential with this library and would love to continue to learn
more and contribute in the future (especially on the Rust side)!
----------
Here is an example set of logs with (apologies for my terribly formatted
println!() debugging messages mixed in)
Checking for required gstreamer plugins...
WebSocket handshake has been successfully completed
Setting up pipeline
0:00:00.040135596 2466 0x58b47b56ef20 DEBUG webrtcbin
gstwebrtcbin.c:319:gst_webrtc_bin_pad_new:<'':sink_0> new visible pad with
direction sink
0:00:00.040182602 2466 0x58b47b56ef20 TRACE webrtcbin
gstwebrtcbin.c:469:_find_transceiver_for_mline:<webrtcbin> Found
transceiver (NULL) for mlineindex 0
0:00:00.040755260 2466 0x58b47b56ef20 LOG webrtcbin
gstwebrtcbin.c:5810:gst_webrtc_bin_request_new_pad:<webrtcbin> Created new
transceiver <webrtctransceiver0> for mline 0
0:00:00.042137091 2466 0x58b47b56ef20 DEBUG webrtcbin
gstwebrtcbin.c:319:gst_webrtc_bin_pad_new:<'':sink_1> new visible pad with
direction sink
0:00:00.042170292 2466 0x58b47b56ef20 TRACE webrtcbin
gstwebrtcbin.c:469:_find_transceiver_for_mline:<webrtcbin> Found
transceiver (NULL) for mlineindex 1
0:00:00.042202906 2466 0x58b47b56ef20 LOG webrtcbin
gstwebrtcbin.c:5810:gst_webrtc_bin_request_new_pad:<webrtcbin> Created new
transceiver <webrtctransceiver1> for mline 1
0:00:00.042636827 2466 0x58b47b56ef20 DEBUG webrtcice
gstwebrtcice.c:958:gst_webrtc_ice_set_stun_server:<webrtcbin0:ice> setting
stun server, stun://stun.l.google.com:19302
0:00:00.044352105 2466 0x58b47b57a850 DEBUG webrtcbin
gstwebrtcbin.c:5724:gst_webrtc_bin_change_state: changing state: NULL =>
READY
0:00:00.045240190 2466 0x58b47b57a850 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:00.045679975 2466 0x58b47b57a850 LOG webrtcbin
gstwebrtcbin.c:1347:_check_if_negotiation_is_needed:<webrtcbin> no
negotiation possible until caps have been received on all sink pads
0:00:00.047373551 2466 0x58b47b57a850 DEBUG webrtcbin
gstwebrtcbin.c:5724:gst_webrtc_bin_change_state: changing state: READY =>
PAUSED
0:00:00.048683270 2466 0x58b47b57a850 DEBUG webrtcbin
gstwebrtcbin.c:5724:gst_webrtc_bin_change_state: changing state: PAUSED =>
PLAYING
0:00:00.049580487 2466 0x58b47b3846d0 DEBUG webrtcbin
gstwebrtcbin.c:5724:gst_webrtc_bin_change_state: changing state: PLAYING =>
PLAYING
0:00:00.050287689 2466 0x7f7c980050a0 FIXME default
gstutils.c:4026:gst_pad_create_stream_id_internal:<videotestsrc0:src>
Creating random stream-id, consider implementing a deterministic way of
creating a stream-id
0:00:00.052605344 2466 0x7f7c98005050 FIXME default
gstutils.c:4026:gst_pad_create_stream_id_internal:<audiotestsrc0:src>
Creating random stream-id, consider implementing a deterministic way of
creating a stream-id
0:00:00.054544380 2466 0x7f7c98005050 DEBUG webrtcbin
gstwebrtcbin.c:279:gst_webrtcbin_sink_event:<webrtcbin> On
<webrtcbin:sink_1> checking negotiation? 1, caps application/x-rtp,
media=(string)audio, clock-rate=(int)48000, encoding-name=(string)OPUS,
sprop-maxcapturerate=(string)48000, sprop-stereo=(string)0,
payload=(int)97, encoding-params=(string)2, ssrc=(uint)465568367,
timestamp-offset=(uint)1614781904, seqnum-offset=(uint)28659
0:00:00.055381380 2466 0x7f7c98005050 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:00.055402242 2466 0x7f7c98005050 LOG webrtcbin
gstwebrtcbin.c:1347:_check_if_negotiation_is_needed:<webrtcbin> no
negotiation possible until caps have been received on all sink pads
0:00:00.055783493 2466 0x7f7c98005050 LOG webrtcbin
gstwebrtcbin.c:5771:sink_pad_block:<webrtcbin:sink_1> blocking pad with
data buffer: 0x7f7c8800f240, pts 0:00:00.005567255, dts 0:00:00.005567255,
dur 0:00:00.013500000, size 172, offset none, offset_end none, flags 0x4000
0:00:00.060227009 2466 0x7f7c980050a0 DEBUG webrtcbin
gstwebrtcbin.c:279:gst_webrtcbin_sink_event:<webrtcbin> On
<webrtcbin:sink_0> checking negotiation? 1, caps application/x-rtp,
media=(string)video, clock-rate=(int)90000, encoding-name=(string)VP8,
payload=(int)96, ssrc=(uint)3497855691, timestamp-offset=(uint)3612195570,
seqnum-offset=(uint)12225, a-framerate=(string)30
0:00:00.061159720 2466 0x7f7c980050a0 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:00.061750620 2466 0x7f7c980050a0 LOG webrtcbin
gstwebrtcbin.c:1357:_check_if_negotiation_is_needed:<webrtcbin> no local
description set
0:00:00.061892135 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1499:_check_need_negotiation_task:<webrtcbin> emitting
on-negotiation-needed
0:00:00.067811992 2466 0x7f7c980050a0 LOG webrtcbin
gstwebrtcbin.c:5771:sink_pad_block:<webrtcbin:sink_0> blocking pad with
data bufferlist: 0x58b47b509300, 1 buffers, pts 0:00:00.016753993, dts
99:99:99.999999999, size 736
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_SDP","data":{"sdp":{"type":"offer","sdp":"v=0\r\no=-
6037884307875629115 4 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0
1\r\na=msid-semantic: WMS\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8
106 105 13 110 112 113 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4
0.0.0.0\r\na=ice-ufrag:bT57\r\na=ice-pwd:75COdxPqm2uxeNUWBFDiXJDq\r\na=ice-options:trickle\r\na=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1
urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4
urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5
urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6
urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=recvonly\r\na=rtcp-mux\r\na=rtpmap:111
opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111
minptime=10;useinbandfec=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104
ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8
PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13
CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112
telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126
telephone-event/8000\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122
102 121 127 120 125 107 108 109 124 119 123 118 114 115 116\r\nc=IN IP4
0.0.0.0\r\na=rtcp:9 IN IP4
0.0.0.0\r\na=ice-ufrag:bT57\r\na=ice-pwd:75COdxPqm2uxeNUWBFDiXJDq\r\na=ice-options:trickle\r\na=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C\r\na=setup:actpass\r\na=mid:1\r\na=extmap:14
urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:2
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13
urn:3gpp:video-orientation\r\na=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12
http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11
http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7
http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8
http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4
urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5
urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6
urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96
VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96
transport-cc\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96
nack pli\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:98
VP9/90000\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98
transport-cc\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98
nack pli\r\na=fmtp:98 profile-id=0\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99
apt=98\r\na=rtpmap:100 VP9/90000\r\na=rtcp-fb:100
goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=rtcp-fb:100 ccm
fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100
profile-id=2\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101
apt=100\r\na=rtpmap:122 VP9/90000\r\na=rtcp-fb:122
goog-remb\r\na=rtcp-fb:122 transport-cc\r\na=rtcp-fb:122 ccm
fir\r\na=rtcp-fb:122 nack\r\na=rtcp-fb:122 nack pli\r\na=fmtp:122
profile-id=1\r\na=rtpmap:102 H264/90000\r\na=rtcp-fb:102
goog-remb\r\na=rtcp-fb:102 transport-cc\r\na=rtcp-fb:102 ccm
fir\r\na=rtcp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\r\na=rtpmap:121
rtx/90000\r\na=fmtp:121 apt=102\r\na=rtpmap:127 H264/90000\r\na=rtcp-fb:127
goog-remb\r\na=rtcp-fb:127 transport-cc\r\na=rtcp-fb:127 ccm
fir\r\na=rtcp-fb:127 nack\r\na=rtcp-fb:127 nack pli\r\na=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\r\na=rtpmap:120
rtx/90000\r\na=fmtp:120 apt=127\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125
goog-remb\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 ccm
fir\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:107
rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:108 H264/90000\r\na=rtcp-fb:108
goog-remb\r\na=rtcp-fb:108 transport-cc\r\na=rtcp-fb:108 ccm
fir\r\na=rtcp-fb:108 nack\r\na=rtcp-fb:108 nack pli\r\na=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\r\na=rtpmap:109
rtx/90000\r\na=fmtp:109 apt=108\r\na=rtpmap:124 H264/90000\r\na=rtcp-fb:124
goog-remb\r\na=rtcp-fb:124 transport-cc\r\na=rtcp-fb:124 ccm
fir\r\na=rtcp-fb:124 nack\r\na=rtcp-fb:124 nack pli\r\na=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033\r\na=rtpmap:119
rtx/90000\r\na=fmtp:119 apt=124\r\na=rtpmap:123 H264/90000\r\na=rtcp-fb:123
goog-remb\r\na=rtcp-fb:123 transport-cc\r\na=rtcp-fb:123 ccm
fir\r\na=rtcp-fb:123 nack\r\na=rtcp-fb:123 nack pli\r\na=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033\r\na=rtpmap:118
rtx/90000\r\na=fmtp:118 apt=123\r\na=rtpmap:114 red/90000\r\na=rtpmap:115
rtx/90000\r\na=fmtp:115 apt=114\r\na=rtpmap:116
ulpfec/90000\r\n"},"user":"123456"}}
GOT SEND_SDP MESSAGE from 123456
Received offer:
v=0
o=- 6037884307875629115 4 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1
a=msid-semantic: WMS
m=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:bT57
a=ice-pwd:75COdxPqm2uxeNUWBFDiXJDq
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122 102 121 127 120 125 107
108 109 124 119 123 118 114 115 116
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:bT57
a=ice-pwd:75COdxPqm2uxeNUWBFDiXJDq
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:122 VP9/90000
a=rtcp-fb:122 goog-remb
a=rtcp-fb:122 transport-cc
a=rtcp-fb:122 ccm fir
a=rtcp-fb:122 nack
a=rtcp-fb:122 nack pli
a=fmtp:122 profile-id=1
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 H264/90000
a=rtcp-fb:124 goog-remb
a=rtcp-fb:124 transport-cc
a=rtcp-fb:124 ccm fir
a=rtcp-fb:124 nack
a=rtcp-fb:124 nack pli
a=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033
a=rtpmap:119 rtx/90000
a=fmtp:119 apt=124
a=rtpmap:123 H264/90000
a=rtcp-fb:123 goog-remb
a=rtcp-fb:123 transport-cc
a=rtcp-fb:123 ccm fir
a=rtcp-fb:123 nack
a=rtcp-fb:123 nack pli
a=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033
a=rtpmap:118 rtx/90000
a=fmtp:118 apt=123
a=rtpmap:114 red/90000
a=rtpmap:115 rtx/90000
a=fmtp:115 apt=114
a=rtpmap:116 ulpfec/90000
0:00:04.021361800 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:4312:_set_description_task:<webrtcbin> Attempting to set
remote offer in the stable state
0:00:04.023018570 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4313:_set_description_task:<webrtcbin> SDP contents
v=0
o=- 6037884307875629115 4 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1
a=msid-semantic: WMS
m=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:bT57
a=ice-pwd:75COdxPqm2uxeNUWBFDiXJDq
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122 102 121 127 120 125 107
108 109 124 119 123 118 114 115 116
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:bT57
a=ice-pwd:75COdxPqm2uxeNUWBFDiXJDq
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:122 VP9/90000
a=rtcp-fb:122 goog-remb
a=rtcp-fb:122 transport-cc
a=rtcp-fb:122 ccm fir
a=rtcp-fb:122 nack
a=rtcp-fb:122 nack pli
a=fmtp:122 profile-id=1
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 H264/90000
a=rtcp-fb:124 goog-remb
a=rtcp-fb:124 transport-cc
a=rtcp-fb:124 ccm fir
a=rtcp-fb:124 nack
a=rtcp-fb:124 nack pli
a=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033
a=rtpmap:119 rtx/90000
a=fmtp:119 apt=124
a=rtpmap:123 H264/90000
a=rtcp-fb:123 goog-remb
a=rtcp-fb:123 transport-cc
a=rtcp-fb:123 ccm fir
a=rtcp-fb:123 nack
a=rtcp-fb:123 nack pli
a=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033
a=rtpmap:118 rtx/90000
a=fmtp:118 apt=123
a=rtpmap:114 red/90000
a=rtpmap:115 rtx/90000
a=fmtp:115 apt=114
a=rtpmap:116 ulpfec/90000
0:00:04.023208190 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:4479:_set_description_task:<webrtcbin> we are in ice
controlling mode: true
0:00:04.023233046 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
(NULL) for session 0
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_CANDIDATE","data":{"candidate":{"candidate":"candidate:63126866
1 udp 2113937151 ec09dc7d-e98b-4caa-b8af-ae9b04577210.local 38930 typ host
generation 2 ufrag bT57 network-cost
999","sdpMid":"0","sdpMLineIndex":0},"user":"123456"}}
GOT SEND_CANDIDATE MESSAGE
handle_ice:
candidate:63126866 1 udp 2113937151
ec09dc7d-e98b-4caa-b8af-ae9b04577210.local 38930 typ host generation 2
ufrag bT57 network-cost 999
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_CANDIDATE","data":{"candidate":{"candidate":"candidate:3933521124
1 udp 2113934591 e4de021a-535c-4e08-83f1-8b00c44ad5a2.local 38229 typ host
generation 2 ufrag bT57 network-cost
999","sdpMid":"0","sdpMLineIndex":0},"user":"123456"}}
GOT SEND_CANDIDATE MESSAGE
handle_ice:
candidate:3933521124 1 udp 2113934591
e4de021a-535c-4e08-83f1-8b00c44ad5a2.local 38229 typ host generation 2
ufrag bT57 network-cost 999
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_CANDIDATE","data":{"candidate":{"candidate":"candidate:842163049
1 udp 1677729535 68.8.32.177 46192 typ srflx raddr 0.0.0.0 rport 0
generation 2 ufrag bT57 network-cost
999","sdpMid":"0","sdpMLineIndex":0},"user":"123456"}}
GOT SEND_CANDIDATE MESSAGE
handle_ice:
candidate:842163049 1 udp 1677729535 68.8.32.177 46192 typ srflx raddr
0.0.0.0 rport 0 generation 2 ufrag bT57 network-cost 999
0:00:04.107356121 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:400:_find_ice_stream_for_session:<webrtcbin> No ice stream
available for session 0
0:00:04.107418543 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:424:_add_stun_server:<webrtcbin0:ice> adding stun server,
stun://stun.l.google.com:19302
0:00:04.107519650 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:313:_resolve_host:<webrtcbin0:ice> Resolving host
stun.l.google.com
0:00:04.117080140 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:322:_resolve_host:<webrtcbin0:ice> Resolved 1 addresses for
host stun.l.google.com
0:00:04.119156837 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:411:_add_ice_stream_item:<webrtcbin> adding ice stream
<webrtcicestream0> for session 0
0:00:04.122378950 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1700:_create_transport_channel:<webrtcbin> Create transport
<transportstream0> for session 0
0:00:04.123957353 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:5188:on_rtpbin_pad_added:<webrtcbin> new rtpbin pad
recv_rtcp_sink_0
0:00:04.124056653 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:5188:on_rtpbin_pad_added:<webrtcbin> new rtpbin pad
send_rtcp_src_0
0:00:04.124148282 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: NULL => READY
0:00:04.124206903 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: READY => PAUSED
0:00:04.125246274 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PAUSED => PLAYING
0:00:04.125348838 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: NULL => READY
0:00:04.125758539 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: READY => PAUSED
0:00:04.126599558 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PAUSED => PLAYING
0:00:04.128235560 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:746:gst_webrtc_ice_set_remote_credentials:<webrtcbin0:ice>
Setting remote ICE credentials on ICE stream 1 ufrag:bT57
pwd:75COdxPqm2uxeNUWBFDiXJDq
0:00:04.128831496 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.128866622 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.128959866 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.129041986 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:746:gst_webrtc_ice_set_remote_credentials:<webrtcbin0:ice>
Setting remote ICE credentials on ICE stream 1 ufrag:bT57
pwd:75COdxPqm2uxeNUWBFDiXJDq
0:00:04.129062303 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4640:_set_description_task:<webrtcbin> notify
signaling-state from have-remote-offer to have-remote-offer
-----------SET REMOTE DESCRIPTION------------
0:00:04.129222934 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:3310:_create_sdp_task:<webrtcbin> creating answer sdp with
options (NULL)
0:00:04.129508405 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1545:_find_codec_preferences:<webrtcbin> retrieving codec
preferences from <webrtctransceiver0>
0:00:04.131310130 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3120:_create_answer_task:<webrtcbin> trying to compare
application/x-rtp, media=(string)audio, payload=(int)111,
clock-rate=(int)48000, encoding-name=(string)OPUS,
encoding-params=(string)2, minptime=(string)10, useinbandfec=(string)1,
rtcp-fb-transport-cc=(boolean)true; application/x-rtp, media=(string)audio,
payload=(int)103, clock-rate=(int)16000, encoding-name=(string)ISAC;
application/x-rtp, media=(string)audio, payload=(int)104,
clock-rate=(int)32000, encoding-name=(string)ISAC; application/x-rtp,
media=(string)audio, payload=(int)9, clock-rate=(int)8000,
encoding-name=(string)G722; application/x-rtp, media=(string)audio,
payload=(int)0, clock-rate=(int)8000, encoding-name=(string)PCMU;
application/x-rtp, media=(string)audio, payload=(int)8,
clock-rate=(int)8000, encoding-name=(string)PCMA; application/x-rtp,
media=(string)audio, payload=(int)106, clock-rate=(int)32000,
encoding-name=(string)CN; application/x-rtp, media=(string)audio,
payload=(int)105, clock-rate=(int)16000, encoding-name=(string)CN;
application/x-rtp, media=(string)audio, payload=(int)13,
clock-rate=(int)8000, encoding-name=(string)CN; application/x-rtp,
media=(string)audio, payload=(int)110, clock-rate=(int)48000,
encoding-name=(string)TELEPHONE-EVENT; application/x-rtp,
media=(string)audio, payload=(int)112, clock-rate=(int)32000,
encoding-name=(string)TELEPHONE-EVENT; application/x-rtp,
media=(string)audio, payload=(int)113, clock-rate=(int)16000,
encoding-name=(string)TELEPHONE-EVENT; application/x-rtp,
media=(string)audio, payload=(int)126, clock-rate=(int)8000,
encoding-name=(string)TELEPHONE-EVENT and application/x-rtp,
media=(string)video, clock-rate=(int)90000, encoding-name=(string)VP8,
payload=(int)96, ssrc=(uint)3497855691, timestamp-offset=(uint)3612195570,
seqnum-offset=(uint)12225, a-framerate=(string)30
0:00:04.131359231 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1545:_find_codec_preferences:<webrtcbin> retrieving codec
preferences from <webrtctransceiver1>
0:00:04.131394964 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3120:_create_answer_task:<webrtcbin> trying to compare
application/x-rtp, media=(string)audio, payload=(int)111,
clock-rate=(int)48000, encoding-name=(string)OPUS,
encoding-params=(string)2, minptime=(string)10, useinbandfec=(string)1,
rtcp-fb-transport-cc=(boolean)true; application/x-rtp, media=(string)audio,
payload=(int)103, clock-rate=(int)16000, encoding-name=(string)ISAC;
application/x-rtp, media=(string)audio, payload=(int)104,
clock-rate=(int)32000, encoding-name=(string)ISAC; application/x-rtp,
media=(string)audio, payload=(int)9, clock-rate=(int)8000,
encoding-name=(string)G722; application/x-rtp, media=(string)audio,
payload=(int)0, clock-rate=(int)8000, encoding-name=(string)PCMU;
application/x-rtp, media=(string)audio, payload=(int)8,
clock-rate=(int)8000, encoding-name=(string)PCMA; application/x-rtp,
media=(string)audio, payload=(int)106, clock-rate=(int)32000,
encoding-name=(string)CN; application/x-rtp, media=(string)audio,
payload=(int)105, clock-rate=(int)16000, encoding-name=(string)CN;
application/x-rtp, media=(string)audio, payload=(int)13,
clock-rate=(int)8000, encoding-name=(string)CN; application/x-rtp,
media=(string)audio, payload=(int)110, clock-rate=(int)48000,
encoding-name=(string)TELEPHONE-EVENT; application/x-rtp,
media=(string)audio, payload=(int)112, clock-rate=(int)32000,
encoding-name=(string)TELEPHONE-EVENT; application/x-rtp,
media=(string)audio, payload=(int)113, clock-rate=(int)16000,
encoding-name=(string)TELEPHONE-EVENT; application/x-rtp,
media=(string)audio, payload=(int)126, clock-rate=(int)8000,
encoding-name=(string)TELEPHONE-EVENT and application/x-rtp,
media=(string)audio, clock-rate=(int)48000, encoding-name=(string)OPUS,
sprop-maxcapturerate=(string)48000, sprop-stereo=(string)0,
payload=(int)97, encoding-params=(string)2, ssrc=(uint)465568367,
timestamp-offset=(uint)1614781904, seqnum-offset=(uint)28659
0:00:04.131455960 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3176:_create_answer_task:<webrtcbin> Created new transceiver
<webrtctransceiver2> for mline 0
0:00:04.131509657 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.131528075 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.131566263 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.133398729 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1545:_find_codec_preferences:<webrtcbin> retrieving codec
preferences from <webrtctransceiver0>
0:00:04.133512214 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3120:_create_answer_task:<webrtcbin> trying to compare
application/x-rtp, media=(string)video, payload=(int)96,
clock-rate=(int)90000, encoding-name=(string)VP8,
rtcp-fb-goog-remb=(boolean)true, rtcp-fb-transport-cc=(boolean)true,
rtcp-fb-ccm-fir=(boolean)true, rtcp-fb-nack=(boolean)true,
rtcp-fb-nack-pli=(boolean)true; application/x-rtp, media=(string)video,
payload=(int)97, clock-rate=(int)90000, encoding-name=(string)RTX,
apt=(string)96; application/x-rtp, media=(string)video, payload=(int)98,
clock-rate=(int)90000, encoding-name=(string)VP9, profile-id=(string)0,
rtcp-fb-goog-remb=(boolean)true, rtcp-fb-transport-cc=(boolean)true,
rtcp-fb-ccm-fir=(boolean)true, rtcp-fb-nack=(boolean)true,
rtcp-fb-nack-pli=(boolean)true; application/x-rtp, media=(string)video,
payload=(int)99, clock-rate=(int)90000, encoding-name=(string)RTX,
apt=(string)98; application/x-rtp, media=(string)video, payload=(int)100,
clock-rate=(int)90000, encoding-name=(string)VP9, profile-id=(string)2,
rtcp-fb-goog-remb=(boolean)true, rtcp-fb-transport-cc=(boolean)true,
rtcp-fb-ccm-fir=(boolean)true, rtcp-fb-nack=(boolean)true,
rtcp-fb-nack-pli=(boolean)true; application/x-rtp, media=(string)video,
payload=(int)101, clock-rate=(int)90000, encoding-name=(string)RTX,
apt=(string)100; application/x-rtp, media=(string)video, payload=(int)122,
clock-rate=(int)90000, encoding-name=(string)VP9, profile-id=(string)1,
rtcp-fb-goog-remb=(boolean)true, rtcp-fb-transport-cc=(boolean)true,
rtcp-fb-ccm-fir=(boolean)true, rtcp-fb-nack=(boolean)true,
rtcp-fb-nack-pli=(boolean)true; application/x-rtp, media=(string)video,
payload=(int)102, clock-rate=(int)90000, encoding-name=(string)H264,
level-asymmetry-allowed=(string)1, packetization-mode=(string)1,
profile-level-id=(string)42001f, rtcp-fb-goog-remb=(boolean)true,
rtcp-fb-transport-cc=(boolean)true, rtcp-fb-ccm-fir=(boolean)true,
rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true;
application/x-rtp, media=(string)video, payload=(int)121,
clock-rate=(int)90000, encoding-name=(string)RTX, apt=(string)102;
application/x-rtp, media=(string)video, payload=(int)127,
clock-rate=(int)90000, encoding-name=(string)H264,
level-asymmetry-allowed=(string)1, packetization-mode=(string)0,
profile-level-id=(string)42001f, rtcp-fb-goog-remb=(boolean)true,
rtcp-fb-transport-cc=(boolean)true, rtcp-fb-ccm-fir=(boolean)true,
rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true;
application/x-rtp, media=(string)video, payload=(int)120,
clock-rate=(int)90000, encoding-name=(string)RTX, apt=(string)127;
application/x-rtp, media=(string)video, payload=(int)125,
clock-rate=(int)90000, encoding-name=(string)H264,
level-asymmetry-allowed=(string)1, packetization-mode=(string)1,
profile-level-id=(string)42e01f, rtcp-fb-goog-remb=(boolean)true,
rtcp-fb-transport-cc=(boolean)true, rtcp-fb-ccm-fir=(boolean)true,
rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true;
application/x-rtp, media=(string)video, payload=(int)107,
clock-rate=(int)90000, encoding-name=(string)RTX, apt=(string)125;
application/x-rtp, media=(string)video, payload=(int)108,
clock-rate=(int)90000, encoding-name=(string)H264,
level-asymmetry-allowed=(string)1, packetization-mode=(string)0,
profile-level-id=(string)42e01f, rtcp-fb-goog-remb=(boolean)true,
rtcp-fb-transport-cc=(boolean)true, rtcp-fb-ccm-fir=(boolean)true,
rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true;
application/x-rtp, media=(string)video, payload=(int)109,
clock-rate=(int)90000, encoding-name=(string)RTX, apt=(string)108;
application/x-rtp, media=(string)video, payload=(int)124,
clock-rate=(int)90000, encoding-name=(string)H264,
level-asymmetry-allowed=(string)1, packetization-mode=(string)1,
profile-level-id=(string)4d0033, rtcp-fb-goog-remb=(boolean)true,
rtcp-fb-transport-cc=(boolean)true, rtcp-fb-ccm-fir=(boolean)true,
rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true;
application/x-rtp, media=(string)video, payload=(int)119,
clock-rate=(int)90000, encoding-name=(string)RTX, apt=(string)124;
application/x-rtp, media=(string)video, payload=(int)123,
clock-rate=(int)90000, encoding-name=(string)H264,
level-asymmetry-allowed=(string)1, packetization-mode=(string)1,
profile-level-id=(string)640033, rtcp-fb-goog-remb=(boolean)true,
rtcp-fb-transport-cc=(boolean)true, rtcp-fb-ccm-fir=(boolean)true,
rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true;
application/x-rtp, media=(string)video, payload=(int)118,
clock-rate=(int)90000, encoding-name=(string)RTX, apt=(string)123;
application/x-rtp, media=(string)video, payload=(int)114,
clock-rate=(int)90000, encoding-name=(string)RED; application/x-rtp,
media=(string)video, payload=(int)115, clock-rate=(int)90000,
encoding-name=(string)RTX, apt=(string)114; application/x-rtp,
media=(string)video, payload=(int)116, clock-rate=(int)90000,
encoding-name=(string)ULPFEC and application/x-rtp, media=(string)video,
clock-rate=(int)90000, encoding-name=(string)VP8, payload=(int)96,
ssrc=(uint)3497855691, timestamp-offset=(uint)3612195570,
seqnum-offset=(uint)12225, a-framerate=(string)30
0:00:04.133872949 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3130:_create_answer_task:<webrtcbin> found compatible
transceiver <webrtctransceiver0> for offer media 1
0:00:04.133936322 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.134208418 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.134092823 2466 0x7f7c900b22d0 FIXME default
gstutils.c:4026:gst_pad_create_stream_id_internal:<nicesrc0:src> Creating
random stream-id, consider implementing a deterministic way of creating a
stream-id
0:00:04.134325948 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
-----------SENDING SDP ANSWER------------
on_answer_created
0:00:04.134993726 2466 0x7f7c900b2280 FIXME default
gstutils.c:4026:gst_pad_create_stream_id_internal:<nicesrc1:src> Creating
random stream-id, consider implementing a deterministic way of creating a
stream-id
sending SDP answer to peer: v=0
o=- 6037884307875629115 4 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1
m=audio 9 UDP/TLS/RTP/SAVPF 111
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:0
a=rtcp-mux
a=setup:active
a=rtpmap:111 OPUS/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=inactive
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
m=video 9 UDP/TLS/RTP/SAVPF 96
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:1
a=rtcp-mux
a=setup:active
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 nack pli
a=rtcp-fb:96 ccm fir
a=framerate:30
a=ssrc:3497855691 msid:user2578524959 at host-e8f12b09 webrtctransceiver0
a=ssrc:3497855691 cname:user2578524959 at host-e8f12b09
a=sendonly
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
Sending message
{"protocol":"one-to-one","to":"123456","action":"SEND_SDP","data":{"sdp":{"type":"answer","sdp":"v=0\r\no=-
6037884307875629115 4 IN IP4 0.0.0.0\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0
1\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111\r\nc=IN IP4
0.0.0.0\r\na=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN\r\na=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu\r\na=mid:0\r\na=rtcp-mux\r\na=setup:active\r\na=rtpmap:111
OPUS/48000/2\r\na=fmtp:111
minptime=10;useinbandfec=1\r\na=inactive\r\na=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE\r\nm=video
9 UDP/TLS/RTP/SAVPF 96\r\nc=IN IP4
0.0.0.0\r\na=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN\r\na=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu\r\na=mid:1\r\na=rtcp-mux\r\na=setup:active\r\na=rtpmap:96
VP8/90000\r\na=rtcp-fb:96 nack pli\r\na=rtcp-fb:96 ccm
fir\r\na=framerate:30\r\na=ssrc:3497855691 msid:user2578524959 at host-e8f12b09
webrtctransceiver0\r\na=ssrc:3497855691
cname:user2578524959 at host-e8f12b09\r\na=sendonly\r\na=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE\r\n"},"user":"ges-webrtc-service"}}
0:00:04.136527033 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:4312:_set_description_task:<webrtcbin> Attempting to set
local answer in the have-remote-offer state
0:00:04.136550554 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4313:_set_description_task:<webrtcbin> SDP contents
v=0
o=- 6037884307875629115 4 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1
m=audio 9 UDP/TLS/RTP/SAVPF 111
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:0
a=rtcp-mux
a=setup:active
a=rtpmap:111 OPUS/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=inactive
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
m=video 9 UDP/TLS/RTP/SAVPF 96
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:1
a=rtcp-mux
a=setup:active
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 nack pli
a=rtcp-fb:96 ccm fir
a=framerate:30
a=ssrc:3497855691 msid:user2578524959 at host-e8f12b09 webrtctransceiver0
a=ssrc:3497855691 cname:user2578524959 at host-e8f12b09
a=sendonly
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
0:00:04.136761837 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:4479:_set_description_task:<webrtcbin> we are in ice
controlling mode: false
0:00:04.136784597 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.136810735 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.136851866 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.136919126 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp session level attributes to caps
0:00:04.136942062 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp media level attributes to caps
0:00:04.136964782 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:<webrtcbin> looking
at 0 pt: 111
0:00:04.137003678 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp session level attributes to caps
0:00:04.137017911 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp media level attributes to caps
0:00:04.137040318 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:<webrtcbin> looking
at 0 pt: 96
0:00:04.137068824 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.139372068 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.139526173 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.139547658 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:5299:on_rtpbin_request_aux_sender:<webrtcbin> requesting aux
sender for stream <transportstream0> with transport <webrtctransceiver0>
and pt map (NULL)
0:00:04.139657564 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:5188:on_rtpbin_pad_added:<webrtcbin> new rtpbin pad
send_rtp_src_0
0:00:04.139695372 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:5188:on_rtpbin_pad_added:<webrtcbin> new rtpbin pad
send_rtp_sink_0
0:00:04.139782959 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:<webrtcbin> Found
transceiver <webrtctransceiver0>
0:00:04.139801287 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.139819234 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.139851786 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.139945178 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3879:_update_transceiver_from_sdp_media:<webrtcbin>
transceiver <webrtctransceiver0> direction change from none to inactive
0:00:04.139978869 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:329:_on_notify_dtls_client_status:<transportsendbin0>
DTLS-SRTP encoder configured. Unlocking it and changing state <dtlssrtpenc0>
0:00:04.140706283 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:329:_on_notify_dtls_client_status:<transportsendbin0>
DTLS-SRTP encoder configured. Unlocking it and changing state <dtlssrtpenc1>
0:00:04.141554025 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:<webrtcbin> Found
transceiver <webrtctransceiver1>
0:00:04.141587281 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.141606536 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.141660066 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.141727110 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3863:_update_transceiver_from_sdp_media:<webrtcbin> marking
stream 0x7f7c98002d40 as active
0:00:04.141744921 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3879:_update_transceiver_from_sdp_media:<webrtcbin>
transceiver <webrtctransceiver1> direction change from none to sendonly
0:00:04.141760474 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3912:_update_transceiver_from_sdp_media:<webrtcbin> found
existing send pad <webrtcbin:sink_1> for transceiver <webrtctransceiver1>
0:00:04.141773492 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:126:transport_receive_bin_set_receive_state:<transportreceivebin0>
changing receive state to pass
0:00:04.141812946 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:4534:_set_description_task:<webrtcbin:sink_0> Connecting
input stream to rtpbin with transceiver <webrtctransceiver0> and caps
application/x-rtp, media=(string)video, clock-rate=(int)90000,
encoding-name=(string)VP8, payload=(int)96, ssrc=(uint)3497855691,
timestamp-offset=(uint)3612195570, seqnum-offset=(uint)12225,
a-framerate=(string)30
0:00:04.141829138 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:3482:_connect_input_stream:<webrtcbin:sink_0> linking input
stream 0
0:00:04.141891571 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.144721505 2466 0x7f7c980050a0 DEBUG webrtcbin
gstwebrtcbin.c:279:gst_webrtcbin_sink_event:<webrtcbin> On
<webrtcbin:sink_0> checking negotiation? 1, caps application/x-rtp,
media=(string)video, clock-rate=(int)90000, encoding-name=(string)VP8,
payload=(int)96, seqnum-offset=(uint)12225,
timestamp-offset=(uint)3612195570, ssrc=(uint)3497855691,
a-framerate=(string)30
0:00:04.144825665 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:4534:_set_description_task:<webrtcbin:sink_1> Connecting
input stream to rtpbin with transceiver <webrtctransceiver1> and caps
application/x-rtp, media=(string)audio, clock-rate=(int)48000,
encoding-name=(string)OPUS, sprop-maxcapturerate=(string)48000,
sprop-stereo=(string)0, payload=(int)97, encoding-params=(string)2,
ssrc=(uint)465568367, timestamp-offset=(uint)1614781904,
seqnum-offset=(uint)28659
0:00:04.144849930 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:3482:_connect_input_stream:<webrtcbin:sink_1> linking input
stream 1
0:00:04.144959349 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.146049259 2466 0x7f7c98005050 DEBUG webrtcbin
gstwebrtcbin.c:279:gst_webrtcbin_sink_event:<webrtcbin> On
<webrtcbin:sink_1> checking negotiation? 1, caps application/x-rtp,
media=(string)audio, clock-rate=(int)48000, encoding-name=(string)OPUS,
sprop-maxcapturerate=(string)48000, sprop-stereo=(string)0,
payload=(int)97, encoding-params=(string)2, seqnum-offset=(uint)28659,
timestamp-offset=(uint)1614781904, ssrc=(uint)465568367
0:00:04.148991305 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.149058818 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.149454246 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.149676233 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:805:gst_webrtc_ice_set_local_credentials:<webrtcbin0:ice>
Setting local ICE credentials on ICE stream 1
ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
0:00:04.149804835 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.149858415 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:04.150123348 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:04.150366260 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:823:gst_webrtc_ice_gather_candidates:<webrtcbin0:ice> gather
candidates for stream 1
0:00:04.150413993 2466 0x7f7c98005000 DEBUG webrtcicestream
icestream.c:177:gst_webrtc_ice_stream_gather_candidates:<webrtcicestream0>
start gathering candidates
0:00:04.152233597 2466 0x7f7c90083f70 INFO webrtcbin
gstwebrtcbin.c:5619:on_rtpbin_new_sender_ssrc:<webrtcbin> session 0 ssrc
3497855691 new sender ssrc
0:00:04.165057954 2466 0x7f7c900b2400 LOG webrtctransportsendbin
transportsendbin.c:160:pad_block:<dtlssrtpenc0:src> blocking pad with data
buffer: 0x7f7c90021ea0, pts 99:99:99.999999999, dts 99:99:99.999999999, dur
99:99:99.999999999, size 255, offset none, offset_end none, flags 0x0
0:00:04.172765171 2466 0x7f7c90083f70 LOG webrtctransportsendbin
transportsendbin.c:160:pad_block:<rtp_sink:proxypad12> blocking pad with
data bufferlist: 0x58b47b509300, 1 buffers, pts 0:00:00.016753993, dts
99:99:99.999999999, size 736
0:00:04.192156998 2466 0x7f7c900b20a0 LOG webrtctransportsendbin
transportsendbin.c:160:pad_block:<dtlssrtpenc1:src> blocking pad with data
buffer: 0x7f7c900da480, pts 99:99:99.999999999, dts 99:99:99.999999999, dur
99:99:99.999999999, size 255, offset none, offset_end none, flags 0x0
0:00:04.192239888 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4882:_on_local_ice_candidate_cb:<webrtcbin> Queueing
on_ice_candidate_task
0:00:04.192279547 2466 0x7f7c98005000 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport0> 1 1
gathering
0:00:04.192305419 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:394:_find_ice_stream_for_session:<webrtcbin> Found ice
stream id <webrtcicestream0> for session 0
0:00:04.192336811 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3601:_add_ice_candidate:<webrtcbin> adding ICE candidate
with mline:0, a=candidate:63126866 1 udp 2113937151
ec09dc7d-e98b-4caa-b8af-ae9b04577210.local 38930 typ host generation 2
ufrag bT57 network-cost 999
0:00:04.192374160 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:313:_resolve_host:<webrtcbin0:ice> Resolving host
ec09dc7d-e98b-4caa-b8af-ae9b04577210.local
0:00:04.204437393 2466 0x7f7c98005000 ERROR webrtcice
gstwebrtcice.c:316:_resolve_host: Error resolving
“ec09dc7d-e98b-4caa-b8af-ae9b04577210.local”: Name or service not known
0:00:04.205706485 2466 0x7f7c98005000 WARN webrtcice
gstwebrtcice.c:690:gst_webrtc_ice_add_candidate:<webrtcbin0:ice> Failed to
resolve ec09dc7d-e98b-4caa-b8af-ae9b04577210.local
0:00:04.206692528 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:394:_find_ice_stream_for_session:<webrtcbin> Found ice
stream id <webrtcicestream0> for session 0
0:00:04.207873633 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3601:_add_ice_candidate:<webrtcbin> adding ICE candidate
with mline:0, a=candidate:3933521124 1 udp 2113934591
e4de021a-535c-4e08-83f1-8b00c44ad5a2.local 38229 typ host generation 2
ufrag bT57 network-cost 999
0:00:04.209293894 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:313:_resolve_host:<webrtcbin0:ice> Resolving host
e4de021a-535c-4e08-83f1-8b00c44ad5a2.local
0:00:04.213837004 2466 0x58b47b3845e0 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport1> 1 2
gathering
0:00:04.220692384 2466 0x7f7c98005000 ERROR webrtcice
gstwebrtcice.c:316:_resolve_host: Error resolving
“e4de021a-535c-4e08-83f1-8b00c44ad5a2.local”: Name or service not known
0:00:04.221171786 2466 0x7f7c98005000 WARN webrtcice
gstwebrtcice.c:690:gst_webrtc_ice_add_candidate:<webrtcbin0:ice> Failed to
resolve e4de021a-535c-4e08-83f1-8b00c44ad5a2.local
0:00:04.221570418 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:394:_find_ice_stream_for_session:<webrtcbin> Found ice
stream id <webrtcicestream0> for session 0
0:00:04.221850000 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3601:_add_ice_candidate:<webrtcbin> adding ICE candidate
with mline:0, a=candidate:842163049 1 udp 1677729535 68.8.32.177 46192 typ
srflx raddr 0.0.0.0 rport 0 generation 2 ufrag bT57 network-cost 999
0:00:04.222376889 2466 0x7f7c98005000 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport0> 1 1
connecting
0:00:04.222669896 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4640:_set_description_task:<webrtcbin> notify
signaling-state from stable to stable
0:00:04.222944933 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:04.223258823 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1478:_check_if_negotiation_is_needed:<webrtcbin> transceiver
direction (sendrecv) doesn't match description intersected direction
inactive (local inactive remote recvonly)
0:00:04.223556135 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1499:_check_need_negotiation_task:<webrtcbin> emitting
on-negotiation-needed
0:00:04.223865416 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.223969551 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x1
0:00:04.223992264 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.224009360 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x1
0:00:04.224023979 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.224039025 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x2. DTLS connection state: 0x8
0:00:04.224052366 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1154:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.224621949 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1282:_update_peer_connection_state_task:<webrtcbin> Peer
connection state change from new(0) to connecting(1)
0:00:04.224664827 2466 0x7f7c98005050 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:04.224691551 2466 0x7f7c98005050 LOG webrtcbin
gstwebrtcbin.c:1478:_check_if_negotiation_is_needed:<webrtcbin> transceiver
direction (sendrecv) doesn't match description intersected direction
inactive (local inactive remote recvonly)
0:00:04.226695969 2466 0x7f7c980050a0 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:04.226737126 2466 0x7f7c980050a0 LOG webrtcbin
gstwebrtcbin.c:1478:_check_if_negotiation_is_needed:<webrtcbin> transceiver
direction (sendrecv) doesn't match description intersected direction
inactive (local inactive remote recvonly)
0:00:04.233466130 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.234576250 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x1
0:00:04.234838418 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.235170790 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x1
0:00:04.235436198 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.235685269 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x2. DTLS connection state: 0x8
0:00:04.235963223 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1154:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.236236356 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509060 gathering state: 0x1
0:00:04.236632284 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509140 gathering state: 0x1
0:00:04.236967474 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:959:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.237223826 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 gathering state: 0x1
0:00:04.237340858 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:997:_collate_ice_gathering_states:<webrtcbin> ICE gathering
state: 0x2
0:00:04.237466612 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1001:_collate_ice_gathering_states:<webrtcbin> returning
gathering
0:00:04.237654102 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1212:_update_ice_gathering_state_task:<webrtcbin> ICE
gathering state change from new(0) to gathering(1)
0:00:04.237770009 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509060 gathering state: 0x1
0:00:04.237996080 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509140 gathering state: 0x1
0:00:04.238270255 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:959:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.238435857 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 gathering state: 0x1
0:00:04.238839361 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:997:_collate_ice_gathering_states:<webrtcbin> ICE gathering
state: 0x2
0:00:04.239022717 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1001:_collate_ice_gathering_states:<webrtcbin> returning
gathering
0:00:04.239048093 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:1 1 UDP 2015363327 172.18.0.5 40437 typ
host
on_ice_candidate candidate:1 1 UDP 2015363327 172.18.0.5 40437 typ host
0:00:04.242721158 2466 0x7f7c900b22d0 TRACE webrtcbin
gstwebrtcbin.c:4882:_on_local_ice_candidate_cb:<webrtcbin> Queueing
on_ice_candidate_task
0:00:04.243208136 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:2 1 TCP 1015021823 172.18.0.5 9 typ
host tcptype active
on_ice_candidate candidate:2 1 TCP 1015021823 172.18.0.5 9 typ host tcptype
active
0:00:04.243374626 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:3 1 TCP 1010827519 172.18.0.5 36291 typ
host tcptype passive
on_ice_candidate candidate:3 1 TCP 1010827519 172.18.0.5 36291 typ host
tcptype passive
0:00:04.243436959 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:1 2 UDP 2015363326 172.18.0.5 57437 typ
host
on_ice_candidate candidate:1 2 UDP 2015363326 172.18.0.5 57437 typ host
0:00:04.243491372 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:2 2 TCP 1015021822 172.18.0.5 9 typ
host tcptype active
on_ice_candidate candidate:2 2 TCP 1015021822 172.18.0.5 9 typ host tcptype
active
0:00:04.243547228 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:3 2 TCP 1010827518 172.18.0.5 47945 typ
host tcptype passive
on_ice_candidate candidate:3 2 TCP 1010827518 172.18.0.5 47945 typ host
tcptype passive
0:00:04.243612774 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x1
0:00:04.243622773 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x1
0:00:04.243629732 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.243635680 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x2
0:00:04.247743393 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:912:_collate_ice_connection_states:<webrtcbin> returning
checking
0:00:04.247767255 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1247:_update_ice_connection_state_task:<webrtcbin> ICE
connection state change from new(0) to checking(1)
0:00:04.247848555 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.247860570 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x1
0:00:04.247869265 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.247876484 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x1
0:00:04.247884534 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.247892217 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x2. DTLS connection state: 0x8
0:00:04.247898984 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1154:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.247908363 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x1
0:00:04.247916643 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x1
0:00:04.247923645 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.247930634 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x2
0:00:04.247936869 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:912:_collate_ice_connection_states:<webrtcbin> returning
checking
0:00:04.247945965 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.247953823 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x1
0:00:04.247961691 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.247968538 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x1
0:00:04.247975306 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.247982666 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x2. DTLS connection state: 0x8
0:00:04.247989024 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1154:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.247998413 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x1
0:00:04.248006178 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x1
0:00:04.248012826 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.248018986 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x2
0:00:04.248024949 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:912:_collate_ice_connection_states:<webrtcbin> returning
checking
0:00:04.248033598 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.248041013 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x1
0:00:04.248048592 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.248055140 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x1
0:00:04.248061430 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.248068214 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x2. DTLS connection state: 0x8
0:00:04.248074264 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1154:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.248093244 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:4 1 UDP 1679819007 68.8.32.177 41645
typ srflx raddr 172.18.0.5 rport 40437
on_ice_candidate candidate:4 1 UDP 1679819007 68.8.32.177 41645 typ srflx
raddr 172.18.0.5 rport 40437
0:00:04.248224525 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:5 1 TCP 847249663 68.8.32.177 9 typ
srflx raddr 172.18.0.5 rport 9 tcptype active
on_ice_candidate candidate:5 1 TCP 847249663 68.8.32.177 9 typ srflx raddr
172.18.0.5 rport 9 tcptype active
0:00:04.248287010 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:6 1 TCP 843055359 68.8.32.177 36291 typ
srflx raddr 172.18.0.5 rport 36291 tcptype passive
on_ice_candidate candidate:6 1 TCP 843055359 68.8.32.177 36291 typ srflx
raddr 172.18.0.5 rport 36291 tcptype passive
0:00:04.256774319 2466 0x7f7c900b2280 TRACE webrtcbin
gstwebrtcbin.c:4882:_on_local_ice_candidate_cb:<webrtcbin> Queueing
on_ice_candidate_task
0:00:04.256853984 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:4 2 UDP 1679819006 68.8.32.177 39165
typ srflx raddr 172.18.0.5 rport 57437
on_ice_candidate candidate:4 2 UDP 1679819006 68.8.32.177 39165 typ srflx
raddr 172.18.0.5 rport 57437
0:00:04.257026057 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:5 2 TCP 847249662 68.8.32.177 9 typ
srflx raddr 172.18.0.5 rport 9 tcptype active
on_ice_candidate candidate:5 2 TCP 847249662 68.8.32.177 9 typ srflx raddr
172.18.0.5 rport 9 tcptype active
0:00:04.273159784 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4837:_on_local_ice_candidate_task:<webrtcbin> produced ICE
candidate for mline:0 and candidate:6 2 TCP 843055358 68.8.32.177 47945 typ
srflx raddr 172.18.0.5 rport 47945 tcptype passive
on_ice_candidate candidate:6 2 TCP 843055358 68.8.32.177 47945 typ srflx
raddr 172.18.0.5 rport 47945 tcptype passive
0:00:04.274714394 2466 0x58b47b3845e0 DEBUG webrtcicestream
icestream.c:116:_on_candidate_gathering_done:<webrtcicestream0> 1 gathering
done
0:00:04.284772343 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509060 gathering state: 0x2
0:00:04.284800924 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509140 gathering state: 0x2
0:00:04.284815280 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:959:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.284825852 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 gathering state: 0x2
0:00:04.284833778 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:997:_collate_ice_gathering_states:<webrtcbin> ICE gathering
state: 0x4
0:00:04.284841345 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1007:_collate_ice_gathering_states:<webrtcbin> returning
complete
0:00:04.284853011 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1212:_update_ice_gathering_state_task:<webrtcbin> ICE
gathering state change from gathering(1) to complete(2)
0:00:04.284873530 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509060 gathering state: 0x2
0:00:04.284883121 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x58b47b509140 gathering state: 0x2
0:00:04.284891489 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:959:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.284900059 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:975:_collate_ice_gathering_states:<webrtcbin> transceiver
0x7f7c94058a30 gathering state: 0x2
0:00:04.284907711 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:997:_collate_ice_gathering_states:<webrtcbin> ICE gathering
state: 0x4
0:00:04.284914564 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1007:_collate_ice_gathering_states:<webrtcbin> returning
complete
0:00:04.318167415 2466 0x7f7c90083ed0 DEBUG webrtcbin
gstwebrtcbin.c:5259:on_rtpbin_request_pt_map:<webrtcbin> getting pt map for
pt 96 in session 0
0:00:04.318286272 2466 0x7f7c90083ed0 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.318359368 2466 0x7f7c90083ed0 TRACE webrtcbin
gstwebrtcbin.c:5269:on_rtpbin_request_pt_map:<webrtcbin> Found caps
application/x-rtp, media=(string)video, payload=(int)96,
clock-rate=(int)90000, encoding-name=(string)VP8,
rtcp-fb-nack-pli=(boolean)true, rtcp-fb-ccm-fir=(boolean)true for pt 96 in
session 0
0:00:04.318603986 2466 0x7f7c90083ed0 LOG webrtctransportsendbin
transportsendbin.c:160:pad_block:<outputselector0:src_0> blocking pad with
data buffer: 0x7f7c900daa20, pts 99:99:99.999999999, dts
99:99:99.999999999, dur 99:99:99.999999999, size 80, offset none,
offset_end none, flags 0x0
0:00:04.372280386 2466 0x7f7c900b22d0 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport0> 1 1
connected
0:00:04.372353194 2466 0x7f7c900b22d0 LOG webrtctransportsendbin
transportsendbin.c:350:_on_notify_ice_connection_state:<transportsendbin0>
Unblocking pad <dtlssrtpenc0:src>
0:00:04.372392556 2466 0x7f7c900b22d0 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport0> 1 1
ready
0:00:04.372444923 2466 0x7f7c900b2400 FIXME basesink
gstbasesink.c:3386:gst_base_sink_default_event:<nicesink0> stream-start
event without group-id. Consider implementing group-id handling in the
upstream elements
0:00:04.372723506 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x3
0:00:04.372770204 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x3
0:00:04.372788152 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.372803976 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x8
0:00:04.372818846 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:917:_collate_ice_connection_states:<webrtcbin> returning
completed
0:00:04.372837469 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1247:_update_ice_connection_state_task:<webrtcbin> ICE
connection state change from checking(1) to completed(3)
0:00:04.372863317 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.372880485 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x3
0:00:04.372896944 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.372913696 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x3
0:00:04.372928959 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.372944440 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x8. DTLS connection state: 0x8
0:00:04.372958621 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1171:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.372975335 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x3
0:00:04.372991627 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x3
0:00:04.373006240 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.373020435 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x8
0:00:04.373033973 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:917:_collate_ice_connection_states:<webrtcbin> returning
completed
0:00:04.373049759 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x3
0:00:04.373064503 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x3
0:00:04.373079908 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x3
0:00:04.373094512 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x3
0:00:04.373109017 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.373136052 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x8. DTLS connection state: 0x8
0:00:04.373150393 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1171:_collate_peer_connection_states:<webrtcbin> returning
connecting
0:00:04.393425473 2466 0x7f7c900b2230 LOG webrtctransportsendbin
transportsendbin.c:295:_on_dtls_enc_key_set:<transportsendbin0> Unblocking
<dtlssrtpenc0> pads
0:00:04.393972360 2466 0x7f7c90083f70 INFO webrtcbin
gstwebrtcbin.c:5619:on_rtpbin_new_sender_ssrc:<webrtcbin> session 0 ssrc
465568367 new sender ssrc
0:00:04.397703490 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x4
0:00:04.397951672 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x3
0:00:04.398303681 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x4
0:00:04.398812284 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x3
0:00:04.399886757 2466 0x7f7c90083ed0 INFO webrtcbin
gstwebrtcbin.c:5627:on_rtpbin_sender_ssrc_active:<webrtcbin> session 0 ssrc
3497855691 sender ssrc active
0:00:04.399466180 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:04.400560332 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x8. DTLS connection state: 0x10
0:00:04.400798395 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1162:_collate_peer_connection_states:<webrtcbin> returning
connected
0:00:04.401046236 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1282:_update_peer_connection_state_task:<webrtcbin> Peer
connection state change from connecting(1) to connected(2)
0:00:04.564337057 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5576:on_rtpbin_new_ssrc:<webrtcbin> session 0 ssrc 1 new ssrc
0:00:04.564527627 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:04.625442483 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:04.756241000 2466 0x7f7c90083ed0 DEBUG webrtcbin
gstwebrtcbin.c:5259:on_rtpbin_request_pt_map:<webrtcbin> getting pt map for
pt 97 in session 0
0:00:04.757414082 2466 0x7f7c90083ed0 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:04.758616116 2466 0x7f7c90083ed0 TRACE webrtcbin
gstwebrtcbin.c:5269:on_rtpbin_request_pt_map:<webrtcbin> Found caps (NULL)
for pt 97 in session 0
0:00:04.763303904 2466 0x7f7c90083ed0 WARN rtpsource
rtpsource.c:1578:rtp_source_get_new_sr: no clock-rate, cannot interpolate
rtp time for SSRC 465568367
0:00:04.773796232 2466 0x7f7c90083ed0 INFO webrtcbin
gstwebrtcbin.c:5627:on_rtpbin_sender_ssrc_active:<webrtcbin> session 0 ssrc
3497855691 sender ssrc active
0:00:04.780904332 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:04.784526042 2466 0x7f7c90083ed0 INFO webrtcbin
gstwebrtcbin.c:5627:on_rtpbin_sender_ssrc_active:<webrtcbin> session 0 ssrc
465568367 sender ssrc active
0:00:04.808924416 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:04.965853317 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:05.173787805 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:05.371911410 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:05.565984639 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:05.771261422 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:05.968104612 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:06.171078200 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:06.370796303 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:06.572203168 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:06.775277209 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:06.979714849 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:07.182911893 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:07.386129352 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:07.582232460 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_SDP","data":{"sdp":{"type":"offer","sdp":"v=0\r\no=-
6037884307875629115 5 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0
1\r\na=msid-semantic: WMS\r\nm=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8
106 105 13 110 112 113 126\r\nc=IN IP4 0.0.0.0\r\na=rtcp:9 IN IP4
0.0.0.0\r\na=ice-ufrag:mEV3\r\na=ice-pwd:elHiWUbUTm9SIHYJ3KDuHDtm\r\na=ice-options:trickle\r\na=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C\r\na=setup:actpass\r\na=mid:0\r\na=extmap:1
urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4
urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5
urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6
urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=recvonly\r\na=rtcp-mux\r\na=rtpmap:111
opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111
minptime=10;useinbandfec=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104
ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8
PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13
CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112
telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126
telephone-event/8000\r\nm=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122
102 121 127 120 125 107 108 109 124 119 123 118 114 115 116\r\nc=IN IP4
0.0.0.0\r\na=rtcp:9 IN IP4
0.0.0.0\r\na=ice-ufrag:mEV3\r\na=ice-pwd:elHiWUbUTm9SIHYJ3KDuHDtm\r\na=ice-options:trickle\r\na=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C\r\na=setup:actpass\r\na=mid:1\r\na=extmap:14
urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:2
http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13
urn:3gpp:video-orientation\r\na=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12
http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11
http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7
http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8
http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4
urn:ietf:params:rtp-hdrext:sdes:mid\r\na=extmap:5
urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id\r\na=extmap:6
urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id\r\na=recvonly\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96
VP8/90000\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96
transport-cc\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96
nack pli\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:98
VP9/90000\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98
transport-cc\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98
nack pli\r\na=fmtp:98 profile-id=0\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99
apt=98\r\na=rtpmap:100 VP9/90000\r\na=rtcp-fb:100
goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=rtcp-fb:100 ccm
fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=fmtp:100
profile-id=2\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101
apt=100\r\na=rtpmap:122 VP9/90000\r\na=rtcp-fb:122
goog-remb\r\na=rtcp-fb:122 transport-cc\r\na=rtcp-fb:122 ccm
fir\r\na=rtcp-fb:122 nack\r\na=rtcp-fb:122 nack pli\r\na=fmtp:122
profile-id=1\r\na=rtpmap:102 H264/90000\r\na=rtcp-fb:102
goog-remb\r\na=rtcp-fb:102 transport-cc\r\na=rtcp-fb:102 ccm
fir\r\na=rtcp-fb:102 nack\r\na=rtcp-fb:102 nack pli\r\na=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f\r\na=rtpmap:121
rtx/90000\r\na=fmtp:121 apt=102\r\na=rtpmap:127 H264/90000\r\na=rtcp-fb:127
goog-remb\r\na=rtcp-fb:127 transport-cc\r\na=rtcp-fb:127 ccm
fir\r\na=rtcp-fb:127 nack\r\na=rtcp-fb:127 nack pli\r\na=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f\r\na=rtpmap:120
rtx/90000\r\na=fmtp:120 apt=127\r\na=rtpmap:125 H264/90000\r\na=rtcp-fb:125
goog-remb\r\na=rtcp-fb:125 transport-cc\r\na=rtcp-fb:125 ccm
fir\r\na=rtcp-fb:125 nack\r\na=rtcp-fb:125 nack pli\r\na=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:107
rtx/90000\r\na=fmtp:107 apt=125\r\na=rtpmap:108 H264/90000\r\na=rtcp-fb:108
goog-remb\r\na=rtcp-fb:108 transport-cc\r\na=rtcp-fb:108 ccm
fir\r\na=rtcp-fb:108 nack\r\na=rtcp-fb:108 nack pli\r\na=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f\r\na=rtpmap:109
rtx/90000\r\na=fmtp:109 apt=108\r\na=rtpmap:124 H264/90000\r\na=rtcp-fb:124
goog-remb\r\na=rtcp-fb:124 transport-cc\r\na=rtcp-fb:124 ccm
fir\r\na=rtcp-fb:124 nack\r\na=rtcp-fb:124 nack pli\r\na=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033\r\na=rtpmap:119
rtx/90000\r\na=fmtp:119 apt=124\r\na=rtpmap:123 H264/90000\r\na=rtcp-fb:123
goog-remb\r\na=rtcp-fb:123 transport-cc\r\na=rtcp-fb:123 ccm
fir\r\na=rtcp-fb:123 nack\r\na=rtcp-fb:123 nack pli\r\na=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033\r\na=rtpmap:118
rtx/90000\r\na=fmtp:118 apt=123\r\na=rtpmap:114 red/90000\r\na=rtpmap:115
rtx/90000\r\na=fmtp:115 apt=114\r\na=rtpmap:116
ulpfec/90000\r\n"},"user":"123456"}}
GOT SEND_SDP MESSAGE from 123456
Received offer:
v=0
o=- 6037884307875629115 5 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1
a=msid-semantic: WMS
m=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:mEV3
a=ice-pwd:elHiWUbUTm9SIHYJ3KDuHDtm
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122 102 121 127 120 125 107
108 109 124 119 123 118 114 115 116
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:mEV3
a=ice-pwd:elHiWUbUTm9SIHYJ3KDuHDtm
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:122 VP9/90000
a=rtcp-fb:122 goog-remb
a=rtcp-fb:122 transport-cc
a=rtcp-fb:122 ccm fir
a=rtcp-fb:122 nack
a=rtcp-fb:122 nack pli
a=fmtp:122 profile-id=1
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 H264/90000
a=rtcp-fb:124 goog-remb
a=rtcp-fb:124 transport-cc
a=rtcp-fb:124 ccm fir
a=rtcp-fb:124 nack
a=rtcp-fb:124 nack pli
a=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033
a=rtpmap:119 rtx/90000
a=fmtp:119 apt=124
a=rtpmap:123 H264/90000
a=rtcp-fb:123 goog-remb
a=rtcp-fb:123 transport-cc
a=rtcp-fb:123 ccm fir
a=rtcp-fb:123 nack
a=rtcp-fb:123 nack pli
a=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033
a=rtpmap:118 rtx/90000
a=fmtp:118 apt=123
a=rtpmap:114 red/90000
a=rtpmap:115 rtx/90000
a=fmtp:115 apt=114
a=rtpmap:116 ulpfec/90000
0:00:07.791284678 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:4312:_set_description_task:<webrtcbin> Attempting to set
remote offer in the stable state
0:00:07.791421688 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4313:_set_description_task:<webrtcbin> SDP contents
v=0
o=- 6037884307875629115 5 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE 0 1
a=msid-semantic: WMS
m=audio 9 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:mEV3
a=ice-pwd:elHiWUbUTm9SIHYJ3KDuHDtm
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:0
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
m=video 9 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 122 102 121 127 120 125 107
108 109 124 119 123 118 114 115 116
c=IN IP4 0.0.0.0
a=rtcp:9 IN IP4 0.0.0.0
a=ice-ufrag:mEV3
a=ice-pwd:elHiWUbUTm9SIHYJ3KDuHDtm
a=ice-options:trickle
a=fingerprint:sha-256
8E:46:00:21:C6:6C:D0:53:10:70:C9:98:03:92:03:F2:6F:53:AB:2F:04:67:35:E7:96:5E:41:1D:C1:7E:34:4C
a=setup:actpass
a=mid:1
a=extmap:14 urn:ietf:params:rtp-hdrext:toffset
a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=extmap:13 urn:3gpp:video-orientation
a=extmap:3
http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
a=extmap:12 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
a=extmap:11 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type
a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-timing
a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/color-space
a=extmap:4 urn:ietf:params:rtp-hdrext:sdes:mid
a=extmap:5 urn:ietf:params:rtp-hdrext:sdes:rtp-stream-id
a=extmap:6 urn:ietf:params:rtp-hdrext:sdes:repaired-rtp-stream-id
a=recvonly
a=rtcp-mux
a=rtcp-rsize
a=rtpmap:96 VP8/90000
a=rtcp-fb:96 goog-remb
a=rtcp-fb:96 transport-cc
a=rtcp-fb:96 ccm fir
a=rtcp-fb:96 nack
a=rtcp-fb:96 nack pli
a=rtpmap:97 rtx/90000
a=fmtp:97 apt=96
a=rtpmap:98 VP9/90000
a=rtcp-fb:98 goog-remb
a=rtcp-fb:98 transport-cc
a=rtcp-fb:98 ccm fir
a=rtcp-fb:98 nack
a=rtcp-fb:98 nack pli
a=fmtp:98 profile-id=0
a=rtpmap:99 rtx/90000
a=fmtp:99 apt=98
a=rtpmap:100 VP9/90000
a=rtcp-fb:100 goog-remb
a=rtcp-fb:100 transport-cc
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=fmtp:100 profile-id=2
a=rtpmap:101 rtx/90000
a=fmtp:101 apt=100
a=rtpmap:122 VP9/90000
a=rtcp-fb:122 goog-remb
a=rtcp-fb:122 transport-cc
a=rtcp-fb:122 ccm fir
a=rtcp-fb:122 nack
a=rtcp-fb:122 nack pli
a=fmtp:122 profile-id=1
a=rtpmap:102 H264/90000
a=rtcp-fb:102 goog-remb
a=rtcp-fb:102 transport-cc
a=rtcp-fb:102 ccm fir
a=rtcp-fb:102 nack
a=rtcp-fb:102 nack pli
a=fmtp:102
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f
a=rtpmap:121 rtx/90000
a=fmtp:121 apt=102
a=rtpmap:127 H264/90000
a=rtcp-fb:127 goog-remb
a=rtcp-fb:127 transport-cc
a=rtcp-fb:127 ccm fir
a=rtcp-fb:127 nack
a=rtcp-fb:127 nack pli
a=fmtp:127
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f
a=rtpmap:120 rtx/90000
a=fmtp:120 apt=127
a=rtpmap:125 H264/90000
a=rtcp-fb:125 goog-remb
a=rtcp-fb:125 transport-cc
a=rtcp-fb:125 ccm fir
a=rtcp-fb:125 nack
a=rtcp-fb:125 nack pli
a=fmtp:125
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
a=rtpmap:107 rtx/90000
a=fmtp:107 apt=125
a=rtpmap:108 H264/90000
a=rtcp-fb:108 goog-remb
a=rtcp-fb:108 transport-cc
a=rtcp-fb:108 ccm fir
a=rtcp-fb:108 nack
a=rtcp-fb:108 nack pli
a=fmtp:108
level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f
a=rtpmap:109 rtx/90000
a=fmtp:109 apt=108
a=rtpmap:124 H264/90000
a=rtcp-fb:124 goog-remb
a=rtcp-fb:124 transport-cc
a=rtcp-fb:124 ccm fir
a=rtcp-fb:124 nack
a=rtcp-fb:124 nack pli
a=fmtp:124
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=4d0033
a=rtpmap:119 rtx/90000
a=fmtp:119 apt=124
a=rtpmap:123 H264/90000
a=rtcp-fb:123 goog-remb
a=rtcp-fb:123 transport-cc
a=rtcp-fb:123 ccm fir
a=rtcp-fb:123 nack
a=rtcp-fb:123 nack pli
a=fmtp:123
level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=640033
a=rtpmap:118 rtx/90000
a=fmtp:118 apt=123
a=rtpmap:114 red/90000
a=rtpmap:115 rtx/90000
a=fmtp:115 apt=114
a=rtpmap:116 ulpfec/90000
0:00:07.791997046 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:4479:_set_description_task:<webrtcbin> we are in ice
controlling mode: false
0:00:07.792046521 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.792090029 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.793996416 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.795176100 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:746:gst_webrtc_ice_set_remote_credentials:<webrtcbin0:ice>
Setting remote ICE credentials on ICE stream 1 ufrag:mEV3
pwd:elHiWUbUTm9SIHYJ3KDuHDtm
0:00:07.795616284 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.796243513 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.797615658 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:07.798421961 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.799180821 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:746:gst_webrtc_ice_set_remote_credentials:<webrtcbin0:ice>
Setting remote ICE credentials on ICE stream 1 ufrag:mEV3
pwd:elHiWUbUTm9SIHYJ3KDuHDtm
0:00:07.799627578 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4640:_set_description_task:<webrtcbin> notify
signaling-state from have-remote-offer to have-remote-offer
-----------SET REMOTE DESCRIPTION------------
0:00:07.800173749 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:3310:_create_sdp_task:<webrtcbin> creating answer sdp with
options (NULL)
0:00:07.802944590 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1545:_find_codec_preferences:<webrtcbin> retrieving codec
preferences from <webrtctransceiver0>
0:00:07.803153309 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3103:_create_answer_task:<webrtcbin> Found existing
previously negotiated transceiver <webrtctransceiver0> from mid 0 for mline
0 using caps application/x-rtp, media=(string)video, clock-rate=(int)90000,
encoding-name=(string)VP8, payload=(int)96, seqnum-offset=(uint)12225,
timestamp-offset=(uint)3612195570, ssrc=(uint)3497855691,
a-framerate=(string)30
0:00:07.806307896 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1545:_find_codec_preferences:<webrtcbin> retrieving codec
preferences from <webrtctransceiver1>
0:00:07.814746217 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3103:_create_answer_task:<webrtcbin> Found existing
previously negotiated transceiver <webrtctransceiver1> from mid 1 for mline
1 using caps application/x-rtp, media=(string)audio, clock-rate=(int)48000,
encoding-name=(string)OPUS, sprop-maxcapturerate=(string)48000,
sprop-stereo=(string)0, payload=(int)97, encoding-params=(string)2,
seqnum-offset=(uint)28659, timestamp-offset=(uint)1614781904,
ssrc=(uint)465568367
-----------SENDING SDP ANSWER------------
on_answer_created
sending SDP answer to peer: v=0
o=- 6037884307875629115 5 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1
m=video 9 UDP/TLS/RTP/SAVPF 96
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:0
a=rtcp-mux
a=setup:active
a=rtpmap:96 VP8/90000
a=framerate:30
a=ssrc:3497855691 msid:user2578524959 at host-e8f12b09 webrtctransceiver0
a=ssrc:3497855691 cname:user2578524959 at host-e8f12b09
a=sendonly
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
m=audio 9 UDP/TLS/RTP/SAVPF 97
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:1
a=rtcp-mux
a=setup:active
a=rtpmap:97 OPUS/48000/2
a=fmtp:97 sprop-maxcapturerate=48000;sprop-stereo=0
a=ssrc:465568367 msid:user2578524959 at host-e8f12b09 webrtctransceiver1
a=ssrc:465568367 cname:user2578524959 at host-e8f12b09
a=sendonly
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_CANDIDATE","data":{"candidate":{"candidate":"candidate:63126866
1 udp 2113937151 ec09dc7d-e98b-4caa-b8af-ae9b04577210.local 43331 typ host
generation 3 ufrag mEV3 network-cost
999","sdpMid":"0","sdpMLineIndex":0},"user":"123456"}}
GOT SEND_CANDIDATE MESSAGE
handle_ice:
candidate:63126866 1 udp 2113937151
ec09dc7d-e98b-4caa-b8af-ae9b04577210.local 43331 typ host generation 3
ufrag mEV3 network-cost 999
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_CANDIDATE","data":{"candidate":{"candidate":"candidate:3933521124
1 udp 2113934591 e4de021a-535c-4e08-83f1-8b00c44ad5a2.local 35398 typ host
generation 3 ufrag mEV3 network-cost
999","sdpMid":"0","sdpMLineIndex":0},"user":"123456"}}
GOT SEND_CANDIDATE MESSAGE
handle_ice:
candidate:3933521124 1 udp 2113934591
e4de021a-535c-4e08-83f1-8b00c44ad5a2.local 35398 typ host generation 3
ufrag mEV3 network-cost 999
Sending message
{"protocol":"one-to-one","to":"123456","action":"SEND_SDP","data":{"sdp":{"type":"answer","sdp":"v=0\r\no=-
6037884307875629115 5 IN IP4 0.0.0.0\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0
1\r\nm=video 9 UDP/TLS/RTP/SAVPF 96\r\nc=IN IP4
0.0.0.0\r\na=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN\r\na=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu\r\na=mid:0\r\na=rtcp-mux\r\na=setup:active\r\na=rtpmap:96
VP8/90000\r\na=framerate:30\r\na=ssrc:3497855691
msid:user2578524959 at host-e8f12b09 webrtctransceiver0\r\na=ssrc:3497855691
cname:user2578524959 at host-e8f12b09\r\na=sendonly\r\na=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE\r\nm=audio
9 UDP/TLS/RTP/SAVPF 97\r\nc=IN IP4
0.0.0.0\r\na=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN\r\na=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu\r\na=mid:1\r\na=rtcp-mux\r\na=setup:active\r\na=rtpmap:97
OPUS/48000/2\r\na=fmtp:97
sprop-maxcapturerate=48000;sprop-stereo=0\r\na=ssrc:465568367
msid:user2578524959 at host-e8f12b09 webrtctransceiver1\r\na=ssrc:465568367
cname:user2578524959 at host-e8f12b09\r\na=sendonly\r\na=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE\r\n"},"user":"ges-webrtc-service"}}
0:00:07.826491279 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:4312:_set_description_task:<webrtcbin> Attempting to set
local answer in the have-remote-offer state
0:00:07.826737395 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4313:_set_description_task:<webrtcbin> SDP contents
v=0
o=- 6037884307875629115 5 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1
m=video 9 UDP/TLS/RTP/SAVPF 96
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:0
a=rtcp-mux
a=setup:active
a=rtpmap:96 VP8/90000
a=framerate:30
a=ssrc:3497855691 msid:user2578524959 at host-e8f12b09 webrtctransceiver0
a=ssrc:3497855691 cname:user2578524959 at host-e8f12b09
a=sendonly
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
m=audio 9 UDP/TLS/RTP/SAVPF 97
c=IN IP4 0.0.0.0
a=ice-ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN
a=ice-pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
a=mid:1
a=rtcp-mux
a=setup:active
a=rtpmap:97 OPUS/48000/2
a=fmtp:97 sprop-maxcapturerate=48000;sprop-stereo=0
a=ssrc:465568367 msid:user2578524959 at host-e8f12b09 webrtctransceiver1
a=ssrc:465568367 cname:user2578524959 at host-e8f12b09
a=sendonly
a=fingerprint:sha-256
7D:F6:6B:3F:33:81:56:F6:46:60:6E:18:F4:CB:F3:2A:1E:2F:D3:28:F6:25:E7:F5:BD:14:77:19:19:A0:5F:BE
0:00:07.826833318 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:4479:_set_description_task:<webrtcbin> we are in ice
controlling mode: false
0:00:07.826859249 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.826883333 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.826956753 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.827129672 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp session level attributes to caps
0:00:07.827148891 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp media level attributes to caps
0:00:07.827171907 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:<webrtcbin> looking
at 0 pt: 96
0:00:07.827204179 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp session level attributes to caps
0:00:07.827214192 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:<webrtcbin> mapping
sdp media level attributes to caps
0:00:07.827230943 2466 0x7f7c98005000 DEBUG webrtcbin
gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:<webrtcbin> looking
at 0 pt: 97
0:00:07.827260933 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.827333368 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:<webrtcbin> Found
transceiver <webrtctransceiver0>
0:00:07.827349611 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.827368771 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.827622306 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.828150605 2466 0x7f7c98005000 FIXME webrtcbin
gstwebrtcbin.c:3828:_update_transceiver_from_sdp_media:<webrtcbin>
implement transceiver direction changes
0:00:07.828183303 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:<webrtcbin> Found
transceiver <webrtctransceiver1>
0:00:07.833425299 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.833556666 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.833973815 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.834589648 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3863:_update_transceiver_from_sdp_media:<webrtcbin> marking
stream 0x7f7c98002d40 as active
0:00:07.834621003 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.834833295 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.835508304 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.835625265 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:805:gst_webrtc_ice_set_local_credentials:<webrtcbin0:ice>
Setting local ICE credentials on ICE stream 1
ufrag:PlcKGP4B+N73iCLii7TubbfCVEFWLXXN pwd:9El7McL63197VYihxUTmeJn9vIMpMfOu
0:00:07.835712060 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:07.835728506 2466 0x7f7c98005000 DEBUG webrtctransportsendbin
transportsendbin.c:195:transport_send_bin_change_state:<transportsendbin0>
changing state: PLAYING => PLAYING
0:00:07.835823179 2466 0x7f7c98005000 DEBUG webrtctransportreceivebin
transportreceivebin.c:236:transport_receive_bin_change_state: changing
state: PLAYING => PLAYING
0:00:07.836077452 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:823:gst_webrtc_ice_gather_candidates:<webrtcbin0:ice> gather
candidates for stream 1
0:00:07.836099703 2466 0x7f7c98005000 DEBUG webrtcicestream
icestream.c:177:gst_webrtc_ice_stream_gather_candidates:<webrtcicestream0>
start gathering candidates
0:00:07.836122081 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:4640:_set_description_task:<webrtcbin> notify
signaling-state from stable to stable
0:00:07.836174797 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:<webrtcbin> checking if
negotiation is needed
0:00:07.836199274 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:1478:_check_if_negotiation_is_needed:<webrtcbin> transceiver
direction (sendrecv) doesn't match description intersected direction
sendonly (local sendonly remote recvonly)
0:00:07.836209186 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1499:_check_need_negotiation_task:<webrtcbin> emitting
on-negotiation-needed
0:00:07.836292620 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:394:_find_ice_stream_for_session:<webrtcbin> Found ice
stream id <webrtcicestream0> for session 0
0:00:07.836308842 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3601:_add_ice_candidate:<webrtcbin> adding ICE candidate
with mline:0, a=candidate:63126866 1 udp 2113937151
ec09dc7d-e98b-4caa-b8af-ae9b04577210.local 43331 typ host generation 3
ufrag mEV3 network-cost 999
0:00:07.836379330 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:313:_resolve_host:<webrtcbin0:ice> Resolving host
ec09dc7d-e98b-4caa-b8af-ae9b04577210.local
0:00:07.842732024 2466 0x7f7c98005000 ERROR webrtcice
gstwebrtcice.c:316:_resolve_host: Error resolving
“ec09dc7d-e98b-4caa-b8af-ae9b04577210.local”: Name or service not known
0:00:07.842768010 2466 0x7f7c98005000 WARN webrtcice
gstwebrtcice.c:690:gst_webrtc_ice_add_candidate:<webrtcbin0:ice> Failed to
resolve ec09dc7d-e98b-4caa-b8af-ae9b04577210.local
0:00:07.842795756 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:394:_find_ice_stream_for_session:<webrtcbin> Found ice
stream id <webrtcicestream0> for session 0
0:00:07.842810874 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3601:_add_ice_candidate:<webrtcbin> adding ICE candidate
with mline:0, a=candidate:3933521124 1 udp 2113934591
e4de021a-535c-4e08-83f1-8b00c44ad5a2.local 35398 typ host generation 3
ufrag mEV3 network-cost 999
0:00:07.844057594 2466 0x7f7c98005000 DEBUG webrtcice
gstwebrtcice.c:313:_resolve_host:<webrtcbin0:ice> Resolving host
e4de021a-535c-4e08-83f1-8b00c44ad5a2.local
0:00:07.849683557 2466 0x7f7c98005000 ERROR webrtcice
gstwebrtcice.c:316:_resolve_host: Error resolving
“e4de021a-535c-4e08-83f1-8b00c44ad5a2.local”: Name or service not known
0:00:07.849777147 2466 0x7f7c98005000 WARN webrtcice
gstwebrtcice.c:690:gst_webrtc_ice_add_candidate:<webrtcbin0:ice> Failed to
resolve e4de021a-535c-4e08-83f1-8b00c44ad5a2.local
handle_websocket_message:
{"protocol":"one-to-one","to":"ges-webrtc-service","action":"SEND_CANDIDATE","data":{"candidate":{"candidate":"candidate:842163049
1 udp 1677729535 68.8.32.177 33783 typ srflx raddr 0.0.0.0 rport 0
generation 3 ufrag mEV3 network-cost
999","sdpMid":"0","sdpMLineIndex":0},"user":"123456"}}
GOT SEND_CANDIDATE MESSAGE
handle_ice:
candidate:842163049 1 udp 1677729535 68.8.32.177 33783 typ srflx raddr
0.0.0.0 rport 0 generation 3 ufrag mEV3 network-cost 999
0:00:07.855120833 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:394:_find_ice_stream_for_session:<webrtcbin> Found ice
stream id <webrtcicestream0> for session 0
0:00:07.855139754 2466 0x7f7c98005000 LOG webrtcbin
gstwebrtcbin.c:3601:_add_ice_candidate:<webrtcbin> adding ICE candidate
with mline:0, a=candidate:842163049 1 udp 1677729535 68.8.32.177 33783 typ
srflx raddr 0.0.0.0 rport 0 generation 3 ufrag mEV3 network-cost 999
0:00:07.855301370 2466 0x7f7c98005000 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport0> 1 1
connected
0:00:07.855360226 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x2
0:00:07.855371773 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x2
0:00:07.855380585 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:07.855388679 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x4
0:00:07.855395568 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:922:_collate_ice_connection_states:<webrtcbin> returning
connected
0:00:07.855406640 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1247:_update_ice_connection_state_task:<webrtcbin> ICE
connection state change from completed(3) to connected(2)
0:00:07.855421699 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x4
0:00:07.855431074 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x2
0:00:07.855439294 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x4
0:00:07.855446977 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x2
0:00:07.855454619 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:07.855463129 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x4. DTLS connection state: 0x10
0:00:07.855470032 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1162:_collate_peer_connection_states:<webrtcbin> returning
connected
0:00:07.984381133 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:08.081011841 2466 0x7f7c900b22d0 DEBUG webrtcnicetransport
nicetransport.c:186:_on_component_state_changed:<webrtcnicetransport0> 1 1
ready
0:00:08.081107663 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509060 state 0x3
0:00:08.081122577 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:858:_collate_ice_connection_states:<webrtcbin> transceiver
0x58b47b509140 state 0x3
0:00:08.081132564 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:847:_collate_ice_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:08.081141136 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:888:_collate_ice_connection_states:<webrtcbin> ICE
connection state: 0x8
0:00:08.081149055 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:917:_collate_ice_connection_states:<webrtcbin> returning
completed
0:00:08.081161913 2466 0x7f7c98005000 INFO webrtcbin
gstwebrtcbin.c:1247:_update_ice_connection_state_task:<webrtcbin> ICE
connection state change from connected(2) to completed(3)
0:00:08.081179455 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 DTLS state: 0x4
0:00:08.081189127 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509060 ICE state: 0x3
0:00:08.081197854 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1060:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 DTLS state: 0x4
0:00:08.081206549 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1073:_collate_peer_connection_states:<webrtcbin> transceiver
0x58b47b509140 ICE state: 0x3
0:00:08.081214585 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1050:_collate_peer_connection_states:<webrtcbin> transceiver
0x7f7c94058a30 has no mid
0:00:08.081223688 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1118:_collate_peer_connection_states:<webrtcbin> ICE
connection state: 0x8. DTLS connection state: 0x10
0:00:08.081231187 2466 0x7f7c98005000 TRACE webrtcbin
gstwebrtcbin.c:1162:_collate_peer_connection_states:<webrtcbin> returning
connected
0:00:08.181530613 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:08.386843059 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:08.586541507 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:08.783631002 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:08.991216724 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:09.153280307 2466 0x7f7c90083ed0 DEBUG webrtcbin
gstwebrtcbin.c:5259:on_rtpbin_request_pt_map:<webrtcbin> getting pt map for
pt 97 in session 0
0:00:09.153419827 2466 0x7f7c90083ed0 TRACE webrtcbin
gstwebrtcbin.c:508:_find_transport_for_session:<webrtcbin> Found transport
<transportstream0> for session 0
0:00:09.153470733 2466 0x7f7c90083ed0 TRACE webrtcbin
gstwebrtcbin.c:5269:on_rtpbin_request_pt_map:<webrtcbin> Found caps
application/x-rtp, media=(string)audio, payload=(int)97,
clock-rate=(int)48000, encoding-name=(string)OPUS,
encoding-params=(string)2, sprop-maxcapturerate=(string)48000,
sprop-stereo=(string)0 for pt 97 in session 0
0:00:09.156492981 2466 0x7f7c90083ed0 INFO webrtcbin
gstwebrtcbin.c:5627:on_rtpbin_sender_ssrc_active:<webrtcbin> session 0 ssrc
3497855691 sender ssrc active
0:00:09.160586274 2466 0x7f7c90083ed0 INFO webrtcbin
gstwebrtcbin.c:5627:on_rtpbin_sender_ssrc_active:<webrtcbin> session 0 ssrc
465568367 sender ssrc active
0:00:09.202115716 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:09.400252636 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:09.606276215 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:09.823805590 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:10.011814841 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:10.208918998 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:10.409515722 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:10.609140676 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:10.804380944 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:11.014004889 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:11.207673524 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:11.439261574 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
0:00:11.611624416 2466 0x7f7c900b2230 INFO webrtcbin
gstwebrtcbin.c:5583:on_rtpbin_ssrc_active:<webrtcbin> session 0 ssrc 1
active
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/gstreamer-devel/attachments/20201024/e7c0bc50/attachment-0001.htm>
More information about the gstreamer-devel
mailing list