[jboss-jira] [JBoss JIRA] Closed: (JBAS-4160) failing org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase
Dimitris Andreadis (JIRA)
jira-events at lists.jboss.org
Fri Mar 23 07:15:34 EDT 2007
[ http://jira.jboss.com/jira/browse/JBAS-4160?page=all ]
Dimitris Andreadis closed JBAS-4160.
------------------------------------
Resolution: Done
After a very painful investigation I discovered the failing test is caused by the replacement of
<componentref name="oswego-concurrent" version="1.3.4"/>
with
<componentref name="oswego-concurrent" version="1.3.4-brew"/>
The 2 are supposed to only differ in that the 2nd is compiled with debug=on.
JBoss uses a thread pool, that lives in jboss common and is backed by a EDU.oswego.cs.dl.util.concurrent.PooledExecutor.
The test that fails involves a queued task and a thread pool of size 1, executing a spinning task. The spining tasks times out, is initially interrupted and then Thread.stopped().
The original oswego jar makes the stopped pooled thread available to the queued task. In the debug version the pool thread seems to hung and so the remaining queued task is not executed, and the test fails.
I would recommend that any brew replacements must - at a mininum - make sure they don't alter the testsuite status.
> failing org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase
> ---------------------------------------------------------------
>
> Key: JBAS-4160
> URL: http://jira.jboss.com/jira/browse/JBAS-4160
> Project: JBoss Application Server
> Issue Type: Sub-task
> Security Level: Public(Everyone can see)
> Components: Other
> Affects Versions: JBossAS-4.2.0.CR1
> Reporter: Dimitris Andreadis
> Assigned To: Dimitris Andreadis
> Priority: Critical
> Fix For: JBossAS-4.2.0.GA
>
>
> The test timeouts.
> Testsuite: org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase
> Tests run: 1, Failures: 0, Errors: 1, Time elapsed: 0 sec
> Testcase: unknown took 0 sec
> Caused an ERROR
> Timeout occurred
> junit.framework.AssertionFailedError: Timeout occurred
> test.log:
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=1
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,832 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=3
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test1
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test2
> 2007-02-28 01:59:33,832 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test3
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test2
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test3
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,842 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=1
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test1
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test2
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test2
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,842 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=2
> 2007-02-28 01:59:33,842 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitStarted, target=1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitForReleaseStarted, data=test1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test2
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test2
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] releaseStarted, data=test1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=2
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:33,852 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitStarted, target=1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:33,852 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitForReleaseStarted, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] releaseStarted, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=2
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test2
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test2
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:34,853 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitStarted, target=1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] releaseStarted, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=2
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitForReleaseStarted, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test1
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test2
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test2
> 2007-02-28 01:59:34,853 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:34,853 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitStarted, target=1
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] releaseStarted, data=test1
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=1
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitForReleaseStarted, data=test1
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin spin loop
> 2007-02-28 01:59:34,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin sleep
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyFinished, data=test1
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] End run
> 2007-02-28 01:59:44,867 DEBUG [org.jboss.util.threadpool.BasicThreadPool] stop, immediate=true
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitStarted, target=1
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin run
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] notifyStarted, data=test1
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] releaseStarted, data=test1
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitForReleaseStarted, data=test1
> 2007-02-28 01:59:44,867 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Begin spin loop
> 2007-02-28 01:59:55,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitStarted, target=1
> 2007-02-28 01:59:55,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] releaseStarted, data=test2
> 2007-02-28 01:59:55,863 INFO [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] waitFinished, target=1
> 2007-02-28 01:59:55,883 WARN [org.jboss.test.util.test.ThreadPoolRunnableUnitTestCase] Caught throwable
> java.lang.ThreadDeath
> at java.lang.Thread.stop(Thread.java:698)
> at org.jboss.util.threadpool.RunnableTaskWrapper.stopTask(RunnableTaskWrapper.java:122)
> at org.jboss.util.threadpool.BasicThreadPool$TimeoutInfo.stopTask(BasicThreadPool.java:517)
> at org.jboss.util.threadpool.BasicThreadPool$TimeoutMonitor.run(BasicThreadPool.java:579)
> at java.lang.Thread.run(Thread.java:595)
--
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators: http://jira.jboss.com/jira/secure/Administrators.jspa
-
For more information on JIRA, see: http://www.atlassian.com/software/jira
More information about the jboss-jira
mailing list