8 Replies Latest reply on May 10, 2007 8:29 AM by Nicolas Chapurlat

    Seam remoting conversation - possible problem?

    Chris Morrisette Newbie

      I am still having problems with Seam Remoting, within a conversation the state of a SFSB is lost. I had isolated some cases to being because my application restarted and not restarting the browsers session, but have found other unrelated cases.

      I was able to capture the log of an instance of this happening. The conversation id is '6' and the SFSB (with a scope of 'conversation') is 'ServiceBusiness'.

      At time datestamp '2006-12-19 12:20:33,656' you can see that seam conversation 6 is invoking a method on ServiceBusiness instance ServiceBusinessImpl@9403b0.

      At time datestamp '2006-12-19 12:20:37,750' you can see that seam conversation 6 instantiates a new ServiceBusiness object and invokes a method on ServiceBusiness instance ServiceBusinessImpl@b73feb.

      You can see that earlier invocations of conversation 6 all operate on ServiceBusinessImpl@9403b0.

      In looking at the log, the only thing that pops out at me is that Conversation id '2' times out at time datestamp 2006-12-19 12:20:36,468, but this shouldn't have any impact on conversation 6, should it?

      Am I doing something wrong?

      I am about to jump into the source, but wanted to see if anybody had any suggestions first.

      Thanks for any help,
      Chris

      jboss-4.0.5.GA
      Seam 1.1.0.GA
      jdk1.5.0_09

      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] >>> Begin web request
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.manager
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.manager
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.manager
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.core.Manager] No stored conversation, or concurrent call to the stored conversation
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] instantiating Seam component: serviceBusiness
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] initializing new instance of: serviceBusiness
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] done initializing: serviceBusiness
      2006-12-19 12:20:25,453 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] ++++ LongLivedSessionPropagationInterceptor
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.interpolator
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.interpolator
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.interpolator
      2006-12-19 12:20:25,453 ERROR [com.zua.business.ServiceBusinessImpl] Instantiating Service Business object: com.zua.business.ServiceBusinessImpl@9403b0
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.core.Manager] Beginning long-running conversation
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.conversation
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.conversation
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.conversation
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.core.Manager] Storing conversation state: 6
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] After request, destroying contexts
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying business process context
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing server-side conversation context
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing session context
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying event context
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.manager
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.contexts.Lifecycle] <<< End web request
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.remoting.ExecutionHandler] ended request
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,453 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:25,593 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,593 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:25,593 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,593 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:25,609 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,609 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:25,625 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,625 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:25,656 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,656 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] >>> Begin web request
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.manager
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.manager
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.manager
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.core.Manager] Restoring conversation with id: 6
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: serviceBusiness
      2006-12-19 12:20:25,734 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] ++++ LongLivedSessionPropagationInterceptor
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.interpolator
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.interpolator
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.interpolator
      2006-12-19 12:20:25,734 ERROR [com.zua.business.ServiceBusinessImpl] Executing method on Service Business: com.zua.business.ServiceBusinessImpl@9403b0
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.core.Manager] Storing conversation state: 6
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] After request, destroying contexts
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying business process context
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing server-side conversation context
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing session context
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying event context
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.manager
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.contexts.Lifecycle] <<< End web request
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.remoting.ExecutionHandler] ended request
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:25,734 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.contexts.Lifecycle] >>> Begin web request
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.manager
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.manager
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.manager
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.core.Manager] Restoring conversation with id: 6
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: serviceBusiness
      2006-12-19 12:20:28,187 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] ++++ LongLivedSessionPropagationInterceptor
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.interpolator
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.interpolator
      2006-12-19 12:20:28,187 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.interpolator
      2006-12-19 12:20:28,187 ERROR [com.zua.business.ServiceBusinessImpl] Executing method on Service Business: com.zua.business.ServiceBusinessImpl@9403b0
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:28,203 DEBUG [org.jboss.ejb3.entity.ManagedEntityManagerFactory] ************** closing entity managersession **************
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.core.Manager] Storing conversation state: 6
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Lifecycle] After request, destroying contexts
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying business process context
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing server-side conversation context
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing session context
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying event context
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.manager
      2006-12-19 12:20:28,203 DEBUG [org.jboss.seam.contexts.Lifecycle] <<< End web request
      2006-12-19 12:20:28,250 DEBUG [org.jboss.seam.remoting.ExecutionHandler] ended request
      2006-12-19 12:20:28,250 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:28,250 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.contexts.Lifecycle] >>> Begin web request
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.manager
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.manager
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.manager
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.core.Manager] Restoring conversation with id: 6
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: serviceBusiness
      2006-12-19 12:20:33,656 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] ++++ LongLivedSessionPropagationInterceptor
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.interpolator
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.interpolator
      2006-12-19 12:20:33,656 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.interpolator
      2006-12-19 12:20:33,656 ERROR [com.zua.business.ServiceBusinessImpl] Executing method on Service Business: com.zua.business.ServiceBusinessImpl@9403b0
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:36,468 DEBUG [org.jboss.ejb3.entity.ManagedEntityManagerFactory] ************** closing entity managersession **************
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.core.Manager] Storing conversation state: 6
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.core.Manager] conversation timeout for conversation: 2
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.conversation
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Contexts] destroying: serviceBusiness
      2006-12-19 12:20:36,468 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] ++++ LongLivedSessionPropagationInterceptor
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.interpolator
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.interpolator
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.interpolator
      2006-12-19 12:20:36,468 ERROR [com.zua.business.ServiceBusinessImpl] Destroying Service Business object: com.zua.business.ServiceBusinessImpl@1aaf3cb
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.interceptors.RemoveInterceptor] Stateful component was removed: serviceBusiness
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Lifecycle] After request, destroying contexts
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying business process context
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing server-side conversation context
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing session context
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying event context
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.manager
      2006-12-19 12:20:36,468 DEBUG [org.jboss.seam.contexts.Lifecycle] <<< End web request
      2006-12-19 12:20:36,500 DEBUG [org.jboss.seam.remoting.ExecutionHandler] ended request
      2006-12-19 12:20:36,500 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:36,500 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:36,531 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:36,531 DEBUG [org.jboss.seam.servlet.SeamExceptionFilter] ended request
      2006-12-19 12:20:37,734 DEBUG [org.jboss.seam.contexts.Lifecycle] >>> Begin web request
      2006-12-19 12:20:37,734 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.manager
      2006-12-19 12:20:37,734 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.manager
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.manager
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.core.Manager] Restoring conversation with id: 6
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] instantiating Seam component: serviceBusiness
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.util.Naming] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] initializing new instance of: serviceBusiness
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] done initializing: serviceBusiness
      2006-12-19 12:20:37,750 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] ++++ LongLivedSessionPropagationInterceptor
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] instantiating Seam component: org.jboss.seam.core.interpolator
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] initializing new instance of: org.jboss.seam.core.interpolator
      2006-12-19 12:20:37,750 DEBUG [org.jboss.seam.Component] done initializing: org.jboss.seam.core.interpolator
      2006-12-19 12:20:37,750 ERROR [com.zua.business.ServiceBusinessImpl] Executing method on Service Business: com.zua.business.ServiceBusinessImpl@b73feb
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Contexts] found in conversation context: org.jboss.seam.core.persistenceContexts
      2006-12-19 12:20:37,781 DEBUG [org.jboss.ejb3.entity.ManagedEntityManagerFactory] ************** closing entity managersession **************
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.core.Manager] Storing conversation state: 6
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Lifecycle] After request, destroying contexts
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying business process context
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing server-side conversation context
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Lifecycle] flushing session context
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Lifecycle] destroying event context
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Contexts] destroying: org.jboss.seam.core.manager
      2006-12-19 12:20:37,781 DEBUG [org.jboss.seam.contexts.Lifecycle] <<< End web request