search

apache / lucene

Apache Lucene open-source search software
https://lucene.apache.org/
Apache License 2.0
2.62k stars 1.02k forks source link

TestLRUCache failures [LUCENE-9070] #10112

Open asfimport opened 4 years ago

asfimport commented 4 years ago 
02:11:11    [junit4] Suite: org.apache.lucene.search.TestLRUQueryCache
02:11:11    [junit4] IGNOR/A 0.00s J3 | TestLRUQueryCache.testRamBytesUsedAgreesWithRamUsageTester
02:11:11    [junit4]    > Assumption #1: #8646: RamUsageTester does not work exact in Java 9 (estimations for maps and lists)
02:11:11    [junit4] IGNOR/A 0.00s J3 | TestLRUQueryCache.testRamBytesUsedConstantEntryOverhead
02:11:11    [junit4]    > Assumption #1: #8646: RamUsageTester does not work exact in Java 9 (estimations for maps and lists)
02:11:11    [junit4] IGNOR/A 0.00s J3 | TestLRUQueryCache.testDetectMutatedQueries
02:11:11    [junit4]    > Assumption #1: #8655: For some unknown reason the non-constant BadQuery#hashCode() does not trigger ConcurrentModificationException on Java 9 b150
02:11:11    [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestLRUQueryCache -Dtests.method=testLRUConcurrentLoadsOfSameQuery -Dtests.seed=205F9EFCF29BA4D6 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=so-ET -Dtests.timezone=Europe/Ljubljana -Dtests.asserts=true -Dtests.file.encoding=UTF-8
02:11:11    [junit4] ERROR   0.02s J3 | TestLRUQueryCache.testLRUConcurrentLoadsOfSameQuery <<<
02:11:11    [junit4]    > Throwable #1: java.lang.RuntimeException: MockDirectoryWrapper: cannot close: there are still 1 open files: {_0.cfs=1}
02:11:11    [junit4]    >   at __randomizedtesting.SeedInfo.seed([205F9EFCF29BA4D6:5E7DB1C91CF54294]:0)
02:11:11    [junit4]    >   at org.apache.lucene.store.MockDirectoryWrapper.close(MockDirectoryWrapper.java:807)
02:11:11    [junit4]    >   at org.apache.lucene.search.TestLRUQueryCache.testLRUConcurrentLoadsOfSameQuery(TestLRUQueryCache.java:465)
02:11:11    [junit4]    >   at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
02:11:11    [junit4]    >   at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
02:11:11    [junit4]    >   at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
02:11:11    [junit4]    >   at java.base/java.lang.reflect.Method.invoke(Method.java:566)
02:11:11    [junit4]    >   at java.base/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    > Caused by: java.lang.RuntimeException: unclosed IndexInput: _0.cfs
02:11:11    [junit4]    >   at org.apache.lucene.store.MockDirectoryWrapper.addFileHandle(MockDirectoryWrapper.java:725)
02:11:11    [junit4]    >   at org.apache.lucene.store.MockDirectoryWrapper.openInput(MockDirectoryWrapper.java:768)
02:11:11    [junit4]    >   at org.apache.lucene.codecs.lucene50.Lucene50CompoundReader.<init>(Lucene50CompoundReader.java:79)
02:11:11    [junit4]    >   at org.apache.lucene.codecs.lucene50.Lucene50CompoundFormat.getCompoundReader(Lucene50CompoundFormat.java:70)
02:11:11    [junit4]    >   at org.apache.lucene.index.SegmentCoreReaders.<init>(SegmentCoreReaders.java:101)
02:11:11    [junit4]    >   at org.apache.lucene.index.SegmentReader.<init>(SegmentReader.java:84)
02:11:11    [junit4]    >   at org.apache.lucene.index.ReadersAndUpdates.getReader(ReadersAndUpdates.java:177)
02:11:11    [junit4]    >   at org.apache.lucene.index.ReadersAndUpdates.getReadOnlyClone(ReadersAndUpdates.java:219)
02:11:11    [junit4]    >   at org.apache.lucene.index.StandardDirectoryReader.open(StandardDirectoryReader.java:109)
02:11:11    [junit4]    >   at org.apache.lucene.index.IndexWriter.getReader(IndexWriter.java:526)
02:11:11    [junit4]    >   at org.apache.lucene.index.RandomIndexWriter.getReader(RandomIndexWriter.java:442)
02:11:11    [junit4]    >   at org.apache.lucene.index.RandomIndexWriter.getReader(RandomIndexWriter.java:376)
02:11:11    [junit4]    >   at org.apache.lucene.search.TestLRUQueryCache.testLRUConcurrentLoadsOfSameQuery(TestLRUQueryCache.java:418)
02:11:11    [junit4]    >   ... 35 more
02:11:11    [junit4]   2> NOTE: leaving temporary files on disk at: /var/lib/jenkins/workspace/apache+lucene-solr+master/lucene/build/core/test/J3/temp/lucene.search.TestLRUQueryCache_205F9EFCF29BA4D6-001
02:11:11    [junit4]   2> Nov 27, 2019 12:10:48 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
02:11:11    [junit4]   2> WARNING: Will linger awaiting termination of 6 leaked thread(s).
02:11:11    [junit4]   2> Nov 27, 2019 12:11:08 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
02:11:11    [junit4]   2> SEVERE: 6 threads leaked from SUITE scope at org.apache.lucene.search.TestLRUQueryCache: 
02:11:11    [junit4]   2>    1) Thread[id=696, name=TestLRUQueryCache2-125-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    2) Thread[id=697, name=TestLRUQueryCache2-125-thread-2, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    3) Thread[id=699, name=TestLRUQueryCache2-125-thread-4, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    4) Thread[id=700, name=TestLRUQueryCache2-125-thread-5, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    5) Thread[id=698, name=TestLRUQueryCache2-125-thread-3, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    6) Thread[id=701, name=TestLRUQueryCache-124-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2> Nov 27, 2019 12:11:08 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
02:11:11    [junit4]   2> INFO: Starting to interrupt leaked threads:
02:11:11    [junit4]   2>    1) Thread[id=696, name=TestLRUQueryCache2-125-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>    2) Thread[id=697, name=TestLRUQueryCache2-125-thread-2, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>    3) Thread[id=699, name=TestLRUQueryCache2-125-thread-4, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>    4) Thread[id=700, name=TestLRUQueryCache2-125-thread-5, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>    5) Thread[id=698, name=TestLRUQueryCache2-125-thread-3, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>    6) Thread[id=701, name=TestLRUQueryCache-124-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2> Nov 27, 2019 12:11:11 AM com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
02:11:11    [junit4]   2> SEVERE: There are still zombie threads that couldn't be terminated:
02:11:11    [junit4]   2>    1) Thread[id=696, name=TestLRUQueryCache2-125-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    2) Thread[id=697, name=TestLRUQueryCache2-125-thread-2, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    3) Thread[id=699, name=TestLRUQueryCache2-125-thread-4, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    4) Thread[id=700, name=TestLRUQueryCache2-125-thread-5, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    5) Thread[id=698, name=TestLRUQueryCache2-125-thread-3, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2>    6) Thread[id=701, name=TestLRUQueryCache-124-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]   2>         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]   2>         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84): {color=PostingsFormat(name=Direct), f=FST50, foo=FST50, name=PostingsFormat(name=Direct), text=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)), id=PostingsFormat(name=Direct), hobby=FST50}, docValues:{field=DocValuesFormat(name=Asserting), soft_delete=DocValuesFormat(name=Asserting), age=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=902, maxMBSortInHeap=6.521546273854408, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@b04168a), locale=so-ET, timezone=Europe/Ljubljana
02:11:11    [junit4]   2> NOTE: Linux 4.12.14-lp151.28.32-default amd64/Oracle Corporation 11.0.2 (64-bit)/cpus=32,threads=7,free=287030376,total=536870912
02:11:11    [junit4]   2> NOTE: All tests run in this JVM: [TestSumDocFreq, TestStringMSBRadixSorter, FuzzyTermOnShortTermsTest, TestAxiomaticF3LOG, TestLucene50TermVectorsFormat, TestIndexManyDocuments, TestFrozenBufferedUpdates, TestLazyProxSkipping, TestDeterminism, TestTopFieldCollectorEarlyTermination, TestIndexWriterDelete, TestVersion, TestMutablePointsReaderUtils, TestPrefixCodedTerms, TestSloppyPhraseQuery2, TestBinaryTerms, TestReqOptSumScorer, TestSpanMultiTermQueryWrapper, TestFloatRange, TestSpanContainQuery, TestFeatureField, TestConjunctionDISI, TestSimpleFSDirectory, TestFilterSpans, TestFuzzyQuery, TestBoolean2, TestSegmentInfos, TestFstDirectAddressing, TestSearchAfter, TestIndexingSequenceNumbers, TestDemoParallelLeafReader, TestBasicModelIF, TestFieldInvertState, TestSimilarity2, Test2BSortedDocValuesOrds, TestFlex, TestIndependenceSaturated, TestPerSegmentDeletes, TestBooleanQuery, TestFieldCacheRewriteMethod, TestForDeltaUtil, TestRegexpQuery, TestReaderWrapperDVTypeCheck, TestSynonymQuery, TestRecyclingByteBlockAllocator, TestTieredMergePolicy, TestIndexWriterOnJRECrash, TestSortedNumericSortField, TestSPIClassIterator, TestPriorityQueue, TestLRUQueryCache]
02:11:11    [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestLRUQueryCache -Dtests.seed=205F9EFCF29BA4D6 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=so-ET -Dtests.timezone=Europe/Ljubljana -Dtests.asserts=true -Dtests.file.encoding=UTF-8
02:11:11    [junit4] ERROR   0.00s J3 | TestLRUQueryCache (suite) <<<
02:11:11    [junit4]    > Throwable #1: com.carrotsearch.randomizedtesting.ThreadLeakError: 6 threads leaked from SUITE scope at org.apache.lucene.search.TestLRUQueryCache: 
02:11:11    [junit4]    >    1) Thread[id=696, name=TestLRUQueryCache2-125-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    2) Thread[id=697, name=TestLRUQueryCache2-125-thread-2, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    3) Thread[id=699, name=TestLRUQueryCache2-125-thread-4, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    4) Thread[id=700, name=TestLRUQueryCache2-125-thread-5, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    5) Thread[id=698, name=TestLRUQueryCache2-125-thread-3, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    6) Thread[id=701, name=TestLRUQueryCache-124-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >   at __randomizedtesting.SeedInfo.seed([205F9EFCF29BA4D6]:0)Throwable #2: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
02:11:11    [junit4]    >    1) Thread[id=696, name=TestLRUQueryCache2-125-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    2) Thread[id=697, name=TestLRUQueryCache2-125-thread-2, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    3) Thread[id=699, name=TestLRUQueryCache2-125-thread-4, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    4) Thread[id=700, name=TestLRUQueryCache2-125-thread-5, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    5) Thread[id=698, name=TestLRUQueryCache2-125-thread-3, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >    6) Thread[id=701, name=TestLRUQueryCache-124-thread-1, state=WAITING, group=TGRP-TestLRUQueryCache]
02:11:11    [junit4]    >         at java.base@11.0.2/jdk.internal.misc.Unsafe.park(Native Method)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.LockSupport.park(LockSupport.java:194)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2081)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:433)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1054)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1114)
02:11:11    [junit4]    >         at java.base@11.0.2/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
02:11:11    [junit4]    >         at java.base@11.0.2/java.lang.Thread.run(Thread.java:834)
02:11:11    [junit4]    >   at __randomizedtesting.SeedInfo.seed([205F9EFCF29BA4D6]:0)
02:11:11    [junit4] Completed [335/526 (1!)] on J3 in 25.48s, 31 tests, 3 errors, 3 skipped <<< FAILURES!
06:11:11    [junit4] Suite: org.apache.lucene.search.TestLRUQueryCache
06:11:11    [junit4] IGNOR/A 0.00s J2 | TestLRUQueryCache.testRamBytesUsedAgreesWithRamUsageTester
06:11:11    [junit4]    > Assumption #1: #8646: RamUsageTester does not work exact in Java 9 (estimations for maps and lists)
06:11:11    [junit4] IGNOR/A 0.00s J2 | TestLRUQueryCache.testRamBytesUsedConstantEntryOverhead
06:11:11    [junit4]    > Assumption #1: #8646: RamUsageTester does not work exact in Java 9 (estimations for maps and lists)
06:11:11    [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestLRUQueryCache -Dtests.method=testLRUConcurrentCachingAcrossSegments -Dtests.seed=862598D7E65A3764 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=ebu-KE -Dtests.timezone=America/Juneau -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
06:11:11    [junit4] FAILURE 0.06s J2 | TestLRUQueryCache.testLRUConcurrentCachingAcrossSegments <<<
06:11:11    [junit4]    > Throwable #1: java.lang.AssertionError
06:11:11    [junit4]    >   at __randomizedtesting.SeedInfo.seed([862598D7E65A3764:DA651490E2140F60]:0)
06:11:11    [junit4]    >   at org.apache.lucene.search.TestLRUQueryCache.testLRUConcurrentCachingAcrossSegments(TestLRUQueryCache.java:514)
06:11:11    [junit4]    >   at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
06:11:11    [junit4]    >   at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
06:11:11    [junit4]    >   at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
06:11:11    [junit4]    >   at java.base/java.lang.reflect.Method.invoke(Method.java:566)
06:11:11    [junit4]    >   at java.base/java.lang.Thread.run(Thread.java:834)
06:11:11    [junit4] IGNOR/A 0.00s J2 | TestLRUQueryCache.testDetectMutatedQueries
06:11:11    [junit4]    > Assumption #1: #8655: For some unknown reason the non-constant BadQuery#hashCode() does not trigger ConcurrentModificationException on Java 9 b150
06:11:11    [junit4]   2> NOTE: leaving temporary files on disk at: /var/lib/jenkins/workspace/apache+lucene-solr+master/lucene/build/core/test/J2/temp/lucene.search.TestLRUQueryCache_862598D7E65A3764-001
06:11:11    [junit4]   2> NOTE: test params are: codec=Lucene84, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@502879dd), locale=ebu-KE, timezone=America/Juneau
06:11:11    [junit4]   2> NOTE: Linux 4.19.0-6-cloud-amd64 amd64/Oracle Corporation 11.0.2 (64-bit)/cpus=32,threads=1,free=212532040,total=536870912
06:11:11    [junit4]   2> NOTE: All tests run in this JVM: [TestRamUsageEstimator, TestFileSwitchDirectory, TestApproximationSearchEquivalence, TestSpansEnum, TestTopFieldCollector, TestDisjunctionMaxQuery, TestIndependenceChiSquared, TestSegmentTermDocs, TestIndexWriterConfig, Test2BBKDPoints, TestIndexInput, TestLiveFieldValues, TestIndexSorting, TestBasicModelG, TestUsageTrackingFilterCachingPolicy, TestPendingSoftDeletes, TestIndexableField, TestDocsWithFieldSet, TestForceMergeForever, TestMultiThreadTermVectors, TestGraphTokenizers, TestFieldMaskingSpanQuery, TestManyFields, TestSnapshotDeletionPolicy, TestMinimize, TestBinaryDocument, TestPolygon2D, TestComplexExplanationsOfNonMatches, TestMultiLevelSkipList, TestSloppyPhraseQuery, TestSpanOrQuery, TestUpgradeIndexMergePolicy, TestBytesRefArray, TestDeletionPolicy, TestSpanFirstQuery, TestMultiPhraseQuery, TestDuelingCodecs, TestBooleanOr, TestLucene80NormsFormatMergeInstance, TestFixedBitDocIdSet, TestMutableValues, TestPrefixQuery, FiniteStringsIteratorTest, TestTermStates, TestSloppyMath, TestPForUtil, TestRollingBuffer, TestFieldInfos, TestConstantScoreScorer, TestUnicodeUtil, TestIntroSorter, TestStringHelper, TestCompetitiveFreqNormAccumulator, TestPostingsOffsets, TestLucene50CompoundFormat, TestDocValuesRewriteMethod, TestIOUtils, TestFieldType, TestAddIndexes, TestThreadedForceMerge, TestOmitNorms, TestElevationComparator, TestStressNRT, TestBooleanScorer, TestDocValues, TestBytesRefAttImpl, TestCharTermAttributeImpl, TestPackedTokenAttributeImpl, TestSimpleAttributeImpl, TestLucene50StoredFieldsFormatMergeInstance, TestLucene50TermVectorsFormat, TestLucene70SegmentInfoFormat, TestIndexedDISI, TestCodecHoldsOpenFiles, TestConcurrentMergeScheduler, TestDocCount, TestDocumentsWriterStallControl, TestIndexWriterExceptions2, TestIndexWriterMergePolicy, TestIndexWriterOnDiskFull, TestIsCurrent, TestLazyProxSkipping, TestMaxTermFrequency, TestMergeRateLimiter, TestMixedDocValuesUpdates, TestNeverDelete, TestNoMergePolicy, TestNorms, TestOmitTf, TestOneMergeWrappingMergePolicy, TestOrdinalMap, TestParallelCompositeReader, TestParallelReaderEmptyIndex, TestPayloads, TestReaderPool, TestReaderWrapperDVTypeCheck, TestRollback, TestSameTokenSamePosition, TestSegmentMerger, TestStressAdvance, TestTermdocPerf, TestTragicIndexWriterDeadlock, TestTransactions, TermInSetQueryTest, TestBlockMaxConjunction, TestBooleanMinShouldMatch, TestDocIdSetIterator, TestFieldValueQuery, TestFilterWeight, TestFuzzyQuery, TestLRUQueryCache]
06:11:11    [junit4] Completed [411/526 (1!)] on J2 in 2.02s, 31 tests, 1 failure, 3 skipped <<< FAILURES!

The second one reproduces but not the first one. @atris Could you have a look?

Migrated from LUCENE-9070 by Adrien Grand (@jpountz), updated Nov 28 2019

asfimport commented 4 years ago

Atri Sharma (@atris) (migrated from JIRA)

Looking

asfimport commented 4 years ago

Atri Sharma (@atris) (migrated from JIRA)

@jpountz Investigated. I could not reproduce the first one and the second one was an over zealous assert in the test which was not actually related to the test itself (checking if number of segments generated in current random run is more than 1). That should not be an assert since it is not a deterministic scenario and also does not affect the functionality that the test is checking. I pushed a fix to remove the same and beasted the test 20 times with the seed that triggered the failure – no run failed

asfimport commented 4 years ago

Adrien Grand (@jpountz) (migrated from JIRA)

@atris FYI more LRUQueryCache failures keep coming, see e.g. https://builds.apache.org/job/Lucene-Solr-Tests-master/3925/.

asfimport commented 4 years ago

Adrien Grand (@jpountz) (migrated from JIRA)

Another one https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/2031/

asfimport commented 4 years ago

Atri Sharma (@atris) (migrated from JIRA)

@jpountz I investigated the two that you pointed a few hours back – could not reproduce them

Looking at the latest one now

asfimport commented 4 years ago

Adrien Grand (@jpountz) (migrated from JIRA)

I believe some of these failures don't reproduce because they depend on timing (I haven't looked in details), but we should still work on fixing them. If this doesn't look like an easy fix, then let's revert asynchronous caching in order to not get flooded by test failures?

asfimport commented 4 years ago

Andrzej Bialecki (@sigram) (migrated from JIRA)

Sometimes I have a better luck reproducing elusive jenkins failures by running tests while generating heavy load, eg. video encoding, find / -exec grep foo {}\; or something like that...

asfimport commented 4 years ago

Atri Sharma (@atris) (migrated from JIRA)

I am +1 for reverting, though trying to identify if it is more of a test issue rather than a functionality issue. I beasted the test suite using the seeds that were mentioned in the stack trace of the failing tests but to no avail. The last failure seems more of an edge case of how a List is printed in Java (I believe there is no guarantee to the order in which elements would be printed when printing a list, and the test seems to be taking a dependency on that).

asfimport commented 4 years ago

Adrien Grand (@jpountz) (migrated from JIRA)

Can you revert for now then?

asfimport commented 4 years ago

Atri Sharma (@atris) (migrated from JIRA)

@jpountz Done