Re: Problem with Tomcat Cluster

2016-02-03 Thread Edwin Quijada
Well, I have a clustered , I dont test in non clustered environment


From: Mikel Ibiricu 
Sent: Wednesday, February 3, 2016 5:32 AM
To: Tomcat Users List
Subject: Re: Problem with Tomcat Cluster

Are you sure it starts in non-clustered environment? It sounda to me to be
just a spring initialization error.
El 02/02/2016 22:40, "Edwin Quijada"  escribió:

> Hi!
> I have a Tomcat cluster over Debian Jessie, Tomcat 8.0.29 2 instances ,
> PostgreSQL 9.5 ,Apache 2.4 , Mod_jk. When I try to run my project in this
> environment I get eerror. I tested with examples project and it works fine.
> My log iis this
>
>
> 01-Feb-2016 19:07:39.474 SEVERE [main]
> org.apache.catalina.ha.deploy.FarmWarDeployer.start FarmWarDeployer can
> only work as host cluster subelement!
> 01-Feb-2016 19:07:39.537 INFO [localhost-startStop-1]
> org.apache.catalina.startup.HostConfig.deployWAR Despliegue del archivo
> /opt/tomcat8_nodo1/webapps/clusterjsp.war de la aplicación web
> 01-Feb-2016 19:07:40.886 INFO
> [MessageDispatch15Interceptor.MessageDispatchThread1]
> org.apache.catalina.tribes.group.interceptors.ThroughputInterceptor.report
> ThroughputInterceptor Report[
> Tx Msg:1 messages
> Sent:0.00 MB (total)
> Sent:0.00 MB (application)
> Time:0.01 seconds
> Tx Speed:0.06 MB/sec (total)
> TxSpeed:0.06 MB/sec (application)
> Error Msg:0
> Rx Msg:2 messages
> Rx Speed:0.00 MB/sec (since 1st msg)
> Received:0.00 MB]
>
> 01-Feb-2016 19:07:42.068 INFO [localhost-startStop-1]
> org.apache.catalina.util.SessionIdGeneratorBase.createSecureRandom Creation
> of SecureRandom instance for session ID generation using [SHA1PRNG] took
> [1.489] milliseconds.
> 01-Feb-2016 19:07:42.088 INFO [localhost-startStop-1]
> org.apache.catalina.tribes.tipis.AbstractReplicatedMap.init Initializing
> AbstractReplicatedMap with context name:localhost#/clusterjsp-map
> 01-Feb-2016 19:07:42.310 INFO [localhost-startStop-1]
> org.apache.catalina.tribes.tipis.AbstractReplicatedMap.init
> AbstractReplicatedMap[localhost#/clusterjsp-map] initialization was
> completed in 222 ms.
> 01-Feb-2016 19:07:42.585 INFO [localhost-startStop-1]
> org.apache.catalina.startup.HostConfig.deployWAR Deployment of web
> application archive /opt/tomcat8_nodo1/webapps/clusterjsp.war has finished
> in 3.048 ms
> 01-Feb-2016 19:07:45.652 INFO [localhost-startStop-1]
> org.apache.catalina.startup.HostConfig.deployWAR Despliegue del archivo
> /opt/tomcat8_nodo1/webapps/abacus.war de la aplicación web
> 01-Feb-2016 19:14:05.387 INFO [localhost-startStop-1]
> org.apache.jasper.servlet.TldScanner.scanJars Al menos un JAR, que se ha
> explorado buscando TLDs, aún no contenía TLDs. Activar historial de
> depuración para este historiador para una completa lista de los JARs que
> fueron explorados y de los que nos se halló TLDs. Saltarse JARs no
> necesarios durante la exploración puede dar lugar a una mejora de tiempo
> significativa en el arranque y compilación de JSP .
> feb 01, 2016 7:14:05 PM org.apache.catalina.core.ApplicationContext log
> INFORMACIÓN: Initializing AtmosphereFramework
> feb 01, 2016 7:14:05 PM org.apache.catalina.core.ApplicationContext log
> INFORMACIÓN: No Spring WebApplicationInitializer types detected on
> classpath
> feb 01, 2016 7:14:06 PM org.apache.catalina.core.ApplicationContext log
> INFORMACIÓN: Initializing Spring root WebApplicationContext
> feb 01, 2016 7:14:54 PM org.apache.tomcat.jdbc.pool.ConnectionPool init
> ADVERTENCIA: maxActive is smaller than 1, setting maxActive to: 100
> 2016-02-01 19:14:59,345 [localhost-startStop-1] ERROR
> context.GrailsContextLoaderListener  - Error initializing the application:
> Error creating bean with name
> 'org.springframework.context.annotation.internalAsyncAnnotationProcessor'
> defined in class path resource
> [org/springframework/scheduling/annotation/ProxyAsyncConfiguration.class]:
> Instantiation of bean failed; nested exception is
> org.springframework.beans.factory.BeanDefinitionStoreException: Factory
> method [public
> org.springframework.scheduling.annotation.AsyncAnnotationBeanPostProcessor
> org.springframework.scheduling.annotation.ProxyAsyncConfiguration.asyncAdvisor()]
> threw exception; nested exception is java.lang.IllegalArgumentException:
> @EnableAsync annotation metadata was not injected
> org.springframework.beans.factory.BeanCreationException: Error creating
> bean with name
> 'org.springframework.context.annotation.internalAsyncAnnotationProcessor'
> defined in class path resource
> [org/springframework/scheduling/annotation/ProxyAsyncConfiguration.class]:
> Instantiation of bean failed; nested exception

Re: Problem with Tomcat Cluster

2016-02-02 Thread Mikel Ibiricu
Are you sure it starts in non-clustered environment? It sounda to me to be
just a spring initialization error.
El 02/02/2016 22:40, "Edwin Quijada"  escribió:

> Hi!
> I have a Tomcat cluster over Debian Jessie, Tomcat 8.0.29 2 instances ,
> PostgreSQL 9.5 ,Apache 2.4 , Mod_jk. When I try to run my project in this
> environment I get eerror. I tested with examples project and it works fine.
> My log iis this
>
>
> 01-Feb-2016 19:07:39.474 SEVERE [main]
> org.apache.catalina.ha.deploy.FarmWarDeployer.start FarmWarDeployer can
> only work as host cluster subelement!
> 01-Feb-2016 19:07:39.537 INFO [localhost-startStop-1]
> org.apache.catalina.startup.HostConfig.deployWAR Despliegue del archivo
> /opt/tomcat8_nodo1/webapps/clusterjsp.war de la aplicación web
> 01-Feb-2016 19:07:40.886 INFO
> [MessageDispatch15Interceptor.MessageDispatchThread1]
> org.apache.catalina.tribes.group.interceptors.ThroughputInterceptor.report
> ThroughputInterceptor Report[
> Tx Msg:1 messages
> Sent:0.00 MB (total)
> Sent:0.00 MB (application)
> Time:0.01 seconds
> Tx Speed:0.06 MB/sec (total)
> TxSpeed:0.06 MB/sec (application)
> Error Msg:0
> Rx Msg:2 messages
> Rx Speed:0.00 MB/sec (since 1st msg)
> Received:0.00 MB]
>
> 01-Feb-2016 19:07:42.068 INFO [localhost-startStop-1]
> org.apache.catalina.util.SessionIdGeneratorBase.createSecureRandom Creation
> of SecureRandom instance for session ID generation using [SHA1PRNG] took
> [1.489] milliseconds.
> 01-Feb-2016 19:07:42.088 INFO [localhost-startStop-1]
> org.apache.catalina.tribes.tipis.AbstractReplicatedMap.init Initializing
> AbstractReplicatedMap with context name:localhost#/clusterjsp-map
> 01-Feb-2016 19:07:42.310 INFO [localhost-startStop-1]
> org.apache.catalina.tribes.tipis.AbstractReplicatedMap.init
> AbstractReplicatedMap[localhost#/clusterjsp-map] initialization was
> completed in 222 ms.
> 01-Feb-2016 19:07:42.585 INFO [localhost-startStop-1]
> org.apache.catalina.startup.HostConfig.deployWAR Deployment of web
> application archive /opt/tomcat8_nodo1/webapps/clusterjsp.war has finished
> in 3.048 ms
> 01-Feb-2016 19:07:45.652 INFO [localhost-startStop-1]
> org.apache.catalina.startup.HostConfig.deployWAR Despliegue del archivo
> /opt/tomcat8_nodo1/webapps/abacus.war de la aplicación web
> 01-Feb-2016 19:14:05.387 INFO [localhost-startStop-1]
> org.apache.jasper.servlet.TldScanner.scanJars Al menos un JAR, que se ha
> explorado buscando TLDs, aún no contenía TLDs. Activar historial de
> depuración para este historiador para una completa lista de los JARs que
> fueron explorados y de los que nos se halló TLDs. Saltarse JARs no
> necesarios durante la exploración puede dar lugar a una mejora de tiempo
> significativa en el arranque y compilación de JSP .
> feb 01, 2016 7:14:05 PM org.apache.catalina.core.ApplicationContext log
> INFORMACIÓN: Initializing AtmosphereFramework
> feb 01, 2016 7:14:05 PM org.apache.catalina.core.ApplicationContext log
> INFORMACIÓN: No Spring WebApplicationInitializer types detected on
> classpath
> feb 01, 2016 7:14:06 PM org.apache.catalina.core.ApplicationContext log
> INFORMACIÓN: Initializing Spring root WebApplicationContext
> feb 01, 2016 7:14:54 PM org.apache.tomcat.jdbc.pool.ConnectionPool init
> ADVERTENCIA: maxActive is smaller than 1, setting maxActive to: 100
> 2016-02-01 19:14:59,345 [localhost-startStop-1] ERROR
> context.GrailsContextLoaderListener  - Error initializing the application:
> Error creating bean with name
> 'org.springframework.context.annotation.internalAsyncAnnotationProcessor'
> defined in class path resource
> [org/springframework/scheduling/annotation/ProxyAsyncConfiguration.class]:
> Instantiation of bean failed; nested exception is
> org.springframework.beans.factory.BeanDefinitionStoreException: Factory
> method [public
> org.springframework.scheduling.annotation.AsyncAnnotationBeanPostProcessor
> org.springframework.scheduling.annotation.ProxyAsyncConfiguration.asyncAdvisor()]
> threw exception; nested exception is java.lang.IllegalArgumentException:
> @EnableAsync annotation metadata was not injected
> org.springframework.beans.factory.BeanCreationException: Error creating
> bean with name
> 'org.springframework.context.annotation.internalAsyncAnnotationProcessor'
> defined in class path resource
> [org/springframework/scheduling/annotation/ProxyAsyncConfiguration.class]:
> Instantiation of bean failed; nested exception is
> org.springframework.beans.factory.BeanDefinitionStoreException: Factory
> method [public
> org.springframework.scheduling.annotation.AsyncAnnotationBeanPostProcessor
> org.springframework.scheduling.annotation.ProxyAsyncConfiguration.asyncAdvisor()]
> threw exception; nested exception is java.lang.IllegalArgumentException:
> @EnableAsync annotation metadata was not injected
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
> at java.util.concurrent.FutureTask

Problem with Tomcat Cluster

2016-02-02 Thread Edwin Quijada
Hi!
I have a Tomcat cluster over Debian Jessie, Tomcat 8.0.29 2 instances , 
PostgreSQL 9.5 ,Apache 2.4 , Mod_jk. When I try to run my project in this 
environment I get eerror. I tested with examples project and it works fine. My 
log iis this


01-Feb-2016 19:07:39.474 SEVERE [main] 
org.apache.catalina.ha.deploy.FarmWarDeployer.start FarmWarDeployer can only 
work as host cluster subelement!
01-Feb-2016 19:07:39.537 INFO [localhost-startStop-1] 
org.apache.catalina.startup.HostConfig.deployWAR Despliegue del archivo 
/opt/tomcat8_nodo1/webapps/clusterjsp.war de la aplicación web
01-Feb-2016 19:07:40.886 INFO 
[MessageDispatch15Interceptor.MessageDispatchThread1] 
org.apache.catalina.tribes.group.interceptors.ThroughputInterceptor.report 
ThroughputInterceptor Report[
Tx Msg:1 messages
Sent:0.00 MB (total)
Sent:0.00 MB (application)
Time:0.01 seconds
Tx Speed:0.06 MB/sec (total)
TxSpeed:0.06 MB/sec (application)
Error Msg:0
Rx Msg:2 messages
Rx Speed:0.00 MB/sec (since 1st msg)
Received:0.00 MB]

01-Feb-2016 19:07:42.068 INFO [localhost-startStop-1] 
org.apache.catalina.util.SessionIdGeneratorBase.createSecureRandom Creation of 
SecureRandom instance for session ID generation using [SHA1PRNG] took [1.489] 
milliseconds.
01-Feb-2016 19:07:42.088 INFO [localhost-startStop-1] 
org.apache.catalina.tribes.tipis.AbstractReplicatedMap.init Initializing 
AbstractReplicatedMap with context name:localhost#/clusterjsp-map
01-Feb-2016 19:07:42.310 INFO [localhost-startStop-1] 
org.apache.catalina.tribes.tipis.AbstractReplicatedMap.init 
AbstractReplicatedMap[localhost#/clusterjsp-map] initialization was completed 
in 222 ms.
01-Feb-2016 19:07:42.585 INFO [localhost-startStop-1] 
org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application 
archive /opt/tomcat8_nodo1/webapps/clusterjsp.war has finished in 3.048 ms
01-Feb-2016 19:07:45.652 INFO [localhost-startStop-1] 
org.apache.catalina.startup.HostConfig.deployWAR Despliegue del archivo 
/opt/tomcat8_nodo1/webapps/abacus.war de la aplicación web
01-Feb-2016 19:14:05.387 INFO [localhost-startStop-1] 
org.apache.jasper.servlet.TldScanner.scanJars Al menos un JAR, que se ha 
explorado buscando TLDs, aún no contenía TLDs. Activar historial de depuración 
para este historiador para una completa lista de los JARs que fueron explorados 
y de los que nos se halló TLDs. Saltarse JARs no necesarios durante la 
exploración puede dar lugar a una mejora de tiempo significativa en el arranque 
y compilación de JSP .
feb 01, 2016 7:14:05 PM org.apache.catalina.core.ApplicationContext log
INFORMACIÓN: Initializing AtmosphereFramework
feb 01, 2016 7:14:05 PM org.apache.catalina.core.ApplicationContext log
INFORMACIÓN: No Spring WebApplicationInitializer types detected on classpath
feb 01, 2016 7:14:06 PM org.apache.catalina.core.ApplicationContext log
INFORMACIÓN: Initializing Spring root WebApplicationContext
feb 01, 2016 7:14:54 PM org.apache.tomcat.jdbc.pool.ConnectionPool init
ADVERTENCIA: maxActive is smaller than 1, setting maxActive to: 100
2016-02-01 19:14:59,345 [localhost-startStop-1] ERROR 
context.GrailsContextLoaderListener  - Error initializing the application: 
Error creating bean with name 
'org.springframework.context.annotation.internalAsyncAnnotationProcessor' 
defined in class path resource 
[org/springframework/scheduling/annotation/ProxyAsyncConfiguration.class]: 
Instantiation of bean failed; nested exception is 
org.springframework.beans.factory.BeanDefinitionStoreException: Factory method 
[public 
org.springframework.scheduling.annotation.AsyncAnnotationBeanPostProcessor 
org.springframework.scheduling.annotation.ProxyAsyncConfiguration.asyncAdvisor()]
 threw exception; nested exception is java.lang.IllegalArgumentException: 
@EnableAsync annotation metadata was not injected
org.springframework.beans.factory.BeanCreationException: Error creating bean 
with name 
'org.springframework.context.annotation.internalAsyncAnnotationProcessor' 
defined in class path resource 
[org/springframework/scheduling/annotation/ProxyAsyncConfiguration.class]: 
Instantiation of bean failed; nested exception is 
org.springframework.beans.factory.BeanDefinitionStoreException: Factory method 
[public 
org.springframework.scheduling.annotation.AsyncAnnotationBeanPostProcessor 
org.springframework.scheduling.annotation.ProxyAsyncConfiguration.asyncAdvisor()]
 threw exception; nested exception is java.lang.IllegalArgumentException: 
@EnableAsync annotation metadata was not injected
at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.springframe

AW: Problem with Tomcat Cluster (read acknowledgement from server)

2009-06-23 Thread Ehlers, Kolja
Thanks for your reply. We will consider upgrading, but can you explain the 
error that we are facing. Then we may be able to
reproduce this and see if it was fixed with 5.5.27.  

-Ursprüngliche Nachricht-
Von: Pid [mailto:p...@pidster.com] 
Gesendet: Dienstag, 23. Juni 2009 13:50
An: Tomcat Users List
Betreff: Re: Problem with Tomcat Cluster (read acknowledgement from server)

Ehlers, Kolja wrote:
> Hello everybody,
> 
> we are running a couple of clustered Tomcat 5.5.9 instances and keep 
> experiencing problems in our productive environment. This is the 
> configuration:

The current version is 5.5.27, there have been a lot of bug fixes since 5.5.9.  
You should definitely upgrade to a more recent
version before proceeding.  Be careful to read the complete change log before 
you do so as there are several fixes that often catch
people out.

p



>   
> managerClassName="org.apache.catalina.cluster.session.DeltaManager"
>  expireSessionsOnShutdown="false"
>  useDirtyFlag="true"
>  notifyListenersOnReplication="true">
> 
>  className="org.apache.catalina.cluster.mcast.McastService"
> mcastAddr="239.255.0.1"
> mcastPort="45789"
> mcastFrequency="500"
> mcastDropTime="3000"/>
> 
>  
> className="org.apache.catalina.cluster.tcp.ReplicationListener"
> tcpListenAddress="10.0.0.30"
> tcpListenPort="4439"
> tcpSelectorTimeout="100"
> tcpThreadCount="2"/>
> 
>  
> className="org.apache.catalina.cluster.tcp.ReplicationTransmitter"
> replicationMode="pooled"
> ackTimeout="15000"/>
> 
>  className="org.apache.catalina.cluster.tcp.ReplicationValve"
>
> filter=".*\.gif;.*\.js;.*\.jpg;.*\.png;.*\.htm;.*\.html;.*\.css;.*\.tx
> t;"/>
> 
>  className="org.apache.catalina.cluster.deploy.FarmWarDeployer"
>   tempDir="/tmp/war-temp38/"
>   deployDir="/opt/jakarta/dep38/war-deploy/"
>   watchDir="/opt/jakarta/dep38/war-listen/"
>   watchEnabled="false"/>
> 
> 
> This is the log of node2:
> 
> Jun 22, 2009 10:06:16 AM org.apache.catalina.cluster.tcp.DataSender 
> waitForAck
> WARNING: Wasnt able to read acknowledgement from 
> server[{0}:{1,number,integer}] in {2,number,integer} ms. Disconnecting 
> socket, and trying again.
> Jun 22, 2009 10:06:16 AM org.apache.catalina.cluster.tcp.DataSender 
> waitForAck
> WARNING: Wasnt able to read acknowledgement from 
> server[{0}:{1,number,integer}] in {2,number,integer} ms. Disconnecting 
> socket, and trying again.
> Jun 22, 2009 10:06:31 AM org.apache.catalina.cluster.tcp.DataSender 
> waitForAck
> WARNING: Wasnt able to read acknowledgement from 
> server[{0}:{1,number,integer}] in {2,number,integer} ms. Disconnecting 
> socket, and trying again.
> Jun 22, 2009 10:06:31 AM 
> org.apache.catalina.cluster.tcp.ReplicationTransmitter sendMessageData
> WARNING: Unable to send replicated message, is server down?
> java.net.SocketTimeoutException: Read timed out
>   at java.net.SocketInputStream.socketRead0(Native Method)
>   at java.net.SocketInputStream.read(SocketInputStream.java:129)
>   at java.net.SocketInputStream.read(SocketInputStream.java:182)
>   at 
> org.apache.catalina.cluster.tcp.DataSender.waitForAck(DataSender.java:530)
>   at 
> org.apache.catalina.cluster.tcp.DataSender.pushMessage(DataSender.java:508)
>   at 
> org.apache.catalina.cluster.tcp.DataSender.sendMessage(DataSender.java:378)
>   at 
> org.apache.catalina.cluster.tcp.PooledSocketSender.sendMessage(PooledSocketSender.java:118)
>   at 
> org.apache.catalina.cluster.tcp.ReplicationTransmitter.sendMessageData(ReplicationTransmitter.java:646)
>   at 
> org.apache.catalina.cluster.tcp.ReplicationTransmitter.sendMessage(ReplicationTransmitter.java:348)
>   at 
> org.apache.catalina.cluster.tcp.SimpleTcpCluster.send(SimpleTcpCluster.java:466)
>   at 
> org.apache.catalina.cluster.tcp.SimpleTcpCluster.send(SimpleTcpCluster.java:495)
>   at 
> org.apache.catalina.cluster.session.DeltaManager.sessionExpired(DeltaManager.java:811)
>   at 
> org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:7

Re: Problem with Tomcat Cluster (read acknowledgement from server)

2009-06-23 Thread Pid
Ehlers, Kolja wrote:
> Hello everybody,
> 
> we are running a couple of clustered Tomcat 5.5.9 instances and keep 
> experiencing problems in our productive environment. This is
> the configuration:

The current version is 5.5.27, there have been a lot of bug fixes since
5.5.9.  You should definitely upgrade to a more recent version before
proceeding.  Be careful to read the complete change log before you do so
as there are several fixes that often catch people out.

p



>   
> managerClassName="org.apache.catalina.cluster.session.DeltaManager"
>  expireSessionsOnShutdown="false"
>  useDirtyFlag="true"
>  notifyListenersOnReplication="true">
> 
>  className="org.apache.catalina.cluster.mcast.McastService"
> mcastAddr="239.255.0.1"
> mcastPort="45789"
> mcastFrequency="500"
> mcastDropTime="3000"/>
> 
>  
> className="org.apache.catalina.cluster.tcp.ReplicationListener"
> tcpListenAddress="10.0.0.30"
> tcpListenPort="4439"
> tcpSelectorTimeout="100"
> tcpThreadCount="2"/>
> 
>  
> className="org.apache.catalina.cluster.tcp.ReplicationTransmitter"
> replicationMode="pooled"
> ackTimeout="15000"/>
> 
>  className="org.apache.catalina.cluster.tcp.ReplicationValve"
>
> filter=".*\.gif;.*\.js;.*\.jpg;.*\.png;.*\.htm;.*\.html;.*\.css;.*\.txt;"/>
> 
>  className="org.apache.catalina.cluster.deploy.FarmWarDeployer"
>   tempDir="/tmp/war-temp38/"
>   deployDir="/opt/jakarta/dep38/war-deploy/"
>   watchDir="/opt/jakarta/dep38/war-listen/"
>   watchEnabled="false"/>
> 
> 
> This is the log of node2:
> 
> Jun 22, 2009 10:06:16 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
> WARNING: Wasnt able to read acknowledgement from 
> server[{0}:{1,number,integer}] in {2,number,integer} ms. Disconnecting 
> socket, and
> trying again.
> Jun 22, 2009 10:06:16 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
> WARNING: Wasnt able to read acknowledgement from 
> server[{0}:{1,number,integer}] in {2,number,integer} ms. Disconnecting 
> socket, and
> trying again.
> Jun 22, 2009 10:06:31 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
> WARNING: Wasnt able to read acknowledgement from 
> server[{0}:{1,number,integer}] in {2,number,integer} ms. Disconnecting 
> socket, and
> trying again.
> Jun 22, 2009 10:06:31 AM 
> org.apache.catalina.cluster.tcp.ReplicationTransmitter sendMessageData
> WARNING: Unable to send replicated message, is server down?
> java.net.SocketTimeoutException: Read timed out
>   at java.net.SocketInputStream.socketRead0(Native Method)
>   at java.net.SocketInputStream.read(SocketInputStream.java:129)
>   at java.net.SocketInputStream.read(SocketInputStream.java:182)
>   at 
> org.apache.catalina.cluster.tcp.DataSender.waitForAck(DataSender.java:530)
>   at 
> org.apache.catalina.cluster.tcp.DataSender.pushMessage(DataSender.java:508)
>   at 
> org.apache.catalina.cluster.tcp.DataSender.sendMessage(DataSender.java:378)
>   at 
> org.apache.catalina.cluster.tcp.PooledSocketSender.sendMessage(PooledSocketSender.java:118)
>   at 
> org.apache.catalina.cluster.tcp.ReplicationTransmitter.sendMessageData(ReplicationTransmitter.java:646)
>   at 
> org.apache.catalina.cluster.tcp.ReplicationTransmitter.sendMessage(ReplicationTransmitter.java:348)
>   at 
> org.apache.catalina.cluster.tcp.SimpleTcpCluster.send(SimpleTcpCluster.java:466)
>   at 
> org.apache.catalina.cluster.tcp.SimpleTcpCluster.send(SimpleTcpCluster.java:495)
>   at 
> org.apache.catalina.cluster.session.DeltaManager.sessionExpired(DeltaManager.java:811)
>   at 
> org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:730)
>   at 
> org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:653)
>   at 
> org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:641)
>   at 
> org.apache.catalina.cluster.session.DeltaSession.invalidate(DeltaSession.java:1042)
>   at 
> org.apache.catalina.cluster.session.DeltaSessionFacade.invalidate(DeltaSessionFacade.java:150)
>   at webapp.control.FrontServlet.doProcessRequest(Unknown Source)
>   at webapp.control.FrontServlet.doGet(Unknown Source)
>   at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
>   at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
>   at 
> org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
>   at 
> org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
>   at filters.Timeout

Problem with Tomcat Cluster (read acknowledgement from server)

2009-06-23 Thread Ehlers, Kolja
Hello everybody,

we are running a couple of clustered Tomcat 5.5.9 instances and keep 
experiencing problems in our productive environment. This is
the configuration:














This is the log of node2:

Jun 22, 2009 10:06:16 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
WARNING: Wasnt able to read acknowledgement from server[{0}:{1,number,integer}] 
in {2,number,integer} ms. Disconnecting socket, and
trying again.
Jun 22, 2009 10:06:16 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
WARNING: Wasnt able to read acknowledgement from server[{0}:{1,number,integer}] 
in {2,number,integer} ms. Disconnecting socket, and
trying again.
Jun 22, 2009 10:06:31 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
WARNING: Wasnt able to read acknowledgement from server[{0}:{1,number,integer}] 
in {2,number,integer} ms. Disconnecting socket, and
trying again.
Jun 22, 2009 10:06:31 AM org.apache.catalina.cluster.tcp.ReplicationTransmitter 
sendMessageData
WARNING: Unable to send replicated message, is server down?
java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.read(SocketInputStream.java:129)
at java.net.SocketInputStream.read(SocketInputStream.java:182)
at 
org.apache.catalina.cluster.tcp.DataSender.waitForAck(DataSender.java:530)
at 
org.apache.catalina.cluster.tcp.DataSender.pushMessage(DataSender.java:508)
at 
org.apache.catalina.cluster.tcp.DataSender.sendMessage(DataSender.java:378)
at 
org.apache.catalina.cluster.tcp.PooledSocketSender.sendMessage(PooledSocketSender.java:118)
at 
org.apache.catalina.cluster.tcp.ReplicationTransmitter.sendMessageData(ReplicationTransmitter.java:646)
at 
org.apache.catalina.cluster.tcp.ReplicationTransmitter.sendMessage(ReplicationTransmitter.java:348)
at 
org.apache.catalina.cluster.tcp.SimpleTcpCluster.send(SimpleTcpCluster.java:466)
at 
org.apache.catalina.cluster.tcp.SimpleTcpCluster.send(SimpleTcpCluster.java:495)
at 
org.apache.catalina.cluster.session.DeltaManager.sessionExpired(DeltaManager.java:811)
at 
org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:730)
at 
org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:653)
at 
org.apache.catalina.cluster.session.DeltaSession.expire(DeltaSession.java:641)
at 
org.apache.catalina.cluster.session.DeltaSession.invalidate(DeltaSession.java:1042)
at 
org.apache.catalina.cluster.session.DeltaSessionFacade.invalidate(DeltaSessionFacade.java:150)
at webapp.control.FrontServlet.doProcessRequest(Unknown Source)
at webapp.control.FrontServlet.doGet(Unknown Source)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
at 
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
at 
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
at filters.TimeoutFilter.doFilter(TimeoutFilter.java:53)
at 
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
at 
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
at 
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
at 
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
at 
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
at 
org.apache.catalina.cluster.tcp.ReplicationValve.invoke(ReplicationValve.java:145)
at 
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
at 
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
at 
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
at org.apache.jk.server.JkCoyoteHandler.invoke(JkCoyoteHandler.java:307)
at org.apache.jk.common.HandlerRequest.invoke(HandlerRequest.java:385)
at org.apache.jk.common.ChannelSocket.invoke(ChannelSocket.java:748)
at 
org.apache.jk.common.ChannelSocket.processConnection(ChannelSocket.java:678)
at org.apache.jk.common.SocketConnection.runIt(ChannelSocket.java:871)
at 
org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684)
at java.lang.Thread.run(Thread.java:595)
Jun 22, 2009 10:06:31 AM org.apache.catalina.cluster.tcp.DataSender waitForAck
WARNING: Wasnt able to read acknowledgement from server[{0}:{1,number,integer}] 
in {2,number,integer} ms. Disconnecting socket, and
trying again.
Jun 22, 2009 10:06:46 AM org.apache.catalina.cluster.tcp.DataSender waitForAck