[jboss-jira] [JBoss JIRA] Commented: (JBAS-7434) org.jboss.test.cluster.defaultcfg.clusteredentity
Brian Stansberry (JIRA)
jira-events at lists.jboss.org
Thu Nov 12 03:01:06 EST 2009
[ https://jira.jboss.org/jira/browse/JBAS-7434?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12494267#action_12494267 ]
Brian Stansberry commented on JBAS-7434:
----------------------------------------
Appears to be a classloading issue. Note the switch in the thread name in the middle of the logging. This is an entity insert at the beginning of the test:
2009-11-12 15:44:17,139 DEBUG [org.jboss.ejb3.stateful.StatefulContainer] (WorkerThread#0[127.0.0.1:64635]) Received dynamic invocation for method with hash: -792204721456858463
2009-11-12 15:44:17,142 DEBUG [org.jboss.ejb3.entity.ExtendedPersistenceContextPropagationInterceptor] (WorkerThread#0[127.0.0.1:64635]) ++++ LongLivedSessionPropagationInterceptor
2009-11-12 15:44:17,142 DEBUG [org.hibernate.impl.SessionImpl] (WorkerThread#0[127.0.0.1:64635]) opened session at timestamp: 12580118571
2009-11-12 15:44:17,142 DEBUG [org.hibernate.ejb.AbstractEntityManagerImpl] (WorkerThread#0[127.0.0.1:64635]) Looking for a JTA transaction to join
2009-11-12 15:44:17,143 DEBUG [org.hibernate.jdbc.JDBCContext] (WorkerThread#0[127.0.0.1:64635]) successfully registered Synchronization
2009-11-12 15:44:17,144 DEBUG [org.hibernate.ejb.AbstractEntityManagerImpl] (WorkerThread#0[127.0.0.1:64635]) Looking for a JTA transaction to join
2009-11-12 15:44:17,144 DEBUG [org.hibernate.ejb.AbstractEntityManagerImpl] (WorkerThread#0[127.0.0.1:64635]) Transaction already joined
2009-11-12 15:44:17,162 DEBUG [org.hibernate.event.def.AbstractSaveEventListener] (WorkerThread#0[127.0.0.1:64635]) generated identifier: 1001, using strategy: org.hibernate.id.Assigned
2009-11-12 15:44:17,185 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] (RequestProcessor-2) processing flush-time cascades
2009-11-12 15:44:17,186 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] (RequestProcessor-2) dirty checking collections
2009-11-12 15:44:17,189 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] (RequestProcessor-2) Flushed: 1 insertions, 0 updates, 0 deletions to 1 objects
2009-11-12 15:44:17,189 DEBUG [org.hibernate.event.def.AbstractFlushingEventListener] (RequestProcessor-2) Flushed: 0 (re)creations, 0 updates, 0 removals to 0 collections
2009-11-12 15:44:17,190 DEBUG [org.hibernate.pretty.Printer] (RequestProcessor-2) listing entities:
2009-11-12 15:44:17,190 DEBUG [org.hibernate.pretty.Printer] (RequestProcessor-2) org.jboss.test.cluster.clusteredentity.classloader.Account{id=1001, balance=5, accountHolder=2c6d8085f3f280c2eff2e7aeeae2eff3f3aef4e5f3f4aee3ecf5f3f4e5f2aee3ecf5f3f4e5f2e5e4e5eef4e9f4f9aee3ece1f3f3ecefe1e4e5f2aec1e3e3eff5eef4c8efece4e5f2d0cb8080808080808081828082cc8088ece1f3f4cee1ede5f48092cceae1f6e1afece1eee7afd3f4f2e9eee7bbcc8083f3f3eef180fe8081f8f0f48085d3ede9f4e8f48084b1b0b0b0, branch=94536}
2009-11-12 15:44:17,190 DEBUG [org.hibernate.cache.UpdateTimestampsCache] (RequestProcessor-2) Pre-invalidating space [Account]
2009-11-12 15:44:17,198 DEBUG [org.hibernate.jdbc.AbstractBatcher] (RequestProcessor-2) about to open PreparedStatement (open PreparedStatements: 0, globally: 0)
2009-11-12 15:44:17,198 DEBUG [org.hibernate.jdbc.ConnectionManager] (RequestProcessor-2) opening JDBC connection
2009-11-12 15:44:17,205 DEBUG [org.hibernate.SQL] (RequestProcessor-2) insert into Account (accountHolder, balance, branch, id) values (?, ?, ?, ?)
2009-11-12 15:44:17,209 ERROR [org.hibernate.event.def.AbstractFlushingEventListener] (RequestProcessor-2) Could not synchronize database state with session: org.hibernate.type.SerializationException: could not deserialize
at org.hibernate.util.SerializationHelper.deserialize(SerializationHelper.java:185)
at org.hibernate.util.SerializationHelper.deserialize(SerializationHelper.java:211)
at org.hibernate.type.SerializableType.fromBytes(SerializableType.java:105)
at org.hibernate.type.SerializableType.deepCopyNotNull(SerializableType.java:97)
at org.hibernate.type.MutableType.deepCopy(MutableType.java:48)
at org.hibernate.type.SerializableToBlobType.deepCopy(SerializableToBlobType.java:102)
at org.hibernate.type.AbstractType.disassemble(AbstractType.java:78)
at org.hibernate.type.TypeFactory.disassemble(TypeFactory.java:474)
at org.hibernate.cache.entry.CacheEntry.<init>(CacheEntry.java:69)
at org.hibernate.action.EntityInsertAction.execute(EntityInsertAction.java:102)
at org.hibernate.engine.ActionQueue.execute(ActionQueue.java:279)
at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:263)
at org.hibernate.engine.ActionQueue.executeActions(ActionQueue.java:167)
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.hibernate.impl.SessionImpl.managedFlush(SessionImpl.java:365)
at org.hibernate.ejb.AbstractEntityManagerImpl$1.beforeCompletion(AbstractEntityManagerImpl.java:504)
at com.arjuna.ats.internal.jta.resources.jts.orbspecific.SynchronizationImple.before_completion(SynchronizationImple.java:118)
at com.arjuna.ArjunaOTS.ManagedSynchronizationPOATie.before_completion(ManagedSynchronizationPOATie.java:53)
at com.arjuna.ArjunaOTS.ManagedSynchronizationPOA._invoke(ManagedSynchronizationPOA.java:46)
at org.jacorb.poa.RequestProcessor.invokeOperation(Unknown Source)
at org.jacorb.poa.RequestProcessor.process(Unknown Source)
at org.jacorb.poa.RequestProcessor.run(Unknown Source)
Caused by: java.lang.ClassNotFoundException: org.jboss.test.cluster.clusteredentity.classloader.AccountHolderPK
at java.net.URLClassLoader$1.run(URLClassLoader.java:200)
at java.security.AccessController.doPrivileged(Native Method)
at java.net.URLClassLoader.findClass(URLClassLoader.java:188)
at java.lang.ClassLoader.loadClass(ClassLoader.java:319)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:330)
at java.lang.ClassLoader.loadClass(ClassLoader.java:254)
at java.lang.ClassLoader.loadClassInternal(ClassLoader.java:399)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Class.java:247)
at org.jboss.classloader.spi.base.BaseClassLoaderDomain.loadClass(BaseClassLoaderDomain.java:292)
at org.jboss.classloader.spi.base.BaseClassLoaderDomain.loadClass(BaseClassLoaderDomain.java:1119)
at org.jboss.classloader.spi.base.BaseClassLoader.loadClassFromDomain(BaseClassLoader.java:798)
at org.jboss.classloader.spi.base.BaseClassLoader.loadClass(BaseClassLoader.java:441)
at java.lang.ClassLoader.loadClass(ClassLoader.java:254)
at java.lang.ClassLoader.loadClassInternal(ClassLoader.java:399)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Class.java:247)
at java.io.ObjectInputStream.resolveClass(ObjectInputStream.java:604)
at org.hibernate.util.SerializationHelper$CustomObjectInputStream.resolveClass(SerializationHelper.java:239)
at java.io.ObjectInputStream.readNonProxyDesc(ObjectInputStream.java:1575)
at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1496)
at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:1732)
at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1329)
at java.io.ObjectInputStream.readObject(ObjectInputStream.java:351)
at org.hibernate.util.SerializationHelper.deserialize(SerializationHelper.java:181)
... 23 more
2009-11-12 15:44:17,212 DEBUG [org.hibernate.jdbc.ConnectionManager] (RequestProcessor-2) aggressively releasing JDBC connection
2009-11-12 15:44:17,212 DEBUG [org.hibernate.jdbc.ConnectionManager] (RequestProcessor-2) releasing JDBC connection [ (open PreparedStatements: 1, globally: 1) (open ResultSets: 0, globally: 0)]
2009-11-12 15:44:17,213 DEBUG [org.hibernate.ejb.AbstractEntityManagerImpl] (RequestProcessor-2) mark transaction for rollback
2009-11-12 15:44:17,217 WARN [com.arjuna.ats.jts.logging.loggerI18N] (WorkerThread#0[127.0.0.1:64635]) [com.arjuna.ats.internal.jts.orbspecific.coordinator.generror] ArjunaTransactionImple.doBeforeCompletion caught exception: org.omg.CORBA.UNKNOWN: Server-side Exception: vmcid: 0x0 minor code: 0 completed: No
2009-11-12 15:44:17,223 TRACE [org.jboss.cache.interceptors.TxInterceptor] (RequestProcessor-2) Running rollback phase
2009-11-12 15:44:17,224 TRACE [org.jboss.cache.interceptors.TxInterceptor] (RequestProcessor-2) Finished rollback phase
2009-11-12 15:44:17,225 DEBUG [org.jboss.jpa.deployment.ManagedEntityManagerFactory] (RequestProcessor-2) ************** closing entity managersession **************
2009-11-12 15:44:17,226 DEBUG [org.hibernate.cache.UpdateTimestampsCache] (RequestProcessor-2) Invalidating space [Account], timestamp: 12580118572
> org.jboss.test.cluster.defaultcfg.clusteredentity
> -------------------------------------------------
>
> Key: JBAS-7434
> URL: https://jira.jboss.org/jira/browse/JBAS-7434
> Project: JBoss Application Server
> Issue Type: Sub-task
> Security Level: Public(Everyone can see)
> Components: Clustering
> Reporter: Shelly McGowan
> Assignee: Brian Stansberry
> Fix For: JBossAS-6.0.0.M1
>
>
> EntityQueryUnitTestCase
> EntityQueryRedeployUnitTestCase
> OptimisticEntityQueryRedeployUnitTestCase
> OptimisticEntityQueryUnitTestCase
> ProvidedPrefixEntityQueryUnitTestCase
> The above tests are failing in the testsuite with JTS enabled with javax.transaction.RollbackException
> See:
> http://hudson.qa.jboss.com/hudson/view/JBoss%20AS/job/JBoss-AS-5.x-testSuite-JTS/lastBuild/
--
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators: https://jira.jboss.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see: http://www.atlassian.com/software/jira
More information about the jboss-jira
mailing list