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

Leon Kolchinsky lkolchin at gmail.com
Thu Aug 18 02:24:51 BST 2011


Hello Josh,

Sure I would be able to test it when I get a new VM.
Where would I get the new OMERO version (with sync. support)?

BTW,
If I'd like to create a JNLP versions of OMERO clients, like - insight.jnlp,
where would I find some manuals/step-by-step tutorials on that?
Does anyone on the list already did it?

Cheers,
Leon Kolchinsky



On Wed, Aug 17, 2011 at 18:12, Josh Moore <josh at glencoesoftware.com> wrote:

> Hi Leon,
>
> you'll see I've added you to the new wishlist item #6502 (complex
> new_user_group configs). You might also take a look at #6501 (ldap
> synchronization) which is available on a branch if you'd be able to test for
> us.
>
> Cheers,
> ~Josh.
>
>  *  https://trac.openmicroscopy.org.uk/ome/ticket/6501
>  *  https://trac.openmicroscopy.org.uk/ome/ticket/6502
>
> On Aug 17, 2011, at 3:33 AM, Leon Kolchinsky wrote:
>
> > 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/20110818/31aa5f16/attachment.html>


More information about the ome-users mailing list