2009-03-11 16:32:05,422 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,422 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,422 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7801) Testing if invocations are allowed.
2009-03-11 16:32:05,422 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7801) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,422 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,422 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,422 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,423 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7801) Testing if invocations are allowed.
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7801) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,423 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7801) Testing if invocations are allowed.
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7801) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,423 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,424 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7801) Testing if invocations are allowed.
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7801) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_NIST,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_NIST', k='item', 
v='12367891853')
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891852, dataLoaded=false
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_NIST,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,424 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7801) Testing if invocations are allowed.
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7801) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_CASE,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_CASE', k='item', 
v='12367891853')
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891852, dataLoaded=false
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_CASE,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,424 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7801) Testing if invocations are allowed.
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7801) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_AFR_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_AFR_DEMO', k='item', 
v='12367891853')
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7801) Old value is 12367891852, dataLoaded=false
2009-03-11 16:32:05,424 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7801) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_AFR_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,455 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,455 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,455 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,456 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,456 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,456 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,456 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,456 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,457 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,457 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,457 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,457 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,457 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,457 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,457 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,471 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,471 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,471 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,471 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,471 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,471 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,471 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,472 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO', 
k='item', v='12367891853')
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891853, dataLoaded=false
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_OTHER_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,472 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_NIST,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_NIST', k='item', 
v='12367891853')
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891852, dataLoaded=false
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_NIST,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,472 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_CASE,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_CASE', k='item', 
v='12367891853')
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891852, dataLoaded=false
2009-03-11 16:32:05,472 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_CASE,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:05,473 TRACE [org.jboss.cache.factories.ComponentRegistry] 
(Incoming-1,192.45.195.127:7800) Testing if invocations are allowed.
2009-03-11 16:32:05,473 TRACE 
[org.jboss.cache.commands.remote.ReplicateCommand] 
(Incoming-1,192.45.195.127:7800) Invoking command 
PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_AFR_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}, with 
originLocal flag set to false.
2009-03-11 16:32:05,473 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Perform('null', 
'/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_AFR_DEMO', k='item', 
v='12367891853')
2009-03-11 16:32:05,473 TRACE 
[org.jboss.cache.commands.write.PutKeyValueCommand] 
(Incoming-1,192.45.195.127:7800) Old value is 12367891852, dataLoaded=false
2009-03-11 16:32:05,473 TRACE 
[org.jboss.cache.marshall.CommandAwareRpcDispatcher] 
(Incoming-1,192.45.195.127:7800) Command : 
ReplicateCommand{cmds=PutKeyValueCommand{fqn=/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_AFR_DEMO,
 dataVersion=null, globalTransaction=null, key=item, value=12367891853}} 
executed, result is: null
2009-03-11 16:32:15,398 ERROR 
[org.hibernate.event.def.AbstractFlushingEventListener] (http-0.0.0.0-8080-24) 
Could not synchronize database state with session
org.hibernate.cache.CacheException: org.hibernate.cache.CacheException: 
org.jboss.cache.lock.TimeoutException: Unable to acquire lock on Fqn 
[/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_SUBJECT_ARREST] after 
[10000] milliseconds for requestor [Thread[http-0.0.0.0-8080-24,5,jboss]]! Lock 
held by [GlobalTransaction:<192.45.195.127:7802>:2]
        at 
org.hibernate.cache.jbc2.timestamp.TimestampsRegionImpl.put(TimestampsRegionImpl.java:130)
        at 
org.hibernate.cache.UpdateTimestampsCache.preinvalidate(UpdateTimestampsCache.java:70)
        at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:275)
        at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:263)
        at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:172)
        at 
org.hibernate.event.def.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:321)
        at 
org.hibernate.event.def.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:50)
        at org.hibernate.impl.SessionImpl.flush(SessionImpl.java:1027)
        at 
org.springframework.orm.hibernate3.SpringSessionSynchronization.beforeCommit(SpringSessionSynchronization.java:135)
        at 
org.springframework.transaction.support.TransactionSynchronizationUtils.triggerBeforeCommit(TransactionSynchronizationUtils.java:72)
        at 
org.springframework.transaction.support.AbstractPlatformTransactionManager.triggerBeforeCommit(AbstractPlatformTransactionManager.java:905)
        at 
org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:715)
        at 
org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:701)
        at 
org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:321)
        at 
org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:116)
        at 
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
        at 
org.springframework.aop.framework.Cglib2AopProxy$DynamicAdvisedInterceptor.intercept(Cglib2AopProxy.java:635)
        at 
com.ngc.ident1.repository.webservice.siscola.CollectionServiceImplWrapper$$EnhancerByCGLIB$$1c8d4f84.permanentlyDeleteEntities()
        at 
com.ngc.ident1.repository.webservice.siscola.CollectionServicePortTypeImpl.permanentlyDeleteEntities(CollectionServicePortTypeImpl.java:445)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
        at java.lang.reflect.Method.invoke(Method.java:597)
        at 
org.apache.cxf.service.invoker.AbstractInvoker.performInvocation(AbstractInvoker.java:165)
        at 
org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:82)
        at 
org.apache.cxf.jaxws.JAXWSMethodInvoker.invoke(JAXWSMethodInvoker.java:54)
        at 
org.apache.cxf.service.invoker.AbstractInvoker.invoke(AbstractInvoker.java:68)
        at 
org.apache.cxf.interceptor.ServiceInvokerInterceptor$1.run(ServiceInvokerInterceptor.java:56)
        at 
org.apache.cxf.workqueue.SynchronousExecutor.execute(SynchronousExecutor.java:37)
        at 
org.apache.cxf.interceptor.ServiceInvokerInterceptor.handleMessage(ServiceInvokerInterceptor.java:92)
        at 
org.apache.cxf.phase.PhaseInterceptorChain.doIntercept(PhaseInterceptorChain.java:226)
        at 
org.apache.cxf.transport.ChainInitiationObserver.onMessage(ChainInitiationObserver.java:89)
        at 
org.apache.cxf.transport.servlet.ServletDestination.invoke(ServletDestination.java:99)
        at 
org.apache.cxf.transport.servlet.ServletController.invokeDestination(ServletController.java:305)
        at 
org.apache.cxf.transport.servlet.ServletController.invoke(ServletController.java:175)
        at 
org.apache.cxf.transport.servlet.AbstractCXFServlet.invoke(AbstractCXFServlet.java:163)
        at 
org.apache.cxf.transport.servlet.AbstractCXFServlet.doPost(AbstractCXFServlet.java:141)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:810)
        at 
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
        at 
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
        at 
org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
        at 
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202)
        at 
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
        at 
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
        at 
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178)
        at 
org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:175)
        at 
org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:74)
        at 
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126)
        at 
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105)
        at 
org.jboss.web.tomcat.tc5.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:156)
        at 
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107)
        at 
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148)
        at 
org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869)
        at 
org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664)
        at 
org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527)
        at 
org.apache.tomcat.util.net.MasterSlaveWorkerThread.run(MasterSlaveWorkerThread.java:112)
        at java.lang.Thread.run(Thread.java:619)
Caused by: org.hibernate.cache.CacheException: 
org.jboss.cache.lock.TimeoutException: Unable to acquire lock on Fqn 
[/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_SUBJECT_ARREST] after 
[10000] milliseconds for requestor [Thread[http-0.0.0.0-8080-24,5,jboss]]! Lock 
held by [GlobalTransaction:<192.45.195.127:7802>:2]
        at org.hibernate.cache.jbc2.util.CacheHelper.put(CacheHelper.java:214)
        at 
org.hibernate.cache.jbc2.timestamp.TimestampsRegionImpl.put(TimestampsRegionImpl.java:128)
        ... 57 more
Caused by: org.jboss.cache.lock.TimeoutException: Unable to acquire lock on Fqn 
[/TS/org/hibernate/cache/UpdateTimestampsCache/IDENT1.CDB_SUBJECT_ARREST] after 
[10000] milliseconds for requestor [Thread[http-0.0.0.0-8080-24,5,jboss]]! Lock 
held by [GlobalTransaction:<192.45.195.127:7802>:2]
        at 
org.jboss.cache.mvcc.MVCCNodeHelper.acquireLock(MVCCNodeHelper.java:159)
        at 
org.jboss.cache.mvcc.MVCCNodeHelper.wrapNodeForWriting(MVCCNodeHelper.java:212)
        at 
org.jboss.cache.interceptors.MVCCLockingInterceptor.handlePutKeyValueCommand(MVCCLockingInterceptor.java:101)
        at 
org.jboss.cache.interceptors.base.PrePostProcessingCommandInterceptor.visitPutKeyValueCommand(PrePostProcessingCommandInterceptor.java:88)
        at 
org.jboss.cache.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:100)
        at 
org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
        at 
org.jboss.cache.interceptors.ReplicationInterceptor.handleCrudMethod(ReplicationInterceptor.java:150)
        at 
org.jboss.cache.interceptors.ReplicationInterceptor.visitPutKeyValueCommand(ReplicationInterceptor.java:107)
        at 
org.jboss.cache.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:100)
        at 
org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
        at 
org.jboss.cache.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:131)
        at 
org.jboss.cache.commands.AbstractVisitor.visitPutKeyValueCommand(AbstractVisitor.java:65)
        at 
org.jboss.cache.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:100)
        at 
org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
        at 
org.jboss.cache.interceptors.TxInterceptor.attachGtxAndPassUpChain(TxInterceptor.java:261)
        at 
org.jboss.cache.interceptors.TxInterceptor.handleDefault(TxInterceptor.java:250)
        at 
org.jboss.cache.commands.AbstractVisitor.visitPutKeyValueCommand(AbstractVisitor.java:65)
        at 
org.jboss.cache.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:100)
        at 
org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
        at 
org.jboss.cache.interceptors.CacheMgmtInterceptor.visitPutKeyValueCommand(CacheMgmtInterceptor.java:108)
        at 
org.jboss.cache.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:100)
        at 
org.jboss.cache.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:116)
        at 
org.jboss.cache.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:178)
        at 
org.jboss.cache.interceptors.InvocationContextInterceptor.visitPutKeyValueCommand(InvocationContextInterceptor.java:82)
        at 
org.jboss.cache.commands.write.PutKeyValueCommand.acceptVisitor(PutKeyValueCommand.java:100)
        at 
org.jboss.cache.interceptors.InterceptorChain.invoke(InterceptorChain.java:287)
        at 
org.jboss.cache.invocation.CacheInvocationDelegate.put(CacheInvocationDelegate.java:473)
        at org.hibernate.cache.jbc2.util.CacheHelper.put(CacheHelper.java:212)
        ... 58 more


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

Reply to the post : 
http://www.jboss.org/index.html?module=bb&op=posting&mode=reply&p=4217053
_______________________________________________
jboss-user mailing list
[email protected]
https://lists.jboss.org/mailman/listinfo/jboss-user

Reply via email to