| 1 | | Actually I think there's two issues here. In my previous comment it's the Ice connection that's timing out not the session. However if I change the session timeout to 120s and run a script that takes 140s I get this error: |
| 2 | | |
| 3 | | {{{ |
| 4 | | simon@ls27151 openmicroscopy$ omero script launch 2657 Number_Of_Messages=15 Log_Interval=10 |
| 5 | | Using /Users/simon/work/openmicroscopy/dist/bin/omero |
| 6 | | Previous session expired for test1 on localhost:4064 |
| 7 | | Server: [localhost] |
| 8 | | Username: [test1] |
| 9 | | Password: |
| 10 | | Created session b1d19410-3a9f-47be-93a7-d03b18a165f8 (test1@localhost:4064). Idle timeout: 2.0 min. Current group: test-read-annotate |
| 11 | | Job 1703 ready |
| 12 | | Waiting.... |
| 13 | | Callback received: FINISHED |
| 14 | | Traceback (most recent call last): |
| 15 | | File "/Users/simon/work/openmicroscopy/dist/bin/omero", line 125, in <module> |
| 16 | | rv = omero.cli.argv() |
| 17 | | File "/Users/simon/work/openmicroscopy/dist/lib/python/omero/cli.py", line 1195, in argv |
| 18 | | cli.invoke(args[1:]) |
| 19 | | File "/Users/simon/work/openmicroscopy/dist/lib/python/omero/cli.py", line 745, in invoke |
| 20 | | stop = self.onecmd(line, previous_args) |
| 21 | | File "/Users/simon/work/openmicroscopy/dist/lib/python/omero/cli.py", line 814, in onecmd |
| 22 | | self.execute(line, previous_args) |
| 23 | | File "/Users/simon/work/openmicroscopy/dist/lib/python/omero/cli.py", line 894, in execute |
| 24 | | args.func(args) |
| 25 | | File "/Users/simon/work/openmicroscopy/dist/lib/python/omero/plugins/script.py", line 368, in launch |
| 26 | | rv = proc.getResults(3) |
| 27 | | File "/Users/simon/work/openmicroscopy/dist/lib/python/omero_Scripts_ice.py", line 638, in getResults |
| 28 | | return _M_omero.grid.ScriptProcess._op_getResults.invoke(self, ((waitSecs, ), _ctx)) |
| 29 | | Ice.UnknownException: exception ::Ice::UnknownException |
| 30 | | { |
| 31 | | unknown = ome.conditions.SessionTimeoutException: Session (started=2013-02-14 17:17:57.459, hits=51, last access=2013-02-14 17:17:57.914) exceeded timeToIdle (120000) by 41112 ms |
| 32 | | at ome.services.sessions.state.SessionCache.getDataNullOrThrowOnTimeout(SessionCache.java:422) |
| 33 | | at ome.services.sessions.state.SessionCache.getSessionContext(SessionCache.java:351) |
| 34 | | at ome.security.basic.CurrentDetails.login(CurrentDetails.java:148) |
| 35 | | at ome.services.util.Executor$Impl.execute(Executor.java:398) |
| 36 | | at omero.grid.InteractiveProcessorI.loadFileOrNull(InteractiveProcessorI.java:386) |
| 37 | | at omero.grid.InteractiveProcessorI.optionallyLoadFile(InteractiveProcessorI.java:403) |
| 38 | | at omero.grid.InteractiveProcessorI.getResults(InteractiveProcessorI.java:271) |
| 39 | | at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) |
| 40 | | at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) |
| 41 | | at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) |
| 42 | | at java.lang.reflect.Method.invoke(Method.java:601) |
| 43 | | at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) |
| 44 | | at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183) |
| 45 | | at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150) |
| 46 | | at omero.cmd.CallContext.invoke(CallContext.java:59) |
| 47 | | at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172) |
| 48 | | at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202) |
| 49 | | at $Proxy87.getResults(Unknown Source) |
| 50 | | at ome.services.blitz.impl.ScriptProcessI.getResults(ScriptProcessI.java:112) |
| 51 | | at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) |
| 52 | | at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) |
| 53 | | at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) |
| 54 | | at java.lang.reflect.Method.invoke(Method.java:601) |
| 55 | | at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307) |
| 56 | | at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183) |
| 57 | | at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150) |
| 58 | | at omero.cmd.CallContext.invoke(CallContext.java:59) |
| 59 | | at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172) |
| 60 | | at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202) |
| 61 | | at $Proxy88.getResults(Unknown Source) |
| 62 | | at omero.grid._ScriptProcessTie.getResults(_ScriptProcessTie.java:125) |
| 63 | | at omero.grid._ScriptProcessDisp.___getResults(_ScriptProcessDisp.java:179) |
| 64 | | at omero.grid._ScriptProcessDisp.__dispatch(_ScriptProcessDisp.java:280) |
| 65 | | at IceInternal.Incoming.invoke(Incoming.java:159) |
| 66 | | at Ice.ConnectionI.invokeAll(ConnectionI.java:2037) |
| 67 | | at Ice.ConnectionI.message(ConnectionI.java:972) |
| 68 | | at IceInternal.ThreadPool.run(ThreadPool.java:577) |
| 69 | | at IceInternal.ThreadPool.access$100(ThreadPool.java:12) |
| 70 | | at IceInternal.ThreadPool$EventHandlerThread.run(ThreadPool.java:971) |
| 71 | | |
| 72 | | } |
| 73 | | }}} |
| | 1 | <deleted> |
| | 2 | Ignore this, it was an artifact of the asdditional debug/logging I added. |
