|
Graham Dumpleton
graham.dumpleton at gmail.com
Mon Apr 7 03:02:26 EDT 2008
2008/4/7 Alec Matusis <matusis at yahoo.com>: > I have been getting the second error too > > IOError: > > Client read error (Timeout?), referer: http://example.com/ > > I assumed that this happens when a user uploads a file, and their incoming connection is pretty slow. I used Fiddler and throttled down upload speeds to below dialup speed, and I could reproduce this error very well in that scenario. Not necessarily. The problem is that mod_python uses Apache ap_get_client_block() function to get more data from client. The return value of this is the length of data rather than an error code. In fact the error code as to why it failed is lost internal to the function. Thus the true reason for the error can't be determined and why mod_python has a question mark there. More often than not it is because connection closed before all expected data received. If there is a timeout on the connection, then you should be able to tell by playing with the Apache Timeout directive to change it and see how application behaves differently or not. Since the default for Timeout is 300 seconds, wouldn't expect a slow connection to trigger a timeout as the timeout applies to a blocked connection, ie., waiting for data for that long, if a slow connection you would still be receiving some data wouldn't you. Graham > > -----Original Message----- > > From: mod_python-bounces at modpython.org [mailto:mod_python- > > bounces at modpython.org] On Behalf Of Clodoaldo > > Sent: Saturday, April 05, 2008 4:06 PM > > To: mod_python at modpython.org list > > Subject: [mod_python] mod_python errors > > > > Three errors have been happening in an application using mod_python. > > > > Configuration: > > Fedora Core 6. This server does not have mod_wsgi installed. > > # uname -a > > Linux myserver.net 2.6.22.14-72.fc6 #1 SMP Wed Nov 21 14:10:25 EST > > 2007 x86_64 x86_64 x86_64 GNU/Linux > > > > Python 2.4.4 > > # ldd /usr/lib64/libpython2.4.so > > libpthread.so.0 => /lib64/libpthread.so.0 (0x0000003751e00000) > > libdl.so.2 => /lib64/libdl.so.2 (0x00000032d1000000) > > libutil.so.1 => /lib64/libutil.so.1 (0x00000032d8800000) > > libm.so.6 => /lib64/libm.so.6 (0x00000032d1400000) > > libc.so.6 => /lib64/libc.so.6 (0x00000032d0c00000) > > /lib64/ld-linux-x86-64.so.2 (0x0000555555554000) > > > > mod_python 3.3.0b > > # ldd /usr/lib64/httpd/modules/mod_python.so > > libpthread.so.0 => /lib64/libpthread.so.0 (0x00002aaaaae07000) > > libdl.so.2 => /lib64/libdl.so.2 (0x00002aaaab021000) > > libutil.so.1 => /lib64/libutil.so.1 (0x00002aaaab225000) > > libm.so.6 => /lib64/libm.so.6 (0x00002aaaab429000) > > libc.so.6 => /lib64/libc.so.6 (0x00002aaaab6ac000) > > /lib64/ld-linux-x86-64.so.2 (0x0000555555554000) > > > > [Sat Apr 05 01:32:13 2008] [notice] Digest: generating secret for > > digest authentication ... > > [Sat Apr 05 01:32:13 2008] [notice] Digest: done > > [Sat Apr 05 01:32:13 2008] [notice] mod_python: Creating 8 session > > mutexes based on 256 max processes and 0 max threads. > > [Sat Apr 05 01:32:13 2008] [notice] mod_python: using mutex_directory > > /tmp > > [Sat Apr 05 01:32:13 2008] [notice] Apache/2.2.6 (Unix) DAV/2 > > PHP/5.1.6 mod_python/3.3.0b Python/2.4.4 mod_ssl/2.2.6 OpenSSL/0.9.8b > > mod_perl/2.0.2 Perl/v5.8.8 configured -- resuming normal operations > > > > # httpd -V > > Server version: Apache/2.2.6 (Unix) > > Server built: Sep 18 2007 11:25:59 > > Server's Module Magic Number: 20051115:5 > > Server loaded: APR 1.2.7, APR-Util 1.2.8 > > Compiled using: APR 1.2.7, APR-Util 1.2.8 > > Architecture: 64-bit > > Server MPM: Prefork > > threaded: no > > forked: yes (variable process count) > > Server compiled with.... > > -D APACHE_MPM_DIR="server/mpm/prefork" > > -D APR_HAS_SENDFILE > > -D APR_HAS_MMAP > > -D APR_HAVE_IPV6 (IPv4-mapped addresses enabled) > > -D APR_USE_SYSVSEM_SERIALIZE > > -D APR_USE_PTHREAD_SERIALIZE > > -D SINGLE_LISTEN_UNSERIALIZED_ACCEPT > > -D APR_HAS_OTHER_CHILD > > -D AP_HAVE_RELIABLE_PIPED_LOGS > > -D DYNAMIC_MODULE_LIMIT=128 > > -D HTTPD_ROOT="/etc/httpd" > > -D SUEXEC_BIN="/usr/sbin/suexec" > > -D DEFAULT_PIDLOG="logs/httpd.pid" > > -D DEFAULT_SCOREBOARD="logs/apache_runtime_status" > > -D DEFAULT_LOCKFILE="logs/accept.lock" > > -D DEFAULT_ERRORLOG="logs/error_log" > > -D AP_TYPES_CONFIG_FILE="conf/mime.types" > > -D SERVER_CONFIG_FILE="conf/httpd.conf" > > > > The first error is already described in this thread: > > http://www.modpython.org/pipermail/mod_python/2007-June/023795.html > > > > It is also commented in these threads: > > http://groups.google.co.uk/group/webpy/browse_thread/thread/4c5f2c76b74 > > 9eb4e > > http://bytes.com/forum/thread40318.html > > > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] > > ServerName: 'example.com', referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] > > DocumentRoot: '/var/www/html/example.com', referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] URI: > > '/_pesquisa', referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] Location: > > None, referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] Directory: > > '/var/www/html/example.com/', referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] Filename: > > '/var/www/html/example.com/_pesquisa.py', referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] PathInfo: > > '', referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] Traceback > > (most recent call last):, referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1537, in HandlerDispatch\n default=default_handler, arg=req, > > silent=hlist.silent), referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1229, in _process_target\n result = _execute_target(config, req, > > object, arg), referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1128, in _execute_target\n result = object(arg), referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/home/carroarodo/mod/_publisher.py", line 5, in handler\n return > > publisher.handler(req), referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/usr/lib64/python2.4/site-packages/mod_python/publisher.py", line > > 213, in handler\n published = publish_object(req, object), referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/usr/lib64/python2.4/site-packages/mod_python/publisher.py", line > > 424, in publish_object\n req.form = util.FieldStorage(req, > > keep_blank_values=1), referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] File > > "/usr/lib64/python2.4/site-packages/mod_python/util.py", line 225, in > > __init__\n pairs = parse_qsl(req.read(clen), keep_blank_values), > > referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > [Sat Apr 05 15:19:51 2008] [error] [client 200.147.229.174] > > SystemError: Objects/stringobject.c:3515: bad argument to internal > > function, referer: > > http://example.com/?estado_sigla=Brasil&localidade_id=0&bairro_id=0&fab > > ricante_id=22&modelo_id=0 > > > > The second is more frequent: > > > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] mod_python > > (pid=326, interpreter='example.com', phase='PythonHandler', > > handler='/home/carroarodo/mod/_publisher.py'): Application error, > > referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] ServerName: > > 'example.com', referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] DocumentRoot: > > '/var/www/html/example.com', referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] URI: > > '/_pesquisa', referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] Location: > > None, referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] Directory: > > '/var/www/html/example.com/', referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] Filename: > > '/var/www/html/example.com/_pesquisa.py', referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] PathInfo: '', > > referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] Traceback > > (most recent call last):, referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1537, in HandlerDispatch\n default=default_handler, arg=req, > > silent=hlist.silent), referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1229, in _process_target\n result = _execute_target(config, req, > > object, arg), referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1128, in _execute_target\n result = object(arg), referer: > > http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/home/carroarodo/mod/_publisher.py", line 5, in handler\n return > > publisher.handler(req), referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/usr/lib64/python2.4/site-packages/mod_python/publisher.py", line > > 213, in handler\n published = publish_object(req, object), referer: > > http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/usr/lib64/python2.4/site-packages/mod_python/publisher.py", line > > 424, in publish_object\n req.form = util.FieldStorage(req, > > keep_blank_values=1), referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] File > > "/usr/lib64/python2.4/site-packages/mod_python/util.py", line 225, in > > __init__\n pairs = parse_qsl(req.read(clen), keep_blank_values), > > referer: http://example.com/ > > [Sat Apr 05 14:57:49 2008] [error] [client 201.32.1.196] IOError: > > Client read error (Timeout?), referer: http://example.com/ > > > > This is the access log for the above error: > > > > 201.32.1.196 - - [05/Apr/2008:14:57:14 +0000] "POST /_pesquisa > > HTTP/1.1" 200 643 "http://example.com/" "Mozilla/4.0 (compatible; MSIE > > 6.0; Windows NT 5.1; SV1; .NET CLR 1.1.4322)" > > 201.32.1.196 - - [05/Apr/2008:14:57:19 +0000] "GET > > /?estado_sigla=RJ&localidade_id=0&bairro_id=0&fabricante_id=22&modelo_i > > d=0 > > HTTP/1.1" 2 > > 00 2773 "http://example.com/" "Mozilla/4.0 (compatible; MSIE 6.0; > > Windows NT 5.1; SV1; .NET CLR 1.1.4322)" > > 201.32.1.196 - - [05/Apr/2008:14:57:21 +0000] "GET > > /pub/fotos/0/a/c/0ac0b8a054571a0502f2653620544562769616d8.jpg > > HTTP/1.1" 200 6801 "http > > ://example.com/?estado_sigla=RJ&localidade_id=0&bairro_id=0&fabricante_ > > id=22&modelo_id=0" > > "Mozilla/4.0 (compatible; MSIE 6.0; Windows > > NT 5.1; SV1; .NET CLR 1.1.4322)" > > 201.32.1.196 - - [05/Apr/2008:14:56:19 +0000] "POST /_pesquisa > > HTTP/1.1" 500 661 "http://example.com/" "Mozilla/4.0 (compatible; MSIE > > 6.0; Windows NT 5.1; SV1; .NET CLR 1.1.4322)" > > 201.32.1.196 - - [05/Apr/2008:14:57:57 +0000] "GET > > /ce?i=934&h=sLH2ndocEZ_8EoGtvtsnNA HTTP/1.1" 200 1113 "-" "Mozilla/4.0 > > (compatible; MS > > IE 6.0; Windows NT 5.1; SV1; .NET CLR 1.1.4322)" > > 201.32.1.196 - - [05/Apr/2008:14:58:01 +0000] "GET /login HTTP/1.1" > > 200 1499 "http://example.com/ce?i=934&h=sLP2ndot1Z_8EoGtvtsnNA" "M > > ozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1; .NET CLR > > 1.1.4322)" > > > > > > And the third is quite strange: > > > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] PathInfo: > > '', referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] Traceback > > (most recent call last):, referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1537, in HandlerDispatch\n default=default_handler, arg=req, > > silent=hlist.silent), referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1229, in _process_target\n result = _execute_target(config, req, > > object, arg), referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/usr/lib64/python2.4/site-packages/mod_python/importer.py", line > > 1128, in _execute_target\n result = object(arg), referer: > > http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/home/carroarodo/mod/_publisher.py", line 5, in handler\n return > > publisher.handler(req), referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/usr/lib64/python2.4/site-packages/mod_python/publisher.py", line > > 213, in handler\n published = publish_object(req, object), referer: > > http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/usr/lib64/python2.4/site-packages/mod_python/publisher.py", line > > 425, in publish_object\n return > > publish_object(req,util.apply_fs_data(object, req.form, req=req)), > > referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/usr/lib64/python2.4/site-packages/mod_python/util.py", line 554, in > > apply_fs_data\n return object(**args), referer: > > http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] File > > "/var/www/html/example.com/login.py", line 52, in index\n > > _d['mensagem'] += \\, referer: http://example.com/login > > [Sat Apr 05 20:58:11 2008] [error] [client 189.69.253.187] TypeError: > > unsupported operand type(s) for +=: 'NoneType' and 'str', referer: > > http://example.com/login > > > > Access log: > > 189.27.86.85 - - [05/Apr/2008:20:58:08 +0000] "GET / HTTP/1.1" 200 > > 5739 "http://example.com/" "Mozilla/4.0 (compatible; MSIE 6.0; Windows > > NT 5.1; SV1; Mozilla/4.0 (compatible; MSIE 6.0; Windows NT 5.1; SV1) ; > > FDM; .NET CLR 1.1.4322; .NET CLR 2.0.50727; .NET CLR 3.0.04506.648; > > .NET CLR 3.5.21022)" > > > > The line it complains about is this: > > > > _d['mensagem'] += \ > > '<br><br>Você já leu o email enviado para %s ?'\ > > > > This line always work except in the above ocasion. > > > > Regards, Clodoaldo Pinto Neto > > > > _______________________________________________ > > Mod_python mailing list > > Mod_python at modpython.org > > http://mailman.modpython.org/mailman/listinfo/mod_python > > > > _______________________________________________ > Mod_python mailing list > Mod_python at modpython.org > http://mailman.modpython.org/mailman/listinfo/mod_python >
|