Jitsi Meet and LDAPS integration

Hello Jitsi meet community,

I would like to run Jitsi Meet under Debian Bullseye with LDAPS connected to Active Directory. However I have a some problems with prosody and LDAPS and it would be great, if you can help me. Me first step was
your handbook

Installed packages
jitsi-meet-prosody package and prosody related

ii  jitsi-meet-prosody                1.0.5415-1                                  all          Prosody configuration for Jitsi Meet
ii  lua-expat:amd64                   1.3.9-1lua54prosody~bullseye3               amd64        libexpat bindings for the Lua language
ii  lua-sec:amd64                     1.0-1prosody2lua54prosody~bullseye1         amd64        SSL socket library for the Lua language
ii  lua-socket:amd64                  3.0~rc1+git+ac3201d-4lua54prosody~bullseye1 amd64        TCP/UDP socket library for the Lua language
ii  prosody                           0.11.10-1~bullseye1                         amd64        Lightweight Jabber/XMPP server
ii  prosody-modules                   0.0~hg20210130.dd3bfe8f182e+dfsg-2          all          Selection of community modules for Prosody

SASL related packages

ii  libsasl2-2:amd64                  2.1.27+dfsg-2.1                             amd64        Cyrus SASL - authentication abstraction library
ii  libsasl2-dev                      2.1.27+dfsg-2.1                             amd64        Cyrus SASL - development files for authentication abstraction library
ii  libsasl2-modules:amd64            2.1.27+dfsg-2.1                             amd64        Cyrus SASL - pluggable authentication modules
ii  libsasl2-modules-db:amd64         2.1.27+dfsg-2.1                             amd64        Cyrus SASL - pluggable authentication modules (DB)
ii  libsasl2-modules-gssapi-mit:amd64 2.1.27+dfsg-2.1                             amd64        Cyrus SASL - pluggable authentication modules (GSSAPI)
ii  libsasl2-modules-ldap:amd64       2.1.27+dfsg-2.1                             amd64        Cyrus SASL - pluggable authentication modules (LDAP)
ii  lua-cyrussasl:amd64               1.1.0-2                                     amd64        Cyrus SASL library for the Lua language
ii  sasl2-bin                         2.1.27+dfsg-2.1                             amd64        Cyrus SASL - administration programs for SASL users database

Then I created the directory and file

/etc/sasl/prosody.conf
pwcheck_method: saslauthd
mech_list: PLAIN

and tested if SASL works

root@vm: testsaslauthd -u user -p password
0: OK "Success."

The cfg from prosody is basicly on default, I just added

c2s_require_encryption = true
consider_bosh_secure = true

and modified the config for my host:

/etc/prosody/conf.avail/vm.foo.com.cfg.lua
plugin_paths = { "/usr/share/jitsi-meet/prosody-plugins/" }

-- domain mapper options, must at least have domain base set to use the mapper
muc_mapper_domain_base = "vm.foo.com";

external_service_secret = "test";
external_services = {
     { type = "stun", host = "vm.foo.com", port = 3478 },
     { type = "turn", host = "vm.foo.com", port = 3478, transport = "udp", secret = true, ttl = 86400, algorithm = "turn" },
     { type = "turns", host = "vm.foo.com", port = 5349, transport = "tcp", secret = true, ttl = 86400, algorithm = "turn" }
};

cross_domain_bosh = false;
consider_bosh_secure = true;
  https_ports = { }; -- Remove this line to prevent listening on port 5284

ssl = {
    protocol = "tlsv1_2+";
    ciphers = "ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384"
}

unlimited_jids = {
    "focus@auth.vm.foo.com",
    "jvb@auth.vm.foo.com"
}

VirtualHost "vm.foo.com"
    authentication = "cyrus"
    allow_unencrypted_plain_auth = true
    cyrus_service_name = "prosody"
    app_id="xxx"
    app_secret="test"

    ssl = {
        key = "/etc/prosody/certs/vm.foo.com.key";
        certificate = "/etc/prosody/certs/vm.foo.com.crt";
    }
    -- av_moderation_component = "avmoderation.vm.foo.com"
    -- speakerstats_component = "speakerstats.vm.foo.com"
    -- conference_duration_component = "conferenceduration.vm.foo.com"
    -- we need bosh
    modules_enabled = {
        "bosh";
        "pubsub";
        "ping"; -- Enable mod_ping
       -- "speakerstats";
       --  "external_services";
       -- "conference_duration";
       -- "muc_lobby_rooms";
       -- "av_moderation";
       --  "saslauth";
       "auth_cyrus";
    }
    c2s_require_encryption = false
    lobby_muc = "lobby.vm.foo.com"
    main_muc = "conference.vm.foo.com"
    -- muc_lobby_whitelist = { "recorder.vm.foo.com" } -- Here we can whitelist jibri to enter lobby enabled rooms

Component "conference.vm.foo.com" "muc"
    restrict_room_creation = true
    storage = "memory"
    modules_enabled = {
        "muc_meeting_id";
        "muc_domain_mapper";
        "polls";
      --  "token_verification";
    }
    admins = { "focus@auth.vm.foo.com" }
    muc_room_locking = false
    muc_room_default_public_jids = true

-- internal muc component
Component "internal.auth.vm.foo.com" "muc"
    storage = "memory"
    modules_enabled = {
        "ping";
    }
    admins = { "focus@auth.vm.foo.com", "jvb@auth.vm.foo.com" }
    muc_room_locking = false
    muc_room_default_public_jids = true

VirtualHost "auth.vm.foo.com"
    ssl = {
        key = "/etc/prosody/certs/auth.vm.foo.com.key";
        certificate = "/etc/prosody/certs/auth.vm.foo.com.crt";
    }
      modules_enabled = {
        "limits_exception";
    }
    authentication = "internal_plain"

-- Proxy to jicofo's user JID, so that it doesn't have to register as a component.
Component "focus.vm.foo.com" "client_proxy"
    target_address = "focus@auth.vm.foo.com"

Component "speakerstats.vm.foo.com" "speakerstats_component"
    muc_component = "conference.vm.foo.com"

Component "conferenceduration.vm.foo.com" "conference_duration_component"
    muc_component = "conference.vm.foo.com"

Component "avmoderation.vm.foo.com" "av_moderation_component"
    muc_component = "conference.vm.foo.com"

Component "lobby.vm.foo.com" "muc"
    storage = "memory"
    restrict_room_creation = true
    muc_room_locking = false
    muc_room_default_public_jids = true

VirtualHost "guest.vm.foo.com"
    authentication = "anonymous"
    c2s_require_encryption = false

After restarting prosody with sudo systemctl restart prosody, I get this:

Nov 29 16:39:05 VM prosody[1783324]: auxpropfunc error invalid parameter supplied
Nov 29 16:39:05 VM prosody[1783324]: _sasl_plugin_load failed on sasl_auxprop_plug_init
Nov 29 16:39:05 VM prosody[1783324]: ldapdb
Nov 29 16:39:05 VM prosody[1783324]: _sasl_plugin_load failed on sasl_canonuser_init

What’s the problem of this issue?
thx for your time

packages

apt-get install prosody-modules lua-ldap

certificate

if no trusted certificate

mkdir -p /etc/ldap

/etc/ldap/ldap.conf

TLS_REQCERT allow

prosody

/etc/prosody/conf.avail/YOUR-DOMAIN.cfg.lua

VirtualHost "YOUR-DOMAIN"
    authentication = "ldap2"

/etc/prosody/conf.avail/ldap.cfg.lua

ldap = {
    hostname = 'samba.yourdomain.com',
    bind_dn = 'cn=USERNAME,cn=users,dc=yourdomain,dc=com',
    bind_password = 'PASSWD',
    use_tls = true,
    user = {
        usernamefield = 'sAMAccountName',
        basedn = 'cn=Users,dc=yourdomain,dc=com',
        filter = '(objectClass=User)',
    },
}
ln -s ../conf.avail/ldap.cfg.lua /etc/prosody/conf.d/
systemctl restart prosody.service

Thanks for your reply. I tried LDAPS also with the LDAPS Lua 5.2 plugin, but it doesn’t worked and using LDAPS gave me errors with LDAP related plugins.

So I decided to use SASL and now here I am :wink:

I have just tested and it works with above setup

my problem is, that I would prefer LDAPS at port 636 and not forcing StartTLS at port 389 and thats the reason why I prefer SASL.

Hello @emrah

I thought I’d test it again with your configuration, even if I then have to force StartTLS. Prosody runs without error messages, but I can’t log in via pigdin, for example. I enabled the debug log and attach it here.

Dec 08 00:00:09 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39334 to 5222
Dec 08 00:00:09 c2s55633f9ada80	info	Client connected
Dec 08 00:00:09 c2s55633f9ada80	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='d06f7479-d604-4a8a-bf28-aece61f0b671' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sent reply <stream:stream> to client
Dec 08 00:00:09 c2s55633f9ada80	debug	Not offering authentication on insecure connection
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:09 runner1QSLkO_R	debug	creating new coroutine
Dec 08 00:00:09 c2s55633f9ada80	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:09 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:09 c2s55633f9ada80	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:09 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9c29e8
Dec 08 00:00:09 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:09 c2s55633f9ada80	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='324846c9-3c48-448b-971d-695cebec9c5c' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sent reply <stream:stream> to client
Dec 08 00:00:09 c2s55633f9ada80	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:09 c2s55633f9ada80	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:09 c2s55633f9ada80	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:09 c2s55633f9ada80	debug	Offering mechanism PLAIN
Dec 08 00:00:09 c2s55633f9ada80	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:09 c2s55633f9ada80	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:09 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:09 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:09 c2s55633f9ada80	debug	Received </stream:stream>
Dec 08 00:00:09 c2s55633f9ada80	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:09 c2s55633f9ada80	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:09 c2s55633f9ada80	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:09 c2s55633f9ada80	info	Client disconnected: connection closed
Dec 08 00:00:09 c2s55633f9ada80	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:09 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:14 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39342 to 5222
Dec 08 00:00:14 c2s55633fa3a180	info	Client connected
Dec 08 00:00:14 c2s55633fa3a180	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='32a06615-aff9-4dc2-af67-ac16bf2d34af' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sent reply <stream:stream> to client
Dec 08 00:00:14 c2s55633fa3a180	debug	Not offering authentication on insecure connection
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:14 runnerVTBLybPW	debug	creating new coroutine
Dec 08 00:00:14 c2s55633fa3a180	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:14 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:14 c2s55633fa3a180	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:14 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fa652c8
Dec 08 00:00:14 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:14 c2s55633fa3a180	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='f419d364-203b-44b2-bc5e-01a6dae4bf65' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sent reply <stream:stream> to client
Dec 08 00:00:14 c2s55633fa3a180	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:14 c2s55633fa3a180	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:14 c2s55633fa3a180	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:14 c2s55633fa3a180	debug	Offering mechanism PLAIN
Dec 08 00:00:14 c2s55633fa3a180	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:14 c2s55633fa3a180	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:14 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:14 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:14 c2s55633fa3a180	debug	Received </stream:stream>
Dec 08 00:00:14 c2s55633fa3a180	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:14 c2s55633fa3a180	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:14 c2s55633fa3a180	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:14 c2s55633fa3a180	info	Client disconnected: connection closed
Dec 08 00:00:14 c2s55633fa3a180	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:14 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:19 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39348 to 5222
Dec 08 00:00:19 c2s55633f949a80	info	Client connected
Dec 08 00:00:19 c2s55633f949a80	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='ae4bce07-9cb3-4e79-9689-a4a104d1c1e7' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:19 c2s55633f949a80	debug	Sent reply <stream:stream> to client
Dec 08 00:00:19 c2s55633f949a80	debug	Not offering authentication on insecure connection
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:19 runner4NFJOVIw	debug	creating new coroutine
Dec 08 00:00:19 c2s55633f949a80	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:19 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:19 c2s55633f949a80	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:19 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9a8588
Dec 08 00:00:19 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:19 c2s55633f949a80	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='317b4e8a-70ba-4de7-8b12-e205dae9f5a7' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:19 c2s55633f949a80	debug	Sent reply <stream:stream> to client
Dec 08 00:00:19 c2s55633f949a80	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:19 c2s55633f949a80	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:19 c2s55633f949a80	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:19 c2s55633f949a80	debug	Offering mechanism PLAIN
Dec 08 00:00:19 c2s55633f949a80	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:19 c2s55633f949a80	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:19 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:19 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:19 c2s55633f949a80	debug	Received </stream:stream>
Dec 08 00:00:19 c2s55633f949a80	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:19 c2s55633f949a80	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:19 c2s55633f949a80	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:19 c2s55633f949a80	info	Client disconnected: connection closed
Dec 08 00:00:19 c2s55633f949a80	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:19 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:24 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39350 to 5222
Dec 08 00:00:24 c2s55633fa2ad90	info	Client connected
Dec 08 00:00:24 c2s55633fa2ad90	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='954770be-0184-4941-a9ee-e3afa38e4415' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sent reply <stream:stream> to client
Dec 08 00:00:24 c2s55633fa2ad90	debug	Not offering authentication on insecure connection
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:24 runnerxavGciKd	debug	creating new coroutine
Dec 08 00:00:24 c2s55633fa2ad90	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:24 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:24 c2s55633fa2ad90	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:24 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f6cf1c8
Dec 08 00:00:24 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:24 c2s55633fa2ad90	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='7c39ec5c-36a7-4b61-b981-d31f42864586' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sent reply <stream:stream> to client
Dec 08 00:00:24 c2s55633fa2ad90	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:24 c2s55633fa2ad90	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:24 c2s55633fa2ad90	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:24 c2s55633fa2ad90	debug	Offering mechanism PLAIN
Dec 08 00:00:24 c2s55633fa2ad90	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:24 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:24 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Received </stream:stream>
Dec 08 00:00:24 c2s55633fa2ad90	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:24 c2s55633fa2ad90	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:24 c2s55633fa2ad90	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:24 c2s55633fa2ad90	info	Client disconnected: connection closed
Dec 08 00:00:24 c2s55633fa2ad90	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:24 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:29 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39352 to 5222
Dec 08 00:00:29 c2s55633faa6c70	info	Client connected
Dec 08 00:00:29 c2s55633faa6c70	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='d3cc2749-8819-44a1-9b0b-a92cebfb657b' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sent reply <stream:stream> to client
Dec 08 00:00:29 c2s55633faa6c70	debug	Not offering authentication on insecure connection
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:29 runnerKPAhBhOc	debug	creating new coroutine
Dec 08 00:00:29 c2s55633faa6c70	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:29 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:29 c2s55633faa6c70	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:29 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fae2a48
Dec 08 00:00:29 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:29 c2s55633faa6c70	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='e694dd99-56f6-48ba-b513-ecc12d3eef63' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sent reply <stream:stream> to client
Dec 08 00:00:29 c2s55633faa6c70	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:29 c2s55633faa6c70	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:29 c2s55633faa6c70	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:29 c2s55633faa6c70	debug	Offering mechanism PLAIN
Dec 08 00:00:29 c2s55633faa6c70	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:29 c2s55633faa6c70	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:29 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:29 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:29 c2s55633faa6c70	debug	Received </stream:stream>
Dec 08 00:00:29 c2s55633faa6c70	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:29 c2s55633faa6c70	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:29 c2s55633faa6c70	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:29 c2s55633faa6c70	info	Client disconnected: connection closed
Dec 08 00:00:29 c2s55633faa6c70	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:29 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:34 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39358 to 5222
Dec 08 00:00:34 c2s55633f9ff3d0	info	Client connected
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='17f24e92-1730-412a-b525-c05f220e8732' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sent reply <stream:stream> to client
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Not offering authentication on insecure connection
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:34 runnerBDBmyhsY	debug	creating new coroutine
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:34 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:34 c2s55633f9ff3d0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:34 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f8cc698
Dec 08 00:00:34 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='eb65ea85-3fcf-400a-9724-4b6dacf5fce6' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sent reply <stream:stream> to client
Dec 08 00:00:34 c2s55633f9ff3d0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Offering mechanism PLAIN
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:34 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:34 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Received </stream:stream>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:34 c2s55633f9ff3d0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:34 c2s55633f9ff3d0	info	Client disconnected: connection closed
Dec 08 00:00:34 c2s55633f9ff3d0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:34 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:39 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39360 to 5222
Dec 08 00:00:39 c2s55633fa619e0	info	Client connected
Dec 08 00:00:39 c2s55633fa619e0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='5cb4ea5d-0b97-461a-9155-c9af0a1c1aca' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sent reply <stream:stream> to client
Dec 08 00:00:39 c2s55633fa619e0	debug	Not offering authentication on insecure connection
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:39 runnerv5b9otRn	debug	creating new coroutine
Dec 08 00:00:39 c2s55633fa619e0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:39 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:39 c2s55633fa619e0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:39 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9bbed8
Dec 08 00:00:39 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:39 c2s55633fa619e0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='60410031-cd06-4b8c-b58b-32fee7bfccc8' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sent reply <stream:stream> to client
Dec 08 00:00:39 c2s55633fa619e0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:39 c2s55633fa619e0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:39 c2s55633fa619e0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:39 c2s55633fa619e0	debug	Offering mechanism PLAIN
Dec 08 00:00:39 c2s55633fa619e0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:39 c2s55633fa619e0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:39 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:39 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:39 c2s55633fa619e0	debug	Received </stream:stream>
Dec 08 00:00:39 c2s55633fa619e0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:39 c2s55633fa619e0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:39 c2s55633fa619e0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:39 c2s55633fa619e0	info	Client disconnected: connection closed
Dec 08 00:00:39 c2s55633fa619e0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:39 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:44 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39362 to 5222
Dec 08 00:00:44 c2s55633faf4400	info	Client connected
Dec 08 00:00:44 c2s55633faf4400	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='0ae2e5b0-95c3-4a1b-987a-fd0900df0c9b' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:44 c2s55633faf4400	debug	Sent reply <stream:stream> to client
Dec 08 00:00:44 c2s55633faf4400	debug	Not offering authentication on insecure connection
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:44 runnerbcxnX0Q0	debug	creating new coroutine
Dec 08 00:00:44 c2s55633faf4400	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:44 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:44 c2s55633faf4400	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:44 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9e82e8
Dec 08 00:00:44 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:44 c2s55633faf4400	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='2801466d-db67-4389-9969-61af149e4dab' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:44 c2s55633faf4400	debug	Sent reply <stream:stream> to client
Dec 08 00:00:44 c2s55633faf4400	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:44 c2s55633faf4400	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:44 c2s55633faf4400	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:44 c2s55633faf4400	debug	Offering mechanism PLAIN
Dec 08 00:00:44 c2s55633faf4400	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:44 c2s55633faf4400	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:44 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:44 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:44 c2s55633faf4400	debug	Received </stream:stream>
Dec 08 00:00:44 c2s55633faf4400	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:44 c2s55633faf4400	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:44 c2s55633faf4400	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:44 c2s55633faf4400	info	Client disconnected: connection closed
Dec 08 00:00:44 c2s55633faf4400	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:44 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:49 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39366 to 5222
Dec 08 00:00:49 c2s55633fab8090	info	Client connected
Dec 08 00:00:49 c2s55633fab8090	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='728a19a8-0d50-4e27-93d3-04269cceaeef' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:49 c2s55633fab8090	debug	Sent reply <stream:stream> to client
Dec 08 00:00:49 c2s55633fab8090	debug	Not offering authentication on insecure connection
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:49 runnerg9K04Yi1	debug	creating new coroutine
Dec 08 00:00:49 c2s55633fab8090	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:49 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:49 c2s55633fab8090	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:49 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f84c3a8
Dec 08 00:00:49 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:49 c2s55633fab8090	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='c39aad1f-6483-4b27-966f-b9d7d77d6448' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:49 c2s55633fab8090	debug	Sent reply <stream:stream> to client
Dec 08 00:00:49 c2s55633fab8090	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:49 c2s55633fab8090	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:49 c2s55633fab8090	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:49 c2s55633fab8090	debug	Offering mechanism PLAIN
Dec 08 00:00:49 c2s55633fab8090	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:49 c2s55633fab8090	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:49 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:49 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:49 c2s55633fab8090	debug	Received </stream:stream>
Dec 08 00:00:49 c2s55633fab8090	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:49 c2s55633fab8090	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:49 c2s55633fab8090	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:49 c2s55633fab8090	info	Client disconnected: connection closed
Dec 08 00:00:49 c2s55633fab8090	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:49 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:54 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39370 to 5222
Dec 08 00:00:54 c2s55633fad70c0	info	Client connected
Dec 08 00:00:54 c2s55633fad70c0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='aa4a4c92-d9b2-4001-9149-ed8a3856e517' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sent reply <stream:stream> to client
Dec 08 00:00:54 c2s55633fad70c0	debug	Not offering authentication on insecure connection
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:54 runnerxE14v9Xe	debug	creating new coroutine
Dec 08 00:00:54 c2s55633fad70c0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:54 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:54 c2s55633fad70c0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:54 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f630de8
Dec 08 00:00:54 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:54 c2s55633fad70c0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='d3524b15-26e5-4c6a-989c-7a58737d48c0' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sent reply <stream:stream> to client
Dec 08 00:00:54 c2s55633fad70c0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:54 c2s55633fad70c0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:54 c2s55633fad70c0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:54 c2s55633fad70c0	debug	Offering mechanism PLAIN
Dec 08 00:00:54 c2s55633fad70c0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:54 c2s55633fad70c0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:54 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:54 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:54 c2s55633fad70c0	debug	Received </stream:stream>
Dec 08 00:00:54 c2s55633fad70c0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:54 c2s55633fad70c0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:54 c2s55633fad70c0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:54 c2s55633fad70c0	info	Client disconnected: connection closed
Dec 08 00:00:54 c2s55633fad70c0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:54 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:00:59 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39372 to 5222
Dec 08 00:00:59 c2s55633f9ba530	info	Client connected
Dec 08 00:00:59 c2s55633f9ba530	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='7d4f861f-3031-4916-b06e-2286b9eac249' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sent reply <stream:stream> to client
Dec 08 00:00:59 c2s55633f9ba530	debug	Not offering authentication on insecure connection
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:59 runnero4p1g1c_	debug	creating new coroutine
Dec 08 00:00:59 c2s55633f9ba530	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:00:59 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:00:59 c2s55633f9ba530	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:00:59 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9b7d68
Dec 08 00:00:59 socket	debug	server.lua: ssl handshake done
Dec 08 00:00:59 c2s55633f9ba530	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='fa456c49-6efe-4155-95ca-749128371fc0' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sent reply <stream:stream> to client
Dec 08 00:00:59 c2s55633f9ba530	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:00:59 c2s55633f9ba530	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:00:59 c2s55633f9ba530	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:00:59 c2s55633f9ba530	debug	Offering mechanism PLAIN
Dec 08 00:00:59 c2s55633f9ba530	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:00:59 c2s55633f9ba530	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:59 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:00:59 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:00:59 c2s55633f9ba530	debug	Received </stream:stream>
Dec 08 00:00:59 c2s55633f9ba530	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:00:59 c2s55633f9ba530	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:00:59 c2s55633f9ba530	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:00:59 c2s55633f9ba530	info	Client disconnected: connection closed
Dec 08 00:00:59 c2s55633f9ba530	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:00:59 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:04 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39374 to 5222
Dec 08 00:01:04 c2s55633fb1c7e0	info	Client connected
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='12bd469c-3941-4102-9802-f321825c184b' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Not offering authentication on insecure connection
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:04 runnerIEHX69ht	debug	creating new coroutine
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:04 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:04 c2s55633fb1c7e0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:04 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb1a018
Dec 08 00:01:04 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='14423a74-6f28-49c3-b46c-9c88acab1372' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:04 c2s55633fb1c7e0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Offering mechanism PLAIN
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:04 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:04 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Received </stream:stream>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:04 c2s55633fb1c7e0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:04 c2s55633fb1c7e0	info	Client disconnected: connection closed
Dec 08 00:01:04 c2s55633fb1c7e0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:04 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:09 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39380 to 5222
Dec 08 00:01:09 c2s55633fb34730	info	Client connected
Dec 08 00:01:09 c2s55633fb34730	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='9744a0b1-7890-49b4-850e-44bae6beccdf' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:09 c2s55633fb34730	debug	Sent reply <stream:stream> to client
Dec 08 00:01:09 c2s55633fb34730	debug	Not offering authentication on insecure connection
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:09 runner7R-jMfbM	debug	creating new coroutine
Dec 08 00:01:09 c2s55633fb34730	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:09 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:09 c2s55633fb34730	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:09 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb31f68
Dec 08 00:01:09 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:09 c2s55633fb34730	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='51e52eb0-74e7-4046-b00d-830f9f275c9a' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:09 c2s55633fb34730	debug	Sent reply <stream:stream> to client
Dec 08 00:01:09 c2s55633fb34730	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:09 c2s55633fb34730	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:09 c2s55633fb34730	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:09 c2s55633fb34730	debug	Offering mechanism PLAIN
Dec 08 00:01:09 c2s55633fb34730	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:09 c2s55633fb34730	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:09 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:09 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:09 c2s55633fb34730	debug	Received </stream:stream>
Dec 08 00:01:09 c2s55633fb34730	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:09 c2s55633fb34730	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:09 c2s55633fb34730	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:09 c2s55633fb34730	info	Client disconnected: connection closed
Dec 08 00:01:09 c2s55633fb34730	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:09 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:14 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39382 to 5222
Dec 08 00:01:14 c2s55633fb4ca40	info	Client connected
Dec 08 00:01:14 c2s55633fb4ca40	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='6652ccd2-0166-4e00-ac42-5966fcf749e0' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sent reply <stream:stream> to client
Dec 08 00:01:14 c2s55633fb4ca40	debug	Not offering authentication on insecure connection
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:14 runner1PNlsnDQ	debug	creating new coroutine
Dec 08 00:01:14 c2s55633fb4ca40	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:14 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:14 c2s55633fb4ca40	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:14 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb4a528
Dec 08 00:01:14 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:14 c2s55633fb4ca40	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='c28f626c-477b-4c9f-ae00-fd8b36caefe2' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sent reply <stream:stream> to client
Dec 08 00:01:14 c2s55633fb4ca40	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:14 c2s55633fb4ca40	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:14 c2s55633fb4ca40	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:14 c2s55633fb4ca40	debug	Offering mechanism PLAIN
Dec 08 00:01:14 c2s55633fb4ca40	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:14 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:14 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Received </stream:stream>
Dec 08 00:01:14 c2s55633fb4ca40	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:14 c2s55633fb4ca40	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:14 c2s55633fb4ca40	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:14 c2s55633fb4ca40	info	Client disconnected: connection closed
Dec 08 00:01:14 c2s55633fb4ca40	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:14 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:19 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39384 to 5222
Dec 08 00:01:19 c2s55633fb65070	info	Client connected
Dec 08 00:01:19 c2s55633fb65070	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='4a79f2d0-addd-48cc-91cb-0c6f2ac2b2eb' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:19 c2s55633fb65070	debug	Sent reply <stream:stream> to client
Dec 08 00:01:19 c2s55633fb65070	debug	Not offering authentication on insecure connection
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:19 runnerCWxYGXxX	debug	creating new coroutine
Dec 08 00:01:19 c2s55633fb65070	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:19 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:19 c2s55633fb65070	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:19 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb628a8
Dec 08 00:01:19 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:19 c2s55633fb65070	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='57f743c6-2825-44db-b5a6-f6561b6a23a3' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:19 c2s55633fb65070	debug	Sent reply <stream:stream> to client
Dec 08 00:01:19 c2s55633fb65070	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:19 c2s55633fb65070	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:19 c2s55633fb65070	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:19 c2s55633fb65070	debug	Offering mechanism PLAIN
Dec 08 00:01:19 c2s55633fb65070	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:19 c2s55633fb65070	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:19 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:19 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:19 c2s55633fb65070	debug	Received </stream:stream>
Dec 08 00:01:19 c2s55633fb65070	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:19 c2s55633fb65070	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:19 c2s55633fb65070	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:19 c2s55633fb65070	info	Client disconnected: connection closed
Dec 08 00:01:19 c2s55633fb65070	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:19 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:24 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39390 to 5222
Dec 08 00:01:24 c2s55633fb7cf00	info	Client connected
Dec 08 00:01:24 c2s55633fb7cf00	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='ce0eab2f-dbb9-41f0-b2d6-bee55c734bcd' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sent reply <stream:stream> to client
Dec 08 00:01:24 c2s55633fb7cf00	debug	Not offering authentication on insecure connection
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:24 runnerJgYXFaQJ	debug	creating new coroutine
Dec 08 00:01:24 c2s55633fb7cf00	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:24 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:24 c2s55633fb7cf00	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:24 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb7a9e8
Dec 08 00:01:24 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:24 c2s55633fb7cf00	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='bc54c10f-3a73-4751-8a4d-646987f48c9c' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sent reply <stream:stream> to client
Dec 08 00:01:24 c2s55633fb7cf00	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:24 c2s55633fb7cf00	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:24 c2s55633fb7cf00	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:24 c2s55633fb7cf00	debug	Offering mechanism PLAIN
Dec 08 00:01:24 c2s55633fb7cf00	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:24 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:24 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Received </stream:stream>
Dec 08 00:01:24 c2s55633fb7cf00	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:24 c2s55633fb7cf00	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:24 c2s55633fb7cf00	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:24 c2s55633fb7cf00	info	Client disconnected: connection closed
Dec 08 00:01:24 c2s55633fb7cf00	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:24 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:29 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39392 to 5222
Dec 08 00:01:29 c2s55633f70b9a0	info	Client connected
Dec 08 00:01:29 c2s55633f70b9a0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='11e0aba0-4b46-4ce4-9c94-bd8c210eabb0' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:29 c2s55633f70b9a0	debug	Not offering authentication on insecure connection
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:29 runnerrbcrQglc	debug	creating new coroutine
Dec 08 00:01:29 c2s55633f70b9a0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:29 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:29 c2s55633f70b9a0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:29 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb8b738
Dec 08 00:01:29 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:29 c2s55633f70b9a0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='e1f217ae-c54b-4154-b8b5-aca25a0b185f' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:29 c2s55633f70b9a0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:29 c2s55633f70b9a0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:29 c2s55633f70b9a0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:29 c2s55633f70b9a0	debug	Offering mechanism PLAIN
Dec 08 00:01:29 c2s55633f70b9a0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:29 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:29 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Received </stream:stream>
Dec 08 00:01:29 c2s55633f70b9a0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:29 c2s55633f70b9a0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:29 c2s55633f70b9a0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:29 c2s55633f70b9a0	info	Client disconnected: connection closed
Dec 08 00:01:29 c2s55633f70b9a0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:29 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:34 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39394 to 5222
Dec 08 00:01:34 c2s55633f7b2ad0	info	Client connected
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='99527475-f1b0-42fe-95fe-cdbb64aca34b' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Not offering authentication on insecure connection
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:34 runnerQerQUSzt	debug	creating new coroutine
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:34 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:34 c2s55633f7b2ad0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:34 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f7db2e8
Dec 08 00:01:34 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='afea2d9c-9321-4eed-b294-e0e8de99d24f' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:34 c2s55633f7b2ad0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Offering mechanism PLAIN
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:34 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:34 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Received </stream:stream>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:34 c2s55633f7b2ad0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:34 c2s55633f7b2ad0	info	Client disconnected: connection closed
Dec 08 00:01:34 c2s55633f7b2ad0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:34 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:39 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39398 to 5222
Dec 08 00:01:39 c2s55633f7b20f0	info	Client connected
Dec 08 00:01:39 c2s55633f7b20f0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='60712676-4548-4486-86ef-bff39b501826' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:39 c2s55633f7b20f0	debug	Not offering authentication on insecure connection
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:39 runnerwLEeDxS1	debug	creating new coroutine
Dec 08 00:01:39 c2s55633f7b20f0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:39 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:39 c2s55633f7b20f0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:39 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb04dc8
Dec 08 00:01:39 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:39 c2s55633f7b20f0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='fd9ab452-3fa3-4f43-8721-b8d9e702f2c8' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:39 c2s55633f7b20f0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:39 c2s55633f7b20f0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:39 c2s55633f7b20f0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:39 c2s55633f7b20f0	debug	Offering mechanism PLAIN
Dec 08 00:01:39 c2s55633f7b20f0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:39 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:39 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Received </stream:stream>
Dec 08 00:01:39 c2s55633f7b20f0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:39 c2s55633f7b20f0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:39 c2s55633f7b20f0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:39 c2s55633f7b20f0	info	Client disconnected: connection closed
Dec 08 00:01:39 c2s55633f7b20f0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:39 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:44 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39402 to 5222
Dec 08 00:01:44 c2s55633f7a6cd0	info	Client connected
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='8345bc90-d7a3-4d21-aacd-7682832653ce' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Not offering authentication on insecure connection
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:44 runnereVwpB8O_	debug	creating new coroutine
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:44 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:44 c2s55633f7a6cd0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:44 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fac9508
Dec 08 00:01:44 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='ec506260-b8cd-4160-b9df-e4b17367ec49' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:44 c2s55633f7a6cd0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Offering mechanism PLAIN
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:44 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:44 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Received </stream:stream>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:44 c2s55633f7a6cd0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:44 c2s55633f7a6cd0	info	Client disconnected: connection closed
Dec 08 00:01:44 c2s55633f7a6cd0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:44 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:49 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39404 to 5222
Dec 08 00:01:49 c2s55633fa13460	info	Client connected
Dec 08 00:01:49 c2s55633fa13460	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='ed86c48f-c659-48ce-bc94-b08213d2a126' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:49 c2s55633fa13460	debug	Sent reply <stream:stream> to client
Dec 08 00:01:49 c2s55633fa13460	debug	Not offering authentication on insecure connection
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:49 runnerWLsfR3Cj	debug	creating new coroutine
Dec 08 00:01:49 c2s55633fa13460	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:49 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:49 c2s55633fa13460	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:49 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9d4288
Dec 08 00:01:49 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:49 c2s55633fa13460	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='5868ea14-cce6-4154-9f68-90820643c420' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:49 c2s55633fa13460	debug	Sent reply <stream:stream> to client
Dec 08 00:01:49 c2s55633fa13460	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:49 c2s55633fa13460	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:49 c2s55633fa13460	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:49 c2s55633fa13460	debug	Offering mechanism PLAIN
Dec 08 00:01:49 c2s55633fa13460	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:49 c2s55633fa13460	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:49 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:49 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:49 c2s55633fa13460	debug	Received </stream:stream>
Dec 08 00:01:49 c2s55633fa13460	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:49 c2s55633fa13460	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:49 c2s55633fa13460	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:49 c2s55633fa13460	info	Client disconnected: connection closed
Dec 08 00:01:49 c2s55633fa13460	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:49 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:54 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39406 to 5222
Dec 08 00:01:54 c2s55633f996770	info	Client connected
Dec 08 00:01:54 c2s55633f996770	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='27047805-94ee-46bc-9d75-729698ce4cf8' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:54 c2s55633f996770	debug	Sent reply <stream:stream> to client
Dec 08 00:01:54 c2s55633f996770	debug	Not offering authentication on insecure connection
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:54 runnerFGLdMNSZ	debug	creating new coroutine
Dec 08 00:01:54 c2s55633f996770	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:54 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:54 c2s55633f996770	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:54 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fa55738
Dec 08 00:01:54 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:54 c2s55633f996770	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='1305be11-17d1-422a-9a79-741d8556c948' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:54 c2s55633f996770	debug	Sent reply <stream:stream> to client
Dec 08 00:01:54 c2s55633f996770	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:54 c2s55633f996770	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:54 c2s55633f996770	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:54 c2s55633f996770	debug	Offering mechanism PLAIN
Dec 08 00:01:54 c2s55633f996770	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:54 c2s55633f996770	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:54 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:54 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:54 c2s55633f996770	debug	Received </stream:stream>
Dec 08 00:01:54 c2s55633f996770	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:54 c2s55633f996770	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:54 c2s55633f996770	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:54 c2s55633f996770	info	Client disconnected: connection closed
Dec 08 00:01:54 c2s55633f996770	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:54 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:01:59 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39412 to 5222
Dec 08 00:01:59 c2s55633f8146f0	info	Client connected
Dec 08 00:01:59 c2s55633f8146f0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='12bcca58-0a41-4203-be55-bf968a57c66c' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:59 c2s55633f8146f0	debug	Not offering authentication on insecure connection
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:59 runnerW19zLOqY	debug	creating new coroutine
Dec 08 00:01:59 c2s55633f8146f0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:01:59 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:01:59 c2s55633f8146f0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:01:59 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f9d9b58
Dec 08 00:01:59 socket	debug	server.lua: ssl handshake done
Dec 08 00:01:59 c2s55633f8146f0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='1c3dd86a-dc6f-40f6-9967-3844970ed665' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sent reply <stream:stream> to client
Dec 08 00:01:59 c2s55633f8146f0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:01:59 c2s55633f8146f0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:01:59 c2s55633f8146f0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:01:59 c2s55633f8146f0	debug	Offering mechanism PLAIN
Dec 08 00:01:59 c2s55633f8146f0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:01:59 c2s55633f8146f0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:59 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:01:59 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:01:59 c2s55633f8146f0	debug	Received </stream:stream>
Dec 08 00:01:59 c2s55633f8146f0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:01:59 c2s55633f8146f0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:01:59 c2s55633f8146f0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:01:59 c2s55633f8146f0	info	Client disconnected: connection closed
Dec 08 00:01:59 c2s55633f8146f0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:01:59 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:02:04 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39414 to 5222
Dec 08 00:02:04 c2s55633fa26900	info	Client connected
Dec 08 00:02:04 c2s55633fa26900	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='fa0c88ad-8689-4c31-b985-3fc465419dc4' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:04 c2s55633fa26900	debug	Sent reply <stream:stream> to client
Dec 08 00:02:04 c2s55633fa26900	debug	Not offering authentication on insecure connection
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:04 runner06KkRGCU	debug	creating new coroutine
Dec 08 00:02:04 c2s55633fa26900	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:04 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:02:04 c2s55633fa26900	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:02:04 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f6ed348
Dec 08 00:02:04 socket	debug	server.lua: ssl handshake done
Dec 08 00:02:04 c2s55633fa26900	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='a793618f-4cc0-433f-aaab-54d4fb9d0fc7' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:04 c2s55633fa26900	debug	Sent reply <stream:stream> to client
Dec 08 00:02:04 c2s55633fa26900	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:02:04 c2s55633fa26900	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:02:04 c2s55633fa26900	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:02:04 c2s55633fa26900	debug	Offering mechanism PLAIN
Dec 08 00:02:04 c2s55633fa26900	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:04 c2s55633fa26900	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:04 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:02:04 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:04 c2s55633fa26900	debug	Received </stream:stream>
Dec 08 00:02:04 c2s55633fa26900	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:02:04 c2s55633fa26900	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:02:04 c2s55633fa26900	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:02:04 c2s55633fa26900	info	Client disconnected: connection closed
Dec 08 00:02:04 c2s55633fa26900	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:02:04 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:02:09 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39416 to 5222
Dec 08 00:02:09 c2s55633f88a800	info	Client connected
Dec 08 00:02:09 c2s55633f88a800	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='111bf4e0-71d2-4c47-9b48-92b1ab2387fc' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:09 c2s55633f88a800	debug	Sent reply <stream:stream> to client
Dec 08 00:02:09 c2s55633f88a800	debug	Not offering authentication on insecure connection
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:09 runnerZcxIGZxp	debug	creating new coroutine
Dec 08 00:02:09 c2s55633f88a800	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:09 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:02:09 c2s55633f88a800	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:02:09 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633f89bba8
Dec 08 00:02:09 socket	debug	server.lua: ssl handshake done
Dec 08 00:02:09 c2s55633f88a800	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='4ee1ef03-ffd7-4949-a28e-0f442fabd6d1' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:09 c2s55633f88a800	debug	Sent reply <stream:stream> to client
Dec 08 00:02:09 c2s55633f88a800	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:02:09 c2s55633f88a800	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:02:09 c2s55633f88a800	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:02:09 c2s55633f88a800	debug	Offering mechanism PLAIN
Dec 08 00:02:09 c2s55633f88a800	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:09 c2s55633f88a800	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:09 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:02:09 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:09 c2s55633f88a800	debug	Received </stream:stream>
Dec 08 00:02:09 c2s55633f88a800	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:02:09 c2s55633f88a800	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:02:09 c2s55633f88a800	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:02:09 c2s55633f88a800	info	Client disconnected: connection closed
Dec 08 00:02:09 c2s55633f88a800	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:02:09 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:02:14 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39422 to 5222
Dec 08 00:02:14 c2s55633f8bd100	info	Client connected
Dec 08 00:02:14 c2s55633f8bd100	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='bca7f964-1b8b-47f7-82ad-d5b694fe8649' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sent reply <stream:stream> to client
Dec 08 00:02:14 c2s55633f8bd100	debug	Not offering authentication on insecure connection
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:14 runnerEX8xhb7d	debug	creating new coroutine
Dec 08 00:02:14 c2s55633f8bd100	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:14 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:02:14 c2s55633f8bd100	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:02:14 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fa45ea8
Dec 08 00:02:14 socket	debug	server.lua: ssl handshake done
Dec 08 00:02:14 c2s55633f8bd100	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='a5fe7301-276c-4877-b895-06a7e4455fd4' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sent reply <stream:stream> to client
Dec 08 00:02:14 c2s55633f8bd100	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:02:14 c2s55633f8bd100	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:02:14 c2s55633f8bd100	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:02:14 c2s55633f8bd100	debug	Offering mechanism PLAIN
Dec 08 00:02:14 c2s55633f8bd100	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:14 c2s55633f8bd100	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:14 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:02:14 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:14 c2s55633f8bd100	debug	Received </stream:stream>
Dec 08 00:02:14 c2s55633f8bd100	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:02:14 c2s55633f8bd100	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:02:14 c2s55633f8bd100	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:02:14 c2s55633f8bd100	info	Client disconnected: connection closed
Dec 08 00:02:14 c2s55633f8bd100	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:02:14 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:02:19 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39424 to 5222
Dec 08 00:02:19 c2s55633fb66cc0	info	Client connected
Dec 08 00:02:19 c2s55633fb66cc0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='2be6daeb-115a-440b-91d6-0eca40946824' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sent reply <stream:stream> to client
Dec 08 00:02:19 c2s55633fb66cc0	debug	Not offering authentication on insecure connection
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:19 runnerLvDXARiH	debug	creating new coroutine
Dec 08 00:02:19 c2s55633fb66cc0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:19 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:02:19 c2s55633fb66cc0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:02:19 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633faeb1a8
Dec 08 00:02:19 socket	debug	server.lua: ssl handshake done
Dec 08 00:02:19 c2s55633fb66cc0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='e144904b-482e-4fbe-982e-fb4d73815f67' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sent reply <stream:stream> to client
Dec 08 00:02:19 c2s55633fb66cc0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:02:19 c2s55633fb66cc0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:02:19 c2s55633fb66cc0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:02:19 c2s55633fb66cc0	debug	Offering mechanism PLAIN
Dec 08 00:02:19 c2s55633fb66cc0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:19 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:02:19 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Received </stream:stream>
Dec 08 00:02:19 c2s55633fb66cc0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:02:19 c2s55633fb66cc0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:02:19 c2s55633fb66cc0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:02:19 c2s55633fb66cc0	info	Client disconnected: connection closed
Dec 08 00:02:19 c2s55633fb66cc0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:02:19 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:02:24 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39426 to 5222
Dec 08 00:02:24 c2s55633f8f82e0	info	Client connected
Dec 08 00:02:24 c2s55633f8f82e0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='9ee047ea-1bfd-4f5b-b3df-b6567f920a65' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sent reply <stream:stream> to client
Dec 08 00:02:24 c2s55633f8f82e0	debug	Not offering authentication on insecure connection
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:24 runneraHsOmdFR	debug	creating new coroutine
Dec 08 00:02:24 c2s55633f8f82e0	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:24 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:02:24 c2s55633f8f82e0	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:02:24 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633fb07538
Dec 08 00:02:24 socket	debug	server.lua: ssl handshake done
Dec 08 00:02:24 c2s55633f8f82e0	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='fe460221-efba-4db5-a916-6be2ba820be8' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sent reply <stream:stream> to client
Dec 08 00:02:24 c2s55633f8f82e0	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:02:24 c2s55633f8f82e0	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:02:24 c2s55633f8f82e0	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:02:24 c2s55633f8f82e0	debug	Offering mechanism PLAIN
Dec 08 00:02:24 c2s55633f8f82e0	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:24 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:02:24 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Received </stream:stream>
Dec 08 00:02:24 c2s55633f8f82e0	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:02:24 c2s55633f8f82e0	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:02:24 c2s55633f8f82e0	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:02:24 c2s55633f8f82e0	info	Client disconnected: connection closed
Dec 08 00:02:24 c2s55633f8f82e0	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:02:24 socket	debug	server.lua: closed client handler and removed socket from list
Dec 08 00:02:29 socket	debug	server.lua: accepted new client connection from 127.0.0.1:39430 to 5222
Dec 08 00:02:29 c2s55633f939b90	info	Client connected
Dec 08 00:02:29 c2s55633f939b90	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='0ee09db1-c66d-4239-af2a-881c404cd028' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:29 c2s55633f939b90	debug	Sent reply <stream:stream> to client
Dec 08 00:02:29 c2s55633f939b90	debug	Not offering authentication on insecure connection
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:29 runner2hyKSf9P	debug	creating new coroutine
Dec 08 00:02:29 c2s55633f939b90	debug	Received[c2s_unauthed]: <starttls xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <proceed xmlns='urn:ietf:params:xml:ns:xmpp-tls'>
Dec 08 00:02:29 socket	debug	server.lua: we need to do tls, but delaying until send buffer empty
Dec 08 00:02:29 c2s55633f939b90	debug	TLS negotiation started for c2s_unauthed...
Dec 08 00:02:29 socket	debug	server.lua: attempting to start tls on tcp{client}: 0x55633faf6f48
Dec 08 00:02:29 socket	debug	server.lua: ssl handshake done
Dec 08 00:02:29 c2s55633f939b90	debug	Client sent opening <stream:stream> to auth.vm.foo.com
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <?xml version='1.0'?>
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <stream:stream xmlns='jabber:client' version='1.0' id='e97db0e2-95ca-4b57-9f39-3492af7cb01c' from='auth.vm.foo.com' xml:lang='en' xmlns:stream='http://etherx.jabber.org/streams'>
Dec 08 00:02:29 c2s55633f939b90	debug	Sent reply <stream:stream> to client
Dec 08 00:02:29 c2s55633f939b90	info	Stream encrypted (TLSv1.3 with TLS_AES_256_GCM_SHA384)
Dec 08 00:02:29 c2s55633f939b90	debug	Channel binding 'tls-unique' undefined in context of TLS 1.3
Dec 08 00:02:29 c2s55633f939b90	debug	Offering mechanism SCRAM-SHA-1
Dec 08 00:02:29 c2s55633f939b90	debug	Offering mechanism PLAIN
Dec 08 00:02:29 c2s55633f939b90	debug	Not offering disabled mechanism DIGEST-MD5
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <stream:features>
Dec 08 00:02:29 c2s55633f939b90	debug	Received[c2s_unauthed]: <auth mechanism='SCRAM-SHA-1' xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:29 auth.vm.foo.com:auth_internal_plain	debug	get_password for username 'jvb'
Dec 08 00:02:29 auth.vm.foo.com:saslauth	debug	sasl reply: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><not-authorized/></failure>
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: <failure xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>
Dec 08 00:02:29 c2s55633f939b90	debug	Received </stream:stream>
Dec 08 00:02:29 c2s55633f939b90	debug	Sending[c2s_unauthed]: </stream:stream>
Dec 08 00:02:29 c2s55633f939b90	debug	c2s stream for 127.0.0.1 closed: session closed
Dec 08 00:02:29 c2s55633f939b90	debug	Destroying session for (unknown) ((unknown)@auth.vm.foo.com)
Dec 08 00:02:29 c2s55633f939b90	info	Client disconnected: connection closed
Dec 08 00:02:29 c2s55633f939b90	debug	Destroying session for (unknown) ((unknown)@(unknown))
Dec 08 00:02:29 socket	debug	server.lua: closed client handler and removed socket from list

I only see, that jvb have trouble with the password(?) and that I’m still using the saslmodule, because it’s not yet deactivated.

greetings
moep

No idea about pidgin. Can participant connect to Jitsi meeting room through browser?

Hello @emrah

when I open jitsi meet, I see the mask to enter the name of a room. Then I click on join and I see “Unfortunalety, something went wrong”. It reload the site after 4s but the effect is still the same.

This is a videobridge issue. Search for udp/10000

my config in /etc/jisi/videobridge/sip-communicator.properties looks like

org.jitsi.videobridge.NAT_HARVESTER_LOCAL_ADDRESS=10.1.1.1
org.jitsi.videobridge.NAT_HARVESTER_PUBLIC_ADDRESS=8.8.8.6
org.ice4j.ice.harvest.DISABLE_AWS_HARVESTER=true
org.ice4j.ice.harvest.STUN_MAPPING_HARVESTER_ADDRESSES=meet-jit-si-turnrelay.jitsi.net:443
org.jitsi.videobridge.ENABLE_STATISTICS=true
org.jitsi.videobridge.STATISTICS_TRANSPORT=muc
org.jitsi.videobridge.xmpp.user.shard.HOSTNAME=localhost
org.jitsi.videobridge.xmpp.user.shard.DOMAIN=auth.vm.foo.com
org.jitsi.videobridge.xmpp.user.shard.USERNAME=jvb
org.jitsi.videobridge.xmpp.user.shard.PASSWORD=xxx
org.jitsi.videobridge.xmpp.user.shard.MUC_JIDS=xxxxxx@internal.auth.vm.foo.com
org.jitsi.videobridge.xmpp.user.shard.MUC_NICKNAME=1234567e2-9754-4a4b-901a-6687c47ca2cb
org.jitsi.videobridge.rest.private.jetty.host=vm.foo.com

In …/config are only used the default ports e.g.JVB_PORT=5347 and I switch it to port 10000 the result is the same.

thx for reply

Comment these two lines and try again after restarting jvb. Also check the js console for errors which will give an idea what is wrong

hello @damencho

there is no error in the video bridge, but the failure picture is not different.
I still see "Unfortunalety, something went wrong”.

Open developer js console to check the error.

Check jicofo logs

hey there and sorry for me late reply.

Here my jicofi.log:

Jicofo 2021-12-12 00:00:14.402 INFO: [537] [xmpp_connection=client] XmppProviderImpl.doConnect#206: Connected, JID= null
Jicofo 2021-12-12 00:00:14.402 SEVERE: [537] [xmpp_connection=client] XmppProviderImpl.doConnect#225: Failed to connect/login: SASLError using SCRAM-SHA-1: not-authorized
org.jivesoftware.smack.sasl.SASLErrorException: SASLError using SCRAM-SHA-1: not-authorized
        at org.jivesoftware.smack.SASLAuthentication.authenticationFailed(SASLAuthentication.java:286)
        at org.jivesoftware.smack.AbstractXMPPConnection.lambda$new$2(AbstractXMPPConnection.java:407)
        at org.jivesoftware.smack.NonzaCallback$ClassAndConsumer.accept(NonzaCallback.java:177)
        at org.jivesoftware.smack.NonzaCallback$ClassAndConsumer.access$200(NonzaCallback.java:166)
        at org.jivesoftware.smack.NonzaCallback.onNonzaReceived(NonzaCallback.java:46)
        at org.jivesoftware.smack.AbstractXMPPConnection.parseAndProcessNonza(AbstractXMPPConnection.java:1447)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection.access$1700(XMPPTCPConnection.java:130)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader.parsePackets(XMPPTCPConnection.java:1007)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader.access$700(XMPPTCPConnection.java:913)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader$1.run(XMPPTCPConnection.java:936)
        at java.base/java.lang.Thread.run(Thread.java:829)
Jicofo 2021-12-12 00:00:19.410 INFO: [537] [xmpp_connection=client] XmppProviderImpl.doConnect#206: Connected, JID= null
Jicofo 2021-12-12 00:00:19.410 SEVERE: [537] [xmpp_connection=client] XmppProviderImpl.doConnect#225: Failed to connect/login: SASLError using SCRAM-SHA-1: not-authorized
org.jivesoftware.smack.sasl.SASLErrorException: SASLError using SCRAM-SHA-1: not-authorized
        at org.jivesoftware.smack.SASLAuthentication.authenticationFailed(SASLAuthentication.java:286)
        at org.jivesoftware.smack.AbstractXMPPConnection.lambda$new$2(AbstractXMPPConnection.java:407)
        at org.jivesoftware.smack.NonzaCallback$ClassAndConsumer.accept(NonzaCallback.java:177)
        at org.jivesoftware.smack.NonzaCallback$ClassAndConsumer.access$200(NonzaCallback.java:166)
        at org.jivesoftware.smack.NonzaCallback.onNonzaReceived(NonzaCallback.java:46)
        at org.jivesoftware.smack.AbstractXMPPConnection.parseAndProcessNonza(AbstractXMPPConnection.java:1447)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection.access$1700(XMPPTCPConnection.java:130)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader.parsePackets(XMPPTCPConnection.java:1007)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader.access$700(XMPPTCPConnection.java:913)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader$1.run(XMPPTCPConnection.java:936)
        at java.base/java.lang.Thread.run(Thread.java:829)
Jicofo 2021-12-12 00:00:24.419 INFO: [537] [xmpp_connection=client] XmppProviderImpl.doConnect#206: Connected, JID= null
Jicofo 2021-12-12 00:00:24.420 SEVERE: [537] [xmpp_connection=client] XmppProviderImpl.doConnect#225: Failed to connect/login: SASLError using SCRAM-SHA-1: not-authorized
org.jivesoftware.smack.sasl.SASLErrorException: SASLError using SCRAM-SHA-1: not-authorized
        at org.jivesoftware.smack.SASLAuthentication.authenticationFailed(SASLAuthentication.java:286)
        at org.jivesoftware.smack.AbstractXMPPConnection.lambda$new$2(AbstractXMPPConnection.java:407)
        at org.jivesoftware.smack.NonzaCallback$ClassAndConsumer.accept(NonzaCallback.java:177)
        at org.jivesoftware.smack.NonzaCallback$ClassAndConsumer.access$200(NonzaCallback.java:166)
        at org.jivesoftware.smack.NonzaCallback.onNonzaReceived(NonzaCallback.java:46)
        at org.jivesoftware.smack.AbstractXMPPConnection.parseAndProcessNonza(AbstractXMPPConnection.java:1447)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection.access$1700(XMPPTCPConnection.java:130)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader.parsePackets(XMPPTCPConnection.java:1007)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader.access$700(XMPPTCPConnection.java:913)
        at org.jivesoftware.smack.tcp.XMPPTCPConnection$PacketReader$1.run(XMPPTCPConnection.java:936)
        at java.base/java.lang.Thread.run(Thread.java:829)

For me it looks like, that it’s trying via SASL, but in my Prosody config I use

authenticaton = "ldap2"
-- authenticaton = "cyrus"
-- cyrus_service_name = "prosody"
-- cyrus_application_name = "prosody"
[…]
modules_enabled = {
   "bosh";
   "pubsub";
   "ping";
-- "saslauth";
-- "auth_cyrus";
}

this Thread can be closed right now and I wanna mark it as resolved.