PATH=/Users/fly2200/bin:/Users/fly2200/ap2200-299195/bin:/Users/fly2200/bin:/Users/fly2200/ap2200-299195/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/opt/X11/bin:/Users/fly2200/var/megalib/bin
Start 2015-08-11T22:40:02
ActivePerl-2200 CPAN-2.00
Reading '/Users/fly2200/var/cpan/Metadata'
  Database was generated on Tue, 11 Aug 2015 05:17:02 GMT
Running make for G/GR/GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz
Fetching with LWP:
http://cpan.nas1.activestate.com/authors/id/G/GR/GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz
Checksum for /Users/fly2200/var/cpan/sources/authors/id/G/GR/GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz ok
Mojolicious-Plugin-MethodOverride-0.053/
Mojolicious-Plugin-MethodOverride-0.053/README.md
Mojolicious-Plugin-MethodOverride-0.053/lib/
Mojolicious-Plugin-MethodOverride-0.053/lib/Mojolicious/
Mojolicious-Plugin-MethodOverride-0.053/lib/Mojolicious/Plugin/
Mojolicious-Plugin-MethodOverride-0.053/lib/Mojolicious/Plugin/MethodOverride.pm
Mojolicious-Plugin-MethodOverride-0.053/META.yml
Mojolicious-Plugin-MethodOverride-0.053/t/
Mojolicious-Plugin-MethodOverride-0.053/t/pod.t
Mojolicious-Plugin-MethodOverride-0.053/t/04-override-charset.t
Mojolicious-Plugin-MethodOverride-0.053/t/01-override.t
Mojolicious-Plugin-MethodOverride-0.053/t/02-override-config.t
Mojolicious-Plugin-MethodOverride-0.053/t/03-override-noheader.t
Mojolicious-Plugin-MethodOverride-0.053/t/00-load.t
Mojolicious-Plugin-MethodOverride-0.053/MANIFEST.skip
Mojolicious-Plugin-MethodOverride-0.053/inc/
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/AutoInstall.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Include.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Makefile.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Win32.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Metadata.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Fetch.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Can.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/AutoInstall.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/WriteAll.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install/Base.pm
Mojolicious-Plugin-MethodOverride-0.053/inc/Module/Install.pm
Mojolicious-Plugin-MethodOverride-0.053/Makefile.PL
Mojolicious-Plugin-MethodOverride-0.053/Changes
Mojolicious-Plugin-MethodOverride-0.053/MANIFEST

  CPAN.pm: Building G/GR/GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz

>>> /Users/fly2200/ap2200-299195/bin/perl-dynamic Makefile.PL
*** Module::AutoInstall version 1.14
*** Checking for Perl dependencies...
*** Since we're running under CPAN, I'll just let it take care
    of the dependency's installation later.
[Core Features]
- Test::More  ...loaded. (1.001014)
- Test::Mojo  ...loaded. (undef)
- Mojolicious ...loaded. (6.14 >= 2.48)
*** Module::AutoInstall configuration finished.
Checking if your kit is complete...
Looks good
Generating a Unix-style Makefile
Writing Makefile for Mojolicious::Plugin::MethodOverride
Writing MYMETA.yml and MYMETA.json
>>> make
cp lib/Mojolicious/Plugin/MethodOverride.pm blib/lib/Mojolicious/Plugin/MethodOverride.pm
Manifying 1 pod document
  GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz
  make -- OK
Running make test
>>> make test TEST_VERBOSE=1
PERL_DL_NONLAZY=1 "/Users/fly2200/ap2200-299195/bin/perl-dynamic" "-MExtUtils::Command::MM" "-MTest::Harness" "-e" "undef *Test::Harness::Switches; test_harness(1, 'inc', 'blib/lib', 'blib/arch')" t/00-load.t t/01-override.t t/02-override-config.t t/03-override-noheader.t t/04-override-charset.t t/pod.t
# Testing Mojolicious::Plugin::MethodOverride 0.053, Perl 5.022000, /Users/fly2200/ap2200-299195/bin/perl-dynamic
t/00-load.t ............... 
1..1
ok 1 - use Mojolicious::Plugin::MethodOverride;
ok
[Tue Aug 11 22:40:04 2015] [debug] GET "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000573s, 1745.201/s)
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000331s, 3021.148/s)
[Tue Aug 11 22:40:04 2015] [debug] PUT "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000277s, 3610.108/s)
[Tue Aug 11 22:40:04 2015] [debug] DELETE "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000263s, 3802.281/s)
[Tue Aug 11 22:40:04 2015] [debug] X-HTTP-Method-Override: GET
[Tue Aug 11 22:40:04 2015] [debug] GET "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000296s, 3378.378/s)
[Tue Aug 11 22:40:04 2015] [debug] X-HTTP-Method-Override: POST
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000186s, 5376.344/s)
[Tue Aug 11 22:40:04 2015] [debug] X-HTTP-Method-Override: PUT
[Tue Aug 11 22:40:04 2015] [debug] PUT "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000183s, 5464.481/s)
[Tue Aug 11 22:40:04 2015] [debug] X-HTTP-Method-Override: DELETE
[Tue Aug 11 22:40:04 2015] [debug] DELETE "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000185s, 5405.405/s)
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000209s, 4784.689/s)
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000213s, 4694.836/s)
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000206s, 4854.369/s)
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000206s, 4854.369/s)
[Tue Aug 11 22:40:04 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:04 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:04 2015] [debug] 200 OK (0.000208s, 4807.692/s)
t/01-override.t ........... 
ok 1 - GET /welcome
ok 2 - 200 OK
ok 3 - content is similar
ok 4 - POST /welcome
ok 5 - 200 OK
ok 6 - content is similar
ok 7 - PUT /welcome
ok 8 - 200 OK
ok 9 - content is similar
ok 10 - DELETE /welcome
ok 11 - 200 OK
ok 12 - content is similar
ok 13 - POST /welcome
ok 14 - 200 OK
ok 15 - content is similar
ok 16 - POST /welcome
ok 17 - 200 OK
ok 18 - content is similar
ok 19 - POST /welcome
ok 20 - 200 OK
ok 21 - content is similar
ok 22 - POST /welcome
ok 23 - 200 OK
ok 24 - content is similar
ok 25 - POST /welcome
ok 26 - 200 OK
ok 27 - content is not similar
ok 28 - content is similar
ok 29 - POST /welcome?x-tunneled-method=GET
ok 30 - 200 OK
ok 31 - content is not similar
ok 32 - content is similar
ok 33 - POST /welcome?x-tunneled-method=POST
ok 34 - 200 OK
ok 35 - content is similar
ok 36 - POST /welcome?x-tunneled-method=PUT
ok 37 - 200 OK
ok 38 - content is not similar
ok 39 - content is similar
ok 40 - POST /welcome?x-tunneled-method=DELETE
ok 41 - 200 OK
ok 42 - content is not similar
ok 43 - content is similar
ok 44 - GET /static.txt
ok 45 - 200 OK
ok 46 - content is similar
1..46
ok
[Tue Aug 11 22:40:04 2015] [debug] X-HTTP-Test-Override: GET
[Tue Aug 11 22:40:05 2015] [debug] GET "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000532s, 1879.699/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: POST
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000276s, 3623.188/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: PUT
[Tue Aug 11 22:40:05 2015] [debug] PUT "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000262s, 3816.794/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: DELETE
[Tue Aug 11 22:40:05 2015] [debug] DELETE "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000270s, 3703.704/s)
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000189s, 5291.005/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: GET
[Tue Aug 11 22:40:05 2015] [debug] GET "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000199s, 5025.126/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: POST
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000187s, 5347.594/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: PUT
[Tue Aug 11 22:40:05 2015] [debug] PUT "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000186s, 5376.344/s)
[Tue Aug 11 22:40:05 2015] [debug] X-HTTP-Test-Override: DELETE
[Tue Aug 11 22:40:05 2015] [debug] DELETE "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000186s, 5376.344/s)
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000189s, 5291.005/s)
t/02-override-config.t .... 
ok 1 - POST /welcome
ok 2 - 200 OK
ok 3 - content is similar
ok 4 - POST /welcome
ok 5 - 200 OK
ok 6 - content is similar
ok 7 - POST /welcome
ok 8 - 200 OK
ok 9 - content is similar
ok 10 - POST /welcome
ok 11 - 200 OK
ok 12 - content is similar
ok 13 - POST /welcome
ok 14 - 200 OK
ok 15 - content is not similar
ok 16 - content is similar
ok 17 - POST /welcome?x-test-tunnel-method=GET
ok 18 - 200 OK
ok 19 - content is similar
ok 20 - POST /welcome?x-test-tunnel-method=POST
ok 21 - 200 OK
ok 22 - content is similar
ok 23 - POST /welcome?x-test-tunnel-method=PUT
ok 24 - 200 OK
ok 25 - content is similar
ok 26 - POST /welcome?x-test-tunnel-method=DELETE
ok 27 - 200 OK
ok 28 - content is similar
ok 29 - POST /welcome?x-tunneled-method=GET
ok 30 - 200 OK
ok 31 - content is not similar
ok 32 - content is similar
1..32
ok
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000614s, 1628.664/s)
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000242s, 4132.231/s)
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000212s, 4716.981/s)
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000226s, 4424.779/s)
[Tue Aug 11 22:40:05 2015] [debug] x-tunneled-method: GET
[Tue Aug 11 22:40:05 2015] [debug] GET "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000326s, 3067.485/s)
[Tue Aug 11 22:40:05 2015] [debug] x-tunneled-method: POST
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000333s, 3003.003/s)
[Tue Aug 11 22:40:05 2015] [debug] x-tunneled-method: PUT
[Tue Aug 11 22:40:05 2015] [debug] PUT "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000289s, 3460.208/s)
[Tue Aug 11 22:40:05 2015] [debug] x-tunneled-method: DELETE
[Tue Aug 11 22:40:05 2015] [debug] DELETE "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000409s, 2444.988/s)
[Tue Aug 11 22:40:05 2015] [debug] POST "/welcome"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000291s, 3436.426/s)
t/03-override-noheader.t .. 
ok 1 - POST /welcome
ok 2 - 200 OK
ok 3 - content is not similar
ok 4 - content is similar
ok 5 - POST /welcome
ok 6 - 200 OK
ok 7 - content is similar
ok 8 - POST /welcome
ok 9 - 200 OK
ok 10 - content is not similar
ok 11 - content is similar
ok 12 - POST /welcome
ok 13 - 200 OK
ok 14 - content is not similar
ok 15 - content is similar
ok 16 - POST /welcome?x-tunneled-method=GET
ok 17 - 200 OK
ok 18 - content is similar
ok 19 - POST /welcome?x-tunneled-method=POST
ok 20 - 200 OK
ok 21 - content is similar
ok 22 - POST /welcome?x-tunneled-method=PUT
ok 23 - 200 OK
ok 24 - content is similar
ok 25 - POST /welcome?x-tunneled-method=DELETE
ok 26 - 200 OK
ok 27 - content is similar
ok 28 - POST /welcome?x-tunneled-thingy=GET
ok 29 - 200 OK
ok 30 - content is not similar
ok 31 - content is similar
1..31
ok
[Tue Aug 11 22:40:05 2015] [debug] Your secret passphrase needs to be changed
[Tue Aug 11 22:40:05 2015] [debug] POST "/"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000575s, 1739.130/s)
[Tue Aug 11 22:40:05 2015] [debug] x-test-tunnel-method: GET
[Tue Aug 11 22:40:05 2015] [debug] GET "/"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000352s, 2840.909/s)
[Tue Aug 11 22:40:05 2015] [debug] x-test-tunnel-method: POST
[Tue Aug 11 22:40:05 2015] [debug] POST "/"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000259s, 3861.004/s)
[Tue Aug 11 22:40:05 2015] [debug] x-test-tunnel-method: PUT
[Tue Aug 11 22:40:05 2015] [debug] PUT "/"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000327s, 3058.104/s)
[Tue Aug 11 22:40:05 2015] [debug] x-test-tunnel-method: PATCH
[Tue Aug 11 22:40:05 2015] [debug] PATCH "/"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000325s, 3076.923/s)
[Tue Aug 11 22:40:05 2015] [debug] x-test-tunnel-method: DELETE
[Tue Aug 11 22:40:05 2015] [debug] DELETE "/"
[Tue Aug 11 22:40:05 2015] [debug] Routing to a callback
[Tue Aug 11 22:40:05 2015] [debug] 200 OK (0.000325s, 3076.923/s)
t/04-override-charset.t ... 
ok 1 - POST http://127.0.0.1:57473/?p=%82%E2%82%C1%82%BD
ok 2 - 200 OK
ok 3 - exact match for content
ok 4 - POST http://127.0.0.1:57473/?p=%82%E2%82%C1%82%BD&x-test-tunnel-method=GET
ok 5 - 200 OK
ok 6 - exact match for content
ok 7 - POST http://127.0.0.1:57473/?p=%82%E2%82%C1%82%BD&x-test-tunnel-method=POST
ok 8 - 200 OK
ok 9 - exact match for content
ok 10 - POST http://127.0.0.1:57473/?p=%82%E2%82%C1%82%BD&x-test-tunnel-method=PUT
ok 11 - 200 OK
ok 12 - exact match for content
ok 13 - POST http://127.0.0.1:57473/?p=%82%E2%82%C1%82%BD&x-test-tunnel-method=PATCH
ok 14 - 200 OK
ok 15 - exact match for content
ok 16 - POST http://127.0.0.1:57473/?p=%82%E2%82%C1%82%BD&x-test-tunnel-method=DELETE
ok 17 - 200 OK
ok 18 - exact match for content
1..18
ok
t/pod.t ................... 
1..1
ok 1 - POD test for blib/lib/Mojolicious/Plugin/MethodOverride.pm
ok
All tests successful.
Files=6, Tests=129,  1 wallclock secs ( 0.04 usr  0.02 sys +  1.29 cusr  0.15 csys =  1.50 CPU)
Result: PASS
  GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz
  make test TEST_VERBOSE=1 -- OK
<SOFTPKG NAME="Mojolicious-Plugin-MethodOverride" VERSION="0.053" DATE="2015-06-03">
  <AUTHOR CPAN="GRAF">Bernhard Graf &lt;graf@cpan.org></AUTHOR>
  <ABSTRACT>Simulate HTTP Verbs</ABSTRACT>
  <ARCHITECTURE NAME="darwin-thread-multi-2level-5.22"/>
  <CODEBASE HREF="Mojolicious-Plugin-MethodOverride-0.053.tar.gz"/>
  <PROVIDE NAME="Mojolicious::Plugin::MethodOverride" VERSION="0.053"/>
  <REQUIRE NAME="Mojolicious::" VERSION="2.48"/>
  <REQUIRE NAME="Test::Mojo"/>
  <REQUIRE NAME="Test::More"/>
  <!-- Built 2015-08-11 with ActivePerl-2200 on perl-osx (Mac OS X 10.9.5) log Mojolicious-Plugin-MethodOverride-0.053.d/log-20150811T224001.txt -->
</SOFTPKG>
>>> (cd /Users/fly2200/var/cpan/build/Mojolicious-Plugin-MethodOverride-0.053-BCjixg && tar cvf - Mojolicious-Plugin-MethodOverride-0.053.ppd blib) | gzip -c >/Users/fly2200/var/REPO/G/GR/GRAF/Mojolicious-Plugin-MethodOverride-0.053.tar.gz
Mojolicious-Plugin-MethodOverride-0.053.ppd
blib/
blib/lib/
blib/lib/Mojolicious/
blib/lib/Mojolicious/Plugin/
blib/lib/Mojolicious/Plugin/MethodOverride.pm
blib/man3/
blib/man3/Mojolicious::Plugin::MethodOverride.3
>>> mv /Users/fly2200/var/cpan/build/Mojolicious-Plugin-MethodOverride-0.053-BCjixg/Mojolicious-Plugin-MethodOverride-0.053.ppd /Users/fly2200/var/REPO/G/GR/GRAF
Finished 2015-08-11T22:40:05