[jboss-user] [JBoss Cache: Core Edition] - Re: Passivation false problem
rachna_agg
do-not-reply at jboss.com
Fri Jun 27 12:09:47 EDT 2008
Yes we have enabled JMX in tomcat and are retrieving the statistics from the MBeans "jboss.cache:service=TreeCache,cache-interceptor=CacheLoaderInterceptor" and "jboss.cache:service=TreeCache,cache-interceptor=CacheMgmtInterceptor".
I tried using the newer version 2.1.1.GA but got same results. Here are the logs after Step 2:
Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - process(): region: /
| Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - processed 0 node events in region: /
| Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - Recycle queue is empty
| Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 10000ms
| Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 10000ms
| Jun 27, 2008 09:36:11.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - process(): region: /
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - processed 0 node events in region: /
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - Recycle queue is empty
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 15000ms
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 15000ms
| Jun 27, 2008 09:36:16.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /3520 at rachna/42/1214582760875/8501033611511983927136 for owner Thread[http-8080-Processor24,5,main]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - invoke MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - don't load, key requested is null
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - load element /3520 at rachna/42/1214582760875/8501033611511983927136 mustLoad=false
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheStoreInterceptor - invoke MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CallInterceptor - Passing up method MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136) so it gets invoked on cache.
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Invoking EvictionInterceptor
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Updating node/element events with no tx
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Adding event EvictedEN[fqn=/3520 at rachna/42/1214582760875/8501033611511983927136 event=VISIT_NODE_EVENT diff=0] to region at /
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished updating node
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished invoking EvictionInterceptor
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread. Lock table is {Thread[http-8080-Processor24,5,main]=[read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]]]}
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875/8501033611511983927136: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /3520 at rachna/42/1214582760875/8501033611511983927136 for owner Thread[http-8080-Processor24,5,main]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor24,5,main], lock=<unlocked>
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - invoke MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - must Load, uninitialized
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - load element /3520 at rachna/42/1214582760875/8501033611511983927136 mustLoad=true
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _lock; MethodIdInteger: 33; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, WRITE, false)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _lock; MethodIdInteger: 33; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, WRITE, false)]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _lock; MethodIdInteger: 33; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, WRITE, false)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /3520 at rachna/42/1214582760875/8501033611511983927136 for owner Thread[http-8080-Processor24,5,main]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller Thread[http-8080-Processor24,5,main] already owns lock for /
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller Thread[http-8080-Processor24,5,main] already owns lock for /3520 at rachna
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller Thread[http-8080-Processor24,5,main] already owns lock for /3520 at rachna/42
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller Thread[http-8080-Processor24,5,main] already owns lock for /3520 at rachna/42/1214582760875
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller Thread[http-8080-Processor24,5,main] already owns lock for /3520 at rachna/42/1214582760875/8501033611511983927136
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor24,5,main], lock=read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - loadNode /3520 at rachna/42/1214582760875/8501033611511983927136
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.loader.JDBCCacheLoader - executing sql: select node from jbosscache where fqn=? (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.765 PM DEBUG org.jboss.cache.loader.ManagedConnectionFactory - Connection checked out: org.apache.tomcat.dbcp.dbcp.PoolableConnection at 1e2f6b0
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.marshall.VersionAwareMarshaller - Read version 20
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.marshall.CacheMarshaller200 - Unmarshalled object {somedata}
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - nodeExists true
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - Node data is not null, loading
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - Setting dataLoaded to true
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CacheStoreInterceptor - invoke MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CallInterceptor - Passing up method MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true) so it gets invoked on cache.
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.CacheImpl.JBossCache-Cluster - _get("/3520 at rachna/42/1214582760875/8501033611511983927136", "", "true")
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Invoking EvictionInterceptor
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Updating node/element events with no tx
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - No event added. Element does not exist
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished invoking EvictionInterceptor
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread. Lock table is {Thread[http-8080-Processor24,5,main]=[read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]], read owners=[Thread[http-8080-Processor24,5,main]]]}
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875/8501033611511983927136: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /: read owners=[Thread[http-8080-Processor24,5,main]]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)]
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - bypassed locking as method _getData() doesn't require locking
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - invoke MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CacheStoreInterceptor - invoke MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.CallInterceptor - Passing up method MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136) so it gets invoked on cache.
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Invoking EvictionInterceptor
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Updating node/element events with no tx
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Adding event EvictedEN[fqn=/3520 at rachna/42/1214582760875/8501033611511983927136 event=VISIT_NODE_EVENT diff=0] to region at /
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished updating node
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished invoking EvictionInterceptor
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread. Lock table is {}
| Jun 27, 2008 09:36:20.781 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - process(): region: /
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - processed 2 node events in region: /
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - Recycle queue is empty
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 0ms
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 0ms
| Jun 27, 2008 09:36:21.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - process(): region: /
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - processed 0 node events in region: /
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - Recycle queue is empty
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 5000ms
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 5000ms
| Jun 27, 2008 09:36:26.531 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
|
and after Step 3:
Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /3520 at rachna/42/1214582760875/8501033611511983927136 for owner Thread[http-8080-Processor25,5,main]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - invoke MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - don't load, key requested is null
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - load element /3520 at rachna/42/1214582760875/8501033611511983927136 mustLoad=false
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheStoreInterceptor - invoke MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CallInterceptor - Passing up method MethodName: _get; MethodIdInteger: 31; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136) so it gets invoked on cache.
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Invoking EvictionInterceptor
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Updating node/element events with no tx
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Adding event EvictedEN[fqn=/3520 at rachna/42/1214582760875/8501033611511983927136 event=VISIT_NODE_EVENT diff=0] to region at /
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished updating node
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished invoking EvictionInterceptor
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread. Lock table is {Thread[http-8080-Processor25,5,main]=[read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]]]}
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875/8501033611511983927136: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /3520 at rachna/42/1214582760875/8501033611511983927136 for owner Thread[http-8080-Processor25,5,main]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquiring RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor25,5,main], lock=<unlocked>
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.lock.IdentityLock - acquired RL: fqn=/3520 at rachna/42/1214582760875/8501033611511983927136, caller=Thread[http-8080-Processor25,5,main], lock=read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - invoke MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - load element /3520 at rachna/42/1214582760875/8501033611511983927136 mustLoad=false
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheStoreInterceptor - invoke MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CallInterceptor - Passing up method MethodName: _get; MethodIdInteger: 26; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136, , true) so it gets invoked on cache.
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.CacheImpl.JBossCache-Cluster - _get("/3520 at rachna/42/1214582760875/8501033611511983927136", "", "true")
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Invoking EvictionInterceptor
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Updating node/element events with no tx
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - No event added. Element does not exist
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished invoking EvictionInterceptor
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread. Lock table is {Thread[http-8080-Processor25,5,main]=[read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]], read owners=[Thread[http-8080-Processor25,5,main]]]}
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875/8501033611511983927136: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42/1214582760875: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna/42: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /3520 at rachna: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /: read owners=[Thread[http-8080-Processor25,5,main]]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting up transactional context.
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Setting tx as null and gtx as null
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.TxInterceptor - (null) call on method [MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)]
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - bypassed locking as method _getData() doesn't require locking
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheLoaderInterceptor - invoke MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CacheStoreInterceptor - invoke MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136)
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.CallInterceptor - Passing up method MethodName: _getData; MethodIdInteger: 24; Args: (/3520 at rachna/42/1214582760875/8501033611511983927136) so it gets invoked on cache.
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Invoking EvictionInterceptor
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Updating node/element events with no tx
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Adding event EvictedEN[fqn=/3520 at rachna/42/1214582760875/8501033611511983927136 event=VISIT_NODE_EVENT diff=0] to region at /
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished updating node
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.EvictionInterceptor - Finished invoking EvictionInterceptor
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread. Lock table is {}
| Jun 27, 2008 09:40:33.765 PM DEBUG org.jboss.cache.interceptors.InvocationContextInterceptor - Resetting invocation-scope options
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - process(): region: /
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - processed 2 node events in region: /
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.BaseEvictionAlgorithm - Recycle queue is empty
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 0ms
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 has been idle for 0ms
| Jun 27, 2008 09:40:36.593 PM DEBUG org.jboss.cache.eviction.LRUAlgorithm - Node /3520 at rachna/42/1214582760875/8501033611511983927136 should not be evicted
|
View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4161243#4161243
Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=4161243
More information about the jboss-user
mailing list