<div dir="ltr">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.<div> </div><div>In general, I'm following <a href="https://github.com/centricular/gstwebrtc-demos/blob/master/sendrecv/">https://github.com/centricular/gstwebrtc-demos/blob/master/sendrecv/</a> 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). </div><div> </div><div>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). </div><div> </div><div>(Full logs with GST_DEBUG=3,webrtc*:7 on are attached at bottom).</div><div> </div><div>In summary, here is the pipeline:</div><div> </div><div>videotestsrc pattern=ball is-live=true ! vp8enc deadline=1 ! rtpvp8pay pt=96 ! webrtcbin. \ </div><div>audiotestsrc is-live=true ! opusenc ! rtpopuspay pt=97 ! webrtcbin. \ </div><div>webrtcbin name=webrtcbin </div><div> </div><div>Here is my SDP offer that I send from Chrome:</div><div> </div><div>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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:13 urn:3gpp:video-orientation a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> a=extmap:12 <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay</a> a=extmap:11 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type</a> a=extmap:7 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing">http://www.webrtc.org/experiments/rtp-hdrext/video-timing</a> a=extmap:8 <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space">http://www.webrtc.org/experiments/rtp-hdrext/color-space</a> 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 </div><div> </div><div>In response, I get back this SDP answer:</div><div> </div><div>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@host-5afdf240 webrtctransceiver0 a=ssrc:1290502017 cname:user2307279746@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 </div><div> </div><div>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.</div><div> </div><div>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.</div><div> </div><div>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:</div><div> </div><div>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@host-8f3a122d webrtctransceiver0 a=ssrc:422817870 cname:user2542828131@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@host-8f3a122d webrtctransceiver1 a=ssrc:4187272436 cname:user2542828131@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 </div><div> </div><div>However, this triggers an error in Chrome because the m-lines are in the opposite order.</div><div></div><div> </div><div>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. </div><div> </div><div> </div><div>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)! </div><div> </div><div>----------</div><div> </div><div>Here is an example set of logs with (apologies for my terribly formatted println!() debugging messages mixed in)</div><div> </div><div>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://<a href="http://stun.l.google.com:19302">stun.l.google.com:19302</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3</a> <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13</a> urn:3gpp:video-orientation\r\na=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8">http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4">http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:13 urn:3gpp:video-orientation a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> a=extmap:12 <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay</a> a=extmap:11 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type</a> a=extmap:7 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing">http://www.webrtc.org/experiments/rtp-hdrext/video-timing</a> a=extmap:8 <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space">http://www.webrtc.org/experiments/rtp-hdrext/color-space</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:13 urn:3gpp:video-orientation a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> a=extmap:12 <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay</a> a=extmap:11 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type</a> a=extmap:7 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing">http://www.webrtc.org/experiments/rtp-hdrext/video-timing</a> a=extmap:8 <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space">http://www.webrtc.org/experiments/rtp-hdrext/color-space</a> 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://<a href="http://stun.l.google.com:19302">stun.l.google.com:19302</a> 0:00:04.107519650 2466 0x7f7c98005000 DEBUG webrtcice gstwebrtcice.c:313:_resolve_host:<webrtcbin0:ice> Resolving host <a href="http://stun.l.google.com">stun.l.google.com</a> 0:00:04.117080140 2466 0x7f7c98005000 DEBUG webrtcice gstwebrtcice.c:322:_resolve_host:<webrtcbin0:ice> Resolved 1 addresses for host <a href="http://stun.l.google.com">stun.l.google.com</a> 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@host-e8f12b09 webrtctransceiver0 a=ssrc:3497855691 cname:user2578524959@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@host-e8f12b09 webrtctransceiver0\r\na=ssrc:3497855691 cname:user2578524959@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@host-e8f12b09 webrtctransceiver0 a=ssrc:3497855691 cname:user2578524959@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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3</a> <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:4</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:13</a> urn:3gpp:video-orientation\r\na=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:12</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=extmap:11</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type\r\na=extmap:7</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8">http://www.webrtc.org/experiments/rtp-hdrext/video-timing\r\na=extmap:8</a> <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4">http://www.webrtc.org/experiments/rtp-hdrext/color-space\r\na=extmap:4</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:13 urn:3gpp:video-orientation a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> a=extmap:12 <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay</a> a=extmap:11 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type</a> a=extmap:7 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing">http://www.webrtc.org/experiments/rtp-hdrext/video-timing</a> a=extmap:8 <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space">http://www.webrtc.org/experiments/rtp-hdrext/color-space</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> 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 <a href="http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time">http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time</a> a=extmap:13 urn:3gpp:video-orientation a=extmap:3 <a href="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01">http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01</a> a=extmap:12 <a href="http://www.webrtc.org/experiments/rtp-hdrext/playout-delay">http://www.webrtc.org/experiments/rtp-hdrext/playout-delay</a> a=extmap:11 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-content-type">http://www.webrtc.org/experiments/rtp-hdrext/video-content-type</a> a=extmap:7 <a href="http://www.webrtc.org/experiments/rtp-hdrext/video-timing">http://www.webrtc.org/experiments/rtp-hdrext/video-timing</a> a=extmap:8 <a href="http://www.webrtc.org/experiments/rtp-hdrext/color-space">http://www.webrtc.org/experiments/rtp-hdrext/color-space</a> 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@host-e8f12b09 webrtctransceiver0 a=ssrc:3497855691 cname:user2578524959@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@host-e8f12b09 webrtctransceiver1 a=ssrc:465568367 cname:user2578524959@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@host-e8f12b09 webrtctransceiver0\r\na=ssrc:3497855691 cname:user2578524959@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@host-e8f12b09 webrtctransceiver1\r\na=ssrc:465568367 cname:user2578524959@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@host-e8f12b09 webrtctransceiver0 a=ssrc:3497855691 cname:user2578524959@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@host-e8f12b09 webrtctransceiver1 a=ssrc:465568367 cname:user2578524959@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 </div><div> </div></div>