Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23091/
Java: 64bit/jdk-9.0.4 -XX:+UseCompressedOops -XX:+UseG1GC

5 tests failed.
FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 7 in https://127.0.0.1:43971/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:43971/solr
        at 
__randomizedtesting.SeedInfo.seed([8B7C26646A3CD05F:4A8C5FC8476C1AF8]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:902)
        at 
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:567)
        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:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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:844)


FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 7 in https://127.0.0.1:37161/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:37161/solr
        at 
__randomizedtesting.SeedInfo.seed([8B7C26646A3CD05F:4A8C5FC8476C1AF8]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:902)
        at 
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:567)
        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:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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:844)


FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 7 in https://127.0.0.1:45019/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:45019/solr
        at 
__randomizedtesting.SeedInfo.seed([8B7C26646A3CD05F:4A8C5FC8476C1AF8]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:902)
        at 
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:567)
        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:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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:844)


FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 7 in https://127.0.0.1:34181/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:34181/solr
        at 
__randomizedtesting.SeedInfo.seed([8B7C26646A3CD05F:4A8C5FC8476C1AF8]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:902)
        at 
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:567)
        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:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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:844)


FAILED:  org.apache.solr.cloud.TestTlogReplica.testRecovery

Error Message:
Can not find doc 7 in https://127.0.0.1:44523/solr

Stack Trace:
java.lang.AssertionError: Can not find doc 7 in https://127.0.0.1:44523/solr
        at 
__randomizedtesting.SeedInfo.seed([8B7C26646A3CD05F:4A8C5FC8476C1AF8]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at 
org.apache.solr.cloud.TestTlogReplica.checkRTG(TestTlogReplica.java:902)
        at 
org.apache.solr.cloud.TestTlogReplica.testRecovery(TestTlogReplica.java:567)
        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:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1742)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:935)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:971)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:985)
        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:944)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:830)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:891)
        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:844)




Build Log:
[...truncated 12728 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestTlogReplica
   [junit4]   2> 28377 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/init-core-data-001
   [junit4]   2> 28377 WARN  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=14 numCloses=14
   [junit4]   2> 28377 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 28378 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 28379 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001
   [junit4]   2> 28379 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 28381 INFO  (Thread-40) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 28381 INFO  (Thread-40) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 28385 ERROR (Thread-40) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 28481 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:37823
   [junit4]   2> 28509 INFO  (zkConnectionManagerCallback-71-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28561 INFO  (jetty-launcher-68-thread-1) [    ] o.e.j.s.Server 
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 9.0.4+11
   [junit4]   2> 28561 INFO  (jetty-launcher-68-thread-2) [    ] o.e.j.s.Server 
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 9.0.4+11
   [junit4]   2> 28591 INFO  (jetty-launcher-68-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 28591 INFO  (jetty-launcher-68-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 28592 INFO  (jetty-launcher-68-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 28592 INFO  (jetty-launcher-68-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 28592 INFO  (jetty-launcher-68-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 28592 INFO  (jetty-launcher-68-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 28593 INFO  (jetty-launcher-68-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4e8a62e6{/solr,null,AVAILABLE}
   [junit4]   2> 28593 INFO  (jetty-launcher-68-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2c371e61{/solr,null,AVAILABLE}
   [junit4]   2> 28600 INFO  (jetty-launcher-68-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@fd0b6a{SSL,[ssl, 
http/1.1]}{127.0.0.1:44523}
   [junit4]   2> 28600 INFO  (jetty-launcher-68-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@7dbea58c{SSL,[ssl, 
http/1.1]}{127.0.0.1:38883}
   [junit4]   2> 28600 INFO  (jetty-launcher-68-thread-2) [    ] o.e.j.s.Server 
Started @28654ms
   [junit4]   2> 28600 INFO  (jetty-launcher-68-thread-1) [    ] o.e.j.s.Server 
Started @28654ms
   [junit4]   2> 28600 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=38883}
   [junit4]   2> 28600 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44523}
   [junit4]   2> 28601 ERROR (jetty-launcher-68-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 28601 ERROR (jetty-launcher-68-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-25T12:01:06.385613Z
   [junit4]   2> 28601 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-10-25T12:01:06.385632Z
   [junit4]   2> 28629 INFO  (zkConnectionManagerCallback-75-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28643 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 28644 INFO  (zkConnectionManagerCallback-74-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28649 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 28737 INFO  (jetty-launcher-68-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37823/solr
   [junit4]   2> 28760 INFO  (zkConnectionManagerCallback-79-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28773 INFO  (zkConnectionManagerCallback-81-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28876 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:44523_solr
   [junit4]   2> 28876 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.Overseer Overseer 
(id=72156843297275908-127.0.0.1:44523_solr-n_0000000000) starting
   [junit4]   2> 28926 INFO  (jetty-launcher-68-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37823/solr
   [junit4]   2> 28946 INFO  (zkConnectionManagerCallback-89-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28949 INFO  (zkConnectionManagerCallback-92-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28956 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1005a4444d90006, likely client has closed socket
   [junit4]   2> 28958 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:37823/solr ready
   [junit4]   2> 28958 INFO  
(OverseerStateUpdate-72156843297275908-127.0.0.1:44523_solr-n_0000000000) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:44523_solr
   [junit4]   2> 28965 INFO  (zkConnectionManagerCallback-94-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 28966 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44523_solr
   [junit4]   2> 28972 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 29007 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 29007 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38883_solr
   [junit4]   2> 29013 INFO  (zkCallback-80-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 29046 INFO  (zkCallback-88-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 29046 INFO  (zkCallback-93-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 29073 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 29085 INFO  (zkConnectionManagerCallback-102-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 29089 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 29090 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:37823/solr ready
   [junit4]   2> 29096 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 29102 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44523.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 29118 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38883.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 29118 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44523.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 29118 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_44523.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 29119 INFO  (jetty-launcher-68-thread-1) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001/node1/.
   [junit4]   2> 29128 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38883.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 29130 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_38883.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 29131 INFO  (jetty-launcher-68-thread-2) 
[n:127.0.0.1:38883_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001/node2/.
   [junit4]   2> 29189 INFO  (zkConnectionManagerCallback-105-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 29209 INFO  (zkConnectionManagerCallback-110-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 29210 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 29212 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:37823/solr ready
   [junit4]   2> 29215 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.TestTlogReplica Using legacyCloud?: false
   [junit4]   2> 29246 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params 
val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and 
sendToOCPQueue=true
   [junit4]   2> 29248 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={val=false&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2} 
status=0 QTime=2
   [junit4]   2> 29278 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testKillLeader
   [junit4]   2> 29282 INFO  (qtp681124768-280) [n:127.0.0.1:44523_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
pullReplicas=0&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_kill_leader&nrtReplicas=0&action=CREATE&numShards=1&tlogReplicas=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 29283 INFO  
(OverseerThreadFactory-166-thread-1-processing-n:127.0.0.1:44523_solr) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
tlog_replica_test_kill_leader
   [junit4]   2> 29402 INFO  (qtp681124768-289) [n:127.0.0.1:44523_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 29423 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/metrics 
params={prefix=CONTAINER.fs.usableSpace,CONTAINER.fs.totalSpace,CORE.coreName&wt=javabin&version=2&group=solr.node,solr.core}
 status=0 QTime=0
   [junit4]   2> 29429 INFO  
(OverseerStateUpdate-72156843297275908-127.0.0.1:44523_solr-n_0000000000) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_kill_leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"tlog_replica_test_kill_leader_shard1_replica_t1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:38883/solr";,
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 29433 INFO  
(OverseerStateUpdate-72156843297275908-127.0.0.1:44523_solr-n_0000000000) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"tlog_replica_test_kill_leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"tlog_replica_test_kill_leader_shard1_replica_t3",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:44523/solr";,
   [junit4]   2>   "type":"TLOG",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 29544 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr    
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.h.a.CoreAdminOperation 
core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_kill_leader_shard1_replica_t3&action=CREATE&numShards=1&collection=tlog_replica_test_kill_leader&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 29545 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr    
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 29556 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr    
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.h.a.CoreAdminOperation 
core create command 
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=tlog_replica_test_kill_leader_shard1_replica_t1&action=CREATE&numShards=1&collection=tlog_replica_test_kill_leader&shard=shard1&wt=javabin&version=2&replicaType=TLOG
   [junit4]   2> 30564 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 30569 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 30570 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.s.IndexSchema 
[tlog_replica_test_kill_leader_shard1_replica_t3] Schema name=minimal
   [junit4]   2> 30572 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 30573 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_kill_leader_shard1_replica_t3' using 
configuration from collection tlog_replica_test_kill_leader, trusted=true
   [junit4]   2> 30573 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_44523.solr.core.tlog_replica_test_kill_leader.shard1.replica_t3' 
(registry 'solr.core.tlog_replica_test_kill_leader.shard1.replica_t3') enabled 
at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 30574 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SolrCore 
[[tlog_replica_test_kill_leader_shard1_replica_t3] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001/node1/tlog_replica_test_kill_leader_shard1_replica_t3],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001/node1/./tlog_replica_test_kill_leader_shard1_replica_t3/data/]
   [junit4]   2> 30584 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.s.IndexSchema 
[tlog_replica_test_kill_leader_shard1_replica_t1] Schema name=minimal
   [junit4]   2> 30586 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.s.IndexSchema Loaded 
schema minimal/1.1 with uniqueid field id
   [junit4]   2> 30586 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.CoreContainer 
Creating SolrCore 'tlog_replica_test_kill_leader_shard1_replica_t1' using 
configuration from collection tlog_replica_test_kill_leader, trusted=true
   [junit4]   2> 30587 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_38883.solr.core.tlog_replica_test_kill_leader.shard1.replica_t1' 
(registry 'solr.core.tlog_replica_test_kill_leader.shard1.replica_t1') enabled 
at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30c05a9
   [junit4]   2> 30587 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.SolrCore 
[[tlog_replica_test_kill_leader_shard1_replica_t1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001/node2/tlog_replica_test_kill_leader_shard1_replica_t1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-001/tempDir-001/node2/./tlog_replica_test_kill_leader_shard1_replica_t1/data/]
   [junit4]   2> 30641 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 30641 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 30642 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 30642 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 30644 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@53f966a5[tlog_replica_test_kill_leader_shard1_replica_t3] 
main]
   [junit4]   2> 30645 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 30646 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 30647 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 30649 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1615298684186001408
   [junit4]   2> 30649 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 30649 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 30650 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 30650 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 30652 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@65d634ea[tlog_replica_test_kill_leader_shard1_replica_t1] 
main]
   [junit4]   2> 30652 INFO  
(searcherExecutor-175-thread-1-processing-n:127.0.0.1:44523_solr 
x:tlog_replica_test_kill_leader_shard1_replica_t3 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SolrCore 
[tlog_replica_test_kill_leader_shard1_replica_t3] Registered new searcher 
Searcher@53f966a5[tlog_replica_test_kill_leader_shard1_replica_t3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 30653 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 30653 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 30654 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 30654 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1615298684191244288
   [junit4]   2> 30657 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/tlog_replica_test_kill_leader/terms/shard1 to 
Terms{values={core_node4=0}, version=0}
   [junit4]   2> 30658 INFO  
(searcherExecutor-176-thread-1-processing-n:127.0.0.1:38883_solr 
x:tlog_replica_test_kill_leader_shard1_replica_t1 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.SolrCore 
[tlog_replica_test_kill_leader_shard1_replica_t1] Registered new searcher 
Searcher@65d634ea[tlog_replica_test_kill_leader_shard1_replica_t1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 30661 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/tlog_replica_test_kill_leader/terms/shard1 to 
Terms{values={core_node2=0, core_node4=0}, version=1}
   [junit4]   2> 30662 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 30662 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 30662 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SyncStrategy Sync 
replicas to 
https://127.0.0.1:44523/solr/tlog_replica_test_kill_leader_shard1_replica_t3/
   [junit4]   2> 30667 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.PeerSync PeerSync: 
core=tlog_replica_test_kill_leader_shard1_replica_t3 
url=https://127.0.0.1:44523/solr START 
replicas=[https://127.0.0.1:38883/solr/tlog_replica_test_kill_leader_shard1_replica_t1/]
 nUpdates=100
   [junit4]   2> 30667 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.PeerSync PeerSync: 
core=tlog_replica_test_kill_leader_shard1_replica_t3 
url=https://127.0.0.1:44523/solr DONE.  We have no versions.  sync failed.
   [junit4]   2> 30682 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=4
   [junit4]   2> 30690 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SyncStrategy 
Leader's attempt to sync with shard failed, moving to the next candidate
   [junit4]   2> 30690 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we 
can't sync in that case - we were active before, so become leader anyway
   [junit4]   2> 30690 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.ZkController 
tlog_replica_test_kill_leader_shard1_replica_t3 stopping background replication 
from leader
   [junit4]   2> 30695 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:44523/solr/tlog_replica_test_kill_leader_shard1_replica_t3/ 
shard1
   [junit4]   2> 30797 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 30804 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=tlog_replica_test_kill_leader_shard1_replica_t3&action=CREATE&numShards=1&collection=tlog_replica_test_kill_leader&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=1259
   [junit4]   2> 30901 INFO  (zkCallback-80-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_kill_leader/state.json] for collection 
[tlog_replica_test_kill_leader] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 31671 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.ZkController 
tlog_replica_test_kill_leader_shard1_replica_t1 starting background replication 
from leader
   [junit4]   2> 31671 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.ReplicateFromLeader 
Will start replication from leader with poll interval: 00:00:03
   [junit4]   2> 31680 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.h.ReplicationHandler 
Poll scheduled at an interval of 3000ms
   [junit4]   2> 31680 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 31784 INFO  (zkCallback-93-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_kill_leader/state.json] for collection 
[tlog_replica_test_kill_leader] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 31784 INFO  (zkCallback-80-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_kill_leader/state.json] for collection 
[tlog_replica_test_kill_leader] has occurred - updating... (live nodes size: 
[2])
   [junit4]   2> 31859 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.s.HttpSolrCall [admin] 
webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=tlog_replica_test_kill_leader_shard1_replica_t1&action=CREATE&numShards=1&collection=tlog_replica_test_kill_leader&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
 status=0 QTime=2304
   [junit4]   2> 31865 INFO  (qtp681124768-280) [n:127.0.0.1:44523_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 31865 INFO  (qtp681124768-280) [n:127.0.0.1:44523_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={pullReplicas=0&collection.configName=conf&maxShardsPerNode=100&name=tlog_replica_test_kill_leader&nrtReplicas=0&action=CREATE&numShards=1&tlogReplicas=2&wt=javabin&version=2}
 status=0 QTime=2583
   [junit4]   2> 31904 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Updated masterUrl to 
https://127.0.0.1:44523/solr/tlog_replica_test_kill_leader_shard1_replica_t3/
   [junit4]   2> 31905 INFO  (qtp681124768-287) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/tlog_replica_test_kill_leader/terms/shard1 to 
Terms{values={core_node2=1, core_node4=1}, version=2}
   [junit4]   2> 31918 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=7
   [junit4]   2> 31919 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 31920 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 31920 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 31920 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 31920 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher New index in Master. Deleting mine...
   [junit4]   2> 31924 INFO  (qtp205285192-286) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&distrib.from=https://127.0.0.1:44523/solr/tlog_replica_test_kill_leader_shard1_replica_t3/&wt=javabin&version=2}{add=[1
 (1615298685491478528)]} 0 5
   [junit4]   2> 31926 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4653e574[tlog_replica_test_kill_leader_shard1_replica_t1] main]
   [junit4]   2> 31927 INFO  (searcherExecutor-176-thread-1) [    ] 
o.a.s.c.SolrCore [tlog_replica_test_kill_leader_shard1_replica_t1] Registered 
new searcher Searcher@4653e574[tlog_replica_test_kill_leader_shard1_replica_t1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 31928 INFO  (qtp681124768-287) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.u.p.LogUpdateProcessorFactory 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1 (1615298685491478528)]} 0 42
   [junit4]   2> 31939 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] 
o.a.s.u.p.LogUpdateProcessorFactory 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:44523/solr/tlog_replica_test_kill_leader_shard1_replica_t3/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 1
   [junit4]   2> 31944 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.DirectUpdateHandler2 
start 
commit{_version_=1615298685543907328,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 31944 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.SolrIndexWriter 
Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@239713bf 
commitCommandVersion:1615298685543907328
   [junit4]   2> 32199 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@23ecd619[tlog_replica_test_kill_leader_shard1_replica_t3] 
main]
   [junit4]   2> 32200 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.u.DirectUpdateHandler2 
end_commit_flush
   [junit4]   2> 32201 INFO  
(searcherExecutor-175-thread-1-processing-n:127.0.0.1:44523_solr 
x:tlog_replica_test_kill_leader_shard1_replica_t3 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SolrCore 
[tlog_replica_test_kill_leader_shard1_replica_t3] Registered new searcher 
Searcher@23ecd619[tlog_replica_test_kill_leader_shard1_replica_t3] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 32202 INFO  (qtp681124768-278) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.u.p.LogUpdateProcessorFactory 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:44523/solr/tlog_replica_test_kill_leader_shard1_replica_t3/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 258
   [junit4]   2> 32204 INFO  (qtp681124768-280) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] 
o.a.s.u.p.LogUpdateProcessorFactory 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr path=/update 
params={_stateVer_=tlog_replica_test_kill_leader:5&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 271
   [junit4]   2> 32217 INFO  (qtp681124768-280) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=3
   [junit4]   2> 32237 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32339 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32442 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32545 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32647 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32749 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32852 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 32955 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33057 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33160 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33263 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33287 INFO  
(OverseerCollectionConfigSetProcessor-72156843297275908-127.0.0.1:44523_solr-n_0000000000)
 [n:127.0.0.1:44523_solr    ] 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> 33365 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33468 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33572 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33676 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33779 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33885 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 33987 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34089 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34192 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34294 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34397 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34500 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34603 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34706 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34809 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34905 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 34906 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 34906 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Master's version: 1540468869728
   [junit4]   2> 34906 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 34906 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Slave's version: 0
   [junit4]   2> 34906 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 34912 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 34914 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist}
 status=0 QTime=7
   [junit4]   2> 34915 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 34917 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@1eb463c0 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@175dfd95)
   [junit4]   2> 34924 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=3
   [junit4]   2> 34937 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34946 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Direct_0.dvdd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34952 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.pos&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34955 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34958 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34961 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34964 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.dvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34968 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.tix&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34973 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.pos&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=1
   [junit4]   2> 34986 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34989 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34993 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.dvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 34997 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Asserting_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 35002 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_FSTOrd50_0.tbk&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 35006 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 35010 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0_Direct_0.dvdm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 35015 INFO  (qtp205285192-288) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 35020 INFO  (qtp681124768-353) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 35030 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr 
path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 35037 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Bytes downloaded: 2903, Bytes skipped downloading: 0
   [junit4]   2> 35037 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=2903) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@1eb463c0 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@175dfd95)
   [junit4]   2> 35041 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 35042 INFO  (indexFetcher-186-thread-1) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@370f4fea[tlog_replica_test_kill_leader_shard1_replica_t1] main]
   [junit4]   2> 35044 INFO  (searcherExecutor-176-thread-1) [    ] 
o.a.s.c.SolrCore [tlog_replica_test_kill_leader_shard1_replica_t1] Registered 
new searcher Searcher@370f4fea[tlog_replica_test_kill_leader_shard1_replica_t1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
   [junit4]   2> 35118 INFO  (qtp205285192-277) [n:127.0.0.1:38883_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node2 
x:tlog_replica_test_kill_leader_shard1_replica_t1] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t1]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 35129 INFO  (qtp681124768-281) [n:127.0.0.1:44523_solr 
c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.S.Request 
[tlog_replica_test_kill_leader_shard1_replica_t3]  webapp=/solr path=/select 
params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 35139 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.c.ChaosMonkey monkey: kill jetty! 44523
   [junit4]   2> 35173 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@fd0b6a{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 35174 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=748862728
   [junit4]   2> 35174 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 35175 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@24e46ba1: rootName = 
solr_44523, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@6d98b3f9
   [junit4]   2> 35183 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 35184 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1d6cf683: rootName = 
solr_44523, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@5cd73f29
   [junit4]   2> 35189 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 35189 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1ad23fec: rootName = 
solr_44523, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@5a6bddfe
   [junit4]   2> 35193 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44523_solr
   [junit4]   2> 35195 INFO  (zkCallback-93-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 35195 INFO  (zkCallback-101-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 35195 INFO  (zkCallback-88-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 35195 INFO  (zkCallback-109-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 35195 INFO  (zkCallback-80-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 35196 INFO  (zkCallback-80-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_kill_leader/state.json] for collection 
[tlog_replica_test_kill_leader] has occurred - updating... (live nodes size: 
[1])
   [junit4]   2> 35197 INFO  (zkCallback-93-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/tlog_replica_test_kill_leader/state.json] for collection 
[tlog_replica_test_kill_leader] has occurred - updating... (live nodes size: 
[1])
   [junit4]   2> 35199 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 35200 INFO  (coreCloseExecutor-188-thread-1) 
[n:127.0.0.1:44523_solr c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.c.SolrCore 
[tlog_replica_test_kill_leader_shard1_replica_t3]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@78c709be
   [junit4]   2> 35200 INFO  (coreCloseExecutor-188-thread-1) 
[n:127.0.0.1:44523_solr c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.core.tlog_replica_test_kill_leader.shard1.replica_t3, tag=78c709be
   [junit4]   2> 35200 INFO  (coreCloseExecutor-188-thread-1) 
[n:127.0.0.1:44523_solr c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.m.r.SolrJmxReporter 
Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5cb756ab: 
rootName = solr_44523, domain = 
solr.core.tlog_replica_test_kill_leader.shard1.replica_t3, service url = null, 
agent id = null] for registry 
solr.core.tlog_replica_test_kill_leader.shard1.replica_t3 / 
com.codahale.metrics.MetricRegistry@702abfd5
   [junit4]   2> 35209 INFO  (coreCloseExecutor-188-thread-1) 
[n:127.0.0.1:44523_solr c:tlog_replica_test_kill_leader s:shard1 r:core_node4 
x:tlog_replica_test_kill_leader_shard1_replica_t3] o.a.s.m.SolrMetricManager 
Closing metric reporters for 
registry=solr.collection.tlog_replica_test_kill_leader.shard1.leader, 
tag=78c709be
   [junit4]   2> 35237 INFO  
(TEST-TestTlogReplica.testKillLeader-seed#[8B7C26646A3CD05F]) [    ] 
o.a.s.c.Overseer Overseer 
(id=72156843297275908-127.0.0.1:44523_solr-n_0000000000) closing
   [junit4]   2> 35237 INFO  
(OverseerStateUpdate-72156843297275908-127.0.0.1:44523_solr-n_0000000000) 
[n:127.0.0.1:44523_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:44523_solr
   [junit4]   2> 35238 WARN  
(OverseerAutoScalingTriggerThread-72156843297275908-127.0.0.1:44523_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 35241 INFO  (zkCallback-93-thread-2) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38883_solr
   [junit4]   2> 35242 INFO

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

4-thread-2) [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@18899145{/solr,null,UNAVAILABLE}
   [junit4]   2> 200196 INFO  (jetty-closer-134-thread-2) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 200197 INFO  (jetty-closer-134-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 200197 INFO  (jetty-closer-134-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5a10132e: rootName = 
solr_43401, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@119b1ae7
   [junit4]   2> 200197 INFO  (jetty-closer-134-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43401_solr
   [junit4]   2> 200198 INFO  (jetty-closer-134-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 200198 INFO  (zkCallback-218-thread-3) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 200198 INFO  (zkCallback-225-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 200199 INFO  (jetty-closer-134-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72157050582925333-127.0.0.1:43401_solr-n_0000000004) closing
   [junit4]   2> 200199 INFO  
(OverseerStateUpdate-72157050582925333-127.0.0.1:43401_solr-n_0000000004) 
[n:127.0.0.1:43401_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:43401_solr
   [junit4]   2> 200199 WARN  
(OverseerAutoScalingTriggerThread-72157050582925333-127.0.0.1:43401_solr-n_0000000004)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 200201 INFO  (jetty-closer-134-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4ed4f555{/solr,null,UNAVAILABLE}
   [junit4]   2> 200201 INFO  (jetty-closer-134-thread-1) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 200201 ERROR 
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 200201 INFO  
(SUITE-TestTlogReplica-seed#[8B7C26646A3CD05F]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:45343 45343
   [junit4]   2> 200311 INFO  (Thread-99) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:45343 45343
   [junit4]   2> 200312 WARN  (Thread-99) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        33      
/solr/collections/tlog_replica_test_create_delete/terms/shard1
   [junit4]   2>        30      /solr/configs/conf
   [junit4]   2>        28      
/solr/collections/tlog_replica_test_create_delete/terms/shard2
   [junit4]   2>        20      
/solr/collections/tlog_replica_test_remove_leader/terms/shard1
   [junit4]   2>        18      
/solr/collections/tlog_replica_test_recovery/terms/shard1
   [junit4]   2>        17      
/solr/collections/tlog_replica_test_basic_leader_election/terms/shard1
   [junit4]   2>        16      
/solr/collections/tlog_replica_test_kill_leader/terms/shard1
   [junit4]   2>        16      
/solr/collections/tlog_replica_test_kill_tlog_replica/terms/shard1
   [junit4]   2>        15      /solr/aliases.json
   [junit4]   2>        11      
/solr/collections/tlog_replica_test_only_leader_indexes/terms/shard1
   [junit4]   2>        10      
/solr/collections/tlog_replica_test_delete_by_id/terms/shard1
   [junit4]   2>        9       
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/terms/shard1
   [junit4]   2>        7       /solr/security.json
   [junit4]   2>        6       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard2
   [junit4]   2>        5       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/terms/shard1
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_add_docs/terms/shard1
   [junit4]   2>        4       
/solr/collections/tlog_replica_test_real_time_get/terms/shard1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        20      
/solr/collections/tlog_replica_test_create_delete/state.json
   [junit4]   2>        15      
/solr/collections/tlog_replica_test_out_of_order_db_qwith_in_place_updates/state.json
   [junit4]   2>        15      /solr/clusterprops.json
   [junit4]   2>        15      /solr/clusterstate.json
   [junit4]   2>        14      
/solr/collections/tlog_replica_test_kill_leader/state.json
   [junit4]   2>        10      
/solr/collections/tlog_replica_test_kill_tlog_replica/state.json
   [junit4]   2>        9       
/solr/collections/tlog_replica_test_remove_leader/state.json
   [junit4]   2>        8       
/solr/collections/tlog_replica_test_recovery/state.json
   [junit4]   2>        8       
/solr/collections/tlog_replica_test_basic_leader_election/state.json
   [junit4]   2>        3       
/solr/overseer_elect/election/72157050582925316-127.0.0.1:43401_solr-n_0000000000
   [junit4]   2>        3       /solr/autoscaling.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/72157050582925316-core_node16-n_0000000001
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_add_remove_tlog_replica/state.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_only_leader_indexes/state.json
   [junit4]   2>        3       
/solr/collections/tlog_replica_test_delete_by_id/state.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard2/election/72157050582925325-core_node15-n_0000000000
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/72157050582925316-core_node9-n_0000000001
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_add_docs/state.json
   [junit4]   2>        2       
/solr/overseer_elect/election/72157050582925333-127.0.0.1:43401_solr-n_0000000004
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_create_delete/leader_elect/shard1/election/72157050582925325-core_node7-n_0000000001
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_kill_tlog_replica/leader_elect/shard1/election/72157050582925329-core_node4-n_0000000000
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_real_time_get/state.json
   [junit4]   2>        2       
/solr/collections/tlog_replica_test_recovery/leader_elect/shard1/election/72157050582925316-core_node3-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/live_nodes
   [junit4]   2>        15      /solr/collections
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        3       /solr/autoscaling/events/.scheduled_maintenance
   [junit4]   2>        3       /solr/autoscaling/events/.auto_add_replicas
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2>        3       /solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.TestTlogReplica_8B7C26646A3CD05F-002
   [junit4]   2> Oct 25, 2018 12:55:22 PM 
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(Lucene80): 
{foo=FSTOrd50, title_s=FSTOrd50, id=PostingsFormat(name=Asserting), 
foo_s=FSTOrd50}, docValues:{_version_=DocValuesFormat(name=Asserting), 
id=DocValuesFormat(name=Direct), 
inplace_updatable_int=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=735, 
maxMBSortInHeap=5.889689477991673, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@78610439),
 locale=nn, timezone=Pacific/Apia
   [junit4]   2> NOTE: Linux 4.15.0-36-generic amd64/Oracle Corporation 9.0.4 
(64-bit)/cpus=8,threads=1,free=209855640,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestTlogReplica, 
TestTlogReplica]
   [junit4] Completed [5/5 (5!)] on J2 in 93.73s, 13 tests, 1 failure <<< 
FAILURES!

[...truncated 15 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1567: 
The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1092: 
There were test failures: 5 suites, 65 tests, 5 failures [seed: 
8B7C26646A3CD05F]

Total time: 3 minutes 23 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   5/5 failed: org.apache.solr.cloud.TestTlogReplica
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all 
warnings.
<Git Blamer> GIT_COMMIT=26e14986af7aa60b72940f611f63b2a50fbb9980, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-master-Linux
[WARNINGS] Computing warning deltas based on reference build #23090
Recording test results
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting 
ANT_1_8_2_HOME=/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to