[jboss-user] [JBossCache] - Re: Config Question

lovelyliatroim do-not-reply at jboss.com
Wed Jan 23 09:26:54 EST 2008


Here you go


  | 2008-01-23 15:16:25,916 INFO  [STDOUT] 2008-01-23 15:16:25,916 DEBUG [at.sit.cdms.web.actions.ActionFactory] - Looking for bean addItem
  | 
  | 2008-01-23 15:16:25,916 DEBUG [at.sit.cdms.web.actions.ActionFactory] Looking for bean addItem
  | 
  | 2008-01-23 15:16:25,916 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] Returning cached instance of singleton bean 'addItem'
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _put; MethodIdInteger: 3; Args: (null, /quotes/2, image, at.sit.cache.node.DataItem at 1a29afb, true)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=true, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [MethodName: _put; MethodIdInteger: 3; Args: (null, /quotes/2, image, at.sit.cache.node.DataItem at 1a29afb, true)]
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.TxInterceptor] Creating transaction for thread Thread[http-127.0.0.1-8080-1,5,jboss]
  | 
  | 2008-01-23 15:16:25,916 DEBUG [org.jboss.cache.interceptors.TxInterceptor]  local transaction exists - registering global tx if not present for Thread[http-127.0.0.1-8080-1,5,jboss]
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is null
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] created new GTX: GlobalTransaction:<null>:2, local TX=TransactionImple < ac, BasicAction: afb9924:679:47974b77:75 status: ActionStatus.RUNNING >
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.TxInterceptor] Registering sync handler for tx TransactionImple < ac, BasicAction: afb9924:679:47974b77:75 status: ActionStatus.RUNNING >, gtx GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.TxInterceptor] registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:2, tx=com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple at 7273602))
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: _put; MethodIdInteger: 3; Args: (GlobalTransaction:<null>:2, /quotes/2, image, at.sit.cache.node.DataItem at 1a29afb, true)
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: _put; MethodIdInteger: 3; Args: (GlobalTransaction:<null>:2, /quotes/2, image, at.sit.cache.node.DataItem at 1a29afb, true)
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] must load, node null
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] load element /quotes/2 mustLoad=true
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.UnversionedNode] created child: fqn=/quotes/2
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] createTempNode n VersionedNode[ /quotes/2 data=[]]
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] loadNode /quotes/2
  | 
  | 2008-01-23 15:16:25,916 DEBUG [org.jboss.cache.loader.JDBCCacheLoader] executing sql: select node from jbosscache where fqn=? (/quotes/2)
  | 
  | 2008-01-23 15:16:25,916 TRACE [org.jboss.cache.loader.ManagedConnectionFactory] Connection checked out: org.jboss.resource.adapter.jdbc.jdk5.WrappedConnectionJDK5 at 83c235
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] nodeExists false
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Setting dataLoaded to true
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] Setting versioning for node /quotes/2 to implicit
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoking EvictionInterceptor
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Updating node/element events with no tx
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/quotes/2 event=ADD_ELEMENT_EVENT diff=1] to region at /quotes
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished updating node
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished invoking EvictionInterceptor
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Running beforeCompletion on gtx GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:75 status: ActionStatus.RUNNING > and gtx as GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] No modifications in this tx.  Skipping beforeCompletion()
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:75 status: ActionStatus.COMMITTED > and gtx as GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] calling aftercompletion for GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Running commit phase.  One phase? false
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor]  running commit for GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:2)
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Commit called with no modifications; ignoring.
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:2)
  | 
  | 2008-01-23 15:16:25,931 DEBUG [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Commiting successfully validated changes for GlobalTransaction GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Merging data since node is dirty
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Versioning is implicit; incrementing.
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Setting version of node /quotes/2 from Ver=0 to Ver=1
  | 
  | 2008-01-23 15:16:25,931 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished local commit/rollback method for GlobalTransaction:<null>:2
  | 
  | 2008-01-23 15:16:25,931 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished commit phase
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:16:25,931 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Resetting invocation-scope options
  | 
  | 2008-01-23 15:16:25,931 INFO  [STDOUT] 2008-01-23 15:16:25,931 DEBUG [at.sit.cdms.web.actions.test.AddItem] - Added item with index of 2
  | 
  | 2008-01-23 15:16:25,931 DEBUG [at.sit.cdms.web.actions.test.AddItem] Added item with index of 2
  | 
  | 2008-01-23 15:16:42,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] process(): region: /quotes
  | 
  | 2008-01-23 15:16:42,400 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding element /quotes/1 for a node that doesn't exist yet. Process as an add.
  | 
  | 2008-01-23 15:16:42,400 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding node /quotes/1 with 1 elements to eviction queue
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] /quotes/1 added successfully to eviction queue
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding element /quotes/2 for a node that doesn't exist yet. Process as an add.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding node /quotes/2 with 1 elements to eviction queue
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] /quotes/2 added successfully to eviction queue
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] processed 2 node events in region: /quotes
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Recycle queue is empty
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/1 has been idle for 47ms
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/1 should not be evicted
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/1 has been idle for 47ms
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/1 should not be evicted
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/1 will be evicted because of exceeding the maxNode limit. maxNode: 1 but current queue size is: 2
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Attempting to evict cache node with fqn of /quotes/1
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/1)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/1)]
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Creating transaction for thread Thread[EvictionTimer-0,5,jboss]
  | 
  | 2008-01-23 15:16:42,447 DEBUG [org.jboss.cache.interceptors.TxInterceptor]  local transaction exists - registering global tx if not present for Thread[EvictionTimer-0,5,jboss]
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is null
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] created new GTX: GlobalTransaction:<null>:3, local TX=TransactionImple < ac, BasicAction: afb9924:679:47974b77:79 status: ActionStatus.RUNNING >
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Registering sync handler for tx TransactionImple < ac, BasicAction: afb9924:679:47974b77:79 status: ActionStatus.RUNNING >, gtx GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:3, tx=com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple at 10900158))
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/1)
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/1)
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] read Method MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/1) called - Not handling, passing on.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CallInterceptor] Passing up method MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/1) so it gets invoked on cache.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] _evict(/quotes/1)
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] _remove(null, "/quotes/1", undo=false)
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoking EvictionInterceptor
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Updating node/element events with no tx
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished invoking EvictionInterceptor
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Running beforeCompletion on gtx GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:79 status: ActionStatus.RUNNING > and gtx as GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] No modifications in this tx.  Skipping beforeCompletion()
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:79 status: ActionStatus.COMMITTED > and gtx as GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor] calling aftercompletion for GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,447 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Running commit phase.  One phase? false
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.TxInterceptor]  running commit for GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:3)
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Commit called with no modifications; ignoring.
  | 
  | 2008-01-23 15:16:42,447 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:3)
  | 
  | 2008-01-23 15:16:42,447 DEBUG [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Commiting successfully validated changes for GlobalTransaction GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,463 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished local commit/rollback method for GlobalTransaction:<null>:3
  | 
  | 2008-01-23 15:16:42,463 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished commit phase
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Resetting invocation-scope options
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Eviction of cache node with fqn of /quotes/1 successful
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] process(): region: /
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] processed 0 node events in region: /
  | 
  | 2008-01-23 15:16:42,463 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Recycle queue is empty
  | 
  | 2008-01-23 15:17:02,931 INFO  [STDOUT] 2008-01-23 15:17:02,931 DEBUG [at.sit.cdms.web.actions.ActionFactory] - Looking for bean addItem
  | 
  | **************Here starts next addition to tree********************
  | 
  | 
  | 2008-01-23 15:17:02,931 DEBUG [at.sit.cdms.web.actions.ActionFactory] Looking for bean addItem
  | 
  | 2008-01-23 15:17:02,931 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] Returning cached instance of singleton bean 'addItem'
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _put; MethodIdInteger: 3; Args: (null, /quotes/3, image, at.sit.cache.node.DataItem at 56d15d, true)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=true, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [MethodName: _put; MethodIdInteger: 3; Args: (null, /quotes/3, image, at.sit.cache.node.DataItem at 56d15d, true)]
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Creating transaction for thread Thread[http-127.0.0.1-8080-1,5,jboss]
  | 
  | 2008-01-23 15:17:02,931 DEBUG [org.jboss.cache.interceptors.TxInterceptor]  local transaction exists - registering global tx if not present for Thread[http-127.0.0.1-8080-1,5,jboss]
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is null
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] created new GTX: GlobalTransaction:<null>:4, local TX=TransactionImple < ac, BasicAction: afb9924:679:47974b77:7b status: ActionStatus.RUNNING >
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] Registering sync handler for tx TransactionImple < ac, BasicAction: afb9924:679:47974b77:7b status: ActionStatus.RUNNING >, gtx GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.TxInterceptor] registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:4, tx=com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple at 7083822))
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: _put; MethodIdInteger: 3; Args: (GlobalTransaction:<null>:4, /quotes/3, image, at.sit.cache.node.DataItem at 56d15d, true)
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: _put; MethodIdInteger: 3; Args: (GlobalTransaction:<null>:4, /quotes/3, image, at.sit.cache.node.DataItem at 56d15d, true)
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] must load, node null
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] load element /quotes/3 mustLoad=true
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.UnversionedNode] created child: fqn=/quotes/3
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] createTempNode n VersionedNode[ /quotes/3 data=[]]
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] loadNode /quotes/3
  | 
  | 2008-01-23 15:17:02,931 DEBUG [org.jboss.cache.loader.JDBCCacheLoader] executing sql: select node from jbosscache where fqn=? (/quotes/3)
  | 
  | 2008-01-23 15:17:02,931 TRACE [org.jboss.cache.loader.ManagedConnectionFactory] Connection checked out: org.jboss.resource.adapter.jdbc.jdk5.WrappedConnectionJDK5 at 65dea9
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] nodeExists false
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Setting dataLoaded to true
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] Setting versioning for node /quotes/3 to implicit
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoking EvictionInterceptor
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Updating node/element events with no tx
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/quotes/3 event=ADD_ELEMENT_EVENT diff=1] to region at /quotes
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished updating node
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished invoking EvictionInterceptor
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Running beforeCompletion on gtx GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:7b status: ActionStatus.RUNNING > and gtx as GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] No modifications in this tx.  Skipping beforeCompletion()
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:7b status: ActionStatus.COMMITTED > and gtx as GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] calling aftercompletion for GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Running commit phase.  One phase? false
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor]  running commit for GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:4)
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Commit called with no modifications; ignoring.
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:4)
  | 
  | 2008-01-23 15:17:02,947 DEBUG [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Commiting successfully validated changes for GlobalTransaction GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Merging data since node is dirty
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Versioning is implicit; incrementing.
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Setting version of node /quotes/3 from Ver=0 to Ver=1
  | 
  | 2008-01-23 15:17:02,947 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished local commit/rollback method for GlobalTransaction:<null>:4
  | 
  | 2008-01-23 15:17:02,947 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished commit phase
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:17:02,947 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Resetting invocation-scope options
  | 
  | 2008-01-23 15:17:02,947 INFO  [STDOUT] 2008-01-23 15:17:02,947 DEBUG [at.sit.cdms.web.actions.test.AddItem] - Added item with index of 3
  | 
  | 2008-01-23 15:17:02,947 DEBUG [at.sit.cdms.web.actions.test.AddItem] Added item with index of 3
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] process(): region: /quotes
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding element /quotes/3 for a node that doesn't exist yet. Process as an add.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Adding node /quotes/3 with 1 elements to eviction queue
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] /quotes/3 added successfully to eviction queue
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] processed 1 node events in region: /quotes
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Recycle queue is empty
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/2 has been idle for 29906ms
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/2 should not be evicted
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/2 has been idle for 29906ms
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/2 should not be evicted
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.LRUAlgorithm] Node /quotes/2 will be evicted because of exceeding the maxNode limit. maxNode: 1 but current queue size is: 2
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Attempting to evict cache node with fqn of /quotes/2
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/2)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=false, dataVersion=null, suppressLocking=false, forceDataGravitation=false, skipDataGravitation=false}, originLocal=true, txHasMods=false}]
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] (null) call on method [MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/2)]
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Creating transaction for thread Thread[EvictionTimer-0,5,jboss]
  | 
  | 2008-01-23 15:17:12,353 DEBUG [org.jboss.cache.interceptors.TxInterceptor]  local transaction exists - registering global tx if not present for Thread[EvictionTimer-0,5,jboss]
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is null
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] created new GTX: GlobalTransaction:<null>:5, local TX=TransactionImple < ac, BasicAction: afb9924:679:47974b77:7f status: ActionStatus.RUNNING >
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Registering sync handler for tx TransactionImple < ac, BasicAction: afb9924:679:47974b77:7f status: ActionStatus.RUNNING >, gtx GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:5, tx=com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionImple at 9930886))
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/2)
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/2)
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] read Method MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/2) called - Not handling, passing on.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CallInterceptor] Passing up method MethodName: _evict; MethodIdInteger: 8; Args: (/quotes/2) so it gets invoked on cache.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] _evict(/quotes/2)
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] _remove(null, "/quotes/2", undo=false)
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoking EvictionInterceptor
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Updating node/element events with no tx
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished invoking EvictionInterceptor
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Running beforeCompletion on gtx GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:7f status: ActionStatus.RUNNING > and gtx as GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] No modifications in this tx.  Skipping beforeCompletion()
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as TransactionImple < ac, BasicAction: afb9924:679:47974b77:7f status: ActionStatus.COMMITTED > and gtx as GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] calling aftercompletion for GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Running commit phase.  One phase? false
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor]  running commit for GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:5)
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Commit called with no modifications; ignoring.
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] invoke MethodName: commit; MethodIdInteger: 11; Args: (GlobalTransaction:<null>:5)
  | 
  | 2008-01-23 15:17:12,353 DEBUG [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Commiting successfully validated changes for GlobalTransaction GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished local commit/rollback method for GlobalTransaction:<null>:5
  | 
  | 2008-01-23 15:17:12,353 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished commit phase
  | 
  | 2008-01-23 15:17:12,353 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
  | 
  | 2008-01-23 15:17:12,369 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as null and gtx as null
  | 
  | 2008-01-23 15:17:12,369 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Resetting invocation-scope options
  | 
  | 2008-01-23 15:17:12,369 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Eviction of cache node with fqn of /quotes/2 successful
  | 
  | 2008-01-23 15:17:12,369 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] process(): region: /
  | 
  | 2008-01-23 15:17:12,369 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] processed 0 node events in region: /
  | 
  | 2008-01-23 15:17:12,369 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] Recycle queue is empty
  | 



View the original post : http://www.jboss.com/index.html?module=bb&op=viewtopic&p=4122649#4122649

Reply to the post : http://www.jboss.com/index.html?module=bb&op=posting&mode=reply&p=4122649



More information about the jboss-user mailing list