Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-7.x/32/

4 tests failed.
FAILED:  org.apache.lucene.index.TestIndexSorting.testRandom3

Error Message:
Java heap space

Stack Trace:
java.lang.OutOfMemoryError: Java heap space
        at 
__randomizedtesting.SeedInfo.seed([2E240DD4F2684B9D:8CFC430E969A629B]:0)
        at org.apache.lucene.util.packed.Packed64.<init>(Packed64.java:73)
        at 
org.apache.lucene.util.packed.PackedInts.getMutable(PackedInts.java:972)
        at 
org.apache.lucene.util.packed.PackedInts.getMutable(PackedInts.java:939)
        at 
org.apache.lucene.util.packed.GrowableWriter.ensureCapacity(GrowableWriter.java:80)
        at 
org.apache.lucene.util.packed.GrowableWriter.set(GrowableWriter.java:88)
        at 
org.apache.lucene.util.packed.AbstractPagedMutable.set(AbstractPagedMutable.java:98)
        at org.apache.lucene.util.fst.NodeHash.addNew(NodeHash.java:152)
        at org.apache.lucene.util.fst.NodeHash.rehash(NodeHash.java:169)
        at org.apache.lucene.util.fst.NodeHash.add(NodeHash.java:133)
        at org.apache.lucene.util.fst.Builder.compileNode(Builder.java:200)
        at org.apache.lucene.util.fst.Builder.freezeTail(Builder.java:296)
        at org.apache.lucene.util.fst.Builder.add(Builder.java:400)
        at 
org.apache.lucene.codecs.memory.MemoryDocValuesConsumer.writeFST(MemoryDocValuesConsumer.java:373)
        at 
org.apache.lucene.codecs.memory.MemoryDocValuesConsumer.addSortedField(MemoryDocValuesConsumer.java:416)
        at 
org.apache.lucene.codecs.memory.MemoryDocValuesConsumer.addSortedField(MemoryDocValuesConsumer.java:406)
        at 
org.apache.lucene.codecs.DocValuesConsumer.mergeSortedField(DocValuesConsumer.java:527)
        at 
org.apache.lucene.codecs.DocValuesConsumer.merge(DocValuesConsumer.java:139)
        at 
org.apache.lucene.codecs.perfield.PerFieldDocValuesFormat$FieldsWriter.merge(PerFieldDocValuesFormat.java:151)
        at 
org.apache.lucene.index.SegmentMerger.mergeDocValues(SegmentMerger.java:181)
        at org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:125)
        at 
org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4392)
        at org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4032)
        at 
org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40)
        at org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2235)
        at org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:2068)
        at org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:2019)
        at 
org.apache.lucene.index.TestIndexSorting.testRandom3(TestIndexSorting.java:2318)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)


FAILED:  org.apache.solr.update.AutoCommitTest.testMaxDocs

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([40BFB5BAEEAE1CBC:F93E6365C2441836]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:880)
        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

        request was:q=id:14&qt=&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:873)
        ... 40 more


FAILED:  org.apache.solr.update.AutoCommitTest.testMaxTime

Error Message:
Exception during query

Stack Trace:
java.lang.RuntimeException: Exception during query
        at 
__randomizedtesting.SeedInfo.seed([40BFB5BAEEAE1CBC:DA4BC85870348080]:0)
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:880)
        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
        xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
</response>

        request was:q=id:529&qt=&start=0&rows=20&version=2.2
        at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:873)
        ... 40 more


FAILED:  org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test

Error Message:
expected:<2> but was:<3>

Stack Trace:
java.lang.AssertionError: expected:<2> but was:<3>
        at 
__randomizedtesting.SeedInfo.seed([40BFB5BAEEAE1CBC:C8EB8A6040527144]: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.solr.cloud.SharedFSAutoReplicaFailoverTest.assertSliceAndReplicaCount(SharedFSAutoReplicaFailoverTest.java:403)
        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:248)
        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:136)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 1148 lines...]
   [junit4] Suite: org.apache.lucene.index.TestIndexSorting
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestIndexSorting 
-Dtests.method=testRandom3 -Dtests.seed=2E240DD4F2684B9D -Dtests.multiplier=2 
-Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=ru -Dtests.timezone=America/Costa_Rica -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR    243s J1 | TestIndexSorting.testRandom3 <<<
   [junit4]    > Throwable #1: java.lang.OutOfMemoryError: Java heap space
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([2E240DD4F2684B9D:8CFC430E969A629B]:0)
   [junit4]    >        at 
org.apache.lucene.util.packed.Packed64.<init>(Packed64.java:73)
   [junit4]    >        at 
org.apache.lucene.util.packed.PackedInts.getMutable(PackedInts.java:972)
   [junit4]    >        at 
org.apache.lucene.util.packed.PackedInts.getMutable(PackedInts.java:939)
   [junit4]    >        at 
org.apache.lucene.util.packed.GrowableWriter.ensureCapacity(GrowableWriter.java:80)
   [junit4]    >        at 
org.apache.lucene.util.packed.GrowableWriter.set(GrowableWriter.java:88)
   [junit4]    >        at 
org.apache.lucene.util.packed.AbstractPagedMutable.set(AbstractPagedMutable.java:98)
   [junit4]    >        at 
org.apache.lucene.util.fst.NodeHash.addNew(NodeHash.java:152)
   [junit4]    >        at 
org.apache.lucene.util.fst.NodeHash.rehash(NodeHash.java:169)
   [junit4]    >        at 
org.apache.lucene.util.fst.NodeHash.add(NodeHash.java:133)
   [junit4]    >        at 
org.apache.lucene.util.fst.Builder.compileNode(Builder.java:200)
   [junit4]    >        at 
org.apache.lucene.util.fst.Builder.freezeTail(Builder.java:296)
   [junit4]    >        at 
org.apache.lucene.util.fst.Builder.add(Builder.java:400)
   [junit4]    >        at 
org.apache.lucene.codecs.memory.MemoryDocValuesConsumer.writeFST(MemoryDocValuesConsumer.java:373)
   [junit4]    >        at 
org.apache.lucene.codecs.memory.MemoryDocValuesConsumer.addSortedField(MemoryDocValuesConsumer.java:416)
   [junit4]    >        at 
org.apache.lucene.codecs.memory.MemoryDocValuesConsumer.addSortedField(MemoryDocValuesConsumer.java:406)
   [junit4]    >        at 
org.apache.lucene.codecs.DocValuesConsumer.mergeSortedField(DocValuesConsumer.java:527)
   [junit4]    >        at 
org.apache.lucene.codecs.DocValuesConsumer.merge(DocValuesConsumer.java:139)
   [junit4]    >        at 
org.apache.lucene.codecs.perfield.PerFieldDocValuesFormat$FieldsWriter.merge(PerFieldDocValuesFormat.java:151)
   [junit4]    >        at 
org.apache.lucene.index.SegmentMerger.mergeDocValues(SegmentMerger.java:181)
   [junit4]    >        at 
org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:125)
   [junit4]    >        at 
org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4392)
   [junit4]    >        at 
org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4032)
   [junit4]    >        at 
org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40)
   [junit4]    >        at 
org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2235)
   [junit4]    >        at 
org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:2068)
   [junit4]    >        at 
org.apache.lucene.index.IndexWriter.forceMerge(IndexWriter.java:2019)
   [junit4]    >        at 
org.apache.lucene.index.TestIndexSorting.testRandom3(TestIndexSorting.java:2318)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/lucene/build/core/test/J1/temp/lucene.index.TestIndexSorting_2E240DD4F2684B9D-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{docs=PostingsFormat(name=Direct), 
sparse_text=PostingsFormat(name=LuceneVarGapFixedInterval), 
norms=PostingsFormat(name=Direct), positions=PostingsFormat(name=Memory), 
id=PostingsFormat(name=Direct), term_vectors=PostingsFormat(name=Direct)}, 
docValues:{multi_valued_long=DocValuesFormat(name=Asserting), 
foo=DocValuesFormat(name=Asserting), numeric=DocValuesFormat(name=Memory), 
float=DocValuesFormat(name=Lucene70), 
multi_valued_numeric=DocValuesFormat(name=Memory), 
long=DocValuesFormat(name=Lucene70), points=DocValuesFormat(name=Direct), 
sparse_int=DocValuesFormat(name=Lucene70), bar=DocValuesFormat(name=Memory), 
multi_valued_double=DocValuesFormat(name=Memory), 
docs=DocValuesFormat(name=Memory), id=DocValuesFormat(name=Memory), 
multi_valued_int=DocValuesFormat(name=Direct), 
multi_valued_bytes=DocValuesFormat(name=Memory), 
sparse_text=DocValuesFormat(name=Lucene70), 
double=DocValuesFormat(name=Memory), positions=DocValuesFormat(name=Asserting), 
sparse_binary=DocValuesFormat(name=Lucene70), int=DocValuesFormat(name=Memory), 
sorted=DocValuesFormat(name=Memory), 
multi_valued_string=DocValuesFormat(name=Memory), 
norms=DocValuesFormat(name=Memory), sparse=DocValuesFormat(name=Lucene70), 
bytes=DocValuesFormat(name=Memory), binary=DocValuesFormat(name=Memory), 
dense_int=DocValuesFormat(name=Memory), 
multi_valued_float=DocValuesFormat(name=Asserting), 
term_vectors=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=723, 
maxMBSortInHeap=6.938002432028471, sim=RandomSimilarity(queryNorm=true): 
{positions=DFR I(ne)1, id=DFR I(F)LZ(0.3), term_vectors=DFR I(ne)2}, locale=ru, 
timezone=America/Costa_Rica
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=4,threads=1,free=318313096,total=379584512
   [junit4]   2> NOTE: All tests run in this JVM: [TestInfoStream, 
TestParallelTermEnum, TestCodecUtil, TestDocIdsWriter, 
TestIndexOrDocValuesQuery, TestCustomSearcherSort, TestDuelingCodecs, 
TestOmitPositions, TestPriorityQueue, TestRecyclingByteBlockAllocator, 
TestAllFilesDetectTruncation, TestWeakIdentityMap, TestCharArraySet, 
TestElevationComparator, TestCustomNorms, TestSpanExplanationsOfNonMatches, 
TestFilterLeafReader, TestPointValues, TestTieredMergePolicy, 
TestTransactionRollback, TestQueryBuilder, TestRecyclingIntBlockAllocator, 
TestFieldValueQuery, TestSortRandom, TestDemo, TestSameScoresWithThreads, 
TestFastDecompressionMode, TestSpanOrQuery, TestLucene60FieldInfoFormat, 
TestCloseableThreadLocal, TestTermQuery, TestLockFactory, 
TestMultiTermConstantScore, TestByteSlices, TestSpanFirstQuery, 
TestPrefixInBooleanQuery, TestDeterminism, TestRAMDirectory, 
FuzzyTermOnShortTermsTest, Test2BSortedDocValuesFixedSorted, TestLRUQueryCache, 
TestBufferedChecksum, TestMSBRadixSorter, TestParallelLeafReader, 
TestSpanExplanations, TestSPIClassIterator, TestPointQueries, 
TestLucene70DocValuesFormat, TestWildcard, TestDuelingCodecsAtNight, 
TestBooleanOr, TestPolygon, TestDoubleValuesSource, TestFieldType, 
TestExternalCodecs, TestForTooMuchCloning, TestOmitTf, TestMinimize, 
TestDocValuesQueries, TestBooleanQuery, TestBM25Similarity, 
TestMultiPhraseEnum, TestStressNRT, TestInPlaceMergeSorter, TestTimSorter, 
TestPrefixRandom, TestTermdocPerf, TestTermVectorsReader, TestDoc, 
TestIndexWriterOutOfFileDescriptors, TestBlockPostingsFormat3, 
TestSearcherManager, TestVirtualMethod, TestIndexWriterUnicode, 
TestIndexSorting]
   [junit4] Completed [273/454 (1!)] on J1 in 312.37s, 50 tests, 1 error <<< 
FAILURES!

[...truncated 644 lines...]
   [junit4] JVM J1: stdout was not empty, see: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/lucene/build/core/test/temp/junit4-J1-20170821_153604_1119205492859019634059.sysout
   [junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
   [junit4] java.lang.OutOfMemoryError: Java heap space
   [junit4] Dumping heap to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/heapdumps/java_pid22267.hprof
 ...
   [junit4] Heap dump file created [501544693 bytes in 2.578 secs]
   [junit4] <<< JVM J1: EOF ----

[...truncated 9546 lines...]
   [junit4] Suite: org.apache.solr.update.AutoCommitTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_40BFB5BAEEAE1CBC-001/init-core-data-001
   [junit4]   2> 226424 WARN  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 226424 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 226426 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 226426 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 226427 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 226427 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 226456 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 226475 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 226620 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 226695 WARN  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 226695 WARN  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 226695 WARN  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 226708 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 226739 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 226776 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 227046 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 227064 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1,
 trusted=true
   [junit4]   2> 227064 WARN  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr 
metrics via JMX.
   [junit4]   2> 227064 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 227064 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_40BFB5BAEEAE1CBC-001/init-core-data-001/]
   [junit4]   2> 227065 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=28, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.6945219450271389]
   [junit4]   2> 227147 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 227147 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 227155 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 227155 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 227155 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=17, maxMergedSegmentMB=0.9033203125, 
floorSegmentMB=1.9599609375, forceMergeDeletesPctAllowed=4.359096416575653, 
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.17750527996062795
   [junit4]   2> 227156 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@78828a4a[collection1] main]
   [junit4]   2> 227159 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 227185 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 227889 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 227889 INFO  (coreLoadExecutor-107-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1576369626105774080
   [junit4]   2> 227890 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 227897 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 227898 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 227898 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 227898 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 227899 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxDocs
   [junit4]   2> 227900 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 227900 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 227901 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 227901 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3481239[collection1] realtime]
   [junit4]   2> 227903 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 3
   [junit4]   2> 227903 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 227904 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 227904 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 227904 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 227905 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 227905 INFO  
(searcherExecutor-108-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@78828a4a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 227948 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 228006 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 228116 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 228137 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1
   [junit4]   2> 228138 WARN  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 228138 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_40BFB5BAEEAE1CBC-001/init-core-data-001/]
   [junit4]   2> 228174 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 228174 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 228176 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3adb8989[collection1] main]
   [junit4]   2> 228176 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 228177 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 228180 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 228180 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1576369626410909696
   [junit4]   2> 228188 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 228188 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 228189 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 228189 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 228189 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 228189 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=45, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=1.5869140625, 
floorSegmentMB=1.7705078125, forceMergeDeletesPctAllowed=14.309636822601272, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 228190 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 228190 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 228191 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 228191 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 228191 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 228192 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3adb8989[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 228192 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3432bec9[collection1] main]
   [junit4]   2> 228193 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@552d876d
   [junit4]   2> 228193 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1429047149
   [junit4]   2> 228193 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3c52887d: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / null
   [junit4]   2> 228196 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3432bec9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 228198 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[0 
(1576369626426638336)]} 0 3
   [junit4]   2> 228199 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[1 
(1576369626430832640)]} 0 4
   [junit4]   2> 228200 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 
(1576369626430832641)]} 0 4
   [junit4]   2> 228201 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[3 
(1576369626431881216)]} 0 6
   [junit4]   2> 228204 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[4 
(1576369626432929792)]} 0 8
   [junit4]   2> 228206 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[5 
(1576369626437124096)]} 0 11
   [junit4]   2> 228207 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[6 
(1576369626439221248)]} 0 11
   [junit4]   2> 228211 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[7 
(1576369626439221249)]} 0 15
   [junit4]   2> 228214 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[8 
(1576369626443415552)]} 0 19
   [junit4]   2> 228215 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[9 
(1576369626446561280)]} 0 19
   [junit4]   2> 228215 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[10 
(1576369626447609856)]} 0 20
   [junit4]   2> 228216 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[11 
(1576369626447609857)]} 0 20
   [junit4]   2> 228216 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[12 
(1576369626448658432)]} 0 21
   [junit4]   2> 228217 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[13 
(1576369626448658433)]} 0 21
   [junit4]   2> 228217 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:1&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 228223 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[14 
(1576369626451804160)]} 0 27
   [junit4]   2> 228224 INFO  (commitScheduler-116-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 228225 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[15 
(1576369626457047040)]} 0 29
   [junit4]   2> 228226 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:14&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 228226 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:14&qt=&start=0&rows=20&version=2.2
   [junit4]   2> 228226 ERROR 
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:14&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST 
FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:14&qt=&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:873)
   [junit4]   2>        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 228227 INFO  
(TEST-AutoCommitTest.testMaxDocs-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxDocs
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxDocs -Dtests.seed=40BFB5BAEEAE1CBC -Dtests.multiplier=2 
-Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=mt-MT -Dtests.timezone=Africa/Maputo -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.33s J2 | AutoCommitTest.testMaxDocs <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([40BFB5BAEEAE1CBC:F93E6365C2441836]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:880)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxDocs(AutoCommitTest.java:225)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request was:q=id:14&qt=&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:873)
   [junit4]    >        ... 40 more
   [junit4]   2> 228232 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Starting testCommitWithin
   [junit4]   2> 228300 INFO  (commitScheduler-116-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@182749fd[collection1] main]
   [junit4]   2> 228302 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL 
DOCUMENTS FROM INDEX
   [junit4]   2> 228303 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@334d1836[collection1] realtime]
   [junit4]   2> 228303 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null 
path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 71
   [junit4]   2> 228303 ERROR 
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 228304 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 228305 INFO  
(searcherExecutor-113-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@182749fd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C16)))}
   [junit4]   2> 228305 INFO  (commitScheduler-116-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 228335 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 228369 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 228568 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 228578 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1
   [junit4]   2> 228578 WARN  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr 
metrics via JMX.
   [junit4]   2> 228578 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_40BFB5BAEEAE1CBC-001/init-core-data-001/]
   [junit4]   2> 228708 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 228708 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 228709 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6f886252[collection1] main]
   [junit4]   2> 228709 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 228710 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 228713 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 228714 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 228715 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 228715 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 228715 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 228717 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 228718 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 228718 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 228718 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 228718 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 228719 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6f886252[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 228734 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=74.0341796875, 
floorSegmentMB=1.8916015625, forceMergeDeletesPctAllowed=10.825225585052507, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 228738 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 228739 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@376505d7[collection1] main]
   [junit4]   2> 228739 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@376505d7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 228739 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@10370789
   [junit4]   2> 228740 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=272041865
   [junit4]   2> 228740 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@7be6b2b: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / null
   [junit4]   2> 228743 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1576369627000209408)]} 0 2
   [junit4]   2> 228744 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 232743 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 232760 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1ee5370b[collection1] main]
   [junit4]   2> 232762 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ee5370b[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C1)))}
   [junit4]   2> 232762 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 232777 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1576369631229116416)]} 0 4035
   [junit4]   2> 232778 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 232779 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[529 
(-1576369631233310720)]} 0 4037
   [junit4]   2> 232779 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 234779 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 234839 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@d1176f4[collection1] 
main]
   [junit4]   2> 234841 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@d1176f4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.1.0):C1)))}
   [junit4]   2> 234842 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 235034 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1
   [junit4]   2> 235035 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 235038 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633599946752)]} 0 6296
   [junit4]   2> 235039 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633602043904)]} 0 6297
   [junit4]   2> 235039 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633603092480)]} 0 6298
   [junit4]   2> 235040 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633604141056)]} 0 6298
   [junit4]   2> 235040 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633604141057)]} 0 6299
   [junit4]   2> 235041 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633604141058)]} 0 6299
   [junit4]   2> 235041 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633605189632)]} 0 6300
   [junit4]   2> 235042 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633605189633)]} 0 6300
   [junit4]   2> 235042 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633606238208)]} 0 6300
   [junit4]   2> 235043 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[500 
(1576369633606238209)]} 0 6301
   [junit4]   2> 235043 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 235044 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633607286784)]} 0 6302
   [junit4]   2> 235044 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633608335360)]} 0 6302
   [junit4]   2> 235044 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633608335361)]} 0 6302
   [junit4]   2> 235044 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633608335362)]} 0 6302
   [junit4]   2> 235044 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633608335363)]} 0 6303
   [junit4]   2> 235045 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633609383936)]} 0 6303
   [junit4]   2> 235045 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633609383937)]} 0 6303
   [junit4]   2> 235045 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633609383938)]} 0 6303
   [junit4]   2> 235045 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633609383939)]} 0 6304
   [junit4]   2> 235046 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {delete=[530 
(-1576369633609383940)]} 0 6304
   [junit4]   2> 235046 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 236044 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
   [junit4]   2> 236051 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@39304f1d[collection1] main]
   [junit4]   2> 236052 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@39304f1d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.1.0):C10/9:delGen=1)))}
   [junit4]   2> 236054 INFO  (commitScheduler-120-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 236299 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:500&qt=&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
   [junit4]   2> 236301 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:530&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 236302 INFO  
(TEST-AutoCommitTest.testCommitWithin-seed#[40BFB5BAEEAE1CBC]) [    
x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testCommitWithin
   [junit4]   2> 236304 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Starting testMaxTime
   [junit4]   2> 236305 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 236306 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1c9ad35d[collection1] realtime]
   [junit4]   2> 236306 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}{deleteByQuery=*:*
 (-9223372036854775807)} 0 1
   [junit4]   2> 236307 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.CorePropertiesLocator Couldn't load core descriptor from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/core.properties:java.nio.file.NoSuchFileException:
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/core.properties
   [junit4]   2> 236307 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 236341 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 236377 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 236501 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 236517 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1
   [junit4]   2> 236518 WARN  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter No JMX server found. Not exposing Solr metrics via 
JMX.
   [junit4]   2> 236518 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.update.AutoCommitTest_40BFB5BAEEAE1CBC-001/init-core-data-001/]
   [junit4]   2> 236577 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 236577 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 236578 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@556c3f06[collection1] main]
   [junit4]   2> 236579 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 236579 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 236582 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 236588 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 236589 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 236589 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 236589 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 236589 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 236590 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=31, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=52.958984375, 
floorSegmentMB=1.7470703125, forceMergeDeletesPctAllowed=23.403136836039675, 
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 236599 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 236599 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 236599 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 236602 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 236602 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 236603 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@556c3f06[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 236603 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@6ca889a2[collection1] main]
   [junit4]   2> 236603 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@2b14c801
   [junit4]   2> 236603 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=722782209
   [junit4]   2> 236603 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2ce53525: rootName = null, 
domain = solr.core.collection1, service url = null, agent id = null] for 
registry solr.core.collection1 / null
   [junit4]   2> 236607 INFO  
(searcherExecutor-121-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6ca889a2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 236620 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[529 
(1576369635245162496)]} 0 15
   [junit4]   2> 236620 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 236621 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[530 
(1576369635261939712)]} 0 16
   [junit4]   2> 236622 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=id:529&qt=&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0
   [junit4]   2> 236622 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]   2> 236622 ERROR 
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 REQUEST FAILED: 
q=id:529&qt=&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST 
FAILED: xpath=//result[@numFound=1]
   [junit4]   2>        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]   2> <response>
   [junit4]   2> <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]   2> </response>
   [junit4]   2> 
   [junit4]   2>        request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]   2>        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:873)
   [junit4]   2>        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 236623 INFO  
(TEST-AutoCommitTest.testMaxTime-seed#[40BFB5BAEEAE1CBC]) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###Ending testMaxTime
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=AutoCommitTest 
-Dtests.method=testMaxTime -Dtests.seed=40BFB5BAEEAE1CBC -Dtests.multiplier=2 
-Dtests.nightly=true -Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=mt-MT -Dtests.timezone=Africa/Maputo -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.32s J2 | AutoCommitTest.testMaxTime <<<
   [junit4]    > Throwable #1: java.lang.RuntimeException: Exception during 
query
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([40BFB5BAEEAE1CBC:DA4BC85870348080]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:880)
   [junit4]    >        at 
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]    > Caused by: java.lang.RuntimeException: REQUEST FAILED: 
xpath=//result[@numFound=1]
   [junit4]    >        xml response was: <?xml version="1.0" encoding="UTF-8"?>
   [junit4]    > <response>
   [junit4]    > <lst name="responseHeader"><int name="status">0</int><int 
name="QTime">0</int></lst><result name="response" numFound="0" 
start="0"></result>
   [junit4]    > </response>
   [junit4]    >        request was:q=id:529&qt=&start=0&rows=20&version=2.2
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:873)
   [junit4]    >        ... 40 more
   [junit4]   2> 236623 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 236623 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1785408474
   [junit4]   2> 236623 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 236623 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1b7ad5e5: rootName = null, 
domain = solr.node, service url = null, agent id = null] for registry solr.node 
/ null
   [junit4]   2> 236624 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 236624 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@351b5403: rootName = null, 
domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / 
null
   [junit4]   2> 236624 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 236624 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@45d59891: rootName = null, 
domain = solr.jetty, service url = null, agent id = null] for registry 
solr.jetty / null
   [junit4]   2> 236624 INFO  
(SUITE-AutoCommitTest-seed#[40BFB5BAEEAE1CBC]-worker) [    x:collection1] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 236632 INFO  
(coreCloseExecutor-125-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@368ca887
   [junit4]   2> 236632 INFO  (cor

[...truncated too long message...]

[junit4]   2>   13      /solr/collections
   [junit4]   2>        8       /solr/live_nodes
   [junit4]   2>        5       /solr/overseer/queue
   [junit4]   2>        5       /solr/overseer/collection-queue-work
   [junit4]   2>        5       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: download the large Jenkins line-docs file by running 
'ant get-jenkins-line-docs' in the lucene directory.
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=SharedFSAutoReplicaFailoverTest -Dtests.method=test 
-Dtests.seed=40BFB5BAEEAE1CBC -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/test-data/enwiki.random.lines.txt
 -Dtests.locale=be -Dtests.timezone=Pacific/Kiritimati -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 82.0s J2 | SharedFSAutoReplicaFailoverTest.test <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: expected:<2> but 
was:<3>
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([40BFB5BAEEAE1CBC:C8EB8A6040527144]:0)
   [junit4]    >        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.assertSliceAndReplicaCount(SharedFSAutoReplicaFailoverTest.java:403)
   [junit4]    >        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.testBasics(SharedFSAutoReplicaFailoverTest.java:248)
   [junit4]    >        at 
org.apache.solr.cloud.SharedFSAutoReplicaFailoverTest.test(SharedFSAutoReplicaFailoverTest.java:136)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:993)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:968)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 3686378 WARN  
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
   [junit4]   2> 3686408 INFO  
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 3686509 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data4/]]
  heartbeating to localhost/127.0.0.1:50152) [    ] 
o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager 
interrupted
   [junit4]   2> 3686509 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data3/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data4/]]
  heartbeating to localhost/127.0.0.1:50152) [    ] o.a.h.h.s.d.DataNode Ending 
block pool service for: Block pool BP-38432504-10.41.0.5-1503346599670 
(Datanode Uuid 433cbaf4-1043-4d5a-8a2f-5339251af270) service to 
localhost/127.0.0.1:50152
   [junit4]   2> 3686512 WARN  
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
   [junit4]   2> 3686534 INFO  
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> 3686540 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data2/]]
  heartbeating to localhost/127.0.0.1:50152) [    ] 
o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager 
interrupted
   [junit4]   2> 3686540 WARN  (DataNode: 
[[[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data1/,
 
[DISK]file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001/tempDir-001/hdfsBaseDir/data/data2/]]
  heartbeating to localhost/127.0.0.1:50152) [    ] o.a.h.h.s.d.DataNode Ending 
block pool service for: Block pool BP-38432504-10.41.0.5-1503346599670 
(Datanode Uuid 2cdc0506-3a40-41ac-83e5-0edd11ce48e0) service to 
localhost/127.0.0.1:50152
   [junit4]   2> 3686547 INFO  
(SUITE-SharedFSAutoReplicaFailoverTest-seed#[40BFB5BAEEAE1CBC]-worker) [    ] 
o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.SharedFSAutoReplicaFailoverTest_40BFB5BAEEAE1CBC-001
   [junit4]   2> Aug 21, 2017 8:18:04 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 34 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{id=PostingsFormat(name=MockRandom), text=PostingsFormat(name=Memory)}, 
docValues:{_version_=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1410, 
maxMBSortInHeap=6.979102404526774, sim=RandomSimilarity(queryNorm=true): {}, 
locale=be, timezone=Pacific/Kiritimati
   [junit4]   2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation 
1.8.0_144 (64-bit)/cpus=4,threads=2,free=187101032,total=522715136
   [junit4]   2> NOTE: All tests run in this JVM: [URLClassifyProcessorTest, 
SortByFunctionTest, TestLFUCache, PolyFieldTest, TestIndexSearcher, 
TestObjectReleaseTracker, TestTolerantSearch, QueryEqualityTest, 
AutoCommitTest, SuggesterTest, TestHttpShardHandlerFactory, 
TestSQLHandlerNonCloud, RequestLoggingTest, TestSort, TestRequestForwarding, 
TestDynamicLoading, OutOfBoxZkACLAndCredentialsProvidersTest, 
TemplateUpdateProcessorTest, TestPKIAuthenticationPlugin, TestExportWriter, 
FacetPivotSmallTest, SuggesterFSTTest, UniqFieldsUpdateProcessorFactoryTest, 
LeaderElectionTest, HardAutoCommitTest, TestSolrCoreProperties, DeleteNodeTest, 
MoveReplicaTest, HdfsWriteToMultipleCollectionsTest, TestRecovery, 
BasicDistributedZk2Test, SimplePostToolTest, TestSystemCollAutoCreate, 
DirectUpdateHandlerTest, DistributedFacetPivotSmallAdvancedTest, 
TestInitParams, TestInitQParser, SolrTestCaseJ4Test, 
CloneFieldUpdateProcessorFactoryTest, PingRequestHandlerTest, CoreSorterTest, 
NotRequiredUniqueKeyTest, RecoveryZkTest, SharedFSAutoReplicaFailoverUtilsTest, 
TestStressReorder, TestDefaultStatsCache, TestFoldingMultitermQuery, 
DirectUpdateHandlerOptimizeTest, TestConfigSets, NumericFieldsTest, 
TestStandardQParsers, TestDynamicFieldResource, 
UUIDUpdateProcessorFallbackTest, TestCloudNestedDocsSort, 
TestFieldTypeCollectionResource, TestQuerySenderListener, 
ParsingFieldUpdateProcessorsTest, PrimitiveFieldTypeTest, TestApiFramework, 
TestTlogReplica, DocumentBuilderTest, FastVectorHighlighterTest, 
TestHdfsCloudBackupRestore, AddSchemaFieldsUpdateProcessorFactoryTest, 
SolrJmxReporterCloudTest, CdcrReplicationDistributedZkTest, 
SolrCloudReportersTest, TestDistributedMissingSort, TestConfigReload, 
TermVectorComponentDistributedTest, TestSortByMinMaxFunction, TestFastWriter, 
TestDistribDocBasedVersion, FullSolrCloudDistribCmdsTest, TestCodecSupport, 
DocValuesNotIndexedTest, TestBulkSchemaAPI, 
ShufflingReplicaListTransformerTest, InfoHandlerTest, TestExactStatsCache, 
TestScoreJoinQPScore, HLLUtilTest, TestManagedSchema, RemoteQueryErrorTest, 
TestJsonFacets, LeaderInitiatedRecoveryOnCommitTest, TestManagedResource, 
TestLMJelinekMercerSimilarityFactory, MissingSegmentRecoveryTest, 
TestSerializedLuceneMatchVersion, SolrInfoBeanTest, TestSubQueryTransformer, 
OverseerTaskQueueTest, DateFieldTest, TestJettySolrRunner, 
SolrCoreMetricManagerTest, TestSolrXml, TestExceedMaxTermLength, 
TestAddFieldRealTimeGet, XsltUpdateRequestHandlerTest, SpatialRPTFieldTypeTest, 
DeleteStatusTest, PathHierarchyTokenizerFactoryTest, BasicAuthStandaloneTest, 
TestConfigOverlay, TestUseDocValuesAsStored, TestRawTransformer, 
TestDFRSimilarityFactory, MergeStrategyTest, 
CollectionsAPIAsyncDistributedZkTest, PeerSyncWithIndexFingerprintCachingTest, 
DistributedQueryComponentCustomSortTest, TlogReplayBufferedWhileIndexingTest, 
ClusterStateTest, MinimalSchemaTest, CdcrVersionReplicationTest, 
TestFieldCacheWithThreads, TestSchemaResource, BasicDistributedZkTest, 
SharedFSAutoReplicaFailoverTest]
   [junit4] Completed [522/729 (2!)] on J2 in 94.47s, 1 test, 1 failure <<< 
FAILURES!

[...truncated 8261 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:818:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-7.x/checkout/build.xml:762:
 Some of the tests produced a heap dump, but did not fail. Maybe a suppressed 
OutOfMemoryError? Dumps created:
* java_pid22267.hprof

Total time: 326 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to