You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@tapestry.apache.org by "Howard M. Lewis Ship (JIRA)" <de...@tapestry.apache.org> on 2007/12/20 20:15:43 UTC
[jira] Created: (TAPESTRY-1993) tapestry-hibernate tests work slow,
generate large amounts of warnings
tapestry-hibernate tests work slow, generate large amounts of warnings
----------------------------------------------------------------------
Key: TAPESTRY-1993
URL: https://issues.apache.org/jira/browse/TAPESTRY-1993
Project: Tapestry
Issue Type: Bug
Components: tapestry-hibernate
Reporter: Howard M. Lewis Ship
Fix For: 5.0
Very concerned that the warnings indicate failures and the tests are passing incorrectly.
[WARN] ThreadPoolAsynchronousRunner com.mchange.v2.async.ThreadPoolAsynchronousRunner$DeadlockDetector@97c401 -- APPARENT DEADLOCK!!! Creating emergency threads for unassigned pending tasks!
[WARN] ThreadPoolAsynchronousRunner com.mchange.v2.async.ThreadPoolAsynchronousRunner$DeadlockDetector@97c401 -- APPARENT DEADLOCK!!! Complete Status:
Managed Threads: 3
Active Threads: 3
Active Tasks:
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@b7ff0e (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#0)
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@ca01f0 (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#1)
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@4563aa (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#2)
Pending Tasks:
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@926c19
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@f6fb59
Pool thread stack traces:
Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#0,5,main]
java.lang.Thread.sleep(Native Method)
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1805)
com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#1,5,main]
java.lang.Thread.sleep(Native Method)
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1805)
com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#2,5,main]
java.lang.Thread.sleep(Native Method)
com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1805)
com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
[WARN] BasicResourcePool com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@b7ff0e -- Acquisition Attempt Failed!!! Clearing pending acquires. While trying to acquire a needed new resource, we failed to succeed more than the maximum number of allowed acquisition attempts (30). Last acquisition attempt exception:
java.sql.SQLException: The database is already in use by another process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/Howard/work/tapestry5/target/unit-testdb.lck, exists=false, locked=false, valid=false, fl =null]: java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/unit-testdb.lck (No such file or directory)
at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
at org.hsqldb.jdbcDriver.connect(Unknown Source)
at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:135)
at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:182)
at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:171)
at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:137)
at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1014)
at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:32)
at com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1810)
at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
[WARN] BasicResourcePool com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@4563aa -- Acquisition Attempt Failed!!! Clearing pending acquires. While trying to acquire a needed new resource, we failed to succeed more than the maximum number of allowed acquisition attempts (30). Last acquisition attempt exception:
java.sql.SQLException: The database is already in use by another process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/Howard/work/tapestry5/target/unit-testdb.lck, exists=false, locked=false, valid=false, fl =null]: java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/unit-testdb.lck (No such file or directory)
at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
at org.hsqldb.jdbcDriver.connect(Unknown Source)
at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:135)
at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:182)
at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:171)
at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:137)
at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1014)
at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:32)
at com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1810)
at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
[WARN] BasicResourcePool com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@ca01f0 -- Acquisition Attempt Failed!!! Clearing pending acquires. While trying to acquire a needed new resource, we failed to succeed more than the maximum number of allowed acquisition attempts (30). Last acquisition attempt exception:
java.sql.SQLException: The database is already in use by another process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/Howard/work/tapestry5/target/unit-testdb.lck, exists=false, locked=false, valid=false, fl =null]: java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/unit-testdb.lck (No such file or directory)
at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
at org.hsqldb.jdbcDriver.connect(Unknown Source)
at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:135)
at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:182)
at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:171)
at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:137)
at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1014)
at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:32)
at com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1810)
at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
[WARN] SettingsFactory Could not obtain connection metadata
java.sql.SQLException: Connections could not be acquired from the underlying database!
at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106)
at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:529)
at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:56)
at org.hibernate.cfg.SettingsFactory.buildSettings(SettingsFactory.java:84)
at org.hibernate.cfg.Configuration.buildSettings(Configuration.java:2009)
at org.hibernate.cfg.Configuration.buildSessionFactory(Configuration.java:1292)
at org.apache.tapestry.internal.hibernate.HibernateSessionSourceImpl.<init>(HibernateSessionSourceImpl.java:43)
at org.apache.tapestry.internal.hibernate.HibernateSessionSourceImplTest.get_configuration(HibernateSessionSourceImplTest.java:77)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.testng.internal.MethodHelper.invokeMethod(MethodHelper.java:580)
at org.testng.internal.Invoker.invokeMethod(Invoker.java:478)
at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:607)
at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:874)
at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
at org.testng.TestRunner.runWorkers(TestRunner.java:689)
at org.testng.TestRunner.privateRun(TestRunner.java:566)
at org.testng.TestRunner.run(TestRunner.java:466)
at org.testng.SuiteRunner.runTest(SuiteRunner.java:301)
at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:296)
at org.testng.SuiteRunner.privateRun(SuiteRunner.java:276)
at org.testng.SuiteRunner.run(SuiteRunner.java:191)
at org.testng.TestNG.createAndRunSuiteRunners(TestNG.java:808)
at org.testng.TestNG.runSuitesLocally(TestNG.java:776)
at org.testng.TestNG.run(TestNG.java:701)
at org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:78)
at org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:92)
at org.apache.maven.surefire.Surefire.run(Surefire.java:177)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.apache.maven.surefire.booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:334)
at org.apache.maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:977)
Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source.
at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1319)
at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:557)
at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:477)
at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
... 36 more
[INFO] HibernateSessionSourceTest Hibernate startup: 138 ms to configure, 30,035 ms overall.
[INFO] HibernateSessionSourceTest Configured Hibernate entities:
[WARN] AnnotationBinder Package not found or wo package-info.java: org.example.myapp.entities
[WARN] AnnotationBinder Package not found or wo package-info.java: org.example.app0.entities
--
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@tapestry.apache.org
For additional commands, e-mail: dev-help@tapestry.apache.org
Re: [jira] Closed: (TAPESTRY-1993) tapestry-hibernate tests work slow, generate large amounts of warnings
Posted by Christian Edward Gruber <ch...@gmail.com>.
Oh come on... Look at the trace. TestNG is executing the tests in
parallel (I suspect), but HSQLDB is trying to access resources which
are locked, so either the tests aren't cleaning up after themselves,
or they're not safe to be run in parallel. The results will,
therefore, not be consistent from hardware to hardware. Try turning
off parallel execution on the platforms in question. You can't blame
Maven for every problem. Sheesh. ;-)
Christian.
On 7-Feb-08, at 19:11 , Howard M. Lewis Ship (JIRA) wrote:
>
> [ https://issues.apache.org/jira/browse/TAPESTRY-1993?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
> ]
>
> Howard M. Lewis Ship closed TAPESTRY-1993.
> ------------------------------------------
>
> Resolution: Cannot Reproduce
> Fix Version/s: (was: 5.0)
> Assignee: Howard M. Lewis Ship
>
> No longer see this and I don't know why it was happening or why it
> stopped. Therefore, it's a Maven problem :-)
>
>> tapestry-hibernate tests work slow, generate large amounts of
>> warnings
>> ----------------------------------------------------------------------
>>
>> Key: TAPESTRY-1993
>> URL: https://issues.apache.org/jira/browse/TAPESTRY-1993
>> Project: Tapestry
>> Issue Type: Bug
>> Components: tapestry-hibernate
>> Affects Versions: 5.0.7
>> Reporter: Howard M. Lewis Ship
>> Assignee: Howard M. Lewis Ship
>>
>> Very concerned that the warnings indicate failures and the tests
>> are passing incorrectly.
>> [WARN] ThreadPoolAsynchronousRunner
>> com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $DeadlockDetector@97c401 -- APPARENT DEADLOCK!!! Creating emergency
>> threads for unassigned pending tasks!
>> [WARN] ThreadPoolAsynchronousRunner
>> com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $DeadlockDetector@97c401 -- APPARENT DEADLOCK!!! Complete Status:
>> Managed Threads: 3
>> Active Threads: 3
>> Active Tasks:
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@b7ff0e
>> (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#0)
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@ca01f0
>> (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#1)
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@4563aa
>> (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#2)
>> Pending Tasks:
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@926c19
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@f6fb59
>> Pool thread stack traces:
>> Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread-#0,5,main]
>> java.lang.Thread.sleep(Native Method)
>> com.mchange.v2.resourcepool.BasicResourcePool
>> $AcquireTask.run(BasicResourcePool.java:1805)
>> com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
>> Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread-#1,5,main]
>> java.lang.Thread.sleep(Native Method)
>> com.mchange.v2.resourcepool.BasicResourcePool
>> $AcquireTask.run(BasicResourcePool.java:1805)
>> com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
>> Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread-#2,5,main]
>> java.lang.Thread.sleep(Native Method)
>> com.mchange.v2.resourcepool.BasicResourcePool
>> $AcquireTask.run(BasicResourcePool.java:1805)
>> com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
>> [WARN] BasicResourcePool
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@b7ff0e --
>> Acquisition Attempt Failed!!! Clearing pending acquires. While
>> trying to acquire a needed new resource, we failed to succeed more
>> than the maximum number of allowed acquisition attempts (30). Last
>> acquisition attempt exception:
>> java.sql.SQLException: The database is already in use by another
>> process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/
>> Howard/work/tapestry5/target/unit-testdb.lck, exists=false,
>> locked=false, valid=false, fl =null]:
>> java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/
>> unit-testdb.lck (No such file or directory)
>> at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
>> at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
>> at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
>> at org.hsqldb.jdbcDriver.connect(Unknown Source)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .DriverManagerDataSource.getConnection(DriverManagerDataSource.java:
>> 135)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .WrapperConnectionPoolDataSource
>> .getPooledConnection(WrapperConnectionPoolDataSource.java:182)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .WrapperConnectionPoolDataSource
>> .getPooledConnection(WrapperConnectionPoolDataSource.java:171)
>> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool
>> $
>> 1PooledConnectionResourcePoolManager
>> .acquireResource(C3P0PooledConnectionPool.java:137)
>> at
>> com
>> .mchange
>> .v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:
>> 1014)
>> at com.mchange.v2.resourcepool.BasicResourcePool.access
>> $800(BasicResourcePool.java:32)
>> at com.mchange.v2.resourcepool.BasicResourcePool
>> $AcquireTask.run(BasicResourcePool.java:1810)
>> at com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
>> [WARN] BasicResourcePool
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@4563aa --
>> Acquisition Attempt Failed!!! Clearing pending acquires. While
>> trying to acquire a needed new resource, we failed to succeed more
>> than the maximum number of allowed acquisition attempts (30). Last
>> acquisition attempt exception:
>> java.sql.SQLException: The database is already in use by another
>> process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/
>> Howard/work/tapestry5/target/unit-testdb.lck, exists=false,
>> locked=false, valid=false, fl =null]:
>> java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/
>> unit-testdb.lck (No such file or directory)
>> at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
>> at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
>> at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
>> at org.hsqldb.jdbcDriver.connect(Unknown Source)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .DriverManagerDataSource.getConnection(DriverManagerDataSource.java:
>> 135)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .WrapperConnectionPoolDataSource
>> .getPooledConnection(WrapperConnectionPoolDataSource.java:182)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .WrapperConnectionPoolDataSource
>> .getPooledConnection(WrapperConnectionPoolDataSource.java:171)
>> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool
>> $
>> 1PooledConnectionResourcePoolManager
>> .acquireResource(C3P0PooledConnectionPool.java:137)
>> at
>> com
>> .mchange
>> .v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:
>> 1014)
>> at com.mchange.v2.resourcepool.BasicResourcePool.access
>> $800(BasicResourcePool.java:32)
>> at com.mchange.v2.resourcepool.BasicResourcePool
>> $AcquireTask.run(BasicResourcePool.java:1810)
>> at com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
>> [WARN] BasicResourcePool
>> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@ca01f0 --
>> Acquisition Attempt Failed!!! Clearing pending acquires. While
>> trying to acquire a needed new resource, we failed to succeed more
>> than the maximum number of allowed acquisition attempts (30). Last
>> acquisition attempt exception:
>> java.sql.SQLException: The database is already in use by another
>> process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/
>> Howard/work/tapestry5/target/unit-testdb.lck, exists=false,
>> locked=false, valid=false, fl =null]:
>> java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/
>> unit-testdb.lck (No such file or directory)
>> at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
>> at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
>> at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
>> at org.hsqldb.jdbcDriver.connect(Unknown Source)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .DriverManagerDataSource.getConnection(DriverManagerDataSource.java:
>> 135)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .WrapperConnectionPoolDataSource
>> .getPooledConnection(WrapperConnectionPoolDataSource.java:182)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .WrapperConnectionPoolDataSource
>> .getPooledConnection(WrapperConnectionPoolDataSource.java:171)
>> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool
>> $
>> 1PooledConnectionResourcePoolManager
>> .acquireResource(C3P0PooledConnectionPool.java:137)
>> at
>> com
>> .mchange
>> .v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:
>> 1014)
>> at com.mchange.v2.resourcepool.BasicResourcePool.access
>> $800(BasicResourcePool.java:32)
>> at com.mchange.v2.resourcepool.BasicResourcePool
>> $AcquireTask.run(BasicResourcePool.java:1810)
>> at com.mchange.v2.async.ThreadPoolAsynchronousRunner
>> $PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
>> [WARN] SettingsFactory Could not obtain connection metadata
>> java.sql.SQLException: Connections could not be acquired from the
>> underlying database!
>> at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .impl
>> .C3P0PooledConnectionPool
>> .checkoutPooledConnection(C3P0PooledConnectionPool.java:529)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .impl
>> .AbstractPoolBackedDataSource
>> .getConnection(AbstractPoolBackedDataSource.java:128)
>> at
>> org
>> .hibernate
>> .connection
>> .C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:56)
>> at
>> org
>> .hibernate.cfg.SettingsFactory.buildSettings(SettingsFactory.java:84)
>> at
>> org.hibernate.cfg.Configuration.buildSettings(Configuration.java:
>> 2009)
>> at
>> org
>> .hibernate.cfg.Configuration.buildSessionFactory(Configuration.java:
>> 1292)
>> at
>> org
>> .apache
>> .tapestry
>> .internal
>> .hibernate
>> .HibernateSessionSourceImpl.<init>(HibernateSessionSourceImpl.java:
>> 43)
>> at
>> org
>> .apache
>> .tapestry
>> .internal
>> .hibernate
>> .HibernateSessionSourceImplTest
>> .get_configuration(HibernateSessionSourceImplTest.java:77)
>> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>> at
>> sun
>> .reflect
>> .NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>> at
>> sun
>> .reflect
>> .DelegatingMethodAccessorImpl
>> .invoke(DelegatingMethodAccessorImpl.java:25)
>> at java.lang.reflect.Method.invoke(Method.java:585)
>> at org.testng.internal.MethodHelper.invokeMethod(MethodHelper.java:
>> 580)
>> at org.testng.internal.Invoker.invokeMethod(Invoker.java:478)
>> at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:607)
>> at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:874)
>> at
>> org
>> .testng
>> .internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:
>> 125)
>> at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:
>> 109)
>> at org.testng.TestRunner.runWorkers(TestRunner.java:689)
>> at org.testng.TestRunner.privateRun(TestRunner.java:566)
>> at org.testng.TestRunner.run(TestRunner.java:466)
>> at org.testng.SuiteRunner.runTest(SuiteRunner.java:301)
>> at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:296)
>> at org.testng.SuiteRunner.privateRun(SuiteRunner.java:276)
>> at org.testng.SuiteRunner.run(SuiteRunner.java:191)
>> at org.testng.TestNG.createAndRunSuiteRunners(TestNG.java:808)
>> at org.testng.TestNG.runSuitesLocally(TestNG.java:776)
>> at org.testng.TestNG.run(TestNG.java:701)
>> at
>> org
>> .apache
>> .maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:78)
>> at
>> org
>> .apache
>> .maven
>> .surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:
>> 92)
>> at org.apache.maven.surefire.Surefire.run(Surefire.java:177)
>> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>> at
>> sun
>> .reflect
>> .NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
>> at
>> sun
>> .reflect
>> .DelegatingMethodAccessorImpl
>> .invoke(DelegatingMethodAccessorImpl.java:25)
>> at java.lang.reflect.Method.invoke(Method.java:585)
>> at
>> org
>> .apache
>> .maven
>> .surefire
>> .booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:334)
>> at
>> org
>> .apache
>> .maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:977)
>> Caused by:
>> com.mchange.v2.resourcepool.CannotAcquireResourceException: A
>> ResourcePool could not acquire a resource from its primary factory
>> or source.
>> at
>> com
>> .mchange
>> .v2
>> .resourcepool
>> .BasicResourcePool.awaitAvailable(BasicResourcePool.java:1319)
>> at
>> com
>> .mchange
>> .v2
>> .resourcepool
>> .BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:557)
>> at
>> com
>> .mchange
>> .v2
>> .resourcepool
>> .BasicResourcePool.checkoutResource(BasicResourcePool.java:477)
>> at
>> com
>> .mchange
>> .v2
>> .c3p0
>> .impl
>> .C3P0PooledConnectionPool
>> .checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
>> ... 36 more
>> [INFO] HibernateSessionSourceTest Hibernate startup: 138 ms to
>> configure, 30,035 ms overall.
>> [INFO] HibernateSessionSourceTest Configured Hibernate entities:
>> [WARN] AnnotationBinder Package not found or wo package-info.java:
>> org.example.myapp.entities
>> [WARN] AnnotationBinder Package not found or wo package-info.java:
>> org.example.app0.entities
>
> --
> This message is automatically generated by JIRA.
> -
> You can reply to this email to add a comment to the issue online.
>
>
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@tapestry.apache.org
For additional commands, e-mail: dev-help@tapestry.apache.org
[jira] Closed: (TAPESTRY-1993) tapestry-hibernate tests work slow,
generate large amounts of warnings
Posted by "Howard M. Lewis Ship (JIRA)" <de...@tapestry.apache.org>.
[ https://issues.apache.org/jira/browse/TAPESTRY-1993?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Howard M. Lewis Ship closed TAPESTRY-1993.
------------------------------------------
Resolution: Cannot Reproduce
Fix Version/s: (was: 5.0)
Assignee: Howard M. Lewis Ship
No longer see this and I don't know why it was happening or why it stopped. Therefore, it's a Maven problem :-)
> tapestry-hibernate tests work slow, generate large amounts of warnings
> ----------------------------------------------------------------------
>
> Key: TAPESTRY-1993
> URL: https://issues.apache.org/jira/browse/TAPESTRY-1993
> Project: Tapestry
> Issue Type: Bug
> Components: tapestry-hibernate
> Affects Versions: 5.0.7
> Reporter: Howard M. Lewis Ship
> Assignee: Howard M. Lewis Ship
>
> Very concerned that the warnings indicate failures and the tests are passing incorrectly.
> [WARN] ThreadPoolAsynchronousRunner com.mchange.v2.async.ThreadPoolAsynchronousRunner$DeadlockDetector@97c401 -- APPARENT DEADLOCK!!! Creating emergency threads for unassigned pending tasks!
> [WARN] ThreadPoolAsynchronousRunner com.mchange.v2.async.ThreadPoolAsynchronousRunner$DeadlockDetector@97c401 -- APPARENT DEADLOCK!!! Complete Status:
> Managed Threads: 3
> Active Threads: 3
> Active Tasks:
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@b7ff0e (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#0)
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@ca01f0 (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#1)
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@4563aa (com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#2)
> Pending Tasks:
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@926c19
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@f6fb59
> Pool thread stack traces:
> Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#0,5,main]
> java.lang.Thread.sleep(Native Method)
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1805)
> com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
> Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#1,5,main]
> java.lang.Thread.sleep(Native Method)
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1805)
> com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
> Thread[com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread-#2,5,main]
> java.lang.Thread.sleep(Native Method)
> com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1805)
> com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
> [WARN] BasicResourcePool com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@b7ff0e -- Acquisition Attempt Failed!!! Clearing pending acquires. While trying to acquire a needed new resource, we failed to succeed more than the maximum number of allowed acquisition attempts (30). Last acquisition attempt exception:
> java.sql.SQLException: The database is already in use by another process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/Howard/work/tapestry5/target/unit-testdb.lck, exists=false, locked=false, valid=false, fl =null]: java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/unit-testdb.lck (No such file or directory)
> at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
> at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
> at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
> at org.hsqldb.jdbcDriver.connect(Unknown Source)
> at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:135)
> at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:182)
> at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:171)
> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:137)
> at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1014)
> at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:32)
> at com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1810)
> at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
> [WARN] BasicResourcePool com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@4563aa -- Acquisition Attempt Failed!!! Clearing pending acquires. While trying to acquire a needed new resource, we failed to succeed more than the maximum number of allowed acquisition attempts (30). Last acquisition attempt exception:
> java.sql.SQLException: The database is already in use by another process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/Howard/work/tapestry5/target/unit-testdb.lck, exists=false, locked=false, valid=false, fl =null]: java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/unit-testdb.lck (No such file or directory)
> at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
> at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
> at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
> at org.hsqldb.jdbcDriver.connect(Unknown Source)
> at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:135)
> at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:182)
> at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:171)
> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:137)
> at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1014)
> at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:32)
> at com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1810)
> at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
> [WARN] BasicResourcePool com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask@ca01f0 -- Acquisition Attempt Failed!!! Clearing pending acquires. While trying to acquire a needed new resource, we failed to succeed more than the maximum number of allowed acquisition attempts (30). Last acquisition attempt exception:
> java.sql.SQLException: The database is already in use by another process: org.hsqldb.persist.NIOLockFile@1aaa8f9c[file =/Users/Howard/work/tapestry5/target/unit-testdb.lck, exists=false, locked=false, valid=false, fl =null]: java.io.FileNotFoundException: /Users/Howard/work/tapestry5/target/unit-testdb.lck (No such file or directory)
> at org.hsqldb.jdbc.Util.sqlException(Unknown Source)
> at org.hsqldb.jdbc.jdbcConnection.<init>(Unknown Source)
> at org.hsqldb.jdbcDriver.getConnection(Unknown Source)
> at org.hsqldb.jdbcDriver.connect(Unknown Source)
> at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:135)
> at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:182)
> at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:171)
> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:137)
> at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1014)
> at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:32)
> at com.mchange.v2.resourcepool.BasicResourcePool$AcquireTask.run(BasicResourcePool.java:1810)
> at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:547)
> [WARN] SettingsFactory Could not obtain connection metadata
> java.sql.SQLException: Connections could not be acquired from the underlying database!
> at com.mchange.v2.sql.SqlUtils.toSQLException(SqlUtils.java:106)
> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:529)
> at com.mchange.v2.c3p0.impl.AbstractPoolBackedDataSource.getConnection(AbstractPoolBackedDataSource.java:128)
> at org.hibernate.connection.C3P0ConnectionProvider.getConnection(C3P0ConnectionProvider.java:56)
> at org.hibernate.cfg.SettingsFactory.buildSettings(SettingsFactory.java:84)
> at org.hibernate.cfg.Configuration.buildSettings(Configuration.java:2009)
> at org.hibernate.cfg.Configuration.buildSessionFactory(Configuration.java:1292)
> at org.apache.tapestry.internal.hibernate.HibernateSessionSourceImpl.<init>(HibernateSessionSourceImpl.java:43)
> at org.apache.tapestry.internal.hibernate.HibernateSessionSourceImplTest.get_configuration(HibernateSessionSourceImplTest.java:77)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
> at java.lang.reflect.Method.invoke(Method.java:585)
> at org.testng.internal.MethodHelper.invokeMethod(MethodHelper.java:580)
> at org.testng.internal.Invoker.invokeMethod(Invoker.java:478)
> at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:607)
> at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:874)
> at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:125)
> at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:109)
> at org.testng.TestRunner.runWorkers(TestRunner.java:689)
> at org.testng.TestRunner.privateRun(TestRunner.java:566)
> at org.testng.TestRunner.run(TestRunner.java:466)
> at org.testng.SuiteRunner.runTest(SuiteRunner.java:301)
> at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:296)
> at org.testng.SuiteRunner.privateRun(SuiteRunner.java:276)
> at org.testng.SuiteRunner.run(SuiteRunner.java:191)
> at org.testng.TestNG.createAndRunSuiteRunners(TestNG.java:808)
> at org.testng.TestNG.runSuitesLocally(TestNG.java:776)
> at org.testng.TestNG.run(TestNG.java:701)
> at org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:78)
> at org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:92)
> at org.apache.maven.surefire.Surefire.run(Surefire.java:177)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
> at java.lang.reflect.Method.invoke(Method.java:585)
> at org.apache.maven.surefire.booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:334)
> at org.apache.maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:977)
> Caused by: com.mchange.v2.resourcepool.CannotAcquireResourceException: A ResourcePool could not acquire a resource from its primary factory or source.
> at com.mchange.v2.resourcepool.BasicResourcePool.awaitAvailable(BasicResourcePool.java:1319)
> at com.mchange.v2.resourcepool.BasicResourcePool.prelimCheckoutResource(BasicResourcePool.java:557)
> at com.mchange.v2.resourcepool.BasicResourcePool.checkoutResource(BasicResourcePool.java:477)
> at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool.checkoutPooledConnection(C3P0PooledConnectionPool.java:525)
> ... 36 more
> [INFO] HibernateSessionSourceTest Hibernate startup: 138 ms to configure, 30,035 ms overall.
> [INFO] HibernateSessionSourceTest Configured Hibernate entities:
> [WARN] AnnotationBinder Package not found or wo package-info.java: org.example.myapp.entities
> [WARN] AnnotationBinder Package not found or wo package-info.java: org.example.app0.entities
--
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@tapestry.apache.org
For additional commands, e-mail: dev-help@tapestry.apache.org