[jboss-user] [JBossCache] - Re: Performence

Thu Sep 7 03:13:53 EDT 2006

Hey, 

"Use your own example and do inspect the log file (under DEBUG). If you only do field update, you should see only _put() but no putObject(). Does that make sense?"

The is the DEBUG log print out, for the code in my prev message:

07/09 09:43:37,607 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", AOPInstance, "false")
07/09 09:43:37,611 [main] DEBUG org.jboss.cache.marshall.RegionManager - getRegion(): user-specified region not found: /a/b
07/09 09:43:37,611 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", __jboss:internal:class__, "false")
07/09 09:43:37,611 [main] DEBUG org.jboss.cache.TreeCache - putObject(): Fqn:/a/b
07/09 09:43:37,614 [main] DEBUG org.jboss.cache.TreeCache - created new GTX: GlobalTransaction:<192.168.11.105:33069>:1, local TX=org.jboss.cache.transaction.DummyTransaction at 1d85f79
07/09 09:43:37,614 [main] DEBUG org.jboss.cache.TreeCache - lockPojo(): Fqn:/a/b Owner: GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,615 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, _lock_, LOCK, true)]
07/09 09:43:37,615 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor -  local transaction exists - registering global tx if not present for Thread[main,5,main]
07/09 09:43:37,615 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Associated gtx in txTable is GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,615 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Registering sync handler for tx org.jboss.cache.transaction.DummyTransaction at 1d85f79, gtx GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,617 [main] DEBUG org.jboss.cache.transaction.DummyTransaction - registering synchronization handler tx=org.jboss.cache.transaction.DummyTransaction at 1d85f79, handlers=[]
07/09 09:43:37,617 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<192.168.11.105:33069>:1, tx=org.jboss.cache.transaction.DummyTransaction at 1d85f79))
07/09 09:43:37,617 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, _lock_, LOCK, true)
07/09 09:43:37,618 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b for owner GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,618 [main] DEBUG org.jboss.cache.Node - created child: fqn=/a
07/09 09:43:37,618 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=
07/09 09:43:37,619 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=read owners=[GlobalTransaction:<192.168.11.105:33069>:1]
07/09 09:43:37,619 [main] DEBUG org.jboss.cache.Node - created child: fqn=/a/b
07/09 09:43:37,619 [main] DEBUG org.jboss.cache.Node - acquiring WL: fqn=/a/b, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=
07/09 09:43:37,619 [main] DEBUG org.jboss.cache.Node - acquired WL: fqn=/a/b, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=write owner=GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,619 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, _lock_, LOCK, true) on cache.
07/09 09:43:37,619 [main] DEBUG org.jboss.cache.TreeCache - _put(GlobalTransaction:<192.168.11.105:33069>:1, "/a/b", _lock_, LOCK)
07/09 09:43:37,621 [main] DEBUG org.jboss.cache.transaction.DummyTransaction - registering synchronization handler org.jboss.cache.aop.PojoTxSynchronizationHandler at 10e3293
07/09 09:43:37,621 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", AOPInstance, "false")
07/09 09:43:37,622 [main] DEBUG org.jboss.cache.aop.TreeCacheAopDelegate - putObject(): fqn: /a/b
07/09 09:43:37,640 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1}, true)]
07/09 09:43:37,640 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor -  local transaction exists - registering global tx if not present for Thread[main,5,main]
07/09 09:43:37,640 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Associated gtx in txTable is GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Transaction org.jboss.cache.transaction.DummyTransaction at 1d85f79 is already registered.
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1}, true)
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Suppressing locking
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Creating nodes if necessary
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1}, true) on cache.
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.TreeCache - _put(GlobalTransaction:<192.168.11.105:33069>:1, "/a/b", {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1})
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", AOPInstance, "false")
07/09 09:43:37,641 [main] DEBUG org.jboss.cache.aop.TreeCacheAopDelegate - putObject(): fqn: /a/b/address
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/address, {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city}, true)]
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor -  local transaction exists - registering global tx if not present for Thread[main,5,main]
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Associated gtx in txTable is GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Transaction org.jboss.cache.transaction.DummyTransaction at 1d85f79 is already registered.
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/address, {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city}, true)
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Suppressing locking
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Creating nodes if necessary
07/09 09:43:37,642 [main] DEBUG org.jboss.cache.Node - created child: fqn=/a/b/address
07/09 09:43:37,643 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/address, {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city}, true) on cache.
07/09 09:43:37,643 [main] DEBUG org.jboss.cache.TreeCache - _put(GlobalTransaction:<192.168.11.105:33069>:1, "/a/b/address", {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city})
07/09 09:43:37,643 [main] DEBUG org.jboss.cache.aop.TreeCacheAopDelegate - _regularPutObject(): inserting with fqn: /a/b/address
07/09 09:43:37,643 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/courses", AOPInstance, "false")
07/09 09:43:37,643 [main] DEBUG org.jboss.cache.aop.TreeCacheAopDelegate - putObject(): fqn: /a/b/courses
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.aop.CollectionClassHandler - collectionPutObject(): aspectized obj is a Set type of size: 0
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, __jboss:internal:class__, class java.util.LinkedHashSet, true)]
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor -  local transaction exists - registering global tx if not present for Thread[main,5,main]
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Associated gtx in txTable is GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Transaction org.jboss.cache.transaction.DummyTransaction at 1d85f79 is already registered.
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, __jboss:internal:class__, class java.util.LinkedHashSet, true)
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Suppressing locking
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Creating nodes if necessary
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.Node - created child: fqn=/a/b/courses
07/09 09:43:37,644 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, __jboss:internal:class__, class java.util.LinkedHashSet, true) on cache.
07/09 09:43:37,645 [main] DEBUG org.jboss.cache.TreeCache - _put(GlobalTransaction:<192.168.11.105:33069>:1, "/a/b/courses", __jboss:internal:class__, class java.util.LinkedHashSet)
07/09 09:43:38,024 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77, true)]
07/09 09:43:38,024 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor -  local transaction exists - registering global tx if not present for Thread[main,5,main]
07/09 09:43:38,024 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Associated gtx in txTable is GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,024 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Transaction org.jboss.cache.transaction.DummyTransaction at 1d85f79 is already registered.
07/09 09:43:38,025 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77, true)
07/09 09:43:38,025 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/courses for owner GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,025 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=read owners=[GlobalTransaction:<192.168.11.105:33069>:1]
07/09 09:43:38,025 [main] DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller GlobalTransaction:<192.168.11.105:33069>:1 already owns lock for /a
07/09 09:43:38,025 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=read owners=[GlobalTransaction:<192.168.11.105:33069>:1]
07/09 09:43:38,026 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=write owner=GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,026 [main] DEBUG org.jboss.cache.lock.IdentityLock - acquireReadLock(): caller GlobalTransaction:<192.168.11.105:33069>:1 already owns lock for /a/b
07/09 09:43:38,026 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=write owner=GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,026 [main] DEBUG org.jboss.cache.Node - acquiring WL: fqn=/a/b/courses, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=
07/09 09:43:38,026 [main] DEBUG org.jboss.cache.Node - acquired WL: fqn=/a/b/courses, caller=GlobalTransaction:<192.168.11.105:33069>:1, lock=write owner=GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,027 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77, true) on cache.
07/09 09:43:38,027 [main] DEBUG org.jboss.cache.TreeCache - _put(GlobalTransaction:<192.168.11.105:33069>:1, "/a/b/courses", AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77)
07/09 09:43:38,027 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/courses", AOPInstance, "false")
07/09 09:43:38,027 [main] DEBUG org.jboss.cache.aop.TreeCacheAopDelegate - _regularPutObject(): inserting with fqn: /a/b
07/09 09:43:38,027 [main] DEBUG org.jboss.cache.transaction.DummyTransaction - processing beforeCompletion for tx=org.jboss.cache.transaction.DummyTransaction at 1d85f79, handlers=[TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<192.168.11.105:33069>:1, tx=org.jboss.cache.transaction.DummyTransaction at 1d85f79)]
07/09 09:43:38,027 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Running beforeCompletion on gtx GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,029 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method prepare(GlobalTransaction:<192.168.11.105:33069>:1, [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, _lock_, LOCK, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1}, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/address, {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city}, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, __jboss:internal:class__, class java.util.LinkedHashSet, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77, true)], 192.168.11.105:33069, false)
07/09 09:43:38,029 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - bypassed locking as method prepare() doesn't require locking
07/09 09:43:38,029 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Suppressing invocation of method prepare(GlobalTransaction:<192.168.11.105:33069>:1, [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, _lock_, LOCK, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1}, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/address, {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city}, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, __jboss:internal:class__, class java.util.LinkedHashSet, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77, true)], 192.168.11.105:33069, false) on cache.
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - (192.168.11.105:33069): running remote prepare for global tx GlobalTransaction:<192.168.11.105:33069>:1 with async mode=false
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Broadcasting call prepare(GlobalTransaction:<192.168.11.105:33069>:1, [_put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, _lock_, LOCK, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b, {__jboss:internal:class__=class com.protagonis.cache.Student, AOPInstance=org.jboss.cache.aop.AOPInstance at 12a3722, name=Name1, school=school1}, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/address, {street=str, __jboss:internal:class__=class com.protagonis.cache.Address, AOPInstance=org.jboss.cache.aop.AOPInstance at 89cf1e, zip=1, city=city}, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, __jboss:internal:class__, class java.util.LinkedHashSet, true), _put(GlobalTransaction:<192.168.11.105:33069>:1, /a/b/courses, AOPInstance, org.jboss.cache.aop.AOPInstance at 1f17e77, true)], 192.168.11.105:33069, false) to recipient list null
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.TreeCache - destination list is empty, discarding call
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - responses=null
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.transaction.DummyTransaction - processing beforeCompletion for org.jboss.cache.aop.PojoTxSynchronizationHandler at 10e3293
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.transaction.DummyTransaction - processing afterCompletion for tx=org.jboss.cache.transaction.DummyTransaction at 1d85f79, handlers=[TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<192.168.11.105:33069>:1, tx=org.jboss.cache.transaction.DummyTransaction at 1d85f79)]
07/09 09:43:38,030 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - calling aftercompletion for GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Running commit phase.  One phase? false
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor -  running commit for GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Broadcasting call commit(GlobalTransaction:<192.168.11.105:33069>:1) to recipient list null
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.TreeCache - destination list is empty, discarding call
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - responses=null
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method commit(GlobalTransaction:<192.168.11.105:33069>:1)
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - committing cache with gtx GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,031 [main] DEBUG org.jboss.cache.TransactionEntry - releasing lock for /a/b/courses (write owner=GlobalTransaction:<192.168.11.105:33069>:1)
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.TransactionEntry - releasing lock for /a/b (write owner=GlobalTransaction:<192.168.11.105:33069>:1)
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.TransactionEntry - releasing lock for /a (read owners=[GlobalTransaction:<192.168.11.105:33069>:1])
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - removing local transaction org.jboss.cache.transaction.DummyTransaction at 1d85f79 and global transaction GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - bypassed locking as method commit() doesn't require locking
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Suppressing invocation of method commit(GlobalTransaction:<192.168.11.105:33069>:1) on cache.
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {}
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Finished local commit/rollback method for GlobalTransaction:<192.168.11.105:33069>:1
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - Finished commit phase
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.transaction.DummyTransaction - processing afterCompletion for org.jboss.cache.aop.PojoTxSynchronizationHandler at 10e3293
07/09 09:43:38,032 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", AOPInstance, "false")
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", AOPInstance, "false")
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_get(/a/b/address, zip, true)]
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _get(/a/b/address, zip, true)
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,034 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _get(/a/b/address, zip, true) on cache.
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", zip, "true")
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]]]}
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: read owners=[Thread[main,5,main]]
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,035 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx and non crud meth
07/09 09:43:38,036 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(null, /a/b/address, zip, 2, true)]
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(null, /a/b/address, zip, 2, true)
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.Node - acquiring WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.Node - acquired WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=write owner=Thread[main,5,main]
07/09 09:43:38,037 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(null, /a/b/address, zip, 2, true) on cache.
07/09 09:43:38,038 [main] DEBUG org.jboss.cache.TreeCache - _put(null, "/a/b/address", zip, 2)
07/09 09:43:38,038 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], write owner=Thread[main,5,main]]}
07/09 09:43:38,038 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: write owner=Thread[main,5,main]
07/09 09:43:38,038 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,038 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx crud meth
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - invoking method _put(null, /a/b/address, zip, 2, true), members=[192.168.11.105:33069], mode=REPL_SYNC, exclude_self=true, timeout=15000
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Broadcasting call _put(null, /a/b/address, zip, 2, true) to recipient list null
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.TreeCache - destination list is empty, discarding call
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - responses=null
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", AOPInstance, "false")
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", AOPInstance, "false")
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_get(/a/b/address, zip, true)]
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _get(/a/b/address, zip, true)
07/09 09:43:38,039 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _get(/a/b/address, zip, true) on cache.
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", zip, "true")
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]]]}
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: read owners=[Thread[main,5,main]]
07/09 09:43:38,040 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx and non crud meth
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(null, /a/b/address, zip, 3, true)]
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(null, /a/b/address, zip, 3, true)
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.Node - acquiring WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,041 [main] DEBUG org.jboss.cache.Node - acquired WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=write owner=Thread[main,5,main]
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(null, /a/b/address, zip, 3, true) on cache.
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.TreeCache - _put(null, "/a/b/address", zip, 3)
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], write owner=Thread[main,5,main]]}
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: write owner=Thread[main,5,main]
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx crud meth
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - invoking method _put(null, /a/b/address, zip, 3, true), members=[192.168.11.105:33069], mode=REPL_SYNC, exclude_self=true, timeout=15000
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Broadcasting call _put(null, /a/b/address, zip, 3, true) to recipient list null
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.TreeCache - destination list is empty, discarding call
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - responses=null
07/09 09:43:38,042 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", AOPInstance, "false")
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", AOPInstance, "false")
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_get(/a/b/address, zip, true)]
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _get(/a/b/address, zip, true)
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,043 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _get(/a/b/address, zip, true) on cache.
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", zip, "true")
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]]]}
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: read owners=[Thread[main,5,main]]
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx and non crud meth
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(null, /a/b/address, zip, 4, true)]
07/09 09:43:38,044 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(null, /a/b/address, zip, 4, true)
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.Node - acquiring WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.Node - acquired WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=write owner=Thread[main,5,main]
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(null, /a/b/address, zip, 4, true) on cache.
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.TreeCache - _put(null, "/a/b/address", zip, 4)
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], write owner=Thread[main,5,main]]}
07/09 09:43:38,045 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: write owner=Thread[main,5,main]
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx crud meth
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - invoking method _put(null, /a/b/address, zip, 4, true), members=[192.168.11.105:33069], mode=REPL_SYNC, exclude_self=true, timeout=15000
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Broadcasting call _put(null, /a/b/address, zip, 4, true) to recipient list null
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.TreeCache - destination list is empty, discarding call
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - responses=null
07/09 09:43:38,046 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b", AOPInstance, "false")
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", AOPInstance, "false")
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_get(/a/b/address, zip, true)]
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _get(/a/b/address, zip, true)
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,047 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,048 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,048 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b/address, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,048 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _get(/a/b/address, zip, true) on cache.
07/09 09:43:38,048 [main] DEBUG org.jboss.cache.TreeCache - _get("/a/b/address", zip, "true")
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]]]}
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: read owners=[Thread[main,5,main]]
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx and non crud meth
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.TxInterceptor - (192.168.11.105:33069) call on method [_put(null, /a/b/address, zip, 5, true)]
07/09 09:43:38,049 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - PessimisticLockInterceptor invoked for method _put(null, /a/b/address, zip, 5, true)
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.interceptors.PessimisticLockInterceptor - Attempting to lock node /a/b/address for owner Thread[main,5,main]
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a, caller=Thread[main,5,main], lock=
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.Node - acquiring RL: fqn=/a/b, caller=Thread[main,5,main], lock=
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.Node - acquired RL: fqn=/a/b, caller=Thread[main,5,main], lock=read owners=[Thread[main,5,main]]
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.Node - acquiring WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.Node - acquired WL: fqn=/a/b/address, caller=Thread[main,5,main], lock=write owner=Thread[main,5,main]
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.interceptors.CallInterceptor - Invoking method _put(null, /a/b/address, zip, 5, true) on cache.
07/09 09:43:38,050 [main] DEBUG org.jboss.cache.TreeCache - _put(null, "/a/b/address", zip, 5)
07/09 09:43:38,054 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - Attempting to release locks on current thread.  Lock table is {Thread[main,5,main]=[read owners=[Thread[main,5,main]], read owners=[Thread[main,5,main]], write owner=Thread[main,5,main]]}
07/09 09:43:38,054 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b/address: write owner=Thread[main,5,main]
07/09 09:43:38,054 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a/b: read owners=[Thread[main,5,main]]
07/09 09:43:38,054 [main] DEBUG org.jboss.cache.interceptors.UnlockInterceptor - releasing lock for /a: read owners=[Thread[main,5,main]]
07/09 09:43:38,055 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Non-tx crud meth
07/09 09:43:38,055 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - invoking method _put(null, /a/b/address, zip, 5, true), members=[192.168.11.105:33069], mode=REPL_SYNC, exclude_self=true, timeout=15000
07/09 09:43:38,055 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - Broadcasting call _put(null, /a/b/address, zip, 5, true) to recipient list null
07/09 09:43:38,055 [main] DEBUG org.jboss.cache.TreeCache - destination list is empty, discarding call
07/09 09:43:38,055 [main] DEBUG org.jboss.cache.interceptors.ReplicationInterceptor - responses=null
07/09 09:43:38,058 [main] INFO  com.protagonis.test.utils.Timing - Elapsed time: 550 millisec com.protagonis.cache.ManualTestCacheJbossExample.doAspect
07/09 09:43:38,058 [main] DEBUG org.jboss.cache.aop.PojoCache - Stopping PojoCache
07/09 09:43:38,058 [main] INFO  org.jboss.cache.TreeCache - stopService(): closing the channel
07/09 09:43:38,075 [main] INFO  org.jboss.cache.TreeCache - stopService(): stopping the dispatcher
07/09 09:43:38,075 [main] DEBUG org.jboss.cache.aop.PojoCache - Stopped PojoCache

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

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