[ome-users] Upgraded but LDAP users can't pull their groups

Leon Kolchinsky lkolchin at gmail.com
Tue Aug 16 00:42:27 BST 2011


Thanks Josh,

The thing is that our users residing in several OU's (Staff, Students,
ExternbalUsers...)
I've checked again and users from Staff OU can login without an issue but
users from another OU=External Users can't (I just couldn't check it
yeaterday with someone else's username from Staff OU, and only had details
of users in External Users OU).

So looking at Blitz-0.log, here is how the successfull login looks like:

2011-08-16 09:27:41,810 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.executeCheckPasswordRO(guest)
2011-08-16 09:27:41,810 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:41,811 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:41,814 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450861810] time[4]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$8.doWork]
2011-08-16 09:27:41,814 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    true
2011-08-16 09:27:41,817 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.createSession
2011-08-16 09:27:41,817 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:41,844 INFO  [         ome.security.basic.EventHandler]
(l.Server-8)  Auth:
user=0,group=0,event=60614(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:41,856 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-8) Adding log:INSERT,class ome.model.meta.Session,6675
2011-08-16 09:27:41,872 INFO  [                 org.perf4j.TimingLogger]
(l.Server-8) start[1313450861817] time[55]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$2.doWork]
2011-08-16 09:27:41,872 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Rslt:    (ome.model.meta.Experimenter:Id_1,
ome.model.meta.ExperimenterGroup:Id_2, [2], ... 4 more)
2011-08-16 09:27:41,876 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-8) Created session
ServiceFactoryI(session-cf2d35f8-f66d-4abf-bdd9-02d97c692848/2efd291e-1437-4f21-9f62-4d6560710ed6)
for user guest (agent=OMERO.web)
2011-08-16 09:27:41,881 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-5) Added servant to adapter:
2efd291e-1437-4f21-9f62-4d6560710ed6/cf2d35f8-f66d-4abf-bdd9-02d97c692848omero.api.ISession(omero.api._ISessionTie at 143bed82
)
2011-08-16 09:27:41,883 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Meth:    interface ome.api.ISession.getSession
2011-08-16 09:27:41,883 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Args:    [2efd291e-1437-4f21-9f62-4d6560710ed6]
2011-08-16 09:27:41,883 INFO  [                 org.perf4j.TimingLogger]
(l.Server-5) start[1313450861883] time[0]
tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2011-08-16 09:27:41,883 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Rslt:    ome.model.meta.Session:Id_6675
2011-08-16 09:27:41,893 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-5) Added servant to adapter:
2efd291e-1437-4f21-9f62-4d6560710ed6/cf2d35f8-f66d-4abf-bdd9-02d97c692848omero.api.IAdmin(omero.api._IAdminTie at 48ae81dd
)
2011-08-16 09:27:41,894 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:27:41,894 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Args:    ()
2011-08-16 09:27:41,896 INFO  [         ome.security.basic.EventHandler]
(l.Server-5)  Auth:
user=1,group=2,event=null(User),sess=2efd291e-1437-4f21-9f62-4d6560710ed6
2011-08-16 09:27:41,897 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(2efd291e-1437-4f21-9f62-4d6560710ed6)
2011-08-16 09:27:41,897 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:41,903 INFO  [         ome.security.basic.EventHandler]
(-thread-24)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:41,913 INFO  [                 org.perf4j.TimingLogger]
(-thread-24) start[1313450861897] time[16]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:27:41,913 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Rslt:    (ome.model.meta.Experimenter:Id_1,
ome.model.meta.ExperimenterGroup:Id_2, [2], ... 4 more)
2011-08-16 09:27:41,914 INFO  [                 org.perf4j.TimingLogger]
(l.Server-5) start[1313450861894] time[20]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:27:41,914 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Rslt:    ome.system.SimpleEventContext at 5afa24c9
2011-08-16 09:27:41,918 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-2) Added servant to adapter:
2efd291e-1437-4f21-9f62-4d6560710ed6/cf2d35f8-f66d-4abf-bdd9-02d97c692848omero.api.IConfig(omero.api._IConfigTie at 224396cd
)
2011-08-16 09:27:41,920 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Meth:    interface ome.api.IConfig.getConfigValue
2011-08-16 09:27:41,920 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Args:    [omero.version]
2011-08-16 09:27:41,935 INFO  [         ome.security.basic.EventHandler]
(l.Server-2)  Auth:
user=1,group=2,event=60615(User),sess=2efd291e-1437-4f21-9f62-4d6560710ed6
2011-08-16 09:27:41,939 INFO  [                 org.perf4j.TimingLogger]
(l.Server-2) start[1313450861920] time[19]
tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2011-08-16 09:27:41,939 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Rslt:    4.3.1-6d4b8c61-b2602
2011-08-16 09:27:41,957 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.executeCheckPasswordRO(ajft)
2011-08-16 09:27:41,957 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:41,958 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:41,959 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450861957] time[2]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$8.doWork]
2011-08-16 09:27:41,959 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    null
2011-08-16 09:27:41,959 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.executeCheckPasswordRW(ajft)
2011-08-16 09:27:41,959 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:41,972 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=0,group=0,event=60616(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:42,496 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,203
2011-08-16 09:27:42,498 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,204
2011-08-16 09:27:42,500 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,205
2011-08-16 09:27:42,501 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,206
2011-08-16 09:27:42,503 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,207
2011-08-16 09:27:42,505 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,208
2011-08-16 09:27:42,506 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,209
2011-08-16 09:27:42,508 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,210
2011-08-16 09:27:42,510 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,211
2011-08-16 09:27:42,511 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,212
2011-08-16 09:27:42,513 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,213
2011-08-16 09:27:42,515 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,214
2011-08-16 09:27:42,517 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,215
2011-08-16 09:27:42,519 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,216
2011-08-16 09:27:42,520 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,217
2011-08-16 09:27:42,523 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,218
2011-08-16 09:27:42,549 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.ExperimenterGroup,219
2011-08-16 09:27:42,573 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.Experimenter,652
2011-08-16 09:27:42,632 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,653
2011-08-16 09:27:42,637 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,654
2011-08-16 09:27:42,639 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,655
2011-08-16 09:27:42,642 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,656
2011-08-16 09:27:42,644 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,657
2011-08-16 09:27:42,648 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,658
2011-08-16 09:27:42,651 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,659
2011-08-16 09:27:42,654 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,660
2011-08-16 09:27:42,657 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,661
2011-08-16 09:27:42,660 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,662
2011-08-16 09:27:42,663 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,663
2011-08-16 09:27:42,666 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,664
2011-08-16 09:27:42,670 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,665
2011-08-16 09:27:42,674 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,666
2011-08-16 09:27:42,677 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,667
2011-08-16 09:27:42,681 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,668
2011-08-16 09:27:42,685 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,669
2011-08-16 09:27:42,690 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-7) Adding log:INSERT,class ome.model.meta.GroupExperimenterMap,670
2011-08-16 09:27:42,742 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450861959] time[783]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$9.doWork]
2011-08-16 09:27:42,742 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    true
2011-08-16 09:27:42,743 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.createSession
2011-08-16 09:27:42,743 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:42,809 INFO  [         ome.security.basic.EventHandler]
(l.Server-8)  Auth:
user=0,group=0,event=60617(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:42,842 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-8) Adding log:INSERT,class ome.model.meta.Session,6676
2011-08-16 09:27:42,856 INFO  [                 org.perf4j.TimingLogger]
(l.Server-8) start[1313450862744] time[112]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$2.doWork]
2011-08-16 09:27:42,856 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Rslt:    (ome.model.meta.Experimenter:Id_652,
ome.model.meta.ExperimenterGroup:Id_203, [203, 205, 204, 207, 206, 216, 217,
218, 219, 212, 213, 214, 215, 208, 209, 210, 211, 1], ... 4 more)
2011-08-16 09:27:42,858 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-8) Created session
ServiceFactoryI(session-a4a0353e-b8bd-42f9-a9e5-464376669558/ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
for user ajft (agent=OMERO.web)
2011-08-16 09:27:42,863 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-1) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/a4a0353e-b8bd-42f9-a9e5-464376669558omero.api.ISession(omero.api._ISessionTie at 7e970be7
)
2011-08-16 09:27:42,864 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.ISession.getSession
2011-08-16 09:27:42,864 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    [ff2e7caf-f1dd-4df4-b6f3-7cc014619816]
2011-08-16 09:27:42,864 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313450862864] time[0]
tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2011-08-16 09:27:42,864 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    ome.model.meta.Session:Id_6676
2011-08-16 09:27:42,871 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-4) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/a4a0353e-b8bd-42f9-a9e5-464376669558omero.api.IConfig(omero.api._IConfigTie at 698adc62
)
2011-08-16 09:27:42,872 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.IConfig.getConfigValue
2011-08-16 09:27:42,872 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    [omero.router.insecure]
2011-08-16 09:27:42,900 INFO  [         ome.security.basic.EventHandler]
(l.Server-4)  Auth:
user=652,group=203,event=60618(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,904 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313450862872] time[32]
tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2011-08-16 09:27:42,904 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    OMERO.Glacier2/router:tcp -p 4063 -h @omero.host@
2011-08-16 09:27:42,912 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-2) Found session locally: ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,914 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-2) Rejoining session
ServiceFactoryI(session-c4e52d45-b19b-4934-b006-140ef665e972/ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
(agent=OMERO.web;secure=False)
2011-08-16 09:27:42,916 INFO  [e.services.sessions.SessionContext$Count]
(l.Server-7) -Reference count: ff2e7caf-f1dd-4df4-b6f3-7cc014619816=1
2011-08-16 09:27:42,919 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-7) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/c4e52d45-b19b-4934-b006-140ef665e972omero.api.IConfig(omero.api._IConfigTie at 5017a6a0
)
2011-08-16 09:27:42,921 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Meth:    interface ome.api.IConfig.getConfigValue
2011-08-16 09:27:42,921 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [omero.router.insecure]
2011-08-16 09:27:42,934 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=652,group=203,event=60619(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,938 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450862921] time[17]
tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2011-08-16 09:27:42,938 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    OMERO.Glacier2/router:tcp -p 4063 -h @omero.host@
2011-08-16 09:27:42,945 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-3) Found session locally: ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,947 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-3) Rejoining session
ServiceFactoryI(session-3d5e88a4-7e2e-420d-b5b5-27d9cd174a09/ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
(agent=OMERO.web;secure=False;secure=False)
2011-08-16 09:27:42,949 INFO  [e.services.sessions.SessionContext$Count]
(l.Server-0) -Reference count: ff2e7caf-f1dd-4df4-b6f3-7cc014619816=1
2011-08-16 09:27:42,953 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-0) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/3d5e88a4-7e2e-420d-b5b5-27d9cd174a09omero.api.IAdmin(omero.api._IAdminTie at 6e6970b6
)
2011-08-16 09:27:42,954 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:27:42,954 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Args:    ()
2011-08-16 09:27:42,955 INFO  [         ome.security.basic.EventHandler]
(l.Server-0)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,956 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
2011-08-16 09:27:42,956 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:42,956 INFO  [         ome.security.basic.EventHandler]
(-thread-24)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:42,963 INFO  [                 org.perf4j.TimingLogger]
(-thread-24) start[1313450862956] time[7]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:27:42,963 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Rslt:    (ome.model.meta.Experimenter:Id_652,
ome.model.meta.ExperimenterGroup:Id_203, [203, 205, 204, 207, 206, 216, 217,
218, 219, 212, 213, 214, 215, 208, 209, 210, 211, 1], ... 4 more)
2011-08-16 09:27:42,964 INFO  [                 org.perf4j.TimingLogger]
(l.Server-0) start[1313450862954] time[10]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:27:42,964 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Rslt:    ome.system.SimpleEventContext at 7546459c
2011-08-16 09:27:42,967 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Meth:    interface ome.api.IAdmin.getExperimenter
2011-08-16 09:27:42,967 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Args:    [652]
2011-08-16 09:27:42,968 INFO  [         ome.security.basic.EventHandler]
(l.Server-8)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,973 INFO  [                 org.perf4j.TimingLogger]
(l.Server-8) start[1313450862967] time[6]
tag[omero.call.success.ome.logic.AdminImpl.getExperimenter]
2011-08-16 09:27:42,974 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Rslt:    ome.model.meta.Experimenter:Id_652
2011-08-16 09:27:42,980 INFO  [e.services.sessions.SessionContext$Count]
(l.Server-1) -Reference count: 2efd291e-1437-4f21-9f62-4d6560710ed6=0
2011-08-16 09:27:42,992 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:27:42,992 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Args:    ()
2011-08-16 09:27:42,993 INFO  [         ome.security.basic.EventHandler]
(l.Server-1)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:42,993 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
2011-08-16 09:27:42,993 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:42,994 INFO  [         ome.security.basic.EventHandler]
(-thread-24)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:43,000 INFO  [                 org.perf4j.TimingLogger]
(-thread-24) start[1313450862993] time[7]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:27:43,001 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Rslt:    (ome.model.meta.Experimenter:Id_652,
ome.model.meta.ExperimenterGroup:Id_203, [203, 205, 204, 207, 206, 216, 217,
218, 219, 212, 213, 214, 215, 208, 209, 210, 211, 1], ... 4 more)
2011-08-16 09:27:43,001 INFO  [                 org.perf4j.TimingLogger]
(l.Server-1) start[1313450862992] time[9]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:27:43,001 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Rslt:    ome.system.SimpleEventContext at 7f24d879
2011-08-16 09:27:43,003 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Meth:    interface ome.api.IAdmin.getExperimenter
2011-08-16 09:27:43,003 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Args:    [652]
2011-08-16 09:27:43,004 INFO  [         ome.security.basic.EventHandler]
(l.Server-3)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:43,009 INFO  [                 org.perf4j.TimingLogger]
(l.Server-3) start[1313450863003] time[6]
tag[omero.call.success.ome.logic.AdminImpl.getExperimenter]
2011-08-16 09:27:43,010 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Rslt:    ome.model.meta.Experimenter:Id_652
2011-08-16 09:27:43,022 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.IAdmin.lookupGroup
2011-08-16 09:27:43,022 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    [user]
2011-08-16 09:27:43,023 INFO  [         ome.security.basic.EventHandler]
(l.Server-4)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:43,031 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313450863022] time[9]
tag[omero.call.success.ome.logic.AdminImpl.lookupGroup]
2011-08-16 09:27:43,031 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    ome.model.meta.ExperimenterGroup:Id_1
2011-08-16 09:27:45,950 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-6) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/3d5e88a4-7e2e-420d-b5b5-27d9cd174a09omero.api.IConfig(omero.api._IConfigTie at 676f64cc
)
2011-08-16 09:27:45,952 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Meth:    interface ome.api.IConfig.getConfigValue
2011-08-16 09:27:45,952 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Args:    [omero.version]
2011-08-16 09:27:45,967 INFO  [         ome.security.basic.EventHandler]
(l.Server-6)  Auth:
user=652,group=203,event=60620(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:45,970 INFO  [                 org.perf4j.TimingLogger]
(l.Server-6) start[1313450865953] time[17]
tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2011-08-16 09:27:45,970 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Rslt:    4.3.1-6d4b8c61-b2602
2011-08-16 09:27:45,987 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-9) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/3d5e88a4-7e2e-420d-b5b5-27d9cd174a09omero.api.IQuery(omero.api._IQueryTie at 36495ac8
)
2011-08-16 09:27:45,990 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:45,990 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Args:    [select distinct obj from ExperimenterGroup as obj
left outer join fetch obj.groupExperimenterMap as map left outer join fetch
map.child e where obj.id in (:ids), PARAMS:ids=ArrayList(1) ]
2011-08-16 09:27:45,991 INFO  [         ome.security.basic.EventHandler]
(l.Server-9)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:45,996 INFO  [                 org.perf4j.TimingLogger]
(l.Server-9) start[1313450865990] time[6]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:45,996 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203)
2011-08-16 09:27:46,002 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,003 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Args:    [select e from ExperimenterGroup as e where e.id in
(:ids), PARAMS:ids=ArrayList(17) ]
2011-08-16 09:27:46,003 INFO  [         ome.security.basic.EventHandler]
(l.Server-5)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,012 INFO  [                 org.perf4j.TimingLogger]
(l.Server-5) start[1313450866003] time[9]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,013 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203,
ome.model.meta.ExperimenterGroup:Id_204,
ome.model.meta.ExperimenterGroup:Id_205, ... 14 more)
2011-08-16 09:27:46,427 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,427 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Args:    [select distinct obj from ExperimenterGroup as obj
left outer join fetch obj.groupExperimenterMap as map left outer join fetch
map.child e where obj.id in (:ids), PARAMS:ids=ArrayList(1) ]
2011-08-16 09:27:46,429 INFO  [         ome.security.basic.EventHandler]
(l.Server-1)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,439 INFO  [                 org.perf4j.TimingLogger]
(l.Server-1) start[1313450866427] time[12]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,440 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203)
2011-08-16 09:27:46,444 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,445 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    [select e from ExperimenterGroup as e where e.id in
(:ids), PARAMS:ids=ArrayList(17) ]
2011-08-16 09:27:46,446 INFO  [         ome.security.basic.EventHandler]
(l.Server-4)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,450 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313450866445] time[5]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,451 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203,
ome.model.meta.ExperimenterGroup:Id_204,
ome.model.meta.ExperimenterGroup:Id_205, ... 14 more)
2011-08-16 09:27:46,462 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-2) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/3d5e88a4-7e2e-420d-b5b5-27d9cd174a09omero.api.ITimeline(omero.api._ITimelineTie at 214e13e
)
2011-08-16 09:27:46,464 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Executor.doWork --
ome.services.blitz.impl.TimelineI.getMostRecentObjects
2011-08-16 09:27:46,464 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:46,466 INFO  [         ome.security.basic.EventHandler]
(l.Server-2)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,487 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-6) Found session locally: ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,489 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-6) Rejoining session
ServiceFactoryI(session-290df595-e731-4ccf-b171-4536a9f34c42/ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
(agent=OMERO.web)
2011-08-16 09:27:46,493 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-7) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/290df595-e731-4ccf-b171-4536a9f34c42omero.api.ISession(omero.api._ISessionTie at 1fc643f5
)
2011-08-16 09:27:46,495 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Meth:    interface ome.api.ISession.getSession
2011-08-16 09:27:46,495 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [ff2e7caf-f1dd-4df4-b6f3-7cc014619816]
2011-08-16 09:27:46,495 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450866495] time[0]
tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2011-08-16 09:27:46,495 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    ome.model.meta.Session:Id_6676
2011-08-16 09:27:46,507 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-7) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/290df595-e731-4ccf-b171-4536a9f34c42omero.api.IAdmin(omero.api._IAdminTie at 5eb3a680
)
2011-08-16 09:27:46,509 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:27:46,509 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    ()
2011-08-16 09:27:46,511 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,511 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
2011-08-16 09:27:46,511 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:46,517 INFO  [         ome.security.basic.EventHandler]
(-thread-24)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:46,524 INFO  [                 org.perf4j.TimingLogger]
(l.Server-2) start[1313450866464] time[60]
tag[omero.call.success.ome.services.blitz.impl.TimelineI$4.doWork]
2011-08-16 09:27:46,524 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Rslt:    {Image=()}
2011-08-16 09:27:46,534 INFO  [                 org.perf4j.TimingLogger]
(-thread-24) start[1313450866511] time[23]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:27:46,534 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Rslt:    (ome.model.meta.Experimenter:Id_652,
ome.model.meta.ExperimenterGroup:Id_203, [203, 205, 204, 207, 206, 216, 217,
218, 219, 212, 213, 214, 215, 208, 209, 210, 211, 1], ... 4 more)
2011-08-16 09:27:46,535 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450866509] time[26]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:27:46,535 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    ome.system.SimpleEventContext at 503654ed
2011-08-16 09:27:46,539 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Meth:    interface ome.api.IAdmin.getExperimenter
2011-08-16 09:27:46,539 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Args:    [652]
2011-08-16 09:27:46,540 INFO  [         ome.security.basic.EventHandler]
(l.Server-0)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,547 INFO  [                 org.perf4j.TimingLogger]
(l.Server-0) start[1313450866539] time[8]
tag[omero.call.success.ome.logic.AdminImpl.getExperimenter]
2011-08-16 09:27:46,547 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Rslt:    ome.model.meta.Experimenter:Id_652
2011-08-16 09:27:46,566 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Meth:    interface ome.api.IAdmin.lookupGroup
2011-08-16 09:27:46,566 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Args:    [user]
2011-08-16 09:27:46,568 INFO  [         ome.security.basic.EventHandler]
(l.Server-8)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,576 INFO  [                 org.perf4j.TimingLogger]
(l.Server-8) start[1313450866566] time[10]
tag[omero.call.success.ome.logic.AdminImpl.lookupGroup]
2011-08-16 09:27:46,576 INFO  [        ome.services.util.ServiceHandler]
(l.Server-8)  Rslt:    ome.model.meta.ExperimenterGroup:Id_1
2011-08-16 09:27:46,607 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-6) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/290df595-e731-4ccf-b171-4536a9f34c42omero.api.IQuery(omero.api._IQueryTie at 6d735d78
)
2011-08-16 09:27:46,609 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,610 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Args:    [select distinct obj from ExperimenterGroup as obj
left outer join fetch obj.groupExperimenterMap as map left outer join fetch
map.child e where obj.id in (:ids), PARAMS:ids=ArrayList(1) ]
2011-08-16 09:27:46,611 INFO  [         ome.security.basic.EventHandler]
(l.Server-6)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,615 INFO  [                 org.perf4j.TimingLogger]
(l.Server-6) start[1313450866610] time[5]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,616 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203)
2011-08-16 09:27:46,620 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,620 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Args:    [select e from ExperimenterGroup as e where e.id in
(:ids), PARAMS:ids=ArrayList(17) ]
2011-08-16 09:27:46,621 INFO  [         ome.security.basic.EventHandler]
(l.Server-3)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,624 INFO  [                 org.perf4j.TimingLogger]
(l.Server-3) start[1313450866620] time[4]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,625 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203,
ome.model.meta.ExperimenterGroup:Id_204,
ome.model.meta.ExperimenterGroup:Id_205, ... 14 more)
2011-08-16 09:27:46,633 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-1) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/290df595-e731-4ccf-b171-4536a9f34c42omero.api.ITimeline(omero.api._ITimelineTie at dd70843
)
2011-08-16 09:27:46,635 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Executor.doWork --
ome.services.blitz.impl.TimelineI.getMostRecentAnnotationLinks
2011-08-16 09:27:46,636 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:46,636 INFO  [         ome.security.basic.EventHandler]
(l.Server-1)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,654 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-2) Found session locally: ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,655 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-2) Rejoining session
ServiceFactoryI(session-f5e4ff14-0f2f-4f71-a7be-00f666ba3800/ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
(agent=OMERO.web)
2011-08-16 09:27:46,661 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-0) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/f5e4ff14-0f2f-4f71-a7be-00f666ba3800omero.api.ISession(omero.api._ISessionTie at 39f8cad0
)
2011-08-16 09:27:46,663 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Meth:    interface ome.api.ISession.getSession
2011-08-16 09:27:46,663 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Args:    [ff2e7caf-f1dd-4df4-b6f3-7cc014619816]
2011-08-16 09:27:46,663 INFO  [                 org.perf4j.TimingLogger]
(l.Server-0) start[1313450866663] time[0]
tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2011-08-16 09:27:46,663 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Rslt:    ome.model.meta.Session:Id_6676
2011-08-16 09:27:46,680 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-0) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/f5e4ff14-0f2f-4f71-a7be-00f666ba3800omero.api.IAdmin(omero.api._IAdminTie at 166ac96b
)
2011-08-16 09:27:46,682 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:27:46,682 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Args:    ()
2011-08-16 09:27:46,683 INFO  [         ome.security.basic.EventHandler]
(l.Server-0)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,684 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(ff2e7caf-f1dd-4df4-b6f3-7cc014619816)
2011-08-16 09:27:46,684 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:46,684 INFO  [         ome.security.basic.EventHandler]
(-thread-24)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:27:46,692 INFO  [                 org.perf4j.TimingLogger]
(-thread-24) start[1313450866684] time[8]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:27:46,692 INFO  [        ome.services.util.ServiceHandler]
(-thread-24)  Rslt:    (ome.model.meta.Experimenter:Id_652,
ome.model.meta.ExperimenterGroup:Id_203, [203, 205, 204, 207, 206, 216, 217,
218, 219, 212, 213, 214, 215, 208, 209, 210, 211, 1], ... 4 more)
2011-08-16 09:27:46,692 INFO  [                 org.perf4j.TimingLogger]
(l.Server-0) start[1313450866682] time[10]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:27:46,692 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Rslt:    ome.system.SimpleEventContext at 762d754d
2011-08-16 09:27:46,695 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.IAdmin.getExperimenter
2011-08-16 09:27:46,695 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    [652]
2011-08-16 09:27:46,696 INFO  [         ome.security.basic.EventHandler]
(l.Server-4)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,702 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313450866695] time[7]
tag[omero.call.success.ome.logic.AdminImpl.getExperimenter]
2011-08-16 09:27:46,702 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    ome.model.meta.Experimenter:Id_652
2011-08-16 09:27:46,719 INFO  [                 org.perf4j.TimingLogger]
(l.Server-1) start[1313450866636] time[83]
tag[omero.call.success.ome.services.blitz.impl.TimelineI$5.doWork]
2011-08-16 09:27:46,719 INFO  [        ome.services.util.ServiceHandler]
(l.Server-1)  Rslt:    ()
2011-08-16 09:27:46,721 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Meth:    interface ome.api.IAdmin.lookupGroup
2011-08-16 09:27:46,721 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [user]
2011-08-16 09:27:46,722 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,730 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313450866721] time[9]
tag[omero.call.success.ome.logic.AdminImpl.lookupGroup]
2011-08-16 09:27:46,730 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    ome.model.meta.ExperimenterGroup:Id_1
2011-08-16 09:27:46,765 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-2) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/f5e4ff14-0f2f-4f71-a7be-00f666ba3800omero.api.IQuery(omero.api._IQueryTie at 5deed809
)
2011-08-16 09:27:46,767 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,768 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Args:    [select distinct obj from ExperimenterGroup as obj
left outer join fetch obj.groupExperimenterMap as map left outer join fetch
map.child e where obj.id in (:ids), PARAMS:ids=ArrayList(1) ]
2011-08-16 09:27:46,769 INFO  [         ome.security.basic.EventHandler]
(l.Server-9)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,773 INFO  [                 org.perf4j.TimingLogger]
(l.Server-9) start[1313450866768] time[5]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,773 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203)
2011-08-16 09:27:46,778 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Meth:    interface ome.api.IQuery.findAllByQuery
2011-08-16 09:27:46,778 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Args:    [select e from ExperimenterGroup as e where e.id in
(:ids), PARAMS:ids=ArrayList(17) ]
2011-08-16 09:27:46,779 INFO  [         ome.security.basic.EventHandler]
(l.Server-5)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,782 INFO  [                 org.perf4j.TimingLogger]
(l.Server-5) start[1313450866778] time[4]
tag[omero.call.success.ome.logic.QueryImpl.findAllByQuery]
2011-08-16 09:27:46,782 INFO  [        ome.services.util.ServiceHandler]
(l.Server-5)  Rslt:    (ome.model.meta.ExperimenterGroup:Id_203,
ome.model.meta.ExperimenterGroup:Id_204,
ome.model.meta.ExperimenterGroup:Id_205, ... 14 more)
2011-08-16 09:27:46,792 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-6) Added servant to adapter:
ff2e7caf-f1dd-4df4-b6f3-7cc014619816/f5e4ff14-0f2f-4f71-a7be-00f666ba3800omero.api.ITimeline(omero.api._ITimelineTie at 63835933
)
2011-08-16 09:27:46,795 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Executor.doWork --
ome.services.blitz.impl.TimelineI.getMostRecentShareComments
2011-08-16 09:27:46,795 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:46,796 INFO  [         ome.security.basic.EventHandler]
(l.Server-6)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,800 INFO  [                 org.perf4j.TimingLogger]
(l.Server-6) start[1313450866795] time[5]
tag[omero.call.success.ome.services.blitz.impl.TimelineI$6.doWork]
2011-08-16 09:27:46,800 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Rslt:    ()
2011-08-16 09:27:46,801 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Executor.doWork --
ome.services.blitz.impl.TimelineI.getMostRecentShareComments
2011-08-16 09:27:46,801 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:27:46,802 INFO  [         ome.security.basic.EventHandler]
(l.Server-0)  Auth:
user=652,group=203,event=null(User),sess=ff2e7caf-f1dd-4df4-b6f3-7cc014619816
2011-08-16 09:27:46,805 INFO  [                 org.perf4j.TimingLogger]
(l.Server-0) start[1313450866801] time[4]
tag[omero.call.success.ome.services.blitz.impl.TimelineI$6.doWork]
2011-08-16 09:27:46,805 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Rslt:    ()


But the user from another OU can't login and I can see in the logs:

2011-08-16 09:33:15,853 INFO  [                 org.perf4j.TimingLogger]
(l.Server-9) start[1313451192770] time[3083]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$9.doWork]
2011-08-16 09:33:15,854 INFO  [        ome.services.util.ServiceHandler]
(l.Server-9)  Rslt:    false
2011-08-16 09:33:15,872 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.executeCheckPasswordRO(guest)
2011-08-16 09:33:15,872 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:33:15,883 INFO  [         ome.security.basic.EventHandler]
(l.Server-3)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:33:15,925 INFO  [                 org.perf4j.TimingLogger]
(l.Server-3) start[1313451195872] time[53]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$8.doWork]
2011-08-16 09:33:15,925 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Rslt:    true
2011-08-16 09:33:15,927 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.createSession
2011-08-16 09:33:15,927 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:33:15,941 INFO  [         ome.security.basic.EventHandler]
(l.Server-6)  Auth:
user=0,group=0,event=60625(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:33:15,951 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-6) Adding log:INSERT,class ome.model.meta.Session,6678
2011-08-16 09:33:15,960 INFO  [                 org.perf4j.TimingLogger]
(l.Server-6) start[1313451195927] time[33]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$2.doWork]
2011-08-16 09:33:15,960 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Rslt:    (ome.model.meta.Experimenter:Id_1,
ome.model.meta.ExperimenterGroup:Id_2, [2], ... 4 more)
2011-08-16 09:33:15,962 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-6) Created session
ServiceFactoryI(session-464d7db3-770e-46ca-aa42-730901b15043/cff5aec8-ced6-4015-8071-f80a2f8f28a3)
for user guest (agent=OMERO.web)
2011-08-16 09:33:15,967 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-4) Added servant to adapter:
cff5aec8-ced6-4015-8071-f80a2f8f28a3/464d7db3-770e-46ca-aa42-730901b15043omero.api.ISession(omero.api._ISessionTie at 6f60caf6
)
2011-08-16 09:33:15,968 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.ISession.getSession
2011-08-16 09:33:15,968 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    [cff5aec8-ced6-4015-8071-f80a2f8f28a3]
2011-08-16 09:33:15,968 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313451195968] time[0]
tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2011-08-16 09:33:15,968 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    ome.model.meta.Session:Id_6678
2011-08-16 09:33:15,976 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-4) Added servant to adapter:
cff5aec8-ced6-4015-8071-f80a2f8f28a3/464d7db3-770e-46ca-aa42-730901b15043omero.api.IAdmin(omero.api._IAdminTie at 5eaae658
)
2011-08-16 09:33:15,978 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:33:15,978 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Args:    ()
2011-08-16 09:33:15,979 INFO  [         ome.security.basic.EventHandler]
(l.Server-4)  Auth:
user=1,group=2,event=null(User),sess=cff5aec8-ced6-4015-8071-f80a2f8f28a3
2011-08-16 09:33:15,979 INFO  [        ome.services.util.ServiceHandler]
(-thread-25)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(cff5aec8-ced6-4015-8071-f80a2f8f28a3)
2011-08-16 09:33:15,980 INFO  [        ome.services.util.ServiceHandler]
(-thread-25)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:33:15,981 INFO  [         ome.security.basic.EventHandler]
(-thread-25)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:33:15,987 INFO  [                 org.perf4j.TimingLogger]
(-thread-25) start[1313451195980] time[7]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:33:15,987 INFO  [        ome.services.util.ServiceHandler]
(-thread-25)  Rslt:    (ome.model.meta.Experimenter:Id_1,
ome.model.meta.ExperimenterGroup:Id_2, [2], ... 4 more)
2011-08-16 09:33:15,988 INFO  [                 org.perf4j.TimingLogger]
(l.Server-4) start[1313451195978] time[10]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:33:15,988 INFO  [        ome.services.util.ServiceHandler]
(l.Server-4)  Rslt:    ome.system.SimpleEventContext at 59de6ee9
2011-08-16 09:33:15,991 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-7) Added servant to adapter:
cff5aec8-ced6-4015-8071-f80a2f8f28a3/464d7db3-770e-46ca-aa42-730901b15043omero.api.IConfig(omero.api._IConfigTie at 72b6f43b
)
2011-08-16 09:33:15,992 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Meth:    interface ome.api.IConfig.getConfigValue
2011-08-16 09:33:15,993 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Args:    [omero.version]
2011-08-16 09:33:16,005 INFO  [         ome.security.basic.EventHandler]
(l.Server-7)  Auth:
user=1,group=2,event=60626(User),sess=cff5aec8-ced6-4015-8071-f80a2f8f28a3
2011-08-16 09:33:16,009 INFO  [                 org.perf4j.TimingLogger]
(l.Server-7) start[1313451195993] time[16]
tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2011-08-16 09:33:16,009 INFO  [        ome.services.util.ServiceHandler]
(l.Server-7)  Rslt:    4.3.1-6d4b8c61-b2602
2011-08-16 09:33:16,038 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.executeCheckPasswordRO(guest)
2011-08-16 09:33:16,038 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:33:16,039 INFO  [         ome.security.basic.EventHandler]
(l.Server-3)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:33:16,042 INFO  [                 org.perf4j.TimingLogger]
(l.Server-3) start[1313451196038] time[4]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$8.doWork]
2011-08-16 09:33:16,042 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Rslt:    true
2011-08-16 09:33:16,043 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.createSession
2011-08-16 09:33:16,043 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Args:    [null, InternalSF at 1940813045]

2011-08-16 09:33:16,057 INFO  [         ome.security.basic.EventHandler]
(l.Server-6)  Auth:
user=0,group=0,event=60627(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:33:16,067 INFO  [       ome.security.basic.CurrentDetails]
(l.Server-6) Adding log:INSERT,class ome.model.meta.Session,6679
2011-08-16 09:33:16,076 INFO  [                 org.perf4j.TimingLogger]
(l.Server-6) start[1313451196043] time[33]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$2.doWork]
2011-08-16 09:33:16,076 INFO  [        ome.services.util.ServiceHandler]
(l.Server-6)  Rslt:    (ome.model.meta.Experimenter:Id_1,
ome.model.meta.ExperimenterGroup:Id_2, [2], ... 4 more)
2011-08-16 09:33:16,079 INFO  [ ome.services.blitz.fire.SessionManagerI]
(l.Server-6) Created session
ServiceFactoryI(session-f7794d81-6201-4646-b21f-000aa88354d7/602ef3dd-67e1-4a50-8203-851081ca2155)
for user guest (agent=OMERO.web)
2011-08-16 09:33:16,084 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-0) Added servant to adapter:
602ef3dd-67e1-4a50-8203-851081ca2155/f7794d81-6201-4646-b21f-000aa88354d7omero.api.ISession(omero.api._ISessionTie at 168b1754
)
2011-08-16 09:33:16,085 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Meth:    interface ome.api.ISession.getSession
2011-08-16 09:33:16,085 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Args:    [602ef3dd-67e1-4a50-8203-851081ca2155]
2011-08-16 09:33:16,085 INFO  [                 org.perf4j.TimingLogger]
(l.Server-0) start[1313451196085] time[0]
tag[omero.call.success.ome.services.sessions.SessionBean.getSession]
2011-08-16 09:33:16,085 INFO  [        ome.services.util.ServiceHandler]
(l.Server-0)  Rslt:    ome.model.meta.Session:Id_6679
2011-08-16 09:33:16,094 INFO  [e.services.sessions.SessionContext$Count]
(l.Server-2) -Reference count: 44e21875-fa6e-411e-a6c4-6748a60a3400=0
2011-08-16 09:33:16,098 INFO  [e.services.sessions.SessionContext$Count]
(l.Server-2) -Reference count: cff5aec8-ced6-4015-8071-f80a2f8f28a3=0
2011-08-16 09:33:16,102 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-2) Added servant to adapter:
602ef3dd-67e1-4a50-8203-851081ca2155/f7794d81-6201-4646-b21f-000aa88354d7omero.api.IAdmin(omero.api._IAdminTie at 462ba2ad
)
2011-08-16 09:33:16,103 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Meth:    interface ome.api.IAdmin.getEventContext
2011-08-16 09:33:16,103 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Args:    ()
2011-08-16 09:33:16,105 INFO  [         ome.security.basic.EventHandler]
(l.Server-2)  Auth:
user=1,group=2,event=null(User),sess=602ef3dd-67e1-4a50-8203-851081ca2155
2011-08-16 09:33:16,105 INFO  [        ome.services.util.ServiceHandler]
(-thread-25)  Executor.doWork --
ome.services.sessions.SessionManagerImpl.reload(602ef3dd-67e1-4a50-8203-851081ca2155)
2011-08-16 09:33:16,105 INFO  [        ome.services.util.ServiceHandler]
(-thread-25)  Args:    [null, InternalSF at 1940813045]
2011-08-16 09:33:16,106 INFO  [         ome.security.basic.EventHandler]
(-thread-25)  Auth:
user=0,group=0,event=null(Sessions),sess=ea945943-81fd-4534-9fb9-bca90eb78006
2011-08-16 09:33:16,112 INFO  [                 org.perf4j.TimingLogger]
(-thread-25) start[1313451196105] time[7]
tag[omero.call.success.ome.services.sessions.SessionManagerImpl$6.doWork]
2011-08-16 09:33:16,112 INFO  [        ome.services.util.ServiceHandler]
(-thread-25)  Rslt:    (ome.model.meta.Experimenter:Id_1,
ome.model.meta.ExperimenterGroup:Id_2, [2], ... 4 more)
2011-08-16 09:33:16,113 INFO  [                 org.perf4j.TimingLogger]
(l.Server-2) start[1313451196104] time[9]
tag[omero.call.success.ome.logic.AdminImpl.getEventContext]
2011-08-16 09:33:16,113 INFO  [        ome.services.util.ServiceHandler]
(l.Server-2)  Rslt:    ome.system.SimpleEventContext at 6fcdf64a
2011-08-16 09:33:16,116 INFO  [ ome.services.blitz.impl.ServiceFactoryI]
(l.Server-3) Added servant to adapter:
602ef3dd-67e1-4a50-8203-851081ca2155/f7794d81-6201-4646-b21f-000aa88354d7omero.api.IConfig(omero.api._IConfigTie at 960cf8e
)
2011-08-16 09:33:16,118 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Meth:    interface ome.api.IConfig.getConfigValue
2011-08-16 09:33:16,118 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Args:    [omero.version]
2011-08-16 09:33:16,131 INFO  [         ome.security.basic.EventHandler]
(l.Server-3)  Auth:
user=1,group=2,event=60628(User),sess=602ef3dd-67e1-4a50-8203-851081ca2155
2011-08-16 09:33:16,135 INFO  [                 org.perf4j.TimingLogger]
(l.Server-3) start[1313451196118] time[17]
tag[omero.call.success.ome.logic.ConfigImpl.getConfigValue]
2011-08-16 09:33:16,135 INFO  [        ome.services.util.ServiceHandler]
(l.Server-3)  Rslt:    4.3.1-6d4b8c61-b2602


Any ideas?

Thanks,
Leon Kolchinsky



On Tue, Aug 16, 2011 at 00:38, Josh Moore <josh at glencoesoftware.com> wrote:

> Hi Leon,
>
> That groups are not synchronized for existing users is expected. The group
> values are only consulted for new users (hence the name). Could you possibly
> send us your var/log/Blitz-0.log so we can figure out why new users can't
> login?
>
> Thanks,
> ~Josh.
>
>
>
>
> On Aug 15, 2011, at 4:31 PM, Leon Kolchinsky wrote:
>
> > Hello Josh,
> >
> > omero.ldap.new_user_group=:query:(uniquemember=@{dn})
> > Groups are not pulled for existing users.
> >
> > New users can't even login ;(
> > Although they could login on a clean installation.
> >
> > Cheers,
> > Leon Kolchinsky
> >
> >
> >
> > On Tue, Aug 16, 2011 at 00:14, Josh Moore <josh at glencoesoftware.com>
> wrote:
> >
> >> Hi Leon,
> >>
> >> what is the value of omero.ldap.new_user_group that you're using? Also,
> is
> >> the problem you're seeing (i.e. groups not being pulled for users) on
> new
> >> users or existing users?
> >>
> >> Cheers,
> >> ~Josh.
> >>
> >>
> >> On Aug 15, 2011, at 3:42 PM, Leon Kolchinsky wrote:
> >>
> >>> Hello,
> >>>
> >>> I've installed 4.3.1 version of OMERO.
> >>> It was configured to pull groups of logged in users from LDAP and it
> worked!
> >>>
> >>> I've dumped DB of 4.2.2 version from another server, restored it on a
> new
> >>> one.
> >>> Upgraded this DB with the script on your site and moved all data to the
> new
> >>> server.
> >>> I've re-run all "/srv/omeroserver/bin/omero config set" instructions
> again
> >>> but the groups of the users aren't pulled from the LDAP ;(
> >>>
> >>> Running "omero config get" shows me the right configuration options.
> >>>
> >>> Is there a configuration in the DB I need to configure/delete?
> >>>
> >>> What could be the reason for that behavior?
> >>>
> >>> Cheers,
> >>> Leon Kolchinsky
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.openmicroscopy.org.uk/pipermail/ome-users/attachments/20110816/07ff05ef/attachment.html>


More information about the ome-users mailing list