Hi,

On 25.11.2009 17:56, Steve Neidinger wrote:
> Greetings,
> 
> I'm setting up a new apache system using mod_jk to talk to 8 JBoss
> instances on a separate server and I'm seeing a lot of entries in the
> mod_jk.log that I find troubling. Here is a snippet:
> 
> [Wed Nov 25 10:32:31.727 2009] [9435:2088340368] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber8server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.755 2009] [8698:2812140432] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber2server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.779 2009] [9229:2885569424] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber5server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.797 2009] [9538:2610826128] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:31.848 2009] [9849:2140789648] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber1server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.868 2009] [8691:2948508560] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber1server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.869 2009] [9229:2990467984] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber1server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.869 2009] [9229:2990467984] [info]
> ajp_send_request::jk_ajp_common.c (1456):
> (jbossjvmnumber1server-app01) all endpoints are disconnected, detected
> by connect check (0), cping (1), send (0)
> [Wed Nov 25 10:32:31.873 2009] [9538:2526907280] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:31.913 2009] [8689:2035891088] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:31.916 2009] [8689:2969488272] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:31.918 2009] [8698:2298137488] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:31.933 2009] [9952:2591853456] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:31.938 2009] [9538:2610826128] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber4server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:31.938 2009] [9538:2610826128] [info]
> ajp_send_request::jk_ajp_common.c (1456):
> (jbossjvmnumber4server-app01) all endpoints are disconnected, detected
> by connect check (0), cping (1), send (0)
> [Wed Nov 25 10:32:32.002 2009] [8764:2130299792] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:32.030 2009] [9538:2526907280] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber4server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> [Wed Nov 25 10:32:32.030 2009] [9538:2526907280] [warn]
> ajp_handle_cping_cpong::jk_ajp_common.c (883): awaited reply cpong,
> received 3 instead
> [Wed Nov 25 10:32:32.068 2009] [8689:2035891088] [info]
> ajp_send_request::jk_ajp_common.c (1402):
> (jbossjvmnumber4server-app01) failed sending request, socket -1
> prepost cping/cpong failure (errno=0)
> 
> Here is a portion of my worker.properties file:
> 
> # Define the common template
> worker.template.type=ajp13
> worker.template.port=8009
> worker.template.lbfactor=1
> worker.template.socket_connect_timeout=5000
> worker.template.connection_pool_timeout=600
> worker.template.ping_mode=A
> worker.template.ping_timeout=10000
> worker.template.reply_timeout=300000
> worker.template.fail_on_status=404,500,503
> worker.template.recovery_options=7
> worker.template.connection_pool_minsize=0
> worker.template.socket_keepalive=True
> worker.template.retries=2
> 
> I've googled and can't find any specific help on these errors.
> Hopefully someone can help on this.

I guess this is a known JBoss bug. I had to analyze it recently. The
JBoss server in that case sended an additional response packet of size 0
after the final response packet. That's a protocol violation.

When mod_jk sends a cping in front of the next request, JBoss answers
correctly with a cpong, but mod_jk reading from the network buffer first
gets the empty response packet left over from the previous response and
complains, because it's not the cpong packet.

You should file a bug at JBoss for this.

Regards,

Rainer

---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscr...@tomcat.apache.org
For additional commands, e-mail: users-h...@tomcat.apache.org

Reply via email to