jitsi / jitsi-meet

Jitsi Meet - Secure, Simple and Scalable Video Conferences that you use as a standalone app or embed in your web application.
https://jitsi.org/meet
Apache License 2.0
22.84k stars 6.68k forks source link

No video from remote users in jitsi mobile app #15048

Open klebanj opened 3 weeks ago

klebanj commented 3 weeks ago

What happened?

We use own jitsi server. After upgrade Jitsi Meet App to version 24.3.0(Android) and 24.4.0(iOS) there is black screen in remote users tiles (no video from them) and "Video for ... has been turned off to save bandwidth" appears(jvb logs doesn't confirm that). When i open url to the room in web browser on mobile device(when i don't use the app) it works properly what means that is something wrong in mobile app. Downgrade app to 24.2.2 resolves problem with no video. I attached main configuration of our jitsi server: jitsi_server_configuration.zip

and jvb logs(look at "Relevant log output", user da1fc9d0 is mobile app). Those logs look good for me.

Platform

Browser / app / sdk version

Jitsi Mobile App on Android: 24.3.0 and iOS: 24.4.0

Relevant log output

JVB 2024-08-23 18:51:06.400 INFO: [44] Videobridge.createConference#255: create_conf, id=f771f9e83d834d25 meeting_id=cba7d0d6-cae8-4041-9c28-87d3e63036d1
JVB 2024-08-23 18:51:06.402 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#234: RECV colibri2 request: <iq xmlns='jabbe
r:client' to='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' from='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtW
ABGS1FBSC0xNQDeXnR9JtqkrQ==' type='get'><conference-modify xmlns='jitsi:colibri2' meeting-id='cba7d0d6-cae8-4041-9c28-87d3e63036d1' name='test@conference.jitsii-test.recourt.comarch.pl' rtcstats-enabled='false'
 create='true'><endpoint stats-id='Henry-GDs' id='f7a876ba' create='true'><media type='audio'><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' clockrate='48000' channels='2' id='111' name='opus'><parameter name
='minptime' value='10'/><parameter name='useinbandfec' value='1'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='t
elephone-event' id='126' clockrate='8000'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level' id='1'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdr
ext:0' uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01' id='5'/><extmap-allow-mixed xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0'/></media><media type='video'><payload-type xmlns=
'urn:xmpp:jingle:apps:rtp:1' name='VP8' id='100' clockrate='90000'><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 xmlns='urn:xmpp:jingle:apps:r
tp:1' name='H264' id='107' clockrate='90000'><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:xm
pp:jingle:apps:rtp:rtcp-fb:0' subtype='pli' type='nack'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/><parameter name='profile-level-id' value='42e01f;level-asymmetry-allowed=1;packe
tization-mode=1;'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='VP9' id='101' clockrate='90000'><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' subtype='fir' type='ccm'/><rtcp-fb xm
lns='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'/></pa
yload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='rtx' id='96' clockrate='90000'><parameter name='apt' value='100'/><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'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' na
me='rtx' id='97' clockrate='90000'><parameter name='apt' value='101'/><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'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='rtx' id='99' clockrate='90000'><parameter name='apt' value
='107'/></payload-type><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' uri='http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time' id='3'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0
' uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01' id='5'/><extmap-allow-mixed xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0'/></media><transport ice-controlling='true'><sctp/></tr
ansport><sources/><capability name='source-names'/><capability name='ssrc-rewriting'/></endpoint></conference-modify></iq>
JVB 2024-08-23 18:51:06.404 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.
gatherCandidates#637: Gathering candidates for component stream-f7a876ba.RTP.
JVB 2024-08-23 18:51:06.408 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba] Endpoint.<init>#325: Created new endpoint, iceControll
ing=true
JVB 2024-08-23 18:51:06.411 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#249: SENT colibri2 response: <iq xmlns='jabb
er:client' to='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' from='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3Nt
WABGS1FBSC0xNQDeXnR9JtqkrQ==' type='result'><conference-modified xmlns='jitsi:colibri2'><endpoint id='f7a876ba'><transport><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='2ssdg10m4mdt866bholqvenkc7
' ufrag='e215s1i602c6h3'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='actpass' hash='sha-256'>76:72:0A:DD:AE:B9:DD:B3:8E:DC:BD:94:F8:29:2B:3F:EE:55:C0:FD:71:B6:94:F7:14:C6:7A:3B:F1:87:45:5F</fingerprint><web-socket xmlns='http://jitsi.org/protocol/colibri' url='wss://jitsii-test.recourt.comarch.pl:443/colibri-ws/jvb/f771f9e83d834d25/f7a876ba?pwd=2ssdg10m4mdt866bholqvenkc7'/><candidate component='1' foundation='3' generation='0' id='556f5341d33f55a0311a06a1' network='0' priority='1677724415' protocol='udp' type='srflx' ip='193.201.139.223' port='10000' rel-addr='0.0.0.0' rel-port='9'/></transport><sctp role='server' port='5000'/></transport></endpoint><sources><media-source type='audio' id='jvb-a0'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='2886566412' name='jvb-a0'/></media-source><media-source type='video' id='jvb-v0'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='768933237' name='jvb-v0'/></media-source></sources></conference-modified></iq>
JVB 2024-08-23 18:51:06.415 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#234: RECV colibri2 request: <iq xmlns='jabber:client' to='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' from='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtWABGS1FBSC0xNgDeXnR9JtqkrQ==' type='get'><conference-modify xmlns='jitsi:colibri2' meeting-id='cba7d0d6-cae8-4041-9c28-87d3e63036d1'><endpoint stats-id='Hortense-7g8' id='da1fc9d0' create='true'><media type='audio'><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' clockrate='48000' channels='2' id='111' name='opus'><parameter name='minptime' value='10'/><parameter name='useinbandfec' value='1'/><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='telephone-event' id='126' clockrate='8000'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level' id='1'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01' id='5'/><extmap-allow-mixed xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0'/></media><media type='video'><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='VP8' id='100' clockrate='90000'><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 xmlns='urn:xmpp:jingle:apps:rtp:1' name='H264' id='107' clockrate='90000'><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'/><parameter name='profile-level-id' value='42e01f;level-asymmetry-allowed=1;packetization-mode=1;'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='VP9' id='101' clockrate='90000'><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 xmlns='urn:xmpp:jingle:apps:rtp:1' name='rtx' id='96' clockrate='90000'><parameter name='apt' value='100'/><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'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='rtx' id='97' clockrate='90000'><parameter name='apt' value='101'/><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'/></payload-type><payload-type xmlns='urn:xmpp:jingle:apps:rtp:1' name='rtx' id='99' clockrate='90000'><parameter name='apt' value='107'/></payload-type><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' uri='http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time' id='3'/><rtp-hdrext xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0' uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01' id='5'/><extmap-allow-mixed xmlns='urn:xmpp:jingle:apps:rtp:rtp-hdrext:0'/></media><transport ice-controlling='true'><sctp/></transport><sources/><capability name='source-names'/><capability name='ssrc-rewriting'/></endpoint></conference-modify></iq>
JVB 2024-08-23 18:51:06.417 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.gatherCandidates#637: Gathering candidates for component stream-da1fc9d0.RTP.
JVB 2024-08-23 18:51:06.419 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0] Endpoint.<init>#325: Created new endpoint, iceControlling=true
JVB 2024-08-23 18:51:06.420 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#249: SENT colibri2 response: <iq xmlns='jabber:client' to='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' from='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtWABGS1FBSC0xNgDeXnR9JtqkrQ==' type='result'><conference-modified xmlns='jitsi:colibri2'><endpoint id='da1fc9d0'><transport><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='6l6d8403ferentvq2fbm3uvije' ufrag='67emp1i602c6hh'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='actpass' hash='sha-256'>76:72:0A:DD:AE:B9:DD:B3:8E:DC:BD:94:F8:29:2B:3F:EE:55:C0:FD:71:B6:94:F7:14:C6:7A:3B:F1:87:45:5F</fingerprint><web-socket xmlns='http://jitsi.org/protocol/colibri' url='wss://jitsii-test.recourt.comarch.pl:443/colibri-ws/jvb/f771f9e83d834d25/da1fc9d0?pwd=6l6d8403ferentvq2fbm3uvije'/><candidate component='1' foundation='3' generation='0' id='5c6196ac72a2ccc7023615317' network='0' priority='1677724415' protocol='udp' type='srflx' ip='193.201.139.223' port='10000' rel-addr='0.0.0.0' rel-port='9'/></transport><sctp role='server' port='5000'/></transport></endpoint><sources><media-source type='audio' id='jvb-a0'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='2886566412' name='jvb-a0'/></media-source><media-source type='video' id='jvb-v0'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='768933237' name='jvb-v0'/></media-source></sources></conference-modified></iq>
JVB 2024-08-23 18:51:06.968 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#234: RECV colibri2 request: <iq xmlns='jabber:client' to='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' from='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtWABGS1FBSC0xNwDeXnR9JtqkrQ==' type='get'><conference-modify xmlns='jitsi:colibri2' meeting-id='cba7d0d6-cae8-4041-9c28-87d3e63036d1'><endpoint stats-id='Henry-GDs' id='f7a876ba'><transport><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='/kDhuWtqUj1pP6E4E0PkP2LH' ufrag='KThB'><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='active' hash='sha-256'>98:EB:C7:99:80:5E:2D:7A:E4:1E:4F:FA:48:F9:E1:81:AD:66:6F:C8:61:3B:A7:3F:43:81:88:03:58:51:FB:60</fingerprint><rtcp-mux/></transport></transport><sources><media-source id='f7a876ba-v0' type='video'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='f7a876ba-v0' videoType='camera' ssrc='576259615'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='f7a876ba-v0' videoType='camera' ssrc='2230247557'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='f7a876ba-v0' videoType='camera' ssrc='3004783666'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='f7a876ba-v0' videoType='camera' ssrc='380004816'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='f7a876ba-v0' videoType='camera' ssrc='1476519932'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='f7a876ba-v0' videoType='camera' ssrc='233284743'/><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='576259615'/><source ssrc='2230247557'/></ssrc-group><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='SIM'><source ssrc='576259615'/><source ssrc='3004783666'/><source ssrc='380004816'/></ssrc-group><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='3004783666'/><source ssrc='1476519932'/></ssrc-group><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='380004816'/><source ssrc='233284743'/></ssrc-group></media-source></sources></endpoint></conference-modify></iq>
JVB 2024-08-23 18:51:06.969 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] DtlsTransport.setSetupAttribute#126: The remote side is acting as DTLS client, we'll act as server
JVB 2024-08-23 18:51:06.969 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3] IceTransport.startConnectivityEstablishment#205: Starting the Agent without remote candidates.
JVB 2024-08-23 18:51:06.970 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.startConnectivityEstablishment#726: Start ICE connectivity establishment.
JVB 2024-08-23 18:51:06.970 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.initCheckLists#962: Init checklist for stream stream-f7a876ba
JVB 2024-08-23 18:51:06.970 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.setState#936: ICE state changed from Waiting to Running.
JVB 2024-08-23 18:51:06.970 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3] IceTransport.iceStateChanged#345: ICE state changed old=Waiting new=Running
JVB 2024-08-23 18:51:06.971 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.startConnectivityEstablishment#748: Trigger checks for pairs that were received before running state
JVB 2024-08-23 18:51:06.971 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.triggerCheck#1727: Add peer CandidatePair with new reflexive address to checkList: CandidatePair (State=Frozen Priority=7962116751041232895):
        LocalCandidate=candidate:2 1 udp 2130706431 192.168.246.85 10000 typ host
        RemoteCandidate=candidate:10000 1 udp 1853824767 91.227.212.3 14085 typ prflx
JVB 2024-08-23 18:51:06.971 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.startChecks#147: Start connectivity checks.
JVB 2024-08-23 18:51:06.979 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#249: SENT colibri2 response: <iq xmlns='jabber:client' to='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' from='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtWABGS1FBSC0xNwDeXnR9JtqkrQ==' type='result'><conference-modified xmlns='jitsi:colibri2'><endpoint xmlns='jitsi:colibri2' id='f7a876ba'/></conference-modified></iq>
JVB 2024-08-23 18:51:07.002 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] AllocationSettingsWrapper.setBandwidthAllocationSettings#141: Ignoring assumed-bandwidth-bps, not allowed in config.
JVB 2024-08-23 18:51:07.032 INFO: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#649: Pair succeeded: 192.168.246.85:10000/udp/host -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.032 INFO: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3 name=stream-f7a876ba componentId=1] ComponentSocket.addAuthorizedAddress#99: Adding allowed address: 91.227.212.3:14085/udp
JVB 2024-08-23 18:51:07.033 INFO: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#658: Pair validated: 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.033 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#649: Pair succeeded: 192.168.246.85:10000/udp/host -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.034 INFO: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] DefaultNominator.strategyNominateFirstHostOrReflexiveValid#268: Nominate (first highest valid): 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP)
JVB 2024-08-23 18:51:07.034 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#658: Pair validated: 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.035 INFO: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.nominate#1800: verify if nominated pair answer again
JVB 2024-08-23 18:51:07.035 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] DefaultNominator.strategyNominateFirstHostOrReflexiveValid#268: Nominate (first highest valid): 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP)
JVB 2024-08-23 18:51:07.037 WARNING: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3 name=stream-f7a876ba componentId=1] MergingDatagramSocket.initializeActive#599: Active socket already initialized.
JVB 2024-08-23 18:51:07.037 INFO: [53] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#727: IsControlling: true USE-CANDIDATE:false.
JVB 2024-08-23 18:51:07.038 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#727: IsControlling: true USE-CANDIDATE:false.
JVB 2024-08-23 18:51:07.092 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#649: Pair succeeded: 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.092 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#658: Pair validated: 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.093 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#727: IsControlling: true USE-CANDIDATE:true.
JVB 2024-08-23 18:51:07.093 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] ConnectivityCheckClient.processSuccessResponse#742: Nomination confirmed for pair: 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP).
JVB 2024-08-23 18:51:07.093 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3 name=stream-f7a876ba] CheckList.handleNominationConfirmed#406: Selected pair for stream stream-f7a876ba.RTP: 193.201.139.223:10000/udp/srflx -> 91.227.212.3:14085/udp/prflx (stream-f7a876ba.RTP)
JVB 2024-08-23 18:51:07.094 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.checkListStatesUpdated#1891: CheckList of stream stream-f7a876ba is COMPLETED
JVB 2024-08-23 18:51:07.094 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.setState#936: ICE state changed from Running to Completed.
JVB 2024-08-23 18:51:07.095 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3] IceTransport.iceStateChanged#345: ICE state changed old=Running new=Completed
JVB 2024-08-23 18:51:07.095 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] Endpoint$setupIceTransport$2.connected#372: ICE connected
JVB 2024-08-23 18:51:07.096 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.logCandTypes#1999: Harvester used for selected pair for stream-f7a876ba.RTP: srflx
JVB 2024-08-23 18:51:07.096 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] DtlsTransport.startDtlsHandshake#108: Starting DTLS handshake, role=org.jitsi.nlj.dtls.DtlsServer@2c0df6b4
JVB 2024-08-23 18:51:07.148 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] TlsServerImpl.notifyHandshakeComplete#179: Negotiated DTLS version DTLS 1.2
JVB 2024-08-23 18:51:07.149 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] Endpoint$setupDtlsTransport$3.handshakeComplete#418: DTLS handshake complete
JVB 2024-08-23 18:51:07.150 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] Endpoint.acceptSctpConnection$lambda$26#645: Attempting to establish SCTP socket connection
JVB 2024-08-23 18:51:07.224 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] SctpSocket.onNotification#200: Got sctp association state update: 1
JVB 2024-08-23 18:51:07.225 INFO: [50] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] SctpSocket.onNotification#207: sctp is now up.  was ready=false
JVB 2024-08-23 18:51:07.251 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] Endpoint$createSctpConnection$3.onReady#593: SCTP connection is ready, creating the Data channel stack
JVB 2024-08-23 18:51:07.252 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs] Endpoint$createSctpConnection$3.onReady#617: Will wait for the remote side to open the data channel.
JVB 2024-08-23 18:51:09.379 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#234: RECV colibri2 request: <iq xmlns='jabber:client' to='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' from='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtWABGS1FBSC0xOADeXnR9JtqkrQ==' type='get'><conference-modify xmlns='jitsi:colibri2' meeting-id='cba7d0d6-cae8-4041-9c28-87d3e63036d1'><endpoint stats-id='Hortense-7g8' id='da1fc9d0'><transport><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='4xs0LfAcx6twVHy6jW7vueh7' ufrag='jLyn'><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='active' hash='sha-256'>61:88:75:21:94:83:FB:E0:02:E1:65:AA:02:28:72:C6:EF:BB:27:DE:6C:F3:66:08:15:D1:E1:92:F5:C2:C7:C4</fingerprint><rtcp-mux/></transport></transport><sources><media-source id='da1fc9d0-a0' type='audio'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-a0' ssrc='3217206524'/></media-source><media-source id='da1fc9d0-v0' type='video'><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-v0' videoType='camera' ssrc='1101025499'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-v0' videoType='camera' ssrc='2571353215'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-v0' videoType='camera' ssrc='286130426'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-v0' videoType='camera' ssrc='568158251'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-v0' videoType='camera' ssrc='851059285'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='da1fc9d0-v0' videoType='camera' ssrc='2303755737'/><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='1101025499'/><source ssrc='2571353215'/></ssrc-group><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='SIM'><source ssrc='1101025499'/><source ssrc='286130426'/><source ssrc='568158251'/></ssrc-group><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='286130426'/><source ssrc='851059285'/></ssrc-group><ssrc-group xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' semantics='FID'><source ssrc='568158251'/><source ssrc='2303755737'/></ssrc-group></media-source></sources></endpoint></conference-modify></iq>
JVB 2024-08-23 18:51:09.380 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] DtlsTransport.setSetupAttribute#126: The remote side is acting as DTLS client, we'll act as server
JVB 2024-08-23 18:51:09.380 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh] IceTransport.startConnectivityEstablishment#205: Starting the Agent without remote candidates.
JVB 2024-08-23 18:51:09.380 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.startConnectivityEstablishment#726: Start ICE connectivity establishment.
JVB 2024-08-23 18:51:09.381 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.initCheckLists#962: Init checklist for stream stream-da1fc9d0
JVB 2024-08-23 18:51:09.381 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.setState#936: ICE state changed from Waiting to Running.
JVB 2024-08-23 18:51:09.382 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh] IceTransport.iceStateChanged#345: ICE state changed old=Waiting new=Running
JVB 2024-08-23 18:51:09.382 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.startConnectivityEstablishment#748: Trigger checks for pairs that were received before running state
JVB 2024-08-23 18:51:09.382 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.triggerCheck#1727: Add peer CandidatePair with new reflexive address to checkList: CandidatePair (State=Frozen Priority=7961846271180799999):
        LocalCandidate=candidate:2 1 udp 2130706431 192.168.246.85 10000 typ host
        RemoteCandidate=candidate:10000 1 udp 1853761791 37.225.89.211 26330 typ prflx
JVB 2024-08-23 18:51:09.382 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.startChecks#147: Start connectivity checks.
JVB 2024-08-23 18:51:09.384 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.lambda$new$0#249: SENT colibri2 response: <iq xmlns='jabber:client' to='jvbbrewery@internal.auth.jitsii-test.recourt.comarch.pl/focus' from='jvb@auth.jitsii-test.recourt.comarch.pl/8BIXzfZyKsmX' id='anZiQGF1dGguaml0c2lpLXRlc3QucmVjb3VydC5jb21hcmNoLnBsLzhCSVh6Zlp5S3NtWABGS1FBSC0xOADeXnR9JtqkrQ==' type='result'><conference-modified xmlns='jitsi:colibri2'><endpoint xmlns='jitsi:colibri2' id='da1fc9d0'/></conference-modified></iq>
JVB 2024-08-23 18:51:09.432 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#610: Receive a peer-reflexive candidate: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp.
JVB 2024-08-23 18:51:09.433 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#649: Pair succeeded: 192.168.246.85:10000/udp/host -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.433 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh name=stream-da1fc9d0 componentId=1] ComponentSocket.addAuthorizedAddress#99: Adding allowed address: 37.225.89.211:26330/udp
JVB 2024-08-23 18:51:09.433 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#658: Pair validated: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.434 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] DefaultNominator.strategyNominateFirstHostOrReflexiveValid#268: Nominate (first highest valid): [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP)
JVB 2024-08-23 18:51:09.434 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.nominate#1800: verify if nominated pair answer again
JVB 2024-08-23 18:51:09.435 WARNING: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh name=stream-da1fc9d0 componentId=1] MergingDatagramSocket.initializeActive#599: Active socket already initialized.
JVB 2024-08-23 18:51:09.435 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#727: IsControlling: true USE-CANDIDATE:false.
JVB 2024-08-23 18:51:09.437 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#649: Pair succeeded: 192.168.246.85:10000/udp/host -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.437 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#658: Pair validated: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.437 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#727: IsControlling: true USE-CANDIDATE:false.
JVB 2024-08-23 18:51:09.475 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#649: Pair succeeded: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.476 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#658: Pair validated: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.476 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#727: IsControlling: true USE-CANDIDATE:true.
JVB 2024-08-23 18:51:09.476 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] ConnectivityCheckClient.processSuccessResponse#742: Nomination confirmed for pair: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP).
JVB 2024-08-23 18:51:09.477 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh name=stream-da1fc9d0] CheckList.handleNominationConfirmed#406: Selected pair for stream stream-da1fc9d0.RTP: [64:ff9b:0:0:0:0:c1c9:8bdf]:10000/udp/prflx -> 37.225.89.211:26330/udp/prflx (stream-da1fc9d0.RTP)
JVB 2024-08-23 18:51:09.477 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.checkListStatesUpdated#1891: CheckList of stream stream-da1fc9d0 is COMPLETED
JVB 2024-08-23 18:51:09.478 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.setState#936: ICE state changed from Running to Completed.
JVB 2024-08-23 18:51:09.478 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh] IceTransport.iceStateChanged#345: ICE state changed old=Running new=Completed
JVB 2024-08-23 18:51:09.478 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] Endpoint$setupIceTransport$2.connected#372: ICE connected
JVB 2024-08-23 18:51:09.478 INFO: [67] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.logCandTypes#1999: Harvester used for selected pair for stream-da1fc9d0.RTP: prflx
JVB 2024-08-23 18:51:09.479 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] DtlsTransport.startDtlsHandshake#108: Starting DTLS handshake, role=org.jitsi.nlj.dtls.DtlsServer@19bc61dc
JVB 2024-08-23 18:51:09.525 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] TlsServerImpl.notifyHandshakeComplete#179: Negotiated DTLS version DTLS 1.2
JVB 2024-08-23 18:51:09.525 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] Endpoint$setupDtlsTransport$3.handshakeComplete#418: DTLS handshake complete
JVB 2024-08-23 18:51:09.526 INFO: [74] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] Endpoint.acceptSctpConnection$lambda$26#645: Attempting to establish SCTP socket connection
JVB 2024-08-23 18:51:09.581 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] SctpSocket.onNotification#200: Got sctp association state update: 1
JVB 2024-08-23 18:51:09.581 INFO: [47] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] SctpSocket.onNotification#207: sctp is now up.  was ready=false
JVB 2024-08-23 18:51:09.627 INFO: [74] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] Endpoint$createSctpConnection$3.onReady#593: SCTP connection is ready, creating the Data channel stack
JVB 2024-08-23 18:51:09.628 INFO: [74] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] Endpoint$createSctpConnection$3.onReady#617: Will wait for the remote side to open the data channel.
JVB 2024-08-23 18:51:09.628 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] DataChannelStack.onIncomingDataChannelPacket#62: Received data channel open message
JVB 2024-08-23 18:51:09.629 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8] Endpoint$createSctpConnection$3.onReady$lambda$1#600: Remote side opened a data channel.
JVB 2024-08-23 18:51:09.784 INFO: [66] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6] Conference.recentSpeakersChanged#475: Recent speakers changed: [da1fc9d0], dominant speaker changed: true silence:false
JVB 2024-08-23 18:51:10.096 INFO: [58] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3 ufrag=e215s1i602c6h3] Agent.setState#936: ICE state changed from Completed to Terminated.
JVB 2024-08-23 18:51:10.097 INFO: [58] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=f7a876ba stats_id=Henry-GDs local_ufrag=e215s1i602c6h3] IceTransport.iceStateChanged#345: ICE state changed old=Completed new=Terminated
JVB 2024-08-23 18:51:12.479 INFO: [58] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh ufrag=67emp1i602c6hh] Agent.setState#936: ICE state changed from Completed to Terminated.
JVB 2024-08-23 18:51:12.479 INFO: [58] [confId=f771f9e83d834d25 conf_name=test@conference.jitsii-test.recourt.comarch.pl meeting_id=cba7d0d6 epId=da1fc9d0 stats_id=Hortense-7g8 local_ufrag=67emp1i602c6hh] IceTransport.iceStateChanged#345: ICE state changed old=Completed new=Terminated

Reproducibility

More details?

The problem occurs both on jitsi-meet 2.0.9364-1 and 2.0.9646-1

saghul commented 3 weeks ago

What resolution constraints did you configure on your server, the defaults?

klebanj commented 2 weeks ago

I attached all main configuration files in ZIP archive. Currently we use:

resolution: "qhd",
    constraints: {
        video: {
            height: {
                ideal: "qhd",
                max: "qhd",
                min: 180,
            },
            frameRate: {
               max: 20,
               min: 15,
            },
        },
    },
After change to defaults still not working. 
saghul commented 2 weeks ago

I don't think "qhd" will work in all cases. Can you please put actual numbers?

klebanj commented 2 weeks ago

What do you mean by actual numbers? For test, i commented resolution and constraints in config.js and the problem still remains. Should i set those variables to specific values? e.g. should i use values from https://meet.jit.si/config.js

LucienBramar commented 2 weeks ago

Hi, I have the same problem. App version 24.2.2 works

App version 24.4 does not provide a video stream. The tiles of all participants remain black. Only the initials are displayed.

How to solve the Problem?

damencho commented 2 weeks ago

Share your config js.

LucienBramar commented 2 weeks ago

hi

meet.*****.de-config.js.zip

damencho commented 2 weeks ago

And 3way call from the browser works? Is the mobile client from the same network as the desktop? Try commenting the resolution in your config.js, does that change anything?

LucienBramar commented 2 weeks ago

The connection via desktop PC runs without problems, as does the connection via app version 24.2.2.

The connection via a browser (Safari) on the mobile device also works.

Only app version 24.4 does not work

I have cancelled all changes in config.js.

no change

resolution: 720,
channelLastN: 4,
enableLayerSuspension: true,
disableAudioLevels: true,

LucienBramar commented 2 weeks ago

the problem occurs in the wifi and mobile network

LucienBramar commented 2 weeks ago

I've found the problem

I had the function

"disableThirdPartyRequest" to true

when I set it to "false" everything works normally

thx :)

damencho commented 2 weeks ago

Are you talking about the feature share video, not the actual video of the participants from their cameras?

LucienBramar commented 2 weeks ago

no video was displayed at all, neither my own nor the videos of the other participants

The own video was not displayed in the waiting room

damencho commented 2 weeks ago

I don't see how changing disableThirdPartyRequest will change things in that case ... I wonder whether mobile has a cached config.js ...