Mailing-List: contact users-help@tomcat.apache.org; run by ezmlm
Precedence: bulk
Reply-To: "Tomcat Users List" <users@tomcat.apache.org>
Received-SPF: pass (athena.apache.org: local policy)
Message-ID: <492D4BE3.9060207@ice-sa.com>
Date: Wed, 26 Nov 2008 14:15:15 +0100
From: =?ISO-8859-1?Q?Andr=E9_Warnier?= <aw@ice-sa.com>
User-Agent: Thunderbird 2.0.0.16 (Windows/20080708)
MIME-Version: 1.0
To: Tomcat Users List <users@tomcat.apache.org>
Subject: JK connector issues ?
Content-Type: text/plain; charset=ISO-8859-1; format=flowed
Content-Transfer-Encoding: 8bit

Hi.

Apache 2.0.52
Tomcat 5.5.20
mod_jk 1.2.x (sorry, don't know the exact version)
OS : Linux (hostname) 2.6.9-67.0.15.ELsmp #1 SMP Tue Apr 22 13:58:43 EDT 
2008 x86_64 x86_64 x86_64 GNU/Linux
(Red Hat Enterprise Linux)
all the above on the same host.

At a customer site we find repeated traces like the one below in the 
catalina.out logfile.

I would just like to know if my analysis is correct in that these 
indicate a problem at the point where Tomcat is trying to send a 
response back to Apache through the Jk/mod_jk connector.
And, if someone has an idea of where the problem might lie, that would 
be very welcome too.
Or an idea as to what else we could activate or examine that would allow 
us to narrow down the problem.

(Note : we sometimes get such traces at a frequency and within such 
short intervals, that it seems unlikely that a number of users (or the 
same user) could press the "cancel" button in their browser fast enough.
But then one never knows.)

(Note also : on the same host, we have been experiencing other rather 
unique problems of perl programs seeming to crash for no reason, 
apparently during network-related operations, the same programs running 
flawlessly at numerous other sites.  So I am not entirely sure at this 
point that the problems originate in Apache or Tomcat.)


Thanks in advance
Andr�


Sample catalina.out :

26.11.2008 13:20:01 org.apache.jk.core.MsgContext action
WARNUNG: Error sending end packet
java.net.SocketException: Broken pipe
	at java.net.SocketOutputStream.socketWrite0(Native Method)
	at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:92)
	at java.net.SocketOutputStream.write(SocketOutputStream.java:136)
	at org.apache.jk.common.ChannelSocket.send(ChannelSocket.java:531)
	at org.apache.jk.common.JkInputStream.endMessage(JkInputStream.java:112)
	at org.apache.jk.core.MsgContext.action(MsgContext.java:293)
	at org.apache.coyote.Response.action(Response.java:182)
	at org.apache.coyote.Response.finish(Response.java:304)
	at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:204)
	at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:282)
	at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:767)
	at 
org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:697)
	at 
org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:889)
	at 
org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684)
	at java.lang.Thread.run(Thread.java:619)
26.11.2008 13:20:01 org.apache.jk.common.ChannelSocket processConnection
WARNUNG: processCallbacks status 2

[some time later]

26.11.2008 13:33:06 org.apache.jk.core.MsgContext action
WARNUNG: Error sending end packet
java.net.SocketException: Broken pipe
	at java.net.SocketOutputStream.socketWrite0(Native Method)
	at java.net.SocketOutputStream.socketWrite(SocketOutputStream.java:92)
	at java.net.SocketOutputStream.write(SocketOutputStream.java:136)
	at org.apache.jk.common.ChannelSocket.send(ChannelSocket.java:531)
	at org.apache.jk.common.JkInputStream.endMessage(JkInputStream.java:112)
	at org.apache.jk.core.MsgContext.action(MsgContext.java:293)
	at org.apache.coyote.Response.action(Response.java:182)
	at org.apache.coyote.Response.finish(Response.java:304)
	at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:204)
	at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:282)
	at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:767)
	at 
org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:697)
	at 
org.apache.jk.common.ChannelSocket$SocketConnection.runIt(ChannelSocket.java:889)
	at 
org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684)
	at java.lang.Thread.run(Thread.java:619)
26.11.2008 13:33:06 org.apache.jk.common.ChannelSocket processConnection
WARNUNG: processCallbacks status 2


Sample mod_jk logfile (level INFO):

[Wed Nov 26 13:19:42 2008] [14572:4416] [info] 
ajp_send_request::jk_ajp_common.c (1244): (ajp13) increase the backend 
idle connection timeout or the connection_pool_minsize
[Wed Nov 26 13:19:42 2008] [14572:4416] [info] 
ajp_service::jk_ajp_common.c (1930): (ajp13) sending request to tomcat 
failed,  recoverable operation attempt=1
[Wed Nov 26 13:20:06 2008] [14637:4416] [info] 
ajp_process_callback::jk_ajp_common.c (1447): Writing to client aborted 
or client network problems
[Wed Nov 26 13:20:06 2008] [14637:4416] [info] 
ajp_service::jk_ajp_common.c (1846): (ajp13) request failed, because of 
client write error without recovery in send loop attempt=0
[Wed Nov 26 13:20:06 2008] [14637:4416] [info]  jk_handler::mod_jk.c 
(2190): Aborting connection for worker=ajp13
[Wed Nov 26 13:22:33 2008] [14710:4416] [info] 
ajp_send_request::jk_ajp_common.c (1215): (ajp13) error sending request. 
Will try another pooled connection
[Wed Nov 26 13:22:33 2008] [14710:4416] [info] 
ajp_send_request::jk_ajp_common.c (1241): (ajp13) all endpoints are 
disconnected
[Wed Nov 26 13:22:33 2008] [14710:4416] [info] 
ajp_send_request::jk_ajp_common.c (1244): (ajp13) increase the backend 
idle connection timeout or the connection_pool_minsize
[Wed Nov 26 13:22:33 2008] [14710:4416] [info] 
ajp_service::jk_ajp_common.c (1930): (ajp13) sending request to tomcat 
failed,  recoverable operation attempt=1
[Wed Nov 26 13:22:52 2008] [14806:4416] [info] 
ajp_send_request::jk_ajp_common.c (1215): (ajp13) error sending request. 
Will try another pooled connection
[Wed Nov 26 13:22:52 2008] [14806:4416] [info] 
ajp_send_request::jk_ajp_common.c (1241): (ajp13) all endpoints are 
disconnected
[Wed Nov 26 13:22:52 2008] [14806:4416] [info] 
ajp_send_request::jk_ajp_common.c (1244): (ajp13) increase the backend 
idle connection timeout or the connection_pool_minsize
[Wed Nov 26 13:22:52 2008] [14806:4416] [info] 
ajp_service::jk_ajp_common.c (1930): (ajp13) sending request to tomcat 
failed,  recoverable operation attempt=1
[Wed Nov 26 13:23:32 2008] [14901:4416] [info] 
ajp_process_callback::jk_ajp_common.c (1447): Writing to client aborted 
or client network problems
[Wed Nov 26 13:23:32 2008] [14901:4416] [info] 
ajp_service::jk_ajp_common.c (1846): (ajp13) request failed, because of 
client write error without recovery in send loop attempt=0
[Wed Nov 26 13:23:32 2008] [14901:4416] [info]  jk_handler::mod_jk.c 
(2190): Aborting connection for worker=ajp13
[Wed Nov 26 13:23:59 2008] [14907:4416] [info] 
ajp_send_request::jk_ajp_common.c (1215): (ajp13) error sending request. 
Will try another pooled connection
[Wed Nov 26 13:23:59 2008] [14907:4416] [info] 
ajp_send_request::jk_ajp_common.c (1241): (ajp13) all endpoints are 
disconnected
[Wed Nov 26 13:23:59 2008] [14907:4416] [info] 
ajp_send_request::jk_ajp_common.c (1244): (ajp13) increase the backend 
idle connection timeout or the connection_pool_minsize
[Wed Nov 26 13:23:59 2008] [14907:4416] [info] 
ajp_service::jk_ajp_common.c (1930): (ajp13) sending request to tomcat 
failed,  recoverable operation attempt=1

[...]


---------------------------------------------------------------------
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