RH7.2 Python2.3.3 Zope2.7.2 and ZEO (sorry for the length)
From event.log:
2005-03-23T09:05:26 ERROR(200) ZServer uncaptured python exception, closing channel <ZServer.HTTPServer.zhttp_channel connected 206.112.73.106:42396 at 0x4421566c channel#: 95 requests:> (socket.error:(104, 'Connection reset by peer') [/usr/local/lib/python2.3/asynchat.py|initiate_send|218] [/var/www/zope/zope272c1/lib/python/ZServer/medusa/http_server.py|send|417] [/usr/local/lib/python2.3/asyncore.py|send|337]) [root@sws003 log]# tail -n100 event.log ------ 2005-03-23T09:16:20 PROBLEM(100) ZServer warning: server accept() threw an exception ------ 2005-03-23T09:16:20 PROBLEM(100) ZServer warning: server accept() threw an exception ------ 2005-03-23T09:16:20 PROBLEM(100) ZServer warning: server accept() threw an exception ------ 2005-03-23T09:16:20 PROBLEM(100) ZServer warning: server accept() threw an exception ... ... ... DeadLockDebugger shows this in several threads calling normal methods or images: File "/var/www/zope/zope272c1/lib/python/ZServer/PubCore/ZServerPublisher.py", line 23, in __init__ response=response) File "/var/www/zope/zope272c1/lib/python/ZPublisher/Publish.py", line 389, in publish_module environ, debug, request, response) File "/var/www/zope/zope272c1/lib/python/ZPublisher/Publish.py", line 180, in publish_module_standard response = publish(request, module_name, after_list, debug=debug) File "/var/www/zope/zope272c1/lib/python/ZPublisher/Publish.py", line 131, in publish sys.exc_info()[2], File "/var/www/zope/zope272c1/lib/python/Zope/App/startup.py", line 179, in zpublisher_exception_hook published=app.__bobo_traverse__(REQUEST).__of__( File "/var/www/zope/zope272c1/lib/python/ZODB/ZApplication.py", line 48, in __bobo_traverse__ conn=db.open(version) File "/var/www/zope/zope272c1/lib/python/ZODB/DB.py", line 493, in open force, waitflag) File "/var/www/zope/zope272c1/lib/python/ZODB/DB.py", line 493, in open force, waitflag) ... ... ... several hundred lines later... File "/var/www/zope/zope272c1/lib/python/ZODB/DB.py", line 493, in open force, waitflag) File "/var/www/zope/zope272c1/lib/python/ZODB/DB.py", line 465, in open pool_lock.acquire() Then this in another DeadLockDebugger thread: (included because it refers to asyncore.py at the end) Thread 2050 (GET /VirtualHostBase/http/www.fredericksburg.com:80//VirtualHostRoot/flshome/): File "/var/www/zope/zope272c2/lib/python/ZServer/PubCore/ZServerPublisher.py", line 23, in __init__ response=response) File "/var/www/zope/zope272c2/lib/python/ZPublisher/Publish.py", line 389, in publish_module environ, debug, request, response) File "/var/www/zope/zope272c2/lib/python/ZPublisher/Publish.py", line 180, in publish_module_standard response = publish(request, module_name, after_list, debug=debug) File "/var/www/zope/zope272c2/lib/python/ZPublisher/Publish.py", line 101, in publish request, bind=1) File "/var/www/zope/zope272c2/lib/python/ZPublisher/mapply.py", line 88, in mapply if debug is not None: return debug(object,args,context) File "/var/www/zope/zope272c2/lib/python/ZPublisher/Publish.py", line 39, in call_object result=apply(object,args) # Type s to step into published object. File "/var/www/zope/zope272c2/lib/python/OFS/DTMLMethod.py", line 130, in __call__ r=apply(HTML.__call__, (self, client, REQUEST), kw) File "/var/www/zope/zope272c2/lib/python/DocumentTemplate/DT_String.py", line 474, in __call__ try: result = render_blocks(self._v_blocks, md) File "/var/www/zope/zope272c2/lib/python/DocumentTemplate/DT_Var.py", line 214, in render val = md[name] File "/var/www/zope/zope272c2/lib/python/Shared/DC/Scripts/Bindings.py", line 320, in __render_with_namespace__ return self._bindAndExec((), namevals, namespace) File "/var/www/zope/zope272c2/lib/python/Shared/DC/Scripts/Bindings.py", line 343, in _bindAndExec return self._exec(bound_data, args, kw) File "/var/www/zope/zope272c2/lib/python/Products/PythonScripts/PythonScript.py", line 323, in _exec result = f(*args, **kw) File "Script (Python)", line 9, in breakingNews File "/var/www/zope/zope272c2/lib/python/Products/ZCatalog/ZCatalog.py", line 649, in searchResults return self._catalog.searchResults(REQUEST, used, **kw) File "/var/www/zope/zope272c2/lib/python/Products/ZCatalog/Catalog.py", line 753, in searchResults return self.search(args, sort_index, reverse, sort_limit, _merge) File "/var/www/zope/zope272c2/lib/python/Products/ZCatalog/Catalog.py", line 500, in search w, rs = weightedIntersection(rs, r) File "/var/www/zope/zope272c2/lib/python/ZODB/Connection.py", line 559, in setstate p, serial = self._storage.load(oid, self._version) File "/var/www/zope/ZOPECLIENT1/lib/python/ZEO/ClientStorage.py", line 749, in load p, s, v, pv, sv = self._server.zeoLoad(oid) File "/var/www/zope/ZOPECLIENT1/lib/python/ZEO/ServerStub.py", line 82, in zeoLoad return self.rpc.call('zeoLoad', oid) File "/var/www/zope/ZOPECLIENT1/lib/python/ZEO/zrpc/connection.py", line 367, in call r_flags, r_args = self.wait(msgid) File "/var/www/zope/ZOPECLIENT1/lib/python/ZEO/zrpc/connection.py", line 474, in wait asyncore.poll(delay, self._map) File "/usr/local/lib/python2.3/asyncore.py", line 108, in poll r, w, e = select.select(r, w, e, timeout)
Allen Schmidt wrote:
RH7.2 Python2.3.3 Zope2.7.2 and ZEO (sorry for the length)
Are you actually experiencing problems here or are you just worried about the errors in your log? cheers, Chris -- Simplistix - Content Management, Zope & Python Consulting - http://www.simplistix.co.uk
The only problem is that our site is completely dead and the threads that show in the DeadLockDebugger stay there and never change and some of the threads go on for hundreds of lines. Chris Withers wrote:
Allen Schmidt wrote:
RH7.2 Python2.3.3 Zope2.7.2 and ZEO (sorry for the length)
Are you actually experiencing problems here or are you just worried about the errors in your log?
cheers,
Chris
Allen Schmidt wrote at 2005-3-23 09:40 -0500:
... RH7.2 Python2.3.3 Zope2.7.2 and ZEO (sorry for the length)
From event.log:
2005-03-23T09:05:26 ERROR(200) ZServer uncaptured python exception, closing channel <ZServer.HTTPServer.zhttp_channel connected 206.112.73.106:42396 at 0x4421566c channel#: 95 requests:> (socket.error:(104, 'Connection reset by peer') [/usr/local/lib/python2.3/asynchat.py|initiate_send|218] [/var/www/zope/zope272c1/lib/python/ZServer/medusa/http_server.py|send|417] [/usr/local/lib/python2.3/asyncore.py|send|337])
This is harmless -- some network problem caused the client connection to get broken.
... 2005-03-23T09:16:20 PROBLEM(100) ZServer warning: server accept() threw an exception
This is deadly. Zope can no longer accept any connection. I have seen this on Solaris and I blamed this outdated OS because the error returned by "accept" could not be raised according to the Solaris documentation ... I assumed that Solaris got some internal resource shortage. There may be an alternative reason: your process has run out of file descriptors. Check the limit ("ulimit -n"). -- Dieter
Upgraded today to Python 2.3.5 In process of upgrading Zope/ZEO to 2.7.5 ZEO and one zope client running. Seeing a variety of issues....some of which were supposed to go away with the upgrade. Too many to mention and flood the list with again. FDs are at 1024 right now. Can I increase this in the zope/zeo startup scripts? Thanks
2005-03-23T09:16:20 PROBLEM(100) ZServer warning: server accept() threw an exception
This is deadly. Zope can no longer accept any connection.
I have seen this on Solaris and I blamed this outdated OS because the error returned by "accept" could not be raised according to the Solaris documentation ... I assumed that Solaris got some internal resource shortage.
There may be an alternative reason: your process has run out of file descriptors. Check the limit ("ulimit -n").
participants (3)
-
Allen Schmidt -
Chris Withers -
Dieter Maurer