You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@perl.apache.org by Jan Schmidt <pe...@jan-o-sch.net> on 2010/04/13 11:29:49 UTC
[mp2] make test fails with a debugging perl
1. Problem Description:
I wanted to debug something different in mod_perl and thought it was a
good idea to have a debugging perl first. After compiling perl with
-Doptimize=-g and a clean rebuild of mod_perl, various tests fail under
Solaris 10.
>From the test logs it seems to me that mod_perl is doing something nasty
(but systematically) with the perl API concerning Perl_sv_catpvn(). From
my limited knowledge of the perl api I can only guess that the first
buffer (*dsv) ought to be less undef (in a perlish-way) than it is in
the test cases. Skipping the assertion in perl-5.10.1/sv.c:4502 helps,
which presumably explains why things go well without -Doptimize=-g. See
below for details (make test output and error log).
2. Used Components and their Configuration:
*** mod_perl version 2.000004
*** using
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/lib/Apache2/BuildConfig.pm
*** Makefile.PL options:
MP_APR_LIB => aprext
MP_AP_CONFIGURE => --with-mpm=prefork --prefix=/opt/RZstgapache
--enable-dav=static --enable-auth-rdbm=static --enable-headers=static
--enable-rewrite=shared --enable-deflate=shared --enable-logio=shared
--enable-proxy=static --enable-ssl=static
--with-ssl=/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/local/openssl-0.9.8h.x86/usr/local/ssl
--enable-suexec --with-suexec-bin=/opt/RZstgapache/bin/suexec
--with-suexec-uidmin=1000 --with-suexec-gidmin=1000
--with-dbmd=/home/janosch/effrafax/obj
MP_AP_PREFIX =>
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/../httpd-2.2.15
MP_CCOPTS => -O1
MP_COMPAT_1X => 1
MP_DEBUG => 1
MP_GENERATE_XS => 1
MP_LIBNAME => mod_perl
MP_TRACE => 1
MP_USE_STATIC => 1
***
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/../httpd-2.2.15/httpd
-V
Server version: Apache/2.2.15 (Unix)
Server built: Apr 12 2010 20:54:12
Server's Module Magic Number: 20051115:24
Server loaded: APR 1.4.2, APR-Util 1.3.9
Compiled using: APR 1.4.2, APR-Util 1.3.9
Architecture: 32-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_PROC_PTHREAD_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="/opt/RZstgapache"
-D SUEXEC_BIN="/opt/RZstgapache/bin/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"
*** /usr/bin/ldd
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/../httpd-2.2.15/httpd
*** (apr|apu)-config linking info
-L/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/httpd-2.2.15/srclib/apr-util/.libs
-L/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/httpd-2.2.15/srclib/apr-util
-laprutil-1
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/httpd-2.2.15/srclib/apr-util/xml/expat/lib/libexpat.la
-L/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/httpd-2.2.15/srclib/apr/.libs
-L/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/httpd-2.2.15/srclib/apr
-lapr-1 -luuid -lsendfile -lrt -lsocket -lnsl -lpthread
*** /opt/RZstgperl/bin/perl -V
Summary of my perl5 (revision 5 version 10 subversion 1) configuration:
Platform:
osname=solaris, osvers=2.10, archname=i86pc-solaris
uname='sunos effrafax 5.10 generic_141445-09 i86pc i386 i86pc '
config_args='-d -e -Dcc=gcc -Dcpp=cpp -Di_stdarg=define
-Di_varargs=undef -Di_varhdr=stdarg.h -Doptimize=-g -Dneed_va_copy=undef
-Dlibswanted=sfio socket bind inet nsl nm ndbm gdbm dbm db dl dld sun m
c cposix posix ndir dir bsd BSD PW x util
-Dlocincpth=/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/include
-Dloclibpth=/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/lib
-Dprefix=/opt/RZstgperl'
hint=recommended, useposix=true, d_sigaction=define
useithreads=undef, usemultiplicity=undef
useperlio=define, d_sfio=undef, uselargefiles=define, usesocks=undef
use64bitint=undef, use64bitall=undef, uselongdouble=undef
usemymalloc=n, bincompat5005=undef
Compiler:
cc='gcc', ccflags ='-DDEBUGGING -fno-strict-aliasing -pipe
-I/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/include
-D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -DPERL_USE_SAFE_PUTENV',
optimize='-g',
cppflags='-DDEBUGGING -fno-strict-aliasing -pipe
-I/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/include'
ccversion='', gccversion='3.4.3 (csl-sol210-3_4-branch+sol_rpath)',
gccosandvers='solaris2.10'
intsize=4, longsize=4, ptrsize=4, doublesize=8, byteorder=1234
d_longlong=define, longlongsize=8, d_longdbl=define, longdblsize=12
ivtype='long', ivsize=4, nvtype='double', nvsize=8, Off_t='off_t',
lseeksize=8
alignbytes=4, prototype=define
Linker and Libraries:
ld='gcc', ldflags ='
-L/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/lib '
libpth=/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/lib
/usr/lib /usr/ccs/lib /usr/local/lib
libs=-lsocket -lnsl -lgdbm -ldb -ldl -lm -lc
perllibs=-lsocket -lnsl -ldl -lm -lc
libc=/lib/libc.so, so=so, useshrplib=false, libperl=libperl.a
gnulibc_version=''
Dynamic Linking:
dlsrc=dl_dlopen.xs, dlext=so, d_dlsymun=undef, ccdlflags=' '
cccdlflags='-fPIC', lddlflags='-G
-L/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgperl/../RZchroot/local/lib'
Characteristics of this binary (from libperl):
Compile-time options: DEBUGGING PERL_DONT_CREATE_GVSV PERL_MALLOC_WRAP
PERL_USE_SAFE_PUTENV USE_LARGE_FILES USE_PERLIO
Built under solaris
Compiled at Apr 12 2010 20:13:28
%ENV:
PERL_LWP_USE_HTTP_10="1"
@INC:
/opt/RZstgperl/lib/5.10.1/i86pc-solaris
/opt/RZstgperl/lib/5.10.1
/opt/RZstgperl/lib/site_perl/5.10.1/i86pc-solaris
/opt/RZstgperl/lib/site_perl/5.10.1
.
*** Packages of interest status:
Apache2 : -
Apache2::Request : -
CGI : 3.43
ExtUtils::MakeMaker: 6.55_02
LWP : -
mod_perl : -
mod_perl2 : 2.000004
3. This is the core dump trace: (if you get a core dump):
[CORE TRACE COMES HERE]
---- make test output ----
/opt/RZstgperl/bin/perl -Iblib/arch -Iblib/lib \
t/TEST -clean
[warning] Skipping 'set unlimited ulimit for coredumps', since we are
running as a non-root user on Solaris
APACHE_TEST_GROUP= APACHE_TEST_HTTPD= APACHE_TEST_PORT=
APACHE_TEST_USER= APACHE_TEST_APXS= \
/opt/RZstgperl/bin/perl -Iblib/arch -Iblib/lib \
t/TEST -bugreport -verbose=1 t/api/lookup_uri.t t/api/rflush.t
t/filter/both_str_con_add.t t/filter/both_str_req_add.t
t/filter/in_autoload.t t/filter/in_str_bin_data.t
t/filter/in_str_consume.t t/filter/in_str_lc.t t/filter/in_str_msg.t
t/filter/in_str_sandwich.t t/filter/out_str_api.t t/filter/out_str_ctx.t
t/filter/out_str_declined.t t/filter/out_str_lc.t
t/filter/out_str_remove.t t/filter/out_str_req_eos.t
t/filter/out_str_req_mix.t t/filter/out_str_req_mix.t
t/filter/out_str_reverse.t t/filter/out_str_subreq_default.t
t/filter/out_str_subreq_default.t t/filter/out_str_subreq_modperl.t
t/filter/with_subrequest.t t/hooks/stacked_handlers2.t
t/protocol/echo_filter.t
[warning] Skipping 'set unlimited ulimit for coredumps', since we are
running as a non-root user on Solaris
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/../httpd-2.2.15/httpd
-d /mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t
-f
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/conf/httpd.conf
-D APACHE2
using Apache/2.2.15 (prefork MPM)
waiting 120 seconds for server to start: .[Tue Apr 13 11:10:17 2010]
[info] 6 Apache2:: modules loaded
[Tue Apr 13 11:10:17 2010] [info] 0 APR:: modules loaded
[Tue Apr 13 11:10:17 2010] [info] base server + 29 vhosts ready to run tests
...............
waiting 120 seconds for server to start: ok (waited 15 secs)
server localhost:8529 started
server localhost:8530 listening (filter_out_apache)
server localhost:8531 listening (perlsections)
server localhost:8532 listening (inherit)
server localhost:8533 listening (TestModperl::merge)
server localhost:8534 listening (TestModperl::perl_options)
server localhost:8535 listening (TestModperl::perl_options2)
server localhost:8536 listening (TestModperl::setupenv)
server localhost:8537 listening (TestModules::proxy)
server localhost:8538 listening (TestUser::rewrite)
server localhost:8539 listening (TestVhost::config)
server localhost:8540 listening (TestVhost::log)
server localhost:8541 listening (TestProtocol::echo_bbs)
server localhost:8542 listening (TestProtocol::echo_bbs2)
server localhost:8543 listening (TestProtocol::echo_block)
server localhost:8544 listening (TestProtocol::echo_filter)
server localhost:8545 listening (TestProtocol::echo_nonblock)
server localhost:8546 listening (TestProtocol::echo_timeout)
server localhost:8547 listening (TestProtocol::pseudo_http)
server localhost:8548 listening (TestPreConnection::note)
server localhost:8549 listening (TestHooks::hookrun)
server localhost:8550 listening (TestHooks::init)
server localhost:8551 listening (TestHooks::stacked_handlers2)
server localhost:8552 listening (TestHooks::startup)
server localhost:8553 listening (TestHooks::trans)
server localhost:8554 listening (TestFilter::both_str_con_add)
server localhost:8555 listening (TestFilter::in_bbs_inject_header)
server localhost:8556 listening (TestFilter::in_bbs_msg)
server localhost:8557 listening (TestFilter::in_str_msg)
server localhost:8558 listening (TestDirective::perlmodule)
server localhost:8559 listening (TestDirective::perlrequire)
server localhost:8560 listening (TestAPI::add_config)
server localhost:8561 listening (TestDirective::perlloadmodule3)
server localhost:8562 listening (TestDirective::perlloadmodule4)
server localhost:8563 listening (TestDirective::perlloadmodule5)
server localhost:8564 listening (TestDirective::perlloadmodule6)
server localhost:8565 listening (TestHooks::push_handlers_anon)
t/api/lookup_uri.t .................
1..4
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:33 2010
# Current time GMT: Tue Apr 13 09:10:33 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : subreq=lookup_uri;filter=none
# expected: pre+subreq=lookup_uri;filter=none+suf
# received:
not ok 1
# Failed test 1 in t/api/lookup_uri.t at line 28
# testing : subreq=lookup_uri;filter=first
# expected: pre+pre+subreq=lookup_uri;filter=first+suf+suf
# received:
not ok 2
# Failed test 2 in t/api/lookup_uri.t at line 28 fail #2
# testing : subreq=lookup_uri;filter=second
# expected: pre+subreq=lookup_uri;filter=second+suf+suf
# received:
not ok 3
# Failed test 3 in t/api/lookup_uri.t at line 28 fail #3
# testing : subreq=lookup_uri;filter=default
# expected: pre+subreq=lookup_uri;filter=default+suf
# received:
not ok 4
# Failed test 4 in t/api/lookup_uri.t at line 28 fail #4
Failed 4/4 subtests
t/api/rflush.t .....................
1..2
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:35 2010
# Current time GMT: Tue Apr 13 09:10:35 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : non-tied rflush creates bucket brigades
# expected: [1][2][3][4][56]
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/api/rflush.t at line 14
# testing : tied STDOUT internal rflush creates bucket brigades
# expected: [1][2][3456]
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 2
# Failed test 2 in t/api/rflush.t at line 20
Failed 2/2 subtests
t/filter/both_str_con_add.t ........
1..4
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:39 2010
# Current time GMT: Tue Apr 13 09:10:39 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
ok 1
# expected: mod_perl
# received:
not ok 2
# expected: 2.0
# received:
not ok 3
# expected: rules
# received:
not ok 4
# Failed test 2 in t/filter/both_str_con_add.t at line 25
# Failed test 3 in t/filter/both_str_con_add.t at line 25 fail #2
# Failed test 4 in t/filter/both_str_con_add.t at line 25 fail #3
Failed 3/4 subtests
t/filter/both_str_req_add.t ........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:41 2010
# Current time GMT: Tue Apr 13 09:10:41 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : lc input and reverse output filters
# expected: abcdefghijklmnopqrstuvwxyz0123456789end
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/both_str_req_add.t at line 16
Failed 1/1 subtests
t/filter/in_autoload.t .............
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:44 2010
# Current time GMT: Tue Apr 13 09:10:44 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : input stream filter lc autoloaded
# expected: [foo bar]
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/in_autoload.t at line 16
Failed 1/1 subtests
t/filter/in_str_bin_data.t .........
1..4
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:47 2010
# Current time GMT: Tue Apr 13 09:10:47 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : /TestFilter__in_str_bin_data binary response length
# expected: 11
# received: 11
ok 1
# testing : /TestFilter__in_str_bin_data binary response data
# expected: 123456789
# received: 123456789
ok 2
request has failed (the response code was: 500)
see t/logs/error_log for more details
Dubious, test returned 255 (wstat 65280, 0xff00)
Failed 2/4 subtests
t/filter/in_str_consume.t ..........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:50 2010
# Current time GMT: Tue Apr 13 09:10:50 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# sent 80000B, expecting 105B to make through
# testing : input stream filter partial consume
# expected: 105
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/in_str_consume.t at line 21
Failed 1/1 subtests
t/filter/in_str_lc.t ...............
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:53 2010
# Current time GMT: Tue Apr 13 09:10:53 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : input stream filter lc
# expected: [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
[foo bar] [foo bar] [foo bar] [foo bar] [foo bar] [foo bar]
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/in_str_lc.t at line 17
Failed 1/1 subtests
t/filter/in_str_msg.t .............. malformed response at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/blib/lib/Apache/TestClient.pm
line 129.
request has failed (the response code was: -1)
see t/logs/error_log for more details
# connecting to localhost:8557
Dubious, test returned 255 (wstat 65280, 0xff00)
No subtests run
t/filter/in_str_sandwich.t .........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:10:58 2010
# Current time GMT: Tue Apr 13 09:10:58 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : input stream filter sandwich
# expected: HEADER
# BODY
# TAIL
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/in_str_sandwich.t at line 15
Failed 1/1 subtests
t/filter/out_str_api.t ............. request has failed (the response
code was: 500)
see t/logs/error_log for more details
Dubious, test returned 255 (wstat 65280, 0xff00)
No subtests run
t/filter/out_str_ctx.t .............
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:02 2010
# Current time GMT: Tue Apr 13 09:11:02 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : context stream filter
# expected:
#################################xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
# received 33 complete blocks
# filter invoked 67 times
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/out_str_ctx.t at line 23
Failed 1/1 subtests
t/filter/out_str_declined.t ........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:04 2010
# Current time GMT: Tue Apr 13 09:11:04 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : an output filter handler returning DECLINED
# expected: 11
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/out_str_declined.t at line 14
Failed 1/1 subtests
t/filter/out_str_lc.t ..............
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:07 2010
# Current time GMT: Tue Apr 13 09:11:07 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
not ok 1
# Failed test 1 in t/filter/out_str_lc.t at line 13
Failed 1/1 subtests
t/filter/out_str_remove.t ..........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:10 2010
# Current time GMT: Tue Apr 13 09:11:10 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : a filter that removes itself
# expected: F_O_O_b_a_r_
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/out_str_remove.t at line 13
Failed 1/1 subtests
t/filter/out_str_req_eos.t .........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:12 2010
# Current time GMT: Tue Apr 13 09:11:12 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : testing the EOS bucket forwarding through the mp filters chains
# expected: PREFIX_BODY_SUFFIX
# received: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
not ok 1
# Failed test 1 in t/filter/out_str_req_eos.t at line 19
Failed 1/1 subtests
t/filter/out_str_req_mix.t .........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:15 2010
# Current time GMT: Tue Apr 13 09:11:15 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : mixing output httpd and mod_perl filters, while preserving order
# expected: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
# received: This is a clear text
not ok 1
# Failed test 1 in t/filter/out_str_req_mix.t at line 18
Failed 1/1 subtests
t/filter/out_str_req_mix.t .........
1..1
# Running under perl version 5.010001 for solaris
# Current time local: Tue Apr 13 11:11:17 2010
# Current time GMT: Tue Apr 13 09:11:17 2010
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.31
# testing : mixing output httpd and mod_perl filters, while preserving order
# expected: <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
# <html><head>
# <title>500 Internal Server Error</title>
# </head><body>
# <h1>Internal Server Error</h1>
# <p>The server encountered an internal error or
# misconfiguration and was unable to complete
# your request.</p>
# <p>Please contact the server administrator,
# janosch@localhost and inform them of the time the error occurred,
# and anything you might have done that may have
# caused the error.</p>
# <p>More information about this error may be available
# in the server error log.</p>
# <hr>
# <address>Apache/2.2.15 (Unix) world domination series/2.0 DAV/2
mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4 Perl/v5.10.1 Server at
localhost Port 8529</address>
# </body></html>
# received: This is a clear text
not ok 1
# Failed test 1 in t/filter/out_str_req_mix.t at line 18
Failed 1/1 subtests
You already have a parser for (t/filter/out_str_req_mix.t). Perhaps you
have run the same test twice. at
/opt/RZstgperl/lib/5.10.1/TAP/Harness.pm line 453
+--------------------------------------------------------+
| Please file a bug report: http://perl.apache.org/bugs/ |
+--------------------------------------------------------+
make: *** [run_tests] Error 255
---- END make test output ----
---- contents of t/logs/error_log ----
[Tue Apr 13 11:10:23 2010] [info] Init: Seeding PRNG with 0 bytes of entropy
[Tue Apr 13 11:10:23 2010] [info] Init: Generating temporary RSA private
keys (512/1024 bits)
[Tue Apr 13 11:10:23 2010] [info] Init: Generating temporary DH
parameters (512/1024 bits)
[Tue Apr 13 11:10:23 2010] [warn] Init: Session Cache is not configured
[hint: SSLSessionCache]
[Tue Apr 13 11:10:23 2010] [info] Init: Initializing (virtual) servers
for SSL
[Tue Apr 13 11:10:23 2010] [info] mod_ssl/2.2.15 compiled against
Server: Apache/2.2.15, Library: OpenSSL/0.9.8h
[Tue Apr 13 11:10:23 2010] [notice] suEXEC mechanism enabled (wrapper:
/opt/RZstgapache/bin/suexec)
END in modperl_extra.pl, pid=26479
[Tue Apr 13 11:10:31 2010] [info] Init: Seeding PRNG with 0 bytes of entropy
[Tue Apr 13 11:10:31 2010] [info] Init: Generating temporary RSA private
keys (512/1024 bits)
[Tue Apr 13 11:10:31 2010] [info] Init: Generating temporary DH
parameters (512/1024 bits)
[Tue Apr 13 11:10:31 2010] [info] Init: Initializing (virtual) servers
for SSL
[Tue Apr 13 11:10:31 2010] [info] mod_ssl/2.2.15 compiled against
Server: Apache/2.2.15, Library: OpenSSL/0.9.8h
[Tue Apr 13 11:10:32 2010] [notice] Apache/2.2.15 (Unix) world
domination series/2.0 DAV/2 mod_ssl/2.2.15 OpenSSL/0.9.8h mod_perl/2.0.4
Perl/v5.10.1 configured -- resuming normal operations
[Tue Apr 13 11:10:32 2010] [info] Server built: Apr 12 2010 20:54:12
[Tue Apr 13 11:10:32 2010] [debug] prefork.c(1013): AcceptMutex: pthread
(default: pthread)
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1818): proxy: grabbed
scoreboard slot 0 in child 26598 for worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1934): proxy:
initialized single connection worker 0 in child 26598 for (localhost)
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1818): proxy: grabbed
scoreboard slot 1 in child 26598 for worker proxy:reverse
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1934): proxy:
initialized single connection worker 1 in child 26598 for (*)
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1818): proxy: grabbed
scoreboard slot 0 in child 26599 for worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1837): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1934): proxy:
initialized single connection worker 0 in child 26599 for (localhost)
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1818): proxy: grabbed
scoreboard slot 1 in child 26599 for worker proxy:reverse
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1837): proxy: worker
proxy:reverse already initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1934): proxy:
initialized single connection worker 1 in child 26599 for (*)
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:32 2010] [debug] proxy_util.c(1803): proxy: worker
http://localhost:8529/TestFilter__both_str_req_proxy_content/ already
initialized
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 63.\n
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 25
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 63.\n
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 25
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 63.\n
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 25
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 63.\n
[Tue Apr 13 11:10:35 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/lookup_uri.pm
line 25
[Tue Apr 13 11:10:39 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/rflush.pm
line 25.\n
[Tue Apr 13 11:10:39 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/rflush.pm
line 43
[Tue Apr 13 11:10:39 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/rflush.pm
line 25.\n
[Tue Apr 13 11:10:39 2010] [error] [client 127.0.0.1] :Apache2 IO flush:
(500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/response/TestAPI/rflush.pm
line 60
[Tue Apr 13 11:10:41 2010] [error] Assertion dstr failed: file "sv.c",
line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/both_str_con_add.pm
line 34.\n
[Tue Apr 13 11:10:41 2010] [error] Apache2::Filter::get_brigade:
(120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/both_str_con_add.pm
line 65
[Tue Apr 13 11:10:44 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/both_str_req_add.pm
line 43.\n
[Tue Apr 13 11:10:44 2010] [error] [client 127.0.0.1]
Apache2::Filter::get_brigade: (120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/lib/TestCommon/Utils.pm
line 39
[Tue Apr 13 11:10:46 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/in_autoload.pm
line 21.\n
[Tue Apr 13 11:10:46 2010] [error] [client 127.0.0.1]
Apache2::Filter::get_brigade: (120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/lib/TestCommon/Utils.pm
line 39
[Tue Apr 13 11:10:50 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/in_str_bin_data.pm
line 22.\n
[Tue Apr 13 11:10:50 2010] [error] [client 127.0.0.1]
Apache2::Filter::get_brigade: (120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/lib/TestCommon/Utils.pm
line 39
[Tue Apr 13 11:10:53 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/in_str_consume.pm
line 85.\n
[Tue Apr 13 11:10:53 2010] [error] [client 127.0.0.1]
Apache2::Filter::get_brigade: (120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/lib/TestCommon/Utils.pm
line 39
[Tue Apr 13 11:10:55 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/in_str_lc.pm
line 17.\n
[Tue Apr 13 11:10:55 2010] [error] [client 127.0.0.1]
Apache2::Filter::get_brigade: (120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/lib/TestCommon/Utils.pm
line 39
[Tue Apr 13 11:10:58 2010] [error] Assertion dstr failed: file "sv.c",
line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/in_str_msg.pm
line 39.\n
[Tue Apr 13 11:11:00 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/in_str_sandwich.pm
line 27.\n
[Tue Apr 13 11:11:00 2010] [error] [client 127.0.0.1]
Apache2::Filter::get_brigade: (120001) filter handler has failed at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/lib/TestCommon/Utils.pm
line 39
[Tue Apr 13 11:11:02 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_api.pm
line 30.\n
[Tue Apr 13 11:11:04 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_ctx.pm
line 27.\n
[Tue Apr 13 11:11:04 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_ctx.pm
line 78
[Tue Apr 13 11:11:07 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_declined.pm
line 47.\n
[Tue Apr 13 11:11:07 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::rflush: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_declined.pm
line 70
[Tue Apr 13 11:11:10 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_lc.pm
line 15.\n
[Tue Apr 13 11:11:10 2010] [debug] core.c(3765): [client 127.0.0.1]
(500)Unknown error: default_handler: ap_pass_brigade returned 500
[Tue Apr 13 11:11:12 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_remove.pm
line 37.\n
[Tue Apr 13 11:11:12 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::rflush: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_remove.pm
line 55
[Tue Apr 13 11:11:15 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_eos.pm
line 30.\n
[Tue Apr 13 11:11:15 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_eos.pm
line 43.\n
[Tue Apr 13 11:11:15 2010] [error] [client 127.0.0.1] Apache2::Filter
internal flush: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_eos.pm
line 62
[Tue Apr 13 11:11:17 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_mix.pm
line 50.\n
[Tue Apr 13 11:11:17 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_mix.pm
line 64
[Tue Apr 13 11:11:19 2010] [error] [client 127.0.0.1] Assertion dstr
failed: file "sv.c", line 4502 at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_mix.pm
line 50.\n
[Tue Apr 13 11:11:19 2010] [error] [client 127.0.0.1]
Apache2::RequestIO::print: (500) Unknown error at
/mnt/waflhome/janosch/effrafax/cvs/pkgs/RZstgapache/mod_perl-2.0.4/t/filter/TestFilter/out_str_req_mix.pm
line 64
---- END contents of t/logs/error_log ----
This report was generated by t/REPORT on Tue Apr 13 08:41:23 2010 GMT.
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org
Re: [mp2] make test fails with a debugging perl
Posted by Torsten Förtsch <to...@gmx.net>.
On Tuesday 13 April 2010 12:00:05 Torsten Förtsch wrote:
> svn checkout \
> https://svn.apache.org/repos/asf/perl/modperl/branches/threading \
> mod_perl-2.0
>
Oops, don't do that. It one requires a threaded perl. Yours is not.
useithreads=undef, usemultiplicity=undef
Torsten Förtsch
--
Need professional modperl support? Hire me! (http://foertsch.name)
Like fantasy? http://kabatinte.net
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org
Re: [mp2] make test fails with a debugging perl
Posted by Jan Schmidt <pe...@jan-o-sch.net>.
Torsten Förtsch wrote:
> On Tuesday 13 April 2010 12:49:45 Jan Schmidt wrote:
>> Tried and works. Thank you! I wonder whether this was just "not nice to
>> perl" or might it have been the root cause for infrequent memory
>> corruptions I am hunting for?
>>
> No. sv_catpvn calls SvGROW itself almost first thing. SvGROW then allocates
> memory and stores it in SvPVX. The patch is really only needed to make
> -DDEBUGGING happy.
Ok, thanks.
> You really might want to try trunk.
I will, in case I still get those infrequent memory corruptions inside
apache. However, I previously used 2.2.14 and now went on to 2.2.15. Up
to now, I cannot even tell if the corruptions were triggered by
mod_perl, the changelog of 2.2.15 looks promising. Thus, if things are
fine now, I'd rather stay with 2.0.4 (or future releases). If not, I
will try trunk of apache and mod_perl.
Jan
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org
Re: [mp2] make test fails with a debugging perl
Posted by Torsten Förtsch <to...@gmx.net>.
On Tuesday 13 April 2010 12:49:45 Jan Schmidt wrote:
> Tried and works. Thank you! I wonder whether this was just "not nice to
> perl" or might it have been the root cause for infrequent memory
> corruptions I am hunting for?
>
No. sv_catpvn calls SvGROW itself almost first thing. SvGROW then allocates
memory and stores it in SvPVX. The patch is really only needed to make
-DDEBUGGING happy.
You really might want to try trunk.
Torsten Förtsch
--
Need professional modperl support? Hire me! (http://foertsch.name)
Like fantasy? http://kabatinte.net
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org
Re: [mp2] make test fails with a debugging perl
Posted by Jan Schmidt <pe...@jan-o-sch.net>.
Torsten Förtsch wrote:
> On Tuesday 13 April 2010 11:29:49 Jan Schmidt wrote:
>> From the test logs it seems to me that mod_perl is doing something nasty
>> (but systematically) with the perl API concerning Perl_sv_catpvn().
>>
> Fixed in trunk.
>
> You may try this patch:
Tried and works. Thank you! I wonder whether this was just "not nice to
perl" or might it have been the root cause for infrequent memory
corruptions I am hunting for?
Jan
PS: no CC required, I do read the list I'm posting to.
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org
Re: [mp2] make test fails with a debugging perl
Posted by Torsten Förtsch <to...@gmx.net>.
On Tuesday 13 April 2010 11:29:49 Jan Schmidt wrote:
> From the test logs it seems to me that mod_perl is doing something nasty
> (but systematically) with the perl API concerning Perl_sv_catpvn().
>
Fixed in trunk.
You may try this patch:
Index: src/modules/perl/modperl_filter.c
===================================================================
--- src/modules/perl/modperl_filter.c (revision 931502)
+++ src/modules/perl/modperl_filter.c (revision 931503)
@@ -654,9 +654,14 @@
apr_size_t len = 0;
(void)SvUPGRADE(buffer, SVt_PV);
- SvPOK_only(buffer);
SvCUR(buffer) = 0;
+ /* calling SvPOK_only here may leave buffer an invalid state since
+ * SvPVX may be NULL. But it's very likely that something is copied.
+ * So, we turn the POK flag on here. Later we check if SvPVX is NULL
+ * and turn the flag off again if so. */
+ SvPOK_only(buffer);
+
/* sometimes the EOS bucket arrives in the same brigade with other
* buckets, so that particular read() will not return 0 and will
* be called again if called in the while ($filter->read(...))
@@ -682,6 +687,7 @@
wanted,
MP_TRACE_STR_TRUNC(filter->pool, filter->leftover,
wanted),
filter->remaining);
+ SvGROW(buffer, wanted+1);
sv_catpvn(buffer, filter->leftover, wanted);
filter->leftover += wanted;
filter->remaining -= wanted;
@@ -692,6 +698,7 @@
"eating remaining %db",
MP_FILTER_NAME(filter->f),
filter->remaining);
+ SvGROW(buffer, filter->remaining+1);
sv_catpvn(buffer, filter->leftover, filter->remaining);
len = filter->remaining;
filter->remaining = 0;
@@ -728,6 +735,7 @@
if (buf_len) {
if ((SvCUR(buffer) + buf_len) >= wanted) {
int nibble = wanted - SvCUR(buffer);
+ SvGROW(buffer, SvCUR(buffer)+nibble+1);
sv_catpvn(buffer, buf, nibble);
filter->leftover = (char *)buf+nibble;
filter->remaining = buf_len - nibble;
@@ -736,11 +744,16 @@
}
else {
len += buf_len;
+ SvGROW(buffer, SvCUR(buffer)+buf_len+1);
sv_catpvn(buffer, buf, buf_len);
}
}
}
+ if (!SvPVX(buffer)) {
+ SvPOK_off(buffer);
+ }
+
MP_TRACE_f(MP_FUNC,
MP_FILTER_NAME_FORMAT
"return: %db from %d bucket%s [%s]\n\t(%db leftover)",
Or use trunk:
svn checkout https://svn.apache.org/repos/asf/perl/modperl/trunk/ mod_perl-2.0
or
svn checkout \
https://svn.apache.org/repos/asf/perl/modperl/branches/threading \
mod_perl-2.0
I'd recommend the latter.
Torsten Förtsch
--
Need professional modperl support? Hire me! (http://foertsch.name)
Like fantasy? http://kabatinte.net
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org