Hmm - have you tried this with 2.1.0.CR3 as well?
No I havent but i have now!!
Had some issues getting the 2.1.0.CR3 to work in JBoss AS 5.0 Beta3. First off the binary lib jboss-cachecore.jar in the meta-inf directory contains all -service.xml files, so JBoss AS picks this up and tries to deploy them and fails in doing so. Removed the -service files and re-jared the jboss-cachecore.jar without -service files.
Cache starts up but i have a few cache related exceptions along the way
11:34:15,854 ERROR [AbstractKernelController] Error installing to Instantiated: name=cache state=Described
java.lang.IllegalAccessException: Class org.jboss.reflect.plugins.introspection.ReflectionUtils can not access a member of class org.jboss.cache.CacheImpl with modifiers "protected"
at sun.reflect.Reflection.ensureMemberAccess(Reflection.java:65)
at java.lang.reflect.Constructor.newInstance(Constructor.java:486)
at org.jboss.reflect.plugins.introspection.ReflectionUtils.newInstance(ReflectionUtils.java:137)
at org.jboss.reflect.plugins.introspection.ReflectConstructorInfoImpl.newInstance(ReflectConstructorInfoImpl.java:106)
at org.jboss.joinpoint.plugins.BasicConstructorJoinPoint.dispatch(BasicConstructorJoinPoint.java:80)
at org.jboss.aop.microcontainer.integration.AOPConstructorJoinpoint.createTarget(AOPConstructorJoinpoint.java:186)
at org.jboss.aop.microcontainer.integration.AOPConstructorJoinpoint.dispatch(AOPConstructorJoinpoint.java:80)
at org.jboss.kernel.plugins.dependency.KernelControllerContextAction$JoinpointDispatchWrapper.execute(KernelControllerContextAction.java:214)
at org.jboss.kernel.plugins.dependency.ExecutionWrapper.execute(ExecutionWrapper.java:45)
at org.jboss.kernel.plugins.dependency.KernelControllerContextAction.dispatchExecutionWrapper(KernelControllerContextAction.java:108)
at org.jboss.kernel.plugins.dependency.KernelControllerContextAction.dispatchJoinPoint(KernelControllerContextAction.java:69)
at org.jboss.kernel.plugins.dependency.InstantiateAction.installActionInternal(InstantiateAction.java:53)
at org.jboss.kernel.plugins.dependency.KernelControllerContextAction.installAction(KernelControllerContextAction.java:135)
at org.jboss.kernel.plugins.dependency.KernelControllerContextAction.installAction(KernelControllerContextAction.java:46)
at org.jboss.dependency.plugins.action.SimpleControllerContextAction.simpleInstallAction(SimpleControllerContextAction.java:62)
at org.jboss.dependency.plugins.action.AccessControllerContextAction.install(AccessControllerContextAction.java:71)
at org.jboss.dependency.plugins.AbstractControllerContextActions.install(AbstractControllerContextActions.java:51)
at org.jboss.dependency.plugins.AbstractControllerContext.install(AbstractControllerContext.java:327)
at org.jboss.dependency.plugins.AbstractController.install(AbstractController.java:1309)
at org.jboss.dependency.plugins.AbstractController.incrementState(AbstractController.java:734)
at org.jboss.dependency.plugins.AbstractController.resolveContexts(AbstractController.java:862)
at org.jboss.dependency.plugins.AbstractController.resolveContexts(AbstractController.java:784)
at org.jboss.dependency.plugins.AbstractController.install(AbstractController.java:574)
at org.jboss.dependency.plugins.AbstractController.install(AbstractController.java:398)
at org.jboss.deployers.vfs.deployer.kernel.BeanMetaDataDeployer.deploy(BeanMetaDataDeployer.java:69)
at org.jboss.deployers.vfs.deployer.kernel.BeanMetaDataDeployer.deploy(BeanMetaDataDeployer.java:42)
at org.jboss.deployers.spi.deployer.helpers.AbstractSimpleRealDeployer.internalDeploy(AbstractSimpleRealDeployer.java:65)
at org.jboss.deployers.spi.deployer.helpers.AbstractRealDeployer.deploy(AbstractRealDeployer.java:50)
at org.jboss.deployers.plugins.deployers.DeployerWrapper.deploy(DeployerWrapper.java:169)
at org.jboss.deployers.plugins.deployers.DeployersImpl.doInstallParentFirst(DeployersImpl.java:853)
at org.jboss.deployers.plugins.deployers.DeployersImpl.doInstallParentFirst(DeployersImpl.java:874)
at org.jboss.deployers.plugins.deployers.DeployersImpl.doInstallParentFirst(DeployersImpl.java:906)
at org.jboss.deployers.plugins.deployers.DeployersImpl.doInstallParentFirst(DeployersImpl.java:906)
at org.jboss.deployers.plugins.deployers.DeployersImpl.doInstallParentFirst(DeployersImpl.java:906)
at org.jboss.deployers.plugins.deployers.DeployersImpl.install(DeployersImpl.java:794)
at org.jboss.dependency.plugins.AbstractControllerContext.install(AbstractControllerContext.java:327)
at org.jboss.dependency.plugins.AbstractController.install(AbstractController.java:1309)
at org.jboss.dependency.plugins.AbstractController.incrementState(AbstractController.java:734)
at org.jboss.dependency.plugins.AbstractController.resolveContexts(AbstractController.java:862)
at org.jboss.dependency.plugins.AbstractController.resolveContexts(AbstractController.java:784)
at org.jboss.dependency.plugins.AbstractController.change(AbstractController.java:622)
at org.jboss.dependency.plugins.AbstractController.change(AbstractController.java:411)
at org.jboss.deployers.plugins.deployers.DeployersImpl.process(DeployersImpl.java:498)
at org.jboss.deployers.plugins.main.MainDeployerImpl.process(MainDeployerImpl.java:506)
at org.jboss.system.server.profileservice.ProfileServiceBootstrap.loadProfile(ProfileServiceBootstrap.java:245)
at org.jboss.system.server.profileservice.ProfileServiceBootstrap.start(ProfileServiceBootstrap.java:131)
at org.jboss.bootstrap.AbstractServerImpl.start(AbstractServerImpl.java:408)
at org.jboss.Main.boot(Main.java:208)
at org.jboss.Main$1.run(Main.java:534)
at java.lang.Thread.run(Thread.java:595)
Anyways cache starts up and im able to make add entries to the cache but it still doesnt write to the DB. Im using the DummyTransactionManager still.
Log looks like so
2008-01-25 11:38:16,616 INFO [STDOUT] 2008-01-25 11:38:16,616 DEBUG [at.sit.cdms.web.actions.ActionFactory] - Looking for bean addItem
2008-01-25 11:38:16,616 DEBUG [at.sit.cdms.web.actions.ActionFactory] Looking for bean addItem
2008-01-25 11:38:16,616 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] Returning cached instance of singleton bean 'addItem'
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = null ...)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=true, dataVersion=null, suppressLocking=false, lockAcquisitionTimeout=-1, forceDataGravitation=false, skipDataGravitation=false, forceAsynchronous=false, forceSynchronous=false}, originLocal=true, txHasMods=false}]
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting up transactional context.
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting tx as null and gtx as null
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.CacheMgmtInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = null ...)
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.TxInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = null ...)
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.TxInterceptor] Creating transaction for thread Thread[http-127.0.0.1-8080-1,5,jboss]
2008-01-25 11:38:16,616 DEBUG [org.jboss.cache.interceptors.TxInterceptor] local transaction exists - registering global tx if not present for Thread[http-127.0.0.1-8080-1,5,jboss]
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is null
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] created new GTX: GlobalTransaction:<null>:2, local TX=org.jboss.cache.transaction.DummyTransaction@9aee72
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.TxInterceptor] Registering sync handler for tx org.jboss.cache.transaction.DummyTransaction@9aee72, gtx GlobalTransaction:<null>:2
2008-01-25 11:38:16,616 DEBUG [org.jboss.cache.transaction.DummyTransaction] registering synchronization handler tx=org.jboss.cache.transaction.DummyTransaction@10153586, handlers=[]
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.TxInterceptor] registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:2, tx=org.jboss.cache.transaction.DummyTransaction@10153586))
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.NotificationInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.NotificationInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,616 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] must load, node null
2008-01-25 11:38:16,632 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] load element /quotes/2 mustLoad=true
2008-01-25 11:38:16,632 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] createTempNode n org.jboss.cache.invocation.NodeInvocationDelegate@19c9b66
2008-01-25 11:38:16,632 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] loadNode /quotes/2
2008-01-25 11:38:16,632 DEBUG [org.jboss.cache.loader.JDBCCacheLoader] executing sql: select node from jbosscache where fqn=? (/quotes/2)
2008-01-25 11:38:16,632 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] supplying ManagedConnection from pool: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257420633 permit=false trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:16,632 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] Got connection from pool org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257420633 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null] [InUse/Available/Max]: [1/9/10]
2008-01-25 11:38:16,632 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] No transaction, no need to enlist: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257420633 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:16,632 TRACE [org.jboss.cache.loader.ManagedConnectionFactory] Connection checked out: org.jboss.resource.adapter.jdbc.jdk5.WrappedConnectionJDK5@9e6837
2008-01-25 11:38:16,757 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] connectionClosed called mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113
2008-01-25 11:38:16,757 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] unregisterConnection: 0 handles left
2008-01-25 11:38:16,757 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] isManagedConnectionFree=true mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113
2008-01-25 11:38:16,757 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] delisting org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257420633 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:16,757 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] putting ManagedConnection back into pool kill=false cl=org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257420633 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:16,757 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] Returning connection to pool org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257496757 permit=false trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null] [InUse/Available/Max]: [0/10/10]
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] nodeExists false
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Setting dataLoaded to true
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.OptimisticLockingInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.OptimisticLockingInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:16,757 TRACE [org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:2 ...)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] Setting versioning for node /quotes/2 to implicit
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.RegionManager] Contents of RegionsRegistry: {/=RegionImpl{fqn=/; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}, /quotes=RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}}
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.RegionManager] Trying next region /quotes and got RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.RegionManager] Contents of RegionsRegistry: {/=RegionImpl{fqn=/; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}, /quotes=RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}}
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.RegionManager] Trying next region /quotes and got RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/quotes/2 event=ADD_ELEMENT_EVENT diff=1] to region at /quotes
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished updating node
2008-01-25 11:38:16,773 DEBUG [org.jboss.cache.transaction.DummyTransaction] processing beforeCompletion for tx=org.jboss.cache.transaction.DummyTransaction@10153586, handlers=[TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:2, tx=org.jboss.cache.transaction.DummyTransaction@10153586)]
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Running beforeCompletion on gtx GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as org.jboss.cache.transaction.DummyTransaction@9aee72 and gtx as GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] No modifications in this tx. Skipping beforeCompletion()
2008-01-25 11:38:16,773 DEBUG [org.jboss.cache.transaction.DummyTransaction] processing afterCompletion for tx=org.jboss.cache.transaction.DummyTransaction@10153586, handlers=[TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:2, tx=org.jboss.cache.transaction.DummyTransaction@10153586)]
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as org.jboss.cache.transaction.DummyTransaction@9aee72 and gtx as GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] calling aftercompletion for GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Running commit phase. One phase? false
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] running commit for GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.NotificationInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Commit called with no modifications; ignoring.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticLockingInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 DEBUG [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Commiting successfully validated changes for GlobalTransaction GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Merging data since node is dirty
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Versioning is implicit; incrementing.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Setting version of node /quotes/2 from Ver=0 to Ver=1
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2)
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] read Method MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2) called - Not handling, passing on.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.CallInterceptor] Suppressing invocation of method MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:2) on cache.
2008-01-25 11:38:16,773 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished local commit/rollback method for GlobalTransaction:<null>:2
2008-01-25 11:38:16,773 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished commit phase
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as null and gtx as null
2008-01-25 11:38:16,773 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Resetting invocation-scope options
2008-01-25 11:38:16,773 INFO [STDOUT] 2008-01-25 11:38:16,773 DEBUG [at.sit.cdms.web.actions.test.AddItem] - Added item with index of 2
2008-01-25 11:38:16,773 DEBUG [at.sit.cdms.web.actions.test.AddItem] Added item with index of 2
2008-01-25 11:38:16,773 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:16,773 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:16,773 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:16,773 TRACE [org.jboss.web.tomcat.security.SecurityAssociationValve] End invoke, callernull
2008-01-25 11:38:16,773 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:16,773 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.security.plugins.JBossSecurityContext, exclude=false
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.security.plugins.JBossSecurityContext) called
2008-01-25 11:38:17,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@1a4f8a6{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/cmds.ear/ ,addedOrder=16} name=org.jboss.security.plugins.JBossSecurityContext, loadClassDepth=0
2008-01-25 11:38:17,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.security.plugins.JBossSecurityContext@2f3fe0<CodeSource: (vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/lib/jbosssx.jar <no signer certificates>)>
2008-01-25 11:38:17,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@1a4f8a6{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/cmds.ear/ ,addedOrder=16} name=org.jboss.security.plugins.JBossSecurityContext class=class org.jboss.security.plugins.JBossSecurityContext cl=org.jboss.mx.loading.UnifiedClassLoader3@14c7cd{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/conf/jboss-service.xml ,addedOrder=2}
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.security.plugins.JBossSecurityContextUtil, exclude=false
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.security.plugins.JBossSecurityContextUtil) called
2008-01-25 11:38:17,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@1a4f8a6{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/cmds.ear/ ,addedOrder=16} name=org.jboss.security.plugins.JBossSecurityContextUtil, loadClassDepth=0
2008-01-25 11:38:17,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.security.plugins.JBossSecurityContextUtil@1793657<CodeSource: (vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/lib/jbosssx.jar <no signer certificates>)>
2008-01-25 11:38:17,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@1a4f8a6{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/cmds.ear/ ,addedOrder=16} name=org.jboss.security.plugins.JBossSecurityContextUtil class=class org.jboss.security.plugins.JBossSecurityContextUtil cl=org.jboss.mx.loading.UnifiedClassLoader3@14c7cd{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/conf/jboss-service.xml ,addedOrder=2}
2008-01-25 11:38:17,476 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.security.SecurityAssociationValve] Begin invoke, callernull
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:17,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:17,476 INFO [STDOUT] 2008-01-25 11:38:17,476 DEBUG [at.sit.cdms.web.actions.ActionFactory] - Looking for bean addItem
2008-01-25 11:38:17,476 DEBUG [at.sit.cdms.web.actions.ActionFactory] Looking for bean addItem
2008-01-25 11:38:17,476 DEBUG [org.springframework.beans.factory.support.DefaultListableBeanFactory] Returning cached instance of singleton bean 'addItem'
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Invoked on cache instance [null] and InvocationContext [InvocationContext{methodCall=MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = null ...)transaction=null, globalTransaction=null, optionOverrides=Option{failSilently=false, cacheModeLocal=true, dataVersion=null, suppressLocking=false, lockAcquisitionTimeout=-1, forceDataGravitation=false, skipDataGravitation=false, forceAsynchronous=false, forceSynchronous=false}, originLocal=true, txHasMods=false}]
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting up transactional context.
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Setting tx as null and gtx as null
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheMgmtInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = null ...)
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.TxInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = null ...)
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.TxInterceptor] Creating transaction for thread Thread[http-127.0.0.1-8080-2,5,jboss]
2008-01-25 11:38:17,476 DEBUG [org.jboss.cache.interceptors.TxInterceptor] local transaction exists - registering global tx if not present for Thread[http-127.0.0.1-8080-2,5,jboss]
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.TxInterceptor] Associated gtx in txTable is null
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.CacheImpl.CMDS-Cluster] created new GTX: GlobalTransaction:<null>:3, local TX=org.jboss.cache.transaction.DummyTransaction@128493c
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.TxInterceptor] Registering sync handler for tx org.jboss.cache.transaction.DummyTransaction@128493c, gtx GlobalTransaction:<null>:3
2008-01-25 11:38:17,476 DEBUG [org.jboss.cache.transaction.DummyTransaction] registering synchronization handler tx=org.jboss.cache.transaction.DummyTransaction@19417404, handlers=[]
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.TxInterceptor] registering for TX completion: SynchronizationHandler(TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:3, tx=org.jboss.cache.transaction.DummyTransaction@19417404))
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.NotificationInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.NotificationInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] must load, node null
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] load element /quotes/3 mustLoad=true
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] createTempNode n org.jboss.cache.invocation.NodeInvocationDelegate@441260
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] loadNode /quotes/3
2008-01-25 11:38:17,476 DEBUG [org.jboss.cache.loader.JDBCCacheLoader] executing sql: select node from jbosscache where fqn=? (/quotes/3)
2008-01-25 11:38:17,476 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] supplying ManagedConnection from pool: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257496757 permit=false trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:17,476 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] Got connection from pool org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257496757 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null] [InUse/Available/Max]: [1/9/10]
2008-01-25 11:38:17,476 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] No transaction, no need to enlist: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257496757 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:17,476 TRACE [org.jboss.cache.loader.ManagedConnectionFactory] Connection checked out: org.jboss.resource.adapter.jdbc.jdk5.WrappedConnectionJDK5@1129113
2008-01-25 11:38:17,523 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] connectionClosed called mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113
2008-01-25 11:38:17,523 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] unregisterConnection: 0 handles left
2008-01-25 11:38:17,523 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] isManagedConnectionFree=true mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113
2008-01-25 11:38:17,523 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] delisting org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257496757 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:17,523 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] putting ManagedConnection back into pool kill=false cl=org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257496757 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null]
2008-01-25 11:38:17,523 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] Returning connection to pool org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@aa045f[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@182d113 handles=0 lastUse=1201257497523 permit=false trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$OnePool@16c73b1 context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@11f80c3 xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@13e9853 txSync=null] [InUse/Available/Max]: [0/10/10]
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] nodeExists false
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Setting dataLoaded to true
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticLockingInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticLockingInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoked with method call MethodName: _put; MethodIdInteger: 3; Args: ( arg[0] = GlobalTransaction:<null>:3 ...)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] Setting versioning for node /quotes/3 to implicit
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.RegionManager] Contents of RegionsRegistry: {/=RegionImpl{fqn=/; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}, /quotes=RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}}
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.RegionManager] Trying next region /quotes and got RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.RegionManager] Contents of RegionsRegistry: {/=RegionImpl{fqn=/; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}, /quotes=RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}}
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.RegionManager] Trying next region /quotes and got RegionImpl{fqn=/quotes; classloader=null; status=ACTIVE; eviction=true; timerThreadRegistered=true}
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Adding event EvictedEN[fqn=/quotes/3 event=ADD_ELEMENT_EVENT diff=1] to region at /quotes
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Finished updating node
2008-01-25 11:38:17,523 DEBUG [org.jboss.cache.transaction.DummyTransaction] processing beforeCompletion for tx=org.jboss.cache.transaction.DummyTransaction@19417404, handlers=[TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:3, tx=org.jboss.cache.transaction.DummyTransaction@19417404)]
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Running beforeCompletion on gtx GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as org.jboss.cache.transaction.DummyTransaction@128493c and gtx as GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] No modifications in this tx. Skipping beforeCompletion()
2008-01-25 11:38:17,523 DEBUG [org.jboss.cache.transaction.DummyTransaction] processing afterCompletion for tx=org.jboss.cache.transaction.DummyTransaction@19417404, handlers=[TxInterceptor.LocalSynchronizationHandler(gtx=GlobalTransaction:<null>:3, tx=org.jboss.cache.transaction.DummyTransaction@19417404)]
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as org.jboss.cache.transaction.DummyTransaction@128493c and gtx as GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] calling aftercompletion for GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Running commit phase. One phase? false
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] running commit for GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.NotificationInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] transactional so don't put stuff in the cloader yet.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheStoreInterceptor] Commit called with no modifications; ignoring.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CacheLoaderInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticLockingInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 DEBUG [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Commiting successfully validated changes for GlobalTransaction GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Merging data since node is dirty
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Versioning is implicit; incrementing.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticValidatorInterceptor] Setting version of node /quotes/3 from Ver=0 to Ver=1
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticCreateIfNotExistsInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Invoked with method call MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3)
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.EvictionInterceptor] Not registered for any handlers, passing up the chain.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.OptimisticNodeInterceptor] read Method MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3) called - Not handling, passing on.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.CallInterceptor] Suppressing invocation of method MethodName: commit; MethodIdInteger: 11; Args: ( arg[0] = GlobalTransaction:<null>:3) on cache.
2008-01-25 11:38:17,523 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished local commit/rollback method for GlobalTransaction:<null>:3
2008-01-25 11:38:17,523 DEBUG [org.jboss.cache.interceptors.TxInterceptor] Finished commit phase
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting up transactional context.
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.TxInterceptor] Setting tx as null and gtx as null
2008-01-25 11:38:17,523 TRACE [org.jboss.cache.interceptors.InvocationContextInterceptor] Resetting invocation-scope options
2008-01-25 11:38:17,523 INFO [STDOUT] 2008-01-25 11:38:17,523 DEBUG [at.sit.cdms.web.actions.test.AddItem] - Added item with index of 3
2008-01-25 11:38:17,523 DEBUG [at.sit.cdms.web.actions.test.AddItem] Added item with index of 3
2008-01-25 11:38:17,523 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:17,523 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:17,523 TRACE [org.jboss.web.tomcat.security.RunAsListener] dataService, runAs: null
2008-01-25 11:38:17,523 TRACE [org.jboss.web.tomcat.security.SecurityAssociationValve] End invoke, callernull
2008-01-25 11:38:17,523 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:17,523 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:19,554 TRACE [org.jboss.system.server.profileservice.hotdeploy.HDScanner] Begin deployment scan
2008-01-25 11:38:19,554 TRACE [org.jboss.system.server.profile.basic.ProfileImpl] Checking applications for modifications
2008-01-25 11:38:19,570 TRACE [org.jboss.system.server.profileservice.hotdeploy.HDScanner] End deployment scan
2008-01-25 11:38:24,570 TRACE [org.jboss.system.server.profileservice.hotdeploy.HDScanner] Begin deployment scan
2008-01-25 11:38:24,570 TRACE [org.jboss.system.server.profile.basic.ProfileImpl] Checking applications for modifications
2008-01-25 11:38:24,585 TRACE [org.jboss.system.server.profileservice.hotdeploy.HDScanner] End deployment scan
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.security.plugins.JBossSecurityContext, exclude=false
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.security.plugins.JBossSecurityContext) called
2008-01-25 11:38:28,976 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContext, loadClassDepth=0
2008-01-25 11:38:28,976 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.security.plugins.JBossSecurityContext@2f3fe0<CodeSource: (vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/lib/jbosssx.jar <no signer certificates>)>
2008-01-25 11:38:28,976 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContext class=class org.jboss.security.plugins.JBossSecurityContext cl=org.jboss.mx.loading.UnifiedClassLoader3@14c7cd{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/conf/jboss-service.xml ,addedOrder=2}
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.security.plugins.JBossSecurityContextUtil, exclude=false
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.security.plugins.JBossSecurityContextUtil) called
2008-01-25 11:38:28,976 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContextUtil, loadClassDepth=0
2008-01-25 11:38:28,976 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.security.plugins.JBossSecurityContextUtil@1793657<CodeSource: (vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/lib/jbosssx.jar <no signer certificates>)>
2008-01-25 11:38:28,976 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContextUtil class=class org.jboss.security.plugins.JBossSecurityContextUtil cl=org.jboss.mx.loading.UnifiedClassLoader3@14c7cd{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/conf/jboss-service.xml ,addedOrder=2}
2008-01-25 11:38:28,976 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:{}
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.security.JaccContextValve] MetaData:org.jboss.metadata.web.jboss.JBossWebMetaData@1f:principalToRoleSetMap{}
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.security.SecurityAssociationValve] Begin invoke, callernull
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.security.RunAsListener] HtmlAdaptor, runAs: null
2008-01-25 11:38:28,976 TRACE [org.jboss.web.tomcat.security.RunAsListener] HtmlAdaptor, runAs: null
2008-01-25 11:38:28,976 TRACE [org.jboss.jmx.adaptor.html.HtmlAdaptorServlet] invokeOp, name=jboss.cache:service=CMDSPersistentCache
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.RunAsListener] jsp, runAs: null
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.RunAsListener] jsp, runAs: null
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=java.lang.StringEditor, exclude=false
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(java.lang.StringEditor) called
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=java.lang.StringEditor, loadClassDepth=0
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.UnifiedClassLoader] loadClassImpl, name=java.lang.StringEditor, resolve=false
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] attempt(1) was: true for :org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.LoadMgr3] registerLoaderThread, ucl=org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}, t=Thread[http-127.0.0.1-8080-1,5,jboss], prevT=null
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.LoadMgr3] Begin beginLoadTask, task=org.jboss.mx.loading.ClassLoadingTask@5062a5{classname: java.lang.StringEditor, requestingThread: Thread[http-127.0.0.1-8080-1,5,jboss], requestingClassLoader: org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}, loadedClass: nullnull, loadOrder: 2147483647, loadException: null, threadTaskCount: 0, state: 0, #CCE: 0}
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClassLocally, org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=java.lang.StringEditor
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClassLocally, org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=java.lang.StringEditor not found
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.LoadMgr3] End beginLoadTask, ClassNotFoundException
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.LoadMgr3] Begin endLoadTask, task=org.jboss.mx.loading.ClassLoadingTask@5062a5{classname: java.lang.StringEditor, requestingThread: Thread[http-127.0.0.1-8080-1,5,jboss], requestingClassLoader: org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}, loadedClass: nullnull, loadOrder: 2147483647, loadException: null, threadTaskCount: 0, state: 0, #CCE: 0}
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] release(1) for :org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] released, holds: 0
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=java.lang.StringEditor not found
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.util.propertyeditor.StringEditor, exclude=false
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.util.propertyeditor.StringEditor) called
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.util.propertyeditor.StringEditor, loadClassDepth=0
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.util.propertyeditor.StringEditor@def14f<CodeSource: (file:/C:/jboss/jboss-5.0.0.Beta3/lib/jboss-common-core.jar <no signer certificates>)>
2008-01-25 11:38:28,991 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.util.propertyeditor.StringEditor class=class org.jboss.util.propertyeditor.StringEditor cl=org.jboss.system.NoAnnotationURLClassLoader@c7b00c
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.RunAsListener] jsp, runAs: null
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.RunAsListener] jsp, runAs: null
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.RunAsListener] HtmlAdaptor, runAs: null
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.RunAsListener] HtmlAdaptor, runAs: null
2008-01-25 11:38:28,991 TRACE [org.jboss.web.tomcat.security.SecurityAssociationValve] End invoke, callernull
2008-01-25 11:38:28,991 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:28,991 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:null
2008-01-25 11:38:29,585 TRACE [org.jboss.system.server.profileservice.hotdeploy.HDScanner] Begin deployment scan
2008-01-25 11:38:29,585 TRACE [org.jboss.system.server.profile.basic.ProfileImpl] Checking applications for modifications
2008-01-25 11:38:29,601 TRACE [org.jboss.system.server.profileservice.hotdeploy.HDScanner] End deployment scan
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] subject: null
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] getManagedConnection trackByTx=true tx=null
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] supplying ManagedConnection from pool: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@15a6eb9[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff handles=0 lastUse=1201257487523 permit=false trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$PoolBySubject@13d346d context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@1a2327a xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@5c0deb txSync=null]
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] Got connection from pool org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@15a6eb9[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff handles=0 lastUse=1201257487523 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$PoolBySubject@13d346d context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@1a2327a xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@5c0deb txSync=null] [InUse/Available/Max]: [1/19/20]
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] No transaction, no need to enlist: org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@15a6eb9[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff handles=0 lastUse=1201257487523 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$PoolBySubject@13d346d context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@1a2327a xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@5c0deb txSync=null]
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] connectionClosed called mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] unregisterConnection: 0 handles left
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] isManagedConnectionFree=true mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.TxConnectionManager] delisting org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@15a6eb9[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff handles=0 lastUse=1201257487523 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$PoolBySubject@13d346d context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@1a2327a xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@5c0deb txSync=null]
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] putting ManagedConnection back into pool kill=false cl=org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@15a6eb9[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff handles=0 lastUse=1201257487523 permit=true trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$PoolBySubject@13d346d context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@1a2327a xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@5c0deb txSync=null]
2008-01-25 11:38:33,038 TRACE [org.jboss.resource.connectionmanager.JBossManagedConnectionPool] Returning connection to pool org.jboss.resource.connectionmanager.TxConnectionManager$TxConnectionEventListener@15a6eb9[state=NORMAL mc=org.jboss.resource.adapter.jdbc.local.LocalManagedConnection@1b4cff handles=0 lastUse=1201257513038 permit=false trackByTx=false mcp=org.jboss.resource.connectionmanager.JBossManagedConnectionPool$PoolBySubject@13d346d context=org.jboss.resource.connectionmanager.InternalManagedConnectionPool@1a2327a xaResource=org.jboss.resource.connectionmanager.TxConnectionManager$LocalXAResource@5c0deb txSync=null] [InUse/Available/Max]: [0/20/20]
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.security.plugins.JBossSecurityContext, exclude=false
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.security.plugins.JBossSecurityContext) called
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContext, loadClassDepth=0
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.security.plugins.JBossSecurityContext@2f3fe0<CodeSource: (vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/lib/jbosssx.jar <no signer certificates>)>
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContext class=class org.jboss.security.plugins.JBossSecurityContext cl=org.jboss.mx.loading.UnifiedClassLoader3@14c7cd{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/conf/jboss-service.xml ,addedOrder=2}
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=org.jboss.security.plugins.JBossSecurityContextUtil, exclude=false
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(org.jboss.security.plugins.JBossSecurityContextUtil) called
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContextUtil, loadClassDepth=0
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] Loaded class from cache, org.jboss.security.plugins.JBossSecurityContextUtil@1793657<CodeSource: (vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/lib/jbosssx.jar <no signer certificates>)>
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=org.jboss.security.plugins.JBossSecurityContextUtil class=class org.jboss.security.plugins.JBossSecurityContextUtil cl=org.jboss.mx.loading.UnifiedClassLoader3@14c7cd{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/conf/jboss-service.xml ,addedOrder=2}
2008-01-25 11:38:33,476 TRACE [org.jboss.security.SecurityRolesAssociation] Setting threadlocal:{}
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.security.JaccContextValve] MetaData:org.jboss.metadata.web.jboss.JBossWebMetaData@1f:principalToRoleSetMap{}
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.security.SecurityAssociationValve] Begin invoke, callernull
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] HtmlAdaptor, runAs: null
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] HtmlAdaptor, runAs: null
2008-01-25 11:38:33,476 TRACE [org.jboss.jmx.adaptor.html.HtmlAdaptorServlet] invokeOp, name=jboss.cache:service=CMDSPersistentCache
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] jsp, runAs: null
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.security.RunAsListener] jsp, runAs: null
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] filter name=java.lang.StringEditor, exclude=false
2008-01-25 11:38:33,476 TRACE [org.jboss.web.tomcat.service.WebAppClassLoader] findClass(java.lang.StringEditor) called
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] loadClass org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29} name=java.lang.StringEditor, loadClassDepth=0
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.UnifiedClassLoader] loadClassImpl, name=java.lang.StringEditor, resolve=false
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.RepositoryClassLoader] attempt(1) was: true for :org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.LoadMgr3] registerLoaderThread, ucl=org.jboss.mx.loading.UnifiedClassLoader3@b77928{ url=vfsfile:/C:/jboss/jboss-5.0.0.Beta3/server/default/deploy/jmx-console.war/ ,addedOrder=29}, t=Thread[http-127.0.0.1-8080-2,5,jboss], prevT=null
2008-01-25 11:38:33,476 TRACE [org.jboss.mx.loading.LoadMgr3] Begin beginLoadTask, task=org.jboss.mx.loading.ClassLoadingTask@1d9726f{classname: java.lang.StringEditor, requestingThread: Thread[http-127.0.0.1-8080-2,5,jboss], request