Build: 
https://builds.apache.org/job/Lucene-Solr-BadApples-NightlyTests-master/90/

3 tests failed.
FAILED:  
org.apache.lucene.codecs.simpletext.TestSimpleTextTermVectorsFormat.testRamBytesUsed

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([151BADD29D0B8642]:0)


FAILED:  
junit.framework.TestSuite.org.apache.lucene.codecs.simpletext.TestSimpleTextTermVectorsFormat

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([151BADD29D0B8642]:0)


FAILED:  
org.apache.solr.cloud.ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms

Error Message:
Address already in use

Stack Trace:
java.net.BindException: Address already in use
        at 
__randomizedtesting.SeedInfo.seed([5E843E84FE58669D:D0B01EC73EFFC6E9]:0)
        at java.base/sun.nio.ch.Net.bind0(Native Method)
        at java.base/sun.nio.ch.Net.bind(Net.java:461)
        at java.base/sun.nio.ch.Net.bind(Net.java:453)
        at 
java.base/sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:227)
        at 
java.base/sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:80)
        at 
org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:342)
        at 
org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:308)
        at 
org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
        at 
org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:236)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
        at org.eclipse.jetty.server.Server.doStart(Server.java:396)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.retryOnPortBindFailure(JettySolrRunner.java:567)
        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:506)
        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:474)
        at 
org.apache.solr.cloud.ForceLeaderTest.bringBackOldLeaderAndSendDoc(ForceLeaderTest.java:242)
        at 
org.apache.solr.cloud.ForceLeaderTest.testReplicasInLowerTerms(ForceLeaderTest.java:167)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
        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:947)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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 
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.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 8271 lines...]
   [junit4] Suite: 
org.apache.lucene.codecs.simpletext.TestSimpleTextTermVectorsFormat
   [junit4]   2> nov. 30, 2019 9:27:23 PRE PODNE 
com.carrotsearch.randomizedtesting.ThreadLeakControl$2 evaluate
   [junit4]   2> WARNING: Suite execution timed out: 
org.apache.lucene.codecs.simpletext.TestSimpleTextTermVectorsFormat
   [junit4]   2>    1) Thread[id=2739, 
name=TEST-TestSimpleTextTermVectorsFormat.testRamBytesUsed-seed#[151BADD29D0B8642],
 state=RUNNABLE, group=TGRP-TestSimpleTextTermVectorsFormat]
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextUtil.readLine(SimpleTextUtil.java:59)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextTermVectorsReader.readLine(SimpleTextTermVectorsReader.java:232)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextTermVectorsReader.get(SimpleTextTermVectorsReader.java:162)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.TermVectorsWriter.merge(TermVectorsWriter.java:223)
   [junit4]   2>         at 
app//org.apache.lucene.index.SegmentMerger.mergeVectors(SegmentMerger.java:239)
   [junit4]   2>         at 
app//org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:173)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4446)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4040)
   [junit4]   2>         at 
app//org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2141)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.processEvents(IndexWriter.java:5103)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1597)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
   [junit4]   2>         at 
app//org.apache.lucene.index.BaseIndexFileFormatTestCase.testRamBytesUsed(BaseIndexFileFormatTestCase.java:283)
   [junit4]   2>         at 
app//org.apache.lucene.index.BaseTermVectorsFormatTestCase.testRamBytesUsed(BaseTermVectorsFormatTestCase.java:71)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>         at 
[email protected]/java.lang.reflect.Method.invoke(Method.java:566)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>         at 
app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
   [junit4]   2>         at 
app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.run(Thread.java:834)
   [junit4]   2>    2) Thread[id=1, name=main, state=WAITING, group=main]
   [junit4]   2>         at [email protected]/java.lang.Object.wait(Native 
Method)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.join(Thread.java:1305)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.join(Thread.java:1379)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:639)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.run(RandomizedRunner.java:496)
   [junit4]   2>         at 
app//com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.execute(SlaveMain.java:269)
   [junit4]   2>         at 
app//com.carrotsearch.ant.tasks.junit4.slave.SlaveMain.main(SlaveMain.java:394)
   [junit4]   2>         at 
app//com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe.main(SlaveMainSafe.java:13)
   [junit4]   2>    3) Thread[id=11, name=JUnit4-serializer-daemon, 
state=TIMED_WAITING, group=main]
   [junit4]   2>         at [email protected]/java.lang.Thread.sleep(Native 
Method)
   [junit4]   2>         at 
app//com.carrotsearch.ant.tasks.junit4.events.Serializer$1.run(Serializer.java:50)
   [junit4]   2>    4) Thread[id=2738, 
name=SUITE-TestSimpleTextTermVectorsFormat-seed#[151BADD29D0B8642], 
state=RUNNABLE, group=TGRP-TestSimpleTextTermVectorsFormat]
   [junit4]   2>         at 
java.base/java.lang.Thread.getStackTrace(Thread.java:1606)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:696)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$4.run(ThreadLeakControl.java:693)
   [junit4]   2>         at 
java.base/java.security.AccessController.doPrivileged(Native Method)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.getStackTrace(ThreadLeakControl.java:693)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.getThreadsWithTraces(ThreadLeakControl.java:709)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.formatThreadStacksFull(ThreadLeakControl.java:689)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.access$1000(ThreadLeakControl.java:65)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$2.evaluate(ThreadLeakControl.java:415)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:708)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.RandomizedRunner.access$200(RandomizedRunner.java:138)
   [junit4]   2>         at 
com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:629)
   [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=TestSimpleTextTermVectorsFormat -Dtests.method=testRamBytesUsed 
-Dtests.seed=151BADD29D0B8642 -Dtests.multiplier=2 -Dtests.nightly=true 
-Dtests.slow=true -Dtests.badapples=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/test-data/enwiki.random.lines.txt
 -Dtests.locale=sr-Latn-XK -Dtests.timezone=Africa/Bangui -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   7042s J1 | TestSimpleTextTermVectorsFormat.testRamBytesUsed 
<<<
   [junit4]    > Throwable #1: java.lang.Exception: Test abandoned because 
suite timeout was reached.
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([151BADD29D0B8642]:0)
   [junit4]   2> nov. 30, 2019 9:27:23 PRE PODNE 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> nov. 30, 2019 9:27:43 PRE PODNE 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.lucene.codecs.simpletext.TestSimpleTextTermVectorsFormat: 
   [junit4]   2>    1) Thread[id=2739, 
name=TEST-TestSimpleTextTermVectorsFormat.testRamBytesUsed-seed#[151BADD29D0B8642],
 state=RUNNABLE, group=TGRP-TestSimpleTextTermVectorsFormat]
   [junit4]   2>         at 
[email protected]/sun.nio.ch.IOUtil.read(IOUtil.java:248)
   [junit4]   2>         at 
[email protected]/sun.nio.ch.FileChannelImpl.readInternal(FileChannelImpl.java:811)
   [junit4]   2>         at 
[email protected]/sun.nio.ch.FileChannelImpl.read(FileChannelImpl.java:796)
   [junit4]   2>         at 
app//org.apache.lucene.mockfile.FilterFileChannel.read(FilterFileChannel.java:111)
   [junit4]   2>         at 
app//org.apache.lucene.store.NIOFSDirectory$NIOFSIndexInput.readInternal(NIOFSDirectory.java:179)
   [junit4]   2>         at 
app//org.apache.lucene.store.BufferedIndexInput.refill(BufferedIndexInput.java:342)
   [junit4]   2>         at 
app//org.apache.lucene.store.BufferedIndexInput.readByte(BufferedIndexInput.java:54)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextUtil.readLine(SimpleTextUtil.java:59)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextFieldsReader$SimpleTextPostingsEnum.nextDoc(SimpleTextFieldsReader.java:416)
   [junit4]   2>         at 
app//org.apache.lucene.index.MappingMultiPostingsEnum$MappingPostingsSub.nextDoc(MappingMultiPostingsEnum.java:51)
   [junit4]   2>         at 
app//org.apache.lucene.index.DocIDMerger$SequentialDocIDMerger.next(DocIDMerger.java:99)
   [junit4]   2>         at 
app//org.apache.lucene.index.MappingMultiPostingsEnum.nextDoc(MappingMultiPostingsEnum.java:103)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextFieldsWriter.write(SimpleTextFieldsWriter.java:115)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.simpletext.SimpleTextFieldsWriter.write(SimpleTextFieldsWriter.java:61)
   [junit4]   2>         at 
app//org.apache.lucene.codecs.FieldsConsumer.merge(FieldsConsumer.java:105)
   [junit4]   2>         at 
app//org.apache.lucene.index.SegmentMerger.mergeTerms(SegmentMerger.java:245)
   [junit4]   2>         at 
app//org.apache.lucene.index.SegmentMerger.merge(SegmentMerger.java:140)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.mergeMiddle(IndexWriter.java:4446)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.merge(IndexWriter.java:4040)
   [junit4]   2>         at 
app//org.apache.lucene.index.SerialMergeScheduler.merge(SerialMergeScheduler.java:40)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.maybeMerge(IndexWriter.java:2141)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.processEvents(IndexWriter.java:5103)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.updateDocument(IndexWriter.java:1597)
   [junit4]   2>         at 
app//org.apache.lucene.index.IndexWriter.addDocument(IndexWriter.java:1213)
   [junit4]   2>         at 
app//org.apache.lucene.index.BaseIndexFileFormatTestCase.testRamBytesUsed(BaseIndexFileFormatTestCase.java:283)
   [junit4]   2>         at 
app//org.apache.lucene.index.BaseTermVectorsFormatTestCase.testRamBytesUsed(BaseTermVectorsFormatTestCase.java:71)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>         at 
[email protected]/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>         at 
[email protected]/java.lang.reflect.Method.invoke(Method.java:566)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
   [junit4]   2>         at 
app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
   [junit4]   2>         at 
app//org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>         at 
app//org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>         at 
app//com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>         at 
[email protected]/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> nov. 30, 2019 9:27:43 PRE PODNE 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=2739, 
name=TEST-TestSimpleTextTermVectorsFormat.testRamBytesUsed-seed#[151BADD29D0B8642],
 state=RUNNABLE, group=TGRP-TestSimpleTextTermVectorsFormat]
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/lucene/build/codecs/test/J1/temp/lucene.codecs.simpletext.TestSimpleTextTermVectorsFormat_151BADD29D0B8642-001
   [junit4]   2> Nov 30, 2019 8:27:43 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: All leaked threads terminated.
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84): {}, 
docValues:{}, maxPointsInLeafNode=1799, maxMBSortInHeap=6.408502755835702, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@99585fe),
 locale=sr-Latn-XK, timezone=Africa/Bangui
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 11.0.4 
(64-bit)/cpus=4,threads=1,free=288970032,total=407896064
   [junit4]   2> NOTE: All tests run in this JVM: [TestBloomPostingsFormat, 
TestFSTDictionary, TestUniformSplitPostingFormat, 
TestVarGapDocFreqIntervalPostingsFormat, TestSimpleTextDocValuesFormat, 
TestSimpleTextTermVectorsFormat]
   [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=TestSimpleTextTermVectorsFormat -Dtests.seed=151BADD29D0B8642 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.badapples=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/test-data/enwiki.random.lines.txt
 -Dtests.locale=sr-Latn-XK -Dtests.timezone=Africa/Bangui -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestSimpleTextTermVectorsFormat (suite) <<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 
7200000 msec).
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([151BADD29D0B8642]:0)
   [junit4] Completed [25/25 (1!)] on J1 in 7220.79s, 11 tests, 2 errors <<< 
FAILURES!

[...truncated 7222 lines...]
   [junit4] Suite: org.apache.solr.cloud.ForceLeaderWithTlogReplicasTest
   [junit4]   2> 4632487 INFO  
(SUITE-ForceLeaderWithTlogReplicasTest-seed#[5E843E84FE58669D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 4632487 INFO  
(SUITE-ForceLeaderWithTlogReplicasTest-seed#[5E843E84FE58669D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Created dataDir: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/data-dir-176-001
   [junit4]   2> 4632487 WARN  
(SUITE-ForceLeaderWithTlogReplicasTest-seed#[5E843E84FE58669D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=20 numCloses=20
   [junit4]   2> 4632488 INFO  
(SUITE-ForceLeaderWithTlogReplicasTest-seed#[5E843E84FE58669D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 4632488 INFO  
(SUITE-ForceLeaderWithTlogReplicasTest-seed#[5E843E84FE58669D]-worker) [     ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-5776";)
   [junit4]   2> 4632488 INFO  
(SUITE-ForceLeaderWithTlogReplicasTest-seed#[5E843E84FE58669D]-worker) [     ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /kr_/jx
   [junit4]   2> 4632510 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 4632512 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 4632512 INFO  (ZkTestServer Run Thread) [     ] 
o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 4632612 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer start zk server on port:37397
   [junit4]   2> 4632612 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:37397
   [junit4]   2> 4632612 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37397
   [junit4]   2> 4632612 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 37397
   [junit4]   2> 4632614 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4632616 INFO  (zkConnectionManagerCallback-14585-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4632616 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4632618 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4632619 INFO  (zkConnectionManagerCallback-14587-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4632619 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4632620 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 4632622 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 4632623 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 4632624 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 4632626 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 4632627 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 4632628 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 4632629 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 4632630 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 4632632 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 4632633 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer put 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 4632634 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.AbstractFullDistribZkTestBase Will use TLOG replicas unless 
explicitly asked otherwise
   [junit4]   2> 4632792 WARN  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 4632793 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding 
port=0)
   [junit4]   2> 4632793 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 
1 ...
   [junit4]   2> 4632793 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 
2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 
11.0.4+10-LTS
   [junit4]   2> 4632794 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 4632794 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 4632794 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@794d74d0{/kr_/jx,null,AVAILABLE}
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.AbstractConnector Started 
ServerConnector@23abb446{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:34419}
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.s.Server Started @4632957ms
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kr_/jx, 
solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/tempDir-001/control/data,
 hostPort=37951, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/control-001/cores}
   [junit4]   2> 4632796 ERROR 
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 9.0.0
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on 
port null
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 4632796 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-30T11:11:30.793876Z
   [junit4]   2> 4632797 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4632798 INFO  (zkConnectionManagerCallback-14589-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4632798 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4632900 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found 
in ZooKeeper)
   [junit4]   2> 4632900 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/control-001/solr.xml
   [junit4]   2> 4632903 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverWorkLoopDelay is ignored
   [junit4]   2> 4632903 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 4632904 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 4632977 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 4632978 WARN  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@5622615d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4632978 WARN  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@5622615d[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4632981 WARN  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.u.s.S.config Trusting all certificates configured for 
Client@27579c0c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4632981 WARN  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm 
configured for Client@27579c0c[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4632982 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37397/solr
   [junit4]   2> 4632983 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4632984 INFO  (zkConnectionManagerCallback-14596-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4632984 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4633087 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 4633088 INFO  (zkConnectionManagerCallback-14598-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4633088 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 4633175 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.OverseerElectionContext I am going 
to be the leader 127.0.0.1:37951_kr_%2Fjx
   [junit4]   2> 4633176 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.Overseer Overseer 
(id=75822617016664068-127.0.0.1:37951_kr_%2Fjx-n_0000000000) starting
   [junit4]   2> 4633183 INFO  
(OverseerStateUpdate-75822617016664068-127.0.0.1:37951_kr_%2Fjx-n_0000000000) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:37951_kr_%2Fjx
   [junit4]   2> 4633184 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.ZkController Register node as live 
in ZooKeeper:/live_nodes/127.0.0.1:37951_kr_%2Fjx
   [junit4]   2> 4633185 INFO  (zkCallback-14597-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 4633206 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 4633222 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4633231 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4633231 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4633233 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.p.PackageLoader /packages.json updated 
to version -1
   [junit4]   2> 4633234 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/control-001/cores
   [junit4]   2> 4633251 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4633251 INFO  (zkConnectionManagerCallback-14607-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4633251 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4633253 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 4633254 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:37397/solr ready
   [junit4]   2> 4633255 INFO  (SocketProxy-Acceptor-37951) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36170,localport=37951], receiveBufferSize:531000
   [junit4]   2> 4633255 INFO  (SocketProxy-Acceptor-37951) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34419,localport=49974], receiveBufferSize=530904
   [junit4]   2> 4633256 INFO  (qtp1138947557-45695) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.h.a.CollectionsHandler Invoked 
Collection Action :create with params 
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37951_kr_%252Fjx&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 4633260 INFO  
(OverseerThreadFactory-10540-thread-1-processing-n:127.0.0.1:37951_kr_%2Fjx) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.a.c.CreateCollectionCmd Create 
collection control_collection
   [junit4]   2> 4633367 INFO  (SocketProxy-Acceptor-37951) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36174,localport=37951], receiveBufferSize:531000
   [junit4]   2> 4633368 INFO  (SocketProxy-Acceptor-37951) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34419,localport=49978], receiveBufferSize=530904
   [junit4]   2> 4633368 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx    x:control_collection_shard1_replica_n1 ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 4633368 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx    x:control_collection_shard1_replica_n1 ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 4634382 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene 
MatchVersion: 9.0.0
   [junit4]   2> 4634397 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema 
[control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 4634514 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema 
test/1.0 with uniqueid field id
   [junit4]   2> 4634531 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating 
SolrCore 'control_collection_shard1_replica_n1' using configuration from 
collection control_collection, trusted=true
   [junit4]   2> 4634532 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX 
monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4634532 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore 
[[control_collection_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 4634534 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy 
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: 
[TieredMergePolicy: maxMergeAtOnce=30, maxMergeAtOnceExplicit=26, 
maxMergedSegmentMB=28.0849609375, floorSegmentMB=0.591796875, 
forceMergeDeletesPctAllowed=2.754388396374928, segmentsPerTier=34.0, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, 
deletesPctAllowed=22.8402034553187
   [junit4]   2> 4634536 WARN  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.RequestHandlers INVALID 
paramSet a in requestHandler {type = requestHandler,name = /dump,class = 
DumpRequestHandler,attributes = {initParams=a, name=/dump, 
class=DumpRequestHandler},args = {defaults={a=A, b=B}}}
   [junit4]   2> 4634579 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 4634579 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing 
UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 4634580 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 4634580 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 4634581 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy 
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: 
[TieredMergePolicy: maxMergeAtOnce=42, maxMergeAtOnceExplicit=48, 
maxMergedSegmentMB=6.9580078125, floorSegmentMB=2.1171875, 
forceMergeDeletesPctAllowed=10.38058995580226, segmentsPerTier=15.0, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.46902283766752184, 
deletesPctAllowed=25.610302030701902
   [junit4]   2> 4634581 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@119664ba[control_collection_shard1_replica_n1] main]
   [junit4]   2> 4634591 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage 
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 4634592 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded 
null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 4634592 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits 
will be reserved for 10000ms.
   [junit4]   2> 4634592 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max 
version in index or recent updates, using new clock 1651624947313803264
   [junit4]   2> 4634595 INFO  
(searcherExecutor-10545-thread-1-processing-n:127.0.0.1:37951_kr_%2Fjx 
x:control_collection_shard1_replica_n1 c:control_collection s:shard1) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore 
[control_collection_shard1_replica_n1] Registered new searcher 
Searcher@119664ba[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 4634598 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update 
of terms at /collections/control_collection/terms/shard1 to 
Terms{values={core_node2=0}, version=0}
   [junit4]   2> 4634598 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase 
make sure parent is created /collections/control_collection/leaders/shard1
   [junit4]   2> 4634602 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext 
Enough replicas found to continue.
   [junit4]   2> 4634602 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I 
may be the new leader - try and sync
   [junit4]   2> 4634602 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:37951/kr_/jx/control_collection_shard1_replica_n1/
   [junit4]   2> 4634602 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - 
now sync replicas to me
   [junit4]   2> 4634603 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy 
http://127.0.0.1:37951/kr_/jx/control_collection_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 4634603 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase 
Creating leader registration node 
/collections/control_collection/leaders/shard1/leader after winning as 
/collections/control_collection/leader_elect/shard1/election/75822617016664068-core_node2-n_0000000000
   [junit4]   2> 4634605 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I 
am the new leader: 
http://127.0.0.1:37951/kr_/jx/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 4634707 INFO  (zkCallback-14597-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4634708 INFO  (zkCallback-14597-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4634708 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, 
no recovery necessary
   [junit4]   2> 4634711 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx c:control_collection s:shard1  
x:control_collection_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1342
   [junit4]   2> 4634713 INFO  (qtp1138947557-45695) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.h.a.CollectionsHandler Wait for new 
collection to be active for at most 45 seconds. Check all shard replicas
   [junit4]   2> 4634811 INFO  (zkCallback-14597-thread-1) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4634811 INFO  (zkCallback-14597-thread-3) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4634811 INFO  (zkCallback-14597-thread-2) [     ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 4634812 INFO  (qtp1138947557-45695) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/collections 
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:37951_kr_%252Fjx&wt=javabin&version=2}
 status=0 QTime=1555
   [junit4]   2> 4634812 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas 
in collection: control_collection
   [junit4]   2> 4634918 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4634918 INFO  (zkConnectionManagerCallback-14613-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4634918 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4634920 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 4634921 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:37397/solr ready
   [junit4]   2> 4634921 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause 
connection loss:false
   [junit4]   2> 4634922 INFO  (SocketProxy-Acceptor-37951) [     ] 
o.a.s.c.s.c.SocketProxy accepted 
Socket[addr=/127.0.0.1,port=36182,localport=37951], receiveBufferSize:531000
   [junit4]   2> 4634922 INFO  (SocketProxy-Acceptor-37951) [     ] 
o.a.s.c.s.c.SocketProxy proxy connection 
Socket[addr=/127.0.0.1,port=34419,localport=49986], receiveBufferSize=530904
   [junit4]   2> 4634922 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.h.a.CollectionsHandler Invoked 
Collection Action :create with params 
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 4634926 INFO  
(OverseerThreadFactory-10540-thread-2-processing-n:127.0.0.1:37951_kr_%2Fjx) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.a.c.CreateCollectionCmd Create 
collection collection1
   [junit4]   2> 4634926 INFO  
(OverseerCollectionConfigSetProcessor-75822617016664068-127.0.0.1:37951_kr_%2Fjx-n_0000000000)
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 4635131 WARN  
(OverseerThreadFactory-10540-thread-2-processing-n:127.0.0.1:37951_kr_%2Fjx) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.a.c.CreateCollectionCmd It is unusual 
to create a collection (collection1) without cores.
   [junit4]   2> 4635133 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.h.a.CollectionsHandler Wait for new 
collection to be active for at most 45 seconds. Check all shard replicas
   [junit4]   2> 4635145 INFO  (qtp1138947557-45697) 
[n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/collections 
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2}
 status=0 QTime=222
   [junit4]   2> 4635149 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
   [junit4]   2> 4635149 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica 
count: 0
   [junit4]   2> 4635149 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
   [junit4]   2> 4635149 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica 
count: 0
   [junit4]   2> 4635150 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
   [junit4]   2> 4635150 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica 
count: 0
   [junit4]   2> 4635150 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances 
pullReplicaCount=0 numOtherReplicas=3
   [junit4]   2> 4635453 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-1-001
 of type TLOG in shard 2
   [junit4]   2> 4635458 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 4635459 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 4635459 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 4635459 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+10-LTS
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4a60df43{/kr_/jx,null,AVAILABLE}
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@3548b328{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:35990}
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.Server Started @4635622ms
   [junit4]   2> 4635460 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kr_/jx, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/tempDir-001/jetty1,
 hostPort=37876, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-1-001/cores,
 replicaType=TLOG}
   [junit4]   2> 4635461 ERROR (closeThreadPool-14614-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 4635461 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 4635461 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 4635461 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 4635461 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 4635461 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-30T11:11:33.458175Z
   [junit4]   2> 4635463 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4635475 INFO  (zkConnectionManagerCallback-14616-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4635475 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4635580 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 4635580 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-1-001/solr.xml
   [junit4]   2> 4635582 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 4635582 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 4635584 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 4635719 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 4635720 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@56dd73d1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4635720 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@56dd73d1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4635759 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6d7c987b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4635759 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6d7c987b[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4635760 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37397/solr
   [junit4]   2> 4635770 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4635770 INFO  (zkConnectionManagerCallback-14623-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4635770 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4635880 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-2-001
 of type TLOG in shard 1
   [junit4]   2> 4635889 WARN  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 4635890 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 4635890 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 4635890 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+10-LTS
   [junit4]   2> 4635894 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 4635905 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 4635905 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 4635905 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 4635905 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@38cd7de0{/kr_/jx,null,AVAILABLE}
   [junit4]   2> 4635906 INFO  (zkConnectionManagerCallback-14625-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@35025c0e{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:40567}
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.s.Server Started @4636067ms
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kr_/jx, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/tempDir-001/jetty2,
 hostPort=34589, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-2-001/cores,
 replicaType=TLOG}
   [junit4]   2> 4635906 ERROR (closeThreadPool-14614-thread-2) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 4635906 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-30T11:11:33.903810Z
   [junit4]   2> 4635907 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4635909 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 4635925 INFO  (zkConnectionManagerCallback-14627-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4635925 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4635926 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (1)
   [junit4]   2> 4635930 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:37876_kr_%2Fjx as DOWN
   [junit4]   2> 4635931 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 4 transient cores
   [junit4]   2> 4635931 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37876_kr_%2Fjx
   [junit4]   2> 4635932 INFO  (zkCallback-14597-thread-3) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 4635942 INFO  (zkCallback-14612-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 4635942 INFO  (zkCallback-14624-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 4636022 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 4636035 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 4636035 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-2-001/solr.xml
   [junit4]   2> 4636038 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 4636038 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 4636063 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 4636101 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4636136 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4636136 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4636149 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.p.PackageLoader /packages.json updated 
to version -1
   [junit4]   2> 4636150 INFO  (closeThreadPool-14614-thread-1) 
[n:127.0.0.1:37876_kr_%2Fjx     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-1-001/cores
   [junit4]   2> 4636276 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:37876_kr_%2Fjx
   [junit4]   2> 4636325 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 4636353 WARN  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@3657f0c4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4636353 WARN  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@3657f0c4[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4636369 WARN  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.u.s.S.config Trusting all certificates configured for 
Client@6e5b8846[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4636369 WARN  (closeThreadPool-14614-thread-2) [     ] 
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for 
Client@6e5b8846[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 4636371 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37397/solr
   [junit4]   2> 4636414 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4636415 INFO  (zkConnectionManagerCallback-14638-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4636415 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4636478 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-3-001
 of type TLOG in shard 2
   [junit4]   2> 4636478 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 4636479 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
   [junit4]   2> 4636479 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 4636479 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: 
afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+10-LTS
   [junit4]   2> 4636479 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 4636479 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 4636479 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1c5276ae{/kr_/jx,null,AVAILABLE}
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.AbstractConnector Started ServerConnector@a4af67{HTTP/1.1,[http/1.1, 
h2c]}{127.0.0.1:44088}
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.s.Server Started @4636641ms
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/kr_/jx, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/tempDir-001/jetty3,
 hostPort=43219, 
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-3-001/cores,
 replicaType=TLOG}
   [junit4]   2> 4636480 ERROR (closeThreadPool-14614-thread-1) [     ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
9.0.0
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 4636480 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2019-11-30T11:11:34.477971Z
   [junit4]   2> 4636482 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 4636491 INFO  (zkConnectionManagerCallback-14640-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4636491 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 4636525 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.c.ConnectionManager Waiting for 
client to connect to ZooKeeper
   [junit4]   2> 4636703 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 4636703 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-3-001/solr.xml
   [junit4]   2> 4636705 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay 
is ignored
   [junit4]   2> 4636705 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig Configuration parameter 
autoReplicaFailoverBadNodeExpiration is ignored
   [junit4]   2> 4636707 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 4636739 INFO  (zkConnectionManagerCallback-14642-thread-1) [   
  ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 4636739 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.c.ConnectionManager Client is 
connected to ZooKeeper
   [junit4]   2> 4636758 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.c.ZkStateReader Updated live nodes 
from ZooKeeper... (0) -> (2)
   [junit4]   2> 4636786 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.ZkController Publish 
node=127.0.0.1:34589_kr_%2Fjx as DOWN
   [junit4]   2> 4636787 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.TransientSolrCoreCacheDefault 
Allocating transient cache for 4 transient cores
   [junit4]   2> 4636787 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:34589_kr_%2Fjx
   [junit4]   2> 4636789 INFO  (zkCallback-14597-thread-3) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 4636789 INFO  (zkCallback-14624-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 4636789 INFO  (zkCallback-14612-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 4636800 INFO  (zkCallback-14641-thread-1) [     ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 4636817 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 4636851 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4636869 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4636877 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@772502b9
   [junit4]   2> 4636882 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.p.PackageLoader /packages.json updated 
to version -1
   [junit4]   2> 4636883 INFO  (closeThreadPool-14614-thread-2) 
[n:127.0.0.1:34589_kr_%2Fjx     ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001/shard-2-001/cores
   [junit4]   2> 4636939 INFO  
(OverseerCollectionConfigSetProcessor-75822617016664068-127.0.0.1:37951_kr_%2Fjx-n_0000000000)
 [n:127.0.0.1:37951_kr_%2Fjx     ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 4636958 INFO  (closeThreadPool-14614-thread-2) [     ] 
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:34589_kr_%2Fjx
   [junit4]   2> 4637006 INFO  (closeThreadPool-14614-thread-1) [     ] 
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: 
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
   [junit4]   2> 4637007 WARN  (closeThreadPool-14614-thread-1) [     ] 
o.e.j.u.s.S.confi

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

   2> 
   [junit4]   2> 4734754 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:37397
   [junit4]   2> 4734754 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:37397
   [junit4]   2> 4734754 INFO  
(TEST-ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms-seed#[5E843E84FE58669D])
 [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 37397
   [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=ForceLeaderWithTlogReplicasTest 
-Dtests.method=testReplicasInLowerTerms -Dtests.seed=5E843E84FE58669D 
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true 
-Dtests.badapples=true 
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/test-data/enwiki.random.lines.txt
 -Dtests.locale=lb -Dtests.timezone=Africa/Timbuktu -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR    102s J2 | 
ForceLeaderWithTlogReplicasTest.testReplicasInLowerTerms <<<
   [junit4]    > Throwable #1: java.net.BindException: Address already in use
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5E843E84FE58669D:D0B01EC73EFFC6E9]:0)
   [junit4]    >        at java.base/sun.nio.ch.Net.bind0(Native Method)
   [junit4]    >        at java.base/sun.nio.ch.Net.bind(Net.java:461)
   [junit4]    >        at java.base/sun.nio.ch.Net.bind(Net.java:453)
   [junit4]    >        at 
java.base/sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:227)
   [junit4]    >        at 
java.base/sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:80)
   [junit4]    >        at 
org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:342)
   [junit4]    >        at 
org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:308)
   [junit4]    >        at 
org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
   [junit4]    >        at 
org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:236)
   [junit4]    >        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
   [junit4]    >        at 
org.eclipse.jetty.server.Server.doStart(Server.java:396)
   [junit4]    >        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
   [junit4]    >        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.retryOnPortBindFailure(JettySolrRunner.java:567)
   [junit4]    >        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:506)
   [junit4]    >        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:474)
   [junit4]    >        at 
org.apache.solr.cloud.ForceLeaderTest.bringBackOldLeaderAndSendDoc(ForceLeaderTest.java:242)
   [junit4]    >        at 
org.apache.solr.cloud.ForceLeaderTest.testReplicasInLowerTerms(ForceLeaderTest.java:167)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:566)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
   [junit4]    >        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-NightlyTests-master/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.ForceLeaderWithTlogReplicasTest_5E843E84FE58669D-001
   [junit4]   2> Nov 30, 2019 11:13:12 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene84): 
{multiDefault=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84)),
 a_t=FSTOrd50, _root_=FSTOrd50, id=FST50, 
text=PostingsFormat(name=MockRandom)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene80), 
_version_=DocValuesFormat(name=Asserting), 
intDefault=DocValuesFormat(name=Asserting), 
id_i1=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Asserting), 
intDvoDefault=DocValuesFormat(name=Lucene80), 
range_facet_l=DocValuesFormat(name=Asserting), 
timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1301, 
maxMBSortInHeap=7.409521518119534, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@133d033),
 locale=lb, timezone=Africa/Timbuktu
   [junit4]   2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 11.0.4 
(64-bit)/cpus=4,threads=1,free=262146592,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestSimpleTextCodec, 
TestSolrQueryResponse, SearchRateTriggerTest, TestSimDistribStateManager, 
UtilsToolTest, ZkSolrClientTest, TestFieldCacheSortRandom, ConnectionReuseTest, 
TestLocalStatsCacheCloud, TestDocBasedVersionConstraints, TestXmlQParserPlugin, 
ExplicitHLLTest, TestFoldingMultitermQuery, TestCoreAdminApis, 
TestNumericRangeQuery64, TestHdfsUpdateLog, TestDownShardTolerantSearch, 
ScheduledTriggerIntegrationTest, DOMUtilTest, TestExactStatsCacheCloud, 
RAMDirectoryFactoryTest, TestDefaultStatsCache, TestDocSet, TestReload, 
TestDeleteCollectionOnDownNodes, HdfsRecoveryZkTest, TestQuerySenderNoQuery, 
AuditLoggerPluginTest, DeleteNodeTest, TestLegacyField, DateFieldTest, 
ReplaceNodeTest, IndexSizeEstimatorTest, TestMacroExpander, 
OverseerTaskQueueTest, FullSolrCloudDistribCmdsTest, 
TestClassicSimilarityFactory, TestZkAclsWithHadoopAuth, SolrCmdDistributorTest, 
MetricsHistoryHandlerTest, BadCopyFieldTest, TestUninvertingReader, 
SyncSliceTest, ByteBuffersDirectoryFactoryTest, TestDistributedGrouping, 
DocValuesNotIndexedTest, TestFileDictionaryLookup, 
TestPayloadCheckQParserPlugin, XMLAtomicUpdateMultivalueTest, 
TriggerCooldownIntegrationTest, TestStressLucene, TestBinaryField, 
HdfsWriteToMultipleCollectionsTest, UUIDUpdateProcessorFallbackTest, 
TestHdfsBackupRestoreCore, HdfsDirectoryFactoryTest, TestSortableTextField, 
PeerSyncWithBufferUpdatesTest, DocValuesMultiTest, TestCoreDiscovery, 
TestSolrDeletionPolicy2, DistanceFunctionTest, DistribJoinFromCollectionTest, 
TaggingAttributeTest, ConvertedLegacyTest, TestSimExtremeIndexing, 
TlogReplayBufferedWhileIndexingTest, TestConfigSetProperties, 
SegmentsInfoRequestHandlerTest, PreAnalyzedFieldTest, 
TestJsonFacetsWithNestedObjects, TestSolr4Spatial, 
TestComplexPhraseQParserPlugin, ResponseLogComponentTest, 
BigEndianAscendingWordDeserializerTest, TermsComponentTest, 
CdcrOpsAndBoundariesTest, TestLegacyTerms, TestSchemaNameResource, 
TestFieldResource, TestFaceting, AtomicUpdatesTest, SpellCheckComponentTest, 
TestLegacyFieldCache, TestStressUserVersions, TestLegacyBM25SimilarityFactory, 
SpatialHeatmapFacetsTest, TestApiFramework, TestHttpShardHandlerFactory, 
TestMaxScoreQueryParser, TestRandomRequestDistribution, TestSSLRandomization, 
TestCSVLoader, DistributedIntervalFacetingTest, SaslZkACLProviderTest, 
SplitHandlerTest, TestSQLHandler, TestConfigSetsAPIExclusivity, 
SpellCheckCollatorWithCollapseTest, TestMergePolicyConfig, 
TestObjectReleaseTracker, TestCloudPseudoReturnFields, 
TestExplainDocTransformer, ClusterStateTest, DefaultValueUpdateProcessorTest, 
AlternateDirectoryTest, TestSimNodeAddedTrigger, PeerSyncWithLeaderTest, 
TestRequestStatusCollectionAPI, CollectionsAPIDistributedZkTest, 
LeaderFailureAfterFreshStartTest, TestAnalyzeInfixSuggestions, SOLR749Test, 
HLLUtilTest, SolrIndexSplitterTest, OutOfBoxZkACLAndCredentialsProvidersTest, 
TestSchemaVersionResource, TestSearcherReuse, SolrRrdBackendFactoryTest, 
ZkCollectionPropsCachingTest, CloudMLTQParserTest, FacetPivotSmallTest, 
MoveReplicaHDFSTest, IgnoreLargeDocumentProcessorFactoryTest, 
BaseCdcrDistributedZkTest, TestHdfsCloudBackupRestore, 
TestJavabinTupleStreamParser, TestJoin, CurrencyRangeFacetCloudTest, 
SolrSlf4jReporterTest, TestDocumentBuilder, UpdateLogTest, HdfsThreadLeakTest, 
TestSolrConfigHandlerConcurrent, TestSchemaField, 
TestHighFrequencyDictionaryFactory, TestCloudSchemaless, RankQueryTest, 
TimeRoutedAliasUpdateProcessorTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, SolrRequestParserTest, 
RandomizedTaggerTest, AnalysisAfterCoreReloadTest, BasicFunctionalityTest, 
CursorPagingTest, DisMaxRequestHandlerTest, OutputWriterTest, SampleTest, 
SolrInfoBeanTest, SolrTestCaseJ4Test, TestCrossCoreJoin, 
TestCursorMarkWithoutUniqueKey, TestGroupingSearch, TestHighlightDedupGrouping, 
TestSimpleTrackingShardHandler, TestTolerantSearch, TestTrie, 
PathHierarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, 
TestLuceneMatchVersion, TokenizerChainTest, TestLuceneIndexBackCompat, 
TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, 
TestEmbeddedSolrServerSchemaAPI, TestJettySolrRunner, ActionThrottleTest, 
AddReplicaTest, AliasIntegrationTest, AssignBackwardCompatibilityTest, 
BasicDistributedZk2Test, BasicDistributedZkTest, BasicZkTest, 
ChaosMonkeyNothingIsSafeTest, CollectionStateFormat2Test, ConfigSetsAPITest, 
CreateRoutedAliasTest, DeleteInactiveReplicaTest, 
DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DeleteShardTest, 
DeleteStatusTest, DistribCursorPagingTest, 
DistribDocExpirationUpdateProcessorTest, ForceLeaderTest, 
ForceLeaderWithTlogReplicasTest]
   [junit4] Completed [459/890 (1!)] on J2 in 102.96s, 2 tests, 1 error, 1 
skipped <<< FAILURES!

[...truncated 54434 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to