WebRTCBin _get_or_create_data_channel_transports: code should not be reached
Hello,
I'm trying to connect GStreamer to Twilio with WebRTC.
I created the whole signaling clienta but WebRTCBin does not want to work firstly i was using GStreamer from 1.16 barnch and i was geting this log:
format field of data channel m= line is not webrtc-datachannel
Now i builded the gstreamer using gst-build from master branch, so i have
GStreamer version: 1.17.0
WebRTCBin version: 1.17.0.1
And i'm getting this kind of Warnings:
** (gst1-java-core:24508): WARNING **: 10:57:51.957: (../subprojects/gst-plugins-bad/ext/webrtc/gstwebrtcbin.c:1991):_get_or_create_data_channel_transports: code should not be reached
The whole log:
0:00:00.985220208 [335m24508[00m 0x7ff4b051cb50 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:5715:gst_webrtc_bin_change_state:[00m changing state: NULL => READY
0:00:00.985478725 [335m24508[00m 0x7ff4b051cb50 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:[00m checking if negotiation is needed
0:00:00.985486660 [335m24508[00m 0x7ff4b051cb50 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:1357:_check_if_negotiation_is_needed:[00m no local description set
0:00:00.985519912 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1499:_check_need_negotiation_task:[00m emitting on-negotiation-needed
0:00:00.994391220 [335m24508[00m 0x7ff4b051cb50 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:5715:gst_webrtc_bin_change_state:[00m changing state: READY => PAUSED
0:00:00.995641181 [335m24508[00m 0x7ff4b051cb50 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:5715:gst_webrtc_bin_change_state:[00m changing state: PAUSED => PLAYING
0:00:01.420612947 [335m24508[00m 0x7ff4b051ce60 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:754:_validate_turn_server:[00m validating turn server, turn://38a48c6451de7733503b9327ac87cd188ab3de95de8a41d942787b91a6ee0327:RemuuiqXD5nBOZqgoEVqDhYAqmtmI6s+KczM4I3ukf4=@frankfurt.turn.twilio.com:3478
0:00:01.426513066 [335m24508[00m 0x7ff4b051ce60 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:754:_validate_turn_server:[00m validating turn server, turns://38a48c6451de7733503b9327ac87cd188ab3de95de8a41d942787b91a6ee0327:RemuuiqXD5nBOZqgoEVqDhYAqmtmI6s+KczM4I3ukf4=@frankfurt.turn.twilio.com:443
{"subscribe":{"rules":[{"all":true,"type":"include"}],"revision":1},"name":"HIBGVBSWJX","recording":{"enabled":false,"revision":1},"published":{"tracks":[],"revision":1},"type":"update","version":2,"participant":{"identity":"test","state":"connected","tracks":[],"sid":"PAc4d7c14f7e87ed157e230782fef13484","revision":1},"sid":"RM79bfa678f90b83b132a60fe0db1135f8","participants":[]}
0:00:02.690512829 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:4312:_set_description_task:[00m Attempting to set remote offer in the stable state
0:00:02.690541262 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4313:_set_description_task:[00m SDP contents
v=0
o=- 3801459471 3801459472 IN IP4 0.0.0.0
s=VM55490d6834aea1121522901a477a95ec
c=IN IP4 0.0.0.0
t=0 0
a=ice-lite
a=group:BUNDLE 0 1 application0
a=msid-semantic:WMS *
m=audio 1 UDP/TLS/RTP/SAVPF 109 0
c=IN IP4 0.0.0.0
a=rtpmap:109 opus/48000/2
a=rtpmap:0 PCMU/8000
a=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1
a=rtcp:9 IN IP4 0.0.0.0
a=rtcp-mux
a=setup:actpass
a=recvonly
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=mid:0
a=ice-ufrag:WOxm
a=ice-pwd:F9jiBNeajvZxyXQEZ5w5QI
a=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host
a=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host
a=fingerprint:sha-256 B0:AC:68:F7:95:55:05:A6:83:76:F5:FA:83:D3:59:F2:6D:1A:F8:00:BD:47:A6:34:4C:D6:31:4B:6C:F3:C4:7D
m=video 1 UDP/TLS/RTP/SAVPF 120 126
c=IN IP4 0.0.0.0
a=rtpmap:120 VP8/90000
a=rtpmap:126 H264/90000
a=fmtp:120 max-fs=12288;max-fr=60
a=fmtp:126 profile-level-id=42e01f;level-asymmetry-allowed=1;packetization-mode=1
a=rtcp:9 IN IP4 0.0.0.0
a=rtcp-mux
a=rtcp-rsize
a=setup:actpass
a=recvonly
a=extmap:4 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=mid:1
a=rtcp-fb:120 nack
a=rtcp-fb:120 nack pli
a=rtcp-fb:120 goog-remb
a=rtcp-fb:120 ccm fir
a=rtcp-fb:126 nack
a=rtcp-fb:126 nack pli
a=rtcp-fb:126 goog-remb
a=rtcp-fb:126 ccm fir
a=ice-ufrag:WOxm
a=ice-pwd:F9jiBNeajvZxyXQEZ5w5QI
a=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host
a=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host
a=fingerprint:sha-256 B0:AC:68:F7:95:55:05:A6:83:76:F5:FA:83:D3:59:F2:6D:1A:F8:00:BD:47:A6:34:4C:D6:31:4B:6C:F3:C4:7D
m=application 1 DTLS/SCTP 5000
c=IN IP4 0.0.0.0
a=sctpmap:5000 webrtc-datachannel 16
a=setup:actpass
a=mid:application0
a=ice-ufrag:WOxm
a=ice-pwd:F9jiBNeajvZxyXQEZ5w5QI
a=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host
a=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host
a=fingerprint:sha-256 B0:AC:68:F7:95:55:05:A6:83:76:F5:FA:83:D3:59:F2:6D:1A:F8:00:BD:47:A6:34:4C:D6:31:4B:6C:F3:C4:7D
0:00:02.690597218 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:4475:_set_description_task:[00m we are in ice controlling mode: true
0:00:02.690618237 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport (NULL) for session 0
{"subscribed":{"tracks":[],"revision":0},"name":"HIBGVBSWJX","recording":{"enabled":false,"revision":1},"peer_connections":[{"description":{"type":"offer","sdp":"v=0\r\no=- 3801459471 3801459472 IN IP4 0.0.0.0\r\ns=VM55490d6834aea1121522901a477a95ec\r\nc=IN IP4 0.0.0.0\r\nt=0 0\r\na=ice-lite\r\na=group:BUNDLE 0 1 application0\r\na=msid-semantic:WMS *\r\nm=audio 1 UDP/TLS/RTP/SAVPF 109 0\r\nc=IN IP4 0.0.0.0\r\na=rtpmap:109 opus/48000/2\r\na=rtpmap:0 PCMU/8000\r\na=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=rtcp-mux\r\na=setup:actpass\r\na=recvonly\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=mid:0\r\na=ice-ufrag:WOxm\r\na=ice-pwd:F9jiBNeajvZxyXQEZ5w5QI\r\na=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host\r\na=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host\r\na=fingerprint:sha-256 B0:AC:68:F7:95:55:05:A6:83:76:F5:FA:83:D3:59:F2:6D:1A:F8:00:BD:47:A6:34:4C:D6:31:4B:6C:F3:C4:7D\r\nm=video 1 UDP/TLS/RTP/SAVPF 120 126\r\nc=IN IP4 0.0.0.0\r\na=rtpmap:120 VP8/90000\r\na=rtpmap:126 H264/90000\r\na=fmtp:120 max-fs=12288;max-fr=60\r\na=fmtp:126 profile-level-id=42e01f;level-asymmetry-allowed=1;packetization-mode=1\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=setup:actpass\r\na=recvonly\r\na=extmap:4 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=mid:1\r\na=rtcp-fb:120 nack\r\na=rtcp-fb:120 nack pli\r\na=rtcp-fb:120 goog-remb\r\na=rtcp-fb:120 ccm fir\r\na=rtcp-fb:126 nack\r\na=rtcp-fb:126 nack pli\r\na=rtcp-fb:126 goog-remb\r\na=rtcp-fb:126 ccm fir\r\na=ice-ufrag:WOxm\r\na=ice-pwd:F9jiBNeajvZxyXQEZ5w5QI\r\na=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host\r\na=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host\r\na=fingerprint:sha-256 B0:AC:68:F7:95:55:05:A6:83:76:F5:FA:83:D3:59:F2:6D:1A:F8:00:BD:47:A6:34:4C:D6:31:4B:6C:F3:C4:7D\r\nm=application 1 DTLS/SCTP 5000\r\nc=IN IP4 0.0.0.0\r\na=sctpmap:5000 webrtc-datachannel 16\r\na=setup:actpass\r\na=mid:application0\r\na=ice-ufrag:WOxm\r\na=ice-pwd:F9jiBNeajvZxyXQEZ5w5QI\r\na=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host\r\na=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host\r\na=fingerprint:sha-256 B0:AC:68:F7:95:55:05:A6:83:76:F5:FA:83:D3:59:F2:6D:1A:F8:00:BD:47:A6:34:4C:D6:31:4B:6C:F3:C4:7D\r\n","revision":2},"id":"88a2ae51-f419-49a5-850a-a96600dfeb50"}],"published":{"tracks":[],"revision":1},"type":"update","version":2,"participant":{"identity":"test","state":"connected","tracks":[],"sid":"PAc4d7c14f7e87ed157e230782fef13484","revision":1},"sid":"RM79bfa678f90b83b132a60fe0db1135f8","participants":[]}
0:00:02.768530506 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:400:_find_ice_stream_for_session:[00m No ice stream available for session 0
0:00:02.768637738 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:310:_resolve_host:webrtcbin0:ice[00m Resolving host frankfurt.turn.twilio.com
0:00:02.850492513 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:319:_resolve_host:webrtcbin0:ice[00m Resolved 1 addresses for host frankfurt.turn.twilio.com
0:00:02.850536376 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:411:_add_ice_stream_item:[00m adding ice stream for session 0
0:00:02.854881409 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1700:_create_transport_channel:[00m Create transport for session 0
0:00:02.868290312 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:5184:on_rtpbin_pad_added:[00m new rtpbin pad recv_rtcp_sink_0
0:00:02.868355515 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:5184:on_rtpbin_pad_added:[00m new rtpbin pad send_rtcp_src_0
0:00:02.868410668 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: NULL => READY
0:00:02.869791025 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: READY => PAUSED
0:00:02.871073437 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PAUSED => PLAYING
0:00:02.872304653 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: NULL => READY
0:00:02.879886255 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: READY => PAUSED
0:00:02.885994004 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PAUSED => PLAYING
0:00:02.889323478 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:649:gst_webrtc_ice_set_remote_credentials:webrtcbin0:ice[00m Setting remote ICE credentials on ICE stream 1 ufrag:WOxm pwd:F9jiBNeajvZxyXQEZ5w5QI
0:00:02.889341732 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.889348565 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.889366759 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.889398639 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:649:gst_webrtc_ice_set_remote_credentials:webrtcbin0:ice[00m Setting remote ICE credentials on ICE stream 1 ufrag:WOxm pwd:F9jiBNeajvZxyXQEZ5w5QI
0:00:02.889404981 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.889409539 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.889419929 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.889455105 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:649:gst_webrtc_ice_set_remote_credentials:webrtcbin0:ice[00m Setting remote ICE credentials on ICE stream 1 ufrag:WOxm pwd:F9jiBNeajvZxyXQEZ5w5QI
0:00:02.889463170 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4636:_set_description_task:[00m notify signaling-state from have-remote-offer to have-remote-offer
0:00:02.889546858 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:3310:_create_sdp_task:[00m creating answer sdp with options (NULL)
onNewTransceiver
0
0:00:02.891568290 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:3176:_create_answer_task:[00m Created new transceiver for mline 0
0:00:02.891597515 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.891603546 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.891622292 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.891719504 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:1545:_find_codec_preferences:[00m retrieving codec preferences from
0:00:02.891726848 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:1587:_find_codec_preferences:[00m Could not find caps for mline 0
0:00:02.891751915 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:3120:_create_answer_task:[00m trying to compare application/x-rtp, media=(string)video, payload=(int)120, clock-rate=(int)90000, encoding-name=(string)VP8, max-fs=(string)12288, max-fr=(string)60, rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true, rtcp-fb-goog-remb=(boolean)true, rtcp-fb-ccm-fir=(boolean)true; application/x-rtp, media=(string)video, payload=(int)126, clock-rate=(int)90000, encoding-name=(string)H264, profile-level-id=(string)42e01f, level-asymmetry-allowed=(string)1, packetization-mode=(string)1, rtcp-fb-nack=(boolean)true, rtcp-fb-nack-pli=(boolean)true, rtcp-fb-goog-remb=(boolean)true, rtcp-fb-ccm-fir=(boolean)true and (NULL)
onNewTransceiver
1
0:00:02.892876040 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:3176:_create_answer_task:[00m Created new transceiver for mline 1
0:00:02.892903862 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.892910795 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.892926324 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.892983622 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_object_ref_sink: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_object_set: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_object_ref_sink: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_object_set: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-WARNING **: 10:57:51.957: invalid (NULL) pointer instance
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_signal_connect_data: assertion 'G_TYPE_CHECK_INSTANCE (instance)' failed
(gst1-java-core:24508): GLib-GObject-WARNING **: 10:57:51.957: invalid (NULL) pointer instance
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_signal_connect_data: assertion 'G_TYPE_CHECK_INSTANCE (instance)' failed
(gst1-java-core:24508): GStreamer-CRITICAL **: 10:57:51.957: gst_element_set_locked_state: assertion 'GST_IS_ELEMENT (element)' failed
(gst1-java-core:24508): GStreamer-CRITICAL **: 10:57:51.957: gst_element_set_locked_state: assertion 'GST_IS_ELEMENT (element)' failed
(gst1-java-core:24508): GStreamer-CRITICAL **: 10:57:51.957: gst_bin_add: assertion 'GST_IS_ELEMENT (element)' failed
(gst1-java-core:24508): GStreamer-CRITICAL **: 10:57:51.957: gst_bin_add: assertion 'GST_IS_ELEMENT (element)' failed
(gst1-java-core:24508): GLib-GObject-WARNING **: 10:57:51.957: invalid (NULL) pointer instance
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.957: g_signal_connect_data: assertion 'G_TYPE_CHECK_INSTANCE (instance)' failed
(gst1-java-core:24508): GStreamer-CRITICAL **: 10:57:51.957: gst_element_link_pads_full: assertion 'GST_IS_ELEMENT (dest)' failed
** (gst1-java-core:24508): WARNING **: 10:57:51.957: (../subprojects/gst-plugins-bad/ext/webrtc/gstwebrtcbin.c:1987):_get_or_create_data_channel_transports: code should not be reached
(gst1-java-core:24508): GStreamer-CRITICAL **: 10:57:51.957: gst_element_link_pads_full: assertion 'GST_IS_ELEMENT (src)' failed
** (gst1-java-core:24508): WARNING **: 10:57:51.957: (../subprojects/gst-plugins-bad/ext/webrtc/gstwebrtcbin.c:1991):_get_or_create_data_channel_transports: code should not be reached
0:00:02.893283646 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.893297803 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.897906272 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:1860:_sctp_check_dtls_state_task:[00m Data channel DTLS connection is not ready yet: 0
0:00:02.898279294 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:4312:_set_description_task:[00m Attempting to set local answer in the have-remote-offer state
0:00:02.898289964 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4313:_set_description_task:[00m SDP contents
v=0
o=- 3801459471 3801459472 IN IP4 0.0.0.0
s=-
t=0 0
a=group:BUNDLE 0 1 application0
m=audio 9 UDP/TLS/RTP/SAVPF 109
c=IN IP4 0.0.0.0
a=ice-ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc
a=ice-pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j
a=rtcp-mux
a=mid:0
a=setup:active
a=rtpmap:109 OPUS/48000/2
a=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1
a=inactive
a=fingerprint:sha-256 C4:26:0D:B8:60:DC:22:83:77:4C:32:34:AF:3E:81:50:3A:53:81:0C:EE:11:B5:A2:59:DE:95:05:8F:83:EF:A0
m=video 9 UDP/TLS/RTP/SAVPF 120
c=IN IP4 0.0.0.0
a=ice-ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc
a=ice-pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j
a=rtcp-mux
a=mid:1
a=setup:active
a=rtpmap:120 VP8/90000
a=rtcp-fb:120 nack pli
a=rtcp-fb:120 ccm fir
a=fmtp:120 max-fs=12288;max-fr=60
a=inactive
a=fingerprint:sha-256 C4:26:0D:B8:60:DC:22:83:77:4C:32:34:AF:3E:81:50:3A:53:81:0C:EE:11:B5:A2:59:DE:95:05:8F:83:EF:A0
m=application 9 UDP/DTLS/SCTP webrtc-datachannel
c=IN IP4 0.0.0.0
a=ice-ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc
a=ice-pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j
a=mid:application0
a=setup:active
a=sctp-port:5000
a=fingerprint:sha-256 C4:26:0D:B8:60:DC:22:83:77:4C:32:34:AF:3E:81:50:3A:53:81:0C:EE:11:B5:A2:59:DE:95:05:8F:83:EF:A0
0:00:02.898313097 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:4475:_set_description_task:[00m we are in ice controlling mode: true
0:00:02.898328967 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.898339817 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.898363141 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.898405040 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:[00m mapping sdp session level attributes to caps
0:00:02.898412895 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:[00m mapping sdp media level attributes to caps
0:00:02.898422603 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:[00m looking at 0 pt: 109
0:00:02.898452840 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:[00m mapping sdp session level attributes to caps
0:00:02.898461597 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:[00m mapping sdp media level attributes to caps
0:00:02.898470603 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:[00m looking at 0 pt: 120
0:00:02.898492485 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3718:_update_transport_ptmap_from_media:[00m mapping sdp session level attributes to caps
0:00:02.898497614 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3720:_update_transport_ptmap_from_media:[00m mapping sdp media level attributes to caps
0:00:02.898504167 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3733:_update_transport_ptmap_from_media:[00m looking at 0 pt: 0
0:00:02.898515408 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.900283353 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.900299754 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.900305615 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:5295:on_rtpbin_request_aux_sender:[00m requesting aux sender for stream with transport and pt map (NULL)
0:00:02.900356942 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:5184:on_rtpbin_pad_added:[00m new rtpbin pad send_rtp_src_0
0:00:02.900374996 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:5184:on_rtpbin_pad_added:[00m new rtpbin pad send_rtp_sink_0
{"body":{"session":"28985072385708cc38c8ed7bd5c1455879bfa678f90b83b132a60fe0db1135f8c4d7c14f7e87ed157e230782fef1348448a09795b0d43553eded5bbe3880c22f","peer_connections":[{"description":{"type":"answer","sdp":"v=0\r\no=- 3801459471 3801459472 IN IP4 0.0.0.0\r\ns=-\r\nt=0 0\r\na=group:BUNDLE 0 1 application0\r\nm=audio 9 UDP/TLS/RTP/SAVPF 109\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc\r\na=ice-pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j\r\na=rtcp-mux\r\na=mid:0\r\na=setup:active\r\na=rtpmap:109 OPUS/48000/2\r\na=fmtp:109 maxplaybackrate=48000;stereo=1;useinbandfec=1\r\na=inactive\r\na=fingerprint:sha-256 C4:26:0D:B8:60:DC:22:83:77:4C:32:34:AF:3E:81:50:3A:53:81:0C:EE:11:B5:A2:59:DE:95:05:8F:83:EF:A0\r\nm=video 9 UDP/TLS/RTP/SAVPF 120\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc\r\na=ice-pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j\r\na=rtcp-mux\r\na=mid:1\r\na=setup:active\r\na=rtpmap:120 VP8/90000\r\na=rtcp-fb:120 nack pli\r\na=rtcp-fb:120 ccm fir\r\na=fmtp:120 max-fs=12288;max-fr=60\r\na=inactive\r\na=fingerprint:sha-256 C4:26:0D:B8:60:DC:22:83:77:4C:32:34:AF:3E:81:50:3A:53:81:0C:EE:11:B5:A2:59:DE:95:05:8F:83:EF:A0\r\nm=application 9 UDP/DTLS/SCTP webrtc-datachannel\r\nc=IN IP4 0.0.0.0\r\na=ice-ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc\r\na=ice-pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j\r\na=mid:application0\r\na=setup:active\r\na=sctp-port:5000\r\na=fingerprint:sha-256 C4:26:0D:B8:60:DC:22:83:77:4C:32:34:AF:3E:81:50:3A:53:81:0C:EE:11:B5:A2:59:DE:95:05:8F:83:EF:A0\r\n","revision":3},"id":"88a2ae51-f419-49a5-850a-a96600dfeb50"}],"type":"update","version":2,"participant":{"tracks":[],"revision":3}},"type":"msg"}
0:00:02.900436281 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:[00m Found transceiver
0:00:02.900444036 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.900448725 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.900464013 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.900619356 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3879:_update_transceiver_from_sdp_media:[00m transceiver direction change from none to inactive
0:00:02.900680641 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:329:_on_notify_dtls_client_status:[00m DTLS-SRTP encoder configured. Unlocking it and changing state
0:00:02.903551161 [335m24508[00m 0x7ff3e4084190 [33;01mLOG [00m [00mwebrtctransportsendbin transportsendbin.c:160:pad_block:dtlssrtpenc0:src[00m blocking pad with data buffer: 0x7ff3e40d4240, 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:02.904134398 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1903:_on_sctp_notify_dtls_state:[00m Data channel DTLS state changed to 3
0:00:02.904199630 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:329:_on_notify_dtls_client_status:[00m DTLS-SRTP encoder configured. Unlocking it and changing state
0:00:02.906417092 [335m24508[00m 0x7ff3e4084280 [33;01mLOG [00m [00mwebrtctransportsendbin transportsendbin.c:160:pad_block:dtlssrtpenc1:src[00m blocking pad with data buffer: 0x7ff3e40d47e0, 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:02.906853653 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:[00m Found transceiver
0:00:02.906864824 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.906871476 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.906907805 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.906968900 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcbin gstwebrtcbin.c:3879:_update_transceiver_from_sdp_media:[00m transceiver direction change from none to inactive
0:00:02.906977015 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:3438:_find_transceiver_for_sdp_media:[00m Found transceiver (NULL)
0:00:02.906982395 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.906987455 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907011660 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907089336 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:329:_on_notify_dtls_client_status:[00m DTLS-SRTP encoder configured. Unlocking it and changing state
0:00:02.907169267 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:329:_on_notify_dtls_client_status:[00m DTLS-SRTP encoder configured. Unlocking it and changing state
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.971: g_object_get: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.971: g_object_set: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.971: g_object_get: assertion 'G_IS_OBJECT (object)' failed
(gst1-java-core:24508): GLib-GObject-CRITICAL **: 10:57:51.971: g_object_set: assertion 'G_IS_OBJECT (object)' failed
0:00:02.907372168 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:126:transport_receive_bin_set_receive_state:[00m changing receive state to pass
0:00:02.907386996 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.907393318 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907419417 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907450646 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:708:gst_webrtc_ice_set_local_credentials:webrtcbin0:ice[00m Setting local ICE credentials on ICE stream 1 ufrag:0vaIJYAV6MCBTNg+LT2WdsyHmuwHhzgc pwd:y1MfZxi03cFf+0piX/j1a6xHMgOT9i/j
0:00:02.907459102 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.907466726 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907490451 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907519145 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:508:_find_transport_for_session:[00m Found transport for session 0
0:00:02.907524825 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportsendbin transportsendbin.c:195:transport_send_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907549081 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00mwebrtctransportreceivebin transportreceivebin.c:236:transport_receive_bin_change_state:[00m changing state: PLAYING => PLAYING
0:00:02.907577364 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcice gstwebrtcice.c:726:gst_webrtc_ice_gather_candidates:webrtcbin0:ice[00m gather candidates for stream 1
0:00:02.907582444 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcicestream icestream.c:177:gst_webrtc_ice_stream_gather_candidates:[00m start gathering candidates
0:00:02.912223644 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:02.912329093 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcnicetransport nicetransport.c:186:_on_component_state_changed:[00m 1 1 gathering
0:00:02.912352397 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:394:_find_ice_stream_for_session:[00m Found ice stream id for session 0
0:00:02.912359119 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:3628:_add_ice_candidates_from_sdp:[00m adding ICE candidate with mline:0, a=candidate:2 1 UDP 2013266430 18.156.18.247 19549 typ host
0:00:02.912573843 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcnicetransport nicetransport.c:186:_on_component_state_changed:[00m 1 1 connecting
0:00:02.912591056 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:3628:_add_ice_candidates_from_sdp:[00m adding ICE candidate with mline:0, a=candidate:2 2 UDP 2013266429 18.156.18.247 13801 typ host
0:00:02.912789669 [335m24508[00m 0x7ff4b0509720 [37mDEBUG [00m [00m webrtcnicetransport nicetransport.c:186:_on_component_state_changed:[00m 1 2 connecting
0:00:02.912805178 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:400:_find_ice_stream_for_session:[00m No ice stream available for session 1
0:00:02.912811610 [335m24508[00m 0x7ff4b0509720 [33;01mWARN [00m [00m webrtcbin gstwebrtcbin.c:3622:_add_ice_candidates_from_sdp:[00m Unknown mline 1, dropping ICE candidates from SDP
0:00:02.912817912 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:400:_find_ice_stream_for_session:[00m No ice stream available for session 2
0:00:02.912822641 [335m24508[00m 0x7ff4b0509720 [33;01mWARN [00m [00m webrtcbin gstwebrtcbin.c:3622:_add_ice_candidates_from_sdp:[00m Unknown mline 2, dropping ICE candidates from SDP
0:00:02.912830266 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4636:_set_description_task:[00m notify signaling-state from stable to stable
0:00:02.912921828 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:1341:_check_if_negotiation_is_needed:[00m checking if negotiation is needed
0:00:02.912935934 [335m24508[00m 0x7ff4b0509720 [33;01mLOG [00m [00m webrtcbin gstwebrtcbin.c:1478:_check_if_negotiation_is_needed:[00m transceiver direction (recvonly) doesn't match description intersected direction inactive (local inactive remote recvonly)
0:00:02.912941304 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1499:_check_need_negotiation_task:[00m emitting on-negotiation-needed
0:00:02.912964037 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:02.912970219 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x1
0:00:02.912975899 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:02.912981009 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x1
0:00:02.912988243 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x2. DTLS connection state: 0x8
0:00:02.912992220 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1154:_collate_peer_connection_states:[00m returning connecting
0:00:02.912998853 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:1282:_update_peer_connection_state_task:[00m Peer connection state change from new(0) to connecting(1)
0:00:02.913058785 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:02.913066340 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x1
0:00:02.913071299 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:02.913075817 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x1
0:00:02.913081729 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x2. DTLS connection state: 0x8
0:00:02.913085035 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1154:_collate_peer_connection_states:[00m returning connecting
0:00:02.913091317 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da850 gathering state: 0x1
0:00:02.913099201 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da930 gathering state: 0x1
0:00:02.913103490 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:997:_collate_ice_gathering_states:[00m ICE gathering state: 0x2
0:00:02.913106696 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1001:_collate_ice_gathering_states:[00m returning gathering
0:00:02.913112256 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:1212:_update_ice_gathering_state_task:[00m ICE gathering state change from new(0) to gathering(1)
0:00:02.913161469 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da850 gathering state: 0x1
0:00:02.913168772 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da930 gathering state: 0x1
0:00:02.913172499 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:997:_collate_ice_gathering_states:[00m ICE gathering state: 0x2
0:00:02.913175575 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1001:_collate_ice_gathering_states:[00m returning gathering
0:00:02.913182648 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:1 1 UDP 2015363327 192.168.0.32 54314 typ host
0:00:02.913189902 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:2 1 TCP 1015021823 192.168.0.32 9 typ host tcptype active
0:00:02.913196955 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:3 1 TCP 1010827519 192.168.0.32 45237 typ host tcptype passive
0:00:02.913202125 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:4 1 UDP 2015363583 10.150.10.6 34050 typ host
0:00:02.913206393 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:5 1 TCP 1015022079 10.150.10.6 9 typ host tcptype active
0:00:02.913210571 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:6 1 TCP 1010827775 10.150.10.6 33829 typ host tcptype passive
0:00:02.913215029 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:7 1 UDP 2015363839 fe80::9253:bfb5:e716:22ac 42730 typ host
0:00:02.913219668 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:8 1 TCP 1015022335 fe80::9253:bfb5:e716:22ac 9 typ host tcptype active
0:00:02.913225158 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:9 1 TCP 1010828031 fe80::9253:bfb5:e716:22ac 39597 typ host tcptype passive
0:00:02.913232662 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:10 1 UDP 2015364095 fe80::85fb:72d5:4d35:c405 54847 typ host
0:00:02.913237872 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:11 1 TCP 1015022591 fe80::85fb:72d5:4d35:c405 9 typ host tcptype active
0:00:02.913242621 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:12 1 TCP 1010828287 fe80::85fb:72d5:4d35:c405 57299 typ host tcptype passive
0:00:02.913247180 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:1 2 UDP 2015363326 192.168.0.32 54431 typ host
0:00:02.913260475 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:2 2 TCP 1015021822 192.168.0.32 9 typ host tcptype active
0:00:02.913265945 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:3 2 TCP 1010827518 192.168.0.32 60103 typ host tcptype passive
0:00:02.913270864 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:4 2 UDP 2015363582 10.150.10.6 44880 typ host
0:00:02.913275643 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:5 2 TCP 1015022078 10.150.10.6 9 typ host tcptype active
0:00:02.913282967 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:6 2 TCP 1010827774 10.150.10.6 45963 typ host tcptype passive
0:00:02.913287866 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:7 2 UDP 2015363838 fe80::9253:bfb5:e716:22ac 38896 typ host
0:00:02.913294669 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:8 2 TCP 1015022334 fe80::9253:bfb5:e716:22ac 9 typ host tcptype active
0:00:02.913299679 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:9 2 TCP 1010828030 fe80::9253:bfb5:e716:22ac 49195 typ host tcptype passive
0:00:02.913304317 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:10 2 UDP 2015364094 fe80::85fb:72d5:4d35:c405 54242 typ host
0:00:02.913311090 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:11 2 TCP 1015022590 fe80::85fb:72d5:4d35:c405 9 typ host tcptype active
0:00:02.913316059 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:12 2 TCP 1010828286 fe80::85fb:72d5:4d35:c405 49883 typ host tcptype passive
0:00:02.913326539 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da850 state 0x1
0:00:02.913332871 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da930 state 0x1
0:00:02.913339694 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:888:_collate_ice_connection_states:[00m ICE connection state: 0x2
0:00:02.913343561 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:912:_collate_ice_connection_states:[00m returning checking
0:00:02.913350113 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:1247:_update_ice_connection_state_task:[00m ICE connection state change from new(0) to checking(1)
0:00:02.913397753 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:02.913405197 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x1
0:00:02.913410116 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:02.913414645 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x1
0:00:02.913419153 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x2. DTLS connection state: 0x8
0:00:02.913422520 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1154:_collate_peer_connection_states:[00m returning connecting
0:00:02.913431426 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da850 state 0x1
0:00:02.913437598 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da930 state 0x1
0:00:02.913441515 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:888:_collate_ice_connection_states:[00m ICE connection state: 0x2
0:00:02.913444701 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:912:_collate_ice_connection_states:[00m returning checking
0:00:02.913452787 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:02.913458577 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x1
0:00:02.913463867 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:02.913468446 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x1
0:00:02.913472744 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x2. DTLS connection state: 0x8
0:00:02.913475960 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1154:_collate_peer_connection_states:[00m returning connecting
0:00:02.913481541 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da850 state 0x1
0:00:02.913489656 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da930 state 0x1
0:00:02.913493714 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:888:_collate_ice_connection_states:[00m ICE connection state: 0x2
0:00:02.913497020 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:912:_collate_ice_connection_states:[00m returning checking
0:00:02.913502710 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:02.913510595 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x1
0:00:02.913517649 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:02.913522558 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x1
0:00:02.913528960 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x2. DTLS connection state: 0x8
0:00:02.913532426 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1154:_collate_peer_connection_states:[00m returning connecting
0:00:02.998902815 [335m24508[00m 0x7ff3e40c16d0 [37mDEBUG [00m [00m webrtcnicetransport nicetransport.c:186:_on_component_state_changed:[00m 1 1 connected
0:00:02.998935446 [335m24508[00m 0x7ff3e40c16d0 [33;01mLOG [00m [00mwebrtctransportsendbin transportsendbin.c:350:_on_notify_ice_connection_state:[00m Unblocking pad dtlssrtpenc0:src
0:00:02.999013162 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da850 state 0x2
0:00:02.999037869 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da930 state 0x2
0:00:02.999047286 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:888:_collate_ice_connection_states:[00m ICE connection state: 0x4
0:00:02.999055281 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:922:_collate_ice_connection_states:[00m returning connected
0:00:02.999071482 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:1247:_update_ice_connection_state_task:[00m ICE connection state change from checking(1) to connected(2)
0:00:02.999275205 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:02.999294191 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x2
0:00:02.999306404 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:02.999317374 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x2
0:00:02.999327574 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x4. DTLS connection state: 0x8
0:00:02.999335358 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1171:_collate_peer_connection_states:[00m returning connecting
0:00:03.232340078 [335m24508[00m 0x7ff3e40c16d0 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.232385444 [335m24508[00m 0x7ff3e40c16d0 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.232399280 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:14 1 TCP 847249663 45.11.62.243 9 typ srflx raddr 192.168.0.32 rport 9 tcptype active
0:00:03.232423385 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:15 1 TCP 843055359 45.11.62.243 45237 typ srflx raddr 192.168.0.32 rport 45237 tcptype passive
0:00:03.232437992 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:16 1 UDP 337641727 18.195.48.231 13259 typ relay raddr 192.168.0.32 rport 9
0:00:03.263113415 [335m24508[00m 0x7ff3e40c16d0 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.263161165 [335m24508[00m 0x7ff3e40c16d0 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.263166325 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:17 1 TCP 847249919 45.11.62.243 9 typ srflx raddr 10.150.10.6 rport 9 tcptype active
0:00:03.263189809 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:18 1 TCP 843055615 45.11.62.243 33829 typ srflx raddr 10.150.10.6 rport 33829 tcptype passive
0:00:03.263217501 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:19 1 UDP 337641983 18.195.48.231 10822 typ relay raddr 10.150.10.6 rport 9
0:00:03.275264993 [335m24508[00m 0x7ff3e40c1720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.275319165 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:14 2 TCP 847249662 45.11.62.243 9 typ srflx raddr 192.168.0.32 rport 9 tcptype active
0:00:03.275346386 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:15 2 TCP 843055358 45.11.62.243 60103 typ srflx raddr 192.168.0.32 rport 60103 tcptype passive
0:00:03.275364109 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:16 2 UDP 337641726 18.195.48.231 41099 typ relay raddr 192.168.0.32 rport 9
0:00:03.303531615 [335m24508[00m 0x7ff3e40c1720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.303569456 [335m24508[00m 0x7ff3e40c1720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4878:_on_local_ice_candidate_cb:[00m Queueing on_ice_candidate_task
0:00:03.303607187 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:17 2 TCP 847249918 45.11.62.243 9 typ srflx raddr 10.150.10.6 rport 9 tcptype active
0:00:03.303629659 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:18 2 TCP 843055614 45.11.62.243 45963 typ srflx raddr 10.150.10.6 rport 45963 tcptype passive
0:00:03.303652592 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:4833:_on_local_ice_candidate_task:[00m produced ICE candidate for mline:0 and candidate:19 2 UDP 337641982 18.195.48.231 45980 typ relay raddr 10.150.10.6 rport 9
0:00:03.316618312 [335m24508[00m 0x7ff4b0509680 [37mDEBUG [00m [00m webrtcicestream icestream.c:116:_on_candidate_gathering_done:[00m 1 gathering done
0:00:03.316691991 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da850 gathering state: 0x2
0:00:03.316710936 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da930 gathering state: 0x2
0:00:03.316720284 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:997:_collate_ice_gathering_states:[00m ICE gathering state: 0x4
0:00:03.316730694 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1007:_collate_ice_gathering_states:[00m returning complete
0:00:03.316745932 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:1212:_update_ice_gathering_state_task:[00m ICE gathering state change from gathering(1) to complete(2)
0:00:03.316924468 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da850 gathering state: 0x2
0:00:03.316943724 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:975:_collate_ice_gathering_states:[00m transceiver 0x7ff3e40da930 gathering state: 0x2
0:00:03.316952892 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:997:_collate_ice_gathering_states:[00m ICE gathering state: 0x4
0:00:03.316960596 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1007:_collate_ice_gathering_states:[00m returning complete
{"code":53403,"name":"HIBGVBSWJX","type":"error","message":"Server is unable to apply a remote media description","version":1,"sid":"RM79bfa678f90b83b132a60fe0db1135f8","participants":[]}
{"type":"bye"}
0:00:04.943320764 [335m24508[00m 0x7ff4b0509680 [37mDEBUG [00m [00m webrtcnicetransport nicetransport.c:186:_on_component_state_changed:[00m 1 1 ready
0:00:04.943410132 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da850 state 0x3
0:00:04.943434077 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:858:_collate_ice_connection_states:[00m transceiver 0x7ff3e40da930 state 0x3
0:00:04.943446541 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:888:_collate_ice_connection_states:[00m ICE connection state: 0x8
0:00:04.943455087 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:917:_collate_ice_connection_states:[00m returning completed
0:00:04.943469885 [335m24508[00m 0x7ff4b0509720 [36mINFO [00m [00m webrtcbin gstwebrtcbin.c:1247:_update_ice_connection_state_task:[00m ICE connection state change from connected(2) to completed(3)
0:00:04.943690800 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 DTLS state: 0x3
0:00:04.943704496 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da850 ICE state: 0x3
0:00:04.943713232 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1060:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 DTLS state: 0x3
0:00:04.943721117 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1073:_collate_peer_connection_states:[00m transceiver 0x7ff3e40da930 ICE state: 0x3
0:00:04.943728541 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1118:_collate_peer_connection_states:[00m ICE connection state: 0x8. DTLS connection state: 0x8
0:00:04.943734452 [335m24508[00m 0x7ff4b0509720 [37mTRACE [00m [00m webrtcbin gstwebrtcbin.c:1171:_collate_peer_connection_states:[00m returning connecting
Is this a bug or i'm doing something wrong?
Thank you in advance.