Some Eclipse Foundation services are deprecated, or will be soon. Please ensure you've read this important communication.

Bug 334036

Summary:	JPA tests hang on SUN JVM for rev 6872 2.0 stream for WLS 10.3.3.0
Product:	z_Archived	Reporter:	Michael OBrien <michael.f.obrien>
Component:	Eclipselink	Assignee:	Project Inbox <eclipselink.orm-inbox>
Status:	RESOLVED WONTFIX	QA Contact:
Severity:	minor
Priority:	P3	CC:	eclipselink.orm-inbox, martin.grebac, peter.krogh, tom.ware
Version:	unspecified
Target Milestone:	---
Hardware:	PC
OS:	Windows XP
URL:	https://fisheye2.atlassian.com/changelog/eclipselink/?cs=6872
Whiteboard:

Description Michael OBrien

2011-01-11 16:09:46 EST

>the ant test-jpa suite hangs on 32-bit JRockit 1.6 JVM (to Oracle 11 db) on XP32 and 32-bit SUN 1.6 JVM on Win7-64 (to Derby 10.5.3 db)
The SUN JVM version will continue - if you print the RMI threads to the database in JConsole
The JRockit JVM continues to hang whether JConsole connects or not - need to try JRMC

Note: normally I would not raise this - however SVN rev# 6872 ships with WLS 10.3.3.0
The 2.0 stream has had several updates past the shipped version.
https://fisheye2.atlassian.com/changelog/eclipselink/?cs=6872

>19h lockup on Win32 SUN JVM on XPS435 core i7 Win7-64 - fixed using JConsole

    [junit] Query: ReadAllQuery(referenceClass=BeerConsumer sql="SELECT DISTINCT t2.DTYPE FROM CMP3_BECKS t0, CMP3_CONSU
MER t2, CMP3_BECKS_TAG t1 WHERE ((t1.CALL_NUMBER = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))"))
    [junit] [EL Warning]: UnitOfWork(1528830)--Exception [EclipseLink-4002] (Eclipse Persistence Services - 2.0.2.qualif
ier): org.eclipse.persistence.exceptions.DatabaseException
    [junit] Internal Exception: java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time r
equested
    [junit] Error Code: -1
    [junit] Call: SELECT t1.ID, t1.CALL_NUMBER, t0.TAG_ID FROM CMP3_BECKS t0, CMP3_CONSUMER t2, CMP3_BECKS_TAG t1 WHERE
((t1.CALL_NUMBER = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))
    [junit]     bind => [123]
    [junit] Query: ReportQuery(referenceClass=BeerConsumer sql="SELECT t1.ID, t1.CALL_NUMBER, t0.TAG_ID FROM CMP3_BECKS
t0, CMP3_CONSUMER t2, CMP3_BECKS_TAG t1 WHERE ((t1.CALL_NUMBER = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))")
    [junit] Internal Exception: java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time r
equested
    [junit] Error Code: -1
    [junit] Call: SELECT t1.ID, t1.CALL_NUMBER, t0.TAG_ID FROM CMP3_BECKS t0, CMP3_CONSUMER t2, CMP3_BECKS_TAG t1 WHERE
((t1.CALL_NUMBER = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))
    [junit]     bind => [123]
    [junit] Query: ReportQuery(referenceClass=BeerConsumer sql="SELECT t1.ID, t1.CALL_NUMBER, t0.TAG_ID FROM CMP3_BECKS
t0, CMP3_CONSUMER t2, CMP3_BECKS_TAG t1 WHERE ((t1.CALL_NUMBER = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))"))
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1075 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1076 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1077 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1078 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1079 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1080 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1081 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1082 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1083 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1084 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1085 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1086 from __JVM_DefineClass__]
   [junit] [Loaded sun.reflect.GeneratedMethodAccessor1087 from __JVM_DefineClass__]

>test.properties
jdbc.driver.jar=${extensions.depend.dir}/derby.jar;${extensions.depend.dir}/derbyclient.jar
db.driver=org.apache.derby.jdbc.ClientDriver
db.url=jdbc:derby://127.0.0.1:1527/eclipselink;create=true
db.user=APP
db.pwd=APP
db.platform=org.eclipse.persistence.platform.database.DerbyPlatform


VM Summary
Monday, January 10, 2011 6:02:24 o'clock PM EST
 
Connection name: 
pid: 876 org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner org.eclipse.persistence.testing.tests.jpa.AllCMP3TestRunModel filtertrace=true haltOnError=false haltOnFailure=false formatter=org.apache.tools.ant.taskdefs.optional.junit.SummaryJUnitResultFormatter showoutput=true outputtoformatters=true logtestlistenerevents=true formatter=org.apache.tools.ant.taskdefs.optional.junit.XMLJUnitResultFormatter,F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\reports\org.eclipse.persistence.testing.tests.jpa.AllCMP3TestRunModel-test-results.xml crashfile=F:\view_20_6872_wls10330\junitvmwatcher8169632959519391299.properties propsfile=F:\view_20_6872_wls10330\junit1128121530883793171.properties
Virtual Machine: 
Java HotSpot(TM) Client VM version 14.3-b01
Vendor: 
Sun Microsystems Inc.
Name: 
876@xps435
Uptime: 
19 hours 10 minutes
Process CPU time: 
31.496 seconds
JIT compiler: 
HotSpot Client Compiler
Total compile time: 
1.748 seconds
 
Live threads: 
11
Peak: 
11
Daemon threads: 
10
Total threads started: 
14
Current classes loaded: 
6,046
Total classes loaded: 
6,157
Total classes unloaded: 
  111


 
Current heap size: 
220,647 kbytes
Maximum heap size: 
520,256 kbytes
Committed memory: 
282,840 kbytes
Pending finalization: 
0 objects
Garbage collector: 
Name = 'Copy', Collections = 348, Total time spent = 1.302 seconds
Garbage collector: 
Name = 'MarkSweepCompact', Collections = 12, Total time spent = 2.186 seconds
 
Operating System: 
Windows 7 6.1
Architecture: 
x86
Number of processors: 
8
Committed virtual memory: 
370,188 kbytes
Total physical memory: 
4,194,303 kbytes
Free physical memory: 
4,194,303 kbytes
Total swap space: 
4,194,303 kbytes
Free swap space: 
4,194,303 kbytes
 
VM arguments: 
-javaagent:../../../eclipselink.jar -Dignore -Dorm.testing=jpa -Declipselink.logging.level=info -Ddb.driver=org.apache.derby.jdbc.ClientDriver -Ddb.url=jdbc:derby://127.0.0.1:1527/eclipselink;create=true -Ddb.user=APP -Ddb.pwd=APP -Ddb.platform=org.eclipse.persistence.platform.database.DerbyPlatform -Xmx512m -Dproxy.user.name=${oracle.proxy.user} -Dpa.connection.user=PA_CONN -Dpa.connection.password=PA_CONN -Dpa.proxyuser=PA_PROXY -Dpa.proxyuser2=PA_PROXY2 
Class path: 
F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\classes;F:\view_20_6872_wls10330\foundation\org.eclipse.persistence.core\classes;F:\view_20_6872_wls10330\jpa\org.eclipse.persistence.jpa\classes;F:\view_20_6872_wls10330\foundation\eclipselink.core.test\classes;F:\view_20_6872_wls10330\foundation\eclipselink.core.test\eclipselink-tests.jar;F:\view_20_6872_wls10330\jpa\plugins\javax.persistence_2.0.0.v201002051058.jar;F:\view_20_6872_wls10330\jpa\plugins\javax.validation_1.0.0.v200907080119-CR3.jar;F:\view_20_6872_wls10330\plugins\javax.persistence_unsigned_for_testing_1.0.0.jar;F:\view_20_6872_wls10330\plugins\javax.activation_1.1.0.v200906290531.jar;F:\view_20_6872_wls10330\plugins\javax.ejb_3.0.0.jar;F:\view_20_6872_wls10330\plugins\javax.jms_1.1.0.jar;F:\view_20_6872_wls10330\plugins\javax.mail_1.4.0.v200804091730.jar;F:\view_20_6872_wls10330\plugins\javax.resource_1.5.0.jar;F:\view_20_6872_wls10330\plugins\javax.transaction_1.1.0.v201002051055.jar;F:\view_20_6872_wls10330\plugins\javax.xml.stream_1.0.1.v201001131653.jar;F:\view_20_6872_wls10330\moxy\org.eclipse.persistence.moxy\classes;F:\view_20_6872_wls10330\plugins\javax.xml.bind_2.1.12.v200912160909.jar;F:\view_20_6872_wls10330\eclipselink.jar;c:\opt\ant\lib\junit-4.5.jar;F:\view_20_6872_wls10330\plugins\org.eclipse.persistence.antlr;F:\view_20_6872_wls10330\plugins\org.eclipse.persistence.asm;f:\view_libs\extension.lib.external\derby.jar;f:\view_libs\extension.lib.external\derbyclient.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-tests.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-annotation-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-ddl-generation-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-xml-only-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-xml-merge-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-validation-failed-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-advanced-field-access-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-advanced-properties.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-pu with spaces.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-cascade-deletes-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\jpa-performance.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-metamodel-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-delimited-model.jar;F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\eclipselink-beanvalidation-model.jar;C:\opt\ant\lib\junit-4.1.jar;C:\opt\ant\lib\ant-launcher.jar;C:\opt\ant\lib\ant.jar;C:\opt\ant\lib\ant-junit.jar;../../../eclipselink.jar
Library path: 
C:\jdk1.6.0_32bit\jre\bin;.;C:\Windows\Sun\Java\bin;C:\Windows\system32;C:\Windows;C:\Xilinx\11.1\ChipScope\bin\nt64;C:\Xilinx\11.1\common\bin\nt64;C:\Xilinx\11.1\common\lib\nt64;C:\Xilinx\11.1\PlanAhead\bin;C:\Xilinx\11.1\ISE\bin\nt64;C:\Xilinx\11.1\ISE\lib\nt64;C:\opt\wls10340_0818\jrockit_160_20_D1.1.0-2119\bin;C:\opt\wls10340_rc6_1001\jrockit_160_20_D1.1.0-15\bin;c:\jdk1.6.0_32bit\bin;c:\jdk1.6.0\bin;C:\Actel\Libero_v9.0\Model\win32acoem;C:\Actel\Libero_v9.0\Designer\bin;c:\oracle11g64\product\11.1.0\db_1\bin;c:\jdk1.6.0\bin;c:\opt\ant\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\TortoiseSVN\bin;C:\Program Files (x86)\QuickTime\QTSystem\;c:\altera\10.0sp1\quartus\bin;c:\bin;C:\soft\SlikSvn1613\bin\;C:\Program Files\Microsoft Network Monitor 3\
Boot class path: 
C:\jdk1.6.0_32bit\jre\lib\resources.jar;C:\jdk1.6.0_32bit\jre\lib\rt.jar;C:\jdk1.6.0_32bit\jre\lib\sunrsasign.jar;C:\jdk1.6.0_32bit\jre\lib\jsse.jar;C:\jdk1.6.0_32bit\jre\lib\jce.jar;C:\jdk1.6.0_32bit\jre\lib\charsets.jar;C:\jdk1.6.0_32bit\jre\classes



>after selecting all of
Name: main
State: RUNNABLE
Total blocked: 3  Total waited: 5,978

Stack trace: 
java.net.SocketInputStream.socketRead0(Native Method)
java.net.SocketInputStream.read(SocketInputStream.java:129)
org.apache.derby.client.net.Reply.fill(Unknown Source)
org.apache.derby.client.net.Reply.ensureALayerDataInBuffer(Unknown Source)
org.apache.derby.client.net.Reply.readDssHeader(Unknown Source)
org.apache.derby.client.net.Reply.startSameIdChainParse(Unknown Source)
org.apache.derby.client.net.NetStatementReply.readPrepareDescribeOutput(Unknown Source)
org.apache.derby.client.net.StatementReply.readPrepareDescribeOutput(Unknown Source)
org.apache.derby.client.net.NetStatement.readPrepareDescribeOutput_(Unknown Source)
org.apache.derby.client.am.Statement.readPrepareDescribeOutput(Unknown Source)
org.apache.derby.client.am.PreparedStatement.readPrepareDescribeInputOutput(Unknown Source)
org.apache.derby.client.am.PreparedStatement.flowPrepareDescribeInputOutput(Unknown Source)
org.apache.derby.client.am.PreparedStatement.prepare(Unknown Source)
org.apache.derby.client.am.Connection.prepareStatementX(Unknown Source)
org.apache.derby.client.am.Connection.prepareStatement(Unknown Source)
   - locked org.apache.derby.client.net.NetConnection40@18a64f1
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.prepareStatement(DatabaseAccessor.java:1404)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.prepareStatement(DatabaseAccessor.java:1353)
org.eclipse.persistence.internal.databaseaccess.DatabaseCall.prepareStatement(DatabaseCall.java:645)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.basicExecuteCall(DatabaseAccessor.java:580)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.executeCall(DatabaseAccessor.java:530)
org.eclipse.persistence.sessions.server.ServerSession.executeCall(ServerSession.java:529)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.executeCall(DatasourceCallQueryMechanism.java:206)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.executeCall(DatasourceCallQueryMechanism.java:192)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.executeSelectCall(DatasourceCallQueryMechanism.java:263)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.executeSelect(DatasourceCallQueryMechanism.java:245)
org.eclipse.persistence.queries.DataReadQuery.executeNonCursor(DataReadQuery.java:188)
org.eclipse.persistence.queries.DataReadQuery.executeDatabaseQuery(DataReadQuery.java:144)
org.eclipse.persistence.queries.DatabaseQuery.execute(DatabaseQuery.java:675)
org.eclipse.persistence.queries.DataReadQuery.execute(DataReadQuery.java:130)
org.eclipse.persistence.internal.sessions.AbstractSession.internalExecuteQuery(AbstractSession.java:2322)
org.eclipse.persistence.internal.sessions.AbstractSession.executeQuery(AbstractSession.java:1225)
org.eclipse.persistence.internal.sessions.AbstractSession.executeQuery(AbstractSession.java:1207)
org.eclipse.persistence.internal.sessions.AbstractSession.executeQuery(AbstractSession.java:1167)
org.eclipse.persistence.internal.sessions.AbstractSession.executeSelectingCall(AbstractSession.java:1332)
org.eclipse.persistence.tools.schemaframework.TableSequenceDefinition.checkIfExist(TableSequenceDefinition.java:83)
org.eclipse.persistence.tools.schemaframework.SequenceDefinition.createOnDatabase(SequenceDefinition.java:75)
org.eclipse.persistence.tools.schemaframework.SchemaManager.createObject(SchemaManager.java:188)
org.eclipse.persistence.tools.schemaframework.SchemaManager.processDatabaseObjectDefinition(SchemaManager.java:367)
org.eclipse.persistence.tools.schemaframework.SchemaManager.processSequenceDefinitions(SchemaManager.java:349)
org.eclipse.persistence.tools.schemaframework.SchemaManager.createOrReplaceSequences(SchemaManager.java:261)
org.eclipse.persistence.tools.schemaframework.SchemaManager.createOrReplaceSequences(SchemaManager.java:227)
org.eclipse.persistence.tools.schemaframework.SchemaManager.createSequences(SchemaManager.java:208)
org.eclipse.persistence.tools.schemaframework.TableCreator.replaceTables(TableCreator.java:250)
org.eclipse.persistence.tools.schemaframework.TableCreator.replaceTables(TableCreator.java:240)
org.eclipse.persistence.testing.tests.jpa.jpql.JUnitJPQLDateTimeTestSuite.testSetup(JUnitJPQLDateTimeTestSuite.java:67)
sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
java.lang.reflect.Method.invoke(Method.java:597)
junit.framework.TestCase.runTest(TestCase.java:168)
junit.framework.TestCase.runBare(TestCase.java:134)
org.eclipse.persistence.testing.framework.junit.JUnitTestCase.runBare(JUnitTestCase.java:444)
junit.framework.TestResult$1.protect(TestResult.java:110)
junit.framework.TestResult.runProtected(TestResult.java:128)
junit.framework.TestResult.run(TestResult.java:113)
junit.framework.TestCase.run(TestCase.java:124)
junit.framework.TestSuite.runTest(TestSuite.java:232)
junit.framework.TestSuite.run(TestSuite.java:227)
junit.framework.TestSuite.runTest(TestSuite.java:232)
junit.framework.TestSuite.run(TestSuite.java:227)
junit.framework.TestSuite.runTest(TestSuite.java:232)
junit.framework.TestSuite.run(TestSuite.java:227)
org.eclipse.persistence.testing.framework.TestExecutor.execute(TestExecutor.java:248)
org.eclipse.persistence.testing.framework.TestModel.execute(TestModel.java:208)
org.eclipse.persistence.testing.framework.TestCollection.run(TestCollection.java:313)
org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420)
org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911)
org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:768)

Name: Reference Handler
State: WAITING on java.lang.ref.Reference$Lock@dfadcb
Total blocked: 327  Total waited: 296

Stack trace: 
java.lang.Object.wait(Native Method)
java.lang.Object.wait(Object.java:485)
java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116)


Name: Finalizer
State: WAITING on java.lang.ref.ReferenceQueue$Lock@164c35f
Total blocked: 338  Total waited: 296

Stack trace: 
java.lang.Object.wait(Native Method)
java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:134)
java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)


Name: Signal Dispatcher
State: RUNNABLE
Total blocked: 0  Total waited: 0

Stack trace: 

Name: Attach Listener
State: RUNNABLE
Total blocked: 0  Total waited: 0

Stack trace: 


Name: RMI TCP Accept-0
State: RUNNABLE
Total blocked: 0  Total waited: 0

Stack trace: 
java.net.PlainSocketImpl.socketAccept(Native Method)
java.net.PlainSocketImpl.accept(PlainSocketImpl.java:390)
   - locked java.net.SocksSocketImpl@6a1d9
java.net.ServerSocket.implAccept(ServerSocket.java:453)
java.net.ServerSocket.accept(ServerSocket.java:421)
sun.management.jmxremote.LocalRMIServerSocketFactory$1.accept(LocalRMIServerSocketFactory.java:34)
sun.rmi.transport.tcp.TCPTransport$AcceptLoop.executeAcceptLoop(TCPTransport.java:369)
sun.rmi.transport.tcp.TCPTransport$AcceptLoop.run(TCPTransport.java:341)
java.lang.Thread.run(Thread.java:619)


ame: RMI TCP Connection(1)-192.168.0.194
State: RUNNABLE
Total blocked: 0  Total waited: 0

Stack trace: 
sun.management.ThreadImpl.dumpThreads0(Native Method)
sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:374)
sun.reflect.GeneratedMethodAccessor1114.invoke(Unknown Source)
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
java.lang.reflect.Method.invoke(Method.java:597)
com.sun.jmx.mbeanserver.ConvertingMethod.invokeWithOpenReturn(ConvertingMethod.java:167)
com.sun.jmx.mbeanserver.MXBeanIntrospector.invokeM2(MXBeanIntrospector.java:96)
com.sun.jmx.mbeanserver.MXBeanIntrospector.invokeM2(MXBeanIntrospector.java:33)
com.sun.jmx.mbeanserver.MBeanIntrospector.invokeM(MBeanIntrospector.java:208)
com.sun.jmx.mbeanserver.PerInterface.invoke(PerInterface.java:120)
com.sun.jmx.mbeanserver.MBeanSupport.invoke(MBeanSupport.java:262)
javax.management.StandardMBean.invoke(StandardMBean.java:391)
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.invoke(DefaultMBeanServerInterceptor.java:836)
com.sun.jmx.mbeanserver.JmxMBeanServer.invoke(JmxMBeanServer.java:761)
javax.management.remote.rmi.RMIConnectionImpl.doOperation(RMIConnectionImpl.java:1426)
javax.management.remote.rmi.RMIConnectionImpl.access$200(RMIConnectionImpl.java:72)
javax.management.remote.rmi.RMIConnectionImpl$PrivilegedOperation.run(RMIConnectionImpl.java:1264)
javax.management.remote.rmi.RMIConnectionImpl.doPrivilegedOperation(RMIConnectionImpl.java:1359)
javax.management.remote.rmi.RMIConnectionImpl.invoke(RMIConnectionImpl.java:788)
sun.reflect.GeneratedMethodAccessor1111.invoke(Unknown Source)
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
java.lang.reflect.Method.invoke(Method.java:597)
sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:305)
sun.rmi.transport.Transport$1.run(Transport.java:159)
java.security.AccessController.doPrivileged(Native Method)
sun.rmi.transport.Transport.serviceCall(Transport.java:155)
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:535)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:790)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:649)
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
java.lang.Thread.run(Thread.java:619)


Name: RMI Scheduler(0)
State: TIMED_WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6160c0
Total blocked: 0  Total waited: 3

Stack trace: 
sun.misc.Unsafe.park(Native Method)
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:198)
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:1963)
java.util.concurrent.DelayQueue.take(DelayQueue.java:164)
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:583)
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:576)
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:947)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
java.lang.Thread.run(Thread.java:619)


Name: RMI Scheduler(0)
State: TIMED_WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6160c0
Total blocked: 0  Total waited: 3

Stack trace: 
sun.misc.Unsafe.park(Native Method)
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:198)
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:1963)
java.util.concurrent.DelayQueue.take(DelayQueue.java:164)
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:583)
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:576)
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:947)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:907)
java.lang.Thread.run(Thread.java:619)


Name: JMX server connection timeout 15
State: TIMED_WAITING on [I@15bde0d
Total blocked: 15  Total waited: 16

Stack trace: 
java.lang.Object.wait(Native Method)
com.sun.jmx.remote.internal.ServerCommunicatorAdmin$Timeout.run(ServerCommunicatorAdmin.java:150)
java.lang.Thread.run(Thread.java:619)


ame: RMI TCP Connection(2)-192.168.0.194
State: TIMED_WAITING on com.sun.jmx.remote.internal.ArrayNotificationBuffer@1dc0066
Total blocked: 0  Total waited: 6

Stack trace: 
java.lang.Object.wait(Native Method)
com.sun.jmx.remote.internal.ArrayNotificationBuffer.fetchNotifications(ArrayNotificationBuffer.java:417)
com.sun.jmx.remote.internal.ArrayNotificationBuffer$ShareBuffer.fetchNotifications(ArrayNotificationBuffer.java:209)
com.sun.jmx.remote.internal.ServerNotifForwarder.fetchNotifs(ServerNotifForwarder.java:258)
javax.management.remote.rmi.RMIConnectionImpl$2.run(RMIConnectionImpl.java:1227)
javax.management.remote.rmi.RMIConnectionImpl$2.run(RMIConnectionImpl.java:1225)
javax.management.remote.rmi.RMIConnectionImpl.fetchNotifications(RMIConnectionImpl.java:1231)
sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
java.lang.reflect.Method.invoke(Method.java:597)
sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:305)
sun.rmi.transport.Transport$1.run(Transport.java:159)
java.security.AccessController.doPrivileged(Native Method)
sun.rmi.transport.Transport.serviceCall(Transport.java:155)
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:535)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:790)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:649)
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
java.lang.Thread.run(Thread.java:619)


Name: RMI TCP Connection(3)-192.168.0.194
State: RUNNABLE
Total blocked: 0  Total waited: 0

Stack trace: 
java.net.SocketInputStream.socketRead0(Native Method)
java.net.SocketInputStream.read(SocketInputStream.java:129)
java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
java.io.BufferedInputStream.read(BufferedInputStream.java:237)
   - locked java.io.BufferedInputStream@495234
java.io.FilterInputStream.read(FilterInputStream.java:66)
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:517)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:790)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:649)
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
java.lang.Thread.run(Thread.java:619)

>restart
    [junit] [EL Warning]: UnitOfWork(9945433)--Exception [EclipseLink-4002] (Eclipse Persistence Services - 2.0.2.qualif
ier): org.eclipse.persistence.exceptions.DatabaseException
    [junit] Internal Exception: java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time r
equested
    [junit] Error Code: -1
    [junit] Call: SELECT t1.CALL_NUMBER FROM CMP3_BECKS t0, CMP3_CONSUMER t2, CMP3_BECKS_TAG t1 WHERE ((t2.NAME = ?) AND
 ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))
    [junit]     bind => [Marvin Monroe]
    [junit] Query: ReportQuery(referenceClass=BeerConsumer sql="SELECT t1.CALL_NUMBER FROM CMP3_BECKS t0, CMP3_CONSUMER
t2, CMP3_BECKS_TAG t1 WHERE ((t2.NAME = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))")
    [junit] Internal Exception: java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time r
equested
    [junit] Error Code: -1
    [junit] Call: SELECT t1.CALL_NUMBER FROM CMP3_BECKS t0, CMP3_CONSUMER t2, CMP3_BECKS_TAG t1 WHERE ((t2.NAME = ?) AND
 ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))
    [junit]     bind => [Marvin Monroe]
    [junit] Query: ReportQuery(referenceClass=BeerConsumer sql="SELECT t1.CALL_NUMBER FROM CMP3_BECKS t0, CMP3_CONSUMER
t2, CMP3_BECKS_TAG t1 WHERE ((t2.NAME = ?) AND ((t0.C_ID = t2.ID) AND (t1.ID = t0.TAG_ID)))"))
    [junit] [Loaded sun.reflect.GeneratedMethodAccessor1115 from __JVM_DefineClass__]


> 5 min later we are holding at one line per min
   [junit] [EL Warning]: UnitOfWork(22071232)--Exception [EclipseLink-4002] (Eclipse Persistence Services - 2.0.2.quali
ier): org.eclipse.persistence.exceptions.DatabaseException
   [junit] Internal Exception: java.sql.SQLTransactionRollbackException: A lock could not be obtained within the time r
quested
   [junit] Error Code: -1
   [junit] Call: SELECT t0.EMP_ID, t1.EMP_ID, t0.PAY_SCALE, t0.L_NAME, t0.STATUS, t0.VERSION, t0.ROOM_NUM, t0.GENDER, t
.SALARY, t0.F_NAME, t0.START_OVERTIME, t0.END_OVERTIME, t0.START_TIME, t0.END_TIME, t0.DEPT_ID, t0.MANAGER_EMP_ID, t0.A
DR_ID, t0.START_DATE, t0.END_DATE, t0.FORMER_COMPANY, t0.FORMER_START_DATE, t0.FORMER_END_DATE, t2.TYPE, t2.OWNER_ID, t
.AREA_CODE, t2.NUMB FROM CMP3_EMPLOYEE t0, CMP3_PHONENUMBER t2, CMP3_SALARY t1 WHERE ((((t2.OWNER_ID = t0.EMP_ID) AND (
0.F_NAME = ?)) AND (t1.EMP_ID = t0.EMP_ID)) AND (t1.EMP_ID = t0.EMP_ID))
   [junit]     bind => [Bob]
   [junit] Query: TupleQuery(referenceClass=PhoneNumber sql="SELECT t0.EMP_ID, t1.EMP_ID, t0.PAY_SCALE, t0.L_NAME, t0.S
ATUS, t0.VERSION, t0.ROOM_NUM, t0.GENDER, t1.SALARY, t0.F_NAME, t0.START_OVERTIME, t0.END_OVERTIME, t0.START_TIME, t0.E
D_TIME, t0.DEPT_ID, t0.MANAGER_EMP_ID, t0.ADDR_ID, t0.START_DATE, t0.END_DATE, t0.FORMER_COMPANY, t0.FORMER_START_DATE,
t0.FORMER_END_DATE, t2.TYPE, t2.OWNER_ID, t2.AREA_CODE, t2.NUMB FROM CMP3_EMPLOYEE t0, CMP3_PHONENUMBER t2, CMP3_SALARY
t1 WHERE ((((t2.OWNER_ID = t0.EMP_ID) AND (t0.F_NAME = ?)) AND (t1.EMP_ID = t0.EMP_ID)) AND (t1.EMP_ID = t0.EMP_ID))")
   [junit] [EL Warning]:

>later
    [junit] Tests run: 74, Failures: 0, Errors: 0, Time elapsed: 50.325 sec
     [echo] jpatest.build.location='F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test'
     [echo] modelgen.processor.jar='eclipselink-jpa-modelgen_2.0.2.qualifier.jar'

config-trunk:
     [echo] jpatest.build.location='F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test'
     [echo] modelgen.processor.jar='eclipselink-jpa-modelgen_2.0.2.qualifier.jar'

config-compile-path:
     [echo] core.classes='jpa/eclipselink.jpa.test/../../foundation/org.eclipse.persistence.core/classes'
     [echo] coretest.classes='jpa/eclipselink.jpa.test/../../foundation/eclipselink.core.test/classes'
     [echo] jpatest.build.location='F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test'
     [echo] modelgen.processor.jar='eclipselink-jpa-modelgen_2.0.2.qualifier.jar'

config-run-path:

config-flat:

oracle-test:
     [echo] jpatest.build.location='F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test'
     [echo] modelgen.processor.jar='eclipselink-jpa-modelgen_2.0.2.qualifier.jar'

generate-report:
[junitreport] Processing F:\view_20_6872_wls10330\jpa\eclipselink.jpa.test\reports\TESTS-TestSuites.xml to F:\view_20_68
72_wls10330\jpa\eclipselink.jpa.test\reports\junit-noframes.html
[junitreport] Loading stylesheet jar:file:/C:/opt/ant/lib/ant-junit.jar!/org/apache/tools/ant/taskdefs/optional/junit/xs
l/junit-noframes.xsl
[junitreport] Transform time: 671ms

BUILD SUCCESSFUL
Total time: 1,166 minutes 31 seconds

Comment 1 Michael OBrien

2011-01-11 16:14:02 EST

JPAHelper.getEntityManager(em).getServerSession().getIdentityMapAccessor().printIdentityMap(YourEntity.class) 


    [junit]     datasource URL=> "jdbc:oracle:thin:@ottvm*.com:1521:TOPLINK"
    [junit] ))
    [junit] [EL Config]: 2011-01-10 14:32:33.19--DatabaseSessionImpl(35340299)--Connection(35524579)--Thread(Thread[Main Thread,5,main])--Connected: jdbc:oracle:thin:@ottvm*.com:1521:TOPLINK
    [junit]     User: MFOBRIEN
    [junit]     Database: Oracle  Version: Oracle Database 11g Release 11.1.0.0.0 - Production
    [junit]     Driver: Oracle JDBC driver  Version: 11.1.0.0.0-Beta5
    [junit] [EL Info]: 2011-01-10 14:32:33.19--DatabaseSessionImpl(35340299)--Thread(Thread[Main Thread,5,main])-- login successful
    [junit] [EL Finer]: 2011-01-10 14:32:33.221--DatabaseSessionImpl(35340299)--Thread(Thread[Main Thread,5,main])--Begin JPAAdvancedTestModel
    [junit] [EL Finest]: ServerSession(36341265)--Thread(Thread[Main Thread,5,main])--Begin predeploying Persistence Uni



    [junit] [EL Finest]: UnitOfWork(49847282)--Thread(Thread[Main Thread,5,main])--Execute query ValueReadQuery(sql="SELECT SYSTIMESTAMP FROM DUAL")
    [junit] [EL Fine]: ClientSession(49855883)--Connection(47839647)--Thread(Thread[Main Thread,5,main])--SELECT SYSTIMESTAMP FROM DUAL
    [junit] [EL Fine]: ClientSession(49855883)--Connection(47839647)--Thread(Thread[Main Thread,5,main])--INSERT INTO CMP3_BLUE (ID, ALCOHOL_CONTENT, UNIQUEKEY, VERSION, C_ID, DTYPE) VALUES (?, ?, ?, ?, ?, ?)
    [junit]     bind => [721, 5, 1, 2011-01-10 14:40:00.420453, 2527, Blue]
    [junit] [INFO ][class  ] created: #7037 sun/reflect/GeneratedMethodAccessor946 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7038 sun/reflect/GeneratedSerializationConstructorAccessor92 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7039 sun/reflect/GeneratedMethodAccessor947 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7040 sun/reflect/GeneratedMethodAccessor948 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7041 sun/reflect/GeneratedMethodAccessor949 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7042 sun/reflect/GeneratedMethodAccessor950 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7043 sun/reflect/GeneratedMethodAccessor951 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7044 sun/reflect/GeneratedMethodAccessor952 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7045 sun/reflect/GeneratedMethodAccessor953 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7046 sun/reflect/GeneratedSerializationConstructorAccessor93 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7047 sun/reflect/GeneratedSerializationConstructorAccessor94 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7048 sun/reflect/GeneratedSerializationConstructorAccessor95 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7049 sun/reflect/GeneratedSerializationConstructorAccessor96 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7050 sun/reflect/GeneratedSerializationConstructorAccessor97 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7051 sun/reflect/GeneratedSerializationConstructorAccessor98 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7052 sun/reflect/GeneratedSerializationConstructorAccessor99 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7053 sun/reflect/GeneratedSerializationConstructorAccessor100 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7054 sun/reflect/GeneratedSerializationConstructorAccessor101 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7055 sun/reflect/GeneratedSerializationConstructorAccessor102 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7056 sun/reflect/GeneratedSerializationConstructorAccessor103 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7057 sun/reflect/GeneratedSerializationConstructorAccessor104 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7058 sun/reflect/GeneratedSerializationConstructorAccessor105 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7059 sun/reflect/GeneratedMethodAccessor954 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7060 sun/reflect/GeneratedMethodAccessor955 (<unknown>)
    [junit]
    [junit] [INFO ][class  ] created: #7061 sun/reflect/GeneratedSerializationConstructorAccessor106 (<unknown>)
    [junit]

>stuck thread (1 hour) until ctrl-c


>in a clean trunk view we are ok - hanging behavior is restricted to svn 6872 in 2.2
generate-report:
[junitreport] Processing C:\view_w36a\jpa\eclipselink.jpa.test\reports\TESTS-TestSuites.xml to C:\view_w36a\jpa\eclipseink.jpa.test\reports\junit-noframes.html
[junitreport] Loading stylesheet jar:file:/C:/opt/ant/lib/ant-junit.jar!/org/apache/tools/ant/taskdefs/optional/junit/xl/junit-noframes.xsl
[junitreport] Transform time: 15000ms

BUILD SUCCESSFUL
Total time: 14 minutes 15 seconds


name: RMI TCP Connection(3)-1*.*.*.246
State: RUNNABLE
Total blocked: 11  Total waited: 0

Stack trace: 
jrockit.net.SocketNativeIO.readBytesPinned(Native Method)
jrockit.net.SocketNativeIO.socketRead(SocketNativeIO.java:32)
java.net.SocketInputStream.socketRead0(SocketInputStream.java)
java.net.SocketInputStream.read(SocketInputStream.java:129)
java.io.BufferedInputStream.fill(BufferedInputStream.java:218)
java.io.BufferedInputStream.read(BufferedInputStream.java:237)
   - locked java.io.BufferedInputStream@30ebb8b
java.io.FilterInputStream.read(FilterInputStream.java:66)
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:517)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:790)
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:649)
java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
java.lang.Thread.run(Thread.java:619)


ame: Main Thread
State: RUNNABLE
Total blocked: 2  Total waited: 2

Stack trace: 
jrockit.net.SocketNativeIO.readBytesPinned(Native Method)
jrockit.net.SocketNativeIO.socketRead(SocketNativeIO.java:32)
java.net.SocketInputStream.socketRead0(SocketInputStream.java)
java.net.SocketInputStream.read(SocketInputStream.java:129)
oracle.net.ns.Packet.receive(Packet.java:239)
oracle.net.ns.DataPacket.receive(DataPacket.java:92)
oracle.net.ns.NetInputStream.getNextPacket(NetInputStream.java:172)
oracle.net.ns.NetInputStream.read(NetInputStream.java:117)
oracle.net.ns.NetInputStream.read(NetInputStream.java:92)
oracle.net.ns.NetInputStream.read(NetInputStream.java:77)
oracle.jdbc.driver.T4CMAREngine.unmarshalUB1(T4CMAREngine.java:1023)
oracle.jdbc.driver.T4CMAREngine.unmarshalSB1(T4CMAREngine.java:999)
oracle.jdbc.driver.T4C8Oall.receive(T4C8Oall.java:579)
oracle.jdbc.driver.T4CPreparedStatement.doOall8(T4CPreparedStatement.java:194)
oracle.jdbc.driver.T4CPreparedStatement.executeForRows(T4CPreparedStatement.java:951)
oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1219)
oracle.jdbc.driver.OraclePreparedStatement.executeInternal(OraclePreparedStatement.java:3364)
oracle.jdbc.driver.OraclePreparedStatement.executeUpdate(OraclePreparedStatement.java:3445)
   - locked oracle.jdbc.driver.T4CConnection@2f9e36a
oracle.jdbc.driver.OraclePreparedStatementWrapper.executeUpdate(OraclePreparedStatementWrapper.java:1061)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.executeDirectNoSelect(DatabaseAccessor.java:792)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.executeNoSelect(DatabaseAccessor.java:867)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.basicExecuteCall(DatabaseAccessor.java:587)
org.eclipse.persistence.internal.databaseaccess.DatabaseAccessor.executeCall(DatabaseAccessor.java:530)
org.eclipse.persistence.internal.sessions.AbstractSession.executeCall(AbstractSession.java:914)
org.eclipse.persistence.internal.sessions.IsolatedClientSession.executeCall(IsolatedClientSession.java:131)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.executeCall(DatasourceCallQueryMechanism.java:206)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.executeCall(DatasourceCallQueryMechanism.java:192)
org.eclipse.persistence.internal.queries.DatasourceCallQueryMechanism.insertObject(DatasourceCallQueryMechanism.java:335)
org.eclipse.persistence.internal.queries.StatementQueryMechanism.insertObject(StatementQueryMechanism.java:162)
org.eclipse.persistence.internal.queries.StatementQueryMechanism.insertObject(StatementQueryMechanism.java:177)
org.eclipse.persistence.internal.queries.DatabaseQueryMechanism.insertObjectForWrite(DatabaseQueryMechanism.java:462)
org.eclipse.persistence.queries.InsertObjectQuery.executeCommit(InsertObjectQuery.java:80)
org.eclipse.persistence.queries.InsertObjectQuery.executeCommitWithChangeSet(InsertObjectQuery.java:90)
org.eclipse.persistence.internal.queries.DatabaseQueryMechanism.executeWriteWithChangeSet(DatabaseQueryMechanism.java:287)
org.eclipse.persistence.queries.WriteObjectQuery.executeDatabaseQuery(WriteObjectQuery.java:58)
org.eclipse.persistence.queries.DatabaseQuery.execute(DatabaseQuery.java:675)
org.eclipse.persistence.queries.DatabaseQuery.executeInUnitOfWork(DatabaseQuery.java:589)
org.eclipse.persistence.queries.ObjectLevelModifyQuery.executeInUnitOfWorkObjectLevelModifyQuery(ObjectLevelModifyQuery.java:109)
org.eclipse.persistence.queries.ObjectLevelModifyQuery.executeInUnitOfWork(ObjectLevelModifyQuery.java:86)
org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.internalExecuteQuery(UnitOfWorkImpl.java:2898)
org.eclipse.persistence.internal.sessions.AbstractSession.executeQuery(AbstractSession.java:1225)
org.eclipse.persistence.internal.sessions.AbstractSession.executeQuery(AbstractSession.java:1207)
org.eclipse.persistence.internal.sessions.AbstractSession.executeQuery(AbstractSession.java:1167)
org.eclipse.persistence.internal.sessions.CommitManager.commitNewObjectsForClassWithChangeSet(CommitManager.java:197)
org.eclipse.persistence.internal.sessions.CommitManager.commitAllObjectsForClassWithChangeSet(CommitManager.java:164)
org.eclipse.persistence.internal.sessions.CommitManager.commitAllObjectsWithChangeSet(CommitManager.java:116)
org.eclipse.persistence.internal.sessions.AbstractSession.writeAllObjectsWithChangeSet(AbstractSession.java:3260)
org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.commitToDatabase(UnitOfWorkImpl.java:1413)
org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.commitToDatabase(RepeatableWriteUnitOfWork.java:547)
org.eclipse.persistence.internal.sessions.UnitOfWorkImpl.commitToDatabaseWithPreBuiltChangeSet(UnitOfWorkImpl.java:1559)
org.eclipse.persistence.internal.sessions.RepeatableWriteUnitOfWork.writeChanges(RepeatableWriteUnitOfWork.java:360)
org.eclipse.persistence.internal.jpa.EntityManagerImpl.flush(EntityManagerImpl.java:696)
org.eclipse.persistence.testing.tests.jpa.jpql.JUnitJPQLComplexTestSuite.mapContainerPolicyMapKeyInSelectionCriteriaTest(JUnitJPQLComplexTestSuite.java:1906)
sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
java.lang.reflect.Method.invoke(Method.java:597)
junit.framework.TestCase.runTest(TestCase.java:168)
junit.framework.TestCase.runBare(TestCase.java:134)
org.eclipse.persistence.testing.framework.junit.JUnitTestCase.runBare(JUnitTestCase.java:444)
junit.framework.TestResult$1.protect(TestResult.java:110)
junit.framework.TestResult.runProtected(TestResult.java:128)
junit.framework.TestResult.run(TestResult.java:113)
junit.framework.TestCase.run(TestCase.java:124)
junit.framework.TestSuite.runTest(TestSuite.java:232)
junit.framework.TestSuite.run(TestSuite.java:227)
junit.framework.TestSuite.runTest(TestSuite.java:232)
junit.framework.TestSuite.run(TestSuite.java:227)
junit.framework.TestSuite.runTest(TestSuite.java:232)
junit.framework.TestSuite.run(TestSuite.java:227)
org.eclipse.persistence.testing.framework.TestExecutor.execute(TestExecutor.java:248)
org.eclipse.persistence.testing.framework.TestModel.execute(TestModel.java:208)
org.eclipse.persistence.testing.framework.TestCollection.run(TestCollection.java:313)
org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.run(JUnitTestRunner.java:420)
org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.launch(JUnitTestRunner.java:911)
org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner.main(JUnitTestRunner.java:768)


VM Summary
Monday, January 10, 2011 8:43:30 o'clock PM VET
 
Connection name: 
pid: 836 org.apache.tools.ant.taskdefs.optional.junit.JUnitTestRunner org.eclipse.persistence.testing.tests.jpa.AllCMP3TestRunModel filtertrace=true haltOnError=false haltOnFailure=false formatter=org.apache.tools.ant.taskdefs.optional.junit.SummaryJUnitResultFormatter showoutput=true outputtoformatters=true logtestlistenerevents=true formatter=org.apache.tools.ant.taskdefs.optional.junit.XMLJUnitResultFormatter,C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\reports\org.eclipse.persistence.testing.tests.jpa.AllCMP3TestRunModel-test-results.xml crashfile=C:\view_202_6872_wls1033\junitvmwatcher2931427195532765692.properties propsfile=C:\view_202_6872_wls1033\junit8420757652163560404.properties
Virtual Machine: 
Oracle JRockit(R) version R28.1.0-120-137830-1.6.0_20-20100922-1826-windows-ia32
Vendor: 
Oracle Corporation
Name: 
836@m*-pc2
Uptime: 
4 hours 40 minutes
Process CPU time: 
1 minute
JIT compiler: 
Oracle JRockit(R) Optimizing Compiler
Total compile time: 
9.111 seconds
 
Live threads: 
22
Peak: 
22
Daemon threads: 
21
Total threads started: 
25
Current classes loaded: 
7,316
Total classes loaded: 
7,480
Total classes unloaded: 
  164


 
Current heap size: 
198,217 kbytes
Maximum heap size: 
524,288 kbytes
Committed memory: 
254,788 kbytes
Pending finalization: 
0 objects
Garbage collector: 
Name = 'Garbage collection optimized for throughput Young Collector', Collections = 145, Total time spent = 1.451 seconds
Garbage collector: 
Name = 'Garbage collection optimized for throughput Old Collector', Collections = 17, Total time spent = 4.229 seconds
 
Operating System: 
Windows XP 5.1
Architecture: 
x86
Number of processors: 
2
Committed virtual memory: 
363,548 kbytes
Total physical memory: 
3,370,532 kbytes
Free physical memory: 
  404,872 kbytes
Total swap space: 
4,194,303 kbytes
Free swap space: 
1,971,776 kbytes
 
VM arguments: 
-javaagent:../../../eclipselink.jar -Dignore -Dorm.testing=jpa -Declipselink.logging.level=FINEST -Ddb.driver=oracle.jdbc.OracleDriver -Ddb.url=jdbc:oracle:thin:@ottvm028.ca.oracle.com:1521:TOPLINK -Ddb.user=mfobrien -Ddb.pwd=password -Ddb.platform=org.eclipse.persistence.platform.database.oracle.Oracle11Platform -Xmx512m -Dproxy.user.name=${oracle.proxy.user} -Dpa.connection.user=PA_CONN -Dpa.connection.password=PA_CONN -Dpa.proxyuser=PA_PROXY -Dpa.proxyuser2=PA_PROXY2 -Dsun.java.launcher=SUN_STANDARD 
Class path: 
C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\classes;C:\view_202_6872_wls1033\foundation\org.eclipse.persistence.core\classes;C:\view_202_6872_wls1033\jpa\org.eclipse.persistence.jpa\classes;C:\view_202_6872_wls1033\foundation\eclipselink.core.test\classes;C:\view_202_6872_wls1033\foundation\eclipselink.core.test\eclipselink-tests.jar;C:\view_202_6872_wls1033\jpa\plugins\javax.persistence_2.0.0.v201002051058.jar;C:\view_202_6872_wls1033\jpa\plugins\javax.validation_1.0.0.v200907080119-CR3.jar;C:\view_202_6872_wls1033\plugins\javax.persistence_unsigned_for_testing_1.0.0.jar;C:\view_202_6872_wls1033\plugins\javax.activation_1.1.0.v200906290531.jar;C:\view_202_6872_wls1033\plugins\javax.ejb_3.0.0.jar;C:\view_202_6872_wls1033\plugins\javax.jms_1.1.0.jar;C:\view_202_6872_wls1033\plugins\javax.mail_1.4.0.v200804091730.jar;C:\view_202_6872_wls1033\plugins\javax.resource_1.5.0.jar;C:\view_202_6872_wls1033\plugins\javax.transaction_1.1.0.v201002051055.jar;C:\view_202_6872_wls1033\plugins\javax.xml.stream_1.0.1.v201001131653.jar;C:\view_202_6872_wls1033\moxy\org.eclipse.persistence.moxy\classes;C:\view_202_6872_wls1033\plugins\javax.xml.bind_2.1.12.v200912160909.jar;C:\view_202_6872_wls1033\eclipselink.jar;c:\opt\ant\lib\junit-4.5.jar;C:\view_202_6872_wls1033\plugins\org.eclipse.persistence.antlr;C:\view_202_6872_wls1033\plugins\org.eclipse.persistence.asm;c:\opt\ojdbc5_11.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-tests.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-annotation-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-ddl-generation-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-xml-only-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-xml-merge-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-validation-failed-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-advanced-field-access-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-advanced-properties.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-pu with spaces.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-cascade-deletes-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\jpa-performance.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-metamodel-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-delimited-model.jar;C:\view_202_6872_wls1033\jpa\eclipselink.jpa.test\eclipselink-beanvalidation-model.jar;C:\opt\ant\lib\junit-4.1.jar;C:\opt\ant\lib\ant-launcher.jar;C:\opt\ant\lib\ant.jar;C:\opt\ant\lib\ant-junit.jar;../../../eclipselink.jar
Library path: 
C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\bin;C:\opt\wls103_0818\jdk160_21\bin;c:\opt\ant\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\system32\WindowsPowerShell\v1.0;C:\apps\db\oracle102\bin;C:\Program Files\TortoiseSVN\bin
Boot class path: 
C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\lib\resources.jar;C:\opt\wls10_1001\jrockit_160_20_D1.1.0-15\jre\lib\rt.jar;C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\lib\sunrsasign.jar;C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\lib\jsse.jar;C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\lib\jce.jar;C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\lib\charsets.jar;C:\opt\wls103_1001\jrockit_160_20_D1.1.0-15\jre\classes

Comment 2 Tom Ware

2011-01-26 14:50:57 EST

Requires triage for 2.3.0

Comment 3 Peter Krogh

2011-06-20 14:27:20 EDT

triage for 2.3.1

Comment 4 Tom Ware

2011-09-22 15:59:42 EDT

Deferring.

Comment 5 Martin Grebac

2014-12-10 14:48:39 EST

No hangs recently.

Comment 6 Eclipse Webmaster

2022-06-09 10:10:51 EDT

The Eclipselink project has moved to Github: https://github.com/eclipse-ee4j/eclipselink

Comment 7 Eclipse Webmaster

2022-06-09 10:17:04 EDT

The Eclipselink project has moved to Github: https://github.com/eclipse-ee4j/eclipselink