Stability problems using Apache / Tomcat / jk2

Trond G. Ziarkowski Wed, 20 Oct 2004 02:22:17 -0700

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


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: [EMAIL PROTECTED]
For additional commands, e-mail: [EMAIL PROTECTED]

Stability problems using Apache / Tomcat / jk2

Reply via email to