Mailing-List: contact tomcat-user-help@jakarta.apache.org; run by ezmlm
Precedence: bulk
Reply-To: "Tomcat Users List" <tomcat-user@jakarta.apache.org>
Message-ID: <3FB8D551.3090903@terra.es>
Date: Mon, 17 Nov 2003 15:04:01 +0100
From: =?ISO-8859-1?Q?Antonio_Fiol_Bonn=EDn?= <fiol.bonnin@terra.es>
User-Agent: Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.2.1) Gecko/20021204
MIME-Version: 1.0
To: tomcat-user@jakarta.apache.org
Subject: Replicated sessions problem (logs included)
Content-Type: text/plain; charset=ISO-8859-1; format=flowed
Content-Transfer-Encoding: 7bit

Dear Filip, and others of course,

Following the thread that started on saturday, we installed TC5 with 
your patch.

Behaviour seems somehow better. I am not sure whether it was the patch 
or the 5.0.12 -> 5.0.14+CVS skip. No more exceptions like the one I 
talked about seem to happen now.

Now we see something different, even more mystifying.

A session exists, but another tomcat (let's call it TC1) modifies it, 
and redirects the user to another servlet. The session replication starts.

TC2 (for which I present the log here) starts receiving the session. It 
says what is marked "1" on the log.

Meanwhile, TC2 receives the request for the "redirected" resource, and 
starts processing it. It is marked "2" on the log.  As you will see, it 
perceives the session as nonexistent (or incomplete).

TC2 ends receiving the session. Marked "3" on the log.

Last, but not least, a session has been created for the user, and it is 
sent to the other tomcats (TC1, TC3). Marked "4" on the log.

Obviously, this should not happen: if TC1 sends a 302-redirect, when the 
request for the redirected resource arrives, session has to be already 
replicated OR at least, TC2 should have waited for the end of the 
session replication before returning a null/new session to the app.

Thank you very much.

Yours sincerely,


Antonio Fiol


--------------------------- 1 -----------------------------------
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO: Received SessionMessage of type=SESSION-MODIFIED
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO: Received SessionMessage 
sender=org.apache.catalina.cluster.mcast.McastMember[tcp://172.19.8.112:4001,172.19.8.112,4001]
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO: readObject() loading session 656EB42322EF71737595FBE2864FFBEB
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'mensaje' with value ''
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'actorSession' with value 
'es.red.esnic.negocio.vo.ActorVO{tipoActor=3, codActor=120068, 
nombreActor='usuario registrado 1', email=
'antonio.contreras@red.es', passwd='qwerty', nicHandle='UR1-ESNIC-F2'}'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'tamDominio' with value '0'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'login' with value 'UR1-ESNIC-F2'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'datos' with value '[Ljava.lang.Object;@1214626'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'cod_contacto' with value '120068'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'url' with value 
'/esnic/servlet/ListaDominiosController?nivelDom=2'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'contadorLista' with value '0'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'rol' with value '3'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'datosUsuario' with value 
'es.red.esnic.negocio.vo.DatosUsuarioVO@1849daf'
-------------------- 2 -------------------------------
[2003-11-17 12:58:39,861] - DEBUG - auth.UserFinalAuthFilter.doFilter - 
There is no session, session has no login name attribute or role 
attribute is incorrect/nonexistent. Let's start authentication procedure.
-------------------- 3 -------------------------------
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'dominios' with value '[]'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO:   loading attribute 'dominio' with value 'midominio95959595.com.es'
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO: Received replicated session=ReplicatedSession 
id=656EB42322EF71737595FBE2864FFBEB 
ref=StandardSession[656EB42322EF71737595FBE2864FFBEB]
        name=actorSession; 
value=es.red.esnic.negocio.vo.ActorVO{tipoActor=3, codActor=120068, 
nombreActor='usuario registrado 1', email='antonio.contreras@r
ed.es', passwd='qwerty', nicHandle='UR1-ESNIC-F2'}
        name=mensaje; value=
        name=tamDominio; value=0
        name=login; value=UR1-ESNIC-F2
        name=datos; value=[Ljava.lang.Object;@1214626
        name=cod_contacto; value=120068
        name=contadorLista; value=0
        name=url; value=/esnic/servlet/ListaDominiosController?nivelDom=2
        name=datosUsuario; 
value=es.red.esnic.negocio.vo.DatosUsuarioVO@1849daf
        name=rol; value=3
        name=dominios; value=[]
        name=dominio; value=midominio95959595.com.es
        LastAccess=1069070319683

-------------------- 4 --------------------
Nov 17, 2003 12:58:39 PM 
org.apache.catalina.cluster.session.SimpleTcpReplicationManager log
INFO: writeObject() storing session 114D8CE3A8A93DACA946E3F1A1C6F4A1


---------------------------------------------------------------------
To unsubscribe, e-mail: tomcat-user-unsubscribe@jakarta.apache.org
For additional commands, e-mail: tomcat-user-help@jakarta.apache.org