-----Messaggio originale-----
Da: Rainer Jung [mailto:[EMAIL PROTECTED]
Inviato: ven 22/08/2008 14.21
A: Tomcat Users List
Oggetto: Re: R: Newer version of mod_jk much slower than 1.2.13
> I get rid of the balancer and set in apache configuration file:
>
> JkMount /eltbinj/* ajp13w_01_01
>
> With the 1.2.13 the result is obviously the same high speed (I unset the lang
> for not italian (lucky) people):
...
> 13:13:00 (630.19 KB/s) - `/dev/null' saved [53048]
>
> With the 1.2.26 the result is the same:
...
> 13:14:53 (7.35 KB/s) - `/dev/null' saved [53048]
>
> So in conclusion, it is not a matter of load balancer.
Thanks for helping narrowing it down, also the information about it only
happening for dynamic content is interesting (maybe it has to do with
chunked encoding).
I could analyze the packet flow between Apache and Tomcat. If you set
JkLogLevel to trace (and if trace doesn't exist for 1.2.13 to debug
there), you get very long log output. If you do the wget test once with
each version and with the increased log level, I could have a look at
those log files. They will contain a full packet dump of the
communication and at least for 1.2.26 millisecond timestamps.
Nevertheless I'm still curious about your JK directives for Apache. I
guess JkMount is not everything ;)
Regards,
Rainer
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: [EMAIL PROTECTED]
For additional commands, e-mail: [EMAIL PROTECTED]
Sorry for the ugly mailer, but I am using a webmail now from home. About the jk
directives for apache, here they are:
LoadModule jk_module modules/mod_jk.so
JkWorkersFile /etc/httpd/conf/workers.properties
JkLogFile /etc/httpd/logs/mod_jk.log
JkLogLevel info
About the trace level, full it is over 700Kbyte (gzipped), I send it directly
to you. Thank you very much if you can look at it.
172.16.1.49 is the host making the wget
193.43.107.13 is the apache server
193.43.107.16 is the tomcat server
A piece following:
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [debug]
init_ws_service::mod_jk.c (888): Service protocol=HTTP/1.0 method=GET
host=(null) a
ddr=172.16.1.49 name=elenco1.comune.prato.it port=80 auth=(null) user=(null)
laddr=193.43.107.14 raddr=172.16.1.49 uri=/eltbinj/servlet/ricer
caelenco
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
get_endpoint::jk_ajp13_worker.c (73): enter
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_get_endpoint::jk_ajp_common.c (2552): enter
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [debug]
ajp_get_endpoint::jk_ajp_common.c (2579): acquired connection pool slot=0
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_get_endpoint::jk_ajp_common.c (2582): exit
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
get_endpoint::jk_ajp13_worker.c (75): exit
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_service::jk_ajp_common.c (1966): enter
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_marshal_into_msgb::jk_ajp_common.c (373): enter
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [debug]
ajp_marshal_into_msgb::jk_ajp_common.c (553): ajp marshaling done
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_marshal_into_msgb::jk_ajp_common.c (554): exit
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [debug]
ajp_service::jk_ajp_common.c (2050): processing ajp13w_01_01 with 2 retries
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_send_request::jk_ajp_common.c (1263): enter
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_next_connection::jk_ajp_common.c (737): enter
[Fri Aug 22 18:10:57.827 2008] [23127:2537062720] [trace]
ajp_next_connection::jk_ajp_common.c (764): exit
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_send_request::jk_ajp_common.c (1352): (ajp13w_01_01) all endpoints are
disconne
cted, detected by connect check (0), cping (0), send (0)
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
ajp_connect_to_endpoint::jk_ajp_common.c (859): enter
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
jk_open_socket::jk_connect.c (426): enter
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
jk_open_socket::jk_connect.c (448): socket TCP_NODELAY set to On
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
jk_open_socket::jk_connect.c (462): socket SO_KEEPALIVE set to On
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
jk_open_socket::jk_connect.c (513): timeout 1 set for socket=17
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
jk_open_socket::jk_connect.c (548): trying to connect socket 17 to
193.43.107.16:8009
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
nb_connect::jk_connect.c (218): enter
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
nb_connect::jk_connect.c (264): exit
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
jk_open_socket::jk_connect.c (574): socket 17 connected to 193.43.107.16:8009
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
jk_open_socket::jk_connect.c (577): exit
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_connect_to_endpoint::jk_ajp_common.c (878): Connected socket 17 to
(193.43.107.16:8009)
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
ajp_connect_to_endpoint::jk_ajp_common.c (908): exit
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [trace]
ajp_connection_tcp_send_message::jk_ajp_common.c (928): enter
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): sending to ajp13 pos=4
len=
190 max=8192
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0000 12 34 00 BA 02
02 0
0 08 48 54 54 50 2F 31 2E 30 - .4......HTTP/1.0
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0010 00 00 1E 2F 65
6C 7
4 62 69 6E 6A 2F 73 65 72 76 - .../eltbinj/serv
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0020 6C 65 74 2F 72
69 6
3 65 72 63 61 65 6C 65 6E 63 - let/ricercaelenc
[Fri Aug 22 18:10:57.828 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0030 6F 00 00 0B 31
37 3
2 2E 31 36 2E 31 2E 34 39 00 - o...172.16.1.49.
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0040 FF FF 00 17 65
6C 6
5 6E 63 6F 31 2E 63 6F 6D 75 - ....elenco1.comu
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0050 6E 65 2E 70 72
61 7
4 6F 2E 69 74 00 00 50 00 00 - ne.prato.it..P..
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0060 05 A0 0E 00 1E
57 6
7 65 74 2F 31 2E 31 30 2E 32 - .....Wget/1.10.2
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0070 20 28 52 65 64
20 4
8 61 74 20 6D 6F 64 69 66 69 - .(Red.Hat.modifi
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0080 65 64 29 00 A0
01 0
0 03 2A 2F 2A 00 A0 0B 00 17 - ed).....*/*.....
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 0090 65 6C 65 6E 63
6F 3
1 2E 63 6F 6D 75 6E 65 2E 70 - elenco1.comune.p
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 00a0 72 61 74 6F 2E
69 7
4 00 A0 06 00 0A 4B 65 65 70 - rato.it.....Keep
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_connection_tcp_send_message::jk_ajp_common.c (934): 00b0 2D 41 6C 69 76
65 0
0 A0 08 00 01 30 00 FF 00 00 - -Alive.....0....
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
jk_tcp_socket_sendfull::jk_connect.c (719): enter
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
jk_tcp_socket_sendfull::jk_connect.c (747): exit
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
ajp_connection_tcp_send_message::jk_ajp_common.c (961): exit
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [debug]
ajp_send_request::jk_ajp_common.c (1395): (ajp13w_01_01) request body to send 0
- r
equest body to resend 0
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
ajp_send_request::jk_ajp_common.c (1506): exit
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
ajp_get_reply::jk_ajp_common.c (1718): enter
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:57.829 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=56 max=8192
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 04 00 C8 00 02
4F 4
B 00 00 01 00 0C 43 6F 6E 74 - .....OK.....Cont
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0010 65 6E 74 2D 54
79 7
0 65 00 00 1C 74 65 78 74 2F - ent-Type...text/
[Fri Aug 22 18:10:58.021 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0020 68 74 6D 6C 3B
63 6
8 61 72 73 65 74 3D 49 53 4F - html;charset=ISO
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0030 2D 38 38 35 39
2D 3
1 00 00 00 00 00 00 00 00 00 - -8859-1.........
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_unmarshal_response::jk_ajp_common.c (590): enter
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [debug]
ajp_unmarshal_response::jk_ajp_common.c (608): status = 200
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [debug]
ajp_unmarshal_response::jk_ajp_common.c (615): Number of headers is = 1
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [debug]
ajp_unmarshal_response::jk_ajp_common.c (671): Header[0] [Content-Type] =
[text/htm
l;charset=ISO-8859-1]
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_unmarshal_response::jk_ajp_common.c (678): exit
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=4 max=8192
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 00 00 00
00 0
0 00 00 00 00 00 00 00 00 00 - ................
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.022 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 len=73 max=8192
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 45 3C 21
44 4
F 43 54 59 50 45 20 48 54 4D - ..E<!DOCTYPE.HTM
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0010 4C 20 50 55 42
4C 4
9 43 20 22 2D 2F 2F 57 33 43 - L.PUBLIC."-//W3C
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0020 2F 2F 44 54 44
20 4
8 54 4D 4C 20 34 2E 30 31 20 - //DTD.HTML.4.01.
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0030 54 72 61 6E 73
69 7
4 69 6F 6E 61 6C 2F 2F 45 4E - Transitional//EN
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0040 22 3E 0A 3C 68
74 6
D 6C 00 00 00 00 00 00 00 00 - ">.<html........
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [debug] ws_write::mod_jk.c
(455): written 69 out of 69
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.025 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.026 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=4 max=8192
[Fri Aug 22 18:10:58.026 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 00 00 00
00 0
0 00 00 00 00 00 00 00 00 00 - ................
[Fri Aug 22 18:10:58.026 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.026 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=13 max=8192
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 09 3E 0A
20 2
0 3C 68 65 61 64 00 00 00 00 - ...>...<head....
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [debug] ws_write::mod_jk.c
(455): written 9 out of 9
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=4 max=8192
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 00 00 00
00 0
0 00 00 00 00 00 00 00 00 00 - ................
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.027 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=93 max=8192
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 59 3E 0A
20 2
0 20 20 3C 4D 45 54 41 20 68 - ..Y>.....<META.h
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0010 74 74 70 2D 65
71 7
5 69 76 3D 22 43 6F 6E 74 65 - ttp-equiv="Conte
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0020 6E 74 2D 54 79
70 6
5 22 20 63 6F 6E 74 65 6E 74 - nt-Type".content
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0030 3D 22 74 65 78
74 2
F 68 74 6D 6C 3B 20 63 68 61 - ="text/html;.cha
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0040 72 73 65 74 3D
49 5
3 4F 2D 38 38 35 39 2D 31 22 - rset=ISO-8859-1"
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0050 3E 0A 20 20 20
20 3
C 74 69 74 6C 65 00 00 00 00 - >.....<title....
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug] ws_write::mod_jk.c
(455): written 89 out of 89
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=4 max=8192
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 00 00 00
00 0
0 00 00 00 00 00 00 00 00 00 - ................
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.029 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=13 max=8192
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 09 3E 52
69 6
3 65 72 63 61 20 00 00 00 00 - ...>Ricerca.....
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [debug] ws_write::mod_jk.c
(455): written 9 out of 9
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.031 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.032 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=4 max=8192
[Fri Aug 22 18:10:58.032 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): 0000 03 00 00 00 00
00 0
0 00 00 00 00 00 00 00 00 00 - ................
[Fri Aug 22 18:10:58.032 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (1123): exit
[Fri Aug 22 18:10:58.032 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1536): enter
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [trace]
ajp_process_callback::jk_ajp_common.c (1680): exit
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [trace]
ajp_connection_tcp_get_message::jk_ajp_common.c (992): enter
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (768): enter
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [trace]
jk_tcp_socket_recvfull::jk_connect.c (796): exit
[Fri Aug 22 18:10:58.033 2008] [23127:2537062720] [debug]
ajp_connection_tcp_get_message::jk_ajp_common.c (1117): received from ajp13
pos=0 l
en=12 max=8192
... and so on
Looking to tcpdump flow of packets between client and apache web server, I
notice a lots of small packets. With older version of mod_jk, there are instead
fewer packets of bigger size.
Leandro