I was testing our game with 4-5 people, and then something happened, not for the first time, but no idea what happened, the clients were not disconnected, they only doesn't receive any updates, and when I was trying to connect to smartfoxserver from the admin tool I was receiving this error - Unable to connect to "IP:PORT" then this strange for me logs appear after 3 minutes, and we were able to connect to server without restarting:
Code: Select all
`07 Mar 2017 | 22:08:46,725 | INFO | qtp570794077-80 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 19, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:07:47,378 | INFO | qtp570794077-77 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 18, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:07:28,522 | INFO | qtp570794077-74 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 17, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:07:23,957 | INFO | qtp570794077-75 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 16, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:07:11,827 | INFO | qtp570794077-43 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 15, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:07:09,689 | INFO | qtp570794077-45 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 14, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:07:00,684 | INFO | qtp570794077-72 | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 13, Type: BLUEBOX, Logged: No, IP: null } on Server port: 0 <---> 0
07 Mar 2017 | 22:06:59,251 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 12, Type: DEFAULT, Logged: No, IP: asfdsf.178.52:35845 }
07 Mar 2017 | 22:06:55,781 | INFO | pool-1-thread-4 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 11, Type: DEFAULT, Logged: Yes, IP: asfdsf.242:50941 }
07 Mar 2017 | 22:09:04,353 | WARN | qtp570794077-77 | jetty.servlet.ServletHandler | | /BlueBox/BlueBox.do
java.lang.IllegalStateException: A session already exists with this id: bf51c9c3174a1052039b036fcee89e5b, Old session: {BBClient - { Id: 18, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }, bf51c9c3174a1052039b036fcee89e5b}
at sfs2x.bluebox.v3.BBConnectionManager.addClient(BBConnectionManager.java:132)
at sfs2x.bluebox.v3.SessionFilter.handleConnectionHandshake(SessionFilter.java:173)
at sfs2x.bluebox.v3.SessionFilter.doFilter(SessionFilter.java:131)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:119)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:524)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:319)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:253)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Unknown Source)
07 Mar 2017 | 22:06:55,131 | INFO | pool-1-thread-2 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 8, Type: DEFAULT, Logged: Yes, IP: 94.139.130.36:39363 }
07 Mar 2017 | 22:09:04,353 | WARN | qtp570794077-75 | jetty.servlet.ServletHandler | | /BlueBox/BlueBox.do
java.lang.IllegalStateException: A session already exists with this id: bf51c9c3174a1052039b036fcee89e5b, Old session: {BBClient - { Id: 16, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }, bf51c9c3174a1052039b036fcee89e5b}
at sfs2x.bluebox.v3.BBConnectionManager.addClient(BBConnectionManager.java:132)
at sfs2x.bluebox.v3.SessionFilter.handleConnectionHandshake(SessionFilter.java:173)
at sfs2x.bluebox.v3.SessionFilter.doFilter(SessionFilter.java:131)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:119)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:524)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:319)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:253)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Unknown Source)
07 Mar 2017 | 22:06:42,967 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 12, Type: DEFAULT, Logged: No, IP: asfdsf.178.52:35845 } on Server port: 9933 <---> 35845
07 Mar 2017 | 22:09:04,353 | WARN | qtp570794077-43 | jetty.servlet.ServletHandler | | /BlueBox/BlueBox.do
java.lang.IllegalStateException: A session already exists with this id: df76b435008e919684105eb2bfc78686, Old session: {BBClient - { Id: 15, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }, df76b435008e919684105eb2bfc78686}
at sfs2x.bluebox.v3.BBConnectionManager.addClient(BBConnectionManager.java:132)
at sfs2x.bluebox.v3.SessionFilter.handleConnectionHandshake(SessionFilter.java:173)
at sfs2x.bluebox.v3.SessionFilter.doFilter(SessionFilter.java:131)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1676)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:119)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:524)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:319)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:253)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.execute(ExecuteProduceConsume.java:100)
at org.eclipse.jetty.io.ManagedSelector.run(ManagedSelector.java:147)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Unknown Source)
07 Mar 2017 | 22:09:04,368 | INFO | SFSWorker:Ext:4 | v2.api.SFSApi | | User disconnected: { Zone: Vikings Fate }, ( User Name: 2314231488.155:109.5378, Id: 5, Priv: 0, Sess: 94.139.130.36:39363 ) , SessionLen: 278694, Type: Unity
07 Mar 2017 | 22:09:04,368 | INFO | pool-1-thread-2 | v2.api.SFSApi | | User disconnected: { Zone: Vikings Fate }, ( User Name: 2314231488.155:109.5378, Id: 5, Priv: 0, Sess: 94.139.130.36:39363 ) , SessionLen: 278693, Type: Unity
07 Mar 2017 | 22:09:04,362 | INFO | SFSWorker:Ext:2 | v2.api.SFSApi | | User disconnected: { Zone: Vikings Fate }, ( User Name: 2314231488.155:123.1058, Id: 8, Priv: 0, Sess: asfdsf.242:50941 ) , SessionLen: 160147, Type: Unity
07 Mar 2017 | 22:09:04,362 | INFO | pool-1-thread-4 | v2.api.SFSApi | | User disconnected: { Zone: Vikings Fate }, ( User Name: 2314231488.155:123.1058, Id: 8, Priv: 0, Sess: asfdsf.242:50941 ) , SessionLen: 160147, Type: Unity
07 Mar 2017 | 22:09:04,386 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 20, Type: DEFAULT, Logged: No, IP: 2314231488.155:55860 } on Server port: 9933 <---> 55860
07 Mar 2017 | 22:09:04,401 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 21, Type: DEFAULT, Logged: No, IP: asfdsf.242:37296 } on Server port: 9933 <---> 37296
07 Mar 2017 | 22:09:04,404 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 22, Type: DEFAULT, Logged: No, IP: asfdsf.242:60206 } on Server port: 9933 <---> 60206
07 Mar 2017 | 22:09:04,404 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 23, Type: DEFAULT, Logged: No, IP: asfdsf.242:41064 } on Server port: 9933 <---> 41064
07 Mar 2017 | 22:09:04,411 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 24, Type: DEFAULT, Logged: No, IP: asfdsf.242:34313 } on Server port: 9933 <---> 34313
07 Mar 2017 | 22:09:04,414 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 25, Type: DEFAULT, Logged: No, IP: asfdsf.178.52:49885 } on Server port: 9933 <---> 49885
07 Mar 2017 | 22:09:04,415 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 26, Type: DEFAULT, Logged: No, IP: asfdsf.242:46467 } on Server port: 9933 <---> 46467
07 Mar 2017 | 22:09:04,418 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 27, Type: DEFAULT, Logged: No, IP: asfdsf.242:55267 } on Server port: 9933 <---> 55267
07 Mar 2017 | 22:09:04,418 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 28, Type: DEFAULT, Logged: No, IP: 2314231488.155:33214 } on Server port: 9933 <---> 33214
07 Mar 2017 | 22:09:04,418 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 29, Type: DEFAULT, Logged: No, IP: 37.34.96.1:56121 } on Server port: 9933 <---> 56121
07 Mar 2017 | 22:09:04,419 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session created: { Id: 30, Type: DEFAULT, Logged: No, IP: 2314231488.155:55508 } on Server port: 9933 <---> 55508
07 Mar 2017 | 22:09:04,432 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 22, Type: DEFAULT, Logged: No, IP: asfdsf.242:60206 }
07 Mar 2017 | 22:09:04,432 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 25, Type: DEFAULT, Logged: No, IP: asfdsf.178.52:49885 }
07 Mar 2017 | 22:09:04,433 | INFO | SocketReader | bitswarm.core.SocketReader | | Socket closed: java.nio.channels.SocketChannel[closed]
07 Mar 2017 | 22:09:04,436 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 24, Type: DEFAULT, Logged: No, IP: asfdsf.242:34313 }
07 Mar 2017 | 22:09:04,439 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 21, Type: DEFAULT, Logged: No, IP: asfdsf.242:37296 }
07 Mar 2017 | 22:09:04,440 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 30, Type: DEFAULT, Logged: No, IP: 2314231488.155:55508 }
07 Mar 2017 | 22:09:04,444 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 20, Type: DEFAULT, Logged: No, IP: 2314231488.155:55860 }
07 Mar 2017 | 22:09:04,445 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 28, Type: DEFAULT, Logged: No, IP: 2314231488.155:33214 }
07 Mar 2017 | 22:09:04,449 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 29, Type: DEFAULT, Logged: No, IP: 37.34.96.1:56121 }
07 Mar 2017 | 22:09:04,452 | INFO | SocketReader | bitswarm.core.SocketReader | | Socket closed: java.nio.channels.SocketChannel[closed]
07 Mar 2017 | 22:09:04,453 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 26, Type: DEFAULT, Logged: No, IP: asfdsf.242:46467 }
07 Mar 2017 | 22:09:04,459 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 23, Type: DEFAULT, Logged: No, IP: asfdsf.242:41064 }
07 Mar 2017 | 22:09:04,460 | INFO | SocketReader | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 27, Type: DEFAULT, Logged: No, IP: asfdsf.242:55267 }
07 Mar 2017 | 22:09:04,597 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 13, Type: BLUEBOX, Logged: No, IP: asfdsf.178.52 }
07 Mar 2017 | 22:09:04,599 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 14, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }
07 Mar 2017 | 22:09:04,605 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 15, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }
07 Mar 2017 | 22:09:04,608 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 16, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }
07 Mar 2017 | 22:09:04,610 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 17, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }
07 Mar 2017 | 22:09:04,611 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 18, Type: BLUEBOX, Logged: No, IP: asfdsf.242 }
07 Mar 2017 | 22:09:04,612 | INFO | Scheduler1-thread-1 | bitswarm.sessions.DefaultSessionManager | | Session removed: { Id: 19, Type: BLUEBOX, Logged: No, IP: 2314231488.155 }
07 Mar 2017 | 22:09:04,727 | WARN | qtp570794077-81 | bluebox.v3.BlueBox | | Invalid request, session expired. Message: { ssid: d6d488b86ebe2dd93a960bdea069d8e3, cmd: poll, data: NoData }
07 Mar 2017 | 22:09:04,730 | WARN | qtp570794077-72 | bluebox.v3.BlueBox | | Invalid request, session expired. Message: { ssid: d6d488b86ebe2dd93a960bdea069d8e3, cmd: data, data: 48 bytes }
07 Mar 2017 | 22:09:04,849 | WARN | qtp570794077-75 | bluebox.v3.BlueBox | | Invalid request, session expired. Message: { ssid: aa68dc8bea4f072b6bb7758cffd6d46c, cmd: poll, data: NoData }
Please help me at least to find out what is causing this error