jvb_1 | [s6-init] making user provided files available at /var/run/s6/etc...exited 0.
jvb_1 | [s6-init] ensuring user provided files have correct perms...exited 0.
jvb_1 | [fix-attrs.d] applying ownership & permissions fixes...
jvb_1 | [fix-attrs.d] done.
jvb_1 | [cont-init.d] executing container initialization scripts...
jvb_1 | [cont-init.d] 01-set-timezone: executing...
jvb_1 | [cont-init.d] 01-set-timezone: exited 0.
jvb_1 | [cont-init.d] 10-config: executing...
jvb_1 | [cont-init.d] 10-config: exited 0.
jvb_1 | [cont-init.d] done.
jvb_1 | [services.d] starting services
jvb_1 | [services.d] done.
jicofo_1 | [s6-init] making user provided files available at /var/run/s6/etc...exited 0.
jicofo_1 | [s6-init] ensuring user provided files have correct perms...exited 0.
jicofo_1 | [fix-attrs.d] applying ownership & permissions fixes...
jicofo_1 | [fix-attrs.d] done.
jicofo_1 | [cont-init.d] executing container initialization scripts...
jicofo_1 | [cont-init.d] 01-set-timezone: executing...
jicofo_1 | [cont-init.d] 01-set-timezone: exited 0.
jicofo_1 | [cont-init.d] 10-config: executing...
jicofo_1 | [cont-init.d] 10-config: exited 0.
jicofo_1 | [cont-init.d] done.
jicofo_1 | [services.d] starting services
jicofo_1 | [services.d] done.
web_1 | [s6-init] making user provided files available at /var/run/s6/etc...exited 0.
web_1 | [s6-init] ensuring user provided files have correct perms...exited 0.
web_1 | [fix-attrs.d] applying ownership & permissions fixes...
prosody_1 | [s6-init] making user provided files available at /var/run/s6/etc...exited 0.
web_1 | [fix-attrs.d] done.
web_1 | [cont-init.d] executing container initialization scripts...
web_1 | [cont-init.d] 01-set-timezone: executing...
web_1 | [cont-init.d] 01-set-timezone: exited 0.
web_1 | [cont-init.d] 10-config: executing...
web_1 | /opt /
web_1 | [Mon Dec 6 23:20:26 UTC 2021] Installing to /config/acme.sh
web_1 | [Mon Dec 6 23:20:26 UTC 2021] Installed to /config/acme.sh/acme.sh
web_1 | [Mon Dec 6 23:20:26 UTC 2021] Installing alias to '/root/.profile'
web_1 | [Mon Dec 6 23:20:26 UTC 2021] OK, Close and reopen your terminal to start using acme.sh
web_1 | [Mon Dec 6 23:20:26 UTC 2021] Installing cron job
web_1 | 42 0 * * * "/config/acme.sh"/acme.sh --cron --home "/config/acme.sh" > /dev/null
web_1 | [Mon Dec 6 23:20:26 UTC 2021] Good, bash is found, so change the shebang to use bash as preferred.
web_1 | [Mon Dec 6 23:20:26 UTC 2021] OK
web_1 | /
web_1 | [Mon Dec 6 23:20:27 UTC 2021] Domains not changed.
web_1 | [Mon Dec 6 23:20:27 UTC 2021] Skip, Next renewal time is: Fri Feb 4 19:42:43 UTC 2022
web_1 | [Mon Dec 6 23:20:27 UTC 2021] Add '--force' to force to renew.
web_1 | [cont-init.d] 10-config: exited 0.
web_1 | [cont-init.d] done.
web_1 | [services.d] starting services
web_1 | [services.d] done.
prosody_1 | [s6-init] ensuring user provided files have correct perms...exited 0.
prosody_1 | [fix-attrs.d] applying ownership & permissions fixes...
prosody_1 | [fix-attrs.d] done.
prosody_1 | [cont-init.d] executing container initialization scripts...
prosody_1 | [cont-init.d] 01-set-timezone: executing...
prosody_1 | [cont-init.d] 01-set-timezone: exited 0.
prosody_1 | [cont-init.d] 10-config: executing...
prosody_1 | mv: cannot stat '/config/data/*.crt': No such file or directory
prosody_1 | mv: cannot stat '/config/data/*.key': No such file or directory
prosody_1 | [cont-init.d] 10-config: exited 0.
prosody_1 | [cont-init.d] done.
prosody_1 | [services.d] starting services
prosody_1 | [services.d] done.
prosody_1 | saslauthd[236] :num_procs : 5
prosody_1 | saslauthd[236] :mech_option: /etc/saslauthd.conf
prosody_1 | saslauthd[236] :run_path : /var/run/saslauthd
prosody_1 | saslauthd[236] :auth_mech : ldap
prosody_1 | saslauthd[236] :mmaped shared memory segment on file: /var/run/saslauthd/cache.mmap
prosody_1 | saslauthd[236] :bucket size: 96 bytes
prosody_1 | saslauthd[236] :stats size : 36 bytes
prosody_1 | saslauthd[236] :timeout : 28800 seconds
prosody_1 | saslauthd[236] :cache table: 985828 total bytes
prosody_1 | saslauthd[236] :cache table: 1711 slots
prosody_1 | saslauthd[236] :cache table: 10266 buckets
prosody_1 | saslauthd[236] :flock file opened at /var/run/saslauthd/cache.flock
prosody_1 | saslauthd[236] :using accept lock file: /var/run/saslauthd/mux.accept
prosody_1 | saslauthd[236] :master pid is: 0
prosody_1 | saslauthd[236] :listening on socket: /var/run/saslauthd/mux
prosody_1 | saslauthd[236] :using process model
prosody_1 | saslauthd[236] :forked child: 251
prosody_1 | saslauthd[236] :forked child: 252
prosody_1 | saslauthd[236] :forked child: 253
prosody_1 | saslauthd[236] :forked child: 254
prosody_1 | saslauthd[236] :acquired accept lock
prosody_1 | startup info Hello and welcome to Prosody version 0.11.10
prosody_1 | startup info Prosody is using the epoll backend for connection handling
prosody_1 | portmanager info Activated service 'c2s' on [::]:5222, [*]:5222
prosody_1 | portmanager info Activated service 'legacy_ssl' on no ports
prosody_1 | wus.host.org:tls info Certificates loaded
prosody_1 | portmanager info Activated service 'http' on [::]:5280, [*]:5280
prosody_1 | portmanager info Activated service 'https' on no ports
prosody_1 | muc.wus.host.org:tls info Certificates loaded
prosody_1 | internal.auth.wus.host.org:tls info Certificates loaded
prosody_1 | general info Starting conference duration timer for muc.wus.host.org
prosody_1 | conferenceduration.wus.host.org:conference_duration_component info Hook to muc events on muc.wus.host.org
prosody_1 | conferenceduration.wus.host.org:tls info Certificates loaded
prosody_1 | focus.wus.host.org:tls info Certificates loaded
prosody_1 | lobby.wus.host.org:tls info Certificates loaded
prosody_1 | wus.host.org:muc_lobby_rooms info Lobby component loaded lobby.wus.host.org
prosody_1 | avmoderation.wus.host.org:av_moderation_component info Starting av_moderation for muc.wus.host.org
prosody_1 | avmoderation.wus.host.org:av_moderation_component info Hook to muc events on muc.wus.host.org
prosody_1 | avmoderation.wus.host.org:tls info Certificates loaded
prosody_1 | auth.wus.host.org:tls info Certificates loaded
prosody_1 | general info Starting speakerstats for muc.wus.host.org
prosody_1 | speakerstats.wus.host.org:speakerstats_component info Hook to muc events on muc.wus.host.org
prosody_1 | speakerstats.wus.host.org:tls info Certificates loaded
prosody_1 | recorder.wus.host.org:tls info Certificates loaded
jibri_1 | [s6-init] making user provided files available at /var/run/s6/etc...exited 0.
jibri_1 | [s6-init] ensuring user provided files have correct perms...exited 0.
jibri_1 | [fix-attrs.d] applying ownership & permissions fixes...
jibri_1 | [fix-attrs.d] done.
jibri_1 | [cont-init.d] executing container initialization scripts...
jibri_1 | [cont-init.d] 01-set-timezone: executing...
jibri_1 | [cont-init.d] 01-set-timezone: exited 0.
jibri_1 | [cont-init.d] 10-config: executing...
jibri_1 | [cont-init.d] 10-config: exited 0.
jibri_1 | [cont-init.d] done.
jibri_1 | [services.d] starting services
jibri_1 | icewmbg: Can't open display: :0. X must be running and $DISPLAY set.
jibri_1 | _XSERVTrans[services.d] done.
jibri_1 | mkdir: Owner of /tmp/.X11-unix should be set to root
jibri_1 |
jibri_1 | X.Org X Server 1.20.4
jibri_1 | X Protocol Version 11, Revision 0
jibri_1 | Build Operating System: Linux 5.10.0-6-amd64 x86_64 Debian
jibri_1 | Current Operating System: Linux 3ed9770a3173 4.19.0-18-amd64 #1 SMP Debian 4.19.208-1 (2021-09-29) x86_64
jibri_1 | Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.19.0-18-amd64 root=UUID=c88d3b20-0d89-4302-a811-35bb50354b23 ro consoleblank=0 quiet
jibri_1 | Build Date: 19 April 2021 09:34:38AM
jibri_1 | xorg-server 2:1.20.4-1+deb10u3 (https://www.debian.org/support)
jibri_1 | Current version of pixman: 0.36.0
jibri_1 | Before reporting problems, check http://wiki.x.org
jibri_1 | to make sure that you have the latest version.
jibri_1 | Markers: (--) probed, (**) from config file, (==) default setting,
jibri_1 | (++) from command line, (!!) notice, (II) informational,
jibri_1 | (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
jibri_1 | (++) Log file: "/tmp/xorg.log", Time: Mon Dec 6 23:20:28 2021
jibri_1 | (++) Using config file: "/etc/jitsi/jibri/xorg-video-dummy.conf"
jibri_1 | (==) Using system config directory "/usr/share/X11/xorg.conf.d"
jicofo_1 | Dec 06, 2021 11:20:28 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Starting Jicofo.
jicofo_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Initialized newConfig: merge of /config/jicofo.conf: 1,system properties,reference.conf @ jar:file:/usr/share/jicofo/jicofo.jar!/reference.conf: 1
jvb_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Initialized newConfig: merge of /config/jvb.conf: 1,application.conf @ jar:file:/usr/share/jitsi-videobridge/jitsi-videobridge.jar!/application.conf: 1,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/ice4j-3.0-35-gadca67b.jar!/reference.conf: 1,reference.conf @ jar:file:/usr/share/jitsi-videobridge/lib/jitsi-media-transform-1.0-261-g7b0aeed.jar!/reference.conf: 1
jvb_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: loading config file at path /config/sip-communicator.properties
jicofo_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: net.java.sip.communicator.SC_HOME_DIR_LOCATION not set
jicofo_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Initialized legacyConfig: sip communicator props (no description provided)
jvb_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Error loading config file: java.io.FileNotFoundException: /config/sip-communicator.properties (No such file or directory)
jicofo_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Reloading the Typesafe config source (previously reloaded 0 times).
jvb_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Initialized legacyConfig: sip communicator props (no description provided)
jvb_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Reloading the Typesafe config source (previously reloaded 0 times).
jibri_1 | 2021-12-06 23:20:29.796 INFO: [1] org.jitsi.jibri.Main.log() Jibri run with args [--config, /etc/jitsi/jibri/config.json]
jvb_1 | Dec 06, 2021 11:20:29 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Starting jitsi-videobridge version 2.1.570-gb802be83
jibri_1 | 2021-12-06 23:20:30.247 INFO: [1] org.jitsi.jibri.Main.log() Checking legacy config file /etc/jitsi/jibri/config.json
jibri_1 | 2021-12-06 23:20:30.251 INFO: [1] org.jitsi.jibri.Main.log() Legacy config file /etc/jitsi/jibri/config.json doesn't exist
prosody_1 | c2s5645c6c6a3d0 info Client connected
jibri_1 | 2021-12-06 23:20:31.282 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | LambdaSupplier: 'JibriConfig::jibriId'
jibri_1 | ConfigSourceSupplier: key: 'jibri.id', type: 'kotlin.String', source: 'config'
jibri_1 | 2021-12-06 23:20:31.292 FINE: [1] org.jitsi.jibri.config.log() LambdaSupplier: Trying to retrieve value via JibriConfig::jibriId
jibri_1 | 2021-12-06 23:20:31.296 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via LambdaSupplier: 'JibriConfig::jibriId': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$Error: class java.lang.NullPointerException
jibri_1 | 2021-12-06 23:20:31.298 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.id' from source 'config' as type kotlin.String
jibri_1 | 2021-12-06 23:20:31.433 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.id' from source 'config' as type kotlin.String
jvb_1 | Dec 06, 2021 11:20:31 PM org.ice4j.ice.harvest.MappingCandidateHarvesters initialize
jvb_1 | INFO: Using AwsCandidateHarvester.
jibri_1 | 2021-12-06 23:20:31.446 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.id', type: 'kotlin.String', source: 'config'
jibri_1 | 2021-12-06 23:20:31.452 INFO: [1] org.jitsi.jibri.Main.log() Jibri starting up with id jibri-411488482
jibri_1 | 2021-12-06 23:20:31.471 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | LambdaSupplier: 'JibriConfig::enableStatsD'
jibri_1 | ConfigSourceSupplier: key: 'jibri.stats.enable-stats-d', type: 'kotlin.Boolean', source: 'config'
jibri_1 | 2021-12-06 23:20:31.481 FINE: [1] org.jitsi.jibri.config.log() LambdaSupplier: Trying to retrieve value via JibriConfig::enableStatsD
jibri_1 | 2021-12-06 23:20:31.484 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via LambdaSupplier: 'JibriConfig::enableStatsD': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$Error: class java.lang.NullPointerException
jibri_1 | 2021-12-06 23:20:31.491 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.stats.enable-stats-d' from source 'config' as type kotlin.Boolean
jibri_1 | 2021-12-06 23:20:31.495 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.stats.enable-stats-d' from source 'config' as type kotlin.Boolean
jibri_1 | 2021-12-06 23:20:31.499 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.stats.enable-stats-d', type: 'kotlin.Boolean', source: 'config'
jibri_1 | 2021-12-06 23:20:31.594 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | ConfigSourceSupplier: key: 'jibri.webhook.subscribers', type: 'kotlin.collections.List<kotlin.String>', source: 'config'
jibri_1 | 2021-12-06 23:20:31.607 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.webhook.subscribers' from source 'config' as type kotlin.collections.List<kotlin.String>
jibri_1 | 2021-12-06 23:20:31.639 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.webhook.subscribers' from source 'config' as type kotlin.collections.List<kotlin.String>
jibri_1 | 2021-12-06 23:20:31.641 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.webhook.subscribers', type: 'kotlin.collections.List<kotlin.String>', source: 'config'
jicofo_1 | Dec 06, 2021 11:20:31 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Initialized octoId=1
prosody_1 | c2s5645c6c6a3d0 info Authenticated as h-eosfhukk8ecy40@wus.host.org
jicofo_1 | Dec 06, 2021 11:20:31 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Authentication service disabled.
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.StunMappingCandidateHarvester discover
jvb_1 | INFO: Discovered public address 45.77.188.121:59699/udp from STUN server 129.146.230.229:443/udp using local address org.ice4j.socket.IceUdpSocketWrapper@4af4079b
jicofo_1 | Dec 06, 2021 11:20:32 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | WARNING: Disabling TLS certificate verification!
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.AwsCandidateHarvester obtainEC2Addresses
jvb_1 | INFO: We failed to obtain EC2 instance addresses for the following reason:
jvb_1 | java.lang.IllegalArgumentException: hostname can't be null
jvb_1 | at java.base/java.net.InetSocketAddress.checkHost(InetSocketAddress.java:149)
jvb_1 | at java.base/java.net.InetSocketAddress.<init>(InetSocketAddress.java:216)
jvb_1 | at org.ice4j.TransportAddress.<init>(TransportAddress.java:61)
jvb_1 | at org.ice4j.ice.harvest.AwsCandidateHarvester.obtainEC2Addresses(AwsCandidateHarvester.java:111)
jvb_1 | at org.ice4j.ice.harvest.AwsCandidateHarvester.getFace(AwsCandidateHarvester.java:153)
jvb_1 | at org.ice4j.ice.harvest.MappingCandidateHarvesters.maybeAdd(MappingCandidateHarvesters.java:189)
jvb_1 | at org.ice4j.ice.harvest.MappingCandidateHarvesters.prune(MappingCandidateHarvesters.java:173)
jvb_1 | at org.ice4j.ice.harvest.MappingCandidateHarvesters.initialize(MappingCandidateHarvesters.java:149)
jvb_1 | at org.jitsi.videobridge.MainKt$startIce4j$1.invoke(Main.kt:230)
jvb_1 | at org.jitsi.videobridge.MainKt$startIce4j$1.invoke(Main.kt:229)
jvb_1 | at kotlin.concurrent.ThreadsKt$thread$thread$1.run(Thread.kt:30)
jvb_1 |
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.AwsCandidateHarvester obtainEC2Addresses
jvb_1 | INFO: String for local IP: null
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.AwsCandidateHarvester obtainEC2Addresses
jvb_1 | INFO: String for public IP: 45.77.188.121
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.MappingCandidateHarvesters maybeAdd
jvb_1 | INFO: Discarding a mapping harvester: org.ice4j.ice.harvest.AwsCandidateHarvester@6a6fd808
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.MappingCandidateHarvesters initialize
jvb_1 | INFO: Using org.ice4j.ice.harvest.StunMappingCandidateHarvester@5831d07e
jvb_1 | Dec 06, 2021 11:20:32 PM org.ice4j.ice.harvest.MappingCandidateHarvesters initialize
jvb_1 | INFO: Initialized mapping harvesters (delay=2633ms). stunDiscoveryFailed=false
jicofo_1 | Dec 06, 2021 11:20:32 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: No dedicated Service XMPP connection configured, re-using the client XMPP connection.
prosody_1 | c2s5645c6c6a3d0 info Client disconnected: connection closed
web_1 | 185.159.157.20 - - [06/Dec/2021:23:20:32 +0000] "GET /xmpp-websocket?room=interestingclothingsclarifyhysterically&previd=1bf96288-6878-487a-93ad-6fe35b047e5c HTTP/1.1" 101 1160 "-" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
jicofo_1 | Dec 06, 2021 11:20:32 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: No Jigasi detector configured.
jicofo_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Using org.jitsi.jicofo.bridge.SingleBridgeSelectionStrategy
prosody_1 | c2s5645c6f06790 info Client connected
jvb_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Initializing a new MucClient for [ org.jitsi.xmpp.mucclient.MucClientConfiguration id=shard domain=auth.wus.host.org hostname=wus.host.org port=null username=jvb mucs=[jvbbrewery@internal.auth.wus.host.org] mucNickname=9b11a06e678c disableCertificateVerification=true]
jicofo_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Initialized with JID=jvbbrewery@internal.auth.wus.host.org
jvb_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | WARNING: Disabling certificate verification!
jibri_1 | 2021-12-06 23:20:33.511 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.jwt-info' from source 'config' as type com.typesafe.config.ConfigObject
jvb_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: LastNReducer with reductionScale: 0.75 recoverScale: 1.25 impactTime: PT1M minLastN: 1 maxEnforcedLastN: 40
jvb_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: TaskPools detected 2 processors, creating the CPU pool with that many threads
jibri_1 | 2021-12-06 23:20:33.589 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.jwt-info' from source 'config' as type com.typesafe.config.ConfigObject
jibri_1 | 2021-12-06 23:20:33.597 INFO: [1] org.jitsi.jibri.webhooks.v1.JwtInfo.log() got jwtConfig: {}
jibri_1 |
jibri_1 | 2021-12-06 23:20:33.611 INFO: [1] org.jitsi.jibri.webhooks.v1.JwtInfo.log() Unable to create JwtInfo: com.typesafe.config.ConfigException$Missing: reference.conf @ jar:file:/opt/jitsi/jibri/jibri.jar!/reference.conf: 63: No configuration setting found for key 'signing-key-path'
jvb_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | 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.
jvb_1 | Dec 06, 2021 11:20:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Starting with 60 second interval.
jibri_1 | 2021-12-06 23:20:34.139 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | ConfigSourceSupplier: key: 'internal_http_port', type: 'kotlin.Int', source: 'command line args'
jibri_1 | ConfigSourceSupplier: key: 'jibri.api.http.internal-api-port', type: 'kotlin.Int', source: 'config'
jibri_1 | 2021-12-06 23:20:34.167 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'internal_http_port' from source 'command line args' as type kotlin.Int
jibri_1 | 2021-12-06 23:20:34.168 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via ConfigSourceSupplier: key: 'internal_http_port', type: 'kotlin.Int', source: 'command line args': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$NotFound: not found
jibri_1 | 2021-12-06 23:20:34.168 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.api.http.internal-api-port' from source 'config' as type kotlin.Int
jvb_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Started with interval=10000, timeout=PT30S, maxDuration=PT3S, stickyFailures=false.
jibri_1 | 2021-12-06 23:20:34.201 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.api.http.internal-api-port' from source 'config' as type kotlin.Int
jibri_1 | 2021-12-06 23:20:34.201 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.api.http.internal-api-port', type: 'kotlin.Int', source: 'config'
jibri_1 | 2021-12-06 23:20:34.202 INFO: [1] org.jitsi.jibri.Main.log() Using port 3333 for internal HTTP API
jibri_1 | SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
jibri_1 | SLF4J: Defaulting to no-operation (NOP) logger implementation
jibri_1 | SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
jibri_1 | 2021-12-06 23:20:34.292 FINE: [18] org.jitsi.jibri.webhooks.v1.WebhookClient.log() Updating 0 subscribers of status
jvb_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Not starting CallstatsService, disabled in configuration.
jvb_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Starting public http server
jvb_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Dispatching a thread to connect and login.
prosody_1 | c2s5645c6f06790 info Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
prosody_1 | c2s5645c6d4d5d0 info Client connected
jicofo_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Connected, JID= null
jvb_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Base URL: wss://wus.host.org/colibri-ws/172.19.0.4
jicofo_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Initialized with JID=jibribrewery@internal.auth.wus.host.org
jicofo_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: No SIP Jibri detector configured.
prosody_1 | c2s5645c6f06790 info Authenticated as focus@auth.wus.host.org
prosody_1 | auth.wus.host.org:limits_exception info Setting stanza size limits for focus@auth.wus.host.org to 10485760
jicofo_1 | Dec 06, 2021 11:20:34 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Starting HTTP server with config: host=null, port=8888, tlsPort=8843, isTls=false, keyStorePath=null, sendServerVersion=true.
jibri_1 | 2021-12-06 23:20:34.957 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | LambdaSupplier: 'JibriConfig::xmppEnvironments'
jibri_1 | TypeConvertingSupplier: converting value from ConfigSourceSupplier: key: 'jibri.api.xmpp.environments', type: 'kotlin.collections.List<com.typesafe.config.Config>', source: 'config'
jibri_1 | 2021-12-06 23:20:34.962 FINE: [1] org.jitsi.jibri.config.log() LambdaSupplier: Trying to retrieve value via JibriConfig::xmppEnvironments
jibri_1 | 2021-12-06 23:20:34.975 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via LambdaSupplier: 'JibriConfig::xmppEnvironments': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$NotFound: Considering empty XMPP envs list as not found
jibri_1 | 2021-12-06 23:20:34.980 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.api.xmpp.environments' from source 'config' as type kotlin.collections.List<com.typesafe.config.Config>
jibri_1 | 2021-12-06 23:20:34.984 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.api.xmpp.environments' from source 'config' as type kotlin.collections.List<com.typesafe.config.Config>
jibri_1 | 2021-12-06 23:20:34.997 FINE: [1] org.jitsi.jibri.config.log() TypeConvertingSupplier: Converted value type from ConfigSourceSupplier: key: 'jibri.api.xmpp.environments', type: 'kotlin.collections.List<com.typesafe.config.Config>', source: 'config'
jibri_1 | 2021-12-06 23:20:35.004 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: value found via TypeConvertingSupplier: converting value from ConfigSourceSupplier: key: 'jibri.api.xmpp.environments', type: 'kotlin.collections.List<com.typesafe.config.Config>', source: 'config'
jicofo_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Discovered av_moderation component at avmoderation.wus.host.org.
jvb_1 | Dec 06, 2021 11:20:35 PM org.eclipse.jetty.util.log.Log initialized
jvb_1 | INFO: Logging initialized @7077ms to org.eclipse.jetty.util.log.JavaUtilLog
jicofo_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Joined the room.
jicofo_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Joined the room.
jicofo_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Set replyTimeout=PT15S
jvb_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Registering servlet at /colibri-ws/*, baseUrl = wss://wus.host.org/colibri-ws/172.19.0.4
jvb_1 | Dec 06, 2021 11:20:35 PM org.eclipse.jetty.server.Server doStart
jvb_1 | INFO: jetty-9.4.40.v20210413; built: 2021-04-13T20:42:42.668Z; git: b881a572662e1943a14ae12e7e1207989f218b74; jvm 11.0.12+7-post-Debian-2deb10u1
jibri_1 | 2021-12-06 23:20:35.712 INFO: [1] org.jitsi.jibri.api.xmpp.XmppApi.log() Jibri reports its status is now JibriStatus(busyStatus=IDLE, health=OverallHealth(healthStatus=HEALTHY, details={})), publishing presence to connections
jibri_1 | 2021-12-06 23:20:35.722 FINE: [1] org.jitsi.xmpp.mucclient.MucClientManager.log() Setting a presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@174e1b69
prosody_1 | c2s5645c6d4d5d0 info Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
jicofo_1 | Dec 06, 2021 11:20:35 PM org.eclipse.jetty.util.log.Log initialized
jicofo_1 | INFO: Logging initialized @7936ms to org.eclipse.jetty.util.log.Slf4jLog
jvb_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Connected.
jvb_1 | Dec 06, 2021 11:20:35 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Logging in.
jibri_1 | 2021-12-06 23:20:35.755 INFO: [1] org.jitsi.jibri.api.xmpp.XmppApi.log() Connecting to xmpp environment on wus.host.org with config XmppEnvironmentConfig(name=<no value>, xmppServerHosts=[wus.host.org], xmppDomain=wus.host.org, baseUrl=https://wus.host.org, controlLogin=XmppCredentials(domain=auth.wus.host.org, port=null, username=jibri, password=*****), controlMuc=XmppMuc(domain=internal.auth.wus.host.org, roomName=jibribrewery, nickname=jibri-411488482), sipControlMuc=null, callLogin=XmppCredentials(domain=recorder.wus.host.org, port=null, username=recorder, password=*****), stripFromRoomDomain=muc., usageTimeoutMins=0, trustAllXmppCerts=true)
jibri_1 | 2021-12-06 23:20:35.763 INFO: [1] org.jitsi.jibri.api.xmpp.XmppApi.log() The trustAllXmppCerts config is enabled for this domain, all XMPP server provided certificates will be accepted
jibri_1 | 2021-12-06 23:20:35.847 FINE: [27] org.jitsi.xmpp.mucclient.MucClient.log() Initializing a new MucClient for [ org.jitsi.xmpp.mucclient.MucClientConfiguration id=wus.host.org domain=auth.wus.host.org hostname=wus.host.org port=null username=jibri mucs=[jibribrewery@internal.auth.wus.host.org] mucNickname=jibri-411488482 disableCertificateVerification=true]
jibri_1 | 2021-12-06 23:20:35.863 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | ConfigSourceSupplier: key: 'http_api_port', type: 'kotlin.Int', source: 'command line args'
jibri_1 | ConfigSourceSupplier: key: 'jibri.api.http.external-api-port', type: 'kotlin.Int', source: 'config'
jibri_1 | 2021-12-06 23:20:35.863 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'http_api_port' from source 'command line args' as type kotlin.Int
jibri_1 | 2021-12-06 23:20:35.864 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via ConfigSourceSupplier: key: 'http_api_port', type: 'kotlin.Int', source: 'command line args': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$NotFound: not found
jibri_1 | 2021-12-06 23:20:35.867 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.api.http.external-api-port' from source 'config' as type kotlin.Int
jibri_1 | 2021-12-06 23:20:35.879 FINE: [1] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.api.http.external-api-port' from source 'config' as type kotlin.Int
jibri_1 | 2021-12-06 23:20:35.880 FINE: [1] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.api.http.external-api-port', type: 'kotlin.Int', source: 'config'
jibri_1 | 2021-12-06 23:20:35.880 INFO: [1] org.jitsi.jibri.Main.log() Using port 2222 for HTTP API
jibri_1 | 2021-12-06 23:20:35.902 WARNING: [27] org.jitsi.xmpp.mucclient.MucClient.log() Disabling certificate verification!
jicofo_1 | Dec 06, 2021 11:20:36 PM org.eclipse.jetty.server.Server doStart
jicofo_1 | INFO: jetty-9.4.41.v20210516; built: 2021-05-16T23:56:28.993Z; git: 98607f93c7833e7dc59489b13f3cb0a114fb9f4c; jvm 11.0.12+7-post-Debian-2deb10u1
jibri_1 | 2021-12-06 23:20:36.051 FINE: [27] org.jitsi.xmpp.mucclient.MucClient.log() About to connect and login.
prosody_1 | c2s5645c6dcf630 info Client connected
prosody_1 | c2s5645c6d4d5d0 info Authenticated as jvb@auth.wus.host.org
prosody_1 | auth.wus.host.org:limits_exception info Setting stanza size limits for jvb@auth.wus.host.org to 10485760
jvb_1 | Dec 06, 2021 11:20:36 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Authenticated, b=false
jvb_1 | Dec 06, 2021 11:20:36 PM org.eclipse.jetty.server.handler.ContextHandler doStart
jvb_1 | INFO: Started o.e.j.s.ServletContextHandler@7e0aadd0{/,null,AVAILABLE}
jvb_1 | Dec 06, 2021 11:20:36 PM org.eclipse.jetty.server.AbstractConnector doStart
jvb_1 | INFO: Started ServerConnector@6c67e137{HTTP/1.1, (http/1.1)}{0.0.0.0:9090}
jvb_1 | Dec 06, 2021 11:20:36 PM org.eclipse.jetty.server.Server doStart
jvb_1 | INFO: Started @8391ms
jvb_1 | Dec 06, 2021 11:20:36 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Starting private http server
jvb_1 | Dec 06, 2021 11:20:36 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Joined MUC: jvbbrewery@internal.auth.wus.host.org
prosody_1 | c2s5645c6dcf630 info Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
jibri_1 | 2021-12-06 23:20:36.751 INFO: [27] org.jitsi.xmpp.mucclient.MucClient.log() Connected.
jibri_1 | 2021-12-06 23:20:36.752 INFO: [27] org.jitsi.xmpp.mucclient.MucClient.log() Logging in.
jvb_1 | Dec 06, 2021 11:20:36 PM org.eclipse.jetty.server.Server doStart
jvb_1 | INFO: jetty-9.4.40.v20210413; built: 2021-04-13T20:42:42.668Z; git: b881a572662e1943a14ae12e7e1207989f218b74; jvm 11.0.12+7-post-Debian-2deb10u1
prosody_1 | c2s5645c6dcf630 info Authenticated as jibri@auth.wus.host.org
jibri_1 | 2021-12-06 23:20:36.947 FINE: [27] org.jitsi.xmpp.mucclient.MucClient.log() Authenticated, b=false
jibri_1 | 2021-12-06 23:20:36.948 FINE: [27] org.jitsi.xmpp.mucclient.MucClient.log() About to join MUCs: [jibribrewery@internal.auth.wus.host.org]
jibri_1 | 2021-12-06 23:20:36.999 INFO: [27] org.jitsi.xmpp.mucclient.MucClient.log() Joined MUC: jibribrewery@internal.auth.wus.host.org
jibri_1 | 2021-12-06 23:20:37.017 FINE: [39] org.jitsi.xmpp.extensions.DefaultPacketExtensionProvider.parse() Could not add a provider for element busy-status from namespace http://jitsi.org/protocol/jibri
jibri_1 | 2021-12-06 23:20:37.026 FINE: [39] org.jitsi.xmpp.extensions.DefaultPacketExtensionProvider.parse() Could not add a provider for element health-status from namespace http://jitsi.org/protocol/health
jicofo_1 | Dec 06, 2021 11:20:37 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Added brewery instance: jibribrewery@internal.auth.wus.host.org/jibri-411488482
jicofo_1 | Dec 06, 2021 11:20:37 PM org.glassfish.jersey.server.wadl.WadlFeature configure
jicofo_1 | WARNING: JAXBContext implementation could not be found. WADL feature is disabled.
jicofo_1 | Dec 06, 2021 11:20:37 PM org.glassfish.jersey.internal.inject.Providers checkProviderRuntime
jicofo_1 | WARNING: A provider org.jitsi.rest.Version registered in SERVER runtime does not implement any provider interfaces applicable in the SERVER runtime. Due to constraint configuration problems the provider org.jitsi.rest.Version will be ignored.
jvb_1 | Dec 06, 2021 11:20:37 PM org.glassfish.jersey.server.wadl.WadlFeature configure
jvb_1 | WARNING: JAXBContext implementation could not be found. WADL feature is disabled.
jvb_1 | Dec 06, 2021 11:20:38 PM org.glassfish.jersey.internal.inject.Providers checkProviderRuntime
jvb_1 | WARNING: A provider org.jitsi.rest.Health registered in SERVER runtime does not implement any provider interfaces applicable in the SERVER runtime. Due to constraint configuration problems the provider org.jitsi.rest.Health will be ignored.
jvb_1 | Dec 06, 2021 11:20:38 PM org.glassfish.jersey.internal.inject.Providers checkProviderRuntime
jvb_1 | WARNING: A provider org.jitsi.rest.Version registered in SERVER runtime does not implement any provider interfaces applicable in the SERVER runtime. Due to constraint configuration problems the provider org.jitsi.rest.Version will be ignored.
jicofo_1 | Dec 06, 2021 11:20:38 PM org.eclipse.jetty.server.handler.ContextHandler doStart
jicofo_1 | INFO: Started o.e.j.s.ServletContextHandler@3d88e6b9{/,null,AVAILABLE}
jicofo_1 | Dec 06, 2021 11:20:38 PM org.eclipse.jetty.server.AbstractConnector doStart
jicofo_1 | INFO: Started ServerConnector@6ea04618{HTTP/1.1, (http/1.1)}{0.0.0.0:8888}
jicofo_1 | Dec 06, 2021 11:20:38 PM org.eclipse.jetty.server.Server doStart
jicofo_1 | INFO: Started @10804ms
jvb_1 | Dec 06, 2021 11:20:39 PM org.eclipse.jetty.server.handler.ContextHandler doStart
jvb_1 | INFO: Started o.e.j.s.ServletContextHandler@4f94e148{/,null,AVAILABLE}
jvb_1 | Dec 06, 2021 11:20:39 PM org.eclipse.jetty.server.AbstractConnector doStart
jvb_1 | INFO: Started ServerConnector@5b69fd74{HTTP/1.1, (http/1.1)}{0.0.0.0:8080}
jvb_1 | Dec 06, 2021 11:20:39 PM org.eclipse.jetty.server.Server doStart
jvb_1 | INFO: Started @10931ms
jicofo_1 | Dec 06, 2021 11:20:39 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Added brewery instance: jvbbrewery@internal.auth.wus.host.org/9b11a06e678c
jicofo_1 | Dec 06, 2021 11:20:39 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Added new videobridge: Bridge[jid=jvbbrewery@internal.auth.wus.host.org/9b11a06e678c, relayId=null, region=null, stress=0.00]
jicofo_1 | Dec 06, 2021 11:20:39 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Scheduled health-check task for: jvbbrewery@internal.auth.wus.host.org/9b11a06e678c
jvb_1 | Dec 06, 2021 11:20:44 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.001992S. Sticky failure: false
jvb_1 | Dec 06, 2021 11:20:54 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.000016S. Sticky failure: false
web_1 | 185.159.157.20 - - [06/Dec/2021:23:21:01 +0000] "GET /InterestingClothingsClarifyHysterically HTTP/2.0" 200 25711 "https://wus.host.org/InterestingClothingsClarifyHysterically" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
web_1 | 185.159.157.20 - - [06/Dec/2021:23:21:01 +0000] "GET /libs/do_external_connect.min.js?v=1 HTTP/2.0" 200 1943 "https://wus.host.org/InterestingClothingsClarifyHysterically" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
web_1 | 185.159.157.20 - - [06/Dec/2021:23:21:02 +0000] "GET /libs/lib-jitsi-meet.min.js?v=5415 HTTP/2.0" 200 229080 "https://wus.host.org/InterestingClothingsClarifyHysterically" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
web_1 | 185.159.157.20 - - [06/Dec/2021:23:21:02 +0000] "GET /libs/app.bundle.min.js?v=5415 HTTP/2.0" 200 1366294 "https://wus.host.org/InterestingClothingsClarifyHysterically" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
jvb_1 | Dec 06, 2021 11:21:04 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.000038S. Sticky failure: false
prosody_1 | c2s5645c70230d0 info Client connected
prosody_1 | c2s5645c70230d0 info Authenticated as ijinihq5jcbyz_xw@wus.host.org
web_1 | 185.159.157.20 - - [06/Dec/2021:23:21:09 +0000] "GET /pwa-worker.js HTTP/2.0" 200 1499 "https://wus.host.org/pwa-worker.js" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
web_1 | 185.159.157.20 - - [06/Dec/2021:23:21:11 +0000] "GET /libs/lib-jitsi-meet.e2ee-worker.js HTTP/2.0" 200 7116 "-" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/96.0.4664.45 Safari/537.36"
jicofo_1 | Dec 06, 2021 11:21:11 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Focus request for room: interestingclothingsclarifyhysterically@muc.wus.host.org
jicofo_1 | Dec 06, 2021 11:21:11 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Created new conference.
jicofo_1 | Dec 06, 2021 11:21:11 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Joining interestingclothingsclarifyhysterically@muc.wus.host.org
jicofo_1 | Dec 06, 2021 11:21:12 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Member joined:c7c2805a
jicofo_1 | Dec 06, 2021 11:21:12 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Electing new owner: ChatMember[interestingclothingsclarifyhysterically@muc.wus.host.org/c7c2805a, jid: null]@185823943
jvb_1 | Dec 06, 2021 11:21:14 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.000016S. Sticky failure: false
jicofo_1 | Dec 06, 2021 11:21:22 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Starting session with Jibri jibribrewery@internal.auth.wus.host.org/jibri-411488482
jicofo_1 | Dec 06, 2021 11:21:22 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Starting Jibri jibribrewery@internal.auth.wus.host.org/jibri-411488482 for stream ID: null in room: interestingclothingsclarifyhysterically@muc.wus.host.org
jibri_1 | 2021-12-06 23:21:22.718 FINE: [41] org.jitsi.xmpp.mucclient.MucClient.log() Received an IQ with type set: IQ Stanza (jibri http://jitsi.org/protocol/jibri) [to=jibri@auth.wus.host.org/FyJo0RzS,from=jibribrewery@internal.auth.wus.host.org/focus,id=amlicmlAYXV0aC53dXMudmlkdGFsay5vcmcvRnlKbzBSelMANFI3QlktMzEAEx5rLUYOzkMgbFiEushBWQ==,type=set,]
jibri_1 | 2021-12-06 23:21:22.724 INFO: [41] org.jitsi.jibri.api.xmpp.XmppApi.log() Received JibriIq <iq to='jibri@auth.wus.host.org/FyJo0RzS' from='jibribrewery@internal.auth.wus.host.org/focus' id='amlicmlAYXV0aC53dXMudmlkdGFsay5vcmcvRnlKbzBSelMANFI3QlktMzEAEx5rLUYOzkMgbFiEushBWQ==' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' action='start' recording_mode='file' room='interestingclothingsclarifyhysterically@muc.wus.host.org' session_id='mdkudhjpkbyonxrp' app_data='{"file_recording_metadata":{"share":true}}'/></iq> from environment [MucClient id=wus.host.org hostname=wus.host.org]
jibri_1 | 2021-12-06 23:21:22.726 INFO: [41] org.jitsi.jibri.api.xmpp.XmppApi.log() Received start request, starting service
jibri_1 | 2021-12-06 23:21:22.911 INFO: [41] org.jitsi.jibri.api.xmpp.XmppApi.log() Parsed call url info: CallUrlInfo(baseUrl=https://wus.host.org, callName=interestingclothingsclarifyhysterically, urlParams=[])
jibri_1 | 2021-12-06 23:21:22.914 INFO: [41] org.jitsi.jibri.JibriManager.log() Starting a file recording with params: FileRecordingRequestParams(callParams=CallParams(callUrlInfo=CallUrlInfo(baseUrl=https://wus.host.org, callName=interestingclothingsclarifyhysterically, urlParams=[]), email='', passcode=null, callStatsUsernameOverride=, displayName=), sessionId=mdkudhjpkbyonxrp, callLoginParams=XmppCredentials(domain=recorder.wus.host.org, port=null, username=recorder, password=*****))
jibri_1 | 2021-12-06 23:21:22.954 FINE: [41] org.jitsi.jibri.capture.ffmpeg.FfmpegCapturer.log() Detected os as OS: LINUX
jibri_1 | 2021-12-06 23:21:22.962 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.call-status-checks.default-call-empty-timeout' from source 'config' as type java.time.Duration
jibri_1 | 2021-12-06 23:21:22.974 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.call-status-checks.default-call-empty-timeout' from source 'config' as type java.time.Duration
jibri_1 | 2021-12-06 23:21:22.986 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.chrome.flags' from source 'config' as type kotlin.collections.List<kotlin.String>
jibri_1 | 2021-12-06 23:21:22.991 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.chrome.flags' from source 'config' as type kotlin.collections.List<kotlin.String>
jibri_1 | Starting ChromeDriver 94.0.4606.61 (418b78f5838ed0b1c69bb4e51ea0252171854915-refs/branch-heads/4606@{#1204}) on port 23670
jibri_1 | Only local connections are allowed.
jibri_1 | Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
jibri_1 | ChromeDriver was started successfully.
jvb_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.000064S. Sticky failure: false
jibri_1 | 2021-12-06 23:21:24.482 INFO: [41] org.openqa.selenium.remote.ProtocolHandshake.createSession() Detected dialect: OSS
jibri_1 | 2021-12-06 23:21:24.505 FINE: [41] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | LambdaSupplier: 'JibriConfig::recordingDirectory'
jibri_1 | ConfigSourceSupplier: key: 'jibri.recording.recordings-directory', type: 'kotlin.String', source: 'config'
jibri_1 | 2021-12-06 23:21:24.505 FINE: [41] org.jitsi.jibri.config.log() LambdaSupplier: Trying to retrieve value via JibriConfig::recordingDirectory
jibri_1 | 2021-12-06 23:21:24.506 FINE: [41] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via LambdaSupplier: 'JibriConfig::recordingDirectory': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$Error: class java.lang.NullPointerException
jibri_1 | 2021-12-06 23:21:24.507 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.recording.recordings-directory' from source 'config' as type kotlin.String
jibri_1 | 2021-12-06 23:21:24.508 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.recording.recordings-directory' from source 'config' as type kotlin.String
jibri_1 | 2021-12-06 23:21:24.509 FINE: [41] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.recording.recordings-directory', type: 'kotlin.String', source: 'config'
jibri_1 | 2021-12-06 23:21:24.510 FINE: [41] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | LambdaSupplier: 'JibriConfig::finalizeRecordingScriptPath'
jibri_1 | ConfigSourceSupplier: key: 'jibri.recording.finalize-script', type: 'kotlin.String', source: 'config'
jibri_1 | 2021-12-06 23:21:24.512 FINE: [41] org.jitsi.jibri.config.log() LambdaSupplier: Trying to retrieve value via JibriConfig::finalizeRecordingScriptPath
jibri_1 | 2021-12-06 23:21:24.512 FINE: [41] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via LambdaSupplier: 'JibriConfig::finalizeRecordingScriptPath': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$Error: class java.lang.NullPointerException
jibri_1 | 2021-12-06 23:21:24.513 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.recording.finalize-script' from source 'config' as type kotlin.String
jibri_1 | 2021-12-06 23:21:24.514 FINE: [41] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.recording.finalize-script' from source 'config' as type kotlin.String
jibri_1 | 2021-12-06 23:21:24.515 FINE: [41] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.recording.finalize-script', type: 'kotlin.String', source: 'config'
jibri_1 | 2021-12-06 23:21:24.516 INFO: [41] org.jitsi.jibri.service.impl.FileRecordingJibriService.log() Writing recording to /config/recordings/mdkudhjpkbyonxrp, finalize script path /config/finalize.sh
jibri_1 | 2021-12-06 23:21:24.522 FINE: [41] org.jitsi.jibri.statsd.JibriStatsDClient.log() Incrementing statsd counter: start:recording
jibri_1 | 2021-12-06 23:21:24.523 INFO: [41] org.jitsi.jibri.status.JibriStatusManager.log() Busy status has changed: IDLE -> BUSY
jibri_1 | 2021-12-06 23:21:24.524 FINE: [41] org.jitsi.jibri.webhooks.v1.WebhookClient.log() Updating 0 subscribers of status
jibri_1 | 2021-12-06 23:21:24.525 INFO: [41] org.jitsi.jibri.api.xmpp.XmppApi.log() Jibri reports its status is now JibriStatus(busyStatus=BUSY, health=OverallHealth(healthStatus=HEALTHY, details={})), publishing presence to connections
jibri_1 | 2021-12-06 23:21:24.526 FINE: [41] org.jitsi.xmpp.mucclient.MucClientManager.log() Setting a presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@1785d32a
jibri_1 | 2021-12-06 23:21:24.526 FINE: [41] org.jitsi.xmpp.mucclient.MucClientManager.log() Replacing presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@174e1b69
jibri_1 | 2021-12-06 23:21:24.530 INFO: [41] org.jitsi.jibri.api.xmpp.XmppApi.log() Sending 'pending' response to start IQ
jibri_1 | 2021-12-06 23:21:24.534 FINE: [39] org.jitsi.xmpp.extensions.DefaultPacketExtensionProvider.parse() Could not add a provider for element busy-status from namespace http://jitsi.org/protocol/jibri
jibri_1 | 2021-12-06 23:21:24.535 FINE: [39] org.jitsi.xmpp.extensions.DefaultPacketExtensionProvider.parse() Could not add a provider for element health-status from namespace http://jitsi.org/protocol/health
jibri_1 | 2021-12-06 23:21:24.545 INFO: [54] org.jitsi.jibri.selenium.pageobjects.HomePage.log() Visiting url https://wus.host.org
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Updating status from JIBRI: <iq xmlns='jabber:client' to='focus@auth.wus.host.org/focus' from='jibribrewery@internal.auth.wus.host.org/jibri-411488482' id='4R7BY-31' type='result'><jibri xmlns='http://jitsi.org/protocol/jibri' status='pending'/></iq> for interestingclothingsclarifyhysterically@muc.wus.host.org
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Got Jibri status update: Jibri jibribrewery@internal.auth.wus.host.org/jibri-411488482 has status pending and failure reason null, current Jibri jid is jibribrewery@internal.auth.wus.host.org/jibri-411488482
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Started Jibri session
jibri_1 | 2021-12-06 23:21:24.879 SEVERE: [54] org.jitsi.jibri.selenium.JibriSelenium.log() An error occurred while joining the call
jibri_1 | org.openqa.selenium.WebDriverException: unknown error: net::ERR_CONNECTION_REFUSED
jibri_1 | (Session info: chrome=94.0.4606.61)
jibri_1 | (Driver info: chromedriver=94.0.4606.61 (418b78f5838ed0b1c69bb4e51ea0252171854915-refs/branch-heads/4606@{#1204}),platform=Linux 4.19.0-18-amd64 x86_64) (WARNING: The server did not provide any stacktrace information)
jibri_1 | Command duration or timeout: 0 milliseconds
jibri_1 | Build info: version: 'unknown', revision: 'unknown', time: 'unknown'
jibri_1 | System info: host: '3ed9770a3173', ip: '172.19.0.6', os.name: 'Linux', os.arch: 'amd64', os.version: '4.19.0-18-amd64', java.version: '11.0.12'
jibri_1 | Driver info: org.openqa.selenium.chrome.ChromeDriver
jibri_1 | Capabilities {acceptInsecureCerts: false, acceptSslCerts: false, applicationCacheEnabled: false, browserConnectionEnabled: false, browserName: chrome, chrome: {chromedriverVersion: 94.0.4606.61 (418b78f5838ed..., userDataDir: /tmp/.com.google.Chrome.zu988n}, cssSelectorsEnabled: true, databaseEnabled: false, goog:chromeOptions: {debuggerAddress: localhost:43371}, handlesAlerts: true, hasTouchScreen: false, javascriptEnabled: true, locationContextEnabled: true, mobileEmulationEnabled: false, nativeEvents: true, networkConnectionEnabled: false, pageLoadStrategy: normal, platform: LINUX, platformName: LINUX, proxy: Proxy(), rotatable: false, setWindowRect: true, strictFileInteractability: false, takesHeapSnapshot: true, takesScreenshot: true, timeouts: {implicit: 0, pageLoad: 300000, script: 30000}, unexpectedAlertBehaviour: ignore, unhandledPromptBehavior: ignore, version: 94.0.4606.61, webStorageEnabled: true, webauthn:extension:credBlob: true, webauthn:extension:largeBlob: true, webauthn:virtualAuthenticators: true}
jibri_1 | Session ID: a9332f7048fadf352fa443527e093de4
jibri_1 | at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
jibri_1 | at java.base/jdk.internal.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
jibri_1 | at java.base/jdk.internal.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
jibri_1 | at java.base/java.lang.reflect.Constructor.newInstance(Constructor.java:490)
jibri_1 | at org.openqa.selenium.remote.ErrorHandler.createThrowable(ErrorHandler.java:214)
jibri_1 | at org.openqa.selenium.remote.ErrorHandler.throwIfResponseFailed(ErrorHandler.java:166)
jibri_1 | at org.openqa.selenium.remote.http.JsonHttpResponseCodec.reconstructValue(JsonHttpResponseCodec.java:40)
jibri_1 | at org.openqa.selenium.remote.http.AbstractHttpResponseCodec.decode(AbstractHttpResponseCodec.java:80)
jibri_1 | at org.openqa.selenium.remote.http.AbstractHttpResponseCodec.decode(AbstractHttpResponseCodec.java:44)
jibri_1 | at org.openqa.selenium.remote.HttpCommandExecutor.execute(HttpCommandExecutor.java:158)
jibri_1 | at org.openqa.selenium.remote.service.DriverCommandExecutor.execute(DriverCommandExecutor.java:83)
jibri_1 | at org.openqa.selenium.remote.RemoteWebDriver.execute(RemoteWebDriver.java:543)
jibri_1 | at org.openqa.selenium.remote.RemoteWebDriver.get(RemoteWebDriver.java:271)
jibri_1 | at org.jitsi.jibri.selenium.pageobjects.AbstractPageObject.visit(AbstractPageObject.kt:35)
jibri_1 | at org.jitsi.jibri.selenium.JibriSelenium$joinCall$1.run(JibriSelenium.kt:291)
jibri_1 | at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
jibri_1 | at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
jibri_1 | at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
jibri_1 | at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
jibri_1 | at java.base/java.lang.Thread.run(Thread.java:829)
jibri_1 | 2021-12-06 23:21:24.881 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Transitioning from state Starting up to Error: FailedToJoinCall SESSION Failed to join the call
jibri_1 | 2021-12-06 23:21:24.882 INFO: [54] org.jitsi.jibri.service.impl.FileRecordingJibriService.log() File recording service transitioning from state Starting up to Error: FailedToJoinCall SESSION Failed to join the call
jibri_1 | 2021-12-06 23:21:24.884 INFO: [54] org.jitsi.jibri.api.xmpp.XmppApi.log() Current service had an error Error: FailedToJoinCall SESSION Failed to join the call, sending error iq <iq to='jibribrewery@internal.auth.wus.host.org/focus' id='jRnm2-26' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='off' failure_reason='error' should_retry='true'/></iq>
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Updating status from JIBRI: <iq xmlns='jabber:client' to='focus@auth.wus.host.org/focus' from='jibribrewery@internal.auth.wus.host.org/jibri-411488482' id='Zm9jdXNAYXV0aC53dXMudmlkdGFsay5vcmcvZm9jdXMAalJubTItMjYAOWpaCx6ViAbYzs4CP5RVMQ==' type='set'><jibri xmlns='http://jitsi.org/protocol/jibri' status='off' failure_reason='error' should_retry='true'/></iq> for interestingclothingsclarifyhysterically@muc.wus.host.org
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Got Jibri status update: Jibri jibribrewery@internal.auth.wus.host.org/jibri-411488482 has status off and failure reason error, current Jibri jid is jibribrewery@internal.auth.wus.host.org/jibri-411488482
jibri_1 | 2021-12-06 23:21:24.893 FINE: [54] org.jitsi.jibri.statsd.JibriStatsDClient.log() Incrementing statsd counter: stop:recording
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Jibri failed, trying to fall back to another Jibri
jibri_1 | 2021-12-06 23:21:24.895 INFO: [54] org.jitsi.jibri.JibriManager.log() Stopping the current service
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | SEVERE: Unable to find an available Jibri, can't start
jibri_1 | 2021-12-06 23:21:24.896 INFO: [54] org.jitsi.jibri.service.impl.FileRecordingJibriService.log() Stopping capturer
jibri_1 | 2021-12-06 23:21:24.897 INFO: [54] org.jitsi.jibri.util.JibriSubprocess.log() Stopping ffmpeg process
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | WARNING: Failed to fall back to another Jibri, this session has now failed: org.jitsi.jicofo.jibri.JibriSession$StartException$AllBusy: All jibri instances are busy
jicofo_1 | org.jitsi.jicofo.jibri.JibriSession$StartException$AllBusy: All jibri instances are busy
jicofo_1 | at org.jitsi.jicofo.jibri.JibriSession.startInternal(JibriSession.java:312)
jicofo_1 | at org.jitsi.jicofo.jibri.JibriSession.start(JibriSession.java:286)
jicofo_1 | at org.jitsi.jicofo.jibri.JibriSession.retryRequestWithAnotherJibri(JibriSession.java:602)
jicofo_1 | at org.jitsi.jicofo.jibri.JibriSession.handleJibriStatusUpdate(JibriSession.java:669)
jicofo_1 | at org.jitsi.jicofo.jibri.JibriSession.processJibriIqFromJibri(JibriSession.java:440)
jicofo_1 | at org.jitsi.jicofo.jibri.JibriSession.processJibriIqRequestFromJibri(JibriSession.java:424)
jicofo_1 | at org.jitsi.jicofo.jibri.BaseJibri.doHandleIQRequest(BaseJibri.kt:158)
jicofo_1 | at org.jitsi.jicofo.jibri.BaseJibri.incomingIqQueue$lambda-0(BaseJibri.kt:56)
jicofo_1 | at org.jitsi.utils.queue.PacketQueue$HandlerAdapter.handleItem(PacketQueue.java:381)
jicofo_1 | at org.jitsi.utils.queue.AsyncQueueHandler$1.run(AsyncQueueHandler.java:133)
jicofo_1 | at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515)
jicofo_1 | at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
jicofo_1 | at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
jicofo_1 | at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
jicofo_1 | at java.base/java.lang.Thread.run(Thread.java:829)
jicofo_1 |
jibri_1 | 2021-12-06 23:21:24.900 INFO: [54] org.jitsi.jibri.util.JibriSubprocess.log() ffmpeg exited with value null
jibri_1 | 2021-12-06 23:21:24.901 INFO: [54] org.jitsi.jibri.service.impl.FileRecordingJibriService.log() Quitting selenium
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Got jibri status off and failure error
jibri_1 | 2021-12-06 23:21:24.902 INFO: [54] org.jitsi.jibri.service.impl.FileRecordingJibriService.log() No media was recorded, deleting directory and skipping metadata file & finalize
jibri_1 | 2021-12-06 23:21:24.903 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Leaving call and quitting browser
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Publishing new jibri-recording-status: <jibri-recording-status xmlns='http://jitsi.org/protocol/jibri' status='off' failure_reason='error' session_id='mdkudhjpkbyonxrp' recording_mode='file'/> in: interestingclothingsclarifyhysterically@muc.wus.host.org
jicofo_1 | Dec 06, 2021 11:21:24 PM org.jitsi.utils.logging2.LoggerImpl log
jicofo_1 | INFO: Cleaning up current JibriSession
jibri_1 | 2021-12-06 23:21:24.911 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Recurring call status checks cancelled
jibri_1 | 2021-12-06 23:21:24.942 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Got 3 log entries for type browser
jibri_1 | 2021-12-06 23:21:24.974 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Got 141 log entries for type driver
jibri_1 | 2021-12-06 23:21:25.054 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Got 0 log entries for type client
jibri_1 | 2021-12-06 23:21:25.057 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Leaving web call
jibri_1 | 2021-12-06 23:21:25.090 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Quitting chrome driver
jibri_1 | 2021-12-06 23:21:25.166 INFO: [54] org.jitsi.jibri.selenium.JibriSelenium.log() Chrome driver quit
jibri_1 | 2021-12-06 23:21:25.167 FINE: [54] org.jitsi.jibri.config.log() FallbackSupplier: checking for value via suppliers:
jibri_1 | LambdaSupplier: 'JibriConfig::singleUseMode'
jibri_1 | ConfigSourceSupplier: key: 'jibri.single-use-mode', type: 'kotlin.Boolean', source: 'config'
jibri_1 | 2021-12-06 23:21:25.168 FINE: [54] org.jitsi.jibri.config.log() LambdaSupplier: Trying to retrieve value via JibriConfig::singleUseMode
jibri_1 | 2021-12-06 23:21:25.169 FINE: [54] org.jitsi.jibri.config.log() FallbackSupplier: failed to find value via LambdaSupplier: 'JibriConfig::singleUseMode': org.jitsi.metaconfig.ConfigException$UnableToRetrieve$Error: class java.lang.NullPointerException
jibri_1 | 2021-12-06 23:21:25.169 FINE: [54] org.jitsi.jibri.config.log() ConfigSourceSupplier: Trying to retrieve key 'jibri.single-use-mode' from source 'config' as type kotlin.Boolean
jibri_1 | 2021-12-06 23:21:25.173 FINE: [54] org.jitsi.jibri.config.log() ConfigSourceSupplier: Successfully retrieved key 'jibri.single-use-mode' from source 'config' as type kotlin.Boolean
jibri_1 | 2021-12-06 23:21:25.175 FINE: [54] org.jitsi.jibri.config.log() FallbackSupplier: value found via ConfigSourceSupplier: key: 'jibri.single-use-mode', type: 'kotlin.Boolean', source: 'config'
jibri_1 | 2021-12-06 23:21:25.175 INFO: [54] org.jitsi.jibri.status.JibriStatusManager.log() Busy status has changed: BUSY -> IDLE
jibri_1 | 2021-12-06 23:21:25.177 FINE: [54] org.jitsi.jibri.webhooks.v1.WebhookClient.log() Updating 0 subscribers of status
jibri_1 | 2021-12-06 23:21:25.179 INFO: [54] org.jitsi.jibri.api.xmpp.XmppApi.log() Jibri reports its status is now JibriStatus(busyStatus=IDLE, health=OverallHealth(healthStatus=HEALTHY, details={})), publishing presence to connections
jibri_1 | 2021-12-06 23:21:25.179 FINE: [54] org.jitsi.xmpp.mucclient.MucClientManager.log() Setting a presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@1d524772
jibri_1 | 2021-12-06 23:21:25.180 FINE: [54] org.jitsi.xmpp.mucclient.MucClientManager.log() Replacing presence extension: org.jitsi.xmpp.extensions.jibri.JibriStatusPacketExt@1785d32a
jibri_1 | 2021-12-06 23:21:25.192 FINE: [39] org.jitsi.xmpp.extensions.DefaultPacketExtensionProvider.parse() Could not add a provider for element busy-status from namespace http://jitsi.org/protocol/jibri
jibri_1 | 2021-12-06 23:21:25.193 FINE: [39] org.jitsi.xmpp.extensions.DefaultPacketExtensionProvider.parse() Could not add a provider for element health-status from namespace http://jitsi.org/protocol/health
jvb_1 | Dec 06, 2021 11:21:33 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Running expire()
jibri_1 | 2021-12-06 23:21:34.116 FINE: [18] org.jitsi.jibri.webhooks.v1.WebhookClient.log() Updating 0 subscribers of status
jvb_1 | Dec 06, 2021 11:21:34 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.000016S. Sticky failure: false
jvb_1 | Dec 06, 2021 11:21:44 PM org.jitsi.utils.logging2.LoggerImpl log
jvb_1 | INFO: Performed a successful health check in PT0.000023S. Sticky failure: false
^CGracefully stopping... (press Ctrl+C again to force)
Stopping docker-jitsi-meet-stable-6433_jibri_1 ... done
Stopping docker-jitsi-meet-stable-6433_jvb_1 ... done
Stopping docker-jitsi-meet-stable-6433_jicofo_1 ... done
Stopping docker-jitsi-meet-stable-6433_prosody_1 ... done
Stopping docker-jitsi-meet-stable-6433_web_1 ... done
