Ticket #5835: re.txt

File re.txt, 19.0 KB (added by jmoore, 8 years ago)
Line 
1Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    trying stored connection with userAgent: OMERO.webgateway  ckey: S:925ce1dd-1f2c-4507-8e1f-c99d39b79770#1
2Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    [('S:925ce1dd-1f2c-4507-8e1f-c99d39b79770#1', <webclient.webclient_gateway.OmeroWebGateway object at 0x05F9C390>)]
3Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    c=1|162:885$FF0000
4Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    [1],[[162.0, 885.0]],[u'FF0000']
5Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    c=1|162:885$FF0000
6Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    [1],[[162.0, 885.0]],[u'FF0000']
7Wed, 08 Jun 2011 13:55:04 cache        DEBUG       set: img_None/3574/0x0-c1-162:885-FF0000-mg-q0.9-r-t0,10,12,256,256
8Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Ice.Exception (1) on safe call load((),{})
9Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Traceback (most recent call last):
10  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2882, in inner
11    return f(*args, **kwargs)
12  File "c:\OMERO-CURRENT\lib\python\omero_api_RenderingEngine_ice.py", line 235, in load
13    return _M_omero.api.RenderingEngine._op_load.invoke(self, ((), _ctx))
14LockTimeout: exception ::omero::LockTimeout
15{
16    serverStackTrace = ome.conditions.LockTimeout: c:\OMERO\Pixels\Dir-001\1077_pyramid is locked by others
17        at ome.io.bioformats.BfPyramidPixelBuffer.initializeReader(BfPyramidPixelBuffer.java:161)
18        at ome.io.bioformats.BfPyramidPixelBuffer.<init>(BfPyramidPixelBuffer.java:145)
19        at ome.io.nio.PixelsService.createPyramidPixelBuffer(PixelsService.java:614)
20        at ome.io.nio.PixelsService.getPixelBuffer(PixelsService.java:389)
21        at ome.services.RenderingBean$14.doWork(RenderingBean.java:1820)
22        at sun.reflect.GeneratedMethodAccessor251.invoke(Unknown Source)
23        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
24        at java.lang.reflect.Method.invoke(Unknown Source)
25        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
26        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
27        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
28        at ome.services.util.Executor$Impl$Interceptor.invoke(Executor.java:439)
29        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
30        at ome.security.basic.EventHandler.invoke(EventHandler.java:150)
31        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
32        at org.springframework.orm.hibernate3.HibernateInterceptor.invoke(HibernateInterceptor.java:111)
33        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
34        at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:108)
35        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
36        at ome.tools.hibernate.ProxyCleanupFilter$Interceptor.invoke(ProxyCleanupFilter.java:231)
37        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
38        at ome.services.util.ServiceHandler.invoke(ServiceHandler.java:116)
39        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
40        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
41        at $Proxy64.doWork(Unknown Source)
42        at ome.services.util.Executor$Impl.execute(Executor.java:369)
43        at ome.services.RenderingBean.getPixelBuffer(RenderingBean.java:1817)
44        at ome.services.RenderingBean.load(RenderingBean.java:389)
45        at sun.reflect.GeneratedMethodAccessor593.invoke(Unknown Source)
46        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
47        at java.lang.reflect.Method.invoke(Unknown Source)
48        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
49        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
50        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
51        at ome.services.util.ServiceHandler.invoke(ServiceHandler.java:116)
52        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
53        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
54        at $Proxy81.load(Unknown Source)
55        at sun.reflect.GeneratedMethodAccessor593.invoke(Unknown Source)
56        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
57        at java.lang.reflect.Method.invoke(Unknown Source)
58        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
59        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
60        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
61        at ome.security.basic.BasicSecurityWiring.invoke(BasicSecurityWiring.java:83)
62        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
63        at ome.services.blitz.fire.AopContextInitializer.invoke(AopContextInitializer.java:43)
64        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
65        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
66        at $Proxy81.load(Unknown Source)
67        at sun.reflect.GeneratedMethodAccessor759.invoke(Unknown Source)
68        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
69        at java.lang.reflect.Method.invoke(Unknown Source)
70        at ome.services.blitz.util.IceMethodInvoker.invoke(IceMethodInvoker.java:179)
71        at ome.services.throttling.Callback.run(Callback.java:56)
72        at ome.services.throttling.InThreadThrottlingStrategy.callInvokerOnRawArgs(InThreadThrottlingStrategy.java:56)
73        at ome.services.blitz.impl.AbstractAmdServant.callInvokerOnRawArgs(AbstractAmdServant.java:136)
74        at ome.services.blitz.impl.RenderingEngineI.load_async(RenderingEngineI.java:307)
75        at omero.api._RenderingEngineTie.load_async(_RenderingEngineTie.java:246)
76        at omero.api._RenderingEngineDisp.___load(_RenderingEngineDisp.java:726)
77        at omero.api._RenderingEngineDisp.__dispatch(_RenderingEngineDisp.java:1650)
78        at IceInternal.Incoming.invoke(Incoming.java:159)
79        at Ice.ConnectionI.invokeAll(ConnectionI.java:2037)
80        at Ice.ConnectionI.message(ConnectionI.java:972)
81        at IceInternal.ThreadPool.run(ThreadPool.java:577)
82        at IceInternal.ThreadPool.access$100(ThreadPool.java:12)
83        at IceInternal.ThreadPool$EventHandlerThread.run(ThreadPool.java:971)
84
85    serverExceptionClass = ome.conditions.LockTimeout
86    message = c:\OMERO\Pixels\Dir-001\1077_pyramid is locked by others
87    backOff = 15000
88    seconds = 0
89}
90
91Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Ice.Exception (2) on safe call load((),{})
92Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Traceback (most recent call last):
93  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2904, in inner
94    return func(*args, **kwargs)
95  File "c:\OMERO-CURRENT\lib\python\omero_api_RenderingEngine_ice.py", line 235, in load
96    return _M_omero.api.RenderingEngine._op_load.invoke(self, ((), _ctx))
97ApiUsageException: exception ::omero::ApiUsageException
98{
99    serverStackTrace = ome.conditions.ApiUsageException: RenderingEngine not ready: Pixels object not set.
100
101        at ome.services.RenderingBean.errorIfNullPixels(RenderingBean.java:1471)
102
103        at ome.services.RenderingBean.load(RenderingBean.java:378)
104
105        at sun.reflect.GeneratedMethodAccessor593.invoke(Unknown Source)
106
107        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
108
109        at java.lang.reflect.Method.invoke(Unknown Source)
110
111        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
112
113        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
114
115        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
116
117        at ome.services.util.ServiceHandler.invoke(ServiceHandler.java:116)
118
119        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
120
121        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
122
123        at $Proxy81.load(Unknown Source)
124
125        at sun.reflect.GeneratedMethodAccessor593.invoke(Unknown Source)
126
127        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
128
129        at java.lang.reflect.Method.invoke(Unknown Source)
130
131        at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
132
133        at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
134
135        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
136
137        at ome.security.basic.BasicSecurityWiring.invoke(BasicSecurityWiring.java:83)
138
139        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
140
141        at ome.services.blitz.fire.AopContextInitializer.invoke(AopContextInitializer.java:43)
142
143        at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
144
145        at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
146
147        at $Proxy81.load(Unknown Source)
148
149        at sun.reflect.GeneratedMethodAccessor759.invoke(Unknown Source)
150
151        at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
152
153        at java.lang.reflect.Method.invoke(Unknown Source)
154
155        at ome.services.blitz.util.IceMethodInvoker.invoke(IceMethodInvoker.java:179)
156
157        at ome.services.throttling.Callback.run(Callback.java:56)
158
159        at ome.services.throttling.InThreadThrottlingStrategy.callInvokerOnRawArgs(InThreadThrottlingStrategy.java:56)
160
161        at ome.services.blitz.impl.AbstractAmdServant.callInvokerOnRawArgs(AbstractAmdServant.java:136)
162
163        at ome.services.blitz.impl.RenderingEngineI.load_async(RenderingEngineI.java:307)
164
165        at omero.api._RenderingEngineTie.load_async(_RenderingEngineTie.java:246)
166
167        at omero.api._RenderingEngineDisp.___load(_RenderingEngineDisp.java:726)
168
169        at omero.api._RenderingEngineDisp.__dispatch(_RenderingEngineDisp.java:1650)
170
171        at IceInternal.Incoming.invoke(Incoming.java:159)
172
173        at Ice.ConnectionI.invokeAll(ConnectionI.java:2037)
174
175        at Ice.ConnectionI.message(ConnectionI.java:972)
176
177        at IceInternal.ThreadPool.run(ThreadPool.java:577)
178
179        at IceInternal.ThreadPool.access$100(ThreadPool.java:12)
180
181        at IceInternal.ThreadPool$EventHandlerThread.run(ThreadPool.java:971)
182
183
184    serverExceptionClass = ome.conditions.ApiUsageException
185    message = RenderingEngine not ready: Pixels object not set.
186}
187
188Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    proxy_connect: a
189Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Connect attempt, sUuid=925ce1dd-1f2c-4507-8e1f-c99d39b79770, group=None, self.sUuid=925ce1dd-1f2c-4507-8e1f-c99d39b79770
190Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    connected? True
191Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    was connected, creating new omero.client
192Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Ice.Exception (1) on safe call setModel((object #0 (::omero::model::RenderingModel)
193{
194    _id = object #1 (::omero::RLong)
195    {
196        _val = 2
197    }
198    _details = object #2 (::omero::model::Details)
199    {
200        _owner = <nil>
201        _group = <nil>
202        _creationEvent = <nil>
203        _updateEvent = <nil>
204        _permissions = object #3 (::omero::model::Permissions)
205        {
206            _perm1 = -35
207        }
208        _externalInfo = <nil>
209    }
210    _loaded = True
211    _value = object #4 (::omero::RString)
212    {
213        _val = greyscale
214    }
215},),{})
216Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Traceback (most recent call last):
217  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2882, in inner
218    return f(*args, **kwargs)
219  File "c:\OMERO-CURRENT\lib\python\omero_api_RenderingEngine_ice.py", line 241, in setModel
220    return _M_omero.api.RenderingEngine._op_setModel.invoke(self, ((model, ), _ctx))
221ConnectionLostException: Ice.ConnectionLostException:
222recv() returned zero
223
224Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Ice.Exception (2) on safe call setModel((object #0 (::omero::model::RenderingModel)
225{
226    _id = object #1 (::omero::RLong)
227    {
228        _val = 2
229    }
230    _details = object #2 (::omero::model::Details)
231    {
232        _owner = <nil>
233        _group = <nil>
234        _creationEvent = <nil>
235        _updateEvent = <nil>
236        _permissions = object #3 (::omero::model::Permissions)
237        {
238            _perm1 = -35
239        }
240        _externalInfo = <nil>
241    }
242    _loaded = True
243    _value = object #4 (::omero::RString)
244    {
245        _val = greyscale
246    }
247},),{})
248Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Traceback (most recent call last):
249  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2902, in inner
250    self._obj = self._create_func()
251  File "c:\OMERO-CURRENT\lib\python\omero_API_ice.py", line 273, in createRenderingEngine
252    return _M_omero.api.ServiceFactory._op_createRenderingEngine.invoke(self, ((), _ctx))
253CommunicatorDestroyedException: exception ::Ice::CommunicatorDestroyedException
254{
255}
256
257Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    proxy_connect: a
258Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Connect attempt, sUuid=925ce1dd-1f2c-4507-8e1f-c99d39b79770, group=None, self.sUuid=925ce1dd-1f2c-4507-8e1f-c99d39b79770
259Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    connected? False
260Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Error: Session already active. Create a new omero.client or closeSession()
261Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    connect failed
262Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    joinSession(None)
263Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    Uncaptured sUuid failure!
264Wed, 08 Jun 2011 13:55:04 blitz_gateway INFO     BlitzGateway.connect().createSession(): Traceback (most recent call last):
265  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 1518, in connect
266    self._createSession()
267  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 1423, in _createSession
268    self._ic_props[omero.constants.PASSWORD])
269  File "c:\OMERO-CURRENT\lib\python\omero\clients.py", line 417, in createSession
270    raise ClientError("Session already active. Create a new omero.client or closeSession()")
271ClientError: Session already active. Create a new omero.client or closeSession()
272
273Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    connect(): Traceback (most recent call last):
274  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 1548, in connect
275    self._createSession()
276  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 1423, in _createSession
277    self._ic_props[omero.constants.PASSWORD])
278  File "c:\OMERO-CURRENT\lib\python\omero\clients.py", line 417, in createSession
279    raise ClientError("Session already active. Create a new omero.client or closeSession()")
280ClientError: Session already active. Create a new omero.client or closeSession()
281
282Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    connect failed
283Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG      File "C:\Python25\Lib\site-packages\isapi_wsgi.py", line 471, in HttpExtensionProc
284    _run_app(self.rootapp, self.apps, ecb)
285/n  File "C:\Python25\Lib\site-packages\isapi_wsgi.py", line 444, in _run_app
286    handler.run(application)
287/n  File "C:\Python25\lib\wsgiref\handlers.py", line 92, in run
288    self.result = application(self.environ, self.start_response)
289/n  File "c:\OMERO-CURRENT\lib\python\django\core\handlers\wsgi.py", line 241, in __call__
290    response = self.get_response(request)
291/n  File "c:\OMERO-CURRENT\lib\python\django\core\handlers\base.py", line 92, in get_response
292    response = callback(request, *callback_args, **callback_kwargs)
293/n  File "c:\omero-current\lib\python\omeroweb\webgateway\views.py", line 603, in render_image_region
294    pi = _get_prepared_image(request, iid, server_id=server_id, _conn=_conn, with_session=USE_SESSION)
295/n  File "c:\omero-current\lib\python\omeroweb\webgateway\views.py", line 555, in _get_prepared_image
296    img.setGreyscaleRenderingModel()
297/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 5560, in setGreyscaleRenderingModel
298    self._re.setModel(self._rm.get('greyscale', rm[0])._obj)
299/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2929, in wrapped
300    return inner(*args, **kwargs)
301/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2914, in inner
302    self._connect(forcejoin=True)
303/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 3052, in _connect
304    logger.debug('/n'.join(traceback.format_stack()))
305
306Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    last try for setModel
307Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG      File "C:\Python25\Lib\site-packages\isapi_wsgi.py", line 471, in HttpExtensionProc
308    _run_app(self.rootapp, self.apps, ecb)
309/n  File "C:\Python25\Lib\site-packages\isapi_wsgi.py", line 444, in _run_app
310    handler.run(application)
311/n  File "C:\Python25\lib\wsgiref\handlers.py", line 92, in run
312    self.result = application(self.environ, self.start_response)
313/n  File "c:\OMERO-CURRENT\lib\python\django\core\handlers\wsgi.py", line 241, in __call__
314    response = self.get_response(request)
315/n  File "c:\OMERO-CURRENT\lib\python\django\core\handlers\base.py", line 92, in get_response
316    response = callback(request, *callback_args, **callback_kwargs)
317/n  File "c:\omero-current\lib\python\omeroweb\webgateway\views.py", line 603, in render_image_region
318    pi = _get_prepared_image(request, iid, server_id=server_id, _conn=_conn, with_session=USE_SESSION)
319/n  File "c:\omero-current\lib\python\omeroweb\webgateway\views.py", line 552, in _get_prepared_image
320    if not img.setActiveChannels(channels, windows, colors):
321/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 5380, in setActiveChannels
322    for c in range(len(self.getChannels())):
323/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 4784, in wrapped
324    if not self._prepareRenderingEngine():
325/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 4990, in _prepareRenderingEngine
326    self._re = self._prepareRE()
327/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 4971, in _prepareRE
328    re.load()
329/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2929, in wrapped
330    return inner(*args, **kwargs)
331/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 2914, in inner
332    self._connect(forcejoin=True)
333/n  File "c:\omero-current\lib\python\omero\gateway\__init__.py", line 3052, in _connect
334    logger.debug('/n'.join(traceback.format_stack()))
335
336Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    ConnectionLostException, bailing out
337Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    last try for load
338Wed, 08 Jun 2011 13:55:04 blitz_gateway DEBUG    ConnectionLostException, bailing out
339Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    :: (session) crasher localhost 4064
340Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    :: (session) crasher localhost 4064
341Wed, 08 Jun 2011 13:55:04 webgateway   DEBUG    :: (request) None None None
342

1.3.13-PRO © 2008-2011 Agilo Software all rights reserved (this page was served in: 0.98429 sec.)

© 2000-2014 University of Dundee & Open Microscopy Environment. Creative Commons Attribution 3.0 Unported License
OME source code is available under the GNU General public license or through commercial license from Glencoe Software

We're Hiring!