You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by "Robert Muir (JIRA)" <ji...@apache.org> on 2012/06/12 00:36:42 UTC

[jira] [Commented] (LUCENE-4136) TestDocumentsWriterStallControl hang (reproducible)

    [ https://issues.apache.org/jira/browse/LUCENE-4136?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13293146#comment-13293146 ] 

Robert Muir commented on LUCENE-4136:
-------------------------------------

{noformat}
   [junit4] Full thread dump Java HotSpot(TM) 64-Bit Server VM (19.1-b02 mixed mode):
   [junit4] 
   [junit4] "waiter" prio=10 tid=0x00007f4be8048000 nid=0x74a6 waiting on condition [0x00007f4bf7743000]
   [junit4]    java.lang.Thread.State: TIMED_WAITING (parking)
   [junit4] 	at sun.misc.Unsafe.park(Native Method)
   [junit4] 	- parking to wait for  <0x00000000fb563eb8> (a java.util.concurrent.CountDownLatch$Sync)
   [junit4] 	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:198)
   [junit4] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1011)
   [junit4] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1303)
   [junit4] 	at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:253)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl$Synchronizer.await(TestDocumentsWriterStallControl.java:419)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl$Waiter.run(TestDocumentsWriterStallControl.java:255)
   [junit4] 
   [junit4] "updater" prio=10 tid=0x00007f4be806d000 nid=0x74a5 waiting on condition [0x00007f4bf733f000]
   [junit4]    java.lang.Thread.State: TIMED_WAITING (parking)
   [junit4] 	at sun.misc.Unsafe.park(Native Method)
   [junit4] 	- parking to wait for  <0x00000000fb563eb8> (a java.util.concurrent.CountDownLatch$Sync)
   [junit4] 	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:198)
   [junit4] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1011)
   [junit4] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1303)
   [junit4] 	at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:253)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl$Synchronizer.await(TestDocumentsWriterStallControl.java:419)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl$Updater.run(TestDocumentsWriterStallControl.java:304)
   [junit4] 
   [junit4] "updater" prio=10 tid=0x00007f4be806c800 nid=0x74a4 waiting on condition [0x00007f4bf7440000]
   [junit4]    java.lang.Thread.State: TIMED_WAITING (parking)
   [junit4] 	at sun.misc.Unsafe.park(Native Method)
   [junit4] 	- parking to wait for  <0x00000000fb563eb8> (a java.util.concurrent.CountDownLatch$Sync)
   [junit4] 	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:198)
   [junit4] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedNanos(AbstractQueuedSynchronizer.java:1011)
   [junit4] 	at java.util.concurrent.locks.AbstractQueuedSynchronizer.tryAcquireSharedNanos(AbstractQueuedSynchronizer.java:1303)
   [junit4] 	at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:253)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl$Synchronizer.await(TestDocumentsWriterStallControl.java:419)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl$Updater.run(TestDocumentsWriterStallControl.java:304)
   [junit4] 
   [junit4] "TEST-TestScope-org.apache.lucene.index.TestDocumentsWriterStallControl.testAccquireReleaseRace-seed#[9D5404FF4A909330]" prio=10 tid=0x00007f4c3827a000 nid=0x74a3 waiting on condition [0x00007f4bf7c4d000]
   [junit4]    java.lang.Thread.State: TIMED_WAITING (sleeping)
   [junit4] 	at java.lang.Thread.sleep(Native Method)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl.assertState(TestDocumentsWriterStallControl.java:215)
   [junit4] 	at org.apache.lucene.index.TestDocumentsWriterStallControl.testAccquireReleaseRace(TestDocumentsWriterStallControl.java:160)
   [junit4] 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4] 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
   [junit4] 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
   [junit4] 	at java.lang.reflect.Method.invoke(Method.java:597)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:814)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:875)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:889)
   [junit4] 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
   [junit4] 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:32)
   [junit4] 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4] 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
   [junit4] 	at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
   [junit4] 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4] 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:821)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$700(RandomizedRunner.java:132)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3$1.run(RandomizedRunner.java:669)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:695)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:734)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:745)
   [junit4] 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4] 	at org.apache.lucene.util.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
   [junit4] 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
   [junit4] 	at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
   [junit4] 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
   [junit4] 	at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
   [junit4] 	at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
   [junit4] 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
   [junit4] 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4] 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)
   [junit4] 
   [junit4] "Low Memory Detector" daemon prio=10 tid=0x00007f4c3809c000 nid=0x6e4d runnable [0x0000000000000000]
   [junit4]    java.lang.Thread.State: RUNNABLE
   [junit4] 
   [junit4] "CompilerThread1" daemon prio=10 tid=0x00007f4c38099800 nid=0x6e4b waiting on condition [0x0000000000000000]
   [junit4]    java.lang.Thread.State: RUNNABLE
   [junit4] 
   [junit4] "CompilerThread0" daemon prio=10 tid=0x00007f4c38096800 nid=0x6e49 waiting on condition [0x0000000000000000]
   [junit4]    java.lang.Thread.State: RUNNABLE
   [junit4] 
   [junit4] "Signal Dispatcher" daemon prio=10 tid=0x00007f4c38094800 nid=0x6e48 waiting on condition [0x0000000000000000]
   [junit4]    java.lang.Thread.State: RUNNABLE
   [junit4] 
   [junit4] "Finalizer" daemon prio=10 tid=0x00007f4c38078000 nid=0x6e42 in Object.wait() [0x00007f4c347f6000]
   [junit4]    java.lang.Thread.State: WAITING (on object monitor)
   [junit4] 	at java.lang.Object.wait(Native Method)
   [junit4] 	- waiting on <0x00000000e017e870> (a java.lang.ref.ReferenceQueue$Lock)
   [junit4] 	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:118)
   [junit4] 	- locked <0x00000000e017e870> (a java.lang.ref.ReferenceQueue$Lock)
   [junit4] 	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:134)
   [junit4] 	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:159)
   [junit4] 
   [junit4] "Reference Handler" daemon prio=10 tid=0x00007f4c38076000 nid=0x6e40 in Object.wait() [0x00007f4c348f7000]
   [junit4]    java.lang.Thread.State: WAITING (on object monitor)
   [junit4] 	at java.lang.Object.wait(Native Method)
   [junit4] 	- waiting on <0x00000000e017e830> (a java.lang.ref.Reference$Lock)
   [junit4] 	at java.lang.Object.wait(Object.java:485)
   [junit4] 	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:116)
   [junit4] 	- locked <0x00000000e017e830> (a java.lang.ref.Reference$Lock)
   [junit4] 
   [junit4] "main" prio=10 tid=0x00007f4c3800a000 nid=0x6e17 in Object.wait() [0x00007f4c3df33000]
   [junit4]    java.lang.Thread.State: WAITING (on object monitor)
   [junit4] 	at java.lang.Object.wait(Native Method)
   [junit4] 	- waiting on <0x00000000fafdb958> (a com.carrotsearch.randomizedtesting.RandomizedRunner$2)
   [junit4] 	at java.lang.Thread.join(Thread.java:1186)
   [junit4] 	- locked <0x00000000fafdb958> (a com.carrotsearch.randomizedtesting.RandomizedRunner$2)
   [junit4] 	at java.lang.Thread.join(Thread.java:1239)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:561)
   [junit4] 	at com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:521)
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:145)
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:238)
   [junit4] 	at com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
   [junit4] 
   [junit4] "VM Thread" prio=10 tid=0x00007f4c3806f800 nid=0x6e3b runnable 
   [junit4] 
   [junit4] "GC task thread#0 (ParallelGC)" prio=10 tid=0x00007f4c3801d000 nid=0x6e1d runnable 
   [junit4] 
   [junit4] "GC task thread#1 (ParallelGC)" prio=10 tid=0x00007f4c3801f000 nid=0x6e1f runnable 
   [junit4] 
   [junit4] "GC task thread#2 (ParallelGC)" prio=10 tid=0x00007f4c38021000 nid=0x6e21 runnable 
   [junit4] 
   [junit4] "GC task thread#3 (ParallelGC)" prio=10 tid=0x00007f4c38022800 nid=0x6e23 runnable 
   [junit4] 
   [junit4] "GC task thread#4 (ParallelGC)" prio=10 tid=0x00007f4c38024800 nid=0x6e24 runnable 
   [junit4] 
   [junit4] "GC task thread#5 (ParallelGC)" prio=10 tid=0x00007f4c38026800 nid=0x6e25 runnable 
   [junit4] 
   [junit4] "GC task thread#6 (ParallelGC)" prio=10 tid=0x00007f4c38028000 nid=0x6e26 runnable 
   [junit4] 
   [junit4] "GC task thread#7 (ParallelGC)" prio=10 tid=0x00007f4c3802a000 nid=0x6e28 runnable 
   [junit4] 
   [junit4] "VM Periodic Task Thread" prio=10 tid=0x00007f4c380a6800 nid=0x6e50 waiting on condition 
   [junit4] 
   [junit4] JNI global references: 1113
   [junit4] 
   [junit4] Heap
   [junit4]  PSYoungGen      total 122560K, used 101761K [0x00000000f5560000, 0x00000000fdb50000, 0x0000000100000000)
   [junit4]   eden space 119552K, 82% used [0x00000000f5560000,0x00000000fb5d0448,0x00000000fca20000)
   [junit4]   from space 3008K, 100% used [0x00000000fd860000,0x00000000fdb50000,0x00000000fdb50000)
   [junit4]   to   space 8064K, 0% used [0x00000000fcb90000,0x00000000fcb90000,0x00000000fd370000)
   [junit4]  PSOldGen        total 171008K, used 74086K [0x00000000e0000000, 0x00000000ea700000, 0x00000000f5560000)
   [junit4]   object space 171008K, 43% used [0x00000000e0000000,0x00000000e4859af8,0x00000000ea700000)
   [junit4]  PSPermGen       total 44352K, used 20608K [0x00000000dae00000, 0x00000000dd950000, 0x00000000e0000000)
   [junit4]   object space 44352K, 46% used [0x00000000dae00000,0x00000000dc2200d0,0x00000000dd950000)
   [junit4] <<< JVM J1: EOF ----
{noformat}
                
> TestDocumentsWriterStallControl hang (reproducible)
> ---------------------------------------------------
>
>                 Key: LUCENE-4136
>                 URL: https://issues.apache.org/jira/browse/LUCENE-4136
>             Project: Lucene - Java
>          Issue Type: Bug
>            Reporter: Robert Muir
>
> On trunk (probably affects 4.0 too, but trunk is where i hit it):
> ant test -Dtestcase=TestDocumentsWriterStallControl -Dtests.seed=9D5404FF4A909330

--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators: https://issues.apache.org/jira/secure/ContactAdministrators!default.jspa
For more information on JIRA, see: http://www.atlassian.com/software/jira

        

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org