2014-06-12 14:01:40,567 INFO  [        ome.services.util.ServiceHandler] (l.Server-3)  Executor.doWork -- ome.services.sessions.SessionManagerImpl.executeCheckPasswordRO(guest)
2014-06-12 14:01:40,568 INFO  [        ome.services.util.ServiceHandler] (l.Server-3)  Args:	[null, InternalSF@6008138]
2014-06-12 14:01:40,570 INFO  [         ome.security.basic.EventHandler] (l.Server-3)  Auth:	user=0,group=0,event=null(Sessions),sess=05f58b4e-1ead-4ed5-b5a8-3238c7064e62
2014-06-12 14:01:40,573 INFO  [                 org.perf4j.TimingLogger] (l.Server-3) start[1402578100568] time[5] tag[omero.call.success.ome.services.sessions.SessionManagerImpl$8.doWork]
2014-06-12 14:01:40,574 INFO  [        ome.services.util.ServiceHandler] (l.Server-3)  Rslt:	true
2014-06-12 14:01:40,575 INFO  [        ome.services.util.ServiceHandler] (l.Server-2)  Executor.doWork -- ome.services.sessions.SessionManagerImpl.createSession
2014-06-12 14:01:40,575 INFO  [        ome.services.util.ServiceHandler] (l.Server-2)  Args:	[null, InternalSF@6008138]
2014-06-12 14:01:40,614 INFO  [         ome.security.basic.EventHandler] (l.Server-2)  Auth:	user=0,group=0,event=132745(Sessions),sess=05f58b4e-1ead-4ed5-b5a8-3238c7064e62
2014-06-12 14:01:40,637 INFO  [       ome.security.basic.CurrentDetails] (l.Server-2) Adding log:INSERT,class ome.model.meta.Session,7919
2014-06-12 14:01:40,664 INFO  [                 org.perf4j.TimingLogger] (l.Server-2) start[1402578100575] time[89] tag[omero.call.success.ome.services.sessions.SessionManagerImpl$2.doWork]
2014-06-12 14:01:40,665 INFO  [        ome.services.util.ServiceHandler] (l.Server-2)  Rslt:	(ome.model.meta.Experimenter:Id_1, ome.model.meta.ExperimenterGroup:Id_2, (2), ... 4 more)
2014-06-12 14:01:40,672 INFO  [ ome.services.blitz.fire.SessionManagerI] (l.Server-2) Created session ServiceFactoryI(session-c99aa31a-b90a-46cd-9f42-e31dcac100d6/412922fe-185d-4969-8395-9b1f62733d4e) for user guest (agent=OMERO.web)
2014-06-12 14:01:40,977 INFO  [                      omero.cmd.SessionI] (l.Server-8) Added servant to adapter: 412922fe-185d-4969-8395-9b1f62733d4e/c99aa31a-b90a-46cd-9f42-e31dcac100d6omero.api.ISession(omero.api._ISessionTie@981b8569)
2014-06-12 14:01:40,995 INFO  [        ome.services.util.ServiceHandler] (l.Server-7)  Meth:	interface ome.api.ISession.getSession
2014-06-12 14:01:40,996 INFO  [        ome.services.util.ServiceHandler] (l.Server-7)  Args:	[412922fe-185d-4969-8395-9b1f62733d4e]
2014-06-12 14:01:40,996 INFO  [                 org.perf4j.TimingLogger] (l.Server-7) start[1402578100996] time[0] tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2014-06-12 14:01:40,996 INFO  [        ome.services.util.ServiceHandler] (l.Server-7)  Rslt:	ome.model.meta.Session:Id_7919
2014-06-12 14:01:41,019 INFO  [                      omero.cmd.SessionI] (l.Server-5) Added servant to adapter: 412922fe-185d-4969-8395-9b1f62733d4e/c99aa31a-b90a-46cd-9f42-e31dcac100d6omero.api.IConfig(omero.api._IConfigTie@855a3dff)
2014-06-12 14:01:41,021 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Meth:	interface ome.api.IConfig.getConfigValue
2014-06-12 14:01:41,021 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Args:	[omero.router.insecure]
2014-06-12 14:01:41,036 INFO  [         ome.security.basic.EventHandler] (l.Server-0)  Auth:	user=1,group=2,event=132746(User),sess=412922fe-185d-4969-8395-9b1f62733d4e
2014-06-12 14:01:41,047 INFO  [                 org.perf4j.TimingLogger] (l.Server-0) start[1402578101021] time[26] tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2014-06-12 14:01:41,047 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Rslt:	OMERO.Glacier2/router:tcp -p 4063 -h @omero.host@
2014-06-12 14:01:41,051 INFO  [ ome.services.blitz.fire.SessionManagerI] (l.Server-1) Found session locally: 412922fe-185d-4969-8395-9b1f62733d4e
2014-06-12 14:01:41,053 INFO  [ ome.services.blitz.fire.SessionManagerI] (l.Server-1) Rejoining session ServiceFactoryI(session-a9acba02-90ab-4a8a-9ffa-33fa730954aa/412922fe-185d-4969-8395-9b1f62733d4e) (agent=OMERO.web;secure=False)
2014-06-12 14:01:41,055 INFO  [e.services.sessions.SessionContext$Count] (l.Server-3) -Reference count: 412922fe-185d-4969-8395-9b1f62733d4e=1
2014-06-12 14:01:41,055 INFO  [                      omero.cmd.SessionI] (l.Server-3) cleanupSelf(ServiceFactoryI(session-c99aa31a-b90a-46cd-9f42-e31dcac100d6/412922fe-185d-4969-8395-9b1f62733d4e)).
2014-06-12 14:01:41,055 INFO  [                      omero.cmd.SessionI] (l.Server-3) Unregistered servant:412922fe-185d-4969-8395-9b1f62733d4e/c99aa31a-b90a-46cd-9f42-e31dcac100d6omero.api.IConfig(omero.api._IConfigTie@855a3dff)
2014-06-12 14:01:41,055 INFO  [                      omero.cmd.SessionI] (l.Server-3) Removed servant from adapter: c99aa31a-b90a-46cd-9f42-e31dcac100d6omero.api.IConfig
2014-06-12 14:01:41,056 INFO  [                      omero.cmd.SessionI] (l.Server-3) Unregistered servant:412922fe-185d-4969-8395-9b1f62733d4e/c99aa31a-b90a-46cd-9f42-e31dcac100d6omero.api.ISession(omero.api._ISessionTie@981b8569)
2014-06-12 14:01:41,056 INFO  [                      omero.cmd.SessionI] (l.Server-3) Removed servant from adapter: c99aa31a-b90a-46cd-9f42-e31dcac100d6omero.api.ISession
2014-06-12 14:01:41,063 INFO  [                      omero.cmd.SessionI] (l.Server-3) Added servant to adapter: 412922fe-185d-4969-8395-9b1f62733d4e/a9acba02-90ab-4a8a-9ffa-33fa730954aaomero.api.IConfig(omero.api._IConfigTie@46b2c3df)
2014-06-12 14:01:41,064 INFO  [        ome.services.util.ServiceHandler] (l.Server-3)  Meth:	interface ome.api.IConfig.getConfigValue
2014-06-12 14:01:41,064 INFO  [        ome.services.util.ServiceHandler] (l.Server-3)  Args:	[omero.version]
2014-06-12 14:01:41,084 INFO  [         ome.security.basic.EventHandler] (l.Server-3)  Auth:	user=1,group=2,event=132747(User),sess=412922fe-185d-4969-8395-9b1f62733d4e
2014-06-12 14:01:41,089 INFO  [                 org.perf4j.TimingLogger] (l.Server-3) start[1402578101064] time[25] tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2014-06-12 14:01:41,089 INFO  [        ome.services.util.ServiceHandler] (l.Server-3)  Rslt:	4.4.8p1-ice33-b304
2014-06-12 14:01:41,103 INFO  [        ome.services.util.ServiceHandler] (l.Server-7)  Executor.doWork -- ome.services.sessions.SessionManagerImpl.executeCheckPasswordRO(shared)
2014-06-12 14:01:41,104 INFO  [        ome.services.util.ServiceHandler] (l.Server-7)  Args:	[null, InternalSF@6008138]
2014-06-12 14:01:41,105 INFO  [         ome.security.basic.EventHandler] (l.Server-7)  Auth:	user=0,group=0,event=null(Sessions),sess=05f58b4e-1ead-4ed5-b5a8-3238c7064e62
2014-06-12 14:01:41,120 INFO  [                 org.perf4j.TimingLogger] (l.Server-7) start[1402578101104] time[16] tag[omero.call.success.ome.services.sessions.SessionManagerImpl$8.doWork]
2014-06-12 14:01:41,121 INFO  [        ome.services.util.ServiceHandler] (l.Server-7)  Rslt:	true
2014-06-12 14:01:41,122 INFO  [        ome.services.util.ServiceHandler] (l.Server-5)  Executor.doWork -- ome.services.sessions.SessionManagerImpl.createSession
2014-06-12 14:01:41,122 INFO  [        ome.services.util.ServiceHandler] (l.Server-5)  Args:	[null, InternalSF@6008138]
2014-06-12 14:01:41,144 INFO  [         ome.security.basic.EventHandler] (l.Server-5)  Auth:	user=0,group=0,event=132748(Sessions),sess=05f58b4e-1ead-4ed5-b5a8-3238c7064e62
2014-06-12 14:01:41,160 INFO  [       ome.security.basic.CurrentDetails] (l.Server-5) Adding log:INSERT,class ome.model.meta.Session,7920
2014-06-12 14:01:41,222 INFO  [                 org.perf4j.TimingLogger] (l.Server-5) start[1402578101122] time[100] tag[omero.call.success.ome.services.sessions.SessionManagerImpl$2.doWork]
2014-06-12 14:01:41,222 INFO  [        ome.services.util.ServiceHandler] (l.Server-5)  Rslt:	(ome.model.meta.Experimenter:Id_2, ome.model.meta.ExperimenterGroup:Id_3, (3, 1), ... 4 more)
2014-06-12 14:01:41,224 INFO  [ ome.services.blitz.fire.SessionManagerI] (l.Server-5) Created session ServiceFactoryI(session-0e86f053-4b9d-4fb3-b455-712b32814a67/8bff4653-5b84-442f-bfbb-e8ac9d1a5764) for user shared (agent=OMERO.web)
2014-06-12 14:01:41,232 INFO  [                      omero.cmd.SessionI] (l.Server-0) Added servant to adapter: 8bff4653-5b84-442f-bfbb-e8ac9d1a5764/0e86f053-4b9d-4fb3-b455-712b32814a67omero.api.ISession(omero.api._ISessionTie@6574cff7)
2014-06-12 14:01:41,233 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Meth:	interface ome.api.ISession.getSession
2014-06-12 14:01:41,233 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Args:	[8bff4653-5b84-442f-bfbb-e8ac9d1a5764]
2014-06-12 14:01:41,233 INFO  [                 org.perf4j.TimingLogger] (l.Server-0) start[1402578101233] time[0] tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2014-06-12 14:01:41,233 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Rslt:	ome.model.meta.Session:Id_7920
2014-06-12 14:01:41,263 INFO  [                      omero.cmd.SessionI] (l.Server-6) Added servant to adapter: 8bff4653-5b84-442f-bfbb-e8ac9d1a5764/0e86f053-4b9d-4fb3-b455-712b32814a67omero.api.IConfig(omero.api._IConfigTie@43d89400)
2014-06-12 14:01:41,265 INFO  [        ome.services.util.ServiceHandler] (l.Server-6)  Meth:	interface ome.api.IConfig.getConfigValue
2014-06-12 14:01:41,266 INFO  [        ome.services.util.ServiceHandler] (l.Server-6)  Args:	[omero.router.insecure]
2014-06-12 14:01:41,280 INFO  [         ome.security.basic.EventHandler] (l.Server-6)  Auth:	user=2,group=3,event=132749(User),sess=8bff4653-5b84-442f-bfbb-e8ac9d1a5764
2014-06-12 14:01:41,287 INFO  [                 org.perf4j.TimingLogger] (l.Server-6) start[1402578101266] time[21] tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2014-06-12 14:01:41,287 INFO  [        ome.services.util.ServiceHandler] (l.Server-6)  Rslt:	OMERO.Glacier2/router:tcp -p 4063 -h @omero.host@
2014-06-12 14:01:41,291 INFO  [ ome.services.blitz.fire.SessionManagerI] (l.Server-8) Found session locally: 8bff4653-5b84-442f-bfbb-e8ac9d1a5764
2014-06-12 14:01:41,292 INFO  [ ome.services.blitz.fire.SessionManagerI] (l.Server-8) Rejoining session ServiceFactoryI(session-a282e53c-6a31-4cbb-b70e-65c865297f02/8bff4653-5b84-442f-bfbb-e8ac9d1a5764) (agent=OMERO.web;secure=False)
2014-06-12 14:01:41,294 INFO  [e.services.sessions.SessionContext$Count] (l.Server-7) -Reference count: 8bff4653-5b84-442f-bfbb-e8ac9d1a5764=1
2014-06-12 14:01:41,295 INFO  [                      omero.cmd.SessionI] (l.Server-7) cleanupSelf(ServiceFactoryI(session-0e86f053-4b9d-4fb3-b455-712b32814a67/8bff4653-5b84-442f-bfbb-e8ac9d1a5764)).
2014-06-12 14:01:41,295 INFO  [                      omero.cmd.SessionI] (l.Server-7) Unregistered servant:8bff4653-5b84-442f-bfbb-e8ac9d1a5764/0e86f053-4b9d-4fb3-b455-712b32814a67omero.api.IConfig(omero.api._IConfigTie@43d89400)
2014-06-12 14:01:41,295 INFO  [                      omero.cmd.SessionI] (l.Server-7) Removed servant from adapter: 0e86f053-4b9d-4fb3-b455-712b32814a67omero.api.IConfig
2014-06-12 14:01:41,295 INFO  [                      omero.cmd.SessionI] (l.Server-7) Unregistered servant:8bff4653-5b84-442f-bfbb-e8ac9d1a5764/0e86f053-4b9d-4fb3-b455-712b32814a67omero.api.ISession(omero.api._ISessionTie@6574cff7)
2014-06-12 14:01:41,295 INFO  [                      omero.cmd.SessionI] (l.Server-7) Removed servant from adapter: 0e86f053-4b9d-4fb3-b455-712b32814a67omero.api.ISession
2014-06-12 14:01:41,345 INFO  [                      omero.cmd.SessionI] (l.Server-4) Added servant to adapter: 8bff4653-5b84-442f-bfbb-e8ac9d1a5764/a282e53c-6a31-4cbb-b70e-65c865297f02omero.api.IAdmin(omero.api._IAdminTie@b4ec2226)
2014-06-12 14:01:41,360 INFO  [        ome.services.util.ServiceHandler] (l.Server-2)  Meth:	interface ome.api.IAdmin.getEventContext
2014-06-12 14:01:41,360 INFO  [        ome.services.util.ServiceHandler] (l.Server-2)  Args:	()
2014-06-12 14:01:41,363 INFO  [         ome.security.basic.EventHandler] (l.Server-2)  Auth:	user=2,group=3,event=null(User),sess=8bff4653-5b84-442f-bfbb-e8ac9d1a5764
2014-06-12 14:01:41,365 INFO  [        ome.services.util.ServiceHandler] (2-thread-1)  Executor.doWork -- ome.services.sessions.SessionManagerImpl.reload(8bff4653-5b84-442f-bfbb-e8ac9d1a5764)
2014-06-12 14:01:41,365 INFO  [        ome.services.util.ServiceHandler] (2-thread-1)  Args:	[null, InternalSF@6008138]
2014-06-12 14:01:41,382 INFO  [         ome.security.basic.EventHandler] (2-thread-1)  Auth:	user=0,group=0,event=null(Sessions),sess=05f58b4e-1ead-4ed5-b5a8-3238c7064e62
2014-06-12 14:01:41,392 INFO  [                 org.perf4j.TimingLogger] (2-thread-1) start[1402578101365] time[27] tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2014-06-12 14:01:41,392 INFO  [        ome.services.util.ServiceHandler] (2-thread-1)  Rslt:	(ome.model.meta.Experimenter:Id_2, ome.model.meta.ExperimenterGroup:Id_3, (3, 1), ... 4 more)
2014-06-12 14:01:41,393 INFO  [                 org.perf4j.TimingLogger] (l.Server-2) start[1402578101360] time[33] tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2014-06-12 14:01:41,393 INFO  [        ome.services.util.ServiceHandler] (l.Server-2)  Rslt:	ome.system.SimpleEventContext@4fe6def3
2014-06-12 14:01:41,397 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Meth:	interface ome.api.IAdmin.getSecurityRoles
2014-06-12 14:01:41,397 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Args:	()
2014-06-12 14:01:41,399 INFO  [         ome.security.basic.EventHandler] (l.Server-0)  Auth:	user=2,group=3,event=null(User),sess=8bff4653-5b84-442f-bfbb-e8ac9d1a5764
2014-06-12 14:01:41,400 INFO  [                 org.perf4j.TimingLogger] (l.Server-0) start[1402578101397] time[3] tag[omero.call.success.ome.logic.AdminImpl.getSecurityRoles]
2014-06-12 14:01:41,400 INFO  [        ome.services.util.ServiceHandler] (l.Server-0)  Rslt:	ome.system.Roles@67d1de8b