perl-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Jie Gao <J....@isu.usyd.edu.au>
Subject Re: [mp2] modperl-2.0_20041207171655 test fails
Date Wed, 08 Dec 2004 22:20:50 GMT



On Wed, 8 Dec 2004, Stas Bekman wrote:

> Date: Wed, 08 Dec 2004 16:45:52 -0500
> From: Stas Bekman <stas@stason.org>
> To: Jie Gao <J.Gao@isu.usyd.edu.au>
> Cc: dev@perl.apache.org
> Subject: Re: [mp2] modperl-2.0_20041207171655 test fails
>
> Jie Gao wrote:
> > make test fails (using Apache/2.0.51 (prefork MPM) on Solaris 9):
> >
> > t/api/lookup_uri........................request has failed (the response code was:
500)
> > see t/logs/error_log for more details
> > t/api/lookup_uri........................dubious
> >         Test returned status 29 (wstat 7424, 0x1d00)
> > t/api/lookup_uri2.......................ok
> > t/api/module............................ok
> > t/api/process...........................ok
> > t/api/query.............................ok
> > t/api/r_subclass........................FAILED test 1
> >         Failed 1/5 tests, 80.00% okay
> > t/api/request_rec.......................FAILED tests 33-37
> >         Failed 5/52 tests, 90.38% okay
> > t/hooks/init............................request has failed (the response code was:
404)
> > t/user/rewrite..........................dubious
> >         Test returned status 29 (wstat 7424, 0x1d00)
> >
> > Have tried 3 times with the same result.
>
> Thanks Jie, but you miss the output of t/REPORT and verbose console
> output. Please run:
>
> rm t/logs/error_log
> t/TEST -v t/api/lookup_uri t/api/r_subclass t/api/request_rec t/hooks/init
> t/user/rewrite
>
> and post here:
>
> 1) console output

> t/TEST -v t/api/lookup_uri t/api/r_subclass t/api/request_rec t/hooks/init t/user/rewrite
[warning] root mode: changing the files ownership to 'nobody' (60001:60001)
[warning] testing whether 'nobody' is able to -rwx /opt/local/src/modperl-2.0/t
"/usr/local/bin/perl" -Mlib=/opt/local/src/modperl-2.0/Apache-Test/lib -MApache::TestRun -e
'eval {
Apache::TestRun::run_root_fs_test(60001, 60001, q[/opt/local/src/modperl-2.0/t]) }';


[warning] result: OK
[warning] the client side drops 'root' permissions and becomes 'nobody'
/usr/local/apache_2.0.51_prefork_test/bin/httpd  -d /opt/local/src/modperl-2.0/t -f
/opt/local/src/modperl-2.0/t/conf/httpd.conf -D APACHE2
using Apache/2.0.51 (prefork MPM)

waiting 120 seconds for server to start: ..[Thu Dec 09 09:13:26 2004] [info] 25 Apache:: modules
loaded
[Thu Dec 09 09:13:26 2004] [info] 5 APR:: modules loaded
[Thu Dec 09 09:13:26 2004] [info] base server + 29 vhosts ready to run tests
.....
waiting 120 seconds for server to start: ok (waited 6 secs)
server localhost:8529 started
server localhost:8530 listening (filter_out_apache)
server localhost:8531 listening (TestModperl::merge)
server localhost:8532 listening (TestModperl::perl_options)
server localhost:8533 listening (TestModperl::setupenv)
server localhost:8534 listening (TestModules::proxy)
server localhost:8535 listening (TestUser::rewrite)
server localhost:8536 listening (TestVhost::config)
server localhost:8537 listening (TestVhost::log)
server localhost:8538 listening (TestProtocol::echo_timeout)
server localhost:8539 listening (TestProtocol::echo_block)
server localhost:8540 listening (TestProtocol::echo_filter)
server localhost:8541 listening (TestProtocol::echo_bbs)
server localhost:8542 listening (TestProtocol::eliza)
server localhost:8543 listening (TestProtocol::echo_nonblock)
server localhost:8544 listening (TestProtocol::echo_bbs2)
server localhost:8545 listening (TestProtocol::pseudo_http)
server localhost:8546 listening (TestPreConnection::note)
server localhost:8547 listening (TestHooks::init)
server localhost:8548 listening (TestHooks::stacked_handlers2)
server localhost:8549 listening (TestHooks::startup)
server localhost:8550 listening (TestHooks::trans)
server localhost:8551 listening (TestHooks::hookrun)
server localhost:8552 listening (TestFilter::in_bbs_inject_header)
server localhost:8553 listening (TestFilter::both_str_con_add)
server localhost:8554 listening (TestFilter::in_bbs_msg)
server localhost:8555 listening (TestFilter::in_str_msg)
server localhost:8556 listening (TestDirective::perlmodule)
server localhost:8557 listening (TestDirective::perlrequire)
server localhost:8558 listening (TestPerl::ithreads)
server localhost:8559 listening (TestDirective::perlloadmodule3)
server localhost:8560 listening (TestDirective::perlloadmodule4)
server localhost:8561 listening (TestDirective::perlloadmodule5)
server localhost:8562 listening (TestDirective::perlloadmodule6)
t/api/lookup_uri.....request has failed (the response code was: 500)
see t/logs/error_log for more details
dubious
        Test returned status 29 (wstat 7424, 0x1d00)
t/api/r_subclass.....1..5
# Running under perl version 5.008004 for solaris
# Current time local: Thu Dec  9 09:13:28 2004
# Current time GMT:   Wed Dec  8 22:13:28 2004
# Using Test.pm version 1.24
# Using Apache/Test.pm version 1.17
not ok 1
ok 2
ok 3
ok 4
ok 5
FAILED test 1
        Failed 1/5 tests, 80.00% okay
t/api/request_rec....1..52
# Running under perl version 5.008004 for solaris
# Current time local: Thu Dec  9 09:13:28 2004
# Current time GMT:   Wed Dec  8 22:13:28 2004
# Using Test.pm version 1.24
# Using Apache/Test.pm version 1.17
ok 1
ok 2
ok 3
ok 4
ok 5
ok 6
ok 7
ok 8
ok 9
ok 10
ok 11
ok 12
# testing : t->proto_num
# expected: 1000
# received: 1000
ok 13
# testing : $r->hostname
# expected: localhost
# received: localhost
ok 14
ok 15
ok 16
ok 17
# testing : $r->method
# expected: GET
# received: GET
ok 18
# testing : $r->method_number
# expected: 0
# received: 0
ok 19
ok 20
ok 21
ok 22
ok 23
ok 24
ok 25
ok 26
ok 27
ok 28
ok 29
# buffered
# testing : buffered print
# expected: 11
# received: 11
ok 30
# testing : buffered print
# expected: 0
# received: 0
ok 31
# not buffered
# testing : unbuffered print
# expected: 15
# received: 15
ok 32
# expected: /TestAPI__request_rec/my_path_info?my_args=3
# received: /TestAPI__request_rec
not ok 33
# testing : $r->uri
# expected: /TestAPI__request_rec/my_path_info
# received: /TestAPI__request_rec
not ok 34
# testing : $r->path_info
# expected: /my_path_info
# received:
not ok 35
# testing : $r->args
# expected: my_args=3
# received: undef
not ok 36
# testing : $r->the_request
# expected: GET /TestAPI__request_rec/my_path_info?my_args=3 HTTP/1.0
# received: GET /TestAPI__request_rec HTTP/1.0
not ok 37
ok 38
# testing : $r->location
# expected: /TestAPI__request_rec
# received: /TestAPI__request_rec
ok 39
# sent so far: 1454 bytes
ok 40
# testing : mtime
# expected: 1101892828
# received: 1101892828
ok 41
# testing : $r->finfo
# expected: /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm
# received: /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm
ok 42
ok 43
ok 44
ok 45
# testing : $r->content_languages
# expected: [
#     fr,
# ]
# received: [
#     fr,
# ]
ok 46
# testing : $r->content_languages
# expected: [
#     fr,
# ]
# received: [
#     fr,
# ]
ok 47
# testing : $r->content_languages
# expected: [
#     fr,
#     us,
#     cn,
# ]
# received: [
#     fr,
#     us,
#     cn,
# ]
ok 48
# testing : $r->content_languages(invalid)
# expected: (?-xism:Not an array reference)
# received: Not an array reference at /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm
line 176.
ok 49
# testing : invalid Apache::RequestRec=HASH(0x1268ec8) object
# expected: (?-xism:method `uri' invoked by a `Apache::RequestRec' object with no `r' key!)
# received: method `uri' invoked by a `Apache::RequestRec' object with no `r' key! at
/opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm line 186.
ok 50
# testing : invalid NonExisting=HASH(0x124eb3c) object
# expected: (?-xism:method `uri' invoked by a `NonExisting' object with no `r' key!)
# received: method `uri' invoked by a `NonExisting' object with no `r' key! at
/opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm line 193.
ok 51
# testing : invalid HASH(0x1268ef8) object
# expected: (?-xism:method `uri' invoked by a `unknown' object with no `r' key!)
# received: method `uri' invoked by a `unknown' object with no `r' key! at
/opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm line 200.
ok 52
FAILED tests 33-37
        Failed 5/52 tests, 90.38% okay
t/hooks/init.........request has failed (the response code was: 404)
see t/logs/error_log for more details
dubious
        Test returned status 29 (wstat 7424, 0x1d00)
t/user/rewrite.......request has failed (the response code was: 404)
see t/logs/error_log for more details
dubious
        Test returned status 29 (wstat 7424, 0x1d00)
Failed Test         Stat Wstat Total Fail  Failed  List of Failed
-------------------------------------------------------------------------------
t/api/lookup_uri.t    29  7424    ??   ??       %  ??
t/api/r_subclass.t                 5    1  20.00%  1
t/api/request_rec.t               52    5   9.62%  33-37
t/hooks/init.t        29  7424    ??   ??       %  ??
t/user/rewrite.t      29  7424    ??   ??       %  ??
Failed 5/5 test scripts, 0.00% okay. 6/57 subtests failed, 89.47% okay.
[warning] server localhost:8529 shutdown
[  error] error running tests (please examine t/logs/error_log)

> 2) error_log

> more t/logs/error_log
[Thu Dec 09 09:13:26 2004] [info] Init: Initializing OpenSSL library
[Thu Dec 09 09:13:26 2004] [info] Init: Seeding PRNG with 0 bytes of entropy
[Thu Dec 09 09:13:26 2004] [info] Init: Generating temporary RSA private keys (512/1024 bits)
[Thu Dec 09 09:13:27 2004] [info] Init: Generating temporary DH parameters (512/1024 bits)
[Thu Dec 09 09:13:27 2004] [warn] Init: Session Cache is not configured [hint: SSLSessionCache]
[Thu Dec 09 09:13:27 2004] [info] Init: Initializing (virtual) servers for SSL
[Thu Dec 09 09:13:27 2004] [info] Server: Apache/2.0.51, Interface: mod_ssl/2.0.51, Library:
OpenSSL/0.9.7d
[Thu Dec 09 09:13:27 2004] [info] mod_unique_id: using ip addr 129.78.64.98
END in modperl_extra.pl, pid=8202
[Thu Dec 09 09:13:30 2004] [notice] Digest: generating secret for digest authentication ...
[Thu Dec 09 09:13:30 2004] [notice] Digest: done
[Thu Dec 09 09:13:30 2004] [info] mod_unique_id: using ip addr 129.78.64.98
[Thu Dec 09 09:13:31 2004] [info] Init: Initializing OpenSSL library
[Thu Dec 09 09:13:31 2004] [info] Init: Seeding PRNG with 0 bytes of entropy
[Thu Dec 09 09:13:31 2004] [info] Init: Generating temporary RSA private keys (512/1024 bits)
[Thu Dec 09 09:13:31 2004] [info] Init: Generating temporary DH parameters (512/1024 bits)
[Thu Dec 09 09:13:31 2004] [info] Init: Initializing (virtual) servers for SSL
[Thu Dec 09 09:13:31 2004] [info] Server: Apache/2.0.51, Interface: mod_ssl/2.0.51, Library:
OpenSSL/0.9.7d
[Thu Dec 09 09:13:31 2004] [notice] Apache/2.0.51 (Unix) world domination series/2.0 mod_perl/1.99_18-dev
Perl/v5.8.4
mod_ssl/2.0.51
 OpenSSL/0.9.7d DAV/2 configured -- resuming normal operations
[Thu Dec 09 09:13:31 2004] [info] Server built: Dec  9 2004 07:54:54
[Thu Dec 09 09:13:31 2004] [debug] prefork.c(955): AcceptMutex: fcntl (default: fcntl)
[Thu Dec 09 09:13:33 2004] [error] [client 127.0.0.1] Can't call method "run" on an undefined
value at
/opt/local/src/modperl-2.0/t/
response/TestAPI/lookup_uri.pm line 54.\n
# Failed test 1 in /opt/local/src/modperl-2.0/t/response/TestAPI/r_subclass.pm at line 28
# Failed test 33 in /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm at line 112
# Failed test 34 in /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm at line 114
# Failed test 35 in /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm at line 116
# Failed test 36 in /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm at line 118
# Failed test 37 in /opt/local/src/modperl-2.0/t/response/TestAPI/request_rec.pm at line 120
[Thu Dec 09 09:13:36 2004] [error] [client 127.0.0.1] File does not exist:
/opt/local/src/modperl-2.0/t/htdocs/TestHooks__init
[Thu Dec 09 09:13:37 2004] [error] [client 127.0.0.1] File does not exist:
/opt/local/src/modperl-2.0/t/htdocs/TestUser__rewrite
[Thu Dec 09 09:13:37 2004] [info] Child process pid=8217 is exiting
END in modperl_extra.pl, pid=8217
[Thu Dec 09 09:13:37 2004] [info] Child process pid=8238 is exiting
END in modperl_extra.pl, pid=8238
[Thu Dec 09 09:13:37 2004] [info] Child process pid=8216 is exiting
END in modperl_extra.pl, pid=8216
[Thu Dec 09 09:13:38 2004] [info] removed PID file /opt/local/src/modperl-2.0/t/logs/httpd.pid
(pid=8209)
[Thu Dec 09 09:13:38 2004] [notice] caught SIGTERM, shutting down
END in modperl_extra.pl, pid=8209

> 3) t/REPORT output

> t/REPORT
-------------8<---------- Start Bug Report ------------8<----------
1. Problem Description:

  [DESCRIBE THE PROBLEM HERE]

2. Used Components and their Configuration:

*** mod_perl version 1.9918

*** using /opt/local/src/modperl-2.0/lib/Apache/BuildConfig.pm

*** Makefile.PL options:
  MP_APR_LIB     => aprext
  MP_APXS        => /usr/local/apache_2.0.51_prefork_test/bin/apxs
  MP_COMPAT_1X   => 1
  MP_DEBUG       => 1
  MP_GENERATE_XS => 1
  MP_LIBNAME     => mod_perl
  MP_TRACE       => 1
  MP_USE_DSO     => 1


*** /usr/local/apache_2.0.51_prefork_test/bin/httpd -V
Server version: Apache/2.0.51
Server built:   Dec  9 2004 07:54:54
Server's Module Magic Number: 20020903:9
Architecture:   32-bit
Server compiled with....
 -D APACHE_MPM_DIR="server/mpm/prefork"
 -D APR_HAS_SENDFILE
 -D APR_HAS_MMAP
 -D APR_USE_FCNTL_SERIALIZE
 -D APR_USE_PTHREAD_SERIALIZE
 -D SINGLE_LISTEN_UNSERIALIZED_ACCEPT
 -D APR_HAS_OTHER_CHILD
 -D AP_HAVE_RELIABLE_PIPED_LOGS
 -D HTTPD_ROOT="/usr/local/apache_2.0.51_prefork_test"
 -D SUEXEC_BIN="/usr/local/apache_2.0.51_prefork_test/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"


*** (apr|apu)-config linking info

 -L/usr/local/apache_2.0.51_prefork_test/lib -lapr-0 -lsendfile -lrt -lm -lsocket -lnsl -lresolv
 -lpthread -ldl
 -L/usr/local/apache_2.0.51_prefork_test/lib -laprutil-0 -lgdbm -ldb-4.2 -lexpat -liconv



*** /usr/local/perl-5.8.4/bin/perl -V
Summary of my perl5 (revision 5 version 8 subversion 4) configuration:
  Platform:
    osname=solaris, osvers=2.9, archname=sun4-solaris
    uname='sunos test 5.9 generic_112233-12 sun4u sparc sunw,sun-fire-v210 '
    config_args='-Dcc=gcc -B/usr/ccs/bin/ -Doptimize=-O3 -Uinstallusrbinperl -Dprefix=/usr/local/perl-5.8.4
-Ui_db
-Uusemymalloc -Dlocincpth=/usr/local/include /opt/local/include /include /usr/include /opt/sfw/include
-Dloclibpth=/usr/local/lib /opt/local/lib /usr/lib /usr/ccs/lib /opt/sfw/lib'
    hint=recommended, useposix=true, d_sigaction=define
    usethreads=undef use5005threads=undef 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 -B/usr/ccs/bin/', ccflags ='-fno-strict-aliasing -I/usr/local/include -I/opt/local/include
-I/opt/sfw/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64',
    optimize='-O3',
    cppflags='-fno-strict-aliasing -I/usr/local/include -I/opt/local/include -I/opt/sfw/include'
    ccversion='', gccversion='3.4.0', gccosandvers='solaris2.9'
    intsize=4, longsize=4, ptrsize=4, doublesize=8, byteorder=4321
    d_longlong=define, longlongsize=8, d_longdbl=define, longdblsize=16
    ivtype='long', ivsize=4, nvtype='double', nvsize=8, Off_t='off_t', lseeksize=8
    alignbytes=8, prototype=define
  Linker and Libraries:
    ld='gcc -B/usr/ccs/bin/', ldflags =' -L/usr/local/lib -L/opt/local/lib -L/usr/lib -L/usr/ccs/lib
-L/opt/sfw/lib '
   libpth=/usr/local/lib /opt/local/lib /usr/lib /usr/ccs/lib /opt/sfw/lib
    libs=-lsocket -lnsl -lgdbm -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/usr/local/lib -L/opt/local/lib -L/usr/lib -L/usr/ccs/lib
-L/opt/sfw/lib'


Characteristics of this binary (from libperl):
  Compile-time options: USE_LARGE_FILES
  Built under solaris
  Compiled at May 14 2004 15:53:55
  %ENV:
    PERL_LWP_USE_HTTP_10="1"
  @INC:
    /usr/local/perl-5.8.4/lib/5.8.4/sun4-solaris
    /usr/local/perl-5.8.4/lib/5.8.4
    /usr/local/perl-5.8.4/lib/site_perl/5.8.4/sun4-solaris
    /usr/local/perl-5.8.4/lib/site_perl/5.8.4
    /usr/local/perl-5.8.4/lib/site_perl
    .

*** Packages of interest status:

Apache::Request: -
CGI            : 3.04
LWP            : 5.79
mod_perl       : 1.9916


3. This is the core dump trace: (if you get a core dump):

  [CORE TRACE COMES HERE]

This report was generated by t/REPORT on Wed Dec  8 22:17:40 2004 GMT.



---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@perl.apache.org
For additional commands, e-mail: dev-help@perl.apache.org


Mime
View raw message