double disconnected event on server

[rav]

I use Java client API and sometimes I get double disconnection server event:

my disconnect handler

Code: Select all

public class DisconnectEventHandler extends BaseServerEventHandler
{

    @Override
    public void handleServerEvent(ISFSEvent event) throws SFSException
    {
         doSomeActionOnUserDisconnect();
    }
}

and my extension

Code: Select all

public class DBLogin extends SFSExtension {
    public void init()
    {
        addEventHandler(SFSEventType.USER_DISCONNECT,   DisconnectEventHandler.class);
     }
}

doSomeActionOnUserDisconnect() method is called twice from time to time
In logs I've found such trace:

Code: Select all

22 июл 2011 16:24:10,743 INFO  [SocketReader] v2.api.SFSApi     - User disconnected: ( User Name: 1000024, Id: 12, Priv: 1, Sess: 127.0.0.1:51308 ) 
22 июл 2011 16:24:10,743 INFO  [Scheduler1-thread-1] v2.entities.SFSZone     - User: 1000024 was disconnected.
22 июл 2011 16:24:10,744 INFO  [Scheduler1-thread-1] v2.api.SFSApi     - User disconnected: ( User Name: 1000024, Id: 12, Priv: 1, Sess: 127.0.0.1:51308 ) 
22 июл 2011 16:24:10,744 INFO  [SocketReader] bitswarm.core.SocketReader     - Socket closed: java.nio.channels.SocketChannel[closed]
22 июл 2011 16:24:10,745 INFO  [SocketReader] bitswarm.sessions.DefaultSessionManager     - Session removed: { Id: 14, Type: DEFAULT, Logged: Yes, IP: 127.0.0.1:51318 }
22 июл 2011 16:24:10,745 INFO  [Scheduler1-thread-1] bitswarm.sessions.DefaultSessionManager     - Session removed: { Id: 14, Type: DEFAULT, Logged: Yes, IP: 127.0.0.1:51318 }
22 июл 2011 16:24:10,746 INFO  [SocketReader] v2.entities.SFSZone     - User: 1000026 was disconnected.
22 июл 2011 16:24:10,746 INFO  [Scheduler1-thread-1] v2.entities.SFSZone     - User: 1000026 was disconnected.
22 июл 2011 16:24:10,746 INFO  [SocketReader] v2.api.SFSApi     - User disconnected: ( User Name: 1000026, Id: 13, Priv: 1, Sess: 127.0.0.1:51318 ) 
22 июл 2011 16:24:10,747 INFO  [Scheduler1-thread-1] v2.api.SFSApi     - User disconnected: ( User Name: 1000026, Id: 13, Priv: 1, Sess: 127.0.0.1:51318 ) 
22 июл 2011 16:24:10,747 INFO  [SocketReader] bitswarm.core.SocketReader     - Socket closed: java.nio.channels.SocketChannel[closed]
22 июл 2011 16:24:10,748 INFO  [Scheduler1-thread-1] bitswarm.sessions.DefaultSessionManager     - Session removed: { Id: 15, Type: DEFAULT, Logged: Yes, IP: 127.0.0.1:51328 }
22 июл 2011 16:24:10,748 INFO  [Scheduler1-thread-1] v2.entities.SFSZone     - User: 1000028 was disconnected.
22 июл 2011 16:24:10,748 INFO  [Scheduler1-thread-1] v2.api.SFSApi     - User disconnected: ( User Name: 1000028, Id: 14, Priv: 1, Sess: 127.0.0.1:51328 ) 
22 июл 2011 16:24:10,749 INFO  [Scheduler1-thread-1] bitswarm.sessions.DefaultSessionManager     - Session removed: { Id: 16, Type: DEFAULT, Logged: Yes, IP: 127.0.0.1:51338 }
22 июл 2011 16:24:10,749 INFO  [Scheduler1-thread-1] v2.entities.SFSZone     - User: 1000030 was disconnected.
22 июл 2011 16:24:10,750 INFO  [Scheduler1-thread-1] v2.api.SFSApi     - User disconnected: ( User Name: 1000030, Id: 15, Priv: 1, Sess: 127.0.0.1:51338 ) 
22 июл 2011 16:24:10,750 INFO  [Scheduler1-thread-1] bitswarm.sessions.DefaultSessionManager     - Session removed: { Id: 17, Type: DEFAULT, Logged: Yes, IP: 127.0.0.1:51348 }

note: User: 1000026 was disconnected in SocketReader and in Scheduler1-thread-1

[Lapo]

This doesn't pose any problems, you can ignore the message.