Start 2009-01-15T06:06:46 Going to read /export/home/fly1064/var/cpan/Metadata Database was generated on Tue, 13 Jan 2009 09:27:58 GMT Running make for L/LB/LBROCARD/Test-WWW-Mechanize-Catalyst-0.45.tar.gz Checksum for /net/nas/data/cpan/authors/id/L/LB/LBROCARD/Test-WWW-Mechanize-Catalyst-0.45.tar.gz ok Test-WWW-Mechanize-Catalyst-0.45/ Test-WWW-Mechanize-Catalyst-0.45/CHANGES Test-WWW-Mechanize-Catalyst-0.45/META.yml Test-WWW-Mechanize-Catalyst-0.45/t/ Test-WWW-Mechanize-Catalyst-0.45/t/cookies.t Test-WWW-Mechanize-Catalyst-0.45/t/pod.t Test-WWW-Mechanize-Catalyst-0.45/t/redirect.t Test-WWW-Mechanize-Catalyst-0.45/t/pod_coverage.t Test-WWW-Mechanize-Catalyst-0.45/t/multi_content_type.t Test-WWW-Mechanize-Catalyst-0.45/t/auth-test.t Test-WWW-Mechanize-Catalyst-0.45/t/simple.t Test-WWW-Mechanize-Catalyst-0.45/t/lib/ Test-WWW-Mechanize-Catalyst-0.45/t/lib/ExternalCatty.pm Test-WWW-Mechanize-Catalyst-0.45/t/lib/CattySession.pm Test-WWW-Mechanize-Catalyst-0.45/t/lib/Catty.pm Test-WWW-Mechanize-Catalyst-0.45/Makefile.PL Test-WWW-Mechanize-Catalyst-0.45/README Test-WWW-Mechanize-Catalyst-0.45/lib/ Test-WWW-Mechanize-Catalyst-0.45/lib/Test/ Test-WWW-Mechanize-Catalyst-0.45/lib/Test/WWW/ Test-WWW-Mechanize-Catalyst-0.45/lib/Test/WWW/Mechanize/ Test-WWW-Mechanize-Catalyst-0.45/lib/Test/WWW/Mechanize/Catalyst.pm Test-WWW-Mechanize-Catalyst-0.45/MANIFEST CPAN.pm: Going to build L/LB/LBROCARD/Test-WWW-Mechanize-Catalyst-0.45.tar.gz >>> /export/home/fly1064/bin/perl Makefile.PL Checking if your kit is complete... Looks good Writing Makefile for Test::WWW::Mechanize::Catalyst >>> make cp lib/Test/WWW/Mechanize/Catalyst.pm blib/lib/Test/WWW/Mechanize/Catalyst.pm Manifying blib/man3/Test::WWW::Mechanize::Catalyst.3 LBROCARD/Test-WWW-Mechanize-Catalyst-0.45.tar.gz make -- OK Running make test >>> make test TEST_VERBOSE=1 PERL_DL_NONLAZY=1 /export/home/fly1064/bin/perl "-MExtUtils::Command::MM" "-e" "test_harness(1, 'blib/lib', 'blib/arch')" t/*.t t/auth-test............. 1..5 [debug] Debug messages enabled [debug] Statistics enabled [debug] Loaded dispatcher "Catalyst::Dispatcher" [debug] Loaded engine "Catalyst::Engine::CGI" [debug] Couldn't find home [debug] Loaded Private actions: .----------------------+--------------------------------------+--------------. | Private | Class | Method | +----------------------+--------------------------------------+--------------+ | /hi | Catty | hi | | /gzipped | Catty | gzipped | | /default | Catty | default | | /die | Catty | die | | /greetings | Catty | greetings | | /hello | Catty | hello | | /bonjour | Catty | bonjour | | /check_auth_basic | Catty | check_auth_- | | | | basic | '----------------------+--------------------------------------+--------------' [debug] Loaded Path actions: .-------------------------------------+--------------------------------------. | Path | Private | +-------------------------------------+--------------------------------------+ | /bonjour | /bonjour | | /check_auth_basic | /check_auth_basic | | /die | /die | | /greetings | /greetings | | /gzipped | /gzipped | | /hello | /hello | | /hi | /hi | '-------------------------------------+--------------------------------------' [info] Catty powered by Catalyst 5.7015 Use of uninitialized value $auth in pattern match (m//) at t/lib/Catty.pm line 60. Use of uninitialized value in subroutine entry at t/lib/Catty.pm line 61. [info] *** Request 1 (1.000/s) [16305] [Thu Jan 15 06:06:58 2009] *** [debug] "GET" request for "check_auth_basic/" from "127.0.0.1" [debug] Path is "check_auth_basic" [info] Request took 0.015750s (63.492/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /check_auth_basic | 0.000933s | '----------------------------------------------------------------+-----------' not ok 1 - GET http://localhost/check_auth_basic/ # Failed test 'GET http://localhost/check_auth_basic/' # at t/auth-test.t line 14. # 401 # Unauthorized ok 2 not ok 3 # Failed test at t/auth-test.t line 16. # got: '401' # expected: '200' Use of uninitialized value $auth in pattern match (m//) at t/lib/Catty.pm line 60. Use of uninitialized value in subroutine entry at t/lib/Catty.pm line 61. [info] *** Request 2 (2.000/s) [16305] [Thu Jan 15 06:06:58 2009] *** [debug] "GET" request for "check_auth_basic/" from "127.0.0.1" [debug] Path is "check_auth_basic" [info] Request took 0.011151s (89.678/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /check_auth_basic | 0.000710s | '----------------------------------------------------------------+-----------' ok 4 ok 5 # Looks like you failed 2 tests of 5. Dubious, test returned 2 (wstat 512, 0x200) Failed 2/5 subtests t/cookies...............[debug] Debug messages enabled [debug] Statistics enabled [debug] Loaded plugins: .----------------------------------------------------------------------------. | Catalyst::Plugin::Session 0.19 | | Catalyst::Plugin::Session::State::Cookie 0.09 | | Catalyst::Plugin::Session::Store::Dummy | '----------------------------------------------------------------------------' [debug] Loaded dispatcher "Catalyst::Dispatcher" [debug] Loaded engine "Catalyst::Engine::CGI" [debug] Couldn't find home [debug] Loaded Private actions: .----------------------+--------------------------------------+--------------. | Private | Class | Method | +----------------------+--------------------------------------+--------------+ | /auto | CattySession | auto | | /default | CattySession | default | '----------------------+--------------------------------------+--------------' [info] CattySession powered by Catalyst 5.7015 Name "Catalyst::setup_session" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::AttrContainer::setup_session" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::AttrContainer::setup" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Controller::setup_session" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Controller::setup" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::Store::setup" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::Store::Dummy::setup_session" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::Store::Dummy::setup" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::Store::setup_session" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::State::setup" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::State::setup_session" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. Name "Catalyst::Plugin::Session::State::Cookie::setup" used only once: possible typo at /export/home/fly1064/var/megalib/NEXT.pm line 56. 1..3 Use of uninitialized value $scheme in pattern match (m//) at /export/home/fly1064/var/megalib/HTTP/Cookies.pm line 44. [info] *** Request 1 (1.000/s) [16307] [Thu Jan 15 06:06:59 2009] *** [debug] "GET" request for "/" from "127.0.0.1" [debug] Created session "c45cff8fbf4af6b7d528aa14f3089a8b3629e380" [info] Request took 0.034430s (29.044/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /auto | 0.013196s | | /default | 0.000639s | '----------------------------------------------------------------+-----------' ok 1 - GET / ok 2 - Title is 'Root' ok 3 ok t/multi_content_type.... 1..6 # ################################################################### # Starting an external Catalyst HTTP server on port 7357 # To change the port, please set the TWMC_TEST_PORT env variable. # (The server will be automatically shut-down right after the tests). # ################################################################### ok 1 - use ExternalCatty; You can connect to your server at http://spike:7357 Use of uninitialized value $scheme in pattern match (m//) at /export/home/fly1064/var/megalib/HTTP/Cookies.pm line 44. ok 2 - Get a multi Content-Type response ok 3 - Survive to a multi Content-Type sting ok 4 - Multi Content-Type Content-Type ok 5 - Multi Content-Type title ok 6 - Multi Content-Type body ok t/pod................... 1..1 ok 1 - blib/lib/Test/WWW/Mechanize/Catalyst.pm ok t/pod_coverage.......... 1..1 ok 1 - Pod coverage on Test::WWW::Mechanize::Catalyst ok t/redirect.............. 1..27 [debug] Debug messages enabled [debug] Statistics enabled [debug] Loaded dispatcher "Catalyst::Dispatcher" [debug] Loaded engine "Catalyst::Engine::CGI" [debug] Couldn't find home [debug] Loaded Private actions: .----------------------+--------------------------------------+--------------. | Private | Class | Method | +----------------------+--------------------------------------+--------------+ | /hi | Catty | hi | | /gzipped | Catty | gzipped | | /default | Catty | default | | /die | Catty | die | | /greetings | Catty | greetings | | /hello | Catty | hello | | /bonjour | Catty | bonjour | | /check_auth_basic | Catty | check_auth_- | | | | basic | '----------------------+--------------------------------------+--------------' [debug] Loaded Path actions: .-------------------------------------+--------------------------------------. | Path | Private | +-------------------------------------+--------------------------------------+ | /bonjour | /bonjour | | /check_auth_basic | /check_auth_basic | | /die | /die | | /greetings | /greetings | | /gzipped | /gzipped | | /hello | /hello | | /hi | /hi | '-------------------------------------+--------------------------------------' [info] Catty powered by Catalyst 5.7015 [info] *** Request 1 (1.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "hi" from "127.0.0.1" [debug] Path is "hi" [debug] Redirecting to "http://localhost/hello" [info] Request took 0.016042s (62.336/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hi | 0.000946s | '----------------------------------------------------------------+-----------' [info] *** Request 2 (2.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "hello" from "127.0.0.1" [debug] Path is "hello" [info] Request took 0.010902s (91.726/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hello | 0.000682s | '----------------------------------------------------------------+-----------' ok 1 - got something when we hi ok 2 - check got to hello 1/4 ok 3 - check got to hello 2/4 ok 4 - check got to hello 3/4 ok 5 - check got to hello 4/4 ok 6 - have a previous ok 7 - was a redirect ok 8 - to the right place [info] *** Request 3 (3.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "greetings" from "127.0.0.1" [debug] Path is "greetings" [debug] Redirecting to "hello" [info] Request took 0.011477s (87.131/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /greetings | 0.000568s | '----------------------------------------------------------------+-----------' [info] *** Request 4 (4.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "hello" from "127.0.0.1" [debug] Path is "hello" [info] Request took 0.010740s (93.110/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hello | 0.000613s | '----------------------------------------------------------------+-----------' ok 9 - got something when we greetings ok 10 - check got to hello 1/4 ok 11 - check got to hello 2/4 ok 12 - check got to hello 3/4 ok 13 - check got to hello 4/4 ok 14 - have a previous ok 15 - was a redirect ok 16 - to the right place [info] *** Request 5 (5.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "bonjour" from "127.0.0.1" [debug] Path is "bonjour" [debug] Redirecting to "http://localhost/hi" [info] Request took 0.012130s (82.440/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /bonjour | 0.000795s | '----------------------------------------------------------------+-----------' [info] *** Request 6 (6.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "hi" from "127.0.0.1" [debug] Path is "hi" [debug] Redirecting to "http://localhost/hello" [info] Request took 0.010902s (91.726/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hi | 0.000634s | '----------------------------------------------------------------+-----------' [info] *** Request 7 (7.000/s) [16313] [Thu Jan 15 06:07:04 2009] *** [debug] "GET" request for "hello" from "127.0.0.1" [debug] Path is "hello" [info] Request took 0.010584s (94.482/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hello | 0.000540s | '----------------------------------------------------------------+-----------' ok 17 - got something when we bonjour ok 18 - check got to hello 1/4 ok 19 - check got to hello 2/4 ok 20 - check got to hello 3/4 ok 21 - check got to hello 4/4 ok 22 - have a previous ok 23 - was a redirect ok 24 - to the right place ok 25 - have a previous previous ok 26 - was a redirect ok 27 - to the right place ok t/simple................ 1..39 [debug] Debug messages enabled [debug] Statistics enabled [debug] Loaded dispatcher "Catalyst::Dispatcher" [debug] Loaded engine "Catalyst::Engine::CGI" [debug] Couldn't find home [debug] Loaded Private actions: .----------------------+--------------------------------------+--------------. | Private | Class | Method | +----------------------+--------------------------------------+--------------+ | /hi | Catty | hi | | /gzipped | Catty | gzipped | | /default | Catty | default | | /die | Catty | die | | /greetings | Catty | greetings | | /hello | Catty | hello | | /bonjour | Catty | bonjour | | /check_auth_basic | Catty | check_auth_- | | | | basic | '----------------------+--------------------------------------+--------------' [debug] Loaded Path actions: .-------------------------------------+--------------------------------------. | Path | Private | +-------------------------------------+--------------------------------------+ | /bonjour | /bonjour | | /check_auth_basic | /check_auth_basic | | /die | /die | | /greetings | /greetings | | /gzipped | /gzipped | | /hello | /hello | | /hi | /hi | '-------------------------------------+--------------------------------------' [info] Catty powered by Catalyst 5.7015 [info] *** Request 1 (1.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "/" from "127.0.0.1" [info] Request took 0.015641s (63.935/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /default | 0.000760s | '----------------------------------------------------------------+-----------' ok 1 - GET http://localhost/ ok 2 ok 3 - Title is 'Root' ok 4 - Content contains "This is the root page" [info] *** Request 2 (2.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "hello/" from "127.0.0.1" [debug] Path is "hello" [info] Request took 0.011348s (88.121/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hello | 0.000604s | '----------------------------------------------------------------+-----------' ok 5 - Followed link with 'text=Hello' ok 6 ok 7 ok 8 - Title is 'Hello' Wide character in print at /export/home/fly1064/var/megalib/Test/Builder.pm line 1351. ok 9 - Content contains "Hi there! ☺" [info] *** Request 3 (3.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "/" from "127.0.0.1" [info] Request took 0.011084s (90.220/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /default | 0.000583s | '----------------------------------------------------------------+-----------' ok 10 - GET / ok 11 ok 12 - Title is 'Root' ok 13 - Content contains "This is the root page" [info] *** Request 4 (4.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "/" from "127.0.0.1" [info] Request took 0.010543s (94.850/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /default | 0.000559s | '----------------------------------------------------------------+-----------' ok 14 - GET http://example.com/ ok 15 ok 16 - Title is 'Root' ok 17 - Content contains "This is the root page" [info] *** Request 5 (5.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "hello/" from "127.0.0.1" [debug] Path is "hello" [info] Request took 0.010547s (94.814/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /hello | 0.000571s | '----------------------------------------------------------------+-----------' ok 18 - GET /hello/ ok 19 ok 20 - Title is 'Hello' Wide character in print at /export/home/fly1064/var/megalib/Test/Builder.pm line 1351. ok 21 - Content contains "Hi there! ☺" [info] *** Request 6 (6.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "gzipped/" from "127.0.0.1" [debug] Path is "gzipped" [info] Request took 0.018242s (54.819/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /gzipped | 0.008080s | '----------------------------------------------------------------+-----------' ok 22 - GET /gzipped/ ok 23 ok 24 - Title is 'Hello' Wide character in print at /export/home/fly1064/var/megalib/Test/Builder.pm line 1351. ok 25 - Content contains "Hi there! ☺" [info] *** Request 7 (7.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "die/" from "127.0.0.1" [debug] Path is "die" [error] Caught exception in Catty->die "erk! at t/lib/Catty.pm line 82." [info] Request took 0.037264s (26.836/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /die | 0.000603s | '----------------------------------------------------------------+-----------' # Catalyst error screen: Caught exception in Catty->die "erk! at t/lib/Catty.pm line 82." ok 26 ok 27 Use of uninitialized value $str in concatenation (.) or string at /export/home/fly1064/var/megalib/Test/WWW/Mechanize.pm line 483. ok 28 - Title is '' ok 29 - Content is "" [info] *** Request 8 (8.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "die/" from "127.0.0.1" [debug] Path is "die" [error] Caught exception in Catty->die "erk! at t/lib/Catty.pm line 82." [info] Request took 0.022770s (43.917/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /die | 0.000701s | '----------------------------------------------------------------+-----------' # Catalyst error screen: Caught exception in Catty->die "erk! at t/lib/Catty.pm line 82." ok 30 ok 31 Use of uninitialized value $str in concatenation (.) or string at /export/home/fly1064/var/megalib/Test/WWW/Mechanize.pm line 483. ok 32 - Title is '' ok 33 - Content is "" [info] *** Request 9 (9.000/s) [16315] [Thu Jan 15 06:07:06 2009] *** [debug] "GET" request for "die/" from "127.0.0.1" [debug] Path is "die" [error] Caught exception in Catty->die "erk! at t/lib/Catty.pm line 82." [info] Request took 0.021525s (46.458/s) .----------------------------------------------------------------+-----------. | Action | Time | +----------------------------------------------------------------+-----------+ | /die | 0.000576s | '----------------------------------------------------------------+-----------' ok 34 ok 35 ok 36 - Title is like '(?-xism:Catty on Catalyst)' ok 37 - Content is like '(?-xism:Caught exception in Catty)' ok 38 - Content is like '(?-xism:erk)' ok 39 - Content is like '(?-xism:This is the die page)' ok Test Summary Report ------------------- t/auth-test (Wstat: 512 Tests: 5 Failed: 2) Failed tests: 1, 3 Non-zero exit status: 2 Files=7, Tests=82, 10 wallclock secs ( 0.19 usr 0.07 sys + 9.01 cusr 0.85 csys = 10.12 CPU) Result: FAIL Failed 1/7 test programs. 2/82 subtests failed. make: *** [test_dynamic] Error 255 LBROCARD/Test-WWW-Mechanize-Catalyst-0.45.tar.gz make test TEST_VERBOSE=1 -- NOT OK //hint// to see the cpan-testers results for installing this module, try: reports LBROCARD/Test-WWW-Mechanize-Catalyst-0.45.tar.gz Finished 2009-01-15T06:07:06