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

Leon Kolchinsky lkolchin at gmail.com
Wed Aug 17 02:33:30 BST 2011


Hello Josh,


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

> Hi Leon,
>
> On Aug 16, 2011, at 1:57 AM, Leon Kolchinsky wrote:
>
> > Here is an update,
> >
> > Users in External Users OU don't actually have any groups ;(
> > Might this be the reason that they can't login?
>
> Definitely. If the new_user_group query returns nothing, then the user
> would be in no group and therefore couldn't login.
>
Yep, I can confirm ;)
Now I've disabled group pulling capability, external users (those without
groups) can login via web client:

Would it be be possible to add the following to the wishlist:
If groups for a particular user in LDAP are not found he will be assigned to
a default group:
as it is now - (omero.ldap.new_user_group=default)
and this group will take precedence, i.e. will be assigned first and lookup
for additional groups (LDAP groups) will continue (successfully or not) and
not prevent the user from logging in.


>
> > And by the way, is there any option to make Omero re-read groups for
> users
> > on every login?
>
> Not yet, no. The story https://trac.openmicroscopy.org.uk/ome/ticket/1382links to several improvements we would like to make to the LDAP
> authentication plugin, one of these is a synchronization option.
>
> > As you know some of those users added to new groups but those new groups
> are
> > not updated in the OMERO ;(
> > Or may be syncronize groups for LDAP users once a day?
>
> That's definitely also part of #1382, but not something we can implement
> immediately.
>
> > BTW, I couldn't find a way to delete user via WebAdmin. Where do you hide
> > this option?
>
> In general, deleting a user is difficult since something must happen to
> their data, therefore it's not an option in the UI. Instead disable the user
> by unselecting "Active" from WebAdmin.
>
Thanks for the info ;)


>
> > Cheers,
> > Leon Kolchinsky
>
> Cheers,
> ~Josh
>
>
Thank you very much,
Leon Kolchinsky


>  >
> >
> > On Tue, Aug 16, 2011 at 09:42, Leon Kolchinsky <lkolchin at gmail.com>
> wrote:
> >
> >> 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.idin
> >> (: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.idin
> >> (: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.idin
> >> (: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.idin
> >> (: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/20110817/90b4085e/attachment.html>


More information about the ome-users mailing list