You are viewing a plain text version of this content. The canonical link for it is here.
Posted to modperl@perl.apache.org by "Christian M. Probst" <cm...@gmail.com> on 2009/01/24 04:33:32 UTC

t/hooks/authen_basic and t/hooks/authz errors

Hi, folks.

I have the following errors when running "make test". I have seen a similar
error discussed in the list in Nov 2008, but as it was mentioned that it
could be an error related to Apache 2.2.10 and I am running Apache 2.2.6 in
Solaris 10, I think there is something else happening here. Here are the
screen messages:

make test TEST_VERBOSE=1 TEST_FILES="hooks/authen_basic hooks/authz"

cd "src/modules/perl" && make
/usr/bin/perl -Iblib/arch -Iblib/lib \
t/TEST -clean
APACHE_TEST_GROUP= APACHE_TEST_HTTPD= APACHE_TEST_PORT= APACHE_TEST_USER=
APACHE_TEST_APXS= \
/usr/bin/perl -Iblib/arch -Iblib/lib \
t/TEST -bugreport -verbose=1 hooks/authen_basic hooks/authz
[warning] root mode: changing the files ownership to 'nobody' (60001:60001)
[warning] testing whether 'nobody' is able to -rwx
/export/home/softwares/mod_perl2.0/mod_perl-2.0.4/t
"/usr/bin/perl"
-Mlib=/export/home/softwares/mod_perl2.0/mod_perl-2.0.4/Apache-Test/lib
-MApache::TestRun -e 'eval { Apache::TestRun::run_root_fs_test(60001, 60001,
q[/export/home/softwares/mod_perl2.0/mod_perl-2.0.4/t]) }';

[warning] result: OK
[warning] the client side drops 'root' permissions and becomes 'nobody'
/opt/coolstack/apache2/bin/httpd  -d
/export/home/softwares/mod_perl2.0/mod_perl-2.0.4/t -f
/export/home/softwares/mod_perl2.0/mod_perl-2.0.4/t/conf/httpd.conf -D
APACHE2
using Apache/2.2.6 (prefork MPM)
waiting 120 seconds for server to start: .[Sat Jan 24 01:32:07 2009] [info]
6 Apache2:: modules loaded
[Sat Jan 24 01:32:07 2009] [info] 0 APR:: modules loaded
[Sat Jan 24 01:32:07 2009] [info] base server + 29 vhosts ready to run tests
..
waiting 120 seconds for server to start: ok (waited 2 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/hooks/authen_basic....
1..4
# Running under perl version 5.008008 for solaris
# Current time local: Sat Jan 24 01:32:10 2009
# Current time GMT:   Sat Jan 24 03:32:10 2009
# Using Test.pm version 1.25
# Using Apache/Test.pm version 1.31
ok 1
ok 2
ok 3
not ok 4
# Failed test 4 in t/hooks/authen_basic.t at line 26
 Failed 1/4 subtests
t/hooks/authz...........
1..4
# Running under perl version 5.008008 for solaris
# Current time local: Sat Jan 24 01:32:10 2009
# Current time GMT:   Sat Jan 24 03:32:10 2009
# Using Test.pm version 1.25
# Using Apache/Test.pm version 1.31
ok 1
ok 2
ok 3
not ok 4
# Failed test 4 in t/hooks/authz.t at line 19
 Failed 1/4 subtests
Test Summary Report
-------------------
t/hooks/authen_basic (Wstat: 0 Tests: 4 Failed: 1)
  Failed test:  4
t/hooks/authz       (Wstat: 0 Tests: 4 Failed: 1)
  Failed test:  4
Files=2, Tests=8,  1 wallclock secs ( 0.02 usr  0.01 sys +  0.64 cusr  0.10
csys =  0.77 CPU)
Result: FAIL
Failed 2/2 test programs. 2/8 subtests failed.
[warning] server localhost:8529 shutdown
[  error] error running tests (please examine t/logs/error_log)
+--------------------------------------------------------+
| Please file a bug report: http://perl.apache.org/bugs/ |
+--------------------------------------------------------+
*** Error code 1
make: Fatal error: Command failed for target `run_tests'

________________________________________________________________________________

and the t/logs/error_log file:

[Sat Jan 24 01:32:08 2009] [info] Init: Seeding PRNG with 0 bytes of entropy
[Sat Jan 24 01:32:08 2009] [info] Init: Generating temporary RSA private
keys (512/1024 bits)
[Sat Jan 24 01:32:08 2009] [info] Init: Generating temporary DH parameters
(512/1024 bits)
[Sat Jan 24 01:32:08 2009] [warn] Init: Session Cache is not configured
[hint: SSLSessionCache]
[Sat Jan 24 01:32:08 2009] [info] Init: Initializing (virtual) servers for
SSL
[Sat Jan 24 01:32:08 2009] [info] mod_ssl/2.2.6 compiled against Server:
Apache/2.2.6, Library: OpenSSL/0.9.7d
END in modperl_extra.pl, pid=19864
[Sat Jan 24 01:32:09 2009] [info] Init: Seeding PRNG with 0 bytes of entropy
[Sat Jan 24 01:32:09 2009] [info] Init: Generating temporary RSA private
keys (512/1024 bits)
[Sat Jan 24 01:32:09 2009] [info] Init: Generating temporary DH parameters
(512/1024 bits)
[Sat Jan 24 01:32:09 2009] [info] Init: Initializing (virtual) servers for
SSL
[Sat Jan 24 01:32:09 2009] [info] mod_ssl/2.2.6 compiled against Server:
Apache/2.2.6, Library: OpenSSL/0.9.7d
[Sat Jan 24 01:32:09 2009] [notice] Digest: generating secret for digest
authentication ...
[Sat Jan 24 01:32:09 2009] [notice] Digest: done
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [debug] util_ldap.c(1952): LDAP merging Shared
Cache conf: shm=0x81622f0 rmm=0x8162320 for VHOST: localhost
[Sat Jan 24 01:32:09 2009] [info] APR LDAP: Built with OpenLDAP LDAP SDK
[Sat Jan 24 01:32:09 2009] [info] LDAP: SSL support available
[Sat Jan 24 01:32:09 2009] [notice] Apache/2.2.6 (Unix) world domination
series/2.0 mod_ssl/2.2.6 OpenSSL/0.9.7d PHP/5.2.4 mod_perl/2.0.4 Perl/v5.8.8
configured -- resuming norma
l operations
[Sat Jan 24 01:32:09 2009] [info] Server built: Oct 27 2007 16:00:06
[Sat Jan 24 01:32:09 2009] [debug] prefork.c(991): AcceptMutex: fcntl
(default: fcntl)
[Sat Jan 24 01:32:11 2009] [info] Child process pid=19930 is exiting
[Sat Jan 24 01:32:11 2009] [info] Child process pid=19931 is exiting
[Sat Jan 24 01:32:11 2009] [info] Child process pid=19930 is exiting -
server push
[Sat Jan 24 01:32:11 2009] [info] Child process pid=19931 is exiting -
server push
END in modperl_extra.pl, pid=19930
END in modperl_extra.pl, pid=19931
[Sat Jan 24 01:32:11 2009] [info] removed PID file
/export/home/softwares/mod_perl2.0/mod_perl-2.0.4/t/logs/httpd.pid
(pid=19871)
[Sat Jan 24 01:32:11 2009] [notice] caught SIGTERM, shutting down
END in modperl_extra.pl, pid=19871