SctpSocket is closed error while using Videobridge 2

Hi there,

I am getting the following error and the room does not work for more than 2 seconds.

I checked the videobridge logs. I have a docker setup which uses jitsi videobridge 2. It shows the following error.

Apr 22, 2020 8:01:14 AM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=233971474472ff98 gid=null logging=false
Server can't accept: SctpSocket is closed!
Apr 22, 2020 8:01:14 AM org.jitsi.utils.logging2.LoggerImpl log
INFO: Performed a successful health check in PT0.013S. Sticky failure: false
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Server can't accept: SctpSocket is closed!
Apr 22, 2020 8:01:24 AM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=1c75fb1e4979218 gid=null logging=false
Apr 22, 2020 8:01:24 AM org.jitsi.utils.logging2.LoggerImpl log
INFO: Performed a successful health check in PT0.019S. Sticky failure: false
1 Like

I don’t think the SctpSocket error would explain why you get that error in the web–it may be a symptom of another problem. I think you’ll need to attach the full Jicofo and JVB log.

I removed all the images, and recreated them from scratch with the latest pull. I dont see SctpSocket error now but the problem is the same and the users get kicked out of the room after joining in 2 seconds. I found nothing wrong with jicofo/prosody. It looks like something wrong with the jvb. Personally i am noticing it after jitsi videobridge2 was updated in the docker images. I have tried it multiple times and i ensureto delete the old config files.

**JVB logs**

[s6-init] making user provided files available at /var/run/s6/etc...exited 0.
[s6-init] ensuring user provided files have correct perms...exited 0.
[fix-attrs.d] applying ownership & permissions fixes...
[fix-attrs.d] done.
[cont-init.d] executing container initialization scripts...
[cont-init.d] 01-set-timezone: executing...
[cont-init.d] 01-set-timezone: exited 0.
[cont-init.d] 10-config: executing...
[cont-init.d] 10-config: exited 0.
[cont-init.d] done.
[services.d] starting services
[services.d] done.
Apr 22, 2020 1:25:47 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Loaded NewConfig with origin: merge of system properties,system properties,reference.conf @ jar:file:/usr/share/jitsi-videobridge/jitsi-videobridge.jar!/reference.conf: 1,reference.conf @ jar:file:/usr/share/jitsi-videobridge/lib/jitsi-media-transform-1.0-151-gd47656a.jar!/reference.conf: 1
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Attempting to load legacy config file at path /, config, sip-communicator.properties
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Attempting to load legacy config file at path /, config, sip-communicator.properties
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Reloading.
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Loaded NewConfig with origin: merge of system properties,system properties,reference.conf @ jar:file:/usr/share/jitsi-videobridge/jitsi-videobridge.jar!/reference.conf: 1,reference.conf @ jar:file:/usr/share/jitsi-videobridge/lib/jitsi-media-transform-1.0-151-gd47656a.jar!/reference.conf: 1
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Attempting to load legacy config file at path /, config, sip-communicator.properties
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Attempting to load legacy config file at path /, config, sip-communicator.properties
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Registered the LegacyConfigurationServiceShim in OSGi.
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging.LoggerImpl log
INFO: VersionService registered: JVB 2.1.183-gdbddd169
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging.LoggerImpl log
INFO: Not starting the Jetty service for org.jitsi.videobridge.rest.RESTBundleActivator(port=8080)
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging.LoggerImpl log
INFO: Not starting the Jetty service for org.jitsi.videobridge.websocket.WebSocketBundleActivator(port=-1)
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Running with open files limit 1048576 (hard 1048576), thread limit null (hard null). These values are too low and they will limit the number of participants that the bridge can serve simultaneously.
Apr 22, 2020 1:25:48 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Starting with 60 second interval.
Apr 22, 2020 1:25:49 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: No authorized source regexp configured. Will accept requests from any source.
Apr 22, 2020 1:25:49 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Reloading.
Apr 22, 2020 1:25:50 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Loaded NewConfig with origin: merge of system properties,system properties,reference.conf @ jar:file:/usr/share/jitsi-videobridge/jitsi-videobridge.jar!/reference.conf: 1,reference.conf @ jar:file:/usr/share/jitsi-videobridge/lib/jitsi-media-transform-1.0-151-gd47656a.jar!/reference.conf: 1
Apr 22, 2020 1:25:50 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Attempting to load legacy config file at path /, config, sip-communicator.properties
Apr 22, 2020 1:25:50 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Attempting to load legacy config file at path /, config, sip-communicator.properties
Apr 22, 2020 1:25:50 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Started with interval=10000, timeout=PT30S, maxDuration=PT3S, stickyFailures=false.
Apr 22, 2020 1:25:50 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Octo relay is disabled.
Apr 22, 2020 1:25:50 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Disabling certificate verification!
Apr 22, 2020 1:25:52 PM org.ice4j.ice.harvest.StunMappingCandidateHarvester discover
INFO: Discovered public address 45.127.195.129:64581/udp from STUN server 3.7.22.167:443/udp using local address 172.18.0.4:0/udp
Apr 22, 2020 1:25:52 PM org.ice4j.ice.harvest.MappingCandidateHarvesters initialize
INFO: Using org.ice4j.ice.harvest.StunMappingCandidateHarvester, face=/172.18.0.4, mask=/45.127.195.129
Apr 22, 2020 1:25:52 PM org.ice4j.ice.harvest.MappingCandidateHarvesters initialize
INFO: Initialized mapping harvesters (delay=2384ms).  stunDiscoveryFailed=false
Apr 22, 2020 1:25:53 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Connected.
Apr 22, 2020 1:25:53 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Logging in.
Apr 22, 2020 1:25:53 PM org.jitsi.utils.logging.LoggerImpl log
SEVERE: The invocation of the method org.jitsi.videobridge.stats.StatsManager$StatisticsPeriodicRunnable.run() threw an exception.
java.lang.NullPointerException
	at org.jitsi.xmpp.mucclient.MucClient.lambda$getMucsJoinedCount$1(MucClient.java:399)
	at java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:174)
	at java.util.concurrent.ConcurrentHashMap$ValueSpliterator.forEachRemaining(ConcurrentHashMap.java:3566)
	at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:482)
	at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:472)
	at java.util.stream.ReduceOps$ReduceOp.evaluateSequential(ReduceOps.java:708)
	at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
	at java.util.stream.LongPipeline.reduce(LongPipeline.java:461)
	at java.util.stream.LongPipeline.sum(LongPipeline.java:419)
	at java.util.stream.ReferencePipeline.count(ReferencePipeline.java:593)
	at org.jitsi.xmpp.mucclient.MucClient.getMucsJoinedCount(MucClient.java:400)
	at java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:193)
	at java.util.concurrent.ConcurrentHashMap$ValueSpliterator.forEachRemaining(ConcurrentHashMap.java:3566)
	at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:482)
	at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:472)
	at java.util.stream.ReduceOps$ReduceOp.evaluateSequential(ReduceOps.java:708)
	at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
	at java.util.stream.IntPipeline.reduce(IntPipeline.java:479)
	at java.util.stream.IntPipeline.sum(IntPipeline.java:437)
	at org.jitsi.xmpp.mucclient.MucClientManager.getMucJoinedCount(MucClientManager.java:355)
	at org.jitsi.videobridge.stats.VideobridgeStatistics.generate0(VideobridgeStatistics.java:560)
	at org.jitsi.videobridge.stats.VideobridgeStatistics.generate(VideobridgeStatistics.java:158)
	at org.jitsi.videobridge.stats.StatsManager$StatisticsPeriodicRunnable.doRun(StatsManager.java:321)
	at org.jitsi.utils.concurrent.PeriodicRunnableWithObject.run(PeriodicRunnableWithObject.java:87)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor.run(RecurringRunnableExecutor.java:216)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor.runInThread(RecurringRunnableExecutor.java:292)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor.access$000(RecurringRunnableExecutor.java:36)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor$1.run(RecurringRunnableExecutor.java:328)

Apr 22, 2020 1:25:54 PM org.jivesoftware.smack.AbstractXMPPConnection callConnectionAuthenticatedListener
SEVERE: Exception in authenticated listener
java.lang.RuntimeException: org.jivesoftware.smack.XMPPException$XMPPErrorException: XMPP error reply received from jvbbrewery@internal-muc.meet.jitsi/30a1cbb0a59b: XMPPError: item-not-found - cancel
	at org.jitsi.xmpp.mucclient.MucClient$1.authenticated(MucClient.java:282)
	at org.jivesoftware.smack.AbstractXMPPConnection.callConnectionAuthenticatedListener(AbstractXMPPConnection.java:1297)
	at org.jivesoftware.smack.AbstractXMPPConnection.afterSuccessfulLogin(AbstractXMPPConnection.java:572)
	at org.jivesoftware.smack.tcp.XMPPTCPConnection.afterSuccessfulLogin(XMPPTCPConnection.java:379)
	at org.jivesoftware.smack.tcp.XMPPTCPConnection.loginInternal(XMPPTCPConnection.java:444)
	at org.jivesoftware.smack.AbstractXMPPConnection.login(AbstractXMPPConnection.java:491)
	at org.jivesoftware.smack.AbstractXMPPConnection.login(AbstractXMPPConnection.java:448)
	at org.jitsi.xmpp.mucclient.MucClient.lambda$getConnectAndLoginCallable$7(MucClient.java:649)
	at org.jitsi.retry.RetryStrategy$TaskRunner.run(RetryStrategy.java:193)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
Caused by: org.jivesoftware.smack.XMPPException$XMPPErrorException: XMPP error reply received from jvbbrewery@internal-muc.meet.jitsi/30a1cbb0a59b: XMPPError: item-not-found - cancel
	at org.jivesoftware.smack.XMPPException$XMPPErrorException.ifHasErrorThenThrow(XMPPException.java:132)
	at org.jivesoftware.smack.StanzaCollector.nextResultOrThrow(StanzaCollector.java:263)
	at org.jivesoftware.smackx.muc.MultiUserChat.enter(MultiUserChat.java:355)
	at org.jivesoftware.smackx.muc.MultiUserChat.createOrJoin(MultiUserChat.java:498)
	at org.jivesoftware.smackx.muc.MultiUserChat.createOrJoin(MultiUserChat.java:444)
	at org.jitsi.xmpp.mucclient.MucClient$MucWrapper.join(MucClient.java:732)
	at org.jitsi.xmpp.mucclient.MucClient$MucWrapper.access$400(MucClient.java:661)
	at org.jitsi.xmpp.mucclient.MucClient.joinMucs(MucClient.java:367)
	at org.jitsi.xmpp.mucclient.MucClient.access$100(MucClient.java:50)
	at org.jitsi.xmpp.mucclient.MucClient$1.authenticated(MucClient.java:278)
	... 15 more

Apr 22, 2020 1:26:00 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=d99f1e02e3bb1c27 gid=null logging=false
Apr 22, 2020 1:26:00 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: TaskPools detected 2 processors, creating the CPU pool with that many threads
Apr 22, 2020 1:26:00 PM org.ice4j.ice.harvest.AbstractUdpListener <init>
INFO: Initialized AbstractUdpListener with address 172.18.0.4:10000/udp. Receive buffer size 212992 (asked for 10485760)
Apr 22, 2020 1:26:00 PM org.ice4j.ice.harvest.SinglePortUdpHarvester <init>
INFO: Initialized SinglePortUdpHarvester with address 172.18.0.4:10000/udp
SCTP JNI load: Linux OS detected
SCTP lib loaded
=====>: org_jitsi_modified_sctp4j_SctpJni.c calling init
=====>: org_jitsi_modified_sctp4j_SctpJni.c about to set SCTP_DEBUG_ALL
Apr 22, 2020 1:26:10 PM org.jitsi.utils.logging2.LoggerImpl log
SEVERE: Health check failed in PT10.089S:
java.lang.Exception: Performing a health check took too long: PT10.089S
	at org.jitsi.health.AbstractHealthCheckService.run(AbstractHealthCheckService.kt:159)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor.run(RecurringRunnableExecutor.java:216)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor.runInThread(RecurringRunnableExecutor.java:292)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor.access$000(RecurringRunnableExecutor.java:36)
	at org.jitsi.utils.concurrent.RecurringRunnableExecutor$1.run(RecurringRunnableExecutor.java:328)

Apr 22, 2020 1:26:10 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=f0ee91bcb349c015 gid=null logging=false
Apr 22, 2020 1:26:10 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Performed a successful health check in PT0.044S. Sticky failure: false
Apr 22, 2020 1:26:20 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=5cece275ee5d5101 gid=null logging=false
Apr 22, 2020 1:26:20 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Performed a successful health check in PT0.059S. Sticky failure: false
Apr 22, 2020 1:26:30 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=abaa758f2e80f0c7 gid=null logging=false

Prosody Logs

[cont-init.d] done.
[services.d] starting services
[services.d] done.
startup             info	Hello and welcome to Prosody version 0.11.5
saslauthd[253] :num_procs  : 5
saslauthd[253] :mech_option: /etc/saslauthd.conf
saslauthd[253] :run_path   : /var/run/saslauthd
saslauthd[253] :auth_mech  : ldap
saslauthd[253] :mmaped shared memory segment on file: /var/run/saslauthd/cache.mmap
saslauthd[253] :bucket size: 96 bytes
saslauthd[253] :stats size : 36 bytes
saslauthd[253] :timeout    : 28800 seconds
saslauthd[253] :cache table: 985828 total bytes
saslauthd[253] :cache table: 1711 slots
saslauthd[253] :cache table: 10266 buckets
saslauthd[253] :flock file opened at /var/run/saslauthd/cache.flock
saslauthd[253] :using accept lock file: /var/run/saslauthd/mux.accept
saslauthd[253] :master pid is: 0
saslauthd[253] :listening on socket: /var/run/saslauthd/mux
saslauthd[253] :using process model
saslauthd[253] :forked child: 274
saslauthd[253] :forked child: 275
saslauthd[253] :forked child: 276
saslauthd[253] :forked child: 277
saslauthd[253] :acquired accept lock
startup             info	Prosody is using the epoll backend for connection handling
portmanager         info	Activated service 's2s' on [*]:5269, [::]:5269
portmanager         info	Activated service 'component' on [*]:5347
portmanager         info	Activated service 'c2s' on [*]:5222, [::]:5222
portmanager         info	Activated service 'legacy_ssl' on no ports
portmanager         info	Activated service 'http' on [*]:5280, [::]:5280
portmanager         info	Activated service 'https' on no ports
c2s55c0dbe20470     info	Client connected
c2s55c0dbdb9700     info	Client connected
c2s55c0dbe20470     info	Stream encrypted (TLSv1.2 with ECDHE-RSA-AES256-GCM-SHA384)
c2s55c0dbe20470     info	Authenticated as focus@auth.meet.jitsi
c2s55c0dbdb9700     info	Stream encrypted (TLSv1.2 with ECDHE-RSA-AES256-GCM-SHA384)
c2s55c0dbdb9700     info	Authenticated as jvb@auth.meet.jitsi
focus.meet.jitsi:component  warn	Component not connected, bouncing error for: <iq from='focus@auth.meet.jitsi/focus91474671365853' type='get' to='focus.meet.jitsi' id='cWOaF-39'>
jcp55c0dbdb9610             info	Incoming Jabber component connection
focus.meet.jitsi:component  info	External component successfully authenticated
mod_bosh                    info	New BOSH session, assigned it sid '83d84634-b383-48f8-a081-df8158f8588e'
bosh83d84634-b383-48f8-a081-df8158f8588e  info	Authenticated as wuu2mowgg4y2ojoe@meet.jitsi
mod_bosh                                  info	New BOSH session, assigned it sid '5e85392c-26ac-4dae-b868-759365c33abf'
bosh5e85392c-26ac-4dae-b868-759365c33abf  info	Authenticated as 91jts7jxgblterqf@meet.jitsi
bosh5e85392c-26ac-4dae-b868-759365c33abf  info	BOSH client disconnected: session close
bosh83d84634-b383-48f8-a081-df8158f8588e  info	BOSH client disconnected: session close
mod_bosh                                  info	New BOSH session, assigned it sid '5253ead3-8b98-415a-81cf-fb7e85a1da23'
bosh5253ead3-8b98-415a-81cf-fb7e85a1da23  info	Authenticated as lop59br1onrdlyrr@meet.jitsi
mod_bosh                                  info	New BOSH session, assigned it sid '7dc52398-9e73-479d-b1e5-595cec94c981'
bosh7dc52398-9e73-479d-b1e5-595cec94c981  info	Authenticated as qfpgx9pyb1itwazw@meet.jitsi
bosh5253ead3-8b98-415a-81cf-fb7e85a1da23  info	BOSH client disconnected: session close
bosh7dc52398-9e73-479d-b1e5-595cec94c981  info	BOSH client disconnected: session close
mod_bosh                                  info	New BOSH session, assigned it sid 'ce540410-4180-4c5e-a556-8c64baf284aa'
boshce540410-4180-4c5e-a556-8c64baf284aa  info	Authenticated as wn4zfhfykz8ckh6o@meet.jitsi
mod_bosh                                  info	New BOSH session, assigned it sid 'e76f40e7-31d2-4ad0-ae7e-2ecfec7ed526'
boshe76f40e7-31d2-4ad0-ae7e-2ecfec7ed526  info	Authenticated as 6cvywb-nvo67rpfi@meet.jitsi
boshce540410-4180-4c5e-a556-8c64baf284aa  info	BOSH client disconnected: session close
boshe76f40e7-31d2-4ad0-ae7e-2ecfec7ed526  info	BOSH client disconnected: session close

Jicofo logs

Jicofo 2020-04-22 13:28:16.540 INFO: [31] org.jitsi.jicofo.health.Health.log() Performed a successful health check in PT0.036S. Sticky failure: false

Jicofo 2020-04-22 13:28:26.558 INFO: [31] org.jitsi.jicofo.health.Health.log() Performed a successful health check in PT0.054S. Sticky failure: false

Jicofo 2020-04-22 13:28:37.084 INFO: [31] org.jitsi.jicofo.health.Health.log() Performed a successful health check in PT0.45S. Sticky failure: false

Jicofo 2020-04-22 13:28:39.239 INFO: [51] org.jitsi.jicofo.xmpp.FocusComponent.handleConferenceIq().401 Focus request for room: test@muc.meet.jitsi

Jicofo 2020-04-22 13:28:39.280 INFO: [51] org.jitsi.jicofo.FocusManager.log() Created new focus for test@muc.meet.jitsi@auth.meet.jitsi. Conference count 3,options:

Jicofo 2020-04-22 13:28:39.316 INFO: [51] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Joining the room: test@muc.meet.jitsi

Jicofo 2020-04-22 13:28:39.674 WARNING: [51] org.jitsi.xmpp.component.ComponentBase.log() PROCESSING TIME LIMIT EXCEEDED - it took 471ms to process: <iq to="focus.meet.jitsi" id="48db2d0d-fc8a-4d0c-8ad9-76dbbd119022:sendIQ" type="set" from="wuu2mowgg4y2ojoe@meet.jitsi/AD1HYH5l"><conference xmlns="http://jitsi.org/protocol/focus" machine-uid="f9b4d2755b9b1c23b01a20b4638e4a18" session-id="8a491305-5627-4c35-829b-3bc190d380d2" room="test@muc.meet.jitsi"><property name="channelLastN" value="-1"/><property name="disableRtx" value="false"/><property name="enableLipSync" value="false"/><property name="openSctp" value="true"/></conference></iq>

Jicofo 2020-04-22 13:28:40.187 INFO: [27] org.jitsi.jicofo.ChatRoomRoleAndPresence.log() Chat room event ChatRoomMemberPresenceChangeEvent[type=MemberJoined sourceRoom=org.jitsi.impl.protocol.xmpp.ChatRoomImpl@5ed1940a member=ChatMember[test@muc.meet.jitsi/e9bb1b87, jid: null]@412291307]

Jicofo 2020-04-22 13:28:40.258 INFO: [27] org.jitsi.jicofo.ChatRoomRoleAndPresence.log() Granted owner to test@muc.meet.jitsi/e9bb1b87

Jicofo 2020-04-22 13:28:40.259 INFO: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Member test@muc.meet.jitsi/e9bb1b87 joined.

Jicofo 2020-04-22 13:28:47.014 INFO: [31] org.jitsi.jicofo.health.Health.log() Performed a successful health check in PT0.252S. Sticky failure: false

Jicofo 2020-04-22 13:28:53.060 INFO: [57] org.jitsi.jicofo.xmpp.FocusComponent.handleConferenceIq().401 Focus request for room: test@muc.meet.jitsi

Jicofo 2020-04-22 13:28:53.098 WARNING: [57] org.jitsi.xmpp.component.ComponentBase.log() PROCESSING TIME LIMIT EXCEEDED - it took 180ms to process: <iq to="focus.meet.jitsi" id="dd6ca108-ff1b-4609-a11a-aafb0e38fb14:sendIQ" type="set" from="91jts7jxgblterqf@meet.jitsi/nxRb8RS7"><conference xmlns="http://jitsi.org/protocol/focus" machine-uid="7d2f3b3761e080f47e45cde29fc2d55a" room="test@muc.meet.jitsi"><property name="channelLastN" value="-1"/><property name="disableRtx" value="false"/><property name="enableLipSync" value="false"/><property name="openSctp" value="true"/></conference></iq>

Jicofo 2020-04-22 13:28:53.760 INFO: [27] org.jitsi.jicofo.ChatRoomRoleAndPresence.log() Chat room event ChatRoomMemberPresenceChangeEvent[type=MemberJoined sourceRoom=org.jitsi.impl.protocol.xmpp.ChatRoomImpl@5ed1940a member=ChatMember[test@muc.meet.jitsi/e2762fee, jid: null]@970617177]

Jicofo 2020-04-22 13:28:53.764 INFO: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Member test@muc.meet.jitsi/e2762fee joined.

Jicofo 2020-04-22 13:28:53.819 WARNING: [27] org.jitsi.jicofo.bridge.BridgeSelectionStrategy.log() Failed to select initial bridge for participantRegion=null

Jicofo 2020-04-22 13:28:53.819 SEVERE: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Can not invite participant -- no bridge available.

Jicofo 2020-04-22 13:28:53.831 WARNING: [27] org.jitsi.jicofo.bridge.BridgeSelectionStrategy.log() Failed to select initial bridge for participantRegion=null

Jicofo 2020-04-22 13:28:53.834 SEVERE: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Can not invite participant -- no bridge available.

Jicofo 2020-04-22 13:28:54.663 INFO: [27] org.jitsi.jicofo.ChatRoomRoleAndPresence.log() Chat room event ChatRoomMemberPresenceChangeEvent[type=MemberLeft sourceRoom=org.jitsi.impl.protocol.xmpp.ChatRoomImpl@5ed1940a member=ChatMember[test@muc.meet.jitsi/e2762fee, jid: null]@970617177]

Jicofo 2020-04-22 13:28:54.664 INFO: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Member test@muc.meet.jitsi/e2762fee is leaving

Jicofo 2020-04-22 13:28:54.667 INFO: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Removed participant: true, test@muc.meet.jitsi/e2762fee

Jicofo 2020-04-22 13:28:56.369 INFO: [27] org.jitsi.jicofo.ChatRoomRoleAndPresence.log() Chat room event ChatRoomMemberPresenceChangeEvent[type=MemberLeft sourceRoom=org.jitsi.impl.protocol.xmpp.ChatRoomImpl@5ed1940a member=ChatMember[test@muc.meet.jitsi/e9bb1b87, jid: wuu2mowgg4y2ojoe@meet.jitsi/AD1HYH5l]@412291307]

Jicofo 2020-04-22 13:28:56.375 INFO: [27] org.jitsi.jicofo.ChatRoomRoleAndPresence.log() Owner has left the room !

Jicofo 2020-04-22 13:28:56.377 INFO: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Member test@muc.meet.jitsi/e9bb1b87 is leaving

Jicofo 2020-04-22 13:28:56.380 INFO: [27] org.jitsi.jicofo.JitsiMeetConferenceImpl.log() Removed participant: true, test@muc.meet.jitsi/e9bb1b87

Jicofo 2020-04-22 13:28:56.453 INFO: [27] org.jitsi.jicofo.FocusManager.log() Disposed conference for room: test@muc.meet.jitsi conference count: 1

Jicofo 2020-04-22 13:28:56.872 INFO: [31] org.jitsi.jicofo.health.Health.log() Performed a successful health check in PT0.1S. Sticky failure: false

Also, when the room is disconnected here is what is shown in JVB. The prior logs are on jvb start. I am pretty sure that there is something wrong with the project so you can replicate it by pulling the latest commit and building the images manually.

Apr 22, 2020 2:51:32 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=927179f0ce13c7fb gid=null logging=false
Apr 22, 2020 2:51:33 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Performed a successful health check in PT0.481S. Sticky failure: false
Apr 22, 2020 2:51:38 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=a350346650f0d4f1 gid=ff460c logging=true
Apr 22, 2020 2:51:38 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Gathering candidates for component stream-31065bcf.RTP.
Apr 22, 2020 2:51:38 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ds_change ds_id=31065bcf
Apr 22, 2020 2:51:38 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Ignoring empty DtlsFingerprint extension: <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1'><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' required='false'/></transport>
Apr 22, 2020 2:51:38 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Transport description:
 <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='46j9ubkd3i46h4g7mfmqhifdq8' ufrag='cu2fp1e6gv37ip'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='actpass' hash='sha-256'>0A:EE:41:5E:A7:15:2B:66:81:1D:19:30:F5:D5:E5:8A:00:9D:5D:B3:28:B3:6F:B5:24:F7:17:83:9B:65:55:7E</fingerprint><candidate component='1' foundation='1' generation='0' id='32244d03724295c10ffffffffc1070981' network='0' priority='2130706431' protocol='udp' type='host' ip='172.21.0.5' port='10000'/><candidate component='1' foundation='2' generation='0' id='5c1a958e724295c104271ccfd' network='0' priority='1694498815' protocol='udp' type='srflx' ip='45.127.195.129' port='10000' rel-addr='172.21.0.5' rel-port='10000'/></transport>
Apr 22, 2020 2:51:39 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Took 255 ms to handle IQ: <iq to='jvb@auth.meet.jitsi/ZTVfopnz' from='jvbbrewery@internal-muc.meet.jitsi/focus' id='anZiQGF1dGgubWVldC5qaXRzaS9aVFZmb3BuegBtbnFNQy00NzkA5hcYYEZP4PYTKz7gCFE5rA==' type='set'><conference xmlns='http://jitsi.org/protocol/colibri' gid='ff460c' name='test'><content name='audio'><channel endpoint='31065bcf' initiator='true' channel-bundle-id='31065bcf' last-n='-1'><payload-type name='opus' clockrate='48000' channels='2' id='111'><rtcp-fb xmlns='urn:xmpp:jingle:apps:rtp:rtcp-fb:0' type='transport-cc'/><parameter name='minptime' value='10'/><parameter name='useinbandfec' value='1'/></payload-type><payload-type id='103' clockrate='16000' name='ISAC'/><payload-type id='104' clockrate='32000' name='ISAC'/><payload-type id='126' clockrate='8000' name='telephone-event'/><rtp-hdrext uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level' id='1'/><rtp-hdrext uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01' id='5'/></channel></content><content name='video'><channel endpoint='31065bcf' initiator='true' channel-bundle-id='31065bcf' last-n='-1'><payload-type id='100' clockrate='90000' 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'/><parameter name='x-google-start-bitrate' value='800'/></payload-type><payload-type id='107' clockrate='90000' name='H264'><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='x-google-start-bitrate' value='800'/><parameter name='profile-level-id' value='42e01f;level-asymmetry-allowed=1;packetization-mode=1;'/></payload-type><payload-type id='101' clockrate='90000' name='VP9'><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='x-google-start-bitrate' value='800'/></payload-type><rtp-hdrext uri='http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time' id='3'/><rtp-hdrext uri='http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01' id='5'/></channel></content><content name='data'><sctpconnection endpoint='31065bcf' initiator='true' channel-bundle-id='31065bcf' port='5000'/></content><channel-bundle id='31065bcf'><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1'><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' required='false'/></transport></channel-bundle><endpoint id='31065bcf' stats-id='Pauline-PqX'/></conference></iq>
Apr 22, 2020 2:51:39 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Gathering candidates for component stream-551249e4.RTP.
Apr 22, 2020 2:51:39 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Ignoring empty DtlsFingerprint extension: <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1'><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' required='false'/></transport>
Apr 22, 2020 2:51:39 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Transport description:
 <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='68d2f3bts0pqimihrjnbp6jlbp' ufrag='dcee91e6gv38ed'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='actpass' hash='sha-256'>0A:EE:41:5E:A7:15:2B:66:81:1D:19:30:F5:D5:E5:8A:00:9D:5D:B3:28:B3:6F:B5:24:F7:17:83:9B:65:55:7E</fingerprint><candidate component='1' foundation='1' generation='0' id='270566a73e63a6500ffffffffac7f60d8' network='0' priority='2130706431' protocol='udp' type='host' ip='172.21.0.5' port='10000'/><candidate component='1' foundation='2' generation='0' id='680cfd5c3e63a65002dea2454' network='0' priority='1694498815' protocol='udp' type='srflx' ip='45.127.195.129' port='10000' rel-addr='172.21.0.5' rel-port='10000'/></transport>
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: The remote side is acting as DTLS client, we'll act as server
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Starting the Agent without remote candidates.
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Start ICE connectivity establishment.
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Init checklist for stream stream-551249e4
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed from Waiting to Running.
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed old=Waiting new=Running
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Start connectivity checks.
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Transport description:
 <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='68d2f3bts0pqimihrjnbp6jlbp' ufrag='dcee91e6gv38ed'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='passive' hash='sha-256'>0A:EE:41:5E:A7:15:2B:66:81:1D:19:30:F5:D5:E5:8A:00:9D:5D:B3:28:B3:6F:B5:24:F7:17:83:9B:65:55:7E</fingerprint><candidate component='1' foundation='1' generation='0' id='41d9dc9e3e63a6500ffffffffac7f60d8' network='0' priority='2130706431' protocol='udp' type='host' ip='172.21.0.5' port='10000'/><candidate component='1' foundation='2' generation='0' id='5187a41a3e63a65002dea2454' network='0' priority='1694498815' protocol='udp' type='srflx' ip='45.127.195.129' port='10000' rel-addr='172.21.0.5' rel-port='10000'/></transport>
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Took 119 ms to handle IQ: <iq to='jvb@auth.meet.jitsi/ZTVfopnz' from='jvbbrewery@internal-muc.meet.jitsi/focus' id='anZiQGF1dGgubWVldC5qaXRzaS9aVFZmb3BuegBtbnFNQy01MTUA5hcYYEZP4PYTKz7gCFE5rA==' type='set'><conference xmlns='http://jitsi.org/protocol/colibri' id='a350346650f0d4f1' gid='ff460c' name='test'><content name='audio'><channel id='40b4a581d2b9bc83'><payload-type id='111' clockrate='48000' channels='2' name='opus'><parameter name='maxplaybackrate' value='48000'/><parameter name='stereo' value='1'/><parameter name='useinbandfec' value='1'/></payload-type><payload-type id='126' clockrate='8000' channels='1' name='telephone-event'><parameter name='' value='0-15'/></payload-type><rtp-hdrext id='1' uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='2478356927'><parameter xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='cname' value='2545c6a7-812c-5342-bf20-6f9ded95a05e-1'/><ssrc-info xmlns='http://jitsi.org/jitmeet' owner='test@muc.meet.jitsi/551249e4'/></source></channel></content><content name='video'><channel id='63b3540db535f2ba'><payload-type id='100' clockrate='90000' channels='1' name='VP8'><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' subtype='fir' type='ccm'/><parameter name='max-fs' value='12288'/><parameter name='max-fr' value='60'/></payload-type><payload-type id='107' clockrate='90000' channels='1' name='H264'><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' subtype='fir' type='ccm'/><parameter name='profile-level-id' value='42e01f'/><parameter name='level-asymmetry-allowed' value='1'/><parameter name='packetization-mode' value='1'/></payload-type><payload-type id='101' clockrate='90000' channels='1' name='VP9'><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' subtype='fir' type='ccm'/><parameter name='max-fs' value='12288'/><parameter name='max-fr' value='60'/></payload-type><rtp-hdrext id='3' uri='http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='1765326242'><parameter xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='cname' value='2545c6a7-812c-5342-bf20-6f9ded95a05e-1'/><ssrc-info xmlns='http://jitsi.org/jitmeet' owner='test@muc.meet.jitsi/551249e4'/></source></channel></content><channel-bundle id='551249e4'><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' ufrag='a5d20968' pwd='ce2cec4095fb38681809fe85abc73817'><rtcp-mux xmlns='urn:xmpp:jingle:transports:ice-udp:1'/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='active' required='false' hash='sha-256'>24:15:2F:D8:FF:25:86:B9:C9:33:28:66:55:B1:C1:85:57:30:EE:BA:B6:48:23:75:69:09:CC:DB:90:6F:AC:FD</fingerprint></transport></channel-bundle></conference></iq>
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Transport description:
 <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='68d2f3bts0pqimihrjnbp6jlbp' ufrag='dcee91e6gv38ed'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='passive' hash='sha-256'>0A:EE:41:5E:A7:15:2B:66:81:1D:19:30:F5:D5:E5:8A:00:9D:5D:B3:28:B3:6F:B5:24:F7:17:83:9B:65:55:7E</fingerprint><candidate component='1' foundation='1' generation='0' id='2e1c36013e63a6500ffffffffac7f60d8' network='0' priority='2130706431' protocol='udp' type='host' ip='172.21.0.5' port='10000'/><candidate component='1' foundation='2' generation='0' id='611385ad3e63a65002dea2454' network='0' priority='1694498815' protocol='udp' type='srflx' ip='45.127.195.129' port='10000' rel-addr='172.21.0.5' rel-port='10000'/></transport>
Apr 22, 2020 2:51:40 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Starting the Agent without remote candidates.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Start ICE connectivity establishment.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Init checklist for stream stream-31065bcf
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed from Waiting to Running.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed old=Waiting new=Running
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Start connectivity checks.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Transport description:
 <transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' pwd='46j9ubkd3i46h4g7mfmqhifdq8' ufrag='cu2fp1e6gv37ip'><rtcp-mux/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='actpass' hash='sha-256'>0A:EE:41:5E:A7:15:2B:66:81:1D:19:30:F5:D5:E5:8A:00:9D:5D:B3:28:B3:6F:B5:24:F7:17:83:9B:65:55:7E</fingerprint><candidate component='1' foundation='1' generation='0' id='6e21983d724295c10ffffffffc1070981' network='0' priority='2130706431' protocol='udp' type='host' ip='172.21.0.5' port='10000'/><candidate component='1' foundation='2' generation='0' id='2ea4697724295c104271ccfd' network='0' priority='1694498815' protocol='udp' type='srflx' ip='45.127.195.129' port='10000' rel-addr='172.21.0.5' rel-port='10000'/></transport>
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Took 362 ms to handle IQ: <iq to='jvb@auth.meet.jitsi/ZTVfopnz' from='jvbbrewery@internal-muc.meet.jitsi/focus' id='anZiQGF1dGgubWVldC5qaXRzaS9aVFZmb3BuegBtbnFNQy01MjYA5hcYYEZP4PYTKz7gCFE5rA==' type='set'><conference xmlns='http://jitsi.org/protocol/colibri' id='a350346650f0d4f1' gid='ff460c' name='test'><channel-bundle id='31065bcf'><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' ufrag='53a48ce9' pwd='0b74d63a88efb22adede98fa08376de3'><rtcp-mux xmlns='urn:xmpp:jingle:transports:ice-udp:1'/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' required='true' hash='sha-256'>23:31:0C:92:59:38:ED:14:05:EF:2E:ED:7A:85:5C:1F:38:74:71:45:62:18:B1:45:BA:45:59:FF:63:26:63:77</fingerprint><candidate xmlns='urn:xmpp:jingle:transports:ice-udp:1' priority='2122252543' type='host' port='64995' generation='0' protocol='udp' component='1' foundation='0' network='1' id='i4fzc1acuy' ip='8ddc24ce-6285-49f6-8b70-06f439437e51.local'/><candidate xmlns='urn:xmpp:jingle:transports:ice-udp:1' priority='2105524479' type='host' port='9' generation='0' protocol='tcp' foundation='1' component='1' tcptype='active' network='1' id='ov7ygvko7r' ip='8ddc24ce-6285-49f6-8b70-06f439437e51.local'/></transport></channel-bundle></conference></iq>
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Expiring.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
SEVERE: Error processing channels: internal-server-error Error finding channel ec8aca28be95e82e
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Expiring.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Tearing down
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Tearing down
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Tearing down
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Tearing down
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Tearing down
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Stopping
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Stopping
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed from Running to Terminated.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed old=Running new=Terminated
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Closing.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Expired.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Took 124 ms to handle IQ: <iq to='jvb@auth.meet.jitsi/ZTVfopnz' from='jvbbrewery@internal-muc.meet.jitsi/focus' id='anZiQGF1dGgubWVldC5qaXRzaS9aVFZmb3BuegBtbnFNQy01NDEA5hcYYEZP4PYTKz7gCFE5rA==' type='set'><conference xmlns='http://jitsi.org/protocol/colibri' id='a350346650f0d4f1' gid='ff460c' name='test'><content name='audio'><channel expire='0' id='40b4a581d2b9bc83'/></content><content name='video'><channel expire='0' id='63b3540db535f2ba'/></content><content name='data'><sctpconnection endpoint='551249e4' expire='0' id='504a70dedd030a1e' port='5000'/></content></conference></iq>
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ds_change ds_id=null
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Tearing down
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Stopping
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Stopping
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Took 608 ms to handle IQ: <iq to='jvb@auth.meet.jitsi/ZTVfopnz' from='jvbbrewery@internal-muc.meet.jitsi/focus' id='anZiQGF1dGgubWVldC5qaXRzaS9aVFZmb3BuegBtbnFNQy01MjIA5hcYYEZP4PYTKz7gCFE5rA==' type='set'><conference xmlns='http://jitsi.org/protocol/colibri' id='a350346650f0d4f1' gid='ff460c' name='test'><content name='audio'><channel id='ec8aca28be95e82e'><payload-type id='111' clockrate='48000' channels='2' name='opus'><parameter name='maxplaybackrate' value='48000'/><parameter name='stereo' value='1'/><parameter name='useinbandfec' value='1'/></payload-type><payload-type id='126' clockrate='8000' channels='1' name='telephone-event'><parameter name='' value='0-15'/></payload-type><rtp-hdrext id='1' uri='urn:ietf:params:rtp-hdrext:ssrc-audio-level'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='4147112726'><parameter xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='cname' value='82010527-c0a6-1c41-b87f-7c18dfa7c7a9-1'/><ssrc-info xmlns='http://jitsi.org/jitmeet' owner='test@muc.meet.jitsi/31065bcf'/></source></channel></content><content name='video'><channel id='2cb6a79aa8245566'><payload-type id='100' clockrate='90000' channels='1' name='VP8'><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' subtype='fir' type='ccm'/><parameter name='max-fs' value='12288'/><parameter name='max-fr' value='60'/></payload-type><payload-type id='107' clockrate='90000' channels='1' name='H264'><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' subtype='fir' type='ccm'/><parameter name='profile-level-id' value='42e01f'/><parameter name='level-asymmetry-allowed' value='1'/><parameter name='packetization-mode' value='1'/></payload-type><payload-type id='101' clockrate='90000' channels='1' name='VP9'><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' subtype='fir' type='ccm'/><parameter name='max-fs' value='12288'/><parameter name='max-fr' value='60'/></payload-type><rtp-hdrext id='3' uri='http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time'/><source xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' ssrc='996053835'><parameter xmlns='urn:xmpp:jingle:apps:rtp:ssma:0' name='cname' value='82010527-c0a6-1c41-b87f-7c18dfa7c7a9-1'/><ssrc-info xmlns='http://jitsi.org/jitmeet' owner='test@muc.meet.jitsi/31065bcf'/></source></channel></content><channel-bundle id='31065bcf'><transport xmlns='urn:xmpp:jingle:transports:ice-udp:1' ufrag='53a48ce9' pwd='0b74d63a88efb22adede98fa08376de3'><rtcp-mux xmlns='urn:xmpp:jingle:transports:ice-udp:1'/><fingerprint xmlns='urn:xmpp:jingle:apps:dtls:0' setup='active' required='false' hash='sha-256'>23:31:0C:92:59:38:ED:14:05:EF:2E:ED:7A:85:5C:1F:38:74:71:45:62:18:B1:45:BA:45:59:FF:63:26:63:77</fingerprint></transport></channel-bundle></conference></iq>
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed from Running to Terminated.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: ICE state changed old=Running new=Terminated
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Closing.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Expired.
Apr 22, 2020 2:51:41 PM org.jitsi.utils.logging2.LoggerImpl log
WARNING: Took 340 ms to handle IQ: <iq to='jvb@auth.meet.jitsi/ZTVfopnz' from='jvbbrewery@internal-muc.meet.jitsi/focus' id='anZiQGF1dGgubWVldC5qaXRzaS9aVFZmb3BuegBtbnFNQy01MzYA5hcYYEZP4PYTKz7gCFE5rA==' type='set'><conference xmlns='http://jitsi.org/protocol/colibri' id='a350346650f0d4f1' gid='ff460c' name='test'><content name='audio'><channel expire='0' id='ec8aca28be95e82e'/></content><content name='video'><channel expire='0' id='2cb6a79aa8245566'/></content><content name='data'><sctpconnection endpoint='31065bcf' expire='0' id='c5559587d560dc63' port='5000'/></content></conference></iq>
Apr 22, 2020 2:51:42 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: create_conf, id=820d70d7b60cb152 gid=null logging=false
Apr 22, 2020 2:51:42 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Performed a successful health check in PT0.368S. Sticky failure: false

@damencho any idea on the MUC errors?

I am not sure. I tried this on my other computer with a fresh docker-jitsi-meet installation. Got the same error. You can try on your system too. I am sure itll replicate the error.

Hi guys, I had the same issue yesterday when users could not join our meetings for about 2 minutes and then things got working to normal again after 2 minutes.

I checked the logs and Jicofo is all okay.

JVB log at the exact timestamp suggested the same “Server can’t accept: SctpSocket is closed!” for 2 minutes from 2020-05-07 21:20:17 to 2020-05-07 21:21:43 and then started working again

Server can't accept: SctpSocket is closed!

Got sctp association state update: 1

sctp is now up.  was ready? false

2020-05-07 21:20:21.267 INFO: [4332] [confId=a6aa1fa1e1e7fe12 epId=ab67f76e gid=ff532d stats_id=Humberto-EGk conf_name=emeraldcityplaza451] Endpoint$4.onReady#776: SCTP connection is ready, creating the Data channel stack

2020-05-07 21:20:21.267 INFO: [4332] [confId=a6aa1fa1e1e7fe12 epId=ab67f76e gid=ff532d stats_id=Humberto-EGk conf_name=emeraldcityplaza451] Endpoint$4.onReady#803: Will wait for the remote side to open the data channel.

2020-05-07 21:20:21.267 INFO: [4334] [confId=a6aa1fa1e1e7fe12 epId=ab67f76e gid=ff532d stats_id=Humberto-EGk conf_name=emeraldcityplaza451] DataChannelStack.onIncomingDataChannelPacket#62: Received data channel open message

2020-05-07 21:20:21.268 INFO: [4334] [confId=a6aa1fa1e1e7fe12 epId=ab67f76e gid=ff532d stats_id=Humberto-EGk conf_name=emeraldcityplaza451] Endpoint$4.lambda$onReady$1#784: Remote side opened a data channel.

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

2020-05-07 21:20:21.986 INFO: [4332] [confId=a6aa1fa1e1e7fe12 gid=ff532d conf_name=emeraldcityplaza451] Conference.dominantSpeakerChanged#446: ds_change ds_id=ab67f76e

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

Server can't accept: SctpSocket is closed!

any suggestions @bbaldino @damencho

I got the same error. But the reason was that I used Firefox on Linux with user agent set to Edge on Windows. Maybe that helps.

Thanks I see - so means its not a server config error but a browser related peculiarity…
Hmm, will watch out for more :slight_smile:

Anyone found any solution for “Server can’t accept: SctpSocket is closed!” ??
I have faced this error many times, for example:

INFO: Failed to receive: java.net.SocketException: Socket closed
Server can’t accept: SctpSocket is closed!
…(20 times)

Sep 02, 2020 3:01:19 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Failed to receive: java.net.SocketException: Socket closed
Server can’t accept: SctpSocket is closed!Sep 02, 2020 3:04:12 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Expired.
Server can’t accept: SctpSocket is closed!
… (30 times)

:Sep 02, 2020 3:11:02 PM org.jitsi.utils.logging2.LoggerImpl log
INFO: Expired.
Server can’t accept: SctpSocket is closed!
…