avstack / gst-meet

Connect GStreamer pipelines to Jitsi Meet conferences
Apache License 2.0
70 stars 25 forks source link

WebSocket connection reset after 1 minute #2

Closed teodly closed 2 years ago

teodly commented 3 years ago

gst-meet is receiving video stream flawlessly for a while, then simultaneously the WebSocket connection breaks and video freezes.

WebSocket protocol error: Connection reset without closing handshake

I'm using a slightly patched version and custom --xmpp-domain, --muc-domain, --focus-jid arguments to make it work with our docker-jitsi-meet server deployment.

$ target/debug/gst-meet --verbose --web-socket-url=wss://myserver/xmpp-websocket --xmpp-domain=meet.jitsi --muc-domain=muc.meet.jitsi --focus-jid=focus.meet.jitsi --room-name=vbck --recv-pipeline-participant-template="identity name=audio silent=true ! fakesink  identity name=video silent=false ! capsfilter caps=video/x-vp8 ! vp8dec ! autovideosink"
Oct 06 15:43:37.544  INFO Connecting XMPP WebSocket to wss://myserver/xmpp-websocket
Oct 06 15:43:37.625 DEBUG No cached session for DNSNameRef("myserver")    
Oct 06 15:43:37.625 DEBUG Not resuming any session    
Oct 06 15:43:37.676 DEBUG Using ciphersuite TLS13_CHACHA20_POLY1305_SHA256    
Oct 06 15:43:37.677 DEBUG Not resuming    
Oct 06 15:43:37.677 DEBUG TLS1.3 encrypted extensions: []    
Oct 06 15:43:37.677 DEBUG ALPN protocol is None    
Oct 06 15:43:37.728 DEBUG Ticket saved    
Oct 06 15:43:37.728 DEBUG Ticket saved    
Oct 06 15:43:37.780 DEBUG Client handshake done.    
Oct 06 15:43:37.781 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="meet.jitsi" version="1.0"/>
Oct 06 15:43:37.833 DEBUG XMPP    <<< <open id='6b43c99c-47e4-413b-8958-fa49ef51cd3a' xmlns='urn:ietf:params:xml:ns:xmpp-framing' xml:lang='en' from='meet.jitsi' version='1.0'/>
Oct 06 15:43:37.833  INFO Connected XMPP WebSocket
Oct 06 15:43:37.833 DEBUG XMPP    <<< <stream:features xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'><mechanisms xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>ANONYMOUS</mechanism></mechanisms></stream:features>
Oct 06 15:43:37.834 DEBUG XMPP    >>> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="ANONYMOUS"></auth>
Oct 06 15:43:37.884 DEBUG XMPP    <<< <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
Oct 06 15:43:37.885 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="meet.jitsi" version="1.0"/>
Oct 06 15:43:37.935 DEBUG XMPP    <<< <open id='185ea9bd-2898-4499-95c1-3a8120e4a379' xmlns='urn:ietf:params:xml:ns:xmpp-framing' xml:lang='en' from='meet.jitsi' version='1.0'/>
Oct 06 15:43:37.935  INFO Logged in anonymously
Oct 06 15:43:37.935 DEBUG XMPP    <<< <stream:features xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><required/></bind><session xmlns='urn:ietf:params:xml:ns:xmpp-session'><optional/></session><c xmlns='http://jabber.org/protocol/caps' hash='sha-1' ver='MoFF4UiDpY2+1dMOwz8rvUmluaU=' node='http://prosody.im'/><ver xmlns='urn:xmpp:features:rosterver'/></stream:features>
Oct 06 15:43:37.936 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="f02bca17-f372-4d1c-9f2f-1461c4442788" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/></iq>
Oct 06 15:43:37.988 DEBUG XMPP    <<< <iq xmlns='jabber:client' type='result' id='f02bca17-f372-4d1c-9f2f-1461c4442788'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>qzg7eor_wwri8aht@meet.jitsi/_0GGZQei</jid></bind></iq>
Oct 06 15:43:37.989  INFO My JID: qzg7eor_wwri8aht@meet.jitsi/_0GGZQei
Oct 06 15:43:37.990 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="ee2a2dd0-4ff3-4741-b32a-fef31bd51b4e" to="meet.jitsi" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
Oct 06 15:43:38.042 DEBUG XMPP    <<< <iq id='ee2a2dd0-4ff3-4741-b32a-fef31bd51b4e' xmlns='jabber:client' type='result' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='meet.jitsi'><query xmlns='http://jabber.org/protocol/disco#info'><identity type='speakerstats' category='component' name='speakerstats.meet.jitsi'/><identity type='service' category='pubsub' name='Prosody PubSub Service'/><identity type='conference_duration' category='component' name='conferenceduration.meet.jitsi'/><identity type='im' category='server' name='Prosody'/><identity type='pep' category='pubsub' name='Prosody'/><feature var='jabber:iq:roster'/><feature var='jabber:iq:version'/><feature var='http://jabber.org/protocol/pubsub'/><feature var='http://jabber.org/protocol/pubsub#subscribe'/><feature var='http://jabber.org/protocol/pubsub#publisher-affiliation'/><feature var='http://jabber.org/protocol/pubsub#publish'/><feature var='http://jabber.org/protocol/pubsub#subscription-options'/><feature var='http://jabber.org/protocol/pubsub#retrieve-default'/><feature var='http://jabber.org/protocol/pubsub#create-nodes'/><feature var='http://jabber.org/protocol/pubsub#config-node'/><feature var='http://jabber.org/protocol/pubsub#delete-nodes'/><feature var='http://jabber.org/protocol/pubsub#retract-items'/><feature var='http://jabber.org/protocol/pubsub#instant-nodes'/><feature var='http://jabber.org/protocol/pubsub#persistent-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#member-affiliation'/><feature var='http://jabber.org/protocol/pubsub#purge-nodes'/><feature var='http://jabber.org/protocol/pubsub#outcast-affiliation'/><feature var='http://jabber.org/protocol/pubsub#item-ids'/><feature var='http://jabber.org/protocol/pubsub#create-and-configure'/><feature var='http://jabber.org/protocol/pubsub#retrieve-items'/><feature var='http://jabber.org/protocol/pubsub#access-open'/><feature var='http://jabber.org/protocol/pubsub#publish-options'/><feature var='http://jabber.org/protocol/pubsub#delete-items'/><feature var='http://jabber.org/protocol/pubsub#multi-items'/><feature var='http://jabber.org/protocol/pubsub#meta-data'/><feature var='http://jabber.org/protocol/pubsub#modify-affiliations'/><feature var='msgoffline'/><feature var='vcard-temp'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='urn:xmpp:time'/><feature var='jabber:iq:time'/><feature var='jabber:iq:private'/><feature var='jabber:iq:last'/><feature var='jabber:iq:register'/><feature var='urn:xmpp:ping'/><feature var='http://jabber.org/protocol/commands'/></query></iq>
Oct 06 15:43:38.044 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="3038eaa6-23bf-41b4-942b-770a337853c7" to="meet.jitsi" type="get"><services xmlns="urn:xmpp:extdisco:2"/></iq>
Oct 06 15:43:38.095 DEBUG XMPP    <<< <iq id='3038eaa6-23bf-41b4-942b-770a337853c7' xmlns='jabber:client' type='error' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='meet.jitsi'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq>
Oct 06 15:43:38.095  WARN extdisco failed
Oct 06 15:43:38.096 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="ad6c804f-f84f-48c4-8939-b77a47e179cf" to="focus.meet.jitsi" type="set"><conference xmlns="http://jitsi.org/protocol/focus" machine-uid="0918f70b-38c8-4eca-b3c0-2633d5b85ce9" room="vbck@muc.meet.jitsi"><property name="stereo" value="true"/><property name="startBitrate" value="800"/></conference></iq>
Oct 06 15:43:38.164 DEBUG XMPP    <<< <iq id='ad6c804f-f84f-48c4-8939-b77a47e179cf' xmlns='jabber:client' type='result' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='focus.meet.jitsi'><conference xmlns='http://jitsi.org/protocol/focus' ready='true' focusjid='focus@auth.meet.jitsi' room='vbck@muc.meet.jitsi'><property name='authentication' value='false'/></conference></iq>
Oct 06 15:43:38.165 DEBUG send_presence{self=JitsiConference { jid: FullJID(qzg7eor_wwri8aht@meet.jitsi/_0GGZQei), config: JitsiConferenceConfig { muc: BareJID(vbck@muc.meet.jitsi), focus: BareJID(focus.meet.jitsi), nick: "gst-meet", region: "", video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Discovering } } } payloads=[Element { name: "x", namespace: "http://jabber.org/protocol/muc", prefix: None, prefixes: Prefixes(), attributes: {}, children: [] }, Element { name: "c", namespace: "urn:xmpp:caps", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Element(Element { name: "hash", namespace: "urn:xmpp:hashes:2", prefix: None, prefixes: Prefixes(), attributes: {"algo": "sha-256"}, children: [Text("pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=")] })] }, Element { name: "stats-id", namespace: "", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("gst-meet")] }, Element { name: "jitsi_participant_codecType", namespace: "", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("vp8")] }, Element { name: "jitsi_participant_region", namespace: "", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("")] }, Element { name: "audiomuted", namespace: "", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("false")] }, Element { name: "videomuted", namespace: "", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("false")] }, Element { name: "nick", namespace: "http://jabber.org/protocol/nick", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("gst-meet")] }, Element { name: "region", namespace: "http://jitsi.org/jitsi-meet", prefix: None, prefixes: Prefixes(), attributes: {"id": ""}, children: [] }]}: close time.busy=52.6µs time.idle=20.9µs
Oct 06 15:43:38.165 DEBUG XMPP    >>> <presence xmlns="jabber:client" to="vbck@muc.meet.jitsi/qzg7eor_wwri8aht"><x xmlns="http://jabber.org/protocol/muc"/><c xmlns="urn:xmpp:caps"><hash xmlns="urn:xmpp:hashes:2" algo="sha-256">pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp8</jitsi_participant_codecType><jitsi_participant_region></jitsi_participant_region><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns="http://jabber.org/protocol/nick">gst-meet</nick><region xmlns="http://jitsi.org/jitsi-meet" id=""/></presence>
Oct 06 15:43:38.221 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/focus'><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>18e195365a9240f78a3e97ed4907cac5</etherpad><conference-properties xmlns='http://jitsi.org/protocol/focus'><property key='created-ms' value='1633527818134'/><property key='octo-enabled' value='false'/></conference-properties><versions xmlns='http://jitsi.org/jitmeet'><component name='xmpp'>Prosody(0.11.5,Linux)</component><component name='focus'>JiCoFo(1.0.644,Linux)</component></versions><c xmlns='http://jabber.org/protocol/caps' hash='sha-1' ver='6dKlNV2hTmKYwGcTHveFMk15Ydg=' node='http://jitsi.org/jicofo'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.meet.jitsi/focus5356607811024394' role='moderator' affiliation='owner'/></x></presence>
Oct 06 15:43:38.222 DEBUG Joined MUC: vbck@muc.meet.jitsi
Oct 06 15:43:38.222 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/qzg7eor_wwri8aht'><c xmlns='urn:xmpp:caps'><hash algo='sha-256' xmlns='urn:xmpp:hashes:2'>pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp8</jitsi_participant_codecType><jitsi_participant_region/><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns='http://jabber.org/protocol/nick'>gst-meet</nick><region xmlns='http://jitsi.org/jitsi-meet' id=''/><x xmlns='http://jabber.org/protocol/muc#user'><status code='100'/><item jid='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' role='participant' affiliation='none'/><status code='110'/></x></presence>
Oct 06 15:43:38.223 DEBUG XMPP    <<< <message xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='conferenceduration.meet.jitsi'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;created_timestamp&quot;:1633527818000,&quot;type&quot;:&quot;conference_duration&quot;}</json-message></message>
Oct 06 15:43:38.223 DEBUG XMPP    <<< <message xmlns='jabber:client' type='groupchat' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi'><subject/></message>
Oct 06 15:43:38.223 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/qzg7eor_wwri8aht'><c xmlns='urn:xmpp:caps'><hash algo='sha-256' xmlns='urn:xmpp:hashes:2'>pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp8</jitsi_participant_codecType><jitsi_participant_region/><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns='http://jabber.org/protocol/nick'>gst-meet</nick><region xmlns='http://jitsi.org/jitsi-meet' id=''/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' role='moderator' affiliation='owner'><actor nick='focus'/></item><status code='110'/></x></presence>
Oct 06 15:43:38.224 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/focus'><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>18e195365a9240f78a3e97ed4907cac5</etherpad><conference-properties xmlns='http://jitsi.org/protocol/focus'><property key='created-ms' value='1633527818134'/><property key='octo-enabled' value='false'/></conference-properties><versions xmlns='http://jitsi.org/jitmeet'><component name='xmpp'>Prosody(0.11.5,Linux)</component><component name='focus'>JiCoFo(1.0.644,Linux)</component></versions><c xmlns='http://jabber.org/protocol/caps' hash='sha-1' ver='6dKlNV2hTmKYwGcTHveFMk15Ydg=' node='http://jitsi.org/jicofo'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.meet.jitsi/focus5356607811024394' role='moderator' affiliation='owner'/></x></presence>
Oct 06 15:43:49.491 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/9fd0c0b5'><stats-id>Amparo-aHQ</stats-id><c xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jitsimeet' ver='cWj8xSCR2vP2KMorJrpHIw9Q/jA=' hash='sha-1'/><avatar-id>3e8dd52396478fe7e580eddf34b0e724</avatar-id><nick xmlns='http://jabber.org/protocol/nick'>teo0</nick><audiomuted xmlns='http://jitsi.org/jitmeet/audio'>false</audiomuted><videoType xmlns='http://jitsi.org/jitmeet/video'>camera</videoType><videomuted xmlns='http://jitsi.org/jitmeet/video'>false</videomuted><x xmlns='http://jabber.org/protocol/muc#user'><item jid='qbfyb25sz6vgabzf@meet.jitsi/vFg_jsbt' role='participant' affiliation='none'/></x></presence>
Oct 06 15:43:49.492 DEBUG new participant: FullJID(qbfyb25sz6vgabzf@meet.jitsi/vFg_jsbt)
Oct 06 15:43:49.495 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/focus'><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>18e195365a9240f78a3e97ed4907cac5</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='xmpp'>Prosody(0.11.5,Linux)</component><component name='focus'>JiCoFo(1.0.644,Linux)</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property key='created-ms' value='1633527818134'/><property key='octo-enabled' value='false'/><property key='bridge-count' value='1'/></conference-properties><c xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jicofo' ver='6dKlNV2hTmKYwGcTHveFMk15Ydg=' hash='sha-1'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.meet.jitsi/focus5356607811024394' role='moderator' affiliation='owner'/></x></presence>
Oct 06 15:43:49.496 DEBUG XMPP    <<< <iq from='vbck@muc.meet.jitsi/focus' xmlns='jabber:client' type='get' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' id='cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpAFBaTjl5LTIyNDMxMTIArcc9MWwvvctQtbtZX7NpXA=='><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
Oct 06 15:43:49.497 DEBUG Received disco info query from vbck@muc.meet.jitsi/focus for node None
Oct 06 15:43:49.498 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpAFBaTjl5LTIyNDMxMTIArcc9MWwvvctQtbtZX7NpXA==" to="vbck@muc.meet.jitsi/focus" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="urn:xmpp:jingle:apps:rtp:audio"/><feature var="urn:xmpp:jingle:apps:rtp:video"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="urn:xmpp:jingle:apps:dtls:0"/><feature var="urn:ietf:rfc:5888"/><feature var="urn:ietf:rfc:5761"/><feature var="urn:ietf:rfc:4588"/><feature var="http://jitsi.org/tcc"/></query></iq>
Oct 06 15:43:49.543 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/focus'><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>18e195365a9240f78a3e97ed4907cac5</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='xmpp'>Prosody(0.11.5,Linux)</component><component name='focus'>JiCoFo(1.0.644,Linux)</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property key='created-ms' value='1633527818134'/><property key='octo-enabled' value='false'/><property key='bridge-count' value='1'/></conference-properties><c xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jicofo' ver='6dKlNV2hTmKYwGcTHveFMk15Ydg=' hash='sha-1'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.meet.jitsi/focus5356607811024394' role='moderator' affiliation='owner'/></x></presence>
Oct 06 15:43:49.554 DEBUG XMPP    <<< <presence xmlns='jabber:client' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/focus'><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>18e195365a9240f78a3e97ed4907cac5</etherpad><conference-properties xmlns='http://jitsi.org/protocol/focus'><property key='created-ms' value='1633527818134'/><property key='octo-enabled' value='false'/><property key='bridge-count' value='1'/></conference-properties><versions xmlns='http://jitsi.org/jitmeet'><component name='xmpp'>Prosody(0.11.5,Linux)</component><component name='focus'>JiCoFo(1.0.644,Linux)</component><component name='videobridge'>2.1.SNAPSHOT</component></versions><c xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jicofo' ver='6dKlNV2hTmKYwGcTHveFMk15Ydg=' hash='sha-1'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.meet.jitsi/focus5356607811024394' role='moderator' affiliation='owner'/></x></presence>
Oct 06 15:43:49.579 DEBUG XMPP    <<< <iq from='vbck@muc.meet.jitsi/focus' xmlns='jabber:client' type='set' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' id='cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpAFBaTjl5LTIyNDMxMzMArcc9MWwvvctQtbtZX7NpXA=='><jingle xmlns='urn:xmpp:jingle:1' action='session-initiate' initiator='focus@auth.meet.jitsi/focus5356607811024394' sid='1p2fr8fdl03iu'><content name='audio' creator='initiator' senders='both'><description maxptime='60' media='audio' xmlns='urn:xmpp:jingle:apps:rtp:1'><payload-type name='opus' id='111' clockrate='48000' channels='2'><parameter name='minptime' value='10'/><parameter name='stereo' value='1'/><parameter name='useinbandfec' value='1'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/></payload-type><payload-type clockrate='16000' name='ISAC' id='103'/><payload-type clockrate='32000' name='ISAC' id='104'/><payload-type clockrate='8000' name='telephone-event' id='126'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' id='1' uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' id='5' uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01'/><rtcp-mux/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='3063999702'><parameter name='cname' value='mixed'/><parameter name='label' value='mixedlabelaudio0'/><parameter name='msid' value='mixedmslabel mixedlabelaudio0'/><parameter name='mslabel' value='mixedmslabel'/><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' ufrag='6n7je1fhath513' pwd='6lhgv3f4af0cr065c0ubeicvhd'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' required='false' setup='actpass' hash='sha-256'>4B:FC:8E:3A:19:59:67:0A:5A:DC:44:3A:AB:58:DD:45:B1:01:A8:ED:6B:1C:6C:92:43:0B:DA:08:E4:1D:61:8B</fingerprint><candidate port='10000' generation='0' component='1' ip='10.255.254.5' protocol='udp' id='8bce9e577f63554032cef186' foundation='1' type='host' priority='2130706431' network='0'/><candidate port='10000' priority='1694498815' component='1' type='srflx' ip='52.214.101.26' protocol='udp' rel-addr='10.255.254.5' id='10aa6ccc77f6355405ca5589b' foundation='2' rel-port='10000' generation='0' network='0'/></transport></content><content name='video' creator='initiator' senders='both'><description media='video' xmlns='urn:xmpp:jingle:apps:rtp:1'><payload-type clockrate='90000' name='VP8' id='100'><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='ccm' subtype='fir'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack' subtype='pli'/><parameter name='x-google-start-bitrate' value='800'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/></payload-type><payload-type clockrate='90000' name='H264' id='107'><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='ccm' subtype='fir'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack' subtype='pli'/><parameter name='x-google-start-bitrate' value='800'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/><parameter name='profile-level-id' value='42e01f;level-asymmetry-allowed=1;packetization-mode=1;'/></payload-type><payload-type clockrate='90000' name='VP9' id='101'><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='ccm' subtype='fir'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack' subtype='pli'/><parameter name='x-google-start-bitrate' value='800'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/></payload-type><payload-type clockrate='90000' name='rtx' id='96'><parameter name='apt' value='100'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='ccm' subtype='fir'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='nack' subtype='pli'/></payload-type><payload-type clockrate='90000' name='rtx' id='97'><parameter name='apt' value='101'/></payload-type><payload-type clockrate='90000' name='rtx' id='99'><parameter name='apt' value='107'/></payload-type><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' id='3' uri='http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' id='5' uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01'/><rtcp-mux/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='3668235259'><parameter name='cname' value='mixed'/><parameter name='label' value='mixedlabelvideo0'/><parameter name='msid' value='mixedmslabel mixedlabelvideo0'/><parameter name='mslabel' value='mixedmslabel'/><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' ufrag='6n7je1fhath513' pwd='6lhgv3f4af0cr065c0ubeicvhd'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' required='false' setup='actpass' hash='sha-256'>4B:FC:8E:3A:19:59:67:0A:5A:DC:44:3A:AB:58:DD:45:B1:01:A8:ED:6B:1C:6C:92:43:0B:DA:08:E4:1D:61:8B</fingerprint><candidate port='10000' generation='0' component='1' ip='10.255.254.5' protocol='udp' id='8bce9e577f63554032cef186' foundation='1' type='host' priority='2130706431' network='0'/><candidate port='10000' priority='1694498815' component='1' type='srflx' ip='52.214.101.26' protocol='udp' rel-addr='10.255.254.5' id='10aa6ccc77f6355405ca5589b' foundation='2' rel-port='10000' generation='0' network='0'/></transport></content><group xmlns='urn:xmpp:jingle:apps:grouping:0' semantics='BUNDLE'><content name='audio'/><content name='video'/></group><bridge-session xmlns='http://jitsi.org/protocol/focus' id='64002_edbedc'/></jingle></iq>
Oct 06 15:43:49.583 DEBUG Received Jingle session-initiate from focus@auth.meet.jitsi/focus5356607811024394
Oct 06 15:43:49.583 DEBUG adding ssrc to remote_ssrc_map: Source { id: "3063999702", parameters: [Parameter { name: "cname", value: Some("mixed") }, Parameter { name: "label", value: Some("mixedlabelaudio0") }, Parameter { name: "msid", value: Some("mixedmslabel mixedlabelaudio0") }, Parameter { name: "mslabel", value: Some("mixedmslabel") }], info: Some(SsrcInfo { owner: "jvb" }) }
Oct 06 15:43:49.583 DEBUG adding ssrc to remote_ssrc_map: Source { id: "3668235259", parameters: [Parameter { name: "cname", value: Some("mixed") }, Parameter { name: "label", value: Some("mixedlabelvideo0") }, Parameter { name: "msid", value: Some("mixedmslabel mixedlabelvideo0") }, Parameter { name: "mslabel", value: Some("mixedmslabel") }], info: Some(SsrcInfo { owner: "jvb" }) }
Oct 06 15:43:49.583  WARN Remote DTLS fingerprint (verification not implemented yet): [75, 252, 142, 58, 25, 89, 103, 10, 90, 220, 68, 58, 171, 88, 221, 69, 177, 1, 168, 237, 107, 28, 108, 146, 67, 11, 218, 8, 228, 29, 97, 139]
Oct 06 15:43:49.583 DEBUG Local DTLS certificate:
-----BEGIN CERTIFICATE-----
MIIBUTCB96ADAgECAggj1enxder3OTAKBggqhkjOPQQDAjAhMR8wHQYDVQQDDBZy
Y2dlbiBzZWxmIHNpZ25lZCBjZXJ0MCAXDTc1MDEwMTAwMDAwMFoYDzQwOTYwMTAx
MDAwMDAwWjAhMR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MFkwEwYH
KoZIzj0CAQYIKoZIzj0DAQcDQgAEdez4UOTyfETxjNBzYH6g83xyBe8C3H1o95ss
Q10VSESsfv44S5ViFPOYy252X5ON6PpJR7edjY0CwzpB2UpsO6MXMBUwEwYDVR0R
BAwwCoIIZ3N0LW1lZXQwCgYIKoZIzj0EAwIDSQAwRgIhALNOgbQFN/9po0vWyOcb
xxiI8l6p55zaIRooS/lJmefuAiEAmIIpPqGiPocMQYTg3yN6UUjkrdOHpS7/EfRu
+9+mqMI=
-----END CERTIFICATE-----

Oct 06 15:43:49.583 DEBUG Local DTLS fingerprint: 83:2E:45:48:A8:5A:B9:1F:3C:A0:7A:5C:81:9F:11:CA:1B:EA:A9:44:2A:77:A:7F:58:DE:92:56:67:C:FB:8B
Oct 06 15:43:49.584 DEBUG audio SSRC: 1279764169
Oct 06 15:43:49.584 DEBUG video SSRC: 3757068330
Oct 06 15:43:49.584 DEBUG video RTX SSRC: 1324559620
Oct 06 15:43:49.584 DEBUG STUN address: None
Oct 06 15:43:49.584 DEBUG ice_agent=Agent(ObjectRef { inner: 0x7f9260046010, type: NiceAgent })
Oct 06 15:43:49.584 DEBUG ice_stream_id=1
Oct 06 15:43:49.584 DEBUG ice_component_id=1
Oct 06 15:43:49.584 DEBUG setting ICE remote credentials
Oct 06 15:43:49.584 DEBUG gathering ICE candidates
Oct 06 15:43:49.586 DEBUG ICE candidate-gathering-done 1
Oct 06 15:43:49.586 DEBUG setting ICE remote candidates: [Candidate { component: 1, foundation: "1", generation: 0, id: "8bce9e577f63554032cef186", ip: 10.255.254.5, port: 10000, priority: 2130706431, protocol: "udp", rel_addr: None, rel_port: None, network: Some(0), type_: Host }, Candidate { component: 1, foundation: "2", generation: 0, id: "10aa6ccc77f6355405ca5589b", ip: 52.214.101.26, port: 10000, priority: 1694498815, protocol: "udp", rel_addr: Some(10.255.254.5), rel_port: Some(10000), network: Some(0), type_: Srflx }]
Oct 06 15:43:49.587 DEBUG candidate: Candidate { type_: Host, foundation: Ok("1"), addr: 10.255.254.5:10000, priority: 2130706431, stream_id: 1, component_id: 1, username: Ok("6n7je1fhath513"), password: Ok("6lhgv3f4af0cr065c0ubeicvhd") }
Oct 06 15:43:49.587 DEBUG candidate: Candidate { type_: ServerReflexive, foundation: Ok("2"), addr: 52.214.101.26:10000, priority: 1694498815, stream_id: 1, component_id: 1, username: Ok("6n7je1fhath513"), password: Ok("6lhgv3f4af0cr065c0ubeicvhd") }
Oct 06 15:43:49.588 DEBUG building gstreamer pipeline
Oct 06 15:43:49.662 DEBUG linking video payloader -> rtpfunnel
Oct 06 15:43:49.662 DEBUG linking audio payloader -> rtpfunnel
Oct 06 15:43:49.662 DEBUG linking rtpfunnel -> rtpbin
Oct 06 15:43:49.663 DEBUG creating RTX sender for session 0
Oct 06 15:43:49.663 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) send_rtp_src_0]
Oct 06 15:43:49.663 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) send_rtp_sink_0]
Oct 06 15:43:49.663 DEBUG link dtlssrtpdec -> rtpbin
Oct 06 15:43:49.663 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) recv_rtp_sink_0]
Oct 06 15:43:49.664 DEBUG creating RTX receiver for session 0
Oct 06 15:43:49.664 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) recv_rtcp_sink_0]
Oct 06 15:43:49.664 DEBUG linking rtpbin -> dtlssrtpenc
Oct 06 15:43:49.664 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) send_rtcp_src_0]
Oct 06 15:43:49.664 DEBUG linking ice src -> dtlssrtpdec
Oct 06 15:43:49.664 DEBUG linking dtlssrtpenc -> ice sink
Oct 06 15:43:49.665 DEBUG local candidates: [Candidate { type_: Host, foundation: Ok("1"), addr: 192.168.1.48:43048, priority: 2015363327, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("2"), addr: 10.9.241.3:52906, priority: 2015363583, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("3"), addr: 10.9.24.97:47513, priority: 2015363839, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("4"), addr: [fe80::f17f:7072:5601:b0e6%2]:60246, priority: 2015364095, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("5"), addr: [fe80::b750:541f:f9b1:4fc6%4]:37092, priority: 2015364351, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("6"), addr: [fe80::e130:2307:81e2:a6bc%5]:60142, priority: 2015364607, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }]
Oct 06 15:43:49.665 DEBUG building Jingle session-accept
Oct 06 15:43:49.667 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpAFBaTjl5LTIyNDMxMzMArcc9MWwvvctQtbtZX7NpXA==" to="vbck@muc.meet.jitsi/focus" type="result"/>
Oct 06 15:43:49.668 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="275003ea-d5a8-4d39-9e46-0009234cfa36" to="vbck@muc.meet.jitsi/focus" type="set"><jingle xmlns="urn:xmpp:jingle:1" action="session-accept" initiator="focus@auth.meet.jitsi/focus5356607811024394" responder="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" sid="1p2fr8fdl03iu"><content creator="responder" name="audio" senders="both"><description xmlns="urn:xmpp:jingle:apps:rtp:1" media="audio" ssrc="1279764169"><payload-type channels="2" clockrate="48000" id="111" name="opus"><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/></payload-type><rtcp-mux/><source xmlns="urn:xmpp:jingle:apps:rtp:ssma:0" ssrc="1279764169"><parameter name="cname" value="1179bc6f-3352-4eef-894f-d893e89aa8ab"/><parameter name="msid" value="2b6cceb6-2031-4a55-8d04-4ff261d784f2 d6158b58-3e0b-487c-ba10-cbee6d5ec38a"/></source><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="1" uri="urn:ietf:params:rtp-hdrext:ssrc-audio-level"/><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="5" uri="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01"/></description><transport xmlns="urn:xmpp:jingle:transports:ice-udp:1" pwd="q1+1pXrZO8SnCp2ZItIvDO" ufrag="ArXK"><candidate component="1" foundation="1" generation="0" id="d31124e6-2ebb-4b5e-8e85-5e419dc947ff" ip="192.168.1.48" port="43048" priority="2015363327" protocol="udp" type="host"/><candidate component="1" foundation="2" generation="0" id="98ca041d-73c9-403c-912d-6b970af84c1f" ip="10.9.241.3" port="52906" priority="2015363583" protocol="udp" type="host"/><candidate component="1" foundation="3" generation="0" id="99abd936-0103-4c04-b056-f48db436ab6d" ip="10.9.24.97" port="47513" priority="2015363839" protocol="udp" type="host"/><candidate component="1" foundation="4" generation="0" id="af031314-d649-448e-abe1-bafaf528d33d" ip="fe80::f17f:7072:5601:b0e6" port="60246" priority="2015364095" protocol="udp" type="host"/><candidate component="1" foundation="5" generation="0" id="84e2e173-fedc-4efa-ace2-5737c0b180e6" ip="fe80::b750:541f:f9b1:4fc6" port="37092" priority="2015364351" protocol="udp" type="host"/><candidate component="1" foundation="6" generation="0" id="8ac21712-d9ee-4513-ae99-623b2b62f691" ip="fe80::e130:2307:81e2:a6bc" port="60142" priority="2015364607" protocol="udp" type="host"/><fingerprint xmlns="urn:xmpp:jingle:apps:dtls:0" hash="sha-256" required="true" setup="active">83:2E:45:48:A8:5A:B9:1F:3C:A0:7A:5C:81:9F:11:CA:1B:EA:A9:44:2A:77:0A:7F:58:DE:92:56:67:0C:FB:8B</fingerprint></transport></content><content creator="responder" name="video" senders="both"><description xmlns="urn:xmpp:jingle:apps:rtp:1" media="video" ssrc="3757068330"><payload-type clockrate="90000" id="100" name="VP8"><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" subtype="fir" type="ccm"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" subtype="pli" type="nack"/><rtcp-fb xmlns="urn:xmpp:jingle:apps:rtp:rtcp-fb:0" type="transport-cc"/></payload-type><payload-type clockrate="90000" id="96" name="rtx"><parameter name="apt" value="100"/></payload-type><rtcp-mux/><ssrc-group xmlns="urn:xmpp:jingle:apps:rtp:ssma:0" semantics="FID"><source ssrc="3757068330"/><source ssrc="1324559620"/></ssrc-group><source xmlns="urn:xmpp:jingle:apps:rtp:ssma:0" ssrc="3757068330"><parameter name="cname" value="54fedbc1-81f1-4947-8e83-eb3926cd795e"/><parameter name="msid" value="d5d534d9-5b70-4659-a526-d7fefcb9a7c7 8a82d12d-c251-47f8-ae64-c9f04aa43a83"/></source><source xmlns="urn:xmpp:jingle:apps:rtp:ssma:0" ssrc="1324559620"><parameter name="cname" value="54fedbc1-81f1-4947-8e83-eb3926cd795e"/><parameter name="msid" value="d5d534d9-5b70-4659-a526-d7fefcb9a7c7 8a82d12d-c251-47f8-ae64-c9f04aa43a83"/></source><rtp-hdrext xmlns="urn:xmpp:jingle:apps:rtp:rtp-hdrext:0" id="5" uri="http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01"/></description><transport xmlns="urn:xmpp:jingle:transports:ice-udp:1" pwd="q1+1pXrZO8SnCp2ZItIvDO" ufrag="ArXK"><candidate component="1" foundation="1" generation="0" id="41824ad4-3d89-413d-8b8a-aae2684fb090" ip="192.168.1.48" port="43048" priority="2015363327" protocol="udp" type="host"/><candidate component="1" foundation="2" generation="0" id="c442c07c-906c-4198-b2e9-1f17f1fd749d" ip="10.9.241.3" port="52906" priority="2015363583" protocol="udp" type="host"/><candidate component="1" foundation="3" generation="0" id="fc41d350-181e-4b6c-9094-9ee11c7c5a7a" ip="10.9.24.97" port="47513" priority="2015363839" protocol="udp" type="host"/><candidate component="1" foundation="4" generation="0" id="d1f5b7c0-7835-4a4c-a509-764f4eac03df" ip="fe80::f17f:7072:5601:b0e6" port="60246" priority="2015364095" protocol="udp" type="host"/><candidate component="1" foundation="5" generation="0" id="9aaaa913-3554-41f5-bfb0-78085dba8934" ip="fe80::b750:541f:f9b1:4fc6" port="37092" priority="2015364351" protocol="udp" type="host"/><candidate component="1" foundation="6" generation="0" id="d40f90e4-55a1-467a-9688-5d8db9bf50a8" ip="fe80::e130:2307:81e2:a6bc" port="60142" priority="2015364607" protocol="udp" type="host"/><fingerprint xmlns="urn:xmpp:jingle:apps:dtls:0" hash="sha-256" required="true" setup="active">83:2E:45:48:A8:5A:B9:1F:3C:A0:7A:5C:81:9F:11:CA:1B:EA:A9:44:2A:77:0A:7F:58:DE:92:56:67:0C:FB:8B</fingerprint></transport></content></jingle></iq>
Oct 06 15:43:49.740 DEBUG XMPP    <<< <iq id='cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpADYxZWYzYjNmLWNkYmYtNDljNS04MTcxLWZhYjQ4NmIzYTc5ZjpzZW5kSVEAaKO50Yof4KQ8vrZtkyvSjg==' xmlns='jabber:client' type='get' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/9fd0c0b5'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
Oct 06 15:43:49.741 DEBUG Received disco info query from vbck@muc.meet.jitsi/9fd0c0b5 for node None
Oct 06 15:43:49.741 DEBUG XMPP    <<< <message xmlns='jabber:client' type='chat' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' from='vbck@muc.meet.jitsi/9fd0c0b5'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;type&quot;:&quot;olm&quot;,&quot;olm&quot;:{&quot;type&quot;:&quot;session-init&quot;,&quot;data&quot;:{&quot;idKey&quot;:&quot;jA1Fj795vZvD/5pz/4QHqbaJGdz8KTDmuvWugvaaRm4&quot;,&quot;otKey&quot;:&quot;vzm5/HXbxVhR+aGHDML4vK6o1k5Z6c8vXq6Dwr/2/Do&quot;,&quot;uuid&quot;:&quot;823a8acb-3c9e-46f0-866f-18f2dcb937fc&quot;}}}</json-message><x xmlns='http://jabber.org/protocol/muc#user'/></message>
Oct 06 15:43:49.742 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpADYxZWYzYjNmLWNkYmYtNDljNS04MTcxLWZhYjQ4NmIzYTc5ZjpzZW5kSVEAaKO50Yof4KQ8vrZtkyvSjg==" to="vbck@muc.meet.jitsi/9fd0c0b5" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="urn:xmpp:jingle:apps:rtp:audio"/><feature var="urn:xmpp:jingle:apps:rtp:video"/><feature var="urn:xmpp:jingle:transports:ice-udp:1"/><feature var="urn:xmpp:jingle:apps:dtls:0"/><feature var="urn:ietf:rfc:5888"/><feature var="urn:ietf:rfc:5761"/><feature var="urn:ietf:rfc:4588"/><feature var="http://jitsi.org/tcc"/></query></iq>
Oct 06 15:43:49.786 DEBUG XMPP    <<< <iq from='vbck@muc.meet.jitsi/focus' xmlns='jabber:client' type='result' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' id='275003ea-d5a8-4d39-9e46-0009234cfa36'/>
Oct 06 15:43:49.787 DEBUG Focus acknowledged session-accept
Oct 06 15:43:49.787 DEBUG join{xmpp_connection=Connection { tx: Sender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x55802c2bed20, tail_position: 6 }, semaphore: (Semaphore { permits: 64 }, 64), rx_waker: AtomicWaker, tx_count: 3, rx_fields: "..." } } }, inner: Mutex { data: ConnectionInner { state: Idle, jid: Some(FullJID(qzg7eor_wwri8aht@meet.jitsi/_0GGZQei)) } } } glib_main_context=MainContext(Shared { inner: 0x55802c2bc090 }) config=JitsiConferenceConfig { muc: BareJID(vbck@muc.meet.jitsi), focus: BareJID(focus.meet.jitsi), nick: "gst-meet", region: "", video_codec: "vp8", extra_muc_features: [] }}: close time.busy=166µs time.idle=11.7s
Oct 06 15:43:49.787 DEBUG calling on_participant with existing participant: Participant { jid: Some(FullJID(qbfyb25sz6vgabzf@meet.jitsi/vFg_jsbt)), muc_jid: FullJID(vbck@muc.meet.jitsi/9fd0c0b5), nick: Some("teo0") }
Oct 06 15:43:49.787  INFO New participant: Participant { jid: Some(FullJID(qbfyb25sz6vgabzf@meet.jitsi/vFg_jsbt)), muc_jid: FullJID(vbck@muc.meet.jitsi/9fd0c0b5), nick: Some("teo0") }
Oct 06 15:43:49.789 DEBUG add_bin{self=JitsiConference { jid: FullJID(qzg7eor_wwri8aht@meet.jitsi/_0GGZQei), config: JitsiConferenceConfig { muc: BareJID(vbck@muc.meet.jitsi), focus: BareJID(focus.meet.jitsi), nick: "gst-meet", region: "", video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } bin=Bin(ObjectRef { inner: 0x7f92600e6710, type: GstBin })}: close time.busy=79.5µs time.idle=17.9µs
Oct 06 15:43:49.789 DEBUG set_pipeline_state{self=JitsiConference { jid: FullJID(qzg7eor_wwri8aht@meet.jitsi/_0GGZQei), config: JitsiConferenceConfig { muc: BareJID(vbck@muc.meet.jitsi), focus: BareJID(focus.meet.jitsi), nick: "gst-meet", region: "", video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } state=Playing}: close time.busy=96.2µs time.idle=15.2µs
Oct 06 15:43:50.142 DEBUG XMPP    <<< <iq from='vbck@muc.meet.jitsi/focus' xmlns='jabber:client' type='set' to='qzg7eor_wwri8aht@meet.jitsi/_0GGZQei' id='cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpAFBaTjl5LTIyNDMxNTIArcc9MWwvvctQtbtZX7NpXA=='><jingle xmlns='urn:xmpp:jingle:1' action='source-add' sid='1p2fr8fdl03iu'><content name='video'><description media='video' xmlns='urn:xmpp:jingle:apps:rtp:1'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='4077975604'><parameter name='cname' value='dxmhpbDsp8fGo87v-1'/><parameter name='msid' value='3b5466e3-a12c-4d1a-afe8-ff9befcb170b-1 6a103b40-368b-4252-86b1-3521cfe1dd46-1'/><ssrc-info owner='vbck@muc.meet.jitsi/9fd0c0b5' xmlns='http://jitsi.org/jitmeet'/></source><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='3875558317'><parameter name='cname' value='dxmhpbDsp8fGo87v-1'/><parameter name='msid' value='3b5466e3-a12c-4d1a-afe8-ff9befcb170b-1 6a103b40-368b-4252-86b1-3521cfe1dd46-1'/><ssrc-info owner='vbck@muc.meet.jitsi/9fd0c0b5' xmlns='http://jitsi.org/jitmeet'/></source><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='4077975604'/><source ssrc='3875558317'/></ssrc-group></description></content><content name='audio'><description media='audio' xmlns='urn:xmpp:jingle:apps:rtp:1'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='3629437829'><parameter name='cname' value='dxmhpbDsp8fGo87v-1'/><parameter name='msid' value='109f8014-9611-4b58-b6db-d4017a5f3356-1 304a188f-6d44-4d24-b313-c891f0d1a48c-1'/><ssrc-info owner='vbck@muc.meet.jitsi/9fd0c0b5' xmlns='http://jitsi.org/jitmeet'/></source></description></content></jingle></iq>
Oct 06 15:43:50.144 DEBUG Received Jingle source-add
Oct 06 15:43:50.144 DEBUG adding ssrc to remote_ssrc_map: Source { id: "4077975604", parameters: [Parameter { name: "cname", value: Some("dxmhpbDsp8fGo87v-1") }, Parameter { name: "msid", value: Some("3b5466e3-a12c-4d1a-afe8-ff9befcb170b-1 6a103b40-368b-4252-86b1-3521cfe1dd46-1") }], info: Some(SsrcInfo { owner: "vbck@muc.meet.jitsi/9fd0c0b5" }) }
Oct 06 15:43:50.144 DEBUG adding ssrc to remote_ssrc_map: Source { id: "3875558317", parameters: [Parameter { name: "cname", value: Some("dxmhpbDsp8fGo87v-1") }, Parameter { name: "msid", value: Some("3b5466e3-a12c-4d1a-afe8-ff9befcb170b-1 6a103b40-368b-4252-86b1-3521cfe1dd46-1") }], info: Some(SsrcInfo { owner: "vbck@muc.meet.jitsi/9fd0c0b5" }) }
Oct 06 15:43:50.144 DEBUG adding ssrc to remote_ssrc_map: Source { id: "3629437829", parameters: [Parameter { name: "cname", value: Some("dxmhpbDsp8fGo87v-1") }, Parameter { name: "msid", value: Some("109f8014-9611-4b58-b6db-d4017a5f3356-1 304a188f-6d44-4d24-b313-c891f0d1a48c-1") }], info: Some(SsrcInfo { owner: "vbck@muc.meet.jitsi/9fd0c0b5" }) }
Oct 06 15:43:50.145 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="qzg7eor_wwri8aht@meet.jitsi/_0GGZQei" id="cXpnN2Vvcl93d3JpOGFodEBtZWV0LmppdHNpL18wR0daUWVpAFBaTjl5LTIyNDMxNTIArcc9MWwvvctQtbtZX7NpXA==" to="vbck@muc.meet.jitsi/focus" type="result"/>
Oct 06 15:43:50.961 DEBUG rtpbin request-pt-map [(GstElement) (GstRtpBin) rtpbin, (guint) 0, (guint) 111]
Oct 06 15:43:50.961 DEBUG mapped pt to caps: Caps("application/x-rtp, media=(string)audio, encoding-name=(string)OPUS, clock-rate=(int)48000, extmap-1=(string)urn:ietf:params:rtp-hdrext:ssrc-audio-level, extmap-5=(string)http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01")
Oct 06 15:43:50.981 DEBUG new jitterbuffer created for session 0 ssrc 3629437829
Oct 06 15:43:50.981 DEBUG jitterbuffer is for remote source: Source { ssrc: 3629437829, participant_id: Some("9fd0c0b5"), media_type: Audio }
Oct 06 15:43:51.043 DEBUG rtpbin request-pt-map [(GstElement) (GstRtpBin) rtpbin, (guint) 0, (guint) 100]
Oct 06 15:43:51.043 DEBUG mapped pt to caps: Caps("application/x-rtp, media=(string)video, clock-rate=(int)90000, encoding-name=(string)VP8, extmap-5=(string)http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01")
Oct 06 15:43:51.048 DEBUG new jitterbuffer created for session 0 ssrc 4077975604
Oct 06 15:43:51.048 DEBUG jitterbuffer is for remote source: Source { ssrc: 4077975604, participant_id: Some("9fd0c0b5"), media_type: Video }
Oct 06 15:43:51.048 DEBUG enabling RTX for ssrc 4077975604
Oct 06 15:43:51.161 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) recv_rtp_src_0_3629437829_111]
Oct 06 15:43:51.161 DEBUG pad added for remote source: Source { ssrc: 3629437829, participant_id: Some("9fd0c0b5"), media_type: Audio }
Oct 06 15:43:51.161 DEBUG created depayloader
Oct 06 15:43:51.161 DEBUG linked rtpbin.recv_rtp_src_0_3629437829_111 to depayloader
Oct 06 15:43:51.162 DEBUG linking depayloader to participant bin
Oct 06 15:43:51.162 DEBUG depayloader requested extension: 1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
Oct 06 15:43:51.162 DEBUG depayloader requested extension: 5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
Oct 06 15:43:51.244 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) recv_rtp_src_0_4077975604_100]
Oct 06 15:43:51.244 DEBUG pad added for remote source: Source { ssrc: 4077975604, participant_id: Some("9fd0c0b5"), media_type: Video }
Oct 06 15:43:51.244 DEBUG created depayloader
Oct 06 15:43:51.244 DEBUG linked rtpbin.recv_rtp_src_0_4077975604_100 to depayloader
Oct 06 15:43:51.244 DEBUG linking depayloader to participant bin
Oct 06 15:43:51.245 DEBUG depayloader requested extension: 5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
Oct 06 15:44:07.437 DEBUG rtpbin request-pt-map [(GstElement) (GstRtpBin) rtpbin, (guint) 0, (guint) 96]
Oct 06 15:44:07.437 DEBUG mapped pt to caps: Caps("application/x-rtp, media=(string)video, clock-rate=(int)90000, encoding-name=(string)RTX, apt=(guchar)100")
Oct 06 15:44:50.143 ERROR fatal (in read loop): WebSocket protocol error: Connection reset without closing handshake
Oct 06 15:45:01.187 DEBUG pipeline state is null
jbg commented 3 years ago

Thanks for the report!

If you connect to your jitsi-meet deployment with a browser, do you see the websocket reconnecting once a minute? (Check developer tools in your browser, either look for a new websocket entry appearing in the network tab once a minute, or logs in the javascript console referring to it reconnecting.) The standard jitsi-meet frontend handles reconnecting the colibri websocket gracefully (the user doesn't even notice) but reconnecting is not implemented in gst-meet yet.

jbg commented 3 years ago

And thanks for the link to your patch, I'll incorporate these changes, or similar changes, to allow it to work with a focus component and no extdisco support.

teodly commented 3 years ago

The web client websocket connection doesn't break, but the difference is that it pings the server every 10 seconds.

<iq id="c6599877-91a6-4e7b-b2e0-c857183064ee:sendIQ" to="meet.jitsi" type="get" xmlns="jabber:client"><ping xmlns="urn:xmpp:ping"/></iq>
<iq xmlns='jabber:client' type='result' id='c6599877-91a6-4e7b-b2e0-c857183064ee:sendIQ' from='meet.jitsi' to='s3yy7dntw3rnlk5o@meet.jitsi/48j1XMTZ'/>
jbg commented 3 years ago

Ah, we're talking about the XMPP websocket rather than the Colibri websocket, got it.

lib-gst-meet will currently respond to pings from the XMPP server (e.g. if mod_pinger is enabled in Prosody) but it doesn't send them itself, so if the server doesn't send pings and there is a load balancer or proxy (e.g. nginx) in the path with a very short connection timeout, then this behaviour would be expected.

So the fix will be to add support for pinging the server to lib-gst-meet.

teodly commented 3 years ago

Yup, it was caused by nginx proxy (the web component of docker-jitsi-meet). Worked around by adding:

    proxy_read_timeout 36500d;
    proxy_send_timeout 36500d;

to location ~ ^/colibri-ws/([a-zA-Z0-9-\.]+)/(.*) and location = /xmpp-websocket sections of configuration file $CONFIG/web/nginx/meet.conf.

EDIT: don't do it on production server, you'll have ghost users when their internet connection is lost, see below why.

For most users it's probably a better idea to add it to the meet.conf template, but we have autogeneration of this file disabled in our installation.

damencho commented 3 years ago

proxy_read_timeout 36500d; proxy_send_timeout 36500d;

This is a bad idea as it will fail to detect users that lost internet connection and you will keep getting ghosts in the meeting after reload. You should leave it as 30s for /xmpp-websocket ... and send pings every 10 seconds as the client.

jbg commented 3 years ago

If you want a quick fix until client-side pinging is implemented in lib-gst-meet, you can use mod_pinger in prosody to ping from the server side.

teodly commented 3 years ago

This is a bad idea as it will fail to detect users that lost internet connection and you will keep getting ghosts in the meeting after reload.

I thought it'll time out on the kernel level (TCP socket), but I've checked it and the timeout is 2 hours in Ubuntu Server, so... better rely on xmpp ping as you both pointed out.

serenaraju commented 2 years ago

@teowoz Hi, can you please tell me where you were able to view the video that was received?

serenaraju commented 2 years ago

If you want a quick fix until client-side pinging is implemented in lib-gst-meet, you can use mod_pinger in prosody to ping from the server side.

I included the mod_pinger here on /usr/lib/prosody/modules/

image And also here

image As it was (no changes made in the file)

then I added pinger in prosody of my domain tifr.ml.cfg.lua image

But this connection is being reset still. Is there any other reason this might be happening? @jbg Can you please take a look at this if possible?

jbg commented 2 years ago

Client -> server pings are now implemented in 68c9935823e2d0efedd1e0aaadea08f01144c06e, so the connection should stay alive even if something in the path has a very short timeout. Please let me know if it resolves your issue. I'll make a release soon.