You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@tomcat.apache.org by Avi Flax <av...@arc90.com> on 2007/04/20 22:23:48 UTC
Tomcat + jk + Apache httpd on Windows 2003 Very Slow
Hi, I'd appreciate some tips here! This is my first Tomcat install,
and I'm new to Java in general.
My setup:
Windows Server 2003, Web Edition, Service Pack 2
32-bit X86 CPU, 2 GB RAM
Apache httpd 2.0.59
mod_jk 1.2.22 for Win32
Apache Tomcat/5.5.23
Sun JVM 1.5.0_09-b01
My problem is that requests which run through mod_jk to httpd respond
very slowly: about 10 seconds to load the Tomcat Status page. If I
access the page directly from Tomcat at port 8080, it's less than a
second.
I've tried lots of different settings, like switching between
JkAutoAlias and JkMount, different JkLogLevels, and other things. I
feel that I must be missing something.
I tried looking at the various log files, and the only thing that
caught my eye was in localhost.log:
Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextDestroyed()
Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextDestroyed()
Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextDestroyed()
Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextDestroyed()
Apr 20, 2007 3:55:20 PM org.apache.catalina.core.ApplicationContext log
INFO: org.apache.webapp.balancer.BalancerFilter: init(): ruleChain:
[org.apache.webapp.balancer.RuleChain:
[org.apache.webapp.balancer.rules.URLStringMatchRule: Target string:
News / Redirect URL: http://www.cnn.com],
[org.apache.webapp.balancer.rules.RequestParameterRule: Target param
name: paramName / Target param value: paramValue / Redirect URL:
http://www.yahoo.com],
[org.apache.webapp.balancer.rules.AcceptEverythingRule: Redirect URL:
http://jakarta.apache.org]]
Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextInitialized()
Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextInitialized()
Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
INFO: ContextListener: contextInitialized()
Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
INFO: SessionListener: contextInitialized()
It looks to me that the web app might be initializing for each request.
If anyone has any ideas, or troubleshooting tips, it'd be greatly appreciated.
Thanks!
--
Avi Flax
Web Services Architect
arc90 | http://arc90.com
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
For additional commands, e-mail: users-help@tomcat.apache.org
Re: Tomcat + jk + Apache httpd on Windows 2003 Very Slow
Posted by Rainer Jung <ra...@kippdata.de>.
OK, but for this request all log lines belonging to the request were
logged during a single second. So there's no indication, hat this
request took a long time (like the 10 seconds you mentioned in your
original post).
Regards,
Rainer
Avi Flax schrieb:
> Rainer, thanks for the suggestion. I set JkLogLevel to debug, and
> here's an example of what shows up in the file for a request:
>
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (2092): Single
> worker (localhost) configuration for /manager/status
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (2111): Into
> handler jakarta-servlet worker=localhost r->proxyreq=0
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_worker.c (114):
> found a worker localhost
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_worker.c (321):
> Maintaining worker localhost
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_worker.c (290):
> Found worker type 'ajp13'
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (607): Service
> protocol=HTTP/1.1 method=GET host=(null) addr=172.17.100.161
> name=java.avif.arc90-dev-01 port=80 auth=(null) user=(null)
> laddr=172.17.200.40 raddr=172.17.100.161
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (2343):
> acquired connection pool slot=0
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (548):
> ajp marshaling done
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1796):
> processing localhost with 2 retries
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> sending to ajp13 pos=4 len=492 max=8192
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0000 12 34 01 E8 02 02 00 08 48 54 54 50 2F 31 2E 31 -
> .4......HTTP/1.1
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0010 00 00 0F 2F 6D 61 6E 61 67 65 72 2F 73 74 61 74 -
> .../manager/stat
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0020 75 73 00 00 0E 31 37 32 2E 31 37 2E 31 30 30 2E -
> us...172.17.100.
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0030 31 36 31 00 FF FF 00 16 6A 61 76 61 2E 61 76 69 -
> 161.....java.avi
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0040 66 2E 61 72 63 39 30 2D 64 65 76 2D 30 31 00 00 -
> f.arc90-dev-01..
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0050 50 00 00 0B A0 0B 00 16 6A 61 76 61 2E 61 76 69 -
> P.......java.avi
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0060 66 2E 61 72 63 39 30 2D 64 65 76 2D 30 31 00 A0 -
> f.arc90-dev-01..
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0070 0E 00 58 4D 6F 7A 69 6C 6C 61 2F 35 2E 30 20 28 -
> ..XMozilla/5.0.(
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0080 4D 61 63 69 6E 74 6F 73 68 3B 20 55 3B 20 49 6E -
> Macintosh;.U;.In
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0090 74 65 6C 20 4D 61 63 20 4F 53 20 58 3B 20 65 6E -
> tel.Mac.OS.X;.en
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 00a0 3B 20 72 76 3A 31 2E 38 2E 31 2E 32 70 72 65 29 -
> ;.rv:1.8.1.2pre)
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 00b0 20 47 65 63 6B 6F 2F 32 30 30 37 30 32 32 33 20 -
> .Gecko/20070223.
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 00c0 43 61 6D 69 6E 6F 2F 31 2E 31 62 00 A0 01 00 63 -
> Camino/1.1b....c
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 00d0 74 65 78 74 2F 78 6D 6C 2C 61 70 70 6C 69 63 61 -
> text/xml,applica
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 00e0 74 69 6F 6E 2F 78 6D 6C 2C 61 70 70 6C 69 63 61 -
> tion/xml,applica
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 00f0 74 69 6F 6E 2F 78 68 74 6D 6C 2B 78 6D 6C 2C 74 -
> tion/xhtml+xml,t
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0100 65 78 74 2F 68 74 6D 6C 3B 71 3D 30 2E 39 2C 74 -
> ext/html;q=0.9,t
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0110 65 78 74 2F 70 6C 61 69 6E 3B 71 3D 30 2E 38 2C -
> ext/plain;q=0.8,
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0120 69 6D 61 67 65 2F 70 6E 67 2C 2A 2F 2A 3B 71 3D -
> image/png,*/*;q=
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0130 30 2E 35 00 A0 04 00 17 65 6E 2D 55 53 2C 65 6E -
> 0.5.....en-US,en
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0140 3B 71 3D 30 2E 37 2C 68 65 3B 71 3D 30 2E 33 00 -
> ;q=0.7,he;q=0.3.
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0150 A0 03 00 0C 67 7A 69 70 2C 64 65 66 6C 61 74 65 -
> ....gzip,deflate
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0160 00 A0 02 00 1E 49 53 4F 2D 38 38 35 39 2D 31 2C -
> .....ISO-8859-1,
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0170 75 74 66 2D 38 3B 71 3D 30 2E 37 2C 2A 3B 71 3D -
> utf-8;q=0.7,*;q=
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0180 30 2E 37 00 00 0A 4B 65 65 70 2D 41 6C 69 76 65 -
> 0.7...Keep-Alive
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 0190 00 00 03 33 30 30 00 A0 06 00 0A 6B 65 65 70 2D -
> ...300.....keep-
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 01a0 61 6C 69 76 65 00 A0 05 00 1E 42 61 73 69 63 20 -
> alive.....Basic.
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 01b0 59 57 52 74 61 57 34 36 56 32 39 73 62 47 6C 77 -
> YWRtaW46V29sbGlw
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 01c0 4D 6A 41 77 4E 51 3D 3D 00 00 0D 43 61 63 68 65 -
> MjAwNQ==...Cache
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 01d0 2D 43 6F 6E 74 72 6F 6C 00 00 09 6D 61 78 2D 61 -
> -Control...max-a
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
> 01e0 67 65 3D 30 00 A0 08 00 01 30 00 FF 00 00 00 00 -
> ge=0.....0......
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1287):
> (localhost) request body to send 0 - request body to resend 0
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> received from ajp13 pos=0 len=164 max=8192
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0000 04 00 C8 00 02 4F 4B 00 00 05 00 06 50 72 61 67 -
> .....OK.....Prag
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0010 6D 61 00 00 08 4E 6F 2D 63 61 63 68 65 00 00 0D -
> ma...No-cache...
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0020 43 61 63 68 65 2D 43 6F 6E 74 72 6F 6C 00 00 08 -
> Cache-Control...
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0030 6E 6F 2D 63 61 63 68 65 00 00 07 45 78 70 69 72 -
> no-cache...Expir
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0040 65 73 00 00 1D 57 65 64 2C 20 33 31 20 44 65 63 -
> es...Wed,.31.Dec
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0050 20 31 39 36 39 20 31 39 3A 30 30 3A 30 30 20 45 -
> .1969.19:00:00.E
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0060 53 54 00 00 0C 43 6F 6E 74 65 6E 74 2D 54 79 70 -
> ST...Content-Typ
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0070 65 00 00 17 74 65 78 74 2F 68 74 6D 6C 3B 63 68 -
> e...text/html;ch
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0080 61 72 73 65 74 3D 75 74 66 2D 38 00 00 0E 43 6F -
> arset=utf-8...Co
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0090 6E 74 65 6E 74 2D 4C 65 6E 67 74 68 00 00 04 35 -
> ntent-Length...5
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00a0 35 31 31 00 00 00 00 00 00 00 00 00 00 00 00 00 -
> 511.............
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (603):
> status = 200
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (610):
> Number of headers is = 5
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
> Header[0] [Pragma] = [No-cache]
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
> Header[1] [Cache-Control] = [no-cache]
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
> Header[2] [Expires] = [Wed, 31 Dec 1969 19:00:00 EST]
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
> Header[3] [Content-Type] = [text/html;charset=utf-8]
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
> Header[4] [Content-Length] = [5511]
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> received from ajp13 pos=0 len=5515 max=8192
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0000 03 15 87 3C 68 74 6D 6C 3E 0A 3C 68 65 61 64 3E -
> ...<html>.<head>
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0010 0A 3C 73 74 79 6C 65 3E 0A 48 31 20 7B 66 6F 6E -
> .<style>.H1.{fon
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0020 74 2D 66 61 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C -
> t-family:Tahoma,
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0030 41 72 69 61 6C 2C 73 61 6E 73 2D 73 65 72 69 66 -
> Arial,sans-serif
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0040 3B 63 6F 6C 6F 72 3A 77 68 69 74 65 3B 62 61 63 -
> ;color:white;bac
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0050 6B 67 72 6F 75 6E 64 2D 63 6F 6C 6F 72 3A 23 35 -
> kground-color:#5
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0060 32 35 44 37 36 3B 66 6F 6E 74 2D 73 69 7A 65 3A -
> 25D76;font-size:
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0070 32 32 70 78 3B 7D 20 48 32 20 7B 66 6F 6E 74 2D -
> 22px;}.H2.{font-
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0080 66 61 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C 41 72 -
> family:Tahoma,Ar
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0090 69 61 6C 2C 73 61 6E 73 2D 73 65 72 69 66 3B 63 -
> ial,sans-serif;c
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00a0 6F 6C 6F 72 3A 77 68 69 74 65 3B 62 61 63 6B 67 -
> olor:white;backg
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00b0 72 6F 75 6E 64 2D 63 6F 6C 6F 72 3A 23 35 32 35 -
> round-color:#525
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00c0 44 37 36 3B 66 6F 6E 74 2D 73 69 7A 65 3A 31 36 -
> D76;font-size:16
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00d0 70 78 3B 7D 20 48 33 20 7B 66 6F 6E 74 2D 66 61 -
> px;}.H3.{font-fa
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00e0 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C 41 72 69 61 -
> mily:Tahoma,Aria
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 00f0 6C 2C 73 61 6E 73 2D 73 65 72 69 66 3B 63 6F 6C -
> l,sans-serif;col
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0100 6F 72 3A 77 68 69 74 65 3B 62 61 63 6B 67 72 6F -
> or:white;backgro
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0110 75 6E 64 2D 63 6F 6C 6F 72 3A 23 35 32 35 44 37 -
> und-color:#525D7
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0120 36 3B 66 6F 6E 74 2D 73 69 7A 65 3A 31 34 70 78 -
> 6;font-size:14px
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0130 3B 7D 20 42 4F 44 59 20 7B 66 6F 6E 74 2D 66 61 -
> ;}.BODY.{font-fa
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0140 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C 41 72 69 61 -
> mily:Tahoma,Aria
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0150 6C 2C 73 61 6E 73 2D 73 65 72 69 66 3B 63 6F 6C -
> l,sans-serif;col
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0160 6F 72 3A 62 6C 61 63 6B 3B 62 61 63 6B 67 72 6F -
> or:black;backgro
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0170 75 6E 64 2D 63 6F 6C 6F 72 3A 77 68 69 74 65 3B -
> und-color:white;
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0180 7D 20 42 20 7B 66 6F 6E 74 2D 66 61 6D 69 6C 79 -
> }.B.{font-family
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0190 3A 54 61 68 6F 6D 61 2C 41 72 69 61 6C 2C 73 61 -
> :Tahoma,Arial,sa
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 01a0 6E 73 2D 73 65 72 69 66 3B 63 6F 6C 6F 72 3A 77 -
> ns-serif;color:w
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 01b0 68 69 74 65 3B 62 61 63 6B 67 72 6F 75 6E 64 2D -
> hite;background-
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 01c0 63 6F 6C 6F 72 3A 23 35 32 35 44 37 36 3B 7D 20 -
> color:#525D76;}.
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 01d0 50 20 7B 66 6F 6E 74 2D 66 61 6D 69 6C 79 3A 54 -
> P.{font-family:T
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 01e0 61 68 6F 6D 61 2C 41 72 69 61 6C 2C 73 61 6E 73 -
> ahoma,Arial,sans
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 01f0 2D 73 65 72 69 66 3B 62 61 63 6B 67 72 6F 75 6E -
> -serif;backgroun
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0200 64 3A 77 68 69 74 65 3B 63 6F 6C 6F 72 3A 62 6C -
> d:white;color:bl
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0210 61 63 6B 3B 66 6F 6E 74 2D 73 69 7A 65 3A 31 32 -
> ack;font-size:12
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0220 70 78 3B 7D 41 20 7B 63 6F 6C 6F 72 20 3A 20 62 -
> px;}A.{color.:.b
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0230 6C 61 63 6B 3B 7D 41 2E 6E 61 6D 65 20 7B 63 6F -
> lack;}A.name.{co
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0240 6C 6F 72 20 3A 20 62 6C 61 63 6B 3B 7D 48 52 20 -
> lor.:.black;}HR.
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0250 7B 63 6F 6C 6F 72 20 3A 20 23 35 32 35 44 37 36 -
> {color.:.#525D76
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0260 3B 7D 20 20 74 61 62 6C 65 20 7B 0A 20 20 20 20 -
> ;}..table.{.....
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0270 77 69 64 74 68 3A 20 31 30 30 25 3B 0A 20 20 7D -
> width:.100%;...}
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0280 0A 20 20 74 64 2E 70 61 67 65 2D 74 69 74 6C 65 -
> ...td.page-title
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0290 20 7B 0A 20 20 20 20 74 65 78 74 2D 61 6C 69 67 -
> .{.....text-alig
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 02a0 6E 3A 20 63 65 6E 74 65 72 3B 0A 20 20 20 20 76 -
> n:.center;.....v
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 02b0 65 72 74 69 63 61 6C 2D 61 6C 69 67 6E 3A 20 74 -
> ertical-align:.t
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 02c0 6F 70 3B 0A 20 20 20 20 66 6F 6E 74 2D 66 61 6D -
> op;.....font-fam
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 02d0 69 6C 79 3A 73 61 6E 73 2D 73 65 72 69 66 2C 54 -
> ily:sans-serif,T
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 02e0 61 68 6F 6D 61 2C 41 72 69 61 6C 3B 0A 20 20 20 -
> ahoma,Arial;....
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 02f0 20 66 6F 6E 74 2D 77 65 69 67 68 74 3A 20 62 6F -
> .font-weight:.bo
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0300 6C 64 3B 0A 20 20 20 20 62 61 63 6B 67 72 6F 75 -
> ld;.....backgrou
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0310 6E 64 3A 20 77 68 69 74 65 3B 0A 20 20 20 20 63 -
> nd:.white;.....c
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0320 6F 6C 6F 72 3A 20 62 6C 61 63 6B 3B 0A 20 20 7D -
> olor:.black;...}
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0330 0A 20 20 74 64 2E 74 69 74 6C 65 20 7B 0A 20 20 -
> ...td.title.{...
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0340 20 20 74 65 78 74 2D 61 6C 69 67 6E 3A 20 6C 65 -
> ..text-align:.le
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0350 66 74 3B 0A 20 20 20 20 76 65 72 74 69 63 61 6C -
> ft;.....vertical
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0360 2D 61 6C 69 67 6E 3A 20 74 6F 70 3B 0A 20 20 20 -
> -align:.top;....
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0370 20 66 6F 6E 74 2D 66 61 6D 69 6C 79 3A 73 61 6E -
> .font-family:san
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0380 73 2D 73 65 72 69 66 2C 54 61 68 6F 6D 61 2C 41 -
> s-serif,Tahoma,A
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0390 72 69 61 6C 3B 0A 20 20 20 20 66 6F 6E 74 2D 73 -
> rial;.....font-s
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 03a0 74 79 6C 65 3A 69 74 61 6C 69 63 3B 0A 20 20 20 -
> tyle:italic;....
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 03b0 20 66 6F 6E 74 2D 77 65 69 67 68 74 3A 20 62 6F -
> .font-weight:.bo
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 03c0 6C 64 3B 0A 20 20 20 20 62 61 63 6B 67 72 6F 75 -
> ld;.....backgrou
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 03d0 6E 64 3A 20 23 44 32 41 34 31 43 3B 0A 20 20 7D -
> nd:.#D2A41C;...}
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 03e0 0A 20 20 74 64 2E 68 65 61 64 65 72 2D 6C 65 66 -
> ...td.header-lef
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 03f0 74 20 7B 0A 20 20 20 20 74 65 78 74 2D 61 6C 69 -
> t.{.....text-ali
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (452): written
> 5511 out of 5511
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> received from ajp13 pos=0 len=2 max=8192
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
> 0000 05 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 -
> ................
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1506):
> AJP13 protocol: Reuse is OK
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (2286):
> recycling connection pool slot=0 for worker localhost
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (2238):
> Service finished with status=200 for worker=localhost
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
> (589): Attempting to map URI '/manager/images/asf-logo.gif' from 1
> maps
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
> (601): Attempting to map context URI '/manager/=localhost' source
> 'JkMount'
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
> (589): Attempting to map URI '/manager/images/asf-logo.gif' from 1
> maps
> [Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
> (601): Attempting to map context URI '/manager/=localhost' source
> 'JkMount'
> [Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
> (589): Attempting to map URI '/manager/images/tomcat.gif' from 1 maps
> [Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
> (601): Attempting to map context URI '/manager/=localhost' source
> 'JkMount'
> [Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
> (589): Attempting to map URI '/manager/images/tomcat.gif' from 1 maps
> [Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
> (601): Attempting to map context URI '/manager/=localhost' source
> 'JkMount'
>
> I don't know how to interpret this. Can anyone help?
>
> Thanks!
> Avi
>
> On 4/20/07, Rainer Jung <ra...@kippdata.de> wrote:
>> If you can reproduce your problem without high load, you can use
>> JkLogLevel debug to understand, which of the steps take the most time.
>> This might give an idea about the root cause.
>>
>> The log contains time stamps and you can post log parts around the
>> moments, where you seem to loose most of the 10 seconds.
>>
>> Regards,
>>
>> Rainer
>>
>> Avi Flax wrote:
>> > Thanks Khalil. I've just read through the article, and it looks good.
>> > But I'm pretty sure that my setup matches the one described there, as
>> > far as I can tell. And it doesn't say anything about way slow
>> > performance with JK. I think I may need some troubleshooting tips.
>> >
>> > Thanks!
>> > Avi
>>
>> ---------------------------------------------------------------------
>> To start a new topic, e-mail: users@tomcat.apache.org
>> To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
>> For additional commands, e-mail: users-help@tomcat.apache.org
>>
>>
>
>
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
For additional commands, e-mail: users-help@tomcat.apache.org
Re: Tomcat + jk + Apache httpd on Windows 2003 Very Slow
Posted by Avi Flax <av...@arc90.com>.
Rainer, thanks for the suggestion. I set JkLogLevel to debug, and
here's an example of what shows up in the file for a request:
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (2092): Single
worker (localhost) configuration for /manager/status
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (2111): Into
handler jakarta-servlet worker=localhost r->proxyreq=0
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_worker.c (114):
found a worker localhost
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_worker.c (321):
Maintaining worker localhost
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_worker.c (290):
Found worker type 'ajp13'
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (607): Service
protocol=HTTP/1.1 method=GET host=(null) addr=172.17.100.161
name=java.avif.arc90-dev-01 port=80 auth=(null) user=(null)
laddr=172.17.200.40 raddr=172.17.100.161
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (2343):
acquired connection pool slot=0
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (548):
ajp marshaling done
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1796):
processing localhost with 2 retries
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
sending to ajp13 pos=4 len=492 max=8192
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0000 12 34 01 E8 02 02 00 08 48 54 54 50 2F 31 2E 31 -
.4......HTTP/1.1
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0010 00 00 0F 2F 6D 61 6E 61 67 65 72 2F 73 74 61 74 -
.../manager/stat
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0020 75 73 00 00 0E 31 37 32 2E 31 37 2E 31 30 30 2E -
us...172.17.100.
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0030 31 36 31 00 FF FF 00 16 6A 61 76 61 2E 61 76 69 -
161.....java.avi
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0040 66 2E 61 72 63 39 30 2D 64 65 76 2D 30 31 00 00 -
f.arc90-dev-01..
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0050 50 00 00 0B A0 0B 00 16 6A 61 76 61 2E 61 76 69 -
P.......java.avi
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0060 66 2E 61 72 63 39 30 2D 64 65 76 2D 30 31 00 A0 -
f.arc90-dev-01..
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0070 0E 00 58 4D 6F 7A 69 6C 6C 61 2F 35 2E 30 20 28 -
..XMozilla/5.0.(
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0080 4D 61 63 69 6E 74 6F 73 68 3B 20 55 3B 20 49 6E -
Macintosh;.U;.In
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0090 74 65 6C 20 4D 61 63 20 4F 53 20 58 3B 20 65 6E -
tel.Mac.OS.X;.en
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
00a0 3B 20 72 76 3A 31 2E 38 2E 31 2E 32 70 72 65 29 -
;.rv:1.8.1.2pre)
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
00b0 20 47 65 63 6B 6F 2F 32 30 30 37 30 32 32 33 20 -
.Gecko/20070223.
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
00c0 43 61 6D 69 6E 6F 2F 31 2E 31 62 00 A0 01 00 63 -
Camino/1.1b....c
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
00d0 74 65 78 74 2F 78 6D 6C 2C 61 70 70 6C 69 63 61 -
text/xml,applica
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
00e0 74 69 6F 6E 2F 78 6D 6C 2C 61 70 70 6C 69 63 61 -
tion/xml,applica
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
00f0 74 69 6F 6E 2F 78 68 74 6D 6C 2B 78 6D 6C 2C 74 -
tion/xhtml+xml,t
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0100 65 78 74 2F 68 74 6D 6C 3B 71 3D 30 2E 39 2C 74 -
ext/html;q=0.9,t
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0110 65 78 74 2F 70 6C 61 69 6E 3B 71 3D 30 2E 38 2C -
ext/plain;q=0.8,
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0120 69 6D 61 67 65 2F 70 6E 67 2C 2A 2F 2A 3B 71 3D -
image/png,*/*;q=
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0130 30 2E 35 00 A0 04 00 17 65 6E 2D 55 53 2C 65 6E -
0.5.....en-US,en
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0140 3B 71 3D 30 2E 37 2C 68 65 3B 71 3D 30 2E 33 00 -
;q=0.7,he;q=0.3.
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0150 A0 03 00 0C 67 7A 69 70 2C 64 65 66 6C 61 74 65 -
....gzip,deflate
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0160 00 A0 02 00 1E 49 53 4F 2D 38 38 35 39 2D 31 2C -
.....ISO-8859-1,
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0170 75 74 66 2D 38 3B 71 3D 30 2E 37 2C 2A 3B 71 3D -
utf-8;q=0.7,*;q=
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0180 30 2E 37 00 00 0A 4B 65 65 70 2D 41 6C 69 76 65 -
0.7...Keep-Alive
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
0190 00 00 03 33 30 30 00 A0 06 00 0A 6B 65 65 70 2D -
...300.....keep-
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
01a0 61 6C 69 76 65 00 A0 05 00 1E 42 61 73 69 63 20 -
alive.....Basic.
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
01b0 59 57 52 74 61 57 34 36 56 32 39 73 62 47 6C 77 -
YWRtaW46V29sbGlw
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
01c0 4D 6A 41 77 4E 51 3D 3D 00 00 0D 43 61 63 68 65 -
MjAwNQ==...Cache
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
01d0 2D 43 6F 6E 74 72 6F 6C 00 00 09 6D 61 78 2D 61 -
-Control...max-a
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (896):
01e0 67 65 3D 30 00 A0 08 00 01 30 00 FF 00 00 00 00 -
ge=0.....0......
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1287):
(localhost) request body to send 0 - request body to resend 0
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
received from ajp13 pos=0 len=164 max=8192
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0000 04 00 C8 00 02 4F 4B 00 00 05 00 06 50 72 61 67 -
.....OK.....Prag
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0010 6D 61 00 00 08 4E 6F 2D 63 61 63 68 65 00 00 0D -
ma...No-cache...
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0020 43 61 63 68 65 2D 43 6F 6E 74 72 6F 6C 00 00 08 -
Cache-Control...
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0030 6E 6F 2D 63 61 63 68 65 00 00 07 45 78 70 69 72 -
no-cache...Expir
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0040 65 73 00 00 1D 57 65 64 2C 20 33 31 20 44 65 63 -
es...Wed,.31.Dec
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0050 20 31 39 36 39 20 31 39 3A 30 30 3A 30 30 20 45 -
.1969.19:00:00.E
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0060 53 54 00 00 0C 43 6F 6E 74 65 6E 74 2D 54 79 70 -
ST...Content-Typ
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0070 65 00 00 17 74 65 78 74 2F 68 74 6D 6C 3B 63 68 -
e...text/html;ch
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0080 61 72 73 65 74 3D 75 74 66 2D 38 00 00 0E 43 6F -
arset=utf-8...Co
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0090 6E 74 65 6E 74 2D 4C 65 6E 67 74 68 00 00 04 35 -
ntent-Length...5
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00a0 35 31 31 00 00 00 00 00 00 00 00 00 00 00 00 00 -
511.............
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (603):
status = 200
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (610):
Number of headers is = 5
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
Header[0] [Pragma] = [No-cache]
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
Header[1] [Cache-Control] = [no-cache]
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
Header[2] [Expires] = [Wed, 31 Dec 1969 19:00:00 EST]
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
Header[3] [Content-Type] = [text/html;charset=utf-8]
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (666):
Header[4] [Content-Length] = [5511]
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
received from ajp13 pos=0 len=5515 max=8192
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0000 03 15 87 3C 68 74 6D 6C 3E 0A 3C 68 65 61 64 3E -
...<html>.<head>
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0010 0A 3C 73 74 79 6C 65 3E 0A 48 31 20 7B 66 6F 6E -
.<style>.H1.{fon
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0020 74 2D 66 61 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C -
t-family:Tahoma,
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0030 41 72 69 61 6C 2C 73 61 6E 73 2D 73 65 72 69 66 -
Arial,sans-serif
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0040 3B 63 6F 6C 6F 72 3A 77 68 69 74 65 3B 62 61 63 -
;color:white;bac
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0050 6B 67 72 6F 75 6E 64 2D 63 6F 6C 6F 72 3A 23 35 -
kground-color:#5
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0060 32 35 44 37 36 3B 66 6F 6E 74 2D 73 69 7A 65 3A -
25D76;font-size:
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0070 32 32 70 78 3B 7D 20 48 32 20 7B 66 6F 6E 74 2D -
22px;}.H2.{font-
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0080 66 61 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C 41 72 -
family:Tahoma,Ar
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0090 69 61 6C 2C 73 61 6E 73 2D 73 65 72 69 66 3B 63 -
ial,sans-serif;c
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00a0 6F 6C 6F 72 3A 77 68 69 74 65 3B 62 61 63 6B 67 -
olor:white;backg
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00b0 72 6F 75 6E 64 2D 63 6F 6C 6F 72 3A 23 35 32 35 -
round-color:#525
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00c0 44 37 36 3B 66 6F 6E 74 2D 73 69 7A 65 3A 31 36 -
D76;font-size:16
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00d0 70 78 3B 7D 20 48 33 20 7B 66 6F 6E 74 2D 66 61 -
px;}.H3.{font-fa
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00e0 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C 41 72 69 61 -
mily:Tahoma,Aria
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
00f0 6C 2C 73 61 6E 73 2D 73 65 72 69 66 3B 63 6F 6C -
l,sans-serif;col
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0100 6F 72 3A 77 68 69 74 65 3B 62 61 63 6B 67 72 6F -
or:white;backgro
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0110 75 6E 64 2D 63 6F 6C 6F 72 3A 23 35 32 35 44 37 -
und-color:#525D7
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0120 36 3B 66 6F 6E 74 2D 73 69 7A 65 3A 31 34 70 78 -
6;font-size:14px
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0130 3B 7D 20 42 4F 44 59 20 7B 66 6F 6E 74 2D 66 61 -
;}.BODY.{font-fa
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0140 6D 69 6C 79 3A 54 61 68 6F 6D 61 2C 41 72 69 61 -
mily:Tahoma,Aria
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0150 6C 2C 73 61 6E 73 2D 73 65 72 69 66 3B 63 6F 6C -
l,sans-serif;col
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0160 6F 72 3A 62 6C 61 63 6B 3B 62 61 63 6B 67 72 6F -
or:black;backgro
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0170 75 6E 64 2D 63 6F 6C 6F 72 3A 77 68 69 74 65 3B -
und-color:white;
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0180 7D 20 42 20 7B 66 6F 6E 74 2D 66 61 6D 69 6C 79 -
}.B.{font-family
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0190 3A 54 61 68 6F 6D 61 2C 41 72 69 61 6C 2C 73 61 -
:Tahoma,Arial,sa
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
01a0 6E 73 2D 73 65 72 69 66 3B 63 6F 6C 6F 72 3A 77 -
ns-serif;color:w
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
01b0 68 69 74 65 3B 62 61 63 6B 67 72 6F 75 6E 64 2D -
hite;background-
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
01c0 63 6F 6C 6F 72 3A 23 35 32 35 44 37 36 3B 7D 20 -
color:#525D76;}.
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
01d0 50 20 7B 66 6F 6E 74 2D 66 61 6D 69 6C 79 3A 54 -
P.{font-family:T
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
01e0 61 68 6F 6D 61 2C 41 72 69 61 6C 2C 73 61 6E 73 -
ahoma,Arial,sans
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
01f0 2D 73 65 72 69 66 3B 62 61 63 6B 67 72 6F 75 6E -
-serif;backgroun
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0200 64 3A 77 68 69 74 65 3B 63 6F 6C 6F 72 3A 62 6C -
d:white;color:bl
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0210 61 63 6B 3B 66 6F 6E 74 2D 73 69 7A 65 3A 31 32 -
ack;font-size:12
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0220 70 78 3B 7D 41 20 7B 63 6F 6C 6F 72 20 3A 20 62 -
px;}A.{color.:.b
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0230 6C 61 63 6B 3B 7D 41 2E 6E 61 6D 65 20 7B 63 6F -
lack;}A.name.{co
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0240 6C 6F 72 20 3A 20 62 6C 61 63 6B 3B 7D 48 52 20 -
lor.:.black;}HR.
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0250 7B 63 6F 6C 6F 72 20 3A 20 23 35 32 35 44 37 36 -
{color.:.#525D76
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0260 3B 7D 20 20 74 61 62 6C 65 20 7B 0A 20 20 20 20 -
;}..table.{.....
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0270 77 69 64 74 68 3A 20 31 30 30 25 3B 0A 20 20 7D -
width:.100%;...}
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0280 0A 20 20 74 64 2E 70 61 67 65 2D 74 69 74 6C 65 -
...td.page-title
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0290 20 7B 0A 20 20 20 20 74 65 78 74 2D 61 6C 69 67 -
.{.....text-alig
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
02a0 6E 3A 20 63 65 6E 74 65 72 3B 0A 20 20 20 20 76 -
n:.center;.....v
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
02b0 65 72 74 69 63 61 6C 2D 61 6C 69 67 6E 3A 20 74 -
ertical-align:.t
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
02c0 6F 70 3B 0A 20 20 20 20 66 6F 6E 74 2D 66 61 6D -
op;.....font-fam
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
02d0 69 6C 79 3A 73 61 6E 73 2D 73 65 72 69 66 2C 54 -
ily:sans-serif,T
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
02e0 61 68 6F 6D 61 2C 41 72 69 61 6C 3B 0A 20 20 20 -
ahoma,Arial;....
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
02f0 20 66 6F 6E 74 2D 77 65 69 67 68 74 3A 20 62 6F -
.font-weight:.bo
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0300 6C 64 3B 0A 20 20 20 20 62 61 63 6B 67 72 6F 75 -
ld;.....backgrou
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0310 6E 64 3A 20 77 68 69 74 65 3B 0A 20 20 20 20 63 -
nd:.white;.....c
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0320 6F 6C 6F 72 3A 20 62 6C 61 63 6B 3B 0A 20 20 7D -
olor:.black;...}
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0330 0A 20 20 74 64 2E 74 69 74 6C 65 20 7B 0A 20 20 -
...td.title.{...
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0340 20 20 74 65 78 74 2D 61 6C 69 67 6E 3A 20 6C 65 -
..text-align:.le
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0350 66 74 3B 0A 20 20 20 20 76 65 72 74 69 63 61 6C -
ft;.....vertical
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0360 2D 61 6C 69 67 6E 3A 20 74 6F 70 3B 0A 20 20 20 -
-align:.top;....
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0370 20 66 6F 6E 74 2D 66 61 6D 69 6C 79 3A 73 61 6E -
.font-family:san
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0380 73 2D 73 65 72 69 66 2C 54 61 68 6F 6D 61 2C 41 -
s-serif,Tahoma,A
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0390 72 69 61 6C 3B 0A 20 20 20 20 66 6F 6E 74 2D 73 -
rial;.....font-s
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
03a0 74 79 6C 65 3A 69 74 61 6C 69 63 3B 0A 20 20 20 -
tyle:italic;....
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
03b0 20 66 6F 6E 74 2D 77 65 69 67 68 74 3A 20 62 6F -
.font-weight:.bo
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
03c0 6C 64 3B 0A 20 20 20 20 62 61 63 6B 67 72 6F 75 -
ld;.....backgrou
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
03d0 6E 64 3A 20 23 44 32 41 34 31 43 3B 0A 20 20 7D -
nd:.#D2A41C;...}
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
03e0 0A 20 20 74 64 2E 68 65 61 64 65 72 2D 6C 65 66 -
...td.header-lef
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
03f0 74 20 7B 0A 20 20 20 20 74 65 78 74 2D 61 6C 69 -
t.{.....text-ali
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (452): written
5511 out of 5511
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
received from ajp13 pos=0 len=2 max=8192
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1043):
0000 05 01 00 00 00 00 00 00 00 00 00 00 00 00 00 00 -
................
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (1506):
AJP13 protocol: Reuse is OK
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_ajp_common.c (2286):
recycling connection pool slot=0 for worker localhost
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] mod_jk.c (2238):
Service finished with status=200 for worker=localhost
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
(589): Attempting to map URI '/manager/images/asf-logo.gif' from 1
maps
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
(601): Attempting to map context URI '/manager/=localhost' source
'JkMount'
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
(589): Attempting to map URI '/manager/images/asf-logo.gif' from 1
maps
[Mon Apr 23 13:47:46 2007] [1188:2392] [debug] jk_uri_worker_map.c
(601): Attempting to map context URI '/manager/=localhost' source
'JkMount'
[Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
(589): Attempting to map URI '/manager/images/tomcat.gif' from 1 maps
[Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
(601): Attempting to map context URI '/manager/=localhost' source
'JkMount'
[Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
(589): Attempting to map URI '/manager/images/tomcat.gif' from 1 maps
[Mon Apr 23 13:47:46 2007] [1188:2244] [debug] jk_uri_worker_map.c
(601): Attempting to map context URI '/manager/=localhost' source
'JkMount'
I don't know how to interpret this. Can anyone help?
Thanks!
Avi
On 4/20/07, Rainer Jung <ra...@kippdata.de> wrote:
> If you can reproduce your problem without high load, you can use
> JkLogLevel debug to understand, which of the steps take the most time.
> This might give an idea about the root cause.
>
> The log contains time stamps and you can post log parts around the
> moments, where you seem to loose most of the 10 seconds.
>
> Regards,
>
> Rainer
>
> Avi Flax wrote:
> > Thanks Khalil. I've just read through the article, and it looks good.
> > But I'm pretty sure that my setup matches the one described there, as
> > far as I can tell. And it doesn't say anything about way slow
> > performance with JK. I think I may need some troubleshooting tips.
> >
> > Thanks!
> > Avi
>
> ---------------------------------------------------------------------
> To start a new topic, e-mail: users@tomcat.apache.org
> To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
> For additional commands, e-mail: users-help@tomcat.apache.org
>
>
--
Avi Flax
Web Services Architect
arc90 | http://arc90.com
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
For additional commands, e-mail: users-help@tomcat.apache.org
Re: Tomcat + jk + Apache httpd on Windows 2003 Very Slow
Posted by Rainer Jung <ra...@kippdata.de>.
If you can reproduce your problem without high load, you can use
JkLogLevel debug to understand, which of the steps take the most time.
This might give an idea about the root cause.
The log contains time stamps and you can post log parts around the
moments, where you seem to loose most of the 10 seconds.
Regards,
Rainer
Avi Flax wrote:
> Thanks Khalil. I've just read through the article, and it looks good.
> But I'm pretty sure that my setup matches the one described there, as
> far as I can tell. And it doesn't say anything about way slow
> performance with JK. I think I may need some troubleshooting tips.
>
> Thanks!
> Avi
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
For additional commands, e-mail: users-help@tomcat.apache.org
Re: Tomcat + jk + Apache httpd on Windows 2003 Very Slow
Posted by Avi Flax <av...@arc90.com>.
Thanks Khalil. I've just read through the article, and it looks good.
But I'm pretty sure that my setup matches the one described there, as
far as I can tell. And it doesn't say anything about way slow
performance with JK. I think I may need some troubleshooting tips.
Thanks!
Avi
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
For additional commands, e-mail: users-help@tomcat.apache.org
Re: Tomcat + jk + Apache httpd on Windows 2003 Very Slow
Posted by Khalil <kh...@comcast.net>.
Avi,
Take a look at this article
http://confluence.atlassian.com/display/DOC/Using+Apache+with+mod_jk
Regards,
Khalil
----- Original Message -----
From: "Avi Flax" <av...@arc90.com>
To: <us...@tomcat.apache.org>
Sent: Friday, April 20, 2007 3:23 PM
Subject: Tomcat + jk + Apache httpd on Windows 2003 Very Slow
> Hi, I'd appreciate some tips here! This is my first Tomcat install,
> and I'm new to Java in general.
>
> My setup:
>
> Windows Server 2003, Web Edition, Service Pack 2
> 32-bit X86 CPU, 2 GB RAM
> Apache httpd 2.0.59
> mod_jk 1.2.22 for Win32
> Apache Tomcat/5.5.23
> Sun JVM 1.5.0_09-b01
>
> My problem is that requests which run through mod_jk to httpd respond
> very slowly: about 10 seconds to load the Tomcat Status page. If I
> access the page directly from Tomcat at port 8080, it's less than a
> second.
>
> I've tried lots of different settings, like switching between
> JkAutoAlias and JkMount, different JkLogLevels, and other things. I
> feel that I must be missing something.
>
> I tried looking at the various log files, and the only thing that
> caught my eye was in localhost.log:
>
> Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
> INFO: SessionListener: contextDestroyed()
> Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
> INFO: ContextListener: contextDestroyed()
> Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
> INFO: SessionListener: contextDestroyed()
> Apr 20, 2007 3:55:15 PM org.apache.catalina.core.ApplicationContext log
> INFO: ContextListener: contextDestroyed()
> Apr 20, 2007 3:55:20 PM org.apache.catalina.core.ApplicationContext log
> INFO: org.apache.webapp.balancer.BalancerFilter: init(): ruleChain:
> [org.apache.webapp.balancer.RuleChain:
> [org.apache.webapp.balancer.rules.URLStringMatchRule: Target string:
> News / Redirect URL: http://www.cnn.com],
> [org.apache.webapp.balancer.rules.RequestParameterRule: Target param
> name: paramName / Target param value: paramValue / Redirect URL:
> http://www.yahoo.com],
> [org.apache.webapp.balancer.rules.AcceptEverythingRule: Redirect URL:
> http://jakarta.apache.org]]
> Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
> INFO: ContextListener: contextInitialized()
> Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
> INFO: SessionListener: contextInitialized()
> Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
> INFO: ContextListener: contextInitialized()
> Apr 20, 2007 3:55:21 PM org.apache.catalina.core.ApplicationContext log
> INFO: SessionListener: contextInitialized()
>
> It looks to me that the web app might be initializing for each request.
>
> If anyone has any ideas, or troubleshooting tips, it'd be greatly
> appreciated.
>
> Thanks!
>
> --
> Avi Flax
> Web Services Architect
> arc90 | http://arc90.com
>
> ---------------------------------------------------------------------
> To start a new topic, e-mail: users@tomcat.apache.org
> To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
> For additional commands, e-mail: users-help@tomcat.apache.org
>
---------------------------------------------------------------------
To start a new topic, e-mail: users@tomcat.apache.org
To unsubscribe, e-mail: users-unsubscribe@tomcat.apache.org
For additional commands, e-mail: users-help@tomcat.apache.org