Bug#849082: libapache2-mod-perl2: FTBFS: test failures

Thu Dec 22 16:17:34 UTC 2016

On Thu, 22 Dec 2016 17:23:24 +0200, Niko Tyni wrote:

> Package: libapache2-mod-perl2
> Version: 2.0.10-1
> Severity: serious
> User: debian-perl at lists.debian.org
> Usertags: autopkgtest
> 
>   -apache2 2.4.23-8
>   -apache2-bin 2.4.23-8
>   -apache2-data 2.4.23-8
>   -apache2-utils 2.4.23-8
>   +apache2 2.4.25-1
>   +apache2-bin 2.4.25-1
>   +apache2-data 2.4.25-1
>   +apache2-utils 2.4.25-1

From the apache2 changelog:

  * Security: CVE-2016-8743:
    Enforce HTTP request grammar corresponding to RFC7230 for request lines
    and request headers, to prevent response splitting and cache pollution by
    malicious clients or downstream proxies.
  * The stricter HTTP enforcement may cause compatibility problems with
    non-conforming clients. Fine-tuning is possible with the new
    HttpProtocolOptions directive.

>   # Failed test 1 in t/apache/read.t at line 52
>   t/apache/read.t ......................... 
>   1..1
>   # Running under perl version 5.024001 for linux
>   # Current time local: Thu Dec 22 09:33:49 2016
>   # Current time GMT:   Thu Dec 22 09:33:49 2016
>   # Using Test.pm version 1.28_01
>   # Using Apache/Test.pm version 1.40
>   not ok 1
>   Failed 1/1 subtests 
> [...]
>   request has failed (the response code was: 400)

This seems to match https://httpd.apache.org/docs/2.4/mod/core.html#httpprotocoloptions
which says:

"Users should pay particular attention to the 400 responses in the
access log for invalid requests which were unexpectedly rejected."

I'm attaching t/logs/error_log from the build for further analysis.

Cheers,
gregor

-- 
 .''`.  https://info.comodo.priv.at/ - Debian Developer https://www.debian.org
 : :' : OpenPGP fingerprint D1E1 316E 93A7 60A8 104D  85FA BB3A 6801 8649 AA06
 `. `'  Member of VIBE!AT & SPI, fellow of the Free Software Foundation Europe
   `-   NP: J.J. Cale: I Got The Same Old Blues
-------------- next part --------------
********************************************************************************
*** This is a test for Apache2::ServerUtil::server_shutdown_cleanup_register ***
*** Following a line consisting only of * characters there should be a line  ***
*** containing                                                               ***
***     "cleanup died: testing server_shutdown_cleanup_register".            ***
*** The next line should then read                                           ***
***     "done with server_shutdown_cleanup_register"                         ***
********************************************************************************
Apache2::ServerUtil: cleanup died: testing server_shutdown_cleanup_register
*** done with server_shutdown_cleanup_register                               ***
********************************************************************************
END in modperl_extra.pl, pid=14485
END in modperl_extra.pl, pid=14485
[Thu Dec 22 16:09:36.989606 2016] [auth_digest:notice] [pid 14861:tid 140571007677632] AH01757: generating secret for digest authentication ...
[Thu Dec 22 16:09:36.989625 2016] [auth_digest:debug] [pid 14861:tid 140571007677632] mod_auth_digest.c(250): AH01759: done
[Thu Dec 22 16:09:36.989735 2016] [watchdog:debug] [pid 14861:tid 140571007677632] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Thu Dec 22 16:09:36.989740 2016] [watchdog:debug] [pid 14861:tid 140571007677632] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Thu Dec 22 16:09:36.989743 2016] [watchdog:debug] [pid 14861:tid 140571007677632] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Thu Dec 22 16:09:36.989746 2016] [watchdog:debug] [pid 14861:tid 140571007677632] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Thu Dec 22 16:09:37.052903 2016] [mpm_worker:notice] [pid 14861:tid 140571007677632] AH00292: Apache/2.4.25 (Debian) world domination series/2.0 mod_perl/2.0.10 Perl/v5.24.1 configured -- resuming normal operations
[Thu Dec 22 16:09:37.052938 2016] [mpm_worker:info] [pid 14861:tid 140571007677632] AH00293: Server built: 2016-12-21T22:46:06
[Thu Dec 22 16:09:37.052946 2016] [core:notice] [pid 14861:tid 140571007677632] AH00094: Command line: '/usr/sbin/apache2 -d /build/libapache2-mod-perl2-2.0.10/t -f /build/libapache2-mod-perl2-2.0.10/t/conf/httpd.conf -D APACHE2 -D APACHE2_4 -D PERL_USEITHREADS'
[Thu Dec 22 16:09:37.054011 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054056 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054065 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054071 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054077 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054082 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054088 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054093 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054099 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054120 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054127 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054132 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054138 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054144 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054150 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054155 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054160 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054166 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054171 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054176 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054182 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054187 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054193 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054198 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054204 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054209 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054215 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054220 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054226 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054237 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054243 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054249 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054255 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054260 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054266 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054271 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054277 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054282 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054288 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054293 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054298 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054303 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054309 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054314 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054320 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054325 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054330 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054335 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054340 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054351 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054356 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054362 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054367 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054372 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054378 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054383 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054389 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054394 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054400 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054405 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054410 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054415 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054421 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054426 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054432 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054437 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054447 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054453 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054488 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054499 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.054505 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:37.054511 2016] [proxy:debug] [pid 15240:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:37.760450 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40618] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:38.479785 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40624] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:38.479972 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40624] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:39.205075 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40630] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:39.208063 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40634] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:39.867036 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40642] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.886249 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40652] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.889632 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40656] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.891344 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40660] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.893005 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40664] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.894582 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40668] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.896072 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40672] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.897684 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40676] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.899185 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40680] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:40.900719 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40684] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:41.545965 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40692] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:42.262477 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40698] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:42.265859 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40702] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:42.268246 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40706] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:42.945880 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40710] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:42.948720 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40714] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:44.062915 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.062978 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.062986 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.062992 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.062998 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063003 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063009 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063014 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063020 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063025 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063031 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063036 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063042 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063047 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063053 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063058 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063064 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063084 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063091 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063097 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063102 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063108 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063113 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063118 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063124 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063129 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063134 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063139 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063145 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063150 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063156 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063161 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063167 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063172 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063177 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063182 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063188 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063193 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063203 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063208 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063214 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063219 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063225 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063230 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063235 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063240 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063245 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063250 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063255 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063260 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063265 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063270 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063275 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063280 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063286 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063291 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063296 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063301 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063312 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063318 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063323 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063328 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063334 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063339 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063345 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063350 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063360 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063366 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063385 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063390 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:44.063396 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1774): AH00924: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ shared already initialized
[Thu Dec 22 16:09:44.063401 2016] [proxy:debug] [pid 18669:tid 140571007677632] proxy_util.c(1816): AH00926: worker http://localhost:8529/TestFilter__both_str_req_proxy_content/ local already initialized
[Thu Dec 22 16:09:46.332204 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40738] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:47.005573 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40742] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:47.683257 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40748] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:48.348560 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40756] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:49.069225 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40764] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:49.073695 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40768] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:49.074721 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40768] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:49.724730 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40774] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:50.402941 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40778] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:51.100622 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40788] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:51.765542 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40794] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:52.456702 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40802] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:53.751304 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40812] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.751364 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40812] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.751371 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(728): [client 127.0.0.1:40812] AH01625: authorization result of Require valid-user : neutral (directive limited to other methods)
[Thu Dec 22 16:09:53.751375 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40812] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.756900 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40816] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.756938 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40816] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.756943 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(728): [client 127.0.0.1:40816] AH01625: authorization result of Require valid-user : neutral (directive limited to other methods)
[Thu Dec 22 16:09:53.756946 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40816] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.759336 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40820] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.759368 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40820] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.759372 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(728): [client 127.0.0.1:40820] AH01625: authorization result of Require valid-user : neutral (directive limited to other methods)
[Thu Dec 22 16:09:53.759376 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40820] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.761308 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40824] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.761343 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40824] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.761347 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(728): [client 127.0.0.1:40824] AH01625: authorization result of Require valid-user : neutral (directive limited to other methods)
[Thu Dec 22 16:09:53.761350 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40824] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.763180 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40828] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.763206 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40828] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.763211 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(728): [client 127.0.0.1:40828] AH01625: authorization result of Require valid-user : neutral (directive limited to other methods)
[Thu Dec 22 16:09:53.763214 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40828] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.764964 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40832] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.764988 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40832] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.764993 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(728): [client 127.0.0.1:40832] AH01625: authorization result of Require valid-user : neutral (directive limited to other methods)
[Thu Dec 22 16:09:53.764996 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40832] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.765049 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40832] AH01626: authorization result of Require my-user goo bar: granted
[Thu Dec 22 16:09:53.765054 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:40832] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:09:53.768441 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40836] AH01626: authorization result of Require my-user goo bar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.768468 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40836] AH01626: authorization result of Require my-group xar tar: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.768473 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40836] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:09:53.768476 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40836] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:09:53.768529 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40836] AH01626: authorization result of Require my-user goo bar: granted
[Thu Dec 22 16:09:53.768535 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:40836] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:09:54.419198 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:46552] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:54.419348 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:46552] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:55.079366 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40848] AH01628: authorization result: granted (no directives)

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.084412 2016] [perl:info] [pid 18669:tid 140570722825984] [client 127.0.0.1:40848] TestAPI::aplog test in progress

*** The following warn entry is expected and harmless ***
This log message comes with no header

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.085723 2016] [perl:debug] [pid 18669:tid 140570722825984] aplog.pm(78): log_serror test 1

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.086027 2016] [perl:debug] [pid 18669:tid 140570722825984] aplog.pm(90): (20014)Internal error (specific information not available): log_serror test 2

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:09:55.086376 2016] [perl:crit] [pid 18669:tid 140570722825984] (20007)No time was provided and one was required.: [client 127.0.0.1:40848] log_rerror test

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:09:55.086665 2016] [:error] [pid 18669:tid 140570722825984] $r->log_error test

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:09:55.086944 2016] [:error] [pid 18669:tid 140570722825984] $s->log_error test

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:09:55.087352 2016] [:error] [pid 18669:tid 140570722825984] access to /TestAPI__aplog failed for 127.0.0.1, reason: $r->log_reason test

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:09:55.087643 2016] [:error] [pid 18669:tid 140570722825984] access to filename failed for 127.0.0.1, reason: $r->log_reason filename test

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.088035 2016] [:warn] [pid 18669:tid 140570722825984] $s->warn test

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.088339 2016] [:warn] [pid 18669:tid 140570722825984] Apache2::ServerRec::warn test

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.088656 2016] [:warn] [pid 18669:tid 140570722825984] Apache2::ServerRec::warn test

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:09:55.088924 2016] [:warn] [pid 18669:tid 140570722825984] warn test
[Thu Dec 22 16:09:55.785295 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40854] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:56.467344 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40858] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:57.161241 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40866] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:57.877007 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40874] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:58.597582 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40892] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:58.601805 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40900] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:59.285562 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40904] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:59.288519 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40908] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:09:59.970831 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40914] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.671322 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40922] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.671603 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40922] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.673827 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40926] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.673953 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40926] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.675553 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40930] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.675667 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40930] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.677372 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40934] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:00.677551 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40934] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:01.347502 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40938] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:01.348073 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40938] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:01.350534 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40942] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:01.351275 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40942] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.059599 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40948] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.060431 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40948] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.062509 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40952] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.063220 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40952] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.811042 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40968] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.811177 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40968] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.813567 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40972] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.813692 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40972] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.815490 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40976] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.815583 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40976] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.817353 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40980] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:02.817441 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:40980] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:03.602867 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40988] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:03.603496 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40988] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:03.603629 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:40988] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:04.333482 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41002] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:05.032243 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41008] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:05.676694 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41012] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:06.327563 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41018] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:07.036457 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41024] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:07.736287 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41030] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:08.484167 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41044] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.292657 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41054] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.295213 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41058] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.983168 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41068] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.985694 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41072] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.987810 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41076] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.989355 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41080] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.989437 2016] [core:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:41080] AH00524: Handler for modperl returned invalid result code 2
[Thu Dec 22 16:10:09.991284 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41084] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:09.991467 2016] [core:error] [pid 18669:tid 140570802792192] [client 127.0.0.1:41084] AH00524: Handler for modperl returned invalid result code 2
[Thu Dec 22 16:10:10.707435 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41088] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/t/response/TestAPI/server_const.pm line 53.
[Thu Dec 22 16:10:11.406648 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41092] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:12.057723 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41098] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:12.745138 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41104] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:13.429299 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41108] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.146150 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41116] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.150070 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41120] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.152831 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41124] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.154599 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41128] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.156261 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41132] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.157850 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41136] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.159434 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41140] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.160945 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41144] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.162815 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41148] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.829487 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41152] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:14.831899 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41152] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:15.511200 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41156] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:22.020902 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41176] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:22.697213 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41182] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:23.453976 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41186] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:24.419771 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41190] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:25.107865 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41194] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:25.813499 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41198] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:26.527419 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41202] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:27.219480 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41206] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:27.939356 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41226] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:28.629939 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41230] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:29.380335 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41236] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:29.383177 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41236] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:30.080486 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41240] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:30.772785 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41244] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:31.529260 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41248] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:32.275373 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41256] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:33.114172 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41262] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:33.865115 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41270] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:34.589167 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41276] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:35.296870 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41280] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:36.051886 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41288] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:36.763517 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41292] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:37.539120 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41302] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:37.542464 2016] [:error] [pid 18669:tid 140570722825984] Apache::log_error test ok

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:10:37.542543 2016] [:warn] [pid 18669:tid 140570722825984] Apache->warn ok

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:10:37.542595 2016] [:warn] [pid 18669:tid 140570722825984] Apache::warn ok

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:10:37.542656 2016] [:warn] [pid 18669:tid 140570722825984] Apache::Server->warn ok

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:10:37.542707 2016] [:warn] [pid 18669:tid 140570722825984] Apache::Server::warn ok
[Thu Dec 22 16:10:38.325096 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41306] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:39.020398 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41310] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:39.694313 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41316] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:40.366356 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41324] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:41.052771 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41328] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:41.759526 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41336] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:41.759550 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41336] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:41.766030 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41340] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:41.766057 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41340] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:41.767171 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41340] AH01626: authorization result of Require valid-user : granted
[Thu Dec 22 16:10:41.767187 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41340] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:10:42.456477 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41346] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:43.162137 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41352] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.003306 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41410] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.006573 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41416] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.009627 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41420] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.011740 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41424] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.014712 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41428] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.789135 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:44.791654 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41450] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:45.684001 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41456] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:46.454119 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41466] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:47.188477 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41470] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.188507 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41470] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.194380 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41474] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.194405 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41474] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.198070 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41478] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.198096 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41478] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.198125 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41478] AH01626: authorization result of Require valid-user : granted
[Thu Dec 22 16:10:47.198130 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41478] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:10:47.200334 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41482] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.200360 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41482] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.202544 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41486] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.202568 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41486] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.204853 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41490] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.204877 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41490] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.207125 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41494] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.207148 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41494] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:47.207191 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41494] AH01626: authorization result of Require valid-user : granted
[Thu Dec 22 16:10:47.207196 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:41494] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:10:47.209283 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41498] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:10:47.209308 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:41498] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:10:48.013417 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:45972] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.015948 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:45972] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.016148 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:45972] Use of uninitialized value in string eq at /build/libapache2-mod-perl2-2.0.10/t/response/TestDirective/perlcleanuphandler.pm line 24.\n
[Thu Dec 22 16:10:48.017975 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:45972] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.024224 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:45972] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.024397 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:45972] Use of uninitialized value in string eq at /build/libapache2-mod-perl2-2.0.10/t/response/TestDirective/perlcleanuphandler.pm line 24.\n
[Thu Dec 22 16:10:48.080116 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:45972] Use of uninitialized value in string eq at /build/libapache2-mod-perl2-2.0.10/t/response/TestDirective/perlcleanuphandler.pm line 24.\n
[Thu Dec 22 16:10:48.713980 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41506] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.747480 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41510] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.753898 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41514] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.756589 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41518] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.759223 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41522] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:48.767346 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41526] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:49.543116 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41532] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:50.300762 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41540] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:50.302976 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41544] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:50.304825 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41548] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:51.041694 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41556] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:51.045010 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:43888] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:51.047819 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:43892] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:51.788747 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:55374] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:52.514534 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:43194] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:53.272282 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:49222] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:53.941264 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41596] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:54.652013 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:46354] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:55.336801 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38054] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:55.645394 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41610] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:56.363774 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41618] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:57.108121 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41624] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:57.839737 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41634] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:58.593626 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41644] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:58.594928 2016] [perl:error] [pid 18669:tid 140570802792192] [client 127.0.0.1:41644] APR::Socket::recv: (11) Resource temporarily unavailable at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 157
[Thu Dec 22 16:10:58.602073 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41648] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:58.603249 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:41648] Undefined subroutine &TestError::runtime::no_such_func called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 151.\n
[Thu Dec 22 16:10:58.606106 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41652] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:58.606903 2016] [perl:error] [pid 18669:tid 140570722825984] [client 127.0.0.1:41652] APR::Socket::recv: (11) Resource temporarily unavailable at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 157.\n\tTestError::runtime::mp_error(APR::Socket=SCALAR(0x7fd91c4e6118)) called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 76\n\tTestError::runtime::die_hook_confess_mp_error(Apache2::RequestRec=SCALAR(0x7fd92405d4a8), APR::Socket=SCALAR(0x7fd91c4e6118)) called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 32\n\tTestError::runtime::handler(Apache2::RequestRec=SCALAR(0x7fd92405d4a8)) called at -e line 0\n\teval {...} called at -e line 0\n
[Thu Dec 22 16:10:58.609157 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41656] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:58.609723 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:41656] Undefined subroutine &TestError::runtime::no_such_func called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 151.\n at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 151.\n\tTestError::runtime::non_mp_error(APR::Socket=SCALAR(0x7fd91c2ccfe0)) called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 83\n\tTestError::runtime::die_hook_confess_non_mp_error(Apache2::RequestRec=SCALAR(0x7fd91c2ccf20), APR::Socket=SCALAR(0x7fd91c2ccfe0)) called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 32\n\tTestError::runtime::handler(Apache2::RequestRec=SCALAR(0x7fd91c2ccf20)) called at -e line 0\n\teval {...} called at -e line 0\n
[Thu Dec 22 16:10:58.611709 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41660] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:58.611992 2016] [perl:error] [pid 18669:tid 140570802792192] [client 127.0.0.1:41660] custom die hook: APR::Socket::recv: (11) Resource temporarily unavailable at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 157 at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 88.\n
[Thu Dec 22 16:10:58.613881 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41664] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:58.614035 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:41664] custom die hook: Undefined subroutine &TestError::runtime::no_such_func called at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/runtime.pm line 151.\n
[Thu Dec 22 16:10:58.615818 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41668] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:58.617683 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41672] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:58.619207 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41676] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:58.620852 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41680] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:58.622979 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41684] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:10:59.337997 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41690] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:10:59.338387 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:41690] failed to resolve handler `TestError::syntax': syntax error at /build/libapache2-mod-perl2-2.0.10/t/response/TestError/syntax.pm line 18, near "\\;"\nCompilation failed in require at (eval 276) line 2.\n
[Thu Dec 22 16:11:00.670097 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41698] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:00.670409 2016] [deflate:debug] [pid 15240:tid 140570802792192] mod_deflate.c(1421): [client 127.0.0.1:41698] AH01393: Zlib: Inflated 14 to 12 : URL /TestFilter__both_str_native_remove
[Thu Dec 22 16:11:00.673143 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41702] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:01.357158 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41712] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:02.124900 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41724] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:02.125060 2016] [deflate:debug] [pid 18669:tid 140570802792192] mod_deflate.c(1421): [client 127.0.0.1:41724] AH01393: Zlib: Inflated 54 to 59 : URL /TestFilter__both_str_req_mix
[Thu Dec 22 16:11:02.125341 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41724] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:02.125796 2016] [deflate:debug] [pid 18669:tid 140570802792192] mod_deflate.c(853): [client 127.0.0.1:41724] AH01384: Zlib: Compressed 21 to 26 : URL /TestFilter__both_str_req_mix
[Thu Dec 22 16:11:02.868382 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41734] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:02.868425 2016] [proxy:debug] [pid 15240:tid 140570802792192] mod_proxy.c(1228): [client 127.0.0.1:41734] AH01143: Running scheme http handler (attempt 0)
[Thu Dec 22 16:11:02.868434 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2209): [client 127.0.0.1:41734] AH00944: connecting http://localhost:8529/TestFilter__both_str_req_proxy_content/foo to localhost:8529
[Thu Dec 22 16:11:02.868484 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2418): [client 127.0.0.1:41734] AH00947: connected /TestFilter__both_str_req_proxy_content/foo to localhost:8529
[Thu Dec 22 16:11:02.868836 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41738] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:03.613507 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41748] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:04.285493 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41758] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:04.287817 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41762] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:04.289560 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41766] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:05.020853 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41770] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:05.806225 2016] [core:debug] [pid 18669:tid 140570802792192] protocol.c(957): (22)Invalid argument: [client 127.0.0.1:50632] Failed to read request header line X-My-Protocol: POST-IT
[Thu Dec 22 16:11:05.806252 2016] [core:debug] [pid 18669:tid 140570802792192] protocol.c(1313): [client 127.0.0.1:50632] AH00567: request failed: error reading the headers
[Thu Dec 22 16:11:06.579850 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:39464] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:07.314496 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41788] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:08.084993 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41794] AH01628: authorization result: granted (no directives)

*** The following 2 error entries are expected and harmless ***
[Thu Dec 22 16:11:08.085154 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:41794] This filter must die at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/in_error.pm line 27.\n
[Thu Dec 22 16:11:08.085281 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:41794] Apache2::RequestIO::read: (120001) filter handler has failed at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/in_error.pm line 42
[Thu Dec 22 16:11:08.848456 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41798] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:09.581094 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41802] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:09.583522 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41806] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:10.329587 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41814] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:10.995632 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41818] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:11.683573 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41822] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:12.418892 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41828] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:13.105307 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41554] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:13.872751 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41836] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:14.574537 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:50546] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:14.574636 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:50546] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:15.249052 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41844] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:15.910003 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41850] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:16.661577 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41856] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:16.664197 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41860] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:16.667688 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41864] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:16.675067 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41868] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:16.690925 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41872] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:17.456528 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41880] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:18.206127 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41890] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:18.990530 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41900] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:19.793996 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41912] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:20.552948 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41924] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:21.352407 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41934] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:22.136907 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41950] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:22.898378 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41964] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:23.697238 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41970] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:24.458923 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41978] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:24.459196 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41978] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:25.158705 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:41986] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:25.161199 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41990] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:25.870482 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41998] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:25.870772 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:41998] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:26.588423 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42014] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:26.588675 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42014] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:27.310581 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42024] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:27.311016 2016] [core:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] AH00125: Request exceeded the limit of 10 subrequest nesting levels due to probable configuration error. Use 'LimitInternalRecursion' to increase the limit if necessary. Use 'LogLevel debug' to get a backtrace.
[Thu Dec 22 16:11:27.311025 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3761): [client 127.0.0.1:42024] AH00121: r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311036 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311039 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311041 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311044 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311046 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311048 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311050 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311052 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311054 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311056 2016] [core:debug] [pid 15240:tid 140570722825984] core.c(3775): [client 127.0.0.1:42024] AH00123: subrequested from r->uri = /with_subrequest/Makefile
[Thu Dec 22 16:11:27.311061 2016] [core:info] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] AH00128: File does not exist: 
[Thu Dec 22 16:11:27.312856 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (104) Connection reset by peer at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.312994 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.313109 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.313251 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.313401 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.313529 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.313655 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.313776 2016] [perl:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42024] Apache2::Filter::print: (103) Software caused connection abort at /build/libapache2-mod-perl2-2.0.10/t/filter/TestFilter/with_subrequest.pm line 19
[Thu Dec 22 16:11:27.986556 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42040] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:28.734133 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42062] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:28.734163 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42062] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:28.740026 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42068] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:28.740057 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42068] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:28.743792 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42072] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:28.743809 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42072] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:28.746687 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42076] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:28.746703 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42076] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:28.746784 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42076] AH01626: authorization result of Require valid-user : granted
[Thu Dec 22 16:11:28.746793 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42076] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:11:28.752957 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42080] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:28.752985 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42080] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:28.756098 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42084] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:28.756125 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42084] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:29.746441 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42098] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:29.746472 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42098] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:29.747021 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42098] AH01626: authorization result of Require valid-user : granted
[Thu Dec 22 16:11:29.747032 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42098] AH01626: authorization result of <RequireAny>: granted
[Thu Dec 22 16:11:29.750105 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42102] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:29.750142 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42102] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.579363 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42110] AH01626: authorization result of Require user dougm: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.579385 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42110] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.583747 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42114] AH01626: authorization result of Require user dougm: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.583771 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42114] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.585973 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42118] AH01626: authorization result of Require user dougm: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.585995 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42118] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.588046 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42122] AH01626: authorization result of Require user dougm: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.588072 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:42122] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.592959 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42126] AH01626: authorization result of Require user dougm: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.592982 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42126] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.594987 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42130] AH01626: authorization result of Require user dougm: denied (no authenticated user yet)
[Thu Dec 22 16:11:30.595008 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(809): [client 127.0.0.1:42130] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:31.278300 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42134] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:31.964253 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42140] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:32.630278 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42144] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:32.631054 2016] [perl:error] [pid 18669:tid 140570802792192] [client 127.0.0.1:42144] Undefined subroutine &TestHooks::error::bomb called at /build/libapache2-mod-perl2-2.0.10/t/hooks/TestHooks/error.pm line 22.\n
[Thu Dec 22 16:11:32.631106 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42144] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:32.633234 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42148] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:32.634036 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:42148] Undefined subroutine &TestHooks::error::bomb called at /build/libapache2-mod-perl2-2.0.10/t/hooks/TestHooks/error.pm line 22.\n
[Thu Dec 22 16:11:32.634098 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42148] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:33.303296 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42152] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:33.971026 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42162] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:35.486823 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:56662] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:36.215055 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42186] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:36.217710 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42190] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:36.930062 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42200] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:37.650988 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:39764] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:38.444308 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42216] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:39.147756 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42226] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:39.896428 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42234] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:40.629551 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42244] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:41.382999 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:43166] AH01626: authorization result of Require valid-user : denied (no authenticated user yet)
[Thu Dec 22 16:11:41.383024 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(809): [client 127.0.0.1:43166] AH01626: authorization result of <RequireAny>: denied (no authenticated user yet)
[Thu Dec 22 16:11:42.066491 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:38978] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:42.069070 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42268] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:11:42.846142 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42684] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:42.846177 2016] [core:info] [pid 18669:tid 140570722825984] [client 127.0.0.1:42684] AH00128: File does not exist: /build/libapache2-mod-perl2-2.0.10/t/htdocs/nope
[Thu Dec 22 16:11:42.849115 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42688] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:42.851066 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42692] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:43.617311 2016] [perl:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:42290] Use of uninitialized value in string eq at /build/libapache2-mod-perl2-2.0.10/t/response/TestModperl/cookie.pm line 18.\n
[Thu Dec 22 16:11:43.619567 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42294] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:43.621433 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42294] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:43.622666 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42294] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:44.321223 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42300] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:44.323267 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42300] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:44.324587 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42300] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:45.030454 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42306] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:45.694727 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42314] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:46.382463 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42322] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:47.066385 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42326] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:47.768805 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42330] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:47.771617 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42334] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:48.440155 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42340] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:49.126003 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42348] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:49.807018 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42356] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:49.808222 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42356] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:50.614653 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42366] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:51.631456 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:48710] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:51.631556 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:48710] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:52.363906 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:48718] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:52.364029 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:48718] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:53.092965 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:48726] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:53.093045 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:48726] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:53.766390 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42390] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:54.472256 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42396] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:55.275830 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42400] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:55.941052 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42406] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:56.624520 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:57610] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:57.304746 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:35396] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:58.044217 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42426] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:58.049077 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42426] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:58.054232 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42430] AH01628: authorization result: granted (no directives)

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:58.762628 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42434] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:58.763541 2016] [:warn] [pid 15240:tid 140570802792192] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:58.966613 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42438] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:58.968312 2016] [:warn] [pid 18669:tid 140570722825984] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:59.172321 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42442] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:59.172576 2016] [:warn] [pid 15240:tid 140570722825984] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:59.375487 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:59.375713 2016] [:warn] [pid 18669:tid 140570802792192] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:59.579311 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42450] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:59.579567 2016] [:warn] [pid 15240:tid 140570802792192] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:59.781894 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42454] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:59.782109 2016] [:warn] [pid 18669:tid 140570722825984] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:11:59.985121 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42458] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:11:59.986168 2016] [:warn] [pid 15240:tid 140570722825984] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:12:00.189026 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42462] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:00.190285 2016] [:warn] [pid 18669:tid 140570802792192] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:12:00.392836 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42468] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:00.393701 2016] [:warn] [pid 15240:tid 140570802792192] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:12:00.595598 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42474] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:00.596419 2016] [:warn] [pid 18669:tid 140570722825984] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:12:00.798643 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42478] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:00.799574 2016] [:warn] [pid 15240:tid 140570722825984] pnotes are destroyed after cleanup passed

*** The following warn entry is expected and harmless ***
[Thu Dec 22 16:12:01.002849 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42482] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:01.004169 2016] [:warn] [pid 18669:tid 140570802792192] pnotes are destroyed after cleanup passed
[Thu Dec 22 16:12:02.028397 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42500] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:02.758285 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42512] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:03.481509 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42524] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:04.161061 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42532] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:04.845240 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42536] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:05.508829 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42544] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:06.202117 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42548] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:06.205623 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42552] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:07.003634 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42560] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:07.733005 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42564] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:12:07.735839 2016] [core:error] [pid 18669:tid 140570722825984] [client 127.0.0.1:42564] AH00572: need AuthName: /TestModperl__setauth
[Thu Dec 22 16:12:08.558086 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.562150 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.564181 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.566435 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.568522 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.570682 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.572908 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.574462 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.575704 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:08.577321 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:38446] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:09.282393 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42576] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:09.287029 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42580] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.051807 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42592] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.055015 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42596] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:12:10.055535 2016] [core:info] [pid 15240:tid 140570722825984] [client 127.0.0.1:42596] AH00128: File does not exist: /build/libapache2-mod-perl2-2.0.10/t/htdocs/TestModperl__status
[Thu Dec 22 16:12:10.058117 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42600] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.060459 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42604] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.062355 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42608] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.064221 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42612] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.064298 2016] [core:error] [pid 15240:tid 140570722825984] [client 127.0.0.1:42612] AH00524: Handler for modperl returned invalid result code 601
[Thu Dec 22 16:12:10.065971 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42616] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.067670 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42620] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.067749 2016] [core:error] [pid 15240:tid 140570802792192] [client 127.0.0.1:42620] AH00524: Handler for modperl returned invalid result code 1
[Thu Dec 22 16:12:10.069360 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42624] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.071430 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42628] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.073041 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42632] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
[Thu Dec 22 16:12:10.073136 2016] [perl:error] [pid 18669:tid 140570802792192] [client 127.0.0.1:42632] Died at /build/libapache2-mod-perl2-2.0.10/t/response/TestModperl/status.pm line 25.\n
[Thu Dec 22 16:12:10.074791 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42636] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
Argument "foobar" isn't numeric.
[Thu Dec 22 16:12:10.076263 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42640] AH01628: authorization result: granted (no directives)

*** The following error entry is expected and harmless ***
Argument "foo9bar" isn't numeric.
[Thu Dec 22 16:12:10.077723 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42644] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.785102 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42648] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:10.785292 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42648] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:11.534677 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42656] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:11.534940 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42656] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:12.287078 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42662] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:13.153644 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42666] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:13.903631 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42680] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:14.655972 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42684] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.396815 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42692] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.399843 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42696] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.401859 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42700] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.403849 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42704] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.406154 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42708] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.408314 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42712] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.411840 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42716] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.413993 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42720] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.478073 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42724] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.488258 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42728] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.496581 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42732] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.569403 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42736] AH01628: authorization result: granted (no directives)
ap_get_server_version() is deprecated since httpd/2.3.0 try using ap_get_server_(description|banner)() instead at /build/libapache2-mod-perl2-2.0.10/blib/lib/Apache2/Status.pm line 145.
[Thu Dec 22 16:12:15.571427 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42740] AH01628: authorization result: granted (no directives)
Option -slow unrecognized at /usr/lib/x86_64-linux-gnu/perl/5.24/B/Concise.pm line 321.
[Thu Dec 22 16:12:15.593566 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42744] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:16.379822 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42752] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:16.407253 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42756] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:16.450302 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42760] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:16.464120 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42764] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:16.467355 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42768] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:17.304447 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42776] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:17.308310 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42780] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:17.311562 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42784] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:17.323884 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42788] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:17.326371 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42792] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.062802 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42796] AH01628: authorization result: granted (no directives)
CGI::param called in list context from /build/libapache2-mod-perl2-2.0.10/t/response/TestModules/cgipost.pm line 18, this can lead to vulnerabilities. See the warning in "Fetching the value or values of a single named parameter" at /usr/share/perl5/CGI.pm line 412.
[Thu Dec 22 16:12:18.066113 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42800] AH01628: authorization result: granted (no directives)
CGI::param called in list context from /build/libapache2-mod-perl2-2.0.10/t/response/TestModules/cgipost.pm line 18, this can lead to vulnerabilities. See the warning in "Fetching the value or values of a single named parameter" at /usr/share/perl5/CGI.pm line 412.
[Thu Dec 22 16:12:18.069694 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42804] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.073273 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42808] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.077311 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42812] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.082028 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42816] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.799432 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42824] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.802803 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42828] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.806295 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42832] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.809878 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42836] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.814044 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42840] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:18.818921 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42844] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:19.527090 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42848] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:19.531855 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42852] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:20.258293 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42862] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:20.262825 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42866] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:20.997721 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42872] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:20.998481 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42872] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:21.003008 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42872] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:21.760527 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42876] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.498755 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.498861 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.499515 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.499567 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.499630 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.499760 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.499827 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:22.499956 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42884] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:23.240042 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:35650] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:23.240118 2016] [proxy:debug] [pid 15240:tid 140570802792192] mod_proxy.c(1228): [client 127.0.0.1:35650] AH01143: Running scheme http handler (attempt 0)
[Thu Dec 22 16:12:23.240176 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2156): AH00942: HTTP: has acquired connection for (*)
[Thu Dec 22 16:12:23.240190 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2209): [client 127.0.0.1:35650] AH00944: connecting http://localhost:8536/TestModules__proxy_real to localhost:8536
[Thu Dec 22 16:12:23.240354 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2418): [client 127.0.0.1:35650] AH00947: connected /TestModules__proxy_real to localhost:8536
[Thu Dec 22 16:12:23.240400 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2875): (111)Connection refused: AH00957: HTTP: attempt to connect to [::1]:8536 (*) failed
[Thu Dec 22 16:12:23.240445 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2884): AH02824: HTTP: connection established with 127.0.0.1:8536 (*)
[Thu Dec 22 16:12:23.240460 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(3051): AH00962: HTTP: connection complete to [::1]:8536 (localhost)
[Thu Dec 22 16:12:23.240694 2016] [authz_core:debug] [pid 18669:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:35654] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:23.240838 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2171): AH00943: *: has released connection for (*)
[Thu Dec 22 16:12:23.240852 2016] [proxy:debug] [pid 15240:tid 140570802792192] proxy_util.c(2991): [remote 127.0.0.1:8536] AH02642: proxy: connection shutdown
[Thu Dec 22 16:12:24.075619 2016] [authz_core:debug] [pid 15240:tid 140570722825984] mod_authz_core.c(835): [client 127.0.0.1:42900] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:25.183515 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:42904] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:25.910642 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:51448] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:32.237537 2016] [authz_core:debug] [pid 18669:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:54940] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:32.936325 2016] [authz_core:debug] [pid 15240:tid 140570802792192] mod_authz_core.c(835): [client 127.0.0.1:33828] AH01628: authorization result: granted (no directives)
[Thu Dec 22 16:12:34.486579 2016] [perl:info] [pid 15240:tid 140571007677632] Child process pid=15240 is exiting
[Thu Dec 22 16:12:34.486579 2016] [perl:info] [pid 18669:tid 140571007677632] Child process pid=18669 is exiting
[Thu Dec 22 16:12:34.486650 2016] [perl:info] [pid 18669:tid 140571007677632] Child process pid=18669 is exiting - server push
[Thu Dec 22 16:12:34.486655 2016] [perl:info] [pid 15240:tid 140571007677632] Child process pid=15240 is exiting - server push
END in modperl_extra.pl, pid=18669
END in modperl_extra.pl, pid=15240
END in TestModperl::print, pid=18669
END in modperl_extra.pl, pid=15240
END in modperl_extra.pl, pid=18669
END in modperl_extra.pl, pid=18669
[Thu Dec 22 16:12:35.331467 2016] [core:info] [pid 14861:tid 140571007677632] AH00096: removed PID file /build/libapache2-mod-perl2-2.0.10/t/logs/httpd.pid (pid=14861)
[Thu Dec 22 16:12:35.331519 2016] [mpm_worker:notice] [pid 14861:tid 140571007677632] AH00295: caught SIGTERM, shutting down
********************************************************************************
*** This is a test for Apache2::ServerUtil::server_shutdown_cleanup_register ***
*** Following a line consisting only of * characters there should be a line  ***
*** containing                                                               ***
***     "cleanup died: testing server_shutdown_cleanup_register".            ***
*** The next line should then read                                           ***
***     "done with server_shutdown_cleanup_register"                         ***
********************************************************************************
Apache2::ServerUtil: cleanup died: testing server_shutdown_cleanup_register
*** done with server_shutdown_cleanup_register                               ***
********************************************************************************
END in modperl_extra.pl, pid=14861
END in modperl_extra.pl, pid=14861
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 963 bytes
Desc: Digital Signature
URL: <http://lists.alioth.debian.org/pipermail/pkg-perl-maintainers/attachments/20161222/628a3fa6/attachment-0001.sig>