Java Mailing List Archive

http://www.junlu.com/

Home » Home (12/2007) » Tomcat Users »

Stability problems using Apache / Tomcat / jk2

Trond G. Ziarkowski

2004-10-20

Replies:

System:
Debian "testing" i386
jdk1.5.0
Tomcat 5.0.28 - CATALINA_OPTS -ms64m -mx128m
Apache 2.0.52-1
libapache-mod-jk2 2.0.4-3
MySQL 4.0.21-7
mysql-connector-java-3.0.15-ga

Tomcat is running a service called Tomcat-Apache, an engine called
Apache with
a host called localhost. localhost has the /admin and /manager webapps
and my webapp, /mediaport, using precompiled jsp pages and Servlets, and a
connection pool to MySQL.

Configurations:
Apache configuration is default debian config

server.xml service definition:
<Service name="Tomcat-Apache">
  <Connector
  port="8009"
  debug="0"
  protocol="AJP/1.3" />

  <Engine name="Apache" defaultHost="localhost" debug="0">
  <Realm
  className="org.apache.catalina.realm.MemoryRealm"
  pathname="conf/tomcat-users.xml"/>
 
  <Logger
  className="org.apache.catalina.logger.FileLogger"
  prefix="apache."
  suffix=".log"
  timestamp="true"/>
 
  <Host
  name="localhost"
  debug="0"
  appBase="webapps"
  unpackWARs="true"
  autoDeploy="false"
  deployOnStartup="true"
  xmlValidation="true"
  xmlNamespaceAware="true">
 
  <Logger
  className="org.apache.catalina.logger.FileLogger"
  prefix="localhost."
  suffix=".log"
  timestamp="true"/>
 
  </Host>
  </Engine>
</Service>


workers2.properties:
[logger]
info=Native logger
level=ERROR

[config:]
file=${serverRoot}/conf/workers2.properties
debug=0
debugEnv=0

[uriMap:]
info=Maps the requests.
debug=0

[shm:]
info=Scoreboard. Required for reconfiguration and status with
multiprocess servers
file=anonymous
debug=0

[workerEnv:]
info=Global server options
timing=0
debug=0

[lb:lb]
info=Default load balancer.
debug=0

[channel.socket:localhost:8009]
info=Ajp13 forwarding over socket
debug=0
tomcatId=localhost:8009

[status:]
[uri:/jkstatus]
group=status:

[uri:/admin/*]
info=Tomcat HTML based administration web application.
debug=0

[uri:/manager/*]
info=A scriptable management web application for the Tomcat Web Server.
debug=0

[uri:/mediaport/*.jsp]
[uri:/mediaport/servlet/*]

Here are my problems

1. Strange log message
This message shows up frequently in error.log:
[Tue Oct 19 17:14:40 2004] [error] ajp13.service() ajpGetReply
recoverable error 3
[Tue Oct 19 17:14:40 2004] [error] ajp13.service() ajpGetReply
recoverable error 3
[Tue Oct 19 17:14:40 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 0
[Tue Oct 19 17:14:40 2004] [error] mod_jk2.handler() Error connecting to
tomcat 3, status 200


2. Serious stability problem
Sometimes tomcat "stops" and gives a 500 error. This seems to happen at
times
when load is high, but happens every once in a while when load is low as
well.
A restart of Tomcat does the work. This results in having to restart
tomcat at
least 2-3 times a day.

This is what show up in the logs

catalina.out:
19.okt.2004 17:14:43 org.apache.coyote.tomcat5.CoyoteConnector pause
SEVERE: Protocol handler pause failed
java.net.ConnectException: Connection refused
  at java.net.PlainSocketImpl.socketConnect(Native Method)
  at java.net.PlainSocketImpl.doConnect (PlainSocketImpl.java:333)
  at java.net.PlainSocketImpl.connectToAddress (PlainSocketImpl.java:195)
  at java.net.PlainSocketImpl.connect (PlainSocketImpl.java:182)
  at java.net.SocksSocketImpl.connect (SocksSocketImpl.java:364)
  at java.net.Socket.connect (Socket.java:507)
  at java.net.Socket.connect (Socket.java:457)
  at java.net.Socket.<init>(Socket.java:365)
  at java.net.Socket.<init>(Socket.java:207)
  at
org.apache.jk.common.ChannelSocket.unLockSocket (ChannelSocket.java:460)
  at org.apache.jk.common.ChannelSocket.pause (ChannelSocket.java:272)
  at org.apache.jk.server.JkMain.pause (JkMain.java:657)
  at org.apache.jk.server.JkCoyoteHandler.pause (JkCoyoteHandler.java:202)
  at
org.apache.coyote.tomcat5.CoyoteConnector.pause (CoyoteConnector.java:1444)
  at
org.apache.catalina.core.StandardService.stop (StandardService.java:521)
  at
org.apache.catalina.core.StandardServer.stop (StandardServer.java:2347)
  at org.apache.catalina.startup.Catalina.stop (Catalina.java:605)
  at org.apache.catalina.startup.Catalina.start (Catalina.java:580)
  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
  at
sun.reflect.NativeMethodAccessorImpl.invoke (NativeMethodAccessorImpl.java:39)
  at
sun.reflect.DelegatingMethodAccessorImpl.invoke (DelegatingMethodAccessorImpl.java:25)
  at java.lang.reflect.Method.invoke (Method.java:585)
  at org.apache.catalina.startup.Bootstrap.start (Bootstrap.java:287)
  at org.apache.catalina.startup.Bootstrap.main (Bootstrap.java:425)
19.okt.2004 17:14:44 org.apache.catalina.core.StandardService stop
INFO: Stopping service Tomcat-Apache
19.okt.2004 17:14:44 org.apache.catalina.core.StandardHostDeployer remove
INFO: Removing web application at context path /admin
19.okt.2004 17:14:44 org.apache.catalina.logger.LoggerBase stop
INFO: unregistering logger Apache:type=Logger,path=/admin,host=localhost
19.okt.2004 17:14:44 org.apache.catalina.core.StandardHostDeployer remove
INFO: Removing web application at context path /mediaport
19.okt.2004 17:14:44 org.apache.catalina.core.StandardWrapper unload
INFO: Waiting for 19 instance(s) to be deallocated
19.okt.2004 17:14:45 org.apache.catalina.core.StandardWrapper unload
INFO: Waiting for 19 instance(s) to be deallocated
19.okt.2004 17:14:46 org.apache.catalina.core.StandardWrapper unload
INFO: Waiting for 19 instance(s) to be deallocated
19.okt.2004 17:14:46 org.apache.catalina.core.StandardWrapper unload
INFO: Waiting for 1 instance(s) to be deallocated
19.okt.2004 17:14:48 org.apache.catalina.core.StandardWrapper unload
INFO: Waiting for 1 instance(s) to be deallocated
19.okt.2004 17:14:49 org.apache.catalina.core.StandardWrapper unload
INFO: Waiting for 1 instance(s) to be deallocated
19.okt.2004 17:14:49 org.apache.catalina.core.StandardHostDeployer remove
INFO: Removing web application at context path /manager
19.okt.2004 17:14:49 org.apache.catalina.logger.LoggerBase stop
INFO: unregistering logger Apache:type=Logger,host=localhost
19.okt.2004 17:14:49 org.apache.catalina.logger.LoggerBase stop
INFO: unregistering logger Apache:type=Logger


error.log:
[Tue Oct 19 17:14:40 2004] [error] ajp13.service() ajpGetReply
recoverable error 3
[Tue Oct 19 17:14:40 2004] [error] ajp13.service() ajpGetReply
recoverable error 3
[Tue Oct 19 17:14:40 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 0
[Tue Oct 19 17:14:40 2004] [error] mod_jk2.handler() Error connecting to
tomcat 3, status 200
[Tue Oct 19 17:14:44 2004] [error] ajp13.service() ajpGetReply
recoverable error 3
[Tue Oct 19 17:14:44 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:44 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:44 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:44 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 0
[Tue Oct 19 17:14:44 2004] [error] lb.service() worker failed 120000 for
ajp13:localhost:8009
[Tue Oct 19 17:14:44 2004] [error] lb_worker.service() all workers in
error or disabled state
[Tue Oct 19 17:14:44 2004] [error] mod_jk2.handler() Error connecting to
tomcat 120000, status 503
[Tue Oct 19 17:14:44 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:44 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:44 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:45 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:45 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:45 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:45 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:45 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:45 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:45 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:45 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:45 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:45 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:45 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:45 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:46 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:46 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:46 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:46 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:46 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:46 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:46 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:46 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:46 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:46 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:46 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:46 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:46 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:46 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:46 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:47 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:47 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:47 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:48 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:48 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:48 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:48 2004] [error] channelApr.receive(): Error receiving
message body -1 11
[Tue Oct 19 17:14:48 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:48 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] channelApr.open() attempt to connect
to 127.0.0.1:8009 (localhost) failed 111
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] msgAjp.receive(): Bad signature 00
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 0
[Tue Oct 19 17:14:49 2004] [error] msgAjp.receive(): Bad signature 00
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] lb.service() worker failed 120000 for
ajp13:localhost:8009
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Error receiving
message body -1 104
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 0
[Tue Oct 19 17:14:49 2004] [error] lb.service() worker failed 120000 for
ajp13:localhost:8009
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] lb_worker.service() all workers in
error or disabled state
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 0
[Tue Oct 19 17:14:49 2004] [error] lb.service() worker failed 120000 for
ajp13:localhost:8009
[Tue Oct 19 17:14:49 2004] [error] lb_worker.service() all workers in
error or disabled state
[Tue Oct 19 17:14:49 2004] [error] mod_jk2.handler() Error connecting to
tomcat 120000, status 503
[Tue Oct 19 17:14:49 2004] [error] channelApr.receive(): Bad header
[Tue Oct 19 17:14:49 2004] [error] workerEnv.processCallbacks() Error
reading reply
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() ajpGetReply
recoverable error 120000
[Tue Oct 19 17:14:49 2004] [error] channelApr.open() attempt to connect
to 127.0.0.1:8009 (localhost) failed 111
[Tue Oct 19 17:14:49 2004] [error] ajp13.connect() failed
ajp13:localhost:8009
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() failed to connect
endpoint errno=9 Bad file descriptor
[Tue Oct 19 17:14:49 2004] [error] ajp13.service() Error forwarding
ajp13:localhost:8009 1 1
[Tue Oct 19 17:14:49 2004] [error] lb.service() worker failed 120000 for
ajp13:localhost:8009
[Tue Oct 19 17:14:49 2004] [error] lb_worker.service() all workers in
error or disabled state
[Tue Oct 19 17:14:49 2004] [error] mod_jk2.handler() Error connecting to
tomcat 120000, status 503

---------------------------------------------------------------------
To unsubscribe, e-mail: tomcat-user-unsubscribe@(protected)
For additional commands, e-mail: tomcat-user-help@(protected)

©2008 junlu.com - Jax Systems, LLC, U.S.A.