On Fri, Oct 5, 2012 at 8:27 PM, Michael McCandless
<[email protected]> wrote:
> I committed a fix ... this was actually a real bug, not a test bug,
> and my commit is just a workaround.
>
> There seems to be a starvation issue that can allow multiple indexing
> threads to flush segments faster than the single thread can "publish"
> them.  I think the problem is that "publishing" is actually somewhat
> costly (creates CFS, writes .si file, etc.), so somehow we need to
> make these steps concurrent too ... I'll open an issue for a longer
> term fix.
hoho! looking forward to that!

simon


>
> Mike McCandless
>
> http://blog.mikemccandless.com
>
> On Fri, Oct 5, 2012 at 8:03 AM, Michael McCandless
> <[email protected]> wrote:
>> TestBagOfPostings timed out: it got maxBuffereDocs 2 and the
>> AlcoholicMergePolicy!!  A bad combination ... I'll change it to
>> increase maxBufferedDocs ...
>>
>> Mike McCandless
>>
>> http://blog.mikemccandless.com
>>
>> On Fri, Oct 5, 2012 at 4:21 AM, Apache Jenkins Server
>> <[email protected]> wrote:
>>> Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/54/
>>>
>>> 6 tests failed.
>>> REGRESSION:  org.apache.lucene.index.TestBagOfPostings.test
>>>
>>> Error Message:
>>> Test abandoned because suite timeout was reached.
>>>
>>> Stack Trace:
>>> java.lang.Exception: Test abandoned because suite timeout was reached.
>>>         at __randomizedtesting.SeedInfo.seed([88207056F447E506]:0)
>>>
>>>
>>> FAILED:  junit.framework.TestSuite.org.apache.lucene.index.TestBagOfPostings
>>>
>>> Error Message:
>>> Suite timeout exceeded (>= 7200000 msec).
>>>
>>> Stack Trace:
>>> java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
>>>         at __randomizedtesting.SeedInfo.seed([88207056F447E506]:0)
>>>
>>>
>>> REGRESSION:  
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantBeforeClass
>>>
>>> Error Message:
>>> expected:<1> but was:<0>
>>>
>>> Stack Trace:
>>> java.lang.AssertionError: expected:<1> but was:<0>
>>>         at org.junit.Assert.fail(Assert.java:93)
>>>         at org.junit.Assert.failNotEquals(Assert.java:647)
>>>         at org.junit.Assert.assertEquals(Assert.java:128)
>>>         at org.junit.Assert.assertEquals(Assert.java:472)
>>>         at org.junit.Assert.assertEquals(Assert.java:456)
>>>         at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantBeforeClass(TestSystemPropertiesInvariantRule.java:114)
>>>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>>         at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.lang.reflect.Method.invoke(Method.java:616)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>>         at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>>         at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>>         at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>>         at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>>         at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>>         at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>>         at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>>         at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>>         at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>>         at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>>         at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>>         at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>>
>>>
>>> REGRESSION:  
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantAfterClass
>>>
>>> Error Message:
>>> expected:<1> but was:<0>
>>>
>>> Stack Trace:
>>> java.lang.AssertionError: expected:<1> but was:<0>
>>>         at org.junit.Assert.fail(Assert.java:93)
>>>         at org.junit.Assert.failNotEquals(Assert.java:647)
>>>         at org.junit.Assert.assertEquals(Assert.java:128)
>>>         at org.junit.Assert.assertEquals(Assert.java:472)
>>>         at org.junit.Assert.assertEquals(Assert.java:456)
>>>         at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantAfterClass(TestSystemPropertiesInvariantRule.java:123)
>>>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>>         at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.lang.reflect.Method.invoke(Method.java:616)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>>         at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>>         at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>>         at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>>         at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>>         at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>>         at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>>         at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>>         at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>>         at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>>         at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>>         at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>>         at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>>
>>>
>>> REGRESSION:  
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantInTestMethod
>>>
>>> Error Message:
>>> expected:<2> but was:<0>
>>>
>>> Stack Trace:
>>> java.lang.AssertionError: expected:<2> but was:<0>
>>>         at org.junit.Assert.fail(Assert.java:93)
>>>         at org.junit.Assert.failNotEquals(Assert.java:647)
>>>         at org.junit.Assert.assertEquals(Assert.java:128)
>>>         at org.junit.Assert.assertEquals(Assert.java:472)
>>>         at org.junit.Assert.assertEquals(Assert.java:456)
>>>         at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantInTestMethod(TestSystemPropertiesInvariantRule.java:132)
>>>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>>         at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.lang.reflect.Method.invoke(Method.java:616)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>>         at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>>         at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>>         at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>>         at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>>         at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>>         at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>>         at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>>         at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>>         at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>>         at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>>         at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>>         at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>>
>>>
>>> REGRESSION:  
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testNonStringProperties
>>>
>>> Error Message:
>>> expected:<1> but was:<0>
>>>
>>> Stack Trace:
>>> java.lang.AssertionError: expected:<1> but was:<0>
>>>         at org.junit.Assert.fail(Assert.java:93)
>>>         at org.junit.Assert.failNotEquals(Assert.java:647)
>>>         at org.junit.Assert.assertEquals(Assert.java:128)
>>>         at org.junit.Assert.assertEquals(Assert.java:472)
>>>         at org.junit.Assert.assertEquals(Assert.java:456)
>>>         at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testNonStringProperties(TestSystemPropertiesInvariantRule.java:142)
>>>         at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>>         at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>>         at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>>         at java.lang.reflect.Method.invoke(Method.java:616)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>>         at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>>         at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>>         at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>>         at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>>         at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>>         at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>>         at org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>>         at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>>         at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>>         at org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>>         at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>>         at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>>         at org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>>         at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>>         at org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>>         at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>>
>>>
>>>
>>>
>>> Build Log:
>>> [...truncated 1195 lines...]
>>> [junit4:junit4] Suite: org.apache.lucene.index.TestBagOfPostings
>>> [junit4:junit4]   2> 05-10-2012 04:20:38 AM 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate
>>> [junit4:junit4]   2> ADVERTENCIA: Suite execution timed out: 
>>> org.apache.lucene.index.TestBagOfPostings
>>> [junit4:junit4]   2> ==== jstack at approximately timeout time ====
>>> [junit4:junit4]   2> "Thread-127" ID=249 RUNNABLE
>>> [junit4:junit4]   2>    at java.util.HashMap.<init>(HashMap.java:200)
>>> [junit4:junit4]   2>    at java.util.HashMap.<init>(HashMap.java:216)
>>> [junit4:junit4]   2>    at java.util.HashSet.<init>(HashSet.java:116)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.SegmentInfoPerCommit.files(SegmentInfoPerCommit.java:83)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.SegmentInfos.files(SegmentInfos.java:791)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.IndexFileDeleter.incRef(IndexFileDeleter.java:475)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.IndexFileDeleter.checkpoint(IndexFileDeleter.java:448)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.IndexWriter.checkpoint(IndexWriter.java:2120)
>>> [junit4:junit4]   2>    - locked 
>>> org.apache.lucene.index.RandomIndexWriter$MockIndexWriter@391be1ca
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.IndexWriter.publishFlushedSegment(IndexWriter.java:2243)
>>> [junit4:junit4]   2>    - locked 
>>> org.apache.lucene.index.BufferedDeletesStream@5584b210
>>> [junit4:junit4]   2>    - locked 
>>> org.apache.lucene.index.RandomIndexWriter$MockIndexWriter@391be1ca
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriter.publishFlushedSegment(DocumentsWriter.java:511)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriter.finishFlush(DocumentsWriter.java:474)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue$SegmentFlushTicket.publish(DocumentsWriterFlushQueue.java:201)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue.innerPurge(DocumentsWriterFlushQueue.java:119)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue.tryPurge(DocumentsWriterFlushQueue.java:148)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:435)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriter.preUpdate(DocumentsWriter.java:289)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:358)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1443)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1122)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:201)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:160)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.TestBagOfPostings$1.run(TestBagOfPostings.java:94)
>>> [junit4:junit4]   2>    Locked synchronizers:
>>> [junit4:junit4]   2>    - 
>>> java.util.concurrent.locks.ReentrantLock$NonfairSync@7ac6644c
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> "TEST-TestBagOfPostings.test-seed#[88207056F447E506]" 
>>> ID=247 WAITING on org.apache.lucene.index.TestBagOfPostings$1@9caa9bf
>>> [junit4:junit4]   2>    at java.lang.Object.wait(Native Method)
>>> [junit4:junit4]   2>    - waiting on 
>>> org.apache.lucene.index.TestBagOfPostings$1@9caa9bf
>>> [junit4:junit4]   2>    at java.lang.Thread.join(Thread.java:1203)
>>> [junit4:junit4]   2>    at java.lang.Thread.join(Thread.java:1256)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.index.TestBagOfPostings.test(TestBagOfPostings.java:105)
>>> [junit4:junit4]   2>    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>> [junit4:junit4]   2>    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>> [junit4:junit4]   2>    at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>> [junit4:junit4]   2>    at java.lang.reflect.Method.invoke(Method.java:616)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
>>> [junit4:junit4]   2>    at 
>>> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
>>> [junit4:junit4]   2>    at java.lang.Thread.run(Thread.java:679)
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> "SUITE-TestBagOfPostings-seed#[88207056F447E506]" 
>>> ID=246 RUNNABLE
>>> [junit4:junit4]   2>    at sun.management.ThreadImpl.dumpThreads0(Native 
>>> Method)
>>> [junit4:junit4]   2>    at 
>>> sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:392)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:655)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl.access$800(ThreadLeakControl.java:60)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:396)
>>> [junit4:junit4]   2>    - locked java.lang.Object@76e2f88c
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:556)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:79)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$1.run(RandomizedRunner.java:492)
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> "Signal Dispatcher" ID=4 RUNNABLE
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> "Finalizer" ID=3 WAITING on 
>>> java.lang.ref.ReferenceQueue$Lock@2f2bec4e
>>> [junit4:junit4]   2>    at java.lang.Object.wait(Native Method)
>>> [junit4:junit4]   2>    - waiting on 
>>> java.lang.ref.ReferenceQueue$Lock@2f2bec4e
>>> [junit4:junit4]   2>    at 
>>> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:133)
>>> [junit4:junit4]   2>    at 
>>> java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:149)
>>> [junit4:junit4]   2>    at 
>>> java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:177)
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> "Reference Handler" ID=2 WAITING on 
>>> java.lang.ref.Reference$Lock@6ca70d13
>>> [junit4:junit4]   2>    at java.lang.Object.wait(Native Method)
>>> [junit4:junit4]   2>    - waiting on java.lang.ref.Reference$Lock@6ca70d13
>>> [junit4:junit4]   2>    at java.lang.Object.wait(Object.java:502)
>>> [junit4:junit4]   2>    at 
>>> java.lang.ref.Reference$ReferenceHandler.run(Reference.java:133)
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> "main" ID=1 WAITING on 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$1@4dd4882f
>>> [junit4:junit4]   2>    at java.lang.Object.wait(Native Method)
>>> [junit4:junit4]   2>    - waiting on 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$1@4dd4882f
>>> [junit4:junit4]   2>    at java.lang.Thread.join(Thread.java:1203)
>>> [junit4:junit4]   2>    at java.lang.Thread.join(Thread.java:1256)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:502)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:399)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>> [junit4:junit4]   2>    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> ^^==============================================
>>> [junit4:junit4]   2>
>>> [junit4:junit4]   2> NOTE: download the large Jenkins line-docs file by 
>>> running 'ant get-jenkins-line-docs' in the lucene directory.
>>> [junit4:junit4]   2> NOTE: reproduce with: ant test  
>>> -Dtestcase=TestBagOfPostings -Dtests.method=test 
>>> -Dtests.seed=88207056F447E506 -Dtests.multiplier=3 -Dtests.nightly=true 
>>> -Dtests.slow=true 
>>> -Dtests.linedocsfile=/home/hudson/lucene-data/enwiki.random.lines.txt 
>>> -Dtests.locale=es_BO -Dtests.timezone=America/Havana 
>>> -Dtests.file.encoding=ISO-8859-1
>>> [junit4:junit4] ERROR   7200s J1 | TestBagOfPostings.test <<<
>>> [junit4:junit4]    > Throwable #1: java.lang.Exception: Test abandoned 
>>> because suite timeout was reached.
>>> [junit4:junit4]    >    at 
>>> __randomizedtesting.SeedInfo.seed([88207056F447E506]:0)
>>> [junit4:junit4]   2> 05-10-2012 04:20:39 AM 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
>>> [junit4:junit4]   2> ADVERTENCIA: Will linger awaiting termination of 2 
>>> leaked thread(s).
>>> [junit4:junit4]   2> 05-10-2012 04:20:59 AM 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
>>> [junit4:junit4]   2> GRAVE: 2 threads leaked from SUITE scope at 
>>> org.apache.lucene.index.TestBagOfPostings:
>>> [junit4:junit4]   2>    1) Thread[id=249, name=Thread-127, state=RUNNABLE, 
>>> group=TGRP-TestBagOfPostings]
>>> [junit4:junit4]   2>         at java.lang.Thread.holdsLock(Native Method)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexFileDeleter.locked(IndexFileDeleter.java:114)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexFileDeleter.getRefCount(IndexFileDeleter.java:538)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexFileDeleter.decRef(IndexFileDeleter.java:507)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexFileDeleter.decRef(IndexFileDeleter.java:501)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexFileDeleter.checkpoint(IndexFileDeleter.java:462)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.checkpoint(IndexWriter.java:2120)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.publishFlushedSegment(IndexWriter.java:2243)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.publishFlushedSegment(DocumentsWriter.java:511)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.finishFlush(DocumentsWriter.java:474)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue$SegmentFlushTicket.publish(DocumentsWriterFlushQueue.java:201)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue.innerPurge(DocumentsWriterFlushQueue.java:119)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue.tryPurge(DocumentsWriterFlushQueue.java:148)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:435)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.preUpdate(DocumentsWriter.java:289)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:358)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1443)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1122)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:201)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:160)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.TestBagOfPostings$1.run(TestBagOfPostings.java:94)
>>> [junit4:junit4]   2>    2) Thread[id=247, 
>>> name=TEST-TestBagOfPostings.test-seed#[88207056F447E506], state=WAITING, 
>>> group=TGRP-TestBagOfPostings]
>>> [junit4:junit4]   2>         at java.lang.Object.wait(Native Method)
>>> [junit4:junit4]   2>         at java.lang.Thread.join(Thread.java:1203)
>>> [junit4:junit4]   2>         at java.lang.Thread.join(Thread.java:1256)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.TestBagOfPostings.test(TestBagOfPostings.java:105)
>>> [junit4:junit4]   2>         at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>> [junit4:junit4]   2>         at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>> [junit4:junit4]   2>         at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>> [junit4:junit4]   2>         at 
>>> java.lang.reflect.Method.invoke(Method.java:616)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
>>> [junit4:junit4]   2>         at 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
>>> [junit4:junit4]   2>         at java.lang.Thread.run(Thread.java:679)
>>> [junit4:junit4]   2> 05-10-2012 04:20:59 AM 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
>>> [junit4:junit4]   2> INFO: Starting to interrupt leaked threads:
>>> [junit4:junit4]   2>    1) Thread[id=249, name=Thread-127, state=RUNNABLE, 
>>> group=TGRP-TestBagOfPostings]
>>> [junit4:junit4]   2>    2) Thread[id=247, 
>>> name=TEST-TestBagOfPostings.test-seed#[88207056F447E506], state=WAITING, 
>>> group=TGRP-TestBagOfPostings]
>>> [junit4:junit4]   2> 05-10-2012 04:21:02 AM 
>>> com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
>>> [junit4:junit4]   2> SEVERE: There are still zombie threads that couldn't 
>>> be terminated:
>>> [junit4:junit4]   2>    1) Thread[id=249, name=Thread-127, state=RUNNABLE, 
>>> group=TGRP-TestBagOfPostings]
>>> [junit4:junit4]   2>         at java.io.UnixFileSystem.canonicalize0(Native 
>>> Method)
>>> [junit4:junit4]   2>         at 
>>> java.io.UnixFileSystem.canonicalize(UnixFileSystem.java:172)
>>> [junit4:junit4]   2>         at java.io.File.getCanonicalPath(File.java:576)
>>> [junit4:junit4]   2>         at 
>>> sun.security.provider.PolicyFile.canonPath(PolicyFile.java:1851)
>>> [junit4:junit4]   2>         at 
>>> java.io.FilePermission$1.run(FilePermission.java:203)
>>> [junit4:junit4]   2>         at 
>>> java.io.FilePermission$1.run(FilePermission.java:200)
>>> [junit4:junit4]   2>         at 
>>> java.security.AccessController.doPrivileged(Native Method)
>>> [junit4:junit4]   2>         at 
>>> java.io.FilePermission.init(FilePermission.java:200)
>>> [junit4:junit4]   2>         at 
>>> java.io.FilePermission.<init>(FilePermission.java:266)
>>> [junit4:junit4]   2>         at 
>>> java.lang.SecurityManager.checkRead(SecurityManager.java:888)
>>> [junit4:junit4]   2>         at java.io.File.isDirectory(File.java:769)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.store.FSDirectory$1.accept(FSDirectory.java:227)
>>> [junit4:junit4]   2>         at java.io.File.list(File.java:1027)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.store.FSDirectory.listAll(FSDirectory.java:225)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.store.FSDirectory.listAll(FSDirectory.java:243)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.store.BaseDirectoryWrapper.listAll(BaseDirectoryWrapper.java:100)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexFileDeleter.refresh(IndexFileDeleter.java:325)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.prepareFlushedSegment(IndexWriter.java:2195)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.publishFlushedSegment(DocumentsWriter.java:496)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.finishFlush(DocumentsWriter.java:474)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue$SegmentFlushTicket.publish(DocumentsWriterFlushQueue.java:201)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue.innerPurge(DocumentsWriterFlushQueue.java:119)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriterFlushQueue.tryPurge(DocumentsWriterFlushQueue.java:148)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.doFlush(DocumentsWriter.java:435)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.preUpdate(DocumentsWriter.java:289)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.DocumentsWriter.updateDocument(DocumentsWriter.java:358)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1443)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1122)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:201)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.RandomIndexWriter.addDocument(RandomIndexWriter.java:160)
>>> [junit4:junit4]   2>         at 
>>> org.apache.lucene.index.TestBagOfPostings$1.run(TestBagOfPostings.java:94)
>>> [junit4:junit4]   2> NOTE: test params are: codec=Appending, 
>>> sim=DefaultSimilarity, locale=es_BO, timezone=America/Havana
>>> [junit4:junit4]   2> NOTE: FreeBSD 9.0-RELEASE amd64/Sun Microsystems Inc. 
>>> 1.6.0_32 (64-bit)/cpus=16,threads=2,free=169074992,total=525271040
>>> [junit4:junit4]   2> NOTE: All tests run in this JVM: 
>>> [TestCompiledAutomaton, TestDocumentsWriterStallControl, TestDateTools, 
>>> TestParallelCompositeReader, TestSimilarity, TestTermsEnum, 
>>> TestReuseDocsEnum, TestHugeRamFile, TestNRTCachingDirectory, Nested1, 
>>> TestQueryWrapperFilter, TestRegexpRandom, TestLockFactory, 
>>> TestSegmentTermDocs, TestIndexWriterUnicode, TestLookaheadTokenFilter, 
>>> TestDocValuesScoring, Test2BTerms, TestCachingTokenFilter, 
>>> TestRandomStoredFields, TestCrashCausesCorruptIndex, 
>>> TestNumericRangeQuery64, TestFileSwitchDirectory, Test2BPostings, 
>>> TestSegmentMerger, TestPriorityQueue, TestSentinelIntSet, 
>>> TestPositionIncrement, TestDateSort, TestNumericRangeQuery32, 
>>> TestPerSegmentDeletes, TestPerFieldPostingsFormat2, 
>>> TestScoreCachingWrappingScorer, TestOmitTf, Nested, TestBoolean2, 
>>> TestAutomatonQueryUnicode, Before3, Before3, TestBagOfPostings]
>>> [junit4:junit4]   2> NOTE: download the large Jenkins line-docs file by 
>>> running 'ant get-jenkins-line-docs' in the lucene directory.
>>> [junit4:junit4]   2> NOTE: reproduce with: ant test  
>>> -Dtestcase=TestBagOfPostings -Dtests.seed=88207056F447E506 
>>> -Dtests.multiplier=3 -Dtests.nightly=true -Dtests.slow=true 
>>> -Dtests.linedocsfile=/home/hudson/lucene-data/enwiki.random.lines.txt 
>>> -Dtests.locale=es_BO -Dtests.timezone=America/Havana 
>>> -Dtests.file.encoding=ISO-8859-1
>>> [junit4:junit4] ERROR   0.00s J1 | TestBagOfPostings (suite) <<<
>>> [junit4:junit4]    > Throwable #1: java.lang.Exception: Suite timeout 
>>> exceeded (>= 7200000 msec).
>>> [junit4:junit4]    >    at 
>>> __randomizedtesting.SeedInfo.seed([88207056F447E506]:0)
>>> [junit4:junit4] Completed on J1 in 7223.33s, 1 test, 2 errors <<< FAILURES!
>>>
>>> [...truncated 19 lines...]
>>> [junit4:junit4] Suite: 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule
>>> [junit4:junit4] FAILURE 0.06s J1 | 
>>> TestSystemPropertiesInvariantRule.testRuleInvariantBeforeClass <<<
>>> [junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> 
>>> but was:<0>
>>> [junit4:junit4]    >    at org.junit.Assert.fail(Assert.java:93)
>>> [junit4:junit4]    >    at org.junit.Assert.failNotEquals(Assert.java:647)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:128)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:472)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:456)
>>> [junit4:junit4]    >    at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantBeforeClass(TestSystemPropertiesInvariantRule.java:114)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>> [junit4:junit4]    >    at java.lang.reflect.Method.invoke(Method.java:616)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>> [junit4:junit4]    >    at 
>>> org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>> [junit4:junit4] FAILURE 0.01s J1 | 
>>> TestSystemPropertiesInvariantRule.testRuleInvariantAfterClass <<<
>>> [junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> 
>>> but was:<0>
>>> [junit4:junit4]    >    at org.junit.Assert.fail(Assert.java:93)
>>> [junit4:junit4]    >    at org.junit.Assert.failNotEquals(Assert.java:647)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:128)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:472)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:456)
>>> [junit4:junit4]    >    at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantAfterClass(TestSystemPropertiesInvariantRule.java:123)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>> [junit4:junit4]    >    at java.lang.reflect.Method.invoke(Method.java:616)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>> [junit4:junit4]    >    at 
>>> org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>> [junit4:junit4] FAILURE 0.01s J1 | 
>>> TestSystemPropertiesInvariantRule.testRuleInvariantInTestMethod <<<
>>> [junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<2> 
>>> but was:<0>
>>> [junit4:junit4]    >    at org.junit.Assert.fail(Assert.java:93)
>>> [junit4:junit4]    >    at org.junit.Assert.failNotEquals(Assert.java:647)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:128)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:472)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:456)
>>> [junit4:junit4]    >    at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testRuleInvariantInTestMethod(TestSystemPropertiesInvariantRule.java:132)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>> [junit4:junit4]    >    at java.lang.reflect.Method.invoke(Method.java:616)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>> [junit4:junit4]    >    at 
>>> org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>> [junit4:junit4] FAILURE 0.01s J1 | 
>>> TestSystemPropertiesInvariantRule.testNonStringProperties <<<
>>> [junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<1> 
>>> but was:<0>
>>> [junit4:junit4]    >    at org.junit.Assert.fail(Assert.java:93)
>>> [junit4:junit4]    >    at org.junit.Assert.failNotEquals(Assert.java:647)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:128)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:472)
>>> [junit4:junit4]    >    at org.junit.Assert.assertEquals(Assert.java:456)
>>> [junit4:junit4]    >    at 
>>> org.apache.lucene.util.junitcompat.TestSystemPropertiesInvariantRule.testNonStringProperties(TestSystemPropertiesInvariantRule.java:142)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
>>> [junit4:junit4]    >    at 
>>> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
>>> [junit4:junit4]    >    at java.lang.reflect.Method.invoke(Method.java:616)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:45)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:42)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
>>> [junit4:junit4]    >    at 
>>> org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:30)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
>>> [junit4:junit4]    >    at 
>>> org.junit.rules.RunRules.evaluate(RunRules.java:18)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:263)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:68)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:47)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$3.run(ParentRunner.java:231)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:60)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.runChildren(ParentRunner.java:229)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.access$000(ParentRunner.java:50)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:222)
>>> [junit4:junit4]    >    at 
>>> org.junit.runners.ParentRunner.run(ParentRunner.java:300)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:161)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:255)
>>> [junit4:junit4]    >    at 
>>> com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:12)
>>> [junit4:junit4] Completed on J1 in 0.09s, 5 tests, 4 failures <<< FAILURES!
>>>
>>> [...truncated 108 lines...]
>>> BUILD FAILED
>>> /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:38:
>>>  The following error occurred while executing this line:
>>> /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/build.xml:49:
>>>  The following error occurred while executing this line:
>>> /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1143:
>>>  The following error occurred while executing this line:
>>> /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:816:
>>>  There were test failures: 309 suites, 1801 tests, 1 suite-level error, 1 
>>> error, 4 failures, 226 ignored
>>>
>>> Total time: 135 minutes 10 seconds
>>> Build step 'Invoke Ant' marked build as failure
>>> Recording test results
>>> Email was triggered for: Failure
>>> Sending email for trigger: Failure
>>>
>>>
>>>
>>>
>>> ---------------------------------------------------------------------
>>> To unsubscribe, e-mail: [email protected]
>>> For additional commands, e-mail: [email protected]
>
> ---------------------------------------------------------------------
> To unsubscribe, e-mail: [email protected]
> For additional commands, e-mail: [email protected]
>

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to