Hey i’ve tested the current master and could see new NPEs in the log:
2021.10.15 17:37:18 ERROR [TaskEngine-pool-3]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Interner Serverfehler
java.lang.UnsupportedOperationException: null
at org.jivesoftware.util.cache.DefaultLocalCacheStrategy$LocalLock.tryLock(DefaultLocalCacheStrategy.java:216) ~[xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl.checkForTimedOutUsers(MultiUserChatServiceImpl.java:1534) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl.access$000(MultiUserChatServiceImpl.java:126) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl$UserTimeoutTask.run(MultiUserChatServiceImpl.java:1430) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_292]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_292]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_292]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_292]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_292]
and
Exception in thread "socket_c2s-thread-2" java.lang.IncompatibleClassChangeError: Found class org.jivesoftware.openfire.muc.MUCRoom, but interface was expected
at com.reucon.openfire.plugin.archive.xep0313.IQQueryHandler.handleIQ(IQQueryHandler.java:163)
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl.process(MultiUserChatServiceImpl.java:526)
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl.processPacket(MultiUserChatServiceImpl.java:394)
at org.jivesoftware.openfire.component.InternalComponentManager$RoutableComponents.process(InternalComponentManager.java:859)
at org.jivesoftware.openfire.spi.RoutingTableImpl.routeToComponent(RoutingTableImpl.java:544)
at org.jivesoftware.openfire.spi.RoutingTableImpl.routePacket(RoutingTableImpl.java:359)
at org.jivesoftware.openfire.IQRouter.handle(IQRouter.java:340)
at org.jivesoftware.openfire.IQRouter.route(IQRouter.java:105)
at org.jivesoftware.openfire.spi.PacketRouterImpl.route(PacketRouterImpl.java:74)
at org.jivesoftware.openfire.net.StanzaHandler.processIQ(StanzaHandler.java:369)
at org.jivesoftware.openfire.net.ClientStanzaHandler.processIQ(ClientStanzaHandler.java:95)
at org.jivesoftware.openfire.net.StanzaHandler.process(StanzaHandler.java:311)
at org.jivesoftware.openfire.net.StanzaHandler.process(StanzaHandler.java:198)
at org.jivesoftware.openfire.nio.ConnectionHandler.messageReceived(ConnectionHandler.java:183)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:1015)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:650)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:49)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:1128)
at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:122)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:650)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:49)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:1128)
at org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl.flush(ProtocolCodecFilter.java:413)
at org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFilter.java:257)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:650)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:49)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:1128)
at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:106)
at org.apache.mina.core.session.IoEvent.run(IoEvent.java:89)
at org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTask(OrderedThreadPoolExecutor.java:766)
at org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTasks(OrderedThreadPoolExecutor.java:758)
at org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.run(OrderedThreadPoolExecutor.java:697)
at java.lang.Thread.run(Thread.java:748)
Exception in thread "socket_c2s-thread-3" java.lang.IncompatibleClassChangeError: Found class org.jivesoftware.openfire.muc.MUCRoom, but interface was expected
at com.reucon.openfire.plugin.archive.xep0313.IQQueryHandler.handleIQ(IQQueryHandler.java:163)
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl.process(MultiUserChatServiceImpl.java:526)
at org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl.processPacket(MultiUserChatServiceImpl.java:394)
at org.jivesoftware.openfire.component.InternalComponentManager$RoutableComponents.process(InternalComponentManager.java:859)
at org.jivesoftware.openfire.spi.RoutingTableImpl.routeToComponent(RoutingTableImpl.java:544)
at org.jivesoftware.openfire.spi.RoutingTableImpl.routePacket(RoutingTableImpl.java:359)
at org.jivesoftware.openfire.IQRouter.handle(IQRouter.java:340)
at org.jivesoftware.openfire.IQRouter.route(IQRouter.java:105)
at org.jivesoftware.openfire.spi.PacketRouterImpl.route(PacketRouterImpl.java:74)
at org.jivesoftware.openfire.net.StanzaHandler.processIQ(StanzaHandler.java:369)
at org.jivesoftware.openfire.net.ClientStanzaHandler.processIQ(ClientStanzaHandler.java:95)
at org.jivesoftware.openfire.net.StanzaHandler.process(StanzaHandler.java:311)
at org.jivesoftware.openfire.net.StanzaHandler.process(StanzaHandler.java:198)
at org.jivesoftware.openfire.nio.ConnectionHandler.messageReceived(ConnectionHandler.java:183)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$TailFilter.messageReceived(DefaultIoFilterChain.java:1015)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:650)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:49)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:1128)
at org.apache.mina.core.filterchain.IoFilterAdapter.messageReceived(IoFilterAdapter.java:122)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:650)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:49)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:1128)
at org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl.flush(ProtocolCodecFilter.java:413)
at org.apache.mina.filter.codec.ProtocolCodecFilter.messageReceived(ProtocolCodecFilter.java:257)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.callNextMessageReceived(DefaultIoFilterChain.java:650)
at org.apache.mina.core.filterchain.DefaultIoFilterChain.access$1300(DefaultIoFilterChain.java:49)
at org.apache.mina.core.filterchain.DefaultIoFilterChain$EntryImpl$1.messageReceived(DefaultIoFilterChain.java:1128)
at org.apache.mina.core.filterchain.IoFilterEvent.fire(IoFilterEvent.java:106)
at org.apache.mina.core.session.IoEvent.run(IoEvent.java:89)
at org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTask(OrderedThreadPoolExecutor.java:766)
at org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.runTasks(OrderedThreadPoolExecutor.java:758)
at org.apache.mina.filter.executor.OrderedThreadPoolExecutor$Worker.run(OrderedThreadPoolExecutor.java:697)
at java.lang.Thread.run(Thread.java:748)
Furthermore the problem with invalid session from this post Problem with Openfire 4.6.4 - #40 by totzkotz still occurs
I have attached a debug log from this time i wanted to delete the invalid session from admin console:
I am using a valid LetsEncrypt SSL Wildcard Cert.
2021.10.15 18:09:02 DEBUG [NioProcessor-1]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event SESSION_OPENED to session 20
Queue : [SESSION_OPENED, ]
2021.10.15 18:09:02 DEBUG [NioProcessor-1]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event MESSAGE_RECEIVED to session 20
Queue : [SESSION_OPENED, , MESSAGE_RECEIVED, ]
2021.10.15 18:09:02 DEBUG [NioProcessor-1]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event MESSAGE_RECEIVED to session 20
Queue : [SESSION_OPENED, , MESSAGE_RECEIVED, , MESSAGE_RECEIVED, ]
2021.10.15 18:09:05 TRACE [TaskEngine-pool-14]: org.jivesoftware.openfire.pubsub.CachingPubsubPersistenceProvider - Flushing pending nodes (count: 0)
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.session.LocalSession - Suppressing close for session with address mops@MYDOMAIN.LOCAL/Conversations.tWP0 and streamID tjg342r1n.
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.SessionManager - Closing session with address mops@MYDOMAIN.LOCAL/Conversations.tWP0 and streamID tjg342r1n has SM enabled; detaching.
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.session.LocalSession - Setting session with address mops@MYDOMAIN.LOCAL/Conversations.tWP0 and streamID tjg342r1n in detached mode.
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.SessionManager - Marking session 'mops@MYDOMAIN.LOCAL/Conversations.tWP0' (tjg342r1n) as detached.
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.spi.RoutingTableImpl - Removed users cache entry for mops@MYDOMAIN.LOCAL/Conversations.tWP0 / ClientRoute{nodeID=924dde2e-fc94-4f90-aa31-3bc7af6ca2fb, available=true}, changing entry count from 2 to 1
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.spi.RoutingTableImpl - Removing client route mops@MYDOMAIN.LOCAL/Conversations.tWP0 from local routing table
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.spi.LocalRoutingTable - Remove local route 'mops@MYDOMAIN.LOCAL/Conversations.tWP0' (for pair: '{ -> mops@MYDOMAIN.LOCAL/Conversations.tWP0}') removed
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.blacklistspam.Blacklist - JID mops@MYDOMAIN.LOCAL/Conversations.tWP0 on blacklist: false
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.spi.RoutingTableImpl - Failed to route packet to JID: mops@MYDOMAIN.LOCAL/Conversations.tWP0 packet: <presence from="mops@MYDOMAIN.LOCAL/Conversations.tWP0" to="mops@MYDOMAIN.LOCAL/Conversations.tWP0" type="unavailable"/>
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.PresenceRouter - Presence sent to unreachable address: <presence from="mops@MYDOMAIN.LOCAL/Conversations.tWP0" to="mops@MYDOMAIN.LOCAL/Conversations.tWP0" type="unavailable"/>
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.PresenceRouter - Not bouncing a presence stanza of type unavailable
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - Start domain authentication ...
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.xep398.XEP398IQHandler - Read Avatar from PEPService (mops@MYDOMAIN.LOCAL)
2021.10.15 18:09:06 TRACE [Jetty-QTP-BOSH-65]: org.jivesoftware.openfire.http.HttpBindServlet - Data can be written to [[2a02:2454:543:2000:5850:46fb:2c9d:aa62]]
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - Searching for pre-existing outgoing sessions to the remote domain (if one exists, it will be re-used) ...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - There are no pre-existing outgoing sessions to the remote domain itself. Searching for pre-existing outgoing sessions to super- or subdomains of the remote domain (if one exists, it might be re-usable) ...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - There are no pre-existing session to other domains hosted on the remote domain.
2021.10.15 18:09:06 TRACE [Jetty-QTP-BOSH-65]: org.jivesoftware.openfire.http.HttpSession - Session ikt4fi62b Request ID 1572623149, event complete: org.eclipse.jetty.server.AsyncContextEvent@5b1e3f30
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - Unable to re-use an existing session. Creating a new session ...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Creating new session...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Creating plain socket connection to a host that belongs to the remote XMPP domain.
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.pubsub.CachingPubsubPersistenceProvider - Loading nodes for service: PubSubService.UniqueIdentifier{serviceId='mops@MYDOMAIN.LOCAL'}
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.SocketUtil - Creating a socket connection to XMPP domain 'DOMAIN.LOCAL' ...
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.pubsub.CachingPubsubPersistenceProvider - Flushing pending nodes for service: PubSubService.UniqueIdentifier{serviceId='mops@MYDOMAIN.LOCAL'}
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.SocketUtil - Use DNS to resolve remote hosts for the provided XMPP domain 'DOMAIN.LOCAL' (default port: 5269) ...
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.pubsub.DefaultPubSubPersistenceProvider - Loading nodes for service: mops@MYDOMAIN.LOCAL
2021.10.15 18:09:06 TRACE [pool-20-thread-5]: org.jivesoftware.openfire.net.DNSUtil - DNS SRV Lookup for service 'xmpp-server', protocol 'tcp' and name 'DOMAIN.LOCAL'
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.pep.PEPServiceManager - PEP: Restored service for mops@MYDOMAIN.LOCAL from the database.
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.pubsub.PubSubEngine - Starting pubsub service 'PubSubService.UniqueIdentifier{serviceId='mops@MYDOMAIN.LOCAL'}'
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.xep398.XEP398IQHandler - PEPService from mops@MYDOMAIN.LOCAL loaded successfully
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.xep398.XEP398IQHandler - One of the following nodes were not found in PEP: urn:xmpp:avatar:data or urn:xmpp:avatar:metadata (mops@MYDOMAIN.LOCAL)
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.vcard.PhotoResizer - Original image size: 4110 bytes.
2021.10.15 18:09:06 TRACE [pool-20-thread-5]: org.jivesoftware.openfire.net.DNSUtil - 1 SRV record(s) found for '_xmpp-server._tcp.DOMAIN.LOCAL.'
2021.10.15 18:09:06 TRACE [pool-20-thread-5]: org.jivesoftware.openfire.net.DNSUtil - DNS SRV Lookup for service 'xmpps-server', protocol 'tcp' and name 'DOMAIN.LOCAL'
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.vcard.PhotoResizer - Original image dimension (96x96) is within acceptable bounds (96x96). No need to resize.
2021.10.15 18:09:06 WARN [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.xep398.Avatar - getShrinkedImage: Cannot resize avatar. PhotoResizer.cropAndShrink failed!
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.blacklistspam.Blacklist - JID mops@MYDOMAIN.LOCAL/Conversations.tWP0 on blacklist: false
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Routing stanza: <presence from="mops@MYDOMAIN.LOCAL/Conversations.tWP0" to="mopraum@conference.MYDOMAIN.LOCAL/mops" type="unavailable"/>
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - The stanza is a normal packet that should possibly be sent to the room.
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Stanza recipient: mopraum@conference.MYDOMAIN.LOCAL/mops, room name: mopraum, sender: mops@MYDOMAIN.LOCAL/Conversations.tWP0
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Stanza is a regular MUC stanza.
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.LocalMUCRoomManager - Obtaining lock for room 'mopraum' of service 'conference'
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Preexisting role for user mops@MYDOMAIN.LOCAL/Conversations.tWP0 in room mopraum (that currently does exist): MUCRole{roomJid=mopraum@conference.MYDOMAIN.LOCAL, userJid=mops@MYDOMAIN.LOCAL/Conversations.tWP0, nick='mops', role=moderator, affiliation=owner, voiceOnly=false, rJID=mopraum@conference.MYDOMAIN.LOCAL/mops, reportedFmucJID=null}
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.MultiUserChatServiceImpl - Occupant 'mops@MYDOMAIN.LOCAL/Conversations.tWP0' of room 'mopraum' is leaving.
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.MUCRoom - Send presence of leaving occupant 'mops@MYDOMAIN.LOCAL/Conversations.tWP0' to existing occupants of room 'mopraum@conference.MYDOMAIN.LOCAL'.
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.MUCRoom - Remove occupant from room mopraum@conference.MYDOMAIN.LOCAL: MUCRole{roomJid=mopraum@conference.MYDOMAIN.LOCAL, userJid=mops@MYDOMAIN.LOCAL/Conversations.tWP0, nick='mops', role=moderator, affiliation=owner, voiceOnly=false, rJID=mopraum@conference.MYDOMAIN.LOCAL/mops, reportedFmucJID=null}
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.OccupantManager - Removed local occupancy in room 'mopraum' of service 'conference': entity 'mops' using nickname 'mops@MYDOMAIN.LOCAL/Conversations.tWP0'
2021.10.15 18:09:06 DEBUG [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.OccupantManager - Replaced occupants with arguments Occupant{roomName='mopraum', nickname='mops', realJID=mops@MYDOMAIN.LOCAL/Conversations.tWP0, lastActive=2021-10-15T16:09:06.271Z} null 924dde2e-fc94-4f90-aa31-3bc7af6ca2fb
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.jivesoftware.openfire.muc.spi.LocalMUCRoomManager - Syncing room 'mopraum' of service 'conference' (destroy: false)
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.blacklistspam.Blacklist - JID mopraum@conference.MYDOMAIN.LOCAL/mops on blacklist: false
2021.10.15 18:09:06 TRACE [Jetty-QTP-AdminConsole-30]: org.igniterealtime.openfire.plugin.blacklistspam.Blacklist - JID mops@MYDOMAIN.LOCAL/Conversations.tWP0 on blacklist: false
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.DNSUtil - No SRV record found for '_xmpps-server._tcp.DOMAIN.LOCAL.'
javax.naming.NameNotFoundException: DNS name not found [response code 3]
at com.sun.jndi.dns.DnsClient.checkResponseCode(DnsClient.java:660) ~[?:1.8.0_292]
at com.sun.jndi.dns.DnsClient.isMatchResponse(DnsClient.java:578) ~[?:1.8.0_292]
at com.sun.jndi.dns.DnsClient.doUdpQuery(DnsClient.java:426) ~[?:1.8.0_292]
at com.sun.jndi.dns.DnsClient.query(DnsClient.java:211) ~[?:1.8.0_292]
at com.sun.jndi.dns.Resolver.query(Resolver.java:81) ~[?:1.8.0_292]
at com.sun.jndi.dns.DnsContext.c_getAttributes(DnsContext.java:434) ~[?:1.8.0_292]
at com.sun.jndi.toolkit.ctx.ComponentDirContext.p_getAttributes(ComponentDirContext.java:235) ~[?:1.8.0_292]
at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.getAttributes(PartialCompositeDirContext.java:141) ~[?:1.8.0_292]
at com.sun.jndi.toolkit.ctx.PartialCompositeDirContext.getAttributes(PartialCompositeDirContext.java:129) ~[?:1.8.0_292]
at javax.naming.directory.InitialDirContext.getAttributes(InitialDirContext.java:142) ~[?:1.8.0_292]
at org.jivesoftware.openfire.net.DNSUtil.srvLookup(DNSUtil.java:224) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.DNSUtil.resolveXMPPDomain(DNSUtil.java:121) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SocketUtil.createSocketToXmppDomain(SocketUtil.java:52) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SocketUtil.createSocketToXmppDomain(SocketUtil.java:109) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.session.LocalOutgoingServerSession.createOutgoingSession(LocalOutgoingServerSession.java:257) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.session.LocalOutgoingServerSession.authenticateDomain(LocalOutgoingServerSession.java:210) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.server.OutgoingSessionPromise$PacketsProcessor.sendPacket(OutgoingSessionPromise.java:264) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.server.OutgoingSessionPromise$PacketsProcessor.run(OutgoingSessionPromise.java:242) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_292]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_292]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_292]
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.SocketUtil - Found 1 host(s) for XMPP domain 'DOMAIN.LOCAL'.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.SocketUtil - - of1.z.DOMAIN.LOCAL:5269 (no direct TLS)
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.SocketUtil - Trying to create socket connection to XMPP domain 'DOMAIN.LOCAL' using remote host: of1.z.DOMAIN.LOCAL:5269 (blocks up to 120000 ms) ...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.net.SocketUtil - Successfully created socket connection to XMPP domain 'DOMAIN.LOCAL' using remote host: of1.z.DOMAIN.LOCAL:5269!
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Opening a new connection to of1.z.DOMAIN.LOCAL/87.173.86.154:5269 that is initially not encrypted.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Send the stream header and wait for response...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Got a response (stream ID: 7i7n9eneo3, version: 1.0). Check if the remote server is XMPP 1.0 compliant...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - The remote server is XMPP 1.0 compliant (or at least reports to be).
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Processing stream features of the remote domain...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Check if both us as well as the remote server have enabled STARTTLS and/or dialback ...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Both us and the remote server support the STARTTLS feature. Secure and authenticate the connection with TLS & SASL...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Secure connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Securing and authenticating connection ...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Secure connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Indicating we want TLS and wait for response.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Secure connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Received 'proceed' from remote server. Negotiating TLS...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Configured TrustManager class: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Attempting to instantiate 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager' using the three-argument constructor that is properietary to Openfire.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Constructed trust manager. Number of trusted issuers: 148, accepts self-signed: false, checks validity: true
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Successfully instantiated 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager'.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Attempting to verify a chain of 2 certificates.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Validating chain with 2 certificates, using 132 trust anchors.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Secure connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - TLS negotiation was successful. Connection secured. Proceeding with authentication...
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.util.CertificateManager - CertificateManager: Subject Alternative Name Mapping returned [*.DOMAIN.LOCAL, *.z.DOMAIN.LOCAL, DOMAIN.LOCAL]
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Secure connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - TLS negotiation was successful so initiate a new stream.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Remote server is offering dialback: false, EXTERNAL SASL: true
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Trying to authenticate with EXTERNAL SASL.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[EXTERNAL SASL for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL (Stream ID: 7i7n9eneo3)] - Starting EXTERNAL SASL.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[EXTERNAL SASL for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL (Stream ID: 7i7n9eneo3)] - EXTERNAL SASL was successful.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Successfully authenticated with EXTERNAL SASL.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate connection for: MYDOMAIN.LOCAL to: DOMAIN.LOCAL] - Successfully secured and authenticated connection!
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Successfully secured/authenticated the connection with TLS/SASL)!
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Create outgoing session for: MYDOMAIN.LOCAL to DOMAIN.LOCAL] - Successfully created new session!
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - Created a new session.
2021.10.15 18:09:06 TRACE [pool-20-thread-5]: org.jivesoftware.openfire.spi.LocalRoutingTable - Route 'DOMAIN.LOCAL' (for pair: '{MYDOMAIN.LOCAL -> DOMAIN.LOCAL}') added
2021.10.15 18:09:06 TRACE [Jetty-QTP-BOSH-69]: org.jivesoftware.openfire.http.HttpBindServlet - Data is available to be read from [[2a02:2454:543:2000:5850:46fb:2c9d:aa62]]
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession[Authenticate local domain: 'MYDOMAIN.LOCAL' to remote domain: 'DOMAIN.LOCAL'] - Authentication successful.
2021.10.15 18:09:06 TRACE [Jetty-QTP-BOSH-69]: org.jivesoftware.openfire.http.HttpBindServlet - All data has been read from [[2a02:2454:543:2000:5850:46fb:2c9d:aa62]]
2021.10.15 18:09:06 TRACE [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession - Authentication exists for outgoing domain pair {MYDOMAIN.LOCAL -> DOMAIN.LOCAL}: true
2021.10.15 18:09:06 DEBUG [Jetty-QTP-BOSH-69]: org.jivesoftware.openfire.http.HttpSession - Creating connection for rid: 1572623150 in session ikt4fi62b
2021.10.15 18:09:06 DEBUG [Jetty-QTP-BOSH-69]: org.jivesoftware.openfire.http.HttpSession - Updated session ikt4fi62b lastPoll to 2021-10-15T16:09:06.730Z with rid 1572623150 lastResponseEmpty = false overactivity = NONE deltaFromlastPoll = PT43.919S isPollingSession() = false maxRequests = 2 pendingConnections = 0
2021.10.15 18:09:06 DEBUG [Jetty-QTP-BOSH-69]: org.jivesoftware.openfire.http.HttpSession - Adding connection to stream ikt4fi62b with rid 1572623150
2021.10.15 18:09:06 TRACE [pool-20-thread-5]: org.jivesoftware.openfire.session.LocalOutgoingServerSession - Authentication exists for outgoing domain pair {MYDOMAIN.LOCAL -> DOMAIN.LOCAL}: true
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.igniterealtime.openfire.plugin.xep398.XEP398IQHandler - Read Avatar from PEPService (mops@MYDOMAIN.LOCAL)
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.igniterealtime.openfire.plugin.xep398.XEP398IQHandler - PEPService from mops@MYDOMAIN.LOCAL loaded successfully
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.igniterealtime.openfire.plugin.xep398.XEP398IQHandler - One of the following nodes were not found in PEP: urn:xmpp:avatar:data or urn:xmpp:avatar:metadata (mops@MYDOMAIN.LOCAL)
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.vcard.PhotoResizer - Original image size: 4110 bytes.
2021.10.15 18:09:06 DEBUG [pool-20-thread-5]: org.jivesoftware.openfire.vcard.PhotoResizer - Original image dimension (96x96) is within acceptable bounds (96x96). No need to resize.
2021.10.15 18:09:06 WARN [pool-20-thread-5]: org.igniterealtime.openfire.plugin.xep398.Avatar - getShrinkedImage: Cannot resize avatar. PhotoResizer.cropAndShrink failed!
2021.10.15 18:09:06 DEBUG [Socket Listener at port 5269]: org.jivesoftware.openfire.net.BlockingAcceptingMode - Connect Socket[addr=/87.173.86.154,port=59736,localport=5269]
2021.10.15 18:09:06 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Configured TrustManager class: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager
2021.10.15 18:09:06 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Attempting to instantiate 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager' using the three-argument constructor that is properietary to Openfire.
2021.10.15 18:09:06 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Constructed trust manager. Number of trusted issuers: 148, accepts self-signed: false, checks validity: true
2021.10.15 18:09:06 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Successfully instantiated 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager'.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketConnection - Peer certificates have not been verified - there are no certificates to return for: null
javax.net.ssl.SSLPeerUnverifiedException: peer not authenticated
at sun.security.ssl.SSLSessionImpl.getPeerCertificates(SSLSessionImpl.java:579) ~[?:1.8.0_292]
at org.jivesoftware.openfire.net.SocketConnection.getPeerCertificates(SocketConnection.java:443) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SASLAuthentication.getSASLMechanismsElement(SASLAuthentication.java:253) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SASLAuthentication.getSASLMechanisms(SASLAuthentication.java:204) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SocketReadingMode.tlsNegotiated(SocketReadingMode.java:113) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.BlockingReadingMode.tlsNegotiated(BlockingReadingMode.java:203) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.BlockingReadingMode.readStream(BlockingReadingMode.java:145) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.BlockingReadingMode.run(BlockingReadingMode.java:81) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SocketReader.run(SocketReader.java:150) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_292]
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Validating domain...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Check if the remote domain already has a connection to the target domain/subdomain
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Checking to see if the remote server provides stronger authentication based on SASL. If that's the case, dialback-based authentication can be skipped.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketConnection - Peer certificates have not been verified - there are no certificates to return for: null
javax.net.ssl.SSLPeerUnverifiedException: peer not authenticated
at sun.security.ssl.SSLSessionImpl.getPeerCertificates(SSLSessionImpl.java:579) ~[?:1.8.0_292]
at org.jivesoftware.openfire.net.SocketConnection.getPeerCertificates(SocketConnection.java:443) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.server.ServerDialback.validateRemoteDomain(ServerDialback.java:526) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.session.LocalIncomingServerSession.validateSubsequentDomain(LocalIncomingServerSession.java:246) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.ServerSocketReader.processUnknowPacket(ServerSocketReader.java:137) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SocketReader.process(SocketReader.java:247) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.BlockingReadingMode.readStream(BlockingReadingMode.java:188) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.BlockingReadingMode.run(BlockingReadingMode.java:81) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at org.jivesoftware.openfire.net.SocketReader.run(SocketReader.java:150) [xmppserver-4.7.0-SNAPSHOT.jar:4.7.0-SNAPSHOT]
at java.lang.Thread.run(Thread.java:748) [?:1.8.0_292]
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Unable to authenticate host based on stronger SASL. Proceeding with dialback...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketUtil - Creating a socket connection to XMPP domain 'DOMAIN.LOCAL' ...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketUtil - Use DNS to resolve remote hosts for the provided XMPP domain 'DOMAIN.LOCAL' (default port: 5269) ...
2021.10.15 18:09:07 TRACE [Server SR - 437571450]: org.jivesoftware.openfire.net.DNSUtil - DNS SRV Lookup for service 'xmpp-server', protocol 'tcp' and name 'DOMAIN.LOCAL'
2021.10.15 18:09:07 TRACE [Server SR - 437571450]: org.jivesoftware.openfire.net.DNSUtil - 1 SRV record(s) found for '_xmpp-server._tcp.DOMAIN.LOCAL.' (cached result)
2021.10.15 18:09:07 TRACE [Server SR - 437571450]: org.jivesoftware.openfire.net.DNSUtil - DNS SRV Lookup for service 'xmpps-server', protocol 'tcp' and name 'DOMAIN.LOCAL'
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.DNSUtil - No SRV record found for '_xmpps-server._tcp.DOMAIN.LOCAL.' (cached result)
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketUtil - Found 1 host(s) for XMPP domain 'DOMAIN.LOCAL'.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketUtil - - of1.z.DOMAIN.LOCAL:5269 (no direct TLS)
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketUtil - Trying to create socket connection to XMPP domain 'DOMAIN.LOCAL' using remote host: of1.z.DOMAIN.LOCAL:5269 (blocks up to 120000 ms) ...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.net.SocketUtil - Successfully created socket connection to XMPP domain 'DOMAIN.LOCAL' using remote host: of1.z.DOMAIN.LOCAL:5269!
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Verifying dialback key...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Opening a new connection to of1.z.DOMAIN.LOCAL/87.173.86.154:5269 that is initially not encrypted.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Verifying key ...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Configured TrustManager class: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Attempting to instantiate 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager' using the three-argument constructor that is properietary to Openfire.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Constructed trust manager. Number of trusted issuers: 148, accepts self-signed: false, checks validity: true
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Successfully instantiated 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager'.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Send the Authoritative Server a stream header and wait for answer.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Got a response.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - The remote server is XMPP 1.0 compliant (or at least reports to be).
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Negotiating StartTLS with AS...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Attempting to verify a chain of 2 certificates.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Validating chain with 2 certificates, using 132 trust anchors.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Successfully negotiated StartTLS with AS...
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Configured TrustManager class: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Attempting to instantiate 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager' using the three-argument constructor that is properietary to Openfire.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.keystore.OpenfireX509TrustManager - Constructed trust manager. Number of trusted issuers: 148, accepts self-signed: false, checks validity: true
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.spi.EncryptionArtifactFactory - Successfully instantiated 'class org.jivesoftware.openfire.keystore.OpenfireX509TrustManager'.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Send the Authoritative Server a stream header and wait for answer.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Got a response.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - The remote server is XMPP 1.0 compliant (or at least reports to be).
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Request for verification of the key and wait for response
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Key was VERIFIED by the Authoritative Server.
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Verify key with AS: DOMAIN.LOCAL for OS: MYDOMAIN.LOCAL (id 2lspamxdr9)] - Successfully verified key!
2021.10.15 18:09:07 DEBUG [Server SR - 437571450]: org.jivesoftware.openfire.server.ServerDialback[Acting as Receiving Server: Validate domain:MYDOMAIN.LOCAL(id 2lspamxdr9) for OS: DOMAIN.LOCAL] - Dialback key is valid. Sending verification result to remote domain.
I have wachted the log while i have tried to establish a connection with conversations … and the only messages were
2021.10.16 00:35:21 DEBUG [NioProcessor-3]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event SESSION_CLOSED to session 22
Queue : [SESSION_OPENED, , MESSAGE_RECEIVED, , MESSAGE_RECEIVED, , SESSION_CLOSED, ]
2021.10.16 00:35:30 DEBUG [NioProcessor-1]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event SESSION_OPENED to session 24
Queue : [SESSION_OPENED, ]
2021.10.16 00:35:30 DEBUG [NioProcessor-2]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event SESSION_OPENED to session 25
Queue : [SESSION_OPENED, ]
2021.10.16 00:35:30 DEBUG [NioProcessor-2]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event MESSAGE_RECEIVED to session 25
Queue : [SESSION_OPENED, , MESSAGE_RECEIVED, ]
2021.10.16 00:35:30 DEBUG [NioProcessor-2]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event MESSAGE_RECEIVED to session 25
Queue : [SESSION_OPENED, , MESSAGE_RECEIVED, , MESSAGE_RECEIVED, ]
2021.10.16 00:35:33 DEBUG [NioProcessor-2]: org.apache.mina.filter.executor.OrderedThreadPoolExecutor - Adding event MESSAGE_RECEIVED to session 25
Queue : [SESSION_OPENED, , MESSAGE_RECEIVED, , MESSAGE_RECEIVED, , MESSAGE_RECEIVED, ]
so the server recognized the connection but seems to hang… i furthermore noticed that invalid
sessions only occurs on tcp connections on port 5222 but not on the http port 7443/7070
@guus: If i go online and offline several times (> 3x) manually in Converations in a short time, the server won’t accept any new connection anymore on port 5222. Port 7443 is not affected