Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

User joins but doesn´t play any video or audio file #5

Closed
mkn-ta opened this issue Oct 18, 2021 · 17 comments
Closed

User joins but doesn´t play any video or audio file #5

mkn-ta opened this issue Oct 18, 2021 · 17 comments

Comments

@mkn-ta
Copy link

mkn-ta commented Oct 18, 2021

Hi there,
we are an educational institution and we might like to use the project for a big project of us. However, we have the problem that the gst-meet user enters the room, but the user doesn´t play any audio or video file. We´ve tried a YouTube video and a .mp3 file, we did not get any error messages on the console and all required packages from GStreamer should be installed/compiled. We use Debian 10, Jitsi, GStreamer and gst-meet are all installed on one server. Do you have any idea what could cause the problem?
Thanks

@jbg
Copy link
Contributor

jbg commented Oct 18, 2021

Thanks for getting in touch. Can you run with GST_DEBUG=3 and the --verbose option and paste the logs? Please also provide the full command that you're running.

@mkn-ta
Copy link
Author

mkn-ta commented Oct 19, 2021

Hi @jbg thanks for the response.
If we try this command from the example:

YOUTUBE_URL="https://www.youtube.com/watch?v=vjV_2Ri2rfE"
gst-meet --nick bot-test
--verbose
--web-socket-url=wss://jitsi.example.com/xmpp-websocket
--xmpp-domain=jitsi.example.com
--room-name=test
--video-codec=vp9
--send-pipeline="curlhttpsrc location="$(youtube-dl -g $YOUTUBE_URL -f 'bestaudio[acodec=opus]')" ! queue ! matroskademux name=audiodemux
curlhttpsrc location="$(youtube-dl -g $YOUTUBE_URL -f 'bestvideo[vcodec=vp9]')" ! queue ! matroskademux name=videodemux
audiodemux.audio_0 ! queue ! clocksync name=audio
videodemux.video_0 ! queue ! clocksync name=video"

We get the following output:
Oct 19 07:43:39.850 INFO Connecting XMPP WebSocket to wss://jitsi.example.com/xmpp-websocket
Oct 19 07:43:39.865 DEBUG No cached session for DNSNameRef("jitsi.example.com")
Oct 19 07:43:39.866 DEBUG Not resuming any session
Oct 19 07:43:39.866 DEBUG Using ciphersuite TLS13_CHACHA20_POLY1305_SHA256
Oct 19 07:43:39.866 DEBUG Not resuming
Oct 19 07:43:39.866 DEBUG TLS1.3 encrypted extensions: []
Oct 19 07:43:39.866 DEBUG ALPN protocol is None
Oct 19 07:43:39.867 DEBUG Ticket saved
Oct 19 07:43:39.867 DEBUG Ticket saved
Oct 19 07:43:39.867 DEBUG Client handshake done.
Oct 19 07:43:39.868 DEBUG XMPP >>>
Oct 19 07:43:39.868 DEBUG XMPP <<<
Oct 19 07:43:39.868 INFO Connected XMPP WebSocket
Oct 19 07:43:39.868 DEBUG XMPP <<< <stream:features xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>ANONYMOUS</stream:features>
Oct 19 07:43:39.868 DEBUG XMPP >>>
Oct 19 07:43:39.868 DEBUG XMPP <<<
Oct 19 07:43:39.869 DEBUG XMPP >>>
Oct 19 07:43:39.869 DEBUG XMPP <<<
Oct 19 07:43:39.869 INFO Logged in anonymously
Oct 19 07:43:39.869 DEBUG XMPP <<< <stream:features xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'></stream:features>
Oct 19 07:43:39.869 DEBUG XMPP >>>
Oct 19 07:43:39.869 DEBUG XMPP <<< uzvidf9ihxfy1iub@jitsi.example.com/9hWLcQxI
Oct 19 07:43:39.869 INFO My JID: uzvidf9ihxfy1iub@jitsi.example.com/9hWLcQxI
Oct 19 07:43:39.869 DEBUG XMPP >>>
Oct 19 07:43:39.870 DEBUG XMPP <<<
Oct 19 07:43:39.870 DEBUG XMPP >>>
Oct 19 07:43:39.871 DEBUG XMPP <<<
Oct 19 07:43:39.871 DEBUG external services: [Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1634708619"), password: Some("WbGniRa8O2iPA5h+QqzBcHxaN3E="), expires: Some("2021-10-20T05:43:39Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1634708619"), password: Some("WbGniRa8O2iPA5h+QqzBcHxaN3E="), expires: Some("2021-10-20T05:43:39Z") }]
Oct 19 07:43:39.871 DEBUG new{glib_main_context=MainContext(Shared { inner: 0x556176e52350 }) jid=FullJID(uzvidf9ihxfy1iub@jitsi.example.com/9hWLcQxI) config=JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: FullJID(focus@auth.jitsi.example.com/focus), nick: "bot-test", region: "", video_codec: "vp9" } external_services=[Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1634708619"), password: Some("WbGniRa8O2iPA5h+QqzBcHxaN3E="), expires: Some("2021-10-20T05:43:39Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1634708619"), password: Some("WbGniRa8O2iPA5h+QqzBcHxaN3E="), expires: Some("2021-10-20T05:43:39Z") }]}: close time.busy=1.66µs time.idle=1.54µs
Oct 19 07:43:39.871 DEBUG XMPP >>>
Oct 19 07:43:39.872 DEBUG XMPP <<<
Oct 19 07:43:39.872 DEBUG send_presence{self=JitsiConference { jid: FullJID(uzvidf9ihxfy1iub@jitsi.example.com/9hWLcQxI), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: FullJID(focus@auth.jitsi.example.com/focus), nick: "bot-test", region: "", video_codec: "vp9" }, inner: Mutex { data: } } 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("vp9")] }, 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("bot-test")] }, Element { name: "region", namespace: "http://jitsi.org/jitsi-meet", prefix: None, prefixes: Prefixes(), attributes: {"id": ""}, children: [] }]}: close time.busy=4.53µs time.idle=1.12µs
Oct 19 07:43:39.872 DEBUG XMPP >>> pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=gst-meet<jitsi_participant_codecType>vp9</jitsi_participant_codecType><jitsi_participant_region></jitsi_participant_region>falsefalsebot-test
Oct 19 07:43:39.873 DEBUG XMPP <<< Jordan-jPL<jitsi_participant_codecType>vp8</jitsi_participant_codecType>https://bbb-01.example.com:8443/user/pix.php/2/f1.jpgtest<jitsi_participant_e2ee.idKey>PdOQL9PeARls+tK6rtWvdcG2byNujqjJ29YYgmcnjHY</jitsi_participant_e2ee.idKey>truetrue
Oct 19 07:43:39.873 DEBUG Joined MUC: test@conference.jitsi.example.com
Oct 19 07:43:39.874 DEBUG XMPP <<< 0test1.0.813
Oct 19 07:43:39.874 DEBUG XMPP <<< pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=gst-meet<jitsi_participant_codecType>vp9</jitsi_participant_codecType><jitsi_participant_region/>falsefalsebot-test
Oct 19 07:43:39.874 DEBUG MUC user presence: MucUser { status: [NonAnonymousRoom, SelfPresence], items: [Item { affiliation: None, jid: Some(FullJID(uzvidf9ihxfy1iub@jitsi.example.com/9hWLcQxI)), nick: None, role: Participant, actor: None, continue_: None, reason: None }] }
Oct 19 07:43:39.874 DEBUG XMPP <<< {"type":"conference_duration","created_timestamp":1634622208000}
Oct 19 07:43:39.874 DEBUG XMPP <<<
Oct 19 07:43:39.917 DEBUG XMPP <<< 0test1.0.813
Oct 19 07:43:39.917 DEBUG XMPP <<<
Oct 19 07:43:39.917 DEBUG Received disco info query from test@conference.jitsi.example.com/focus for node None
Oct 19 07:43:39.918 DEBUG XMPP >>>
Oct 19 07:43:40.013 DEBUG XMPP <<< F2:E6:0E:C4:02:BB:F2:91:B8:83:D2:44:D9:D4:C6:4B:B2:FB:E0:61:85:8D:B1:C3:8D:AA:69:59:9C:C3:44:91F2:E6:0E:C4:02:BB:F2:91:B8:83:D2:44:D9:D4:C6:4B:B2:FB:E0:61:85:8D:B1:C3:8D:AA:69:59:9C:C3:44:91
Oct 19 07:43:40.013 DEBUG Received non-Jingle IQ

And if we try to play some mp3 file with:

gst-meet --room-name test
--verbose
--nick "bot-test"
--web-socket-url=wss://jitsi.example.com/xmpp-websocket
--xmpp-domain=jitsi.example.com
--send-pipeline="filesrc location=test.mp3 name=audio"

We get this output:
Oct 19 07:52:45.345 INFO Connecting XMPP WebSocket to wss://jitsi.example.com/xmpp-websocket
Oct 19 07:52:45.361 DEBUG No cached session for DNSNameRef("jitsi.example.com")
Oct 19 07:52:45.361 DEBUG Not resuming any session
Oct 19 07:52:45.362 DEBUG Using ciphersuite TLS13_CHACHA20_POLY1305_SHA256
Oct 19 07:52:45.362 DEBUG Not resuming
Oct 19 07:52:45.362 DEBUG TLS1.3 encrypted extensions: []
Oct 19 07:52:45.362 DEBUG ALPN protocol is None
Oct 19 07:52:45.366 DEBUG Ticket saved
Oct 19 07:52:45.366 DEBUG Ticket saved
Oct 19 07:52:45.368 DEBUG Client handshake done.
Oct 19 07:52:45.368 DEBUG XMPP >>>
Oct 19 07:52:45.370 DEBUG XMPP <<<
Oct 19 07:52:45.370 INFO Connected XMPP WebSocket
Oct 19 07:52:45.370 DEBUG XMPP <<< <stream:features xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'>ANONYMOUS</stream:features>
Oct 19 07:52:45.370 DEBUG XMPP >>>
Oct 19 07:52:45.372 DEBUG XMPP <<<
Oct 19 07:52:45.372 DEBUG XMPP >>>
Oct 19 07:52:45.373 DEBUG XMPP <<<
Oct 19 07:52:45.374 INFO Logged in anonymously
Oct 19 07:52:45.374 DEBUG XMPP <<< <stream:features xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams'></stream:features>
Oct 19 07:52:45.374 DEBUG XMPP >>>
Oct 19 07:52:45.375 DEBUG XMPP <<< 09pnjxeifo7xn0ap@jitsi.example.com/wXVGh5-p
Oct 19 07:52:45.375 INFO My JID: 09pnjxeifo7xn0ap@jitsi.example.com/wXVGh5-p
Oct 19 07:52:45.376 DEBUG XMPP >>>
Oct 19 07:52:45.378 DEBUG XMPP <<<
Oct 19 07:52:45.379 DEBUG XMPP >>>
Oct 19 07:52:45.381 DEBUG XMPP <<<
Oct 19 07:52:45.381 DEBUG external services: [Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1634709165"), password: Some("8Gwst06ANWt5hspu5fp3NJw4Tok="), expires: Some("2021-10-20T05:52:45Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1634709165"), password: Some("8Gwst06ANWt5hspu5fp3NJw4Tok="), expires: Some("2021-10-20T05:52:45Z") }]
Oct 19 07:52:45.381 DEBUG XMPP >>>
Oct 19 07:52:45.381 DEBUG new{glib_main_context=MainContext(Shared { inner: 0x562a98c91750 }) jid=FullJID(09pnjxeifo7xn0ap@jitsi.example.com/wXVGh5-p) config=JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: FullJID(focus@auth.jitsi.example.com/focus), nick: "bot-test", region: "", video_codec: "vp8" } external_services=[Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1634709165"), password: Some("8Gwst06ANWt5hspu5fp3NJw4Tok="), expires: Some("2021-10-20T05:52:45Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1634709165"), password: Some("8Gwst06ANWt5hspu5fp3NJw4Tok="), expires: Some("2021-10-20T05:52:45Z") }]}: close time.busy=5.42µs time.idle=8.31µs
Oct 19 07:52:45.385 DEBUG XMPP <<<
Oct 19 07:52:45.386 DEBUG send_presence{self=JitsiConference { jid: FullJID(09pnjxeifo7xn0ap@jitsi.example.com/wXVGh5-p), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: FullJID(focus@auth.jitsi.example.com/focus), nick: "bot-test", region: "", video_codec: "vp8" }, inner: Mutex { data: } } 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("bot-test")] }, Element { name: "region", namespace: "http://jitsi.org/jitsi-meet", prefix: None, prefixes: Prefixes(), attributes: {"id": ""}, children: [] }]}: close time.busy=20.9µs time.idle=6.27µs
Oct 19 07:52:45.386 DEBUG XMPP >>> pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=gst-meet<jitsi_participant_codecType>vp8</jitsi_participant_codecType><jitsi_participant_region></jitsi_participant_region>falsefalsebot-test
Oct 19 07:52:45.393 DEBUG XMPP <<< Jordan-jPL<jitsi_participant_codecType>vp8</jitsi_participant_codecType>https://bbb-01.example.com:8443/user/pix.php/2/f1.jpgtest<jitsi_participant_e2ee.idKey>PdOQL9PeARls+tK6rtWvdcG2byNujqjJ29YYgmcnjHY</jitsi_participant_e2ee.idKey>truetrue
Oct 19 07:52:45.394 DEBUG Joined MUC: test@conference.jitsi.example.com
Oct 19 07:52:45.394 DEBUG XMPP <<< 0test1.0.813
Oct 19 07:52:45.394 DEBUG XMPP <<< pr/wwetmaxozjpmQn1lvYrzZnmR8UdWw0/Gr1XPkV+0=gst-meet<jitsi_participant_codecType>vp8</jitsi_participant_codecType><jitsi_participant_region/>falsefalsebot-test
Oct 19 07:52:45.394 DEBUG MUC user presence: MucUser { status: [NonAnonymousRoom, SelfPresence], items: [Item { affiliation: None, jid: Some(FullJID(09pnjxeifo7xn0ap@jitsi.example.com/wXVGh5-p)), nick: None, role: Participant, actor: None, continue_: None, reason: None }] }
Oct 19 07:52:45.394 DEBUG XMPP <<< {"type":"speakerstats","users":{"31itj59smtmf3b2h":{"displayName":"bot-test","totalDominantSpeakerTime":0},"uzvidf9ihxfy1iub":{"displayName":"bot-test","totalDominantSpeakerTime":0},"fucevxcxdf7ci1ri":{"displayName":"TA Bildungszentrum","totalDominantSpeakerTime":0}}}
Oct 19 07:52:45.394 DEBUG XMPP <<< {"type":"conference_duration","created_timestamp":1634622208000}
Oct 19 07:52:45.394 DEBUG XMPP <<<
Oct 19 07:52:45.434 DEBUG XMPP <<< 0test1.0.813
Oct 19 07:52:45.434 DEBUG XMPP <<<
Oct 19 07:52:45.434 DEBUG Received disco info query from test@conference.jitsi.example.com/focus for node None
Oct 19 07:52:45.435 DEBUG XMPP >>>
Oct 19 07:52:45.456 DEBUG XMPP <<< F2:E6:0E:C4:02:BB:F2:91:B8:83:D2:44:D9:D4:C6:4B:B2:FB:E0:61:85:8D:B1:C3:8D:AA:69:59:9C:C3:44:91F2:E6:0E:C4:02:BB:F2:91:B8:83:D2:44:D9:D4:C6:4B:B2:FB:E0:61:85:8D:B1:C3:8D:AA:69:59:9C:C3:44:91
Oct 19 07:52:45.457 DEBUG Received non-Jingle IQ

@linkmauve
Copy link
Contributor

Hi, GitHub ate the relevant parts of your debug log, please edit your message with ``` around the debug log, to make it format it as code.

@jbg
Copy link
Contributor

jbg commented Oct 25, 2021

Oct 19 07:52:45.457 DEBUG Received non-Jingle IQ

I think this might have been Jitsi's non-standard jingle element failing to parse correctly. Please try again with latest master, and if it still doesn't work, please send your logs formatted as code as @linkmauve suggested above.

@mkn-ta
Copy link
Author

mkn-ta commented Oct 26, 2021

Hi, we´ve updated gst-meet v0.2.2 with cargo install --force gst-meet.
Unfortunately we´re getting nearly the same output.

YOUTUBE_URL="https://www.youtube.com/watch?v=vjV_2Ri2rfE"
gst-meet --web-socket-url=wss://jitsi.example.com/xmpp-websocket
--verbose
--xmpp-domain=jitsi.example.com
--room-name=test
--video-codec=vp9
--send-pipeline="curlhttpsrc location="$(youtube-dl -g $YOUTUBE_URL -f 'bestaudio[acodec=opus]')" ! queue ! matroskademux name=audiodemux
curlhttpsrc location="$(youtube-dl -g $YOUTUBE_URL -f 'bestvideo[vcodec=vp9]')" ! queue ! matroskademux name=videodemux
audiodemux.audio_0 ! queue ! clocksync name=audio
videodemux.video_0 ! queue ! clocksync name=video"

Oct 26 11:05:57.558 DEBUG No cached session for DNSNameRef("jitsi.example.com")
Oct 26 11:05:57.558 DEBUG Not resuming any session
Oct 26 11:05:57.559 DEBUG Using ciphersuite TLS13_CHACHA20_POLY1305_SHA256
Oct 26 11:05:57.559 DEBUG Not resuming
Oct 26 11:05:57.559 DEBUG TLS1.3 encrypted extensions: []
Oct 26 11:05:57.559 DEBUG ALPN protocol is None
Oct 26 11:05:57.560 DEBUG Ticket saved
Oct 26 11:05:57.560 DEBUG Ticket saved
Oct 26 11:05:57.560 DEBUG Client handshake done.
Oct 26 11:05:57.561 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="jitsi.example.com" version="1.0"/>
Oct 26 11:05:57.561 DEBUG XMPP    <<< <open from='jitsi.example.com' version='1.0' id='0539907a-fcb1-4407-87bd-ec370346ba84' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
Oct 26 11:05:57.561  INFO Connected XMPP WebSocket
Oct 26 11:05:57.561 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 26 11:05:57.561 DEBUG XMPP    >>> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="ANONYMOUS"></auth>
Oct 26 11:05:57.562 DEBUG XMPP    <<< <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
Oct 26 11:05:57.562 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="jitsi.example.com" version="1.0"/>
Oct 26 11:05:57.562 DEBUG XMPP    <<< <open from='jitsi.example.com' version='1.0' id='fab0b816-83e2-4f69-ba43-3af00e00bce5' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
Oct 26 11:05:57.562  INFO Logged in anonymously
Oct 26 11:05:57.562 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 ver='vxBnkHr84q8DpXesblwTtMRcbvo=' node='http://prosody.im' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><ver xmlns='urn:xmpp:features:rosterver'/></stream:features>
Oct 26 11:05:57.562 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="4d5012af-19ed-403a-8273-25dc0ebdcffd" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/></iq>
Oct 26 11:05:57.563 DEBUG XMPP    <<< <iq xmlns='jabber:client' id='4d5012af-19ed-403a-8273-25dc0ebdcffd' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1</jid></bind></iq>
Oct 26 11:05:57.563  INFO My JID: uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1
Oct 26 11:05:57.563 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1" id="002c79d6-3575-4b9e-ab56-a1732f7f92c7" to="jitsi.example.com" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
Oct 26 11:05:57.563 DEBUG XMPP    <<< <iq from='jitsi.example.com' id='002c79d6-3575-4b9e-ab56-a1732f7f92c7' xmlns='jabber:client' type='result' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><query xmlns='http://jabber.org/protocol/disco#info'><identity name='Prosody PubSub Service' category='pubsub' type='service'/><identity name='conferenceduration.jitsi.example.com' category='component' type='conference_duration'/><identity name='avmoderation.jitsi.example.com' category='component' type='av_moderation'/><identity name='Prosody' category='server' type='im'/><identity name='lobby.jitsi.example.com' category='component' type='lobbyrooms'/><identity name='Prosody' category='pubsub' type='pep'/><identity name='speakerstats.jitsi.example.com' category='component' type='speakerstats'/><feature var='http://jabber.org/protocol/pubsub'/><feature var='http://jabber.org/protocol/pubsub#publisher-affiliation'/><feature var='http://jabber.org/protocol/pubsub#create-nodes'/><feature var='http://jabber.org/protocol/pubsub#create-and-configure'/><feature var='http://jabber.org/protocol/pubsub#delete-nodes'/><feature var='http://jabber.org/protocol/pubsub#delete-items'/><feature var='http://jabber.org/protocol/pubsub#persistent-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-default'/><feature var='http://jabber.org/protocol/pubsub#access-open'/><feature var='http://jabber.org/protocol/pubsub#subscription-options'/><feature var='http://jabber.org/protocol/pubsub#config-node'/><feature var='http://jabber.org/protocol/pubsub#subscribe'/><feature var='http://jabber.org/protocol/pubsub#publish-options'/><feature var='http://jabber.org/protocol/pubsub#retrieve-items'/><feature var='http://jabber.org/protocol/pubsub#retract-items'/><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#retrieve-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#meta-data'/><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#publish'/><feature var='http://jabber.org/protocol/pubsub#instant-nodes'/><feature var='http://jabber.org/protocol/pubsub#multi-items'/><feature var='http://jabber.org/protocol/pubsub#modify-affiliations'/><feature var='urn:xmpp:carbons:2'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='urn:xmpp:ping'/><feature var='http://jabber.org/protocol/commands'/><feature var='urn:xmpp:blocking'/><feature var='jabber:iq:roster'/><feature var='msgoffline'/><feature var='jabber:iq:private'/><feature var='jabber:iq:register'/><feature var='jabber:iq:version'/><feature var='urn:xmpp:time'/><feature var='jabber:iq:time'/><feature var='jabber:iq:last'/><feature var='urn:xmpp:extdisco:2'/><feature var='urn:xmpp:extdisco:1'/><feature var='vcard-temp'/></query></iq>
Oct 26 11:05:57.563 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1" id="60161c70-5d10-4312-a52d-8ffb8b38c5c4" to="jitsi.example.com" type="get"><services xmlns="urn:xmpp:extdisco:2"/></iq>
Oct 26 11:05:57.564 DEBUG XMPP    <<< <iq from='jitsi.example.com' id='60161c70-5d10-4312-a52d-8ffb8b38c5c4' xmlns='jabber:client' type='result' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><services xmlns='urn:xmpp:extdisco:2'><service port='3478' type='stun' host='jitsi.example.com'/><service password='80Hr7kdZHhKGmeqthu04vXEWrxQ=' port='3478' transport='udp' expires='2021-10-27T09:05:57Z' username='1635325557' restricted='1' type='turn' host='jitsi.example.com'/><service password='80Hr7kdZHhKGmeqthu04vXEWrxQ=' port='5349' transport='tcp' expires='2021-10-27T09:05:57Z' username='1635325557' restricted='1' type='turns' host='jitsi.example.com'/></services></iq>
Oct 26 11:05:57.564 DEBUG external services: [Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1635325557"), password: Some("80Hr7kdZHhKGmeqthu04vXEWrxQ="), expires: Some("2021-10-27T09:05:57Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1635325557"), password: Some("80Hr7kdZHhKGmeqthu04vXEWrxQ="), expires: Some("2021-10-27T09:05:57Z") }]
Oct 26 11:05:57.564 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="42792315-f20a-4b7d-97a0-8e851a85463a" to="focus@auth.jitsi.example.com/focus" type="set"><conference xmlns="http://jitsi.org/protocol/focus" machine-uid="b1b1509a-af62-4656-be98-affb9a2b0bb5" room="test@conference.jitsi.example.com"><property name="stereo" value="true"/><property name="startBitrate" value="800"/></conference></iq>
Oct 26 11:05:57.564 DEBUG new{glib_main_context=MainContext(Shared { inner: 0x555cbd1e51a0 }) jid=FullJID(uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1) config=JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: FullJID(focus@auth.jitsi.example.com/focus), nick: "gst-meet", region: "", video_codec: "vp9" } external_services=[Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1635325557"), password: Some("80Hr7kdZHhKGmeqthu04vXEWrxQ="), expires: Some("2021-10-27T09:05:57Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1635325557"), password: Some("80Hr7kdZHhKGmeqthu04vXEWrxQ="), expires: Some("2021-10-27T09:05:57Z") }]}: close time.busy=1.31µs time.idle=1.67µs
Oct 26 11:05:57.575 DEBUG XMPP    <<< <iq from='focus@auth.jitsi.example.com/focus' id='42792315-f20a-4b7d-97a0-8e851a85463a' xmlns='jabber:client' type='result' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><conference ready='true' xmlns='http://jitsi.org/protocol/focus' room='test@conference.jitsi.example.com' focusjid='focus@auth.jitsi.example.com'><property value='false' name='authentication'/></conference></iq>
Oct 26 11:05:57.575 DEBUG send_presence{self=JitsiConference { jid: FullJID(uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: FullJID(focus@auth.jitsi.example.com/focus), nick: "gst-meet", region: "", video_codec: "vp9" }, inner: Mutex { data: <locked> } } 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("vp9")] }, 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=4.30µs time.idle=1.19µs
Oct 26 11:05:57.575 DEBUG XMPP    >>> <presence xmlns="jabber:client" to="test@conference.jitsi.example.com/uomvsy_jebkhj2pc"><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>vp9</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 26 11:05:57.576 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='UVY2M-352' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/></conference-properties><c node='http://jitsi.org/jicofo' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Oct 26 11:05:57.576 DEBUG Joined MUC: test@conference.jitsi.example.com
Oct 26 11:05:57.576 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/uomvsy_jebkhj2pc' xmlns='jabber:client' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><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>vp9</jitsi_participant_codecType><jitsi_participant_region/><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns='http://jabber.org/protocol/nick'>gst-meet</nick><region id='' xmlns='http://jitsi.org/jitsi-meet'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><status code='100'/><item jid='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1' affiliation='none' role='participant'/><status code='110'/></x></presence>
Oct 26 11:05:57.576 DEBUG MUC user presence: MucUser { status: [NonAnonymousRoom, SelfPresence], items: [Item { affiliation: None, jid: Some(FullJID(uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1)), nick: None, role: Participant, actor: None, continue_: None, reason: None }] }
Oct 26 11:05:57.576 DEBUG XMPP    <<< <message from='conferenceduration.jitsi.example.com' xmlns='jabber:client' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;type&quot;:&quot;conference_duration&quot;,&quot;created_timestamp&quot;:1635239157000}</json-message></message>
Oct 26 11:05:57.576 DEBUG XMPP    <<< <message from='test@conference.jitsi.example.com' xmlns='jabber:client' type='groupchat' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><subject/></message>
Oct 26 11:05:57.621 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/uomvsy_jebkhj2pc' xmlns='jabber:client' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><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>vp9</jitsi_participant_codecType><jitsi_participant_region/><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns='http://jabber.org/protocol/nick'>gst-meet</nick><region id='' xmlns='http://jitsi.org/jitsi-meet'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1' affiliation='owner' role='moderator'><actor nick='focus'/></item><status code='110'/></x></presence>
Oct 26 11:05:57.621 DEBUG MUC user presence: MucUser { status: [SelfPresence], items: [Item { affiliation: Owner, jid: Some(FullJID(uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1)), nick: None, role: Moderator, actor: Some(Nick("focus")), continue_: None, reason: None }] }
Oct 26 11:05:57.621 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='UVY2M-352' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/></conference-properties><c node='http://jitsi.org/jicofo' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Oct 26 11:06:20.093 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/36928569' xmlns='jabber:client' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><stats-id>Jordan-jPL</stats-id><c hash='sha-1' ver='D50Kz2zZl6ZxcI7RzgE166vg6PM=' xmlns='http://jabber.org/protocol/caps' node='https://jitsi.org/jitsi-meet'/><features><feature var='https://jitsi.org/meet/e2ee'/></features><jitsi_participant_codecType>vp8</jitsi_participant_codecType><nick xmlns='http://jabber.org/protocol/nick'>user</nick><jitsi_participant_e2ee.idKey>E4Z0VwwbNUzD0QNsdagEBXwn906zOQpwNudaZBBSVXY</jitsi_participant_e2ee.idKey><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='empdcif9uxkqnh0t@jitsi.example.com/2OBD45xq' affiliation='none' role='participant'/></x></presence>
Oct 26 11:06:20.094 DEBUG MUC user presence: MucUser { status: [], items: [Item { affiliation: None, jid: Some(FullJID(empdcif9uxkqnh0t@jitsi.example.com/2OBD45xq)), nick: None, role: Participant, actor: None, continue_: None, reason: None }] }
Oct 26 11:06:20.094 DEBUG new participant: FullJID(empdcif9uxkqnh0t@jitsi.example.com/2OBD45xq)
Oct 26 11:06:20.096 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='UVY2M-365' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/><property value='1' key='bridge-count'/></conference-properties><c hash='sha-1' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jicofo'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Oct 26 11:06:20.096 DEBUG XMPP    <<< <iq from='test@conference.jitsi.example.com/focus' id='dW9tdnN5X2plYmtoajJwY0BqaXRzaS0wMS50YS5kZS9nQ01UcEVTMQBFRVhYMy0xNgDx1Z7dyIVhPiKtveMhebkI' xmlns='jabber:client' type='get' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><query xmlns='http://jabber.org/protocol/disco#info'/></iq>
Oct 26 11:06:20.096 DEBUG Received disco info query from test@conference.jitsi.example.com/focus for node None
Oct 26 11:06:20.096 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1" id="dW9tdnN5X2plYmtoajJwY0BqaXRzaS0wMS50YS5kZS9nQ01UcEVTMQBFRVhYMy0xNgDx1Z7dyIVhPiKtveMhebkI" to="test@conference.jitsi.example.com/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:5761"/><feature var="urn:ietf:rfc:5888"/><feature var="http://jitsi.org/opus-red"/></query></iq>
Oct 26 11:06:20.203 DEBUG XMPP    <<< <iq from='test@conference.jitsi.example.com/focus' id='dW9tdnN5X2plYmtoajJwY0BqaXRzaS0wMS50YS5kZS9nQ01UcEVTMQBVVlkyTS0zNzMA8dWe3ciFYT4irb3jIXm5CA==' xmlns='jabber:client' type='set' to='uomvsy_jebkhj2pc@jitsi.example.com/gCMTpES1'><jingle action='session-initiate' initiator='focus@auth.jitsi.example.com/focus' sid='de8ug2mg1vs3v' xmlns='urn:xmpp:jingle:1'><content name='audio' creator='initiator' senders='both'><description media='audio' xmlns='urn:xmpp:jingle:apps:rtp:1' maxptime='60'><payload-type id='111' channels='2' name='opus' clockrate='48000'><parameter value='10' name='minptime'/><parameter value='1' name='stereo'/><parameter value='1' name='useinbandfec'/></payload-type><payload-type name='ISAC' id='103' clockrate='16000'/><payload-type name='ISAC' id='104' clockrate='32000'/><payload-type name='telephone-event' id='126' clockrate='8000'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' id='1' uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level'/><rtcp-mux/><source name='jvb-a0' ssrc='2380952034' xmlns='urn:xmpp:jingle:apps:rtp:ssma:0'><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/><parameter value='mixedmslabel mixedlabelaudio0' name='msid'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='65tkkidtkl8rlk2v03bm9j1l8u' ufrag='e1chi1fittjdrl'><web-socket url='wss://jitsi.example.com:443/colibri-ws/default-id/d489889322428102/uomvsy_jebkhj2pc?pwd=65tkkidtkl8rlk2v03bm9j1l8u' xmlns='http://jitsi.org/protocol/colibri'/><rtcp-mux/><fingerprint required='false' setup='actpass' xmlns='urn:xmpp:jingle:apps:dtls:0' hash='sha-256'>30:76:78:44:F9:3B:DE:B1:F3:51:90:F3:84:6C:8C:39:40:98:C9:78:D9:AA:AB:47:87:A7:1A:26:47:BE:7A:9E</fingerprint><candidate foundation='1' id='2231f8030bc12960327e7338' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/><candidate foundation='2' id='65e6ed4230bc1296065f4fd6d' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/></transport></content><content name='video' creator='initiator' senders='both'><description media='video' xmlns='urn:xmpp:jingle:apps:rtp:1'><payload-type name='VP8' id='100' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/></payload-type><payload-type name='H264' id='107' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><parameter value='42e01f;level-asymmetry-allowed=1;packetization-mode=1;' name='profile-level-id'/></payload-type><payload-type name='VP9' id='101' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/></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'/><rtcp-mux/><source name='jvb-v0' ssrc='1921694388' xmlns='urn:xmpp:jingle:apps:rtp:ssma:0'><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/><parameter value='mixedmslabel mixedlabelvideo0' name='msid'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='65tkkidtkl8rlk2v03bm9j1l8u' ufrag='e1chi1fittjdrl'><web-socket url='wss://jitsi.example.com:443/colibri-ws/default-id/d489889322428102/uomvsy_jebkhj2pc?pwd=65tkkidtkl8rlk2v03bm9j1l8u' xmlns='http://jitsi.org/protocol/colibri'/><rtcp-mux/><fingerprint required='false' setup='actpass' xmlns='urn:xmpp:jingle:apps:dtls:0' hash='sha-256'>30:76:78:44:F9:3B:DE:B1:F3:51:90:F3:84:6C:8C:39:40:98:C9:78:D9:AA:AB:47:87:A7:1A:26:47:BE:7A:9E</fingerprint><candidate foundation='1' id='2231f8030bc12960327e7338' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/><candidate foundation='2' id='65e6ed4230bc1296065f4fd6d' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/></transport></content><group xmlns='urn:xmpp:jingle:apps:grouping:0' semantics='BUNDLE'><content name='audio'/><content name='video'/></group><bridge-session id='4c408f' xmlns='http://jitsi.org/protocol/focus'/></jingle></iq>
Oct 26 11:06:20.204 DEBUG Received non-Jingle IQ

@jbg
Copy link
Contributor

jbg commented Oct 26, 2021

Apologies, by "latest master" I mean the source code here in the master branch of the git repository:

git clone https://github.com/avstack/gst-meet.git
cd gst-meet
cargo run --release -- --web-socket-url=wss://jitsi.example.com/xmpp-websocket (… the rest of your options …)

We haven't made a release of the latest code to crates.io yet but will soon.

@mkn-ta
Copy link
Author

mkn-ta commented Oct 26, 2021

Ah okay, thanks :-)

Now we´re getting the following error with cargo run:

```warning: unused import: error
--> gst-meet/src/main.rs:17:15
|
17 | use tracing::{error, info, trace, warn};
| ^^^^^
|
= note: `#[warn(unused_imports)]` on by default

warning: gst-meet` (bin "gst-meet") generated 1 warning
Finished release [optimized] target(s) in 0.05s
Running target/release/gst-meet '--web-socket-url=wss://jitsi.example.com/xmpp-websocket' --verbose --xmpp-domain=jitsi.example.com --room-name=test --video-codec=vp9 '--send-pipeline=curlhttpsrc location="https://r2---sn-4g5ednd7.googlevideo.com/videoplayback?expire=1635262489&ei=uct3YdCbMcSngQfg65_wBw&ip=2a01%3A4f8%3A10b%3A47a4%3A0%3A0%3A0%3A2&id=o-AKrnDXXKMr6itFraumWVYooO0XsZYiuxJh-SAqE-UpWs&itag=251&source=youtube&requiressl=yes&mh=zx&mm=31%2C26&mn=sn-4g5ednd7%2Csn-5hne6nsd&ms=au%2Conr&mv=m&mvi=2&pl=48&initcwndbps=458750&vprv=1&mime=audio%2Fwebm&ns=c3IQsv5H--XYi5S01aL5wZAG&gir=yes&clen=505213&dur=30.021&lmt=1628205447121238&mt=1635240539&fvip=2&keepalive=yes&fexp=24001373%2C24007246&c=WEB&txp=5432434&n=9Vqwj_PuPa3HqG7_z&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cvprv%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AOq0QJ8wRQIhALF8Izv-s6yoSp_ZjSZqu-UZXwx2o8Q7VIDYEH6X_JlvAiAzDtlxY48TZMOAtyvZMei-q5w-aKx_nvk5pSfNNbtECQ%3D%3D&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AG3C_xAwRQIhAKh1SuOgiJxAAcR95eEBQJS7orxzUl8RIu8AoPALr7YmAiBXJXp2oKXuaUSrZPd2eqTCEwv9bifg3PATIj6xw6XZYA%3D%3D" '!' queue '!' matroskademux name=audiodemux
curlhttpsrc location="https://r2---sn-4g5ednd7.googlevideo.com/videoplayback?expire=1635262491&ei=ust3YY_sPNKY1gLUna_IAw&ip=2a01%3A4f8%3A10b%3A47a4%3A0%3A0%3A0%3A2&id=o-AFFwtRrTDkR8ZQJ1TbyeYmq86rSvFLtgRd4CWmHn4XGU&itag=243&aitags=133%2C134%2C135%2C160%2C242%2C243%2C278%2C394%2C395%2C396&source=youtube&requiressl=yes&mh=zx&mm=31%2C26&mn=sn-4g5ednd7%2Csn-5hnekn76&ms=au%2Conr&mv=m&mvi=2&pl=48&initcwndbps=497500&vprv=1&mime=video%2Fwebm&ns=ghel3_krkgSxiZbqO0LrnMYG&gir=yes&clen=905016&dur=29.966&lmt=1628205925483449&mt=1635240539&fvip=2&keepalive=yes&fexp=24001373%2C24007246&c=WEB&txp=5432434&n=5LuBnxSU-Q7GQztDJ&sparams=expire%2Cei%2Cip%2Cid%2Caitags%2Csource%2Crequiressl%2Cvprv%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&sig=AOq0QJ8wRAIgT0VNInLx6w1W10vVcSN4mX6QJxrrawchraihbmshxEYCIF0FXxDPcZDb6h3xlI70Prtp2CPvuWOX1L0AbMfzVagx&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AG3C_xAwRAIgSoZw4ahTZcG53LeYRG3jJ3ZRRZk0HIBdhLEPvhDCBYgCIGv-O31mtNv90dnGOeWhEQfruHzQHWFq4Rad78jJOCYI" '!' queue '!' matroskademux name=videodemux
audiodemux.audio_0 '!' queue '!' clocksync name=audio
videodemux.video_0 '!' queue '!' clocksync name=video'

Oct 26 11:34:51.544 DEBUG Client handshake done.
Oct 26 11:34:51.544 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="jitsi.example.com" version="1.0"/>
Oct 26 11:34:51.544 DEBUG XMPP    <<< <open from='jitsi.example.com' version='1.0' id='1263ac79-9cf5-497a-a231-cc39870e3351' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
Oct 26 11:34:51.545  INFO Connected XMPP WebSocket
Oct 26 11:34:51.545 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 26 11:34:51.545 DEBUG XMPP    >>> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="ANONYMOUS"></auth>
Oct 26 11:34:51.545 DEBUG XMPP    <<< <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
Oct 26 11:34:51.545 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="jitsi.example.com" version="1.0"/>
Oct 26 11:34:51.545 DEBUG XMPP    <<< <open from='jitsi.example.com' version='1.0' id='e3118cf9-cef8-42d1-88d3-2d225fc00a7b' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
Oct 26 11:34:51.545  INFO Logged in anonymously
Oct 26 11:34:51.545 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 ver='vxBnkHr84q8DpXesblwTtMRcbvo=' node='http://prosody.im' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><ver xmlns='urn:xmpp:features:rosterver'/></stream:features>
Oct 26 11:34:51.545 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="86ec1d28-fa35-432f-bda8-1a7f479c237c" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/></iq>
Oct 26 11:34:51.546 DEBUG XMPP    <<< <iq xmlns='jabber:client' id='86ec1d28-fa35-432f-bda8-1a7f479c237c' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc</jid></bind></iq>
Oct 26 11:34:51.546  INFO My JID: 5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc
Oct 26 11:34:51.546 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc" id="56b364df-6938-4660-87a8-1f0e298f6cb3" to="jitsi.example.com" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
Oct 26 11:34:51.547 DEBUG XMPP    <<< <iq from='jitsi.example.com' id='56b364df-6938-4660-87a8-1f0e298f6cb3' xmlns='jabber:client' type='result' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><query xmlns='http://jabber.org/protocol/disco#info'><identity name='Prosody PubSub Service' category='pubsub' type='service'/><identity name='conferenceduration.jitsi.example.com' category='component' type='conference_duration'/><identity name='avmoderation.jitsi.example.com' category='component' type='av_moderation'/><identity name='Prosody' category='server' type='im'/><identity name='lobby.jitsi.example.com' category='component' type='lobbyrooms'/><identity name='Prosody' category='pubsub' type='pep'/><identity name='speakerstats.jitsi.example.com' category='component' type='speakerstats'/><feature var='http://jabber.org/protocol/pubsub'/><feature var='http://jabber.org/protocol/pubsub#publisher-affiliation'/><feature var='http://jabber.org/protocol/pubsub#create-nodes'/><feature var='http://jabber.org/protocol/pubsub#create-and-configure'/><feature var='http://jabber.org/protocol/pubsub#delete-nodes'/><feature var='http://jabber.org/protocol/pubsub#delete-items'/><feature var='http://jabber.org/protocol/pubsub#persistent-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-default'/><feature var='http://jabber.org/protocol/pubsub#access-open'/><feature var='http://jabber.org/protocol/pubsub#subscription-options'/><feature var='http://jabber.org/protocol/pubsub#config-node'/><feature var='http://jabber.org/protocol/pubsub#subscribe'/><feature var='http://jabber.org/protocol/pubsub#publish-options'/><feature var='http://jabber.org/protocol/pubsub#retrieve-items'/><feature var='http://jabber.org/protocol/pubsub#retract-items'/><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#retrieve-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#meta-data'/><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#publish'/><feature var='http://jabber.org/protocol/pubsub#instant-nodes'/><feature var='http://jabber.org/protocol/pubsub#multi-items'/><feature var='http://jabber.org/protocol/pubsub#modify-affiliations'/><feature var='urn:xmpp:carbons:2'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='urn:xmpp:ping'/><feature var='http://jabber.org/protocol/commands'/><feature var='urn:xmpp:blocking'/><feature var='jabber:iq:roster'/><feature var='msgoffline'/><feature var='jabber:iq:private'/><feature var='jabber:iq:register'/><feature var='jabber:iq:version'/><feature var='urn:xmpp:time'/><feature var='jabber:iq:time'/><feature var='jabber:iq:last'/><feature var='urn:xmpp:extdisco:2'/><feature var='urn:xmpp:extdisco:1'/><feature var='vcard-temp'/></query></iq>
Oct 26 11:34:51.547 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc" id="dbc50793-d17b-4b48-9930-519b4eab929c" to="jitsi.example.com" type="get"><services xmlns="urn:xmpp:extdisco:2"/></iq>
Oct 26 11:34:51.547 DEBUG XMPP    <<< <iq from='jitsi.example.com' id='dbc50793-d17b-4b48-9930-519b4eab929c' xmlns='jabber:client' type='result' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><services xmlns='urn:xmpp:extdisco:2'><service port='3478' type='stun' host='jitsi.example.com'/><service password='fRrMqZvXfj7YYr0sWfSiWIIOWF4=' port='3478' transport='udp' expires='2021-10-27T09:34:51Z' username='1635327291' restricted='1' type='turn' host='jitsi.example.com'/><service password='fRrMqZvXfj7YYr0sWfSiWIIOWF4=' port='5349' transport='tcp' expires='2021-10-27T09:34:51Z' username='1635327291' restricted='1' type='turns' host='jitsi.example.com'/></services></iq>
Oct 26 11:34:51.547 DEBUG external services: [Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1635327291"), password: Some("fRrMqZvXfj7YYr0sWfSiWIIOWF4="), expires: Some("2021-10-27T09:34:51Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1635327291"), password: Some("fRrMqZvXfj7YYr0sWfSiWIIOWF4="), expires: Some("2021-10-27T09:34:51Z") }]
Oct 26 11:34:51.547 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="7daa1f27-85c9-4be8-804b-5f4bb29c058a" to="focus@auth.jitsi.example.com/focus" type="set"><conference xmlns="http://jitsi.org/protocol/focus" machine-uid="16f40fd2-9449-4578-b7de-094174b8669a" room="test@conference.jitsi.example.com"><property name="stereo" value="true"/><property name="startBitrate" value="800"/></conference></iq>
Oct 26 11:34:51.549 DEBUG XMPP    <<< <iq from='focus@auth.jitsi.example.com/focus' id='7daa1f27-85c9-4be8-804b-5f4bb29c058a' xmlns='jabber:client' type='result' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><conference ready='true' xmlns='http://jitsi.org/protocol/focus' room='test@conference.jitsi.example.com' focusjid='focus@auth.jitsi.example.com'><property value='false' name='authentication'/></conference></iq>
Oct 26 11:34:51.549 DEBUG send_presence{self=JitsiConference { jid: FullJID(5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "gst-meet", region: None, video_codec: "vp9", 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: "http://jabber.org/protocol/caps", prefix: None, prefixes: Prefixes(), attributes: {"hash": "sha-1", "node": "https://github.com/avstack/gst-meet", "ver": "swMAgANtyBNi66ghGYklxmQQoAQ="}, 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("G/kN7Lvb58mV9M0f+E0V9ctHF3+2rT5irZCuqldbjGU=")] })] }, Element { name: "stats-id", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("gst-meet")] }, Element { name: "jitsi_participant_codecType", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("vp9")] }, Element { name: "audiomuted", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("false")] }, Element { name: "videomuted", namespace: "jabber:client", 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")] }]}: close time.busy=4.34µs time.idle=1.02µs
Oct 26 11:34:51.549 DEBUG XMPP    >>> <presence xmlns="jabber:client" to="test@conference.jitsi.example.com/5anvtj_vzcp0jly8"><x xmlns="http://jabber.org/protocol/muc"/><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="https://github.com/avstack/gst-meet" ver="swMAgANtyBNi66ghGYklxmQQoAQ="/><c xmlns="urn:xmpp:caps"><hash xmlns="urn:xmpp:hashes:2" algo="sha-256">G/kN7Lvb58mV9M0f+E0V9ctHF3+2rT5irZCuqldbjGU=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp9</jitsi_participant_codecType><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns="http://jabber.org/protocol/nick">gst-meet</nick></presence>
Oct 26 11:34:51.551 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='UVY2M-801' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/><property value='0' key='bridge-count'/></conference-properties><c node='http://jitsi.org/jicofo' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Oct 26 11:34:51.551 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/eb909ac7' xmlns='jabber:client' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><stats-id>Jordan-jPL</stats-id><c node='https://jitsi.org/jitsi-meet' ver='D50Kz2zZl6ZxcI7RzgE166vg6PM=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><features><feature var='https://jitsi.org/meet/e2ee'/></features><jitsi_participant_codecType>vp8</jitsi_participant_codecType><nick xmlns='http://jabber.org/protocol/nick'>user</nick><jitsi_participant_e2ee.idKey>pzLuqPk5tBcF8bZxXI5IlWifn4+Bisp7YqHs69pKWAY</jitsi_participant_e2ee.idKey><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='mrhu-kjqymmhyp2m@jitsi.example.com/6B2aXkEQ' affiliation='owner' role='moderator'/></x></presence>
Oct 26 11:34:51.551 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/5anvtj_vzcp0jly8' xmlns='jabber:client' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><c node='https://github.com/avstack/gst-meet' ver='swMAgANtyBNi66ghGYklxmQQoAQ=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><c xmlns='urn:xmpp:caps'><hash algo='sha-256' xmlns='urn:xmpp:hashes:2'>G/kN7Lvb58mV9M0f+E0V9ctHF3+2rT5irZCuqldbjGU=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp9</jitsi_participant_codecType><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns='http://jabber.org/protocol/nick'>gst-meet</nick><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><status code='100'/><item jid='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc' affiliation='none' role='participant'/><status code='110'/></x></presence>
Oct 26 11:34:51.551 DEBUG Joined MUC: test@conference.jitsi.example.com
Oct 26 11:34:51.551 DEBUG XMPP    <<< <message from='conferenceduration.jitsi.example.com' xmlns='jabber:client' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;type&quot;:&quot;conference_duration&quot;,&quot;created_timestamp&quot;:1635240445000}</json-message></message>
Oct 26 11:34:51.551 DEBUG XMPP    <<< <message from='speakerstats.jitsi.example.com' xmlns='jabber:client' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;type&quot;:&quot;speakerstats&quot;,&quot;users&quot;:{&quot;9424cb5b&quot;:{&quot;displayName&quot;:&quot;Nehad Zin Aldin&quot;,&quot;totalDominantSpeakerTime&quot;:0},&quot;dm&quot;:{&quot;displayName&quot;:&quot;gst-meet&quot;,&quot;totalDominantSpeakerTime&quot;:0},&quot;1wtlhmuipzstgxgo&quot;:{&quot;displayName&quot;:&quot;gst-meet&quot;,&quot;totalDominantSpeakerTime&quot;:0}}}</json-message></message>
Oct 26 11:34:51.551 DEBUG XMPP    <<< <message from='test@conference.jitsi.example.com' xmlns='jabber:client' type='groupchat' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><subject/></message>
Oct 26 11:34:51.593 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='UVY2M-816' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/><property value='1' key='bridge-count'/></conference-properties><c hash='sha-1' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jicofo'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Oct 26 11:34:51.593 DEBUG XMPP    <<< <iq from='test@conference.jitsi.example.com/focus' id='NWFudnRqX3Z6Y3Awamx5OEBqaXRzaS0wMS50YS5kZS9WUFNFOHlCYwBVVlkyTS04MjEA8dWe3ciFYT4irb3jIXm5CA==' xmlns='jabber:client' type='set' to='5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc'><jingle action='session-initiate' initiator='focus@auth.jitsi.example.com/focus' sid='57kqebslir5n9' xmlns='urn:xmpp:jingle:1'><content name='audio' creator='initiator' senders='both'><description media='audio' xmlns='urn:xmpp:jingle:apps:rtp:1' maxptime='60'><payload-type id='111' channels='2' name='opus' clockrate='48000'><parameter value='10' name='minptime'/><parameter value='1' name='useinbandfec'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='ISAC' id='103' clockrate='16000'/><payload-type name='ISAC' id='104' clockrate='32000'/><payload-type name='telephone-event' id='126' clockrate='8000'/><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 name='jvb-a0' ssrc='1245405725' xmlns='urn:xmpp:jingle:apps:rtp:ssma:0'><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/><parameter value='mixedmslabel mixedlabelaudio0' name='msid'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='77j80sbbdu6rhlfqq4ig2g5j0b' ufrag='am26i1fitv7l55'><web-socket url='wss://jitsi.example.com:443/colibri-ws/default-id/ffd2577b8cfd2e82/5anvtj_vzcp0jly8?pwd=77j80sbbdu6rhlfqq4ig2g5j0b' xmlns='http://jitsi.org/protocol/colibri'/><rtcp-mux/><fingerprint required='false' setup='actpass' xmlns='urn:xmpp:jingle:apps:dtls:0' hash='sha-256'>30:76:78:44:F9:3B:DE:B1:F3:51:90:F3:84:6C:8C:39:40:98:C9:78:D9:AA:AB:47:87:A7:1A:26:47:BE:7A:9E</fingerprint><candidate foundation='1' id='5246aa3f4eec9b80465cb3fc' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/><candidate foundation='2' id='3dcdcff64eec9b8079d33e31' component='1' protocol='udp' generation='0' network='0' ip='xx' port='10000' type='host' priority='2130706431'/></transport></content><content name='video' creator='initiator' senders='both'><description media='video' xmlns='urn:xmpp:jingle:apps:rtp:1'><payload-type name='VP8' id='100' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='H264' id='107' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='42e01f;level-asymmetry-allowed=1;packetization-mode=1;' name='profile-level-id'/></payload-type><payload-type name='VP9' id='101' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='rtx' id='96' clockrate='90000'><parameter value='100' name='apt'/><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='rtx' id='97' clockrate='90000'><parameter value='101' name='apt'/><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='rtx' id='99' clockrate='90000'><parameter value='107' name='apt'/></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 name='jvb-v0' ssrc='930226417' xmlns='urn:xmpp:jingle:apps:rtp:ssma:0'><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/><parameter value='mixedmslabel mixedlabelvideo0' name='msid'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='77j80sbbdu6rhlfqq4ig2g5j0b' ufrag='am26i1fitv7l55'><web-socket url='wss://jitsi.example.com:443/colibri-ws/default-id/ffd2577b8cfd2e82/5anvtj_vzcp0jly8?pwd=77j80sbbdu6rhlfqq4ig2g5j0b' xmlns='http://jitsi.org/protocol/colibri'/><rtcp-mux/><fingerprint required='false' setup='actpass' xmlns='urn:xmpp:jingle:apps:dtls:0' hash='sha-256'>30:76:78:44:F9:3B:DE:B1:F3:51:90:F3:84:6C:8C:39:40:98:C9:78:D9:AA:AB:47:87:A7:1A:26:47:BE:7A:9E</fingerprint><candidate foundation='1' id='5246aa3f4eec9b80465cb3fc' component='1' protocol='udp' generation='0' network='0' ip='2a01:4f8:10b:47a4:0:0:0:2' port='10000' type='host' priority='2130706431'/><candidate foundation='2' id='3dcdcff64eec9b8079d33e31' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/></transport></content><group xmlns='urn:xmpp:jingle:apps:grouping:0' semantics='BUNDLE'><content name='audio'/><content name='video'/></group><startmuted video='true' xmlns='http://jitsi.org/jitmeet/start-muted' audio='false'/><bridge-session id='d2b23b' xmlns='http://jitsi.org/protocol/focus'/></jingle></iq>
Oct 26 11:34:51.593 DEBUG Received Jingle session-initiate from focus@auth.jitsi.example.com/focus
Oct 26 11:34:51.593 DEBUG adding ssrc to remote_ssrc_map: Source { id: "1245405725", name: Some("jvb-a0"), parameters: [Parameter { name: "msid", value: Some("mixedmslabel mixedlabelaudio0") }], info: Some(SsrcInfo { owner: "jvb" }) }
Oct 26 11:34:51.593 DEBUG adding ssrc to remote_ssrc_map: Source { id: "930226417", name: Some("jvb-v0"), parameters: [Parameter { name: "msid", value: Some("mixedmslabel mixedlabelvideo0") }], info: Some(SsrcInfo { owner: "jvb" }) }
Oct 26 11:34:51.593  WARN Remote DTLS fingerprint (verification not implemented yet): Fingerprint { hash: Sha_256, setup: Some(Actpass), required: Some("false"), value: [48, 118, 120, 68, 249, 59, 222, 177, 243, 81, 144, 243, 132, 108, 140, 57, 64, 152, 201, 120, 217, 170, 171, 71, 135, 167, 26, 38, 71, 190, 122, 158] }
Oct 26 11:34:51.593 DEBUG Local DTLS certificate:
-----BEGIN CERTIFICATE-----
MIIBUDDB96ADAgECAgh4bSbb+5TBOTAKBggqhkjOPQQDAjAhMR8wHQYDVQQDDBZy
Y2dlbiBzZWxmIHNpZ25lZCBjZXJ0MCAXDTc1MDEwMTAwMDAwMFoYDzQwOTYwMTAx
MDAwMDAwWjAhMR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MFkwEwYH
KoZIzj0CAQYIKoZIzj0DAQcDQgAEv9p96FJfExA7JUt8kZd/jHGlH0skQt+VgrSP
GgYVqOhoSvQT/Aj3GABQaJHOCHzMAPXwo7TFFEMCDU0ym9eOqKMXMBUwEwYDVR0R
BAwwCoIIZ3N0LW1lZXQwCgYIKoZIzj0EAwIDSAAwRQIgb/3FtCnVd+6DQ/361Xjm
Z0CfTM4Wp3/GuJDSCo+Tc8ICIFC3Mlw8JznLaGkQtPbOaYuahIMagE+lUXgybD0w
D5fqlQ==
-----END CERTIFICATE-----

Oct 26 11:34:51.593 DEBUG Local DTLS fingerprint: 77:10:8F:5E:4E:A0:4B:5A:F0:2B:7D:99:A7:F2:68:6C:71:3:1F:A1:18:56:98:68:C0:A5:53:51:74:CC:32:48
Oct 26 11:34:51.593 DEBUG audio SSRC: 3522009742
Oct 26 11:34:51.593 DEBUG video SSRC: 2814519638
Oct 26 11:34:51.593 DEBUG video RTX SSRC: 3453487696
Oct 26 11:34:51.594 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="5anvtj_vzcp0jly8@jitsi.example.com/VPSE8yBc" id="NWFudnRqX3Z6Y3Awamx5OEBqaXRzaS0wMS50YS5kZS9WUFNFOHlCYwBVVlkyTS04MjEA8dWe3ciFYT4irb3jIXm5CA==" to="test@conference.jitsi.example.com/focus" type="result"/>
Oct 26 11:34:51.594 DEBUG STUN address: Some(xxx:3478)
Oct 26 11:34:51.594 DEBUG TURN address: xxx:5349
Oct 26 11:34:51.594 DEBUG ice_agent=Agent(ObjectRef { inner: 0x7fc9d403f000, type: NiceAgent })
Oct 26 11:34:51.594 DEBUG ice_stream_id=1
Oct 26 11:34:51.594 DEBUG ice_component_id=1
Oct 26 11:34:51.594 DEBUG setting ICE remote credentials
Oct 26 11:34:51.594 DEBUG gathering ICE candidates
Oct 26 11:34:51.595 DEBUG setting ICE remote candidates: [Candidate { component: 1, foundation: "1", generation: 0, id: "5246aa3f4eec9b80465cb3fc", ip: xxx::2, 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: "3dcdcff64eec9b8079d33e31", ip: xxx, port: 10000, priority: 2130706431, protocol: "udp", rel_addr: None, rel_port: None, network: Some(0), type_: Host }]
Oct 26 11:34:51.595 DEBUG candidate: Candidate { type_: Host, foundation: Ok("1"), addr: [xxx:2]:10000, priority: 2130706431, stream_id: 1, component_id: 1, username: Ok("am26i1fitv7l55"), password: Ok("77j80sbbdu6rhlfqq4ig2g5j0b") }
Oct 26 11:34:51.595 DEBUG candidate: Candidate { type_: Host, foundation: Ok("2"), addr: xxx:10000, priority: 2130706431, stream_id: 1, component_id: 1, username: Ok("am26i1fitv7l55"), password: Ok("77j80sbbdu6rhlfqq4ig2g5j0b") }
Oct 26 11:34:51.595 DEBUG building gstreamer pipeline
Oct 26 11:34:51.596 ERROR error=Failed to create element from factory name
Oct 26 11:34:51.596 ERROR fatal (in read loop): Failed to create element from factory name```

@jbg
Copy link
Contributor

jbg commented Oct 26, 2021

Oct 26 11:34:51.596 ERROR error=Failed to create element from factory name

This error is from GStreamer, you can follow the instructions in the README for debugging your GStreamer pipeline (set GST_DEBUG to 3 or higher and read the extra logging produced by GStreamer). Most likely one of the elements you are trying to use comes from a gst plugin package that you don't have installed.

@jbg
Copy link
Contributor

jbg commented Oct 26, 2021

Or one of the elements that gst-meet is trying to use comes from a package that you don't have installed -- make sure you have at least gst-plugins-bad (version matching your gstreamer version, which must be 1.19+), and also libnice.

I'll see if we can add which element it's failing to create to the log message!

@mkn-ta
Copy link
Author

mkn-ta commented Nov 1, 2021

Thanks for you´re response, we´ve installed further plugins from package bad, now we´re getting this output when we try to play some .mp3 file with the command:

'cargo run --release -- --room-name test --verbose --nick "bot-user" --web-socket-url=wss://jitsi.example.com/xmpp-websocket --xmpp-domain=jitsi.example.com --send-pipeline="filesrc location=/root/test.mp3 ! queue ! mpegaudioparse ! mpg123audiodec ! audioconvert ! audioresample ! opusenc name=audio"

Nov 01 11:50:32.990 DEBUG Client handshake done.
Nov 01 11:50:32.990 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="jitsi.example.com" version="1.0"/>
Nov 01 11:50:32.991 DEBUG XMPP    <<< <open from='jitsi.example.com' version='1.0' id='891db802-f01f-4ef1-8d89-31b951b49be8' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
Nov 01 11:50:32.991  INFO Connected XMPP WebSocket
Nov 01 11:50:32.991 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>
Nov 01 11:50:32.991 DEBUG XMPP    >>> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="ANONYMOUS"></auth>
Nov 01 11:50:32.991 DEBUG XMPP    <<< <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/>
Nov 01 11:50:32.991 DEBUG XMPP    >>> <open xmlns="urn:ietf:params:xml:ns:xmpp-framing" to="jitsi.example.com" version="1.0"/>
Nov 01 11:50:32.992 DEBUG XMPP    <<< <open from='jitsi.example.com' version='1.0' id='c6c1e655-0688-402e-9006-853e607f4df4' xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-framing'/>
Nov 01 11:50:32.992  INFO Logged in anonymously
Nov 01 11:50:32.992 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 ver='vxBnkHr84q8DpXesblwTtMRcbvo=' node='http://prosody.im' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><ver xmlns='urn:xmpp:features:rosterver'/></stream:features>
Nov 01 11:50:32.992 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="45fa9eb9-13ea-4822-aecb-5e188851b74e" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/></iq>
Nov 01 11:50:32.992 DEBUG XMPP    <<< <iq xmlns='jabber:client' id='45fa9eb9-13ea-4822-aecb-5e188851b74e' type='result'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><jid>nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6</jid></bind></iq>
Nov 01 11:50:32.992  INFO My JID: nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6
Nov 01 11:50:32.992 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6" id="025c3681-7752-46e6-b568-13bd1c567ffc" to="jitsi.example.com" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>
Nov 01 11:50:32.993 DEBUG XMPP    <<< <iq from='jitsi.example.com' id='025c3681-7752-46e6-b568-13bd1c567ffc' xmlns='jabber:client' type='result' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><query xmlns='http://jabber.org/protocol/disco#info'><identity name='Prosody PubSub Service' category='pubsub' type='service'/><identity name='conferenceduration.jitsi.example.com' category='component' type='conference_duration'/><identity name='avmoderation.jitsi.example.com' category='component' type='av_moderation'/><identity name='Prosody' category='server' type='im'/><identity name='lobby.jitsi.example.com' category='component' type='lobbyrooms'/><identity name='Prosody' category='pubsub' type='pep'/><identity name='speakerstats.jitsi.example.com' category='component' type='speakerstats'/><feature var='http://jabber.org/protocol/pubsub'/><feature var='http://jabber.org/protocol/pubsub#publisher-affiliation'/><feature var='http://jabber.org/protocol/pubsub#create-nodes'/><feature var='http://jabber.org/protocol/pubsub#create-and-configure'/><feature var='http://jabber.org/protocol/pubsub#delete-nodes'/><feature var='http://jabber.org/protocol/pubsub#delete-items'/><feature var='http://jabber.org/protocol/pubsub#persistent-items'/><feature var='http://jabber.org/protocol/pubsub#retrieve-default'/><feature var='http://jabber.org/protocol/pubsub#access-open'/><feature var='http://jabber.org/protocol/pubsub#subscription-options'/><feature var='http://jabber.org/protocol/pubsub#config-node'/><feature var='http://jabber.org/protocol/pubsub#subscribe'/><feature var='http://jabber.org/protocol/pubsub#publish-options'/><feature var='http://jabber.org/protocol/pubsub#retrieve-items'/><feature var='http://jabber.org/protocol/pubsub#retract-items'/><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#retrieve-subscriptions'/><feature var='http://jabber.org/protocol/pubsub#meta-data'/><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#publish'/><feature var='http://jabber.org/protocol/pubsub#instant-nodes'/><feature var='http://jabber.org/protocol/pubsub#multi-items'/><feature var='http://jabber.org/protocol/pubsub#modify-affiliations'/><feature var='urn:xmpp:carbons:2'/><feature var='http://jabber.org/protocol/disco#info'/><feature var='http://jabber.org/protocol/disco#items'/><feature var='urn:xmpp:ping'/><feature var='http://jabber.org/protocol/commands'/><feature var='urn:xmpp:blocking'/><feature var='jabber:iq:roster'/><feature var='msgoffline'/><feature var='jabber:iq:private'/><feature var='jabber:iq:register'/><feature var='jabber:iq:version'/><feature var='urn:xmpp:time'/><feature var='jabber:iq:time'/><feature var='jabber:iq:last'/><feature var='urn:xmpp:extdisco:2'/><feature var='urn:xmpp:extdisco:1'/><feature var='vcard-temp'/></query></iq>
Nov 01 11:50:32.993 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6" id="5091e2ce-cb33-4eca-91fe-df51c8efff44" to="jitsi.example.com" type="get"><services xmlns="urn:xmpp:extdisco:2"/></iq>
Nov 01 11:50:32.993 DEBUG XMPP    <<< <iq from='jitsi.example.com' id='5091e2ce-cb33-4eca-91fe-df51c8efff44' xmlns='jabber:client' type='result' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><services xmlns='urn:xmpp:extdisco:2'><service port='3478' type='stun' host='jitsi.example.com'/><service password='RVp/ltpp/cU/rum2QQ/wj/A9d3Q=' port='3478' transport='udp' expires='2021-11-02T10:50:32Z' username='1635850232' restricted='1' type='turn' host='jitsi.example.com'/><service password='RVp/ltpp/cU/rum2QQ/wj/A9d3Q=' port='5349' transport='tcp' expires='2021-11-02T10:50:32Z' username='1635850232' restricted='1' type='turns' host='jitsi.example.com'/></services></iq>
Nov 01 11:50:32.993 DEBUG external services: [Service { type: "stun", name: None, host: "jitsi.example.com", port: Some(3478), transport: None, restricted: None, username: None, password: None, expires: None }, Service { type: "turn", name: None, host: "jitsi.example.com", port: Some(3478), transport: Some("udp"), restricted: Some(true), username: Some("1635850232"), password: Some("RVp/ltpp/cU/rum2QQ/wj/A9d3Q="), expires: Some("2021-11-02T10:50:32Z") }, Service { type: "turns", name: None, host: "jitsi.example.com", port: Some(5349), transport: Some("tcp"), restricted: Some(true), username: Some("1635850232"), password: Some("RVp/ltpp/cU/rum2QQ/wj/A9d3Q="), expires: Some("2021-11-02T10:50:32Z") }]
Nov 01 11:50:32.993 DEBUG XMPP    >>> <iq xmlns="jabber:client" id="e093cb06-4cd6-4fd0-8421-ec51e01b5c62" to="focus@auth.jitsi.example.com/focus" type="set"><conference xmlns="http://jitsi.org/protocol/focus" machine-uid="b38c918b-0a9a-4bdf-bf90-f629ad27e407" room="test@conference.jitsi.example.com"><property name="startBitrate" value="800"/><property name="stereo" value="true"/></conference></iq>
Nov 01 11:50:32.995 DEBUG XMPP    <<< <iq from='focus@auth.jitsi.example.com/focus' id='e093cb06-4cd6-4fd0-8421-ec51e01b5c62' xmlns='jabber:client' type='result' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><conference ready='true' xmlns='http://jitsi.org/protocol/focus' room='test@conference.jitsi.example.com' focusjid='focus@auth.jitsi.example.com'><property value='false' name='authentication'/></conference></iq>
Nov 01 11:50:32.995 DEBUG send_presence{self=JitsiConference { jid: FullJID(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, 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: "http://jabber.org/protocol/caps", prefix: None, prefixes: Prefixes(), attributes: {"hash": "sha-1", "node": "https://github.com/avstack/gst-meet", "ver": "swMAgANtyBNi66ghGYklxmQQoAQ="}, 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("G/kN7Lvb58mV9M0f+E0V9ctHF3+2rT5irZCuqldbjGU=")] })] }, Element { name: "stats-id", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("gst-meet")] }, Element { name: "jitsi_participant_codecType", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("vp8")] }, Element { name: "audiomuted", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("false")] }, Element { name: "videomuted", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("false")] }, Element { name: "nick", namespace: "http://jabber.org/protocol/nick", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("bot-user")] }]}: close time.busy=4.16µs time.idle=987ns
Nov 01 11:50:32.995 DEBUG XMPP    >>> <presence xmlns="jabber:client" to="test@conference.jitsi.example.com/nre60ym5kkiokotr"><x xmlns="http://jabber.org/protocol/muc"/><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="https://github.com/avstack/gst-meet" ver="swMAgANtyBNi66ghGYklxmQQoAQ="/><c xmlns="urn:xmpp:caps"><hash xmlns="urn:xmpp:hashes:2" algo="sha-256">G/kN7Lvb58mV9M0f+E0V9ctHF3+2rT5irZCuqldbjGU=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp8</jitsi_participant_codecType><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns="http://jabber.org/protocol/nick">bot-user</nick></presence>
Nov 01 11:50:32.997 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='8EQBD-678' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/><property value='0' key='bridge-count'/></conference-properties><c node='http://jitsi.org/jicofo' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Nov 01 11:50:32.997 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/4d56b101' xmlns='jabber:client' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><stats-id>Jordan-jPL</stats-id><c node='https://jitsi.org/jitsi-meet' ver='D50Kz2zZl6ZxcI7RzgE166vg6PM=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><features><feature var='https://jitsi.org/meet/e2ee'/></features><jitsi_participant_codecType>vp8</jitsi_participant_codecType><nick xmlns='http://jabber.org/protocol/nick'>user</nick><jitsi_participant_e2ee.idKey>w0wKTTl6ZIROylGxgZnQfX15UtVfIj/PPrju3eY0fS4</jitsi_participant_e2ee.idKey><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='1vmmmow2i0xxlsd6@jitsi.example.com/Es4hdO97' affiliation='owner' role='moderator'/></x></presence>
Nov 01 11:50:32.997 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/nre60ym5kkiokotr' xmlns='jabber:client' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><c node='https://github.com/avstack/gst-meet' ver='swMAgANtyBNi66ghGYklxmQQoAQ=' xmlns='http://jabber.org/protocol/caps' hash='sha-1'/><c xmlns='urn:xmpp:caps'><hash algo='sha-256' xmlns='urn:xmpp:hashes:2'>G/kN7Lvb58mV9M0f+E0V9ctHF3+2rT5irZCuqldbjGU=</hash></c><stats-id>gst-meet</stats-id><jitsi_participant_codecType>vp8</jitsi_participant_codecType><audiomuted>false</audiomuted><videomuted>false</videomuted><nick xmlns='http://jabber.org/protocol/nick'>bot-user</nick><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><status code='100'/><item jid='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6' affiliation='none' role='participant'/><status code='110'/></x></presence>
Nov 01 11:50:32.997 DEBUG Joined MUC: test@conference.jitsi.example.com
Nov 01 11:50:32.997 DEBUG XMPP    <<< <message from='conferenceduration.jitsi.example.com' xmlns='jabber:client' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;type&quot;:&quot;conference_duration&quot;,&quot;created_timestamp&quot;:1635763547000}</json-message></message>
Nov 01 11:50:32.997 DEBUG XMPP    <<< <message from='speakerstats.jitsi.example.com' xmlns='jabber:client' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><json-message xmlns='http://jitsi.org/jitmeet'>{&quot;type&quot;:&quot;speakerstats&quot;,&quot;users&quot;:{&quot;vdxktckgjcetvth_&quot;:{&quot;totalDominantSpeakerTime&quot;:0},&quot;9af07781&quot;:{&quot;displayName&quot;:&quot;user&quot;,&quot;totalDominantSpeakerTime&quot;:0},&quot;0mthbunmjg547pl3&quot;:{&quot;totalDominantSpeakerTime&quot;:0}}}</json-message></message>
Nov 01 11:50:32.997 DEBUG XMPP    <<< <message from='test@conference.jitsi.example.com' xmlns='jabber:client' type='groupchat' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><subject/></message>
Nov 01 11:50:33.040 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/focus' xmlns='jabber:client' id='8EQBD-713' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><priority>0</priority><etherpad xmlns='http://jitsi.org/jitmeet/etherpad'>test</etherpad><versions xmlns='http://jitsi.org/jitmeet'><component name='focus'>1.0.813</component></versions><conference-properties xmlns='http://jitsi.org/protocol/focus'><property value='true' key='support-terminate-restart'/><property value='1' key='bridge-count'/></conference-properties><c hash='sha-1' ver='Lg0vhCNhxjoeKJi2/hukdsizNWA=' xmlns='http://jabber.org/protocol/caps' node='http://jitsi.org/jicofo'/><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='focus@auth.jitsi.example.com/focus' affiliation='owner' role='moderator'/></x></presence>
Nov 01 11:50:33.054 DEBUG XMPP    <<< <iq from='test@conference.jitsi.example.com/focus' id='bnJlNjB5bTVra2lva290ckBqaXRzaS0wMS50YS5kZS9SZDdad2tRNgA4RVFCRC03MjEA8dWe3ciFYT4irb3jIXm5CA==' xmlns='jabber:client' type='set' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><jingle action='session-initiate' initiator='focus@auth.jitsi.example.com/focus' sid='7cbj7p7dg114t' xmlns='urn:xmpp:jingle:1'><content name='audio' creator='initiator' senders='both'><description media='audio' xmlns='urn:xmpp:jingle:apps:rtp:1' maxptime='60'><payload-type id='111' channels='2' name='opus' clockrate='48000'><parameter value='10' name='minptime'/><parameter value='1' name='stereo'/><parameter value='1' name='useinbandfec'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='ISAC' id='103' clockrate='16000'/><payload-type name='ISAC' id='104' clockrate='32000'/><payload-type name='telephone-event' id='126' clockrate='8000'/><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 name='jvb-a0' ssrc='190519583' xmlns='urn:xmpp:jingle:apps:rtp:ssma:0'><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/><parameter value='mixedmslabel mixedlabelaudio0' name='msid'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='5kgqi2tg75qcbrpdt1qcu3mq7v' ufrag='4v0g71fjdhui5d'><web-socket url='wss://jitsi.example.com:443/colibri-ws/default-id/3d98b6b81f3edade/nre60ym5kkiokotr?pwd=5kgqi2tg75qcbrpdt1qcu3mq7v' xmlns='http://jitsi.org/protocol/colibri'/><rtcp-mux/><fingerprint required='false' setup='actpass' xmlns='urn:xmpp:jingle:apps:dtls:0' hash='sha-256'>F9:DB:16:C4:DB:19:E4:F0:20:6C:EF:AD:0A:38:DC:B9:24:07:1B:D7:15:04:3E:1D:95:3C:14:7A:66:67:B9:45</fingerprint><candidate foundation='1' id='11ef07f522aca03406e3ba77b' component='1' protocol='udp' generation='0' network='0' ip='xxx:2' port='10000' type='host' priority='2130706431'/><candidate foundation='2' id='486e533922aca0340ffffffffa1b231b0' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/></transport></content><content name='video' creator='initiator' senders='both'><description media='video' xmlns='urn:xmpp:jingle:apps:rtp:1'><payload-type name='VP8' id='100' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='H264' id='107' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='42e01f;level-asymmetry-allowed=1;packetization-mode=1;' name='profile-level-id'/></payload-type><payload-type name='VP9' id='101' clockrate='90000'><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><parameter value='800' name='x-google-start-bitrate'/><rtcp-fb type='transport-cc' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='rtx' id='96' clockrate='90000'><parameter value='100' name='apt'/><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='rtx' id='97' clockrate='90000'><parameter value='101' name='apt'/><rtcp-fb subtype='fir' type='ccm' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/><rtcp-fb subtype='pli' type='nack' xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0'/></payload-type><payload-type name='rtx' id='99' clockrate='90000'><parameter value='107' name='apt'/></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 name='jvb-v0' ssrc='2899368754' xmlns='urn:xmpp:jingle:apps:rtp:ssma:0'><ssrc-info owner='jvb' xmlns='http://jitsi.org/jitmeet'/><parameter value='mixedmslabel mixedlabelvideo0' name='msid'/></source></description><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='5kgqi2tg75qcbrpdt1qcu3mq7v' ufrag='4v0g71fjdhui5d'><web-socket url='wss://jitsi.example.com:443/colibri-ws/default-id/3d98b6b81f3edade/nre60ym5kkiokotr?pwd=5kgqi2tg75qcbrpdt1qcu3mq7v' xmlns='http://jitsi.org/protocol/colibri'/><rtcp-mux/><fingerprint required='false' setup='actpass' xmlns='urn:xmpp:jingle:apps:dtls:0' hash='sha-256'>F9:DB:16:C4:DB:19:E4:F0:20:6C:EF:AD:0A:38:DC:B9:24:07:1B:D7:15:04:3E:1D:95:3C:14:7A:66:67:B9:45</fingerprint><candidate foundation='1' id='11ef07f522aca03406e3ba77b' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/><candidate foundation='2' id='486e533922aca0340ffffffffa1b231b0' component='1' protocol='udp' generation='0' network='0' ip='xxx' port='10000' type='host' priority='2130706431'/></transport></content><group xmlns='urn:xmpp:jingle:apps:grouping:0' semantics='BUNDLE'><content name='audio'/><content name='video'/></group><bridge-session id='12ae7' xmlns='http://jitsi.org/protocol/focus'/></jingle></iq>
Nov 01 11:50:33.055 DEBUG Received Jingle session-initiate from focus@auth.jitsi.example.com/focus
Nov 01 11:50:33.055 DEBUG adding ssrc to remote_ssrc_map: Source { id: "190519583", name: Some("jvb-a0"), parameters: [Parameter { name: "msid", value: Some("mixedmslabel mixedlabelaudio0") }], info: Some(SsrcInfo { owner: "jvb" }) }
Nov 01 11:50:33.055 DEBUG adding ssrc to remote_ssrc_map: Source { id: "2899368754", name: Some("jvb-v0"), parameters: [Parameter { name: "msid", value: Some("mixedmslabel mixedlabelvideo0") }], info: Some(SsrcInfo { owner: "jvb" }) }
Nov 01 11:50:33.055  WARN Remote DTLS fingerprint (verification not implemented yet): Fingerprint { hash: Sha_256, setup: Some(Actpass), required: Some("false"), value: [249, 219, 22, 196, 219, 25, 228, 240, 32, 108, 239, 173, 10, 56, 220, 185, 36, 7, 27, 215, 21, 4, 62, 29, 149, 60, 20, 122, 102, 103, 185, 69] }
Nov 01 11:50:33.055 DEBUG Local DTLS certificate:
-----BEGIN CERTIFICATE-----
MIIBUDCB96ADAgECAgh12bqLlt6qszAKBggqhkjOPQQDAjAhMR8wHQYDVQQDDBZy
Y2dlbiBzZWxmIHNpZ25lZCBjZXJ0MCAXDTc1MDEwMTAwMDAwMFoYDzQwOTYwMTAx
MDAwMDAwWjAhMR8wHQYDVQQDDBZyY2dlbiBzZWxmIHNpZ25lZCBjZXJ0MFkwEwYH
KoZIzj0CAQYIKoZIzj0DAQcDQgAET0NCKGCfDuMTIjJpRhq2yJV+5/qWTI4ffKlS
qrz5ttDV9hgrT0EbhD0iofD5EWU9BxYVwjhEI866t6DDVZ0VeqMXMBUwEwYDVR0R
BAwwCoIIZ3N0LW1lZXQwCgYIKoZIzj0EAwIDSAAwgQIhAMHKRDq1D9/efnfF5w65
kwmm6IJHaR3QTiAAxP4iwRtOAiB8vEBUMJd7wDfF2GF29J5mosdWXJtRC0DM/Hq2
zthAjg==
-----END CERTIFICATE-----

Nov 01 11:50:33.055 DEBUG Local DTLS fingerprint: 69:8A:70:7A:AF:31:37:23:FB:C:8:1B:4C:18:3:A4:7D:B6:98:8D:D8:0:75:A6:95:DC:53:C2:AC:56:57:CE
Nov 01 11:50:33.055 DEBUG audio SSRC: 1046210183
Nov 01 11:50:33.055 DEBUG video SSRC: 190517691
Nov 01 11:50:33.055 DEBUG video RTX SSRC: 2524423608
Nov 01 11:50:33.056 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6" id="bnJlNjB5bTVra2lva290ckBqaXRzaS0wMS50YS5kZS9SZDdad2tRNgA4RVFCRC03MjEA8dWe3ciFYT4irb3jIXm5CA==" to="test@conference.jitsi.example.com/focus" type="result"/>
Nov 01 11:50:33.056 DEBUG STUN address: Some(94.130.212.211:3478)
Nov 01 11:50:33.056 DEBUG TURN address: 94.130.212.211:5349
Nov 01 11:50:33.056 DEBUG ice_agent=Agent(ObjectRef { inner: 0x7f8b2803e000, type: NiceAgent })
Nov 01 11:50:33.056 DEBUG ice_stream_id=1
Nov 01 11:50:33.056 DEBUG ice_component_id=1
Nov 01 11:50:33.056 DEBUG setting ICE remote credentials
Nov 01 11:50:33.056 DEBUG gathering ICE candidates
Nov 01 11:50:33.057 DEBUG setting ICE remote candidates: [Candidate { component: 1, foundation: "1", generation: 0, id: "11ef07f522aca03406e3ba77b", ip: xxx, 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: "486e533922aca0340ffffffffa1b231b0", ip: xxx, port: 10000, priority: 2130706431, protocol: "udp", rel_addr: None, rel_port: None, network: Some(0), type_: Host }]
Nov 01 11:50:33.057 DEBUG candidate: Candidate { type_: Host, foundation: Ok("1"), addr: [2a01:4f8:10b:47a4::2]:10000, priority: 2130706431, stream_id: 1, component_id: 1, username: Ok("4v0g71fjdhui5d"), password: Ok("5kgqi2tg75qcbrpdt1qcu3mq7v") }
Nov 01 11:50:33.057 DEBUG candidate: Candidate { type_: Host, foundation: Ok("2"), addr: 94.130.212.211:10000, priority: 2130706431, stream_id: 1, component_id: 1, username: Ok("4v0g71fjdhui5d"), password: Ok("5kgqi2tg75qcbrpdt1qcu3mq7v") }
Nov 01 11:50:33.057 DEBUG building gstreamer pipeline
Nov 01 11:50:33.090 DEBUG linking video payloader -> rtpfunnel
Nov 01 11:50:33.090 DEBUG linking audio payloader -> rtpfunnel
Nov 01 11:50:33.090 DEBUG linking rtpfunnel -> rtpbin
Nov 01 11:50:33.091 DEBUG creating RTX sender for session 0
Nov 01 11:50:33.091 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) send_rtp_src_0]
Nov 01 11:50:33.091 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) send_rtp_sink_0]
Nov 01 11:50:33.091 DEBUG link dtlssrtpdec -> rtpbin
Nov 01 11:50:33.091 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) recv_rtp_sink_0]
Nov 01 11:50:33.091 DEBUG creating RTX receiver for session 0
Nov 01 11:50:33.091 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) recv_rtcp_sink_0]
Nov 01 11:50:33.091 DEBUG linking rtpbin -> dtlssrtpenc
Nov 01 11:50:33.091 DEBUG rtpbin pad-added [(GstRtpBin) (GstRtpBin) rtpbin, (GstPad) (GstGhostPad) send_rtcp_src_0]
Nov 01 11:50:33.091 DEBUG linking ice src -> dtlssrtpdec
Nov 01 11:50:33.091 DEBUG linking dtlssrtpenc -> ice sink
Nov 01 11:50:33.091 DEBUG local candidates: [Candidate { type_: Host, foundation: Ok("1"), addr: [fe80::b62e:99ff:fe45:389b%2]:34921, priority: 2013266431, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("2"), addr: [xxx]:54909, priority: 2013266430, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }, Candidate { type_: Host, foundation: Ok("3"), addr: 94.130.212.211:40265, priority: 2013266429, stream_id: 1, component_id: 1, username: Ok(""), password: Ok("") }]
Nov 01 11:50:33.091 DEBUG building Jingle session-accept
Nov 01 11:50:33.091 DEBUG XMPP    >>> <iq xmlns="jabber:client" from="nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6" id="749b3e66-320f-4ab1-b758-8a961300753e" to="test@conference.jitsi.example.com/focus" type="set"><jingle xmlns="urn:xmpp:jingle:1" action="session-accept" initiator="focus@auth.jitsi.example.com/focus" responder="nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6" sid="7cbj7p7dg114t"><content creator="responder" name="audio" senders="both"><description xmlns="urn:xmpp:jingle:apps:rtp:1" media="audio" ssrc="1046210183"><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="1046210183"><parameter name="cname" value="54eefbab-ac0f-4789-9a6f-5c951ec70c39"/><parameter name="msid" value="8126139a-fb0c-456d-918b-832a61b8de02 5d1387bd-3658-4dc9-bfd9-defd7f076d42"/></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="mVNr5P6hU5mWi8rVaQH4+3" ufrag="Xe+5"><candidate component="1" foundation="1" generation="0" id="1ec7263f-a4d9-4ec4-90ba-e373646498e8" ip="xxx" port="34921" priority="2013266431" protocol="udp" type="host"/><candidate component="1" foundation="2" generation="0" id="e6f3484f-ecc7-4ae4-88c4-f77f9eb6b429" ip="xxx" port="54909" priority="2013266430" protocol="udp" type="host"/><candidate component="1" foundation="3" generation="0" id="773d4657-7907-4708-84dc-783c581fb82f" ip="xxx" port="40265" priority="2013266429" protocol="udp" type="host"/><fingerprint xmlns="urn:xmpp:jingle:apps:dtls:0" hash="sha-256" required="true" setup="active">69:8A:70:7A:AF:31:37:23:FB:0C:08:1B:4C:18:03:A4:7D:B6:98:8D:D8:00:75:A6:95:DC:53:C2:AC:56:57:CE</fingerprint></transport></content><content creator="responder" name="video" senders="both"><description xmlns="urn:xmpp:jingle:apps:rtp:1" media="video" ssrc="190517691"><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="190517691"/><source ssrc="2524423608"/></ssrc-group><source xmlns="urn:xmpp:jingle:apps:rtp:ssma:0" ssrc="190517691"><parameter name="cname" value="8c3a3b5c-6f6a-49c5-8637-5d07d7286206"/><parameter name="msid" value="fff18f40-60b3-4bb3-b873-d35f3894d6c9 b95943bf-3665-4af0-a324-a7a5c643f93f"/></source><source xmlns="urn:xmpp:jingle:apps:rtp:ssma:0" ssrc="2524423608"><parameter name="cname" value="8c3a3b5c-6f6a-49c5-8637-5d07d7286206"/><parameter name="msid" value="fff18f40-60b3-4bb3-b873-d35f3894d6c9 b95943bf-3665-4af0-a324-a7a5c643f93f"/></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="mVNr5P6hU5mWi8rVaQH4+3" ufrag="Xe+5"><candidate component="1" foundation="1" generation="0" id="f6a049af-2dfe-4b64-bbc0-628f00332fed" ip="xxx" port="34921" priority="2013266431" protocol="udp" type="host"/><candidate component="1" foundation="2" generation="0" id="11cc5179-4598-4752-bdde-371f29d44fe6" ip="xxx" port="54909" priority="2013266430" protocol="udp" type="host"/><candidate component="1" foundation="3" generation="0" id="63d55003-187a-4e58-8462-c201d044c027" ip="xxx" port="40265" priority="2013266429" protocol="udp" type="host"/><fingerprint xmlns="urn:xmpp:jingle:apps:dtls:0" hash="sha-256" required="true" setup="active">69:8A:70:7A:AF:31:37:23:FB:0C:08:1B:4C:18:03:A4:7D:B6:98:8D:D8:00:75:A6:95:DC:53:C2:AC:56:57:CE</fingerprint></transport></content></jingle></iq>
Nov 01 11:50:33.107 DEBUG XMPP    <<< <iq from='test@conference.jitsi.example.com/focus' id='749b3e66-320f-4ab1-b758-8a961300753e' xmlns='jabber:client' type='result' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'/>
Nov 01 11:50:33.107 DEBUG Focus acknowledged session-accept
Nov 01 11:50:33.107  INFO Connecting Colibri WebSocket to wss://jitsi.example.com:443/colibri-ws/default-id/3d98b6b81f3edade/nre60ym5kkiokotr?pwd=5kgqi2tg75qcbrpdt1qcu3mq7v
Nov 01 11:50:33.114 DEBUG Client handshake done.
Nov 01 11:50:33.114  INFO Connected Colibri WebSocket
Nov 01 11:50:33.114 DEBUG Colibri <<< {"colibriClass":"ServerHello"}
Nov 01 11:50:33.114 DEBUG Colibri <<< {"colibriClass":"SenderVideoConstraints", "videoConstraints":{"idealHeight":180}}
Nov 01 11:50:33.114 DEBUG join{xmpp_connection=Connection { tx: Sender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x5617f2e1d010, 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(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6)) } } } glib_main_context=MainContext(Shared { inner: 0x5617f2e1cac0 }) config=JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, video_codec: "vp8", extra_muc_features: [] }}: close time.busy=22.0µs time.idle=121ms
Nov 01 11:50:33.114 DEBUG add_bin{self=JitsiConference { jid: FullJID(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } bin=Bin(ObjectRef { inner: 0x5617f2c39030, type: GstBin })}: close time.busy=50.3µs time.idle=729ns
Nov 01 11:50:33.114  INFO Found audio element in pipeline, linking...
Nov 01 11:50:33.114 DEBUG set_muted{self=JitsiConference { jid: FullJID(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } media_type=Video muted=true}:send_presence{self=JitsiConference { jid: FullJID(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } payloads=[Element { name: "videomuted", namespace: "jabber:client", prefix: None, prefixes: Prefixes(), attributes: {}, children: [Text("true")] }]}: close time.busy=6.92µs time.idle=502ns
Nov 01 11:50:33.114 DEBUG set_muted{self=JitsiConference { jid: FullJID(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } media_type=Video muted=true}: close time.busy=24.2µs time.idle=595ns
Nov 01 11:50:33.114 DEBUG XMPP    >>> <presence xmlns="jabber:client" to="test@conference.jitsi.example.com/nre60ym5kkiokotr"><videomuted>true</videomuted></presence>
Nov 01 11:50:33.114 DEBUG set_pipeline_state{self=JitsiConference { jid: FullJID(nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6), config: JitsiConferenceConfig { muc: BareJID(test@conference.jitsi.example.com), focus: Full(FullJID(focus@auth.jitsi.example.com/focus)), nick: "bot-user", region: None, video_codec: "vp8", extra_muc_features: [] }, inner: Mutex { data: JitsiConferenceInner { state: Idle } } } state=Playing}: close time.busy=111µs time.idle=475ns
Nov 01 11:50:33.115 DEBUG XMPP    <<< <presence from='test@conference.jitsi.example.com/nre60ym5kkiokotr' xmlns='jabber:client' to='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6'><videomuted>true</videomuted><x xmlns='vcard-temp:x:update'/><x xmlns='http://jabber.org/protocol/muc#user'><item jid='nre60ym5kkiokotr@jitsi.example.com/Rd7ZwkQ6' affiliation='none' role='participant'/><status code='110'/></x></presence>
Nov 01 11:50:33.119 DEBUG audio payloader requested extension: 1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
Nov 01 11:50:33.120 DEBUG audio payloader requested extension: 5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
Nov 01 11:50:33.120 ERROR ../plugins/elements/gstqueue.c(1570): gst_queue_loop (): /GstPipeline:pipeline0/GstBin:bin0/GstQueue:queue0:
streaming stopped, reason not-negotiated (-4)
Nov 01 11:50:34.174 DEBUG Colibri <<< {"colibriClass":"SenderVideoConstraints", "videoConstraints":{"idealHeight":2160}}
Nov 01 11:50:34.174  INFO Colibri message: SenderVideoConstraints { video_constraints: Constraints { ideal_height: Some(2160), max_height: None } }
Nov 01 11:50:34.914 DEBUG Colibri <<< {"colibriClass":"EndpointMessage","to":"nre60ym5kkiokotr","from":"4d56b101","msgPayload":{"type":"e2e-ping-request","id":2}}
Nov 01 11:50:34.914  INFO Colibri message: EndpointMessage { from: Some("4d56b101"), to: Some("nre60ym5kkiokotr"), msg_payload: Object({"id": Number(2), "type": String("e2e-ping-request")}) }
Nov 01 11:50:43.124 DEBUG Colibri <<< {"colibriClass":"EndpointMessage","to":"nre60ym5kkiokotr","from":"4d56b101","msgPayload":{"type":"e2e-ping-request","id":3}}
Nov 01 11:50:43.124  INFO Colibri message: EndpointMessage { from: Some("4d56b101"), to: Some("nre60ym5kkiokotr"), msg_payload: Object({"id": Number(3), "type": String("e2e-ping-request")}) }
Nov 01 11:50:43.972 DEBUG Colibri <<< {"colibriClass":"EndpointStats","from":"4d56b101","bitrate":{"upload":0,"download":0,"audio":{"upload":0,"download":0},"video":{"upload":0,"download":0}},"packetLoss":{"total":0,"download":0,"upload":0},"connectionQuality":100,"jvbRTT":61}
Nov 01 11:50:43.972  INFO Colibri message: EndpointStats { from: Some("4d56b101"), bitrate: Bitrates { audio: Bitrate { upload: 0, download: 0 }, video: Bitrate { upload: 0, download: 0 }, total: Bitrate { upload: 0, download: 0 } }, packet_loss: PacketLoss { total: 0, download: 0, upload: 0 }, connection_quality: 100.0, jvb_rtt: Some(61), server_region: None, max_enabled_resolution: None }
Nov 01 11:50:48.874 DEBUG ICE candidate-gathering-done 1
Nov 01 11:50:53.081 DEBUG Colibri <<< {"colibriClass":"EndpointMessage","to":"nre60ym5kkiokotr","from":"4d56b101","msgPayload":{"type":"e2e-ping-request","id":4}}
Nov 01 11:50:53.081  INFO Colibri message: EndpointMessage { from: Some("4d56b101"), to: Some("nre60ym5kkiokotr"), msg_payload: Object({"id": Number(4), "type": String("e2e-ping-request")}) }
Nov 01 11:50:53.971 DEBUG Colibri <<< {"colibriClass":"EndpointStats","from":"4d56b101","bitrate":{"upload":0,"download":0,"audio":{"upload":0,"download":0},"video":{"upload":0,"download":0}},"packetLoss":{"total":0,"download":0,"upload":0},"connectionQuality":100,"jvbRTT":16}
Nov 01 11:50:53.971  INFO Colibri message: EndpointStats { from: Some("4d56b101"), bitrate: Bitrates { audio: Bitrate { upload: 0, download: 0 }, video: Bitrate { upload: 0, download: 0 }, total: Bitrate { upload: 0, download: 0 } }, packet_loss: PacketLoss { total: 0, download: 0, upload: 0 }, connection_quality: 100.0, jvb_rtt: Some(16), server_region: None, max_enabled_resolution: None }
Nov 01 11:51:03.145 DEBUG Colibri <<< {"colibriClass":"EndpointMessage","to":"nre60ym5kkiokotr","from":"4d56b101","msgPayload":{"type":"e2e-ping-request","id":5}}
Nov 01 11:51:03.145  INFO Colibri message: EndpointMessage { from: Some("4d56b101"), to: Some("nre60ym5kkiokotr"), msg_payload: Object({"id": Number(5), "type": String("e2e-ping-request")}) }
Nov 01 11:51:04.091 DEBUG Colibri <<< {"colibriClass":"EndpointStats","from":"4d56b101","bitrate":{"upload":0,"download":0,"audio":{"upload":0,"download":0},"video":{"upload":0,"download":0}},"packetLoss":{"total":0,"download":0,"upload":0},"connectionQuality":100,"jvbRTT":86}
Nov 01 11:51:04.091  INFO Colibri message: EndpointStats { from: Some("4d56b101"), bitrate: Bitrates { audio: Bitrate { upload: 0, download: 0 }, video: Bitrate { upload: 0, download: 0 }, total: Bitrate { upload: 0, download: 0 } }, packet_loss: PacketLoss { total: 0, download: 0, upload: 0 }, connection_quality: 100.0, jvb_rtt: Some(86), server_region: None, max_enabled_resolution: None }```

Do you have any idea which lib could be missing?

@mkn-ta
Copy link
Author

mkn-ta commented Nov 4, 2021

So now we´ve able to play some YouTube link, the YouTube video is running in Jitsi but we´re don´t get audio and it seems that this is the same problem with an mp3 file.
The problem seems to be:

Nov 04 11:49:58.189 ERROR ../libs/gst/base/gstbasesrc.c(3127): gst_base_src_loop (): /GstPipeline:pipeline0/GstBin:bin0/GstCurlHttpSrc:curlhttpsrc0:
streaming stopped, reason not-negotiated (-4)
Nov 04 11:49:58.190 ERROR ../plugins/elements/gstqueue.c(992): gst_queue_handle_sink_event (): /GstPipeline:pipeline0/GstBin:bin0/GstQueue:queue0:
streaming stopped, reason not-negotiated (-4)

But we don´t have an idea what´s missing.

@jbg
Copy link
Contributor

jbg commented Nov 5, 2021

There are instructions for debugging your GStreamer pipeline in the README, which I also mentioned in a comment above. The short verison is: set the environment variable GST_DEBUG to a number (3 or 4 is usually enough) and GStreamer will print a lot of debugging information, which will generally point to the issue.

Feel free to paste that log output here, but please put ``` above and below of the log so that it gets formatted verbatim, otherwise GitHub will interpret parts of the log as formatting characters and mangle it.

streaming stopped, reason not-negotiated suggests that two elements are linked which are not compatible with each other, probably indicating a missing element.

jbg added a commit that referenced this issue Nov 5, 2021
@jbg jbg closed this as completed in 6b33952 Nov 5, 2021
@jbg
Copy link
Contributor

jbg commented Nov 5, 2021

I tested with your pipeline and found that a capsfilter element being added by gst-meet now causes this not-negotiated error, either due to some GStreamer changes or due to some other changes in our hdrext handling.

It should be fixed in latest master.

@mkn-ta
Copy link
Author

mkn-ta commented Nov 8, 2021

That helped, now we can play YouTube videos and .mp3 files to Jitsi - thanks! :-)

@serenaraju
Copy link

Oct 19 07:52:45.457 DEBUG Received non-Jingle IQ

I think this might have been Jitsi's non-standard jingle element failing to parse correctly. Please try again with latest master, and if it still doesn't work, please send your logs formatted as code as @linkmauve suggested above.

I built the repo from the source and run the command as specified but I am still getting a non-JIngle error like this. Also, I have installed all the plugins required (base, good, bad, ugly). Still there is no change in the error. Would you know why that is?

@jbg
Copy link
Contributor

jbg commented Jan 24, 2022

This message alone is not an error; it's logged at DEBUG level and just tells us an IQ was sent that we didn't handle. In many cases this isn't a problem as the IQ was safe to ignore. If you're having a problem, I'd need more context (both details of what problem you're having, and the full log) to assist.

@serenaraju
Copy link

Oh, thank you. I have added the full log in a new issue. What might be causing the issues?

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

4 participants