Test failures when upgrading from 2.000004 to 2.000005

Hi,

I'm running Kubuntu 10.10 (maverick meerkat), with Perl 5.10.1, Apache 2.2.16-1ubuntu3.1 on an i686 architecture.

I have mod_perl 2.000004 and tried to upgrade to 2.000005 via cpanplus, but had failures in t/api/err_headers_out.t, t/api/request_rec.t and in t/filter/out_str_reverse.t

Following the guidelines at http://perl.apache.org/docs/2.0/user/help/help.html#Reporting_Problems the output from t/TEST -verbose is:

$ t/TEST -clean
[warning] setting ulimit to allow core files
ulimit -c unlimited; /usr/bin/perl /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/TEST -clean

$ t/TEST -verbose t/api/err_headers_out.t t/api/request_rec.t t/filter/out_str_reverse.t
[warning] setting ulimit to allow core files
ulimit -c unlimited; /usr/bin/perl /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/TEST -verbose 't/api/err_headers_out.t' 't/api/request_rec.t' 't/filter/out_str_reverse.t'
/usr/sbin/apache2  -d /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t -f /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/conf/httpd.conf -D APACHE2 -D PERL_USEITHREADS
using Apache/2.2.16 (prefork MPM)

waiting 120 seconds for server to start: .[Tue Apr 26 10:55:49 2011] [info] 6 Apache2:: modules loaded
[Tue Apr 26 10:55:49 2011] [info] 0 APR:: modules loaded
[Tue Apr 26 10:55:49 2011] [info] base server + 28 vhosts ready to run tests
.
waiting 120 seconds for server to start: ok (waited 0 secs)
server localhost.localdomain:8529 started
server localhost.localdomain:8530 listening (perlsections)
server localhost.localdomain:8531 listening (inherit)
server localhost.localdomain:8532 listening (filter_out_apache)
server localhost.localdomain:8533 listening (TestModperl::perl_options)
server localhost.localdomain:8534 listening (TestModperl::perl_options2)
server localhost.localdomain:8535 listening (TestModperl::setupenv)
server localhost.localdomain:8536 listening (TestModperl::merge)
server localhost.localdomain:8537 listening (TestUser::rewrite)
server localhost.localdomain:8538 listening (TestVhost::log)
server localhost.localdomain:8539 listening (TestVhost::config)
server localhost.localdomain:8540 listening (TestModules::proxy)
server localhost.localdomain:8541 listening (TestProtocol::echo_block)
server localhost.localdomain:8542 listening (TestProtocol::echo_nonblock)
server localhost.localdomain:8543 listening (TestProtocol::echo_timeout)
server localhost.localdomain:8544 listening (TestProtocol::echo_filter)
server localhost.localdomain:8545 listening (TestProtocol::echo_bbs)
server localhost.localdomain:8546 listening (TestProtocol::pseudo_http)
server localhost.localdomain:8547 listening (TestProtocol::echo_bbs2)
server localhost.localdomain:8548 listening (TestPreConnection::note)
server localhost.localdomain:8549 listening (TestHooks::startup)
server localhost.localdomain:8550 listening (TestHooks::stacked_handlers2)
server localhost.localdomain:8551 listening (TestHooks::init)
server localhost.localdomain:8552 listening (TestHooks::hookrun)
server localhost.localdomain:8553 listening (TestHooks::trans)
server localhost.localdomain:8554 listening (TestFilter::in_bbs_msg)
server localhost.localdomain:8555 listening (TestFilter::both_str_con_add)
server localhost.localdomain:8556 listening (TestFilter::in_bbs_inject_header)
server localhost.localdomain:8557 listening (TestFilter::in_str_msg)
server localhost.localdomain:8558 listening (TestDirective::perlrequire)
server localhost.localdomain:8559 listening (TestDirective::perlmodule)
server localhost.localdomain:8560 listening (TestAPI::add_config)
server localhost.localdomain:8561 listening (TestDirective::perlloadmodule5)
server localhost.localdomain:8562 listening (TestDirective::perlloadmodule3)
server localhost.localdomain:8563 listening (TestDirective::perlloadmodule4)
server localhost.localdomain:8564 listening (TestDirective::perlloadmodule6)
server localhost.localdomain:8565 listening (TestHooks::push_handlers_anon)
[warning] Using random number seed: 2008441511 (autogenerated)
t/api/request_rec.t ......... 
1..55
# Running under perl version 5.010001 for linux
# Current time local: Tue Apr 26 10:55:49 2011
# Current time GMT:   Tue Apr 26 09:55:49 2011
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.36
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: 1001
not ok 13
# testing : $r->hostname
# expected: localhost.localdomain
# received: localhost.localdomain
ok 14
# testing : $r->hostname rw
# expected: other.hostname
# received: other.hostname
ok 15
ok 16
ok 17
ok 18
# testing : $r->method
# expected: GET
# received: GET
ok 19
# testing : $r->method_number
# expected: 0
# received: 0
ok 20
ok 21
ok 22
ok 23
ok 24
ok 25
ok 26
ok 27
ok 28
ok 29
ok 30
# buffered
# testing : buffered print
# expected: 11
# received: 11
ok 31
# testing : buffered print
# expected: 0E0
# received: 0E0
ok 32
# not buffered
# testing : unbuffered print
# expected: 15
# received: 15
ok 33
# expected: /TestAPI__request_rec/my_path_info?my_args=3
# received: /TestAPI__request_rec/my_path_info?my_args=3
ok 34
# testing : $r->uri
# expected: /TestAPI__request_rec/my_path_info
# received: /TestAPI__request_rec/my_path_info
ok 35
# testing : $r->path_info
# expected: /my_path_info
# received: /my_path_info
ok 36
# testing : $r->args
# expected: my_args=3
# received: my_args=3
ok 37
# testing : $r->the_request
# expected: GET /TestAPI__request_rec/my_path_info?my_args=3 HTTP/1.0
# received: GET /TestAPI__request_rec/my_path_info?my_args=3 HTTP/1.1
not ok 38
# testing : $r->the_request rw
# expected: GET /TestAPI__request_rec/my_path_info?my_args=3&foo=bar HTTP/1.0
# received: GET /TestAPI__request_rec/my_path_info?my_args=3&foo=bar HTTP/1.0
ok 39
ok 40
# testing : $r->location
# expected: /TestAPI__request_rec
# received: /TestAPI__request_rec
ok 41
# sent so far: 1828 bytes
ok 42
# testing : mtime
# expected: 1296678226
# received: 1296678226
ok 43
# testing : $r->finfo
# expected: /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm
# received: /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm
ok 44
ok 45
ok 46
ok 47
ok 48 # skip Need mod_mime
ok 49 # skip Need mod_mime
# testing : $r->content_languages
# expected: [
#     fr,
#     us,
#     cn,
# ]
# received: [
#     fr,
#     us,
#     cn,
# ]
ok 50
# testing : $r->content_languages(invalid)
# expected: (?-xism:Not an array reference)
# received: Not an array reference at /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm line 203.
ok 51
# testing : invalid Apache2::RequestRec=HASH(0xba464ef0) object
# expected: (?-xism:method `uri' invoked by a `Apache2::RequestRec' object with no `r' key!)
# received: method `uri' invoked by a `Apache2::RequestRec' object with no `r' key! at /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm line 213.
ok 52
# testing : invalid NonExisting=HASH(0xba464c70) 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 /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm line 220.
ok 53
# testing : invalid HASH(0xba4670e8) 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 /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm line 227.
ok 54
ok 55
Failed 2/55 subtests 
        (less 2 skipped subtests: 51 okay)
t/api/err_headers_out.t ..... 
1..6
# Running under perl version 5.010001 for linux
# Current time local: Tue Apr 26 10:55:51 2011
# Current time GMT:   Tue Apr 26 09:55:51 2011
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.36
# testing : OK
# expected: 200
# received: 200
ok 1
# testing : X-err_headers_out: made it
# expected: err_headers_out
# received: undef
not ok 2
# testing : X-headers_out: made it
# expected: headers_out
# received: undef
not ok 3
# Failed test 2 in t/api/err_headers_out.t at line 22
# Failed test 3 in t/api/err_headers_out.t at line 25
# testing : not found
# expected: 404
# received: 404
ok 4
# testing : X-err_headers_out: made it
# expected: err_headers_out
# received: undef
not ok 5
ok 6
# Failed test 5 in t/api/err_headers_out.t at line 39
Failed 3/6 subtests 
t/filter/out_str_reverse.t .. 
1..2
# Running under perl version 5.010001 for linux
# Current time local: Tue Apr 26 10:55:51 2011
# Current time GMT:   Tue Apr 26 09:55:51 2011
# Using Test.pm version 1.25_02
# Using Apache/Test.pm version 1.36
# testing : reverse filter
# expected: abcdefghijklmnopqrstuvwxyz
# 0123456789
# Reversed by mod_perl 2.0
# received: abcdefghijklmnopqrstuvwxyz
# 0123456789
# Reversed by mod_perl 2.0
ok 1
# testing : reverse filter
# expected: abcdefghijklmnopqrstuvwxyz
# 0123456789
# Reversed by mod_perl 2.0
# received: abcdefghijklmnopqrstuvwxyz
# 0123456789
not ok 2
# Failed test 2 in t/filter/out_str_reverse.t at line 30
Failed 1/2 subtests 

Test Summary Report
-------------------
t/api/request_rec.t       (Wstat: 0 Tests: 55 Failed: 2)
  Failed tests:  13, 38
t/api/err_headers_out.t   (Wstat: 0 Tests: 6 Failed: 3)
  Failed tests:  2-3, 5
t/filter/out_str_reverse.t (Wstat: 0 Tests: 2 Failed: 1)
  Failed test:  2
Files=3, Tests=63,  2 wallclock secs ( 0.03 usr  0.00 sys +  0.87 cusr  0.12 csys =  1.02 CPU)
Result: FAIL
Failed 3/3 test programs. 6/63 subtests failed.
[warning] server localhost.localdomain:8529 shutdown
[  error] error running tests (please examine t/logs/error_log)


$ cat t/logs/error_log 
END in modperl_extra.pl, pid=29802
[Tue Apr 26 10:55:50 2011] [notice] Apache/2.2.16 (Ubuntu) world domination series/2.0 mod_perl/2.0.5 Perl/v5.10.1 configured -- resuming normal operations
[Tue Apr 26 10:55:50 2011] [info] Server built: Nov 18 2010 21:17:29
[Tue Apr 26 10:55:50 2011] [debug] prefork.c(1013): AcceptMutex: sysvsem (default: sysvsem)
# Failed test 13 in /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm at line 61
# Failed test 38 in /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/response/TestAPI/request_rec.pm at line 127
[Tue Apr 26 10:55:52 2011] [info] Child process pid=29817 is exiting
[Tue Apr 26 10:55:52 2011] [info] Child process pid=29816 is exiting
[Tue Apr 26 10:55:52 2011] [info] Child process pid=29817 is exiting - server push
[Tue Apr 26 10:55:52 2011] [info] Child process pid=29816 is exiting - server push
END in modperl_extra.pl, pid=29817
END in modperl_extra.pl, pid=29816
[Tue Apr 26 10:55:52 2011] [info] removed PID file /home/jkobrien/.cpanplus/5.10.1/build/mod_perl-2.0.5/t/logs/httpd.pid (pid=29809)
[Tue Apr 26 10:55:52 2011] [notice] caught SIGTERM, shutting down
END in modperl_extra.pl, pid=29809


Thanks,

John O'Brien