apache error_log with debug info during 2 requests on same connection

two_requests_on_same_connection_debug.log (text/x-log), 13.05 KB, created by Frank Meier on 2014-03-06 10:05:40 UTC

(hide)

Description: apache error_log with debug info during 2 requests on same connection

Filename:

MIME Type:

Creator: Frank Meier

Created: 2014-03-06 10:05:40 UTC

Size: 13.05 KB

patch

obsolete

>[Thu Mar 06 10:57:23.399458 2014] [mpm_event:debug] [pid 26331:tid 139888648304384] event.c(1949): AH02471: start_threads: Using epoll >[Thu Mar 06 10:57:23.399478 2014] [mpm_event:notice] [pid 26330:tid 139888678704960] AH00489: Apache/2.4.7 (Unix) configured -- resuming normal operations >[Thu Mar 06 10:57:23.399620 2014] [mpm_event:debug] [pid 26332:tid 139888648304384] event.c(1949): AH02471: start_threads: Using epoll >[Thu Mar 06 10:57:23.399718 2014] [mpm_event:debug] [pid 26334:tid 139888648304384] event.c(1949): AH02471: start_threads: Using epoll >[Thu Mar 06 10:57:23.399875 2014] [mpm_event:info] [pid 26330:tid 139888678704960] AH00490: Server built: Mar 6 2014 10:26:23 >[Thu Mar 06 10:57:23.400858 2014] [core:notice] [pid 26330:tid 139888678704960] AH00094: Command line: '/home/meierfra/devel/test/apache/httpd-inst/bin/httpd -D FOREGROUND' >[Thu Mar 06 10:57:51.982062 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(354): [client 127.0.0.1:44766] reqtimeout_init: con_rec:580379c0 >[Thu Mar 06 10:57:51.982144 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(392): [client 127.0.0.1:44766] reqtimeout_init: reqtimeout ctx:58037d30 con_rec:580379c0 >[Thu Mar 06 10:57:51.982170 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:57:51.982174 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(189): [client 127.0.0.1:44766] reqtimeout_filter: new_timeout == 8 >[Thu Mar 06 10:57:51.982178 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 8000000 -> 0 >[Thu Mar 06 10:57:51.982180 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(224): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_get:60000000 rv:0 >[Thu Mar 06 10:57:51.982183 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(227): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:8000000 >[Thu Mar 06 10:57:51.982209 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(327): [client 127.0.0.1:44766] reqtimeout_filter: restore socket_timeout:60000000 >[Thu Mar 06 10:57:51.982228 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:57:51.982231 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 7999945 -> 0 >[Thu Mar 06 10:57:51.982233 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(224): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_get:60000000 rv:0 >[Thu Mar 06 10:57:51.982236 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(227): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:7999945 >[Thu Mar 06 10:57:51.982238 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(327): [client 127.0.0.1:44766] reqtimeout_filter: restore socket_timeout:60000000 >[Thu Mar 06 10:57:51.982241 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:57:51.982243 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 7999933 -> 0 >[Thu Mar 06 10:57:51.982245 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(224): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_get:60000000 rv:0 >[Thu Mar 06 10:57:51.982250 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(227): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:7999933 >[Thu Mar 06 10:57:52.440101 2014] [mpm_event:debug] [pid 26426:tid 139888648304384] event.c(1949): AH02471: start_threads: Using epoll >[Thu Mar 06 10:57:52.605761 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(296): [client 127.0.0.1:44766] reqtimeout_filter: after apr_socket_wait rv:0 >[Thu Mar 06 10:57:52.605800 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(301): [client 127.0.0.1:44766] reqtimeout_filter: 2) check_time_left:7376377 saved_sock_timeout:60000000 -> 0 >[Thu Mar 06 10:57:52.605803 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(306): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:7376377 >[Thu Mar 06 10:57:52.605817 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(327): [client 127.0.0.1:44766] reqtimeout_filter: restore socket_timeout:60000000 >[Thu Mar 06 10:57:52.605853 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(404): [client 127.0.0.1:44766] reqtimeout_after_headers: reqtimeout ctx:58037d30 >[Thu Mar 06 10:57:52.605862 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(429): [client 127.0.0.1:44766] reqtimeout_after_headers: new->timeout:0 >[Thu Mar 06 10:57:52.606213 2014] [authz_core:debug] [pid 26334:tid 139888639911680] mod_authz_core.c(828): [client 127.0.0.1:44766] AH01628: authorization result: granted (no directives) >[Thu Mar 06 10:57:52.607321 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:57:52.607384 2014] [reqtimeout:debug] [pid 26334:tid 139888639911680] mod_reqtimeout.c(440): [client 127.0.0.1:44766] reqtimeout_after_body: reqtimeout ctx:58037d30 >[Thu Mar 06 10:58:01.277638 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(354): [client 127.0.0.1:44766] reqtimeout_init: con_rec:580379c0 >[Thu Mar 06 10:58:01.277667 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(392): [client 127.0.0.1:44766] reqtimeout_init: reqtimeout ctx:58037f50 con_rec:580379c0 >[Thu Mar 06 10:58:01.277685 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:58:01.277688 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037f50 >[Thu Mar 06 10:58:01.277690 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(189): [client 127.0.0.1:44766] reqtimeout_filter: new_timeout == 8 >[Thu Mar 06 10:58:01.277693 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 8000000 -> 0 >[Thu Mar 06 10:58:01.277696 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(224): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_get:60000000 rv:0 >[Thu Mar 06 10:58:01.277698 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(227): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:8000000 >[Thu Mar 06 10:58:01.277710 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(327): [client 127.0.0.1:44766] reqtimeout_filter: restore socket_timeout:60000000 >[Thu Mar 06 10:58:01.277720 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:58:01.277722 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(189): [client 127.0.0.1:44766] reqtimeout_filter: new_timeout == 8 >[Thu Mar 06 10:58:01.277725 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 8000000 -> 0 >[Thu Mar 06 10:58:01.277727 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(224): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_get:60000000 rv:0 >[Thu Mar 06 10:58:01.277729 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(227): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:8000000 >[Thu Mar 06 10:58:01.277731 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037f50 >[Thu Mar 06 10:58:01.277738 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 7999955 -> 0 >[Thu Mar 06 10:58:01.316695 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(296): [client 127.0.0.1:44766] reqtimeout_filter: after apr_socket_wait rv:0 >[Thu Mar 06 10:58:01.316704 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(301): [client 127.0.0.1:44766] reqtimeout_filter: 2) check_time_left:7961020 saved_sock_timeout:60000000 -> 0 >[Thu Mar 06 10:58:01.316708 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(306): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:7961020 >[Thu Mar 06 10:58:01.316712 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037f50 >[Thu Mar 06 10:58:01.316715 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 7960978 -> 0 >[Thu Mar 06 10:58:01.316723 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(327): [client 127.0.0.1:44766] reqtimeout_filter: restore socket_timeout:60000000 >[Thu Mar 06 10:58:01.316728 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:58:01.316732 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 7960993 -> 0 >[Thu Mar 06 10:58:01.316735 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(224): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_get:60000000 rv:0 >[Thu Mar 06 10:58:01.316738 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(227): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:7960993 >[Thu Mar 06 10:58:01.316741 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037f50 >[Thu Mar 06 10:58:01.316744 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 7960949 -> 0 >[Thu Mar 06 10:58:02.661569 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(296): [client 127.0.0.1:44766] reqtimeout_filter: after apr_socket_wait rv:0 >[Thu Mar 06 10:58:02.661597 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(301): [client 127.0.0.1:44766] reqtimeout_filter: 2) check_time_left:6616127 saved_sock_timeout:60000000 -> 0 >[Thu Mar 06 10:58:02.661600 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(306): [client 127.0.0.1:44766] reqtimeout_filter: apr_socket_timeout_set:6616127 >[Thu Mar 06 10:58:02.661604 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037f50 >[Thu Mar 06 10:58:02.661607 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 6616086 -> 0 >[Thu Mar 06 10:58:02.661625 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(327): [client 127.0.0.1:44766] reqtimeout_filter: restore socket_timeout:60000000 >[Thu Mar 06 10:58:02.661642 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(404): [client 127.0.0.1:44766] reqtimeout_after_headers: reqtimeout ctx:58037f50 >[Thu Mar 06 10:58:02.661651 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(429): [client 127.0.0.1:44766] reqtimeout_after_headers: new->timeout:0 >[Thu Mar 06 10:58:02.661680 2014] [authz_core:debug] [pid 26334:tid 139888561223424] mod_authz_core.c(828): [client 127.0.0.1:44766] AH01628: authorization result: granted (no directives) >[Thu Mar 06 10:58:02.661993 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037d30 >[Thu Mar 06 10:58:02.662014 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(209): [client 127.0.0.1:44766] reqtimeout_filter: 1) check_time_left 6615711 -> 0 >[Thu Mar 06 10:58:02.662018 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(180): [client 127.0.0.1:44766] reqtimeout_filter: ctx:58037f50 >[Thu Mar 06 10:58:02.662077 2014] [reqtimeout:debug] [pid 26334:tid 139888561223424] mod_reqtimeout.c(440): [client 127.0.0.1:44766] reqtimeout_after_body: reqtimeout ctx:58037f50 >[Thu Mar 06 10:58:55.310593 2014] [core:info] [pid 26330:tid 139888678704960] AH00096: removed PID file /home/meierfra/devel/test/apache/httpd-inst/logs/httpd.pid (pid=26330) >[Thu Mar 06 10:58:55.310617 2014] [mpm_event:notice] [pid 26330:tid 139888678704960] AH00491: caught SIGTERM, shutting down View Attachment As Raw

This is ASF Bugzilla: the Apache Software Foundation bug system. In case of problems with the functioning of ASF Bugzilla, please contact bugzilla-admin@apache.org. Please Note: this e-mail address is only for reporting problems with ASF Bugzilla. Mail about any other subject will be silently ignored.

• • Home
  • | New
  • | Browse
  • | Search
  • |
    [?]
  • | Reports
  • | Help
  • | New Account
  • | Log In
    Remember [x]
  • | Forgot Password
    Login: [x]