[jboss-user] [JBossCache] - Re: Strange ClassCastException in OptimisticCreateIfNotExist

spennec do-not-reply at jboss.com
Fri Nov 2 11:54:32 EDT 2007


Hi Manik,

I've sent a bunch of logging statements to a file, using log4j and a TRACE level appender.

This situation is a real problem for my project, thanks a lot for your help! :)

Here they are:


  | 
  | 
  | 2007-11-02 16:02:43,986 413229 TRACE [org.jboss.cache.ReplicationQueue] (Timer-7:) flush(): flushing repl queue (num elements=0)
  | 2007-11-02 16:02:44,017 413260 TRACE [org.jgroups.protocols.pbcast.STABLE] (Timer,MyProject-TreeCache-Cluster,10.23.65.38:2818:) setting latest_local_digest from NAKACK: [10.23.65.28:3963#2505, 10.23.65.38:2818#9]
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jgroups.protocols.pbcast.STABLE] (Timer,MyProject-TreeCache-Cluster,10.23.65.38:2818:) sending stable msg [10.23.65.28:3963#2505, 10.23.65.38:2818#9]
  | 2007-11-02 16:02:44,298 413541 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jgroups.protocols.pbcast.NAKACK] (Timer,MyProject-TreeCache-Cluster,10.23.65.38:2818:) sending 10.23.65.38:2818#10
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jgroups.protocols.UDP] (Timer,MyProject-TreeCache-Cluster,10.23.65.38:2818:) sending msg to null, src=10.23.65.38:2818, headers are {STABLE=[STABLE_GOSSIP]: digest is 10.23.65.38:2818: [0 : 9 (9)], 10.23.65.28:3963: [0 : 2505 (2508)], NAKACK=[MSG, seqno=10], UDP=[channel_name=MyProject-TreeCache-Cluster]}
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jgroups.protocols.UDP] (Timer,MyProject-TreeCache-Cluster,10.23.65.38:2818:) looping back message [dst: <null>, src: 10.23.65.38:2818 (3 headers), size=0 bytes, flags=OOB]
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jgroups.protocols.UDP] (UDP mcast receiver,MyProject-TreeCache-Cluster,10.23.65.38:2818:) received (mcast) 157 bytes from 10.23.65.38:6601
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest has been idle for 273700ms
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest should not be evicted
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest has been idle for 273700ms
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest should not be evicted
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/NoCliDos_cache has been idle for 366855ms
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/NoCliDos_cache should not be evicted
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache has been idle for 273700ms
  | 2007-11-02 16:02:44,783 414026 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache should not be evicted
  | 2007-11-02 16:02:44,861 414104 TRACE [org.jgroups.protocols.UDP] (UDP mcast receiver,MyProject-TreeCache-Cluster,10.23.65.38:2818:) received (mcast) 59 bytes from 10.23.65.28:6601
  | 2007-11-02 16:02:47,095 416338 TRACE [org.jgroups.protocols.UDP] (UDP mcast receiver,MyProject-TreeCache-Cluster,10.23.65.38:2818:) received (mcast) 59 bytes from 10.23.65.28:6601
  | 2007-11-02 16:02:47,111 416354 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Invoked on cache instance [10.23.65.38:2818] and InvocationContext [InvocationContext{methodCall=MethodName: optimisticPrepare; MethodIdInteger: 18; Args: (GlobalTransaction:<10.23.65.28:3963>:5, [MethodName: _remove; MethodIdInteger: 40; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType2s/MyDataType2 de TotoTest, true, Ver=2), MethodName: _remove; MethodIdInteger: 40; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, true, Ver=2), MethodName: _remove; MethodIdInteger: 40; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/NoCliDos_cache, true, Ver=2), MethodName: _put; MethodIdInteger: 39; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, item, {BIG_TOSTRING}
  | 
  | 
  | 
  | 
  | 2007-11-02 16:02:47,298 416541 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting up transactional context.
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting tx as Xid=BEA1-006D91DC3593C0F2F661(25018081),Status=Active,numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=14,seconds left=16,activeThread=Thread[Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818,5,Incoming],SCInfo[domain_MyProject+main-env_MyCompany_MyProject_intMgd01]=(state=active),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=main-env_MyCompany_MyProject_intMgd01+10.23.65.38:6611+domain_MyProject+t3+, XAResources={weblogic.jdbc.wrapper.JTSXAResourceImpl},NonXAResources={})],CoordinatorURL=main-env_MyCompany_MyProject_intMgd01+10.23.65.38:6611+domain_MyProject+t3+) and gtx as GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest has been idle for 276872ms
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest should not be evicted
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest has been idle for 276872ms
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest should not be evicted
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/NoCliDos_cache has been idle for 370027ms
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/NoCliDos_cache should not be evicted
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache has been idle for 276872ms
  | 2007-11-02 16:02:47,955 417198 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache should not be evicted
  | 2007-11-02 16:02:48,439 417682 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) (10.23.65.38:2818) call on method [MethodName: optimisticPrepare; MethodIdInteger: 18; Args: (GlobalTransaction:<10.23.65.28:3963>:5, [MethodName: _remove; MethodIdInteger: 40; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType2s/MyDataType2 de TotoTest, true, Ver=2), MethodName: _remove; MethodIdInteger: 40; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, true, Ver=2), MethodName: _remove; MethodIdInteger: 40; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/NoCliDos_cache, true, Ver=2), MethodName: _put; MethodIdInteger: 39; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, item, {BIG_TOSTRING}
  | 
  | 
  | 2007-11-02 16:02:49,955 419198 TRACE [org.jboss.cache.ReplicationQueue] (Timer-7:) flush(): flushing repl queue (num elements=0)
  | 2007-11-02 16:02:50,298 419541 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /
  | 2007-11-02 16:02:50,923 420166 DEBUG [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Got gtx from invocation context GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Creating transaction for thread Thread[Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818,5,Incoming]
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Created new tx for gtx GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:50,923 420166 DEBUG [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Started new local TX as result of remote PREPARE: local TX=Xid=BEA1-006E91DC3593(40564248),Status=Active,numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=0,seconds left=30,activeThread=Thread[Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818,5,Incoming],SCInfo[domain_MyProject+main-env_MyCompany_MyProject_intMgd01]=(state=active),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=main-env_MyCompany_MyProject_intMgd01+10.23.65.38:6611+domain_MyProject+t3+, XAResources={weblogic.jdbc.wrapper.JTSXAResourceImpl},NonXAResources={})]) (Status=0), global TX=GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Resuming existing transaction Xid=BEA1-006E91DC3593(40564248),Status=Active,numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=0,seconds left=30,activeThread=Thread[Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818,5,Incoming],SCInfo[domain_MyProject+main-env_MyCompany_MyProject_intMgd01]=(state=active),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=main-env_MyCompany_MyProject_intMgd01+10.23.65.38:6611+domain_MyProject+t3+, XAResources={weblogic.jdbc.wrapper.JTSXAResourceImpl},NonXAResources={})]), global TX=GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest has been idle for 279840ms
  | 2007-11-02 16:02:50,923 420166 DEBUG [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) creating new tx entry
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest should not be evicted
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) TxTable contents: 2 mappings, 2 transactions
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting up transactional context.
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest has been idle for 279840ms
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting tx as Xid=BEA1-006E91DC3593(40564248),Status=Active,numRepliesOwedMe=0,numRepliesOwedOthers=0,seconds since begin=0,seconds left=30,activeThread=Thread[Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818,5,Incoming],SCInfo[domain_MyProject+main-env_MyCompany_MyProject_intMgd01]=(state=active),OwnerTransactionManager=ServerTM[ServerCoordinatorDescriptor=(CoordinatorURL=main-env_MyCompany_MyProject_intMgd01+10.23.65.38:6611+domain_MyProject+t3+, XAResources={weblogic.jdbc.wrapper.JTSXAResourceImpl},NonXAResources={})]) and gtx as GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType2s/MyDataType2 de TotoTest should not be evicted
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) registering for TX completion: SynchronizationHandler(TxInterceptor.RemoteSynchronizationHandler(gtx=GlobalTransaction:<10.23.65.28:3963>:5, tx=weblogic.transaction.internal.ServerTransactionImpl at 40564248))
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:50,923 420166 DEBUG [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Handling optimistic remote prepare GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/NoCliDos_cache has been idle for 372995ms
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/NoCliDos_cache should not be evicted
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Processing method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType2s/MyDataType2 de TotoTest, true)
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache has been idle for 279840ms
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Received method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType2s/MyDataType2 de TotoTest, true) not handling
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache should not be evicted
  | 2007-11-02 16:02:50,923 420166 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting versioning for node /MyProject/MyDataType2s/MyDataType2 de TotoTest to explicit
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) marking node /MyProject/MyDataType2s/MyDataType2 de TotoTest as deleted
  | 2007-11-02 16:02:50,939 420182 DEBUG [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding Method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType2s/MyDataType2 de TotoTest, true) to modification list
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Invoking EvictionInterceptor
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Updating node/element events with no tx
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding event EvictedEN[fqn=/MyProject/MyDataType2s/MyDataType2 de TotoTest event=REMOVE_NODE_EVENT diff=0] to region at /MyProject/MyDataType2s
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished updating node
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished invoking EvictionInterceptor
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Processing method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, true)
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Received method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, true) not handling
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting versioning for node /MyProject/MyDataType1s/MyDataType1_cache to explicit
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) marking node /MyProject/MyDataType1s/MyDataType1_cache as deleted
  | 2007-11-02 16:02:50,939 420182 DEBUG [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding Method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, true) to modification list
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Invoking EvictionInterceptor
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Updating node/element events with no tx
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding event EvictedEN[fqn=/MyProject/MyDataType1s/MyDataType1_cache event=REMOVE_NODE_EVENT diff=0] to region at /MyProject/MyDataType1s
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished updating node
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished invoking EvictionInterceptor
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Processing method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/NoCliDos_cache, true)
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Received method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/NoCliDos_cache, true) not handling
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Setting versioning for node /MyProject/MyDataType1s/NoCliDos_cache to explicit
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) marking node /MyProject/MyDataType1s/NoCliDos_cache as deleted
  | 2007-11-02 16:02:50,939 420182 DEBUG [org.jboss.cache.interceptors.OptimisticNodeInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding Method MethodName: _remove; MethodIdInteger: 5; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/NoCliDos_cache, true) to modification list
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Invoking EvictionInterceptor
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Updating node/element events with no tx
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding event EvictedEN[fqn=/MyProject/MyDataType1s/NoCliDos_cache event=REMOVE_NODE_EVENT diff=0] to region at /MyProject/MyDataType1s
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished updating node
  | 2007-11-02 16:02:50,939 420182 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished invoking EvictionInterceptor
  | 2007-11-02 16:02:51,111 420354 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Processing method MethodName: _put; MethodIdInteger: 3; Args: (GlobalTransaction:<10.23.65.28:3963>:5, /MyProject/MyDataType1s/MyDataType1_cache, item, {BIGF_TOSTRING}
  | 
  | 
  | 2007-11-02 16:02:54,970 424213 TRACE [org.jboss.cache.ReplicationQueue] (Timer-7:) flush(): flushing repl queue (num elements=0)
  | 2007-11-02 16:02:54,986 424229 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Invoking EvictionInterceptor
  | 2007-11-02 16:02:54,986 424229 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Updating node/element events with no tx
  | 2007-11-02 16:02:54,986 424229 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Adding event EvictedEN[fqn=/MyProject/MyDataType1s/MyDataType1_cache event=ADD_ELEMENT_EVENT diff=1] to region at /MyProject/MyDataType1s
  | 2007-11-02 16:02:54,986 424229 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished updating node
  | 2007-11-02 16:02:54,986 424229 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished invoking EvictionInterceptor
  | 2007-11-02 16:02:55,158 424401 TRACE [org.jboss.cache.interceptors.OptimisticReplicationInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Processing method MethodName: _put; MethodIdInteger: 3; Args: (BIG_TOSTRING}
  | 
  | 
  | 2007-11-02 16:02:56,923 426166 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 0 node events in region: /MyProject/MyDataType2s
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) process(): region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Adding element /MyProject/MyDataType1s/MyDataType1_cache for a node that doesn't exist yet. Process as an add.
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Adding node /MyProject/MyDataType1s/MyDataType1_cache with 1 elements to eviction queue
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) /MyProject/MyDataType1s/MyDataType1_cache added successfully to eviction queue
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) processed 1 node events in region: /MyProject/MyDataType1s
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.BaseEvictionAlgorithm] (EvictionTimer-0:) Recycle queue is empty
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache has been idle for 0ms
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache should not be evicted
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache has been idle for 0ms
  | 2007-11-02 16:02:57,283 426526 TRACE [org.jboss.cache.eviction.LRUAlgorithm] (EvictionTimer-0:) Node /MyProject/MyDataType1s/MyDataType1_cache should not be evicted
  | 2007-11-02 16:02:57,298 426541 ERROR [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) method invocation failed
  | java.lang.ClassCastException: com.MyCompany.MyProject.cache.CachedMyDataType1
  |  at org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor.invoke(OptimisticCreateIfNotExistsInterceptor.java:57)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.OptimisticValidatorInterceptor.invoke(OptimisticValidatorInterceptor.java:67)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.OptimisticLockingInterceptor.invoke(OptimisticLockingInterceptor.java:99)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.OptimisticReplicationInterceptor.invoke(OptimisticReplicationInterceptor.java:137)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.NotificationInterceptor.invoke(NotificationInterceptor.java:32)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.TxInterceptor.replayModifications(TxInterceptor.java:511)
  |  at org.jboss.cache.interceptors.TxInterceptor.handleOptimisticPrepare(TxInterceptor.java:373)
  |  at org.jboss.cache.interceptors.TxInterceptor.handleRemotePrepare(TxInterceptor.java:250)
  |  at org.jboss.cache.interceptors.TxInterceptor.invoke(TxInterceptor.java:100)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.CacheMgmtInterceptor.invoke(CacheMgmtInterceptor.java:123)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.InvocationContextInterceptor.invoke(InvocationContextInterceptor.java:62)
  |  at org.jboss.cache.CacheImpl.invokeMethod(CacheImpl.java:3939)
  |  at org.jboss.cache.CacheImpl._replicate(CacheImpl.java:2853)
  |  at sun.reflect.NativeMethoMyProjectcessorImpl.invoke0(Native Method)
  |  at sun.reflect.NativeMethoMyProjectcessorImpl.invoke(NativeMethoMyProjectcessorImpl.java:39)
  |  at sun.reflect.DelegatingMethoMyProjectcessorImpl.invoke(DelegatingMethoMyProjectcessorImpl.java:25)
  |  at java.lang.reflect.Method.invoke(Method.java:585)
  |  at org.jgroups.blocks.MethodCall.invoke(MethodCall.java:330)
  |  at org.jboss.cache.interceptors.CallInterceptor.invoke(CallInterceptor.java:49)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  |  at org.jboss.cache.interceptors.OptimisticNodeInterceptor.invoke(OptimisticNodeInterceptor.java:161)
  |  at org.jboss.cache.interceptors.Interceptor.invoke(Interceptor.java:76)
  | 2007-11-02 16:02:57,314 426557 DEBUG [org.jboss.cache.interceptors.TxInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Finished remote prepare GlobalTransaction:<10.23.65.28:3963>:5
  | 2007-11-02 16:02:57,314 426557 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] (Incoming Thread,MyProject-TreeCache-Cluster,10.23.65.38:2818:) Resetting invocation-scope options
  | 

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

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



More information about the jboss-user mailing list