Users being disconnected

Hello we have a problem,

Users on chat get kicked in around 10-15 minutes when they are on, and they they cannot immediatelly login. We have SSL connection and http-bind BOSH trough SSL. Is there any clue what wrong? We are using openfire 3.9.3 also here is another problem we have

  1. We have openfire working on both http and https

  2. All works fine, except sometimes on refresh user authorization not happens

  3. It happens after few refreshes

  4. Seems like there maybe some timeout or some other thing

Here is the logs for the first thing i asked

error log:

at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)

at org.eclipse.jetty.server.nio.SelectChannelConnector.open(SelectChannelConnector .java:172)

at org.eclipse.jetty.server.AbstractConnector.doStart(AbstractConnector.java:300)

at org.eclipse.jetty.server.nio.SelectChannelConnector.doStart(SelectChannelConnec tor.java:249)

at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java :59)

at org.eclipse.jetty.server.Server.doStart(Server.java:272)

at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java :59)

at org.jivesoftware.openfire.http.HttpBindManager.start(HttpBindManager.java:166)

at org.jivesoftware.openfire.spi.ConnectionManagerImpl.startHTTPBindListeners(Conn ectionManagerImpl.java:564)

at org.jivesoftware.openfire.spi.ConnectionManagerImpl.startListeners(ConnectionMa nagerImpl.java:180)

at org.jivesoftware.openfire.spi.ConnectionManagerImpl.access$000(ConnectionManage rImpl.java:97)

at org.jivesoftware.openfire.spi.ConnectionManagerImpl$1.pluginsMonitored(Connecti onManagerImpl.java:152)

at org.jivesoftware.openfire.container.PluginManager.firePluginsMonitored(PluginMa nager.java:568)

at org.jivesoftware.openfire.container.PluginManager.access$800(PluginManager.java :80)

at org.jivesoftware.openfire.container.PluginManager$PluginMonitor.run(PluginManag er.java:1084)

at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)

at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:304)

at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301 (ScheduledThreadPoolExecutor.java:178)

at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Schedu ledThreadPoolExecutor.java:293)

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)

at java.lang.Thread.run(Thread.java:745)

java.net.BindException: Address already in use

at sun.nio.ch.Net.bind0(Native Method)

at sun.nio.ch.Net.bind(Net.java:444)

at sun.nio.ch.Net.bind(Net.java:436)

at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:214)

at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)

at org.eclipse.jetty.server.nio.SelectChannelConnector.open(SelectChannelConnector .java:172)

at org.eclipse.jetty.server.AbstractConnector.doStart(AbstractConnector.java:300)

at org.eclipse.jetty.server.nio.SelectChannelConnector.doStart(SelectChannelConnec tor.java:249)

at org.eclipse.jetty.server.ssl.SslSelectChannelConnector.doStart(SslSelectChannel Connector.java:612)

at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java :59)

at org.eclipse.jetty.server.Server.doStart(Server.java:272)

warn log:

2015.10.28 05:25:57 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 91744f6. [98.236.105.148]

2015.10.28 05:45:46 org.jivesoftware.openfire.IQRouter - User tried to authenticate with this server using an unknown receipient: http://jabber.org/protocol/muc#roomconfig01

2015.10.28 05:46:18 org.jivesoftware.openfire.IQRouter - User tried to authenticate with this server using an unknown receipient: http://jabber.org/protocol/muc#roomconfig01

2015.10.28 05:46:34 org.jivesoftware.openfire.IQRouter - User tried to authenticate with this server using an unknown receipient: http://jabber.org/protocol/muc#roomconfig01

2015.10.28 05:51:52 org.jivesoftware.openfire.IQRouter - Error or result packet could not be delivered http://jabber.org/protocol/muc#roomconfig01

2015.10.28 06:10:01 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: e217b2be. [208.101.91.120]

2015.10.28 06:14:22 org.jivesoftware.openfire.IQRouter - User tried to authenticate with this server using an unknown receipient: http://jabber.org/protocol/muc#roomconfig01

2015.10.28 07:26:49 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: f832b1b7. [124.44.111.250]

2015.10.28 07:29:44 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 90eb37df. [200.201.184.104]

2015.10.28 07:31:42 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 70eb2907. [98.236.105.148]

2015.10.28 07:42:56 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 3413fbd6. [191.223.255.92]

2015.10.28 07:44:26 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: cfc826f1. [191.223.255.92]

2015.10.28 07:47:43 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 66fec95e. [78.187.141.244]

2015.10.28 07:54:15 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 884b20a5. [98.236.105.148]

2015.10.28 08:00:49 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: dae2154a. [124.182.137.117]

2015.10.28 08:22:11 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: cb0db465. [198.60.24.141]

2015.10.28 08:36:29 org.jivesoftware.openfire.IQRouter - User tried to authenticate with this server using an unknown receipient: http://jabber.org/protocol/muc#roomconfig01

2015.10.28 08:41:52 org.jivesoftware.openfire.IQRouter - Error or result packet could not be delivered http://jabber.org/protocol/muc#roomconfig01

2015.10.28 08:42:22 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 78f06139. [50.121.192.92]

2015.10.28 08:43:22 org.jivesoftware.openfire.http.HttpBindServlet - Error parsing user request. [173.70.120.126]

2015.10.28 08:53:18 org.jivesoftware.openfire.http.HttpSession - Deliverable unavailable for 3845084617

2015.10.28 09:02:34 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 553af0ca. [24.44.223.63]

2015.10.28 09:10:31 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 7256fc22. [82.170.135.223]

2015.10.28 09:19:06 org.jivesoftware.admin.LoginLimitManager - Failed admin console login attempt by admin from 127.0.0.1

2015.10.28 09:25:34 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: abc5a444. [71.92.60.78]

2015.10.28 09:32:30 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 3c6ddcac. [174.101.231.30]

2015.10.28 09:32:32 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 3c6ddcac. [174.101.231.30]

2015.10.28 09:35:33 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 9a072073. [97.83.65.136]

2015.10.28 09:48:41 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 4d4648c5. [198.60.24.141]

2015.10.28 10:20:03 org.jivesoftware.openfire.http.HttpSession - Request 3618569181 > 3618569180, ending session.

2015.10.28 10:20:03 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 1b4fd1db. [124.182.137.117]

2015.10.28 10:29:31 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 8c637359. [170.72.15.1]

2015.10.28 10:37:20 org.jivesoftware.admin.LoginLimitManager - Failed admin console login attempt by admin from 127.0.0.1

2015.10.28 10:37:30 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 39d697d1. [90.216.252.32]

2015.10.28 10:43:13 org.jivesoftware.admin.LoginLimitManager - Failed admin console login attempt by admin from 24.167.239.75

2015.10.28 10:55:27 org.jivesoftware.openfire.IQRouter - User tried to authenticate with this server using an unknown receipient: http://jabber.org/protocol/muc#roomconfig01

2015.10.28 11:00:52 org.jivesoftware.openfire.IQRouter - Error or result packet could not be delivered http://jabber.org/protocol/muc#roomconfig01

2015.10.28 11:03:20 org.jivesoftware.openfire.http.HttpSession - Deliverable unavailable for 1282414785

2015.10.28 11:20:52 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: e16fcacc. [90.216.252.32]

2015.10.28 11:25:21 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 2eb16173. [71.92.60.78]

2015.10.28 11:31:21 org.jivesoftware.openfire.http.HttpSession - Deliverable unavailable for 2288649858

2015.10.28 11:31:21 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 224132aa. [85.76.78.142]

2015.10.28 11:40:18 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: d6e346ca. [182.65.97.65]

2015.10.28 11:47:16 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 5ae32e83. [98.17.137.234]

2015.10.28 12:02:01 org.jivesoftware.admin.LoginLimitManager - Failed admin console login attempt by admin from 127.0.0.1

2015.10.28 12:02:37 org.jivesoftware.openfire.http.HttpBindServlet - Client provided invalid session: 8866faca. [208.101.91.120]

2015.10.28 12:02:51 org.jivesoftware.admin.LoginLimitManager - Failed admin console login attempt by admin from 24.167.239.75

debug log:

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING

bytesConsumed = 546 bytesProduced = 602

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress true

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flushed=602 left=0

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress true

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress false

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] received 0 sent 546

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush1

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] process closing=false in=null out=

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING

bytesConsumed = 134 bytesProduced = 194

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress true

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flushed=194 left=0

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress true

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress false

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] received 0 sent 134

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] fill

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] unwrap space=16921 open=true

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] filled 0

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] process closing=false in=java.nio.HeapByteBuffer[pos=0 lim=16916 cap=16916] out=null

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:07 ssl - status 26c260[SSLEngine[hostname=127.0.0.1 port=60499] SSL_DHE_RSA_WITH_3DES_EDE_CBC_SHA] NOT_HANDSHAKING

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] progress false

2015.10.19 15:05:07 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] received 0 sent 0

2015.10.19 15:05:08 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] fill

2015.10.19 15:05:08 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] unwrap space=16921 open=true

2015.10.19 15:05:08 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] filled -1

2015.10.19 15:05:08 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] close

2015.10.19 15:05:08 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] process closing=true in=null out=null

2015.10.19 15:05:08 ssl - [Session-1, SSL_NULL_WITH_NULL_NULL] flush

2015.10.19 15:05:10 org.jivesoftware.openfire.http.HttpSession - consumeResponse: org.jivesoftware.openfire.http.HttpSession@118cd44 status: 1 address: usachatnow.com/2b644e0f id: 2b644e0f presence:

rid: 2660122509

2015.10.19 15:05:10 org.jivesoftware.openfire.http.HttpSession - consumeResponse: org.jivesoftware.openfire.http.HttpSession@118cd44 status: 1 address: usachatnow.com/2b644e0f id: 2b644e0f presence:

rid: 2660122509

would greatly appreciate any help on this???

It appears via your stack trace that you may have more than one Openfire process running, or some other process is using the server port(s):

java.net.BindException: Address already in use

Not sure if this is the root cause, but certainly something to investigate.