Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/2664/
Java: 64bit/jdk-11-ea+28 -XX:-UseCompressedOops -XX:+UseParallelGC

7 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.DocValuesNotIndexedTest

Error Message:
Collection not found: dv_coll

Stack Trace:
org.apache.solr.common.SolrException: Collection not found: dv_coll
        at __randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]:0)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:853)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.createCluster(DocValuesNotIndexedTest.java:155)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.DocValuesNotIndexedTest

Error Message:
Collection not found: dv_coll

Stack Trace:
org.apache.solr.common.SolrException: Collection not found: dv_coll
        at __randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]:0)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:853)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.createCluster(DocValuesNotIndexedTest.java:155)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.TestCloudRecovery

Error Message:
Could not find collection:collection1

Stack Trace:
java.lang.AssertionError: Could not find collection:collection1
        at __randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]: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.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
        at 
org.apache.solr.cloud.TestCloudRecovery.setupCluster(TestCloudRecovery.java:70)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.TestCloudRecovery

Error Message:
Could not find collection:collection1

Stack Trace:
java.lang.AssertionError: Could not find collection:collection1
        at __randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]: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.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
        at 
org.apache.solr.cloud.TestCloudRecovery.setupCluster(TestCloudRecovery.java:70)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.TestCloudRecovery

Error Message:
Could not find collection:collection1

Stack Trace:
java.lang.AssertionError: Could not find collection:collection1
        at __randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]: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.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
        at 
org.apache.solr.cloud.TestCloudRecovery.setupCluster(TestCloudRecovery.java:70)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.TestCloudRecovery

Error Message:
Could not find collection:collection1

Stack Trace:
java.lang.AssertionError: Could not find collection:collection1
        at __randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]: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.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:155)
        at 
org.apache.solr.cloud.TestCloudRecovery.setupCluster(TestCloudRecovery.java:70)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)


FAILED:  org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingSorting

Error Message:
Error from server at https://127.0.0.1:45637/solr/dv_coll: Async exception 
during distributed update: Socket input is already shutdown

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at https://127.0.0.1:45637/solr/dv_coll: Async exception during 
distributed update: Socket input is already shutdown
        at 
__randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1:364E0386773D6621]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1109)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:886)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
        at 
org.apache.solr.client.solrj.SolrClient.deleteByQuery(SolrClient.java:895)
        at 
org.apache.solr.client.solrj.SolrClient.deleteByQuery(SolrClient.java:858)
        at 
org.apache.solr.client.solrj.SolrClient.deleteByQuery(SolrClient.java:873)
        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.before(DocValuesNotIndexedTest.java:165)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:566)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:968)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        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:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:834)




Build Log:
[...truncated 13920 lines...]
   [junit4] Suite: org.apache.solr.cloud.DocValuesNotIndexedTest
   [junit4]   2> 1190482 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-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-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/init-core-data-001
   [junit4]   2> 1190483 WARN  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
   [junit4]   2> 1190483 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1190484 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-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> 1190484 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001
   [junit4]   2> 1190484 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1190484 INFO  (Thread-4129) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1190484 INFO  (Thread-4129) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1190486 ERROR (Thread-4129) [    ] 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> 1190584 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:42561
   [junit4]   2> 1190586 INFO  (zkConnectionManagerCallback-3153-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190589 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 11+28
   [junit4]   2> 1190589 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: 
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 11+28
   [junit4]   2> 1190589 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1190589 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1190589 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 1190589 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@60f28080{/solr,null,AVAILABLE}
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@4cc6f1bc{/solr,null,AVAILABLE}
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@245977fb{SSL,[ssl, 
http/1.1]}{127.0.0.1:41869}
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.e.j.s.Server Started @1190625ms
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=41869}
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@40f0bc1a{SSL,[ssl, 
http/1.1]}{127.0.0.1:43383}
   [junit4]   2> 1190590 ERROR (jetty-launcher-3150-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.e.j.s.Server Started @1190625ms
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.5.0
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=43383}
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-08-31T20:59:43.899695Z
   [junit4]   2> 1190590 ERROR (jetty-launcher-3150-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.5.0
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1190590 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-08-31T20:59:43.899933Z
   [junit4]   2> 1190591 INFO  (zkConnectionManagerCallback-3155-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190591 INFO  (zkConnectionManagerCallback-3157-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190591 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1190591 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1190680 INFO  (jetty-launcher-3150-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42561/solr
   [junit4]   2> 1190680 INFO  (zkConnectionManagerCallback-3161-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190681 INFO  (zkConnectionManagerCallback-3163-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190715 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:41869_solr
   [junit4]   2> 1190716 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.Overseer Overseer 
(id=72145730876145668-127.0.0.1:41869_solr-n_0000000000) starting
   [junit4]   2> 1190719 INFO  (zkConnectionManagerCallback-3170-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190720 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:42561/solr ready
   [junit4]   2> 1190720 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.Overseer Starting to work on the main 
queue : 127.0.0.1:41869_solr
   [junit4]   2> 1190720 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41869_solr
   [junit4]   2> 1190722 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1190724 INFO  (zkCallback-3169-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1190734 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1190749 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41869.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1190756 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41869.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1190756 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41869.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1190757 INFO  (jetty-launcher-3150-thread-1) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node1/.
   [junit4]   2> 1190828 INFO  (jetty-launcher-3150-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42561/solr
   [junit4]   2> 1190829 INFO  (zkConnectionManagerCallback-3175-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190831 INFO  (zkConnectionManagerCallback-3177-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190834 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1190835 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1190835 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43383_solr
   [junit4]   2> 1190836 INFO  (zkCallback-3169-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1190836 INFO  (zkCallback-3162-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1190836 INFO  (zkCallback-3176-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1190844 INFO  (zkConnectionManagerCallback-3184-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190845 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 1190845 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:42561/solr ready
   [junit4]   2> 1190845 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.h.a.MetricsHistoryHandler No .system 
collection, keeping metrics history in memory.
   [junit4]   2> 1190858 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43383.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1190866 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43383.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1190866 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43383.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1190867 INFO  (jetty-launcher-3150-thread-2) 
[n:127.0.0.1:43383_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node2/.
   [junit4]   2> 1190886 INFO  (zkConnectionManagerCallback-3187-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190888 INFO  (zkConnectionManagerCallback-3192-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 1190889 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1190889 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42561/solr ready
   [junit4]   2> 1190900 INFO  (qtp850861564-14188) [n:127.0.0.1:41869_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
collection.configName=conf1&maxShardsPerNode=2&name=dv_coll&nrtReplicas=1&action=CREATE&numShards=4&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1190901 INFO  
(OverseerThreadFactory-5102-thread-1-processing-n:127.0.0.1:41869_solr) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.a.c.CreateCollectionCmd Create collection 
dv_coll
   [junit4]   2> 1191005 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"dv_coll_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:41869/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1191007 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"dv_coll_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:43383/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1191008 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard3",
   [junit4]   2>   "core":"dv_coll_shard3_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:41869/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1191008 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"dv_coll",
   [junit4]   2>   "shard":"shard4",
   [junit4]   2>   "core":"dv_coll_shard4_replica_n5",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:43383/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 1191222 WARN  (qtp850861564-14266) [    ] 
o.e.j.u.t.QueuedThreadPool 
   [junit4]   2> java.util.NoSuchElementException: No value present
   [junit4]   2>        at java.util.Optional.get(Optional.java:148) ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.ServerHello$T13ServerHelloProducer.produce(ServerHello.java:551)
 ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.SSLHandshake.produce(SSLHandshake.java:436) ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.ClientHello$T13ClientHelloConsumer.goServerHello(ClientHello.java:1189)
 ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.ClientHello$T13ClientHelloConsumer.consume(ClientHello.java:1125)
 ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.ClientHello$ClientHelloConsumer.onClientHello(ClientHello.java:831)
 ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.ClientHello$ClientHelloConsumer.consume(ClientHello.java:792) 
~[?:?]
   [junit4]   2>        at 
sun.security.ssl.SSLHandshake.consume(SSLHandshake.java:392) ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.HandshakeContext.dispatch(HandshakeContext.java:444) ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.SSLEngineImpl$DelegatedTask$DelegatedAction.run(SSLEngineImpl.java:1065)
 ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.SSLEngineImpl$DelegatedTask$DelegatedAction.run(SSLEngineImpl.java:1052)
 ~[?:?]
   [junit4]   2>        at java.security.AccessController.doPrivileged(Native 
Method) ~[?:?]
   [junit4]   2>        at 
sun.security.ssl.SSLEngineImpl$DelegatedTask.run(SSLEngineImpl.java:999) ~[?:?]
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.fill(SslConnection.java:775)
 ~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.fillRequestBuffer(HttpConnection.java:331)
 ~[jetty-server-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:243) 
~[jetty-server-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:281)
 ~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) 
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:291) 
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.io.ssl.SslConnection$3.succeeded(SslConnection.java:151) 
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) 
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:118) 
~[jetty-io-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:762)
 ~[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:680) 
[jetty-util-9.4.11.v20180605.jar:9.4.11.v20180605]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:834) [?:?]
   [junit4]   2> 1191223 WARN  (qtp850861564-14266) [    ] 
o.e.j.u.t.QueuedThreadPool Unexpected thread death: 
org.eclipse.jetty.util.thread.QueuedThreadPool$2@a2368d5 in 
QueuedThreadPool[qtp850861564]@32b71dfc{STARTED,8<=10<=10000,i=1,q=1}[ReservedThreadExecutor@4f21f7f5{s=1/8,p=1}]
   [junit4]   2> 1191225 ERROR 
(OverseerThreadFactory-5102-thread-1-processing-n:127.0.0.1:41869_solr) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler Error 
from shard: https://127.0.0.1:41869/solr
   [junit4]   2> org.apache.solr.client.solrj.SolrServerException: IOException 
occured when talking to server at: https://127.0.0.1:41869/solr
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) ~[java/:?]
   [junit4]   2>        at 
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:172)
 ~[java/:?]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) ~[?:?]
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
   [junit4]   2>        at 
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
 ~[metrics-core-3.2.6.jar:3.2.6]
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:209)
 [java/:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) 
[?:?]
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) 
[?:?]
   [junit4]   2>        at java.lang.Thread.run(Thread.java:834) [?:?]
   [junit4]   2> Caused by: java.net.SocketException: Socket input is already 
shutdown
   [junit4]   2>        at 
sun.security.ssl.SSLSocketImpl.getInputStream(SSLSocketImpl.java:696) ~[?:?]
   [junit4]   2>        at 
org.apache.http.impl.BHttpConnectionBase.getSocketInputStream(BHttpConnectionBase.java:142)
 ~[httpcore-4.4.6.jar:4.4.6]
   [junit4]   2>        at 
org.apache.http.impl.conn.LoggingManagedHttpClientConnection.getSocketInputStream(LoggingManagedHttpClientConnection.java:103)
 ~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.BHttpConnectionBase.ensureOpen(BHttpConnectionBase.java:134)
 ~[httpcore-4.4.6.jar:4.4.6]
   [junit4]   2>        at 
org.apache.http.impl.DefaultBHttpClientConnection.sendRequestHeader(DefaultBHttpClientConnection.java:140)
 ~[httpcore-4.4.6.jar:4.4.6]
   [junit4]   2>        at 
org.apache.http.impl.conn.CPoolProxy.sendRequestHeader(CPoolProxy.java:155) 
~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.protocol.HttpRequestExecutor.doSendRequest(HttpRequestExecutor.java:205)
 ~[httpcore-4.4.6.jar:4.4.6]
   [junit4]   2>        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123)
 ~[httpcore-4.4.6.jar:4.4.6]
   [junit4]   2>        at 
org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.execute(InstrumentedHttpRequestExecutor.java:120)
 ~[java/:?]
   [junit4]   2>        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272) 
~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185) 
~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) 
~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111) 
~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
 ~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
 ~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
 ~[httpclient-4.5.3.jar:4.5.3]
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
 ~[java/:?]
   [junit4]   2>        ... 12 more
   [junit4]   2> 1191230 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1191230 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 1191230 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1191236 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n5&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1192236 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1192236 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1192241 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.s.IndexSchema [dv_coll_shard2_replica_n2] Schema name=minimal
   [junit4]   2> 1192241 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.s.IndexSchema [dv_coll_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 1192243 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1192243 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1192243 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard1_replica_n1' using 
configuration from collection dv_coll, trusted=true
   [junit4]   2> 1192243 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard2_replica_n2' using 
configuration from collection dv_coll, trusted=true
   [junit4]   2> 1192243 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.5.0
   [junit4]   2> 1192243 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43383.solr.core.dv_coll.shard2.replica_n2' (registry 
'solr.core.dv_coll.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1192243 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_41869.solr.core.dv_coll.shard1.replica_n1' (registry 
'solr.core.dv_coll.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1192243 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1192243 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1192243 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] o.a.s.c.SolrCore 
[[dv_coll_shard2_replica_n2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node2/dv_coll_shard2_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node2/./dv_coll_shard2_replica_n2/data/]
   [junit4]   2> 1192243 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] o.a.s.c.SolrCore 
[[dv_coll_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node1/dv_coll_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node1/./dv_coll_shard1_replica_n1/data/]
   [junit4]   2> 1192247 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.s.IndexSchema [dv_coll_shard4_replica_n5] Schema name=minimal
   [junit4]   2> 1192254 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1192254 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.CoreContainer Creating SolrCore 'dv_coll_shard4_replica_n5' using 
configuration from collection dv_coll, trusted=true
   [junit4]   2> 1192255 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_43383.solr.core.dv_coll.shard4.replica_n5' (registry 
'solr.core.dv_coll.shard4.replica_n5') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@2b94bd94
   [junit4]   2> 1192255 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1192255 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] o.a.s.c.SolrCore 
[[dv_coll_shard4_replica_n5] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node2/dv_coll_shard4_replica_n5],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.DocValuesNotIndexedTest_28760B8E0B96DCA1-001/tempDir-001/node2/./dv_coll_shard4_replica_n5/data/]
   [junit4]   2> 1192288 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1192288 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1192289 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1192289 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1192290 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@22f5a220[dv_coll_shard2_replica_n2] 
main]
   [junit4]   2> 1192290 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1192291 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1192291 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1192291 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1192291 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1192291 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1610349738039705600
   [junit4]   2> 1192292 INFO  
(searcherExecutor-5114-thread-1-processing-n:127.0.0.1:43383_solr 
x:dv_coll_shard2_replica_n2 c:dv_coll s:shard2 r:core_node6) 
[n:127.0.0.1:43383_solr c:dv_coll s:shard2 r:core_node6 
x:dv_coll_shard2_replica_n2] o.a.s.c.SolrCore [dv_coll_shard2_replica_n2] 
Registered new searcher Searcher@22f5a220[dv_coll_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1192295 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard2 to Terms{values={core_node6=0}, version=0}
   [junit4]   2> 1192295 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1192295 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1192296 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1192296 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1192296 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:43383/solr/dv_coll_shard2_replica_n2/
   [junit4]   2> 1192296 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1192296 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.SyncStrategy https://127.0.0.1:43383/solr/dv_coll_shard2_replica_n2/ 
has no replicas
   [junit4]   2> 1192296 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1192297 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1192297 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1192297 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:43383/solr/dv_coll_shard2_replica_n2/ shard2
   [junit4]   2> 1192298 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@2073c466[dv_coll_shard1_replica_n1] 
main]
   [junit4]   2> 1192299 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1192299 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1192299 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1192299 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1192300 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1192300 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1610349738049142784
   [junit4]   2> 1192300 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 1192300 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1192300 INFO  
(searcherExecutor-5115-thread-1-processing-n:127.0.0.1:41869_solr 
x:dv_coll_shard1_replica_n1 c:dv_coll s:shard1 r:core_node3) 
[n:127.0.0.1:41869_solr c:dv_coll s:shard1 r:core_node3 
x:dv_coll_shard1_replica_n1] o.a.s.c.SolrCore [dv_coll_shard1_replica_n1] 
Registered new searcher Searcher@2073c466[dv_coll_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1192302 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1192302 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1192303 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4cdbf45c[dv_coll_shard4_replica_n5] 
main]
   [junit4]   2> 1192303 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 1192304 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1192304 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1192304 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1192304 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1192305 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1192305 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1192305 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:41869/solr/dv_coll_shard1_replica_n1/
   [junit4]   2> 1192305 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1192305 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 1192305 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.SyncStrategy https://127.0.0.1:41869/solr/dv_coll_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 1192305 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1192305 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1610349738054385664
   [junit4]   2> 1192305 INFO  
(searcherExecutor-5116-thread-1-processing-n:127.0.0.1:43383_solr 
x:dv_coll_shard4_replica_n5 c:dv_coll s:shard4 r:core_node8) 
[n:127.0.0.1:43383_solr c:dv_coll s:shard4 r:core_node8 
x:dv_coll_shard4_replica_n5] o.a.s.c.SolrCore [dv_coll_shard4_replica_n5] 
Registered new searcher Searcher@4cdbf45c[dv_coll_shard4_replica_n5] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1192307 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:41869/solr/dv_coll_shard1_replica_n1/ shard1
   [junit4]   2> 1192307 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard4 to Terms{values={core_node8=0}, version=0}
   [junit4]   2> 1192309 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1192309 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1192309 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:43383/solr/dv_coll_shard4_replica_n5/
   [junit4]   2> 1192309 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 1192309 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.SyncStrategy https://127.0.0.1:43383/solr/dv_coll_shard4_replica_n5/ 
has no replicas
   [junit4]   2> 1192309 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1192310 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:43383/solr/dv_coll_shard4_replica_n5/ shard4
   [junit4]   2> 1192412 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1192449 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1192458 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 1192518 INFO  (qtp2005651214-14198) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard2 r:core_node6 x:dv_coll_shard2_replica_n2] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node6&collection.configName=conf1&newCollection=true&name=dv_coll_shard2_replica_n2&action=CREATE&numShards=4&collection=dv_coll&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1287
   [junit4]   2> 1192518 INFO  (qtp850861564-14190) [n:127.0.0.1:41869_solr 
c:dv_coll s:shard1 r:core_node3 x:dv_coll_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=dv_coll_shard1_replica_n1&action=CREATE&numShards=4&collection=dv_coll&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1288
   [junit4]   2> 1192518 INFO  (qtp2005651214-14268) [n:127.0.0.1:43383_solr 
c:dv_coll s:shard4 r:core_node8 x:dv_coll_shard4_replica_n5] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=dv_coll_shard4_replica_n5&action=CREATE&numShards=4&collection=dv_coll&shard=shard4&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1281
   [junit4]   2> 1192518 ERROR 
(OverseerThreadFactory-5102-thread-1-processing-n:127.0.0.1:41869_solr) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Cleaning up collection [dv_coll].
   [junit4]   2> 1192518 INFO  
(OverseerThreadFactory-5102-thread-1-processing-n:127.0.0.1:41869_solr) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.a.c.OverseerCollectionMessageHandler 
Executing Collection 
Cmd=action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true&deleteMetricsHistory=true,
 asyncId=null
   [junit4]   2> 1192519 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.dv_coll.shard1.replica_n1, tag=null
   [junit4]   2> 1192519 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.dv_coll.shard4.replica_n5, tag=null
   [junit4]   2> 1192519 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@17260800: rootName = 
solr_41869, domain = solr.core.dv_coll.shard1.replica_n1, service url = null, 
agent id = null] for registry solr.core.dv_coll.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@696137fc
   [junit4]   2> 1192519 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@464da21d: rootName = 
solr_43383, domain = solr.core.dv_coll.shard4.replica_n5, service url = null, 
agent id = null] for registry solr.core.dv_coll.shard4.replica_n5 / 
com.codahale.metrics.MetricRegistry@aff45d8
   [junit4]   2> 1192528 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.c.SolrCore [dv_coll_shard1_replica_n1]  
CLOSING SolrCore org.apache.solr.core.SolrCore@256efb6a
   [junit4]   2> 1192528 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.dv_coll.shard1.replica_n1, tag=256efb6a
   [junit4]   2> 1192528 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection.dv_coll.shard1.leader, tag=256efb6a
   [junit4]   2> 1192530 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard1 to Terms{values={}, version=1}
   [junit4]   2> 1192531 INFO  (qtp850861564-14267) [n:127.0.0.1:41869_solr    
x:dv_coll_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=dv_coll_shard1_replica_n1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=11
   [junit4]   2> 1192535 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.dv_coll.shard2.replica_n2, tag=null
   [junit4]   2> 1192535 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.c.SolrCore [dv_coll_shard4_replica_n5]  
CLOSING SolrCore org.apache.solr.core.SolrCore@5d04c32b
   [junit4]   2> 1192535 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4b6f6e83: rootName = 
solr_43383, domain = solr.core.dv_coll.shard2.replica_n2, service url = null, 
agent id = null] for registry solr.core.dv_coll.shard2.replica_n2 / 
com.codahale.metrics.MetricRegistry@37fa6995
   [junit4]   2> 1192543 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.dv_coll.shard4.replica_n5, tag=5d04c32b
   [junit4]   2> 1192543 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.c.SolrCore [dv_coll_shard2_replica_n2]  
CLOSING SolrCore org.apache.solr.core.SolrCore@665561b8
   [junit4]   2> 1192543 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection.dv_coll.shard4.leader, tag=5d04c32b
   [junit4]   2> 1192544 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.core.dv_coll.shard2.replica_n2, tag=665561b8
   [junit4]   2> 1192544 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric reporters 
for registry=solr.collection.dv_coll.shard2.leader, tag=665561b8
   [junit4]   2> 1192545 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard2 to Terms{values={}, version=1}
   [junit4]   2> 1192546 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/dv_coll/terms/shard4 to Terms{values={}, version=1}
   [junit4]   2> 1192546 INFO  (qtp2005651214-14191) [n:127.0.0.1:43383_solr    
x:dv_coll_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=dv_coll_shard2_replica_n2&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=27
   [junit4]   2> 1192546 INFO  (qtp2005651214-14196) [n:127.0.0.1:43383_solr    
x:dv_coll_shard4_replica_n5] o.a.s.s.HttpSolrCall [admin] webapp=null 
path=/admin/cores 
params={deleteInstanceDir=true&deleteMetricsHistory=true&core=dv_coll_shard4_replica_n5&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
 status=0 QTime=27
   [junit4]   2> 1192648 INFO  (zkCallback-3162-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDeleted path:/collections/dv_coll/state.json] for 
collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1192648 INFO  (zkCallback-3176-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDeleted path:/collections/dv_coll/state.json] for 
collection [dv_coll] has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1193267 INFO  
(OverseerThreadFactory-5102-thread-1-processing-n:127.0.0.1:41869_solr) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.a.c.CreateCollectionCmd Cleaned up 
artifacts for failed create collection for [dv_coll]
   [junit4]   2> 1193268 INFO  (qtp850861564-14188) [n:127.0.0.1:41869_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> 1194903 INFO  
(OverseerCollectionConfigSetProcessor-72145730876145668-127.0.0.1:41869_solr-n_0000000000)
 [n:127.0.0.1:41869_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> 1223271 ERROR (qtp850861564-14188) [n:127.0.0.1:41869_solr    
] o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's replicas 
to become ACTIVE with timeout=30
   [junit4]   2> 1223271 INFO  (qtp850861564-14188) [n:127.0.0.1:41869_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={collection.configName=conf1&maxShardsPerNode=2&name=dv_coll&nrtReplicas=1&action=CREATE&numShards=4&wt=javabin&version=2}
 status=0 QTime=32371
   [junit4]   2> 1223274 INFO  (jetty-closer-3151-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@245977fb{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1223274 INFO  (jetty-closer-3151-thread-2) [    ] 
o.e.j.s.AbstractConnector Stopped ServerConnector@40f0bc1a{SSL,[ssl, 
http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1223274 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1331155692
   [junit4]   2> 1223274 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1223274 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@3e696367: rootName = 
solr_41869, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@2ebc2f02
   [junit4]   2> 1223274 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1594562217
   [junit4]   2> 1223275 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 1223275 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6bdfe78c: rootName = 
solr_43383, domain = solr.node, service url = null, agent id = null] for 
registry solr.node / com.codahale.metrics.MetricRegistry@1d781882
   [junit4]   2> 1223281 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1223281 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@e053049: rootName = 
solr_41869, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@527ea9ab
   [junit4]   2> 1223281 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 1223281 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2dcbc218: rootName = 
solr_43383, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@527ea9ab
   [junit4]   2> 1223285 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1223285 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@70c136f5: rootName = 
solr_41869, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@6a0e2bbf
   [junit4]   2> 1223285 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 1223285 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f9c6148: rootName = 
solr_43383, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@6a0e2bbf
   [junit4]   2> 1223286 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:41869_solr
   [junit4]   2> 1223286 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:43383_solr
   [junit4]   2> 1223286 INFO  (jetty-closer-3151-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 1223286 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 1223286 INFO  (zkCallback-3183-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1223286 INFO  (zkCallback-3169-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1223286 INFO  (zkCallback-3176-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1223287 INFO  (zkCallback-3162-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (0)
   [junit4]   2> 1223287 INFO  (jetty-closer-3151-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=72145730876145668-127.0.0.1:41869_solr-n_0000000000) closing
   [junit4]   2> 1223287 INFO  
(OverseerStateUpdate-72145730876145668-127.0.0.1:41869_solr-n_0000000000) 
[n:127.0.0.1:41869_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:41869_solr
   [junit4]   2> 1223287 WARN  
(OverseerAutoScalingTriggerThread-72145730876145668-127.0.0.1:41869_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 1223288 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 
0x1005028f4ef0005, likely client has closed socket
   [junit4]   2> 1223288 INFO  (jetty-closer-3151-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4cc6f1bc{/solr,null,UNAVAILABLE}
   [junit4]   2> 1223288 INFO  (jetty-closer-3151-thread-2) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1223290 INFO  (jetty-closer-3151-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@60f28080{/solr,null,UNAVAILABLE}
   [junit4]   2> 1223290 INFO  (jetty-closer-3151-thread-1) [    ] 
o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 1223291 ERROR 
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-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> 1223291 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:42561 42561
   [junit4]   2> 1224070 INFO  (Thread-4129) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:42561 42561
   [junit4]   2> 1224070 WARN  (Thread-4129) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        3       /solr/configs/conf1/managed-schema
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard2
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard1
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard4
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        4       /solr/collections/dv_coll/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        5       /solr/collections
   [junit4]   2> 
   [junit4]   2> 1224070 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=false): {}, locale=el, timezone=Pacific/Chatham
   [junit4]   2> NOTE: Linux 4.15.0-32-generic amd64/Oracle Corporation 11 
(64-bit)/cpus=8,threads=1,free=177474336,total=525860864
   [junit4]   2> NOTE: All tests run in this JVM: [IndexBasedSpellCheckerTest, 
CollectionsAPISolrJTest, TestTrieFacet, TestSolrDeletionPolicy1, 
MBeansHandlerTest, SolrCloudReportersTest, TestRequestStatusCollectionAPI, 
TestConfigSets, TestWriterPerf, TestInfoStreamLogging, RollingRestartTest, 
TestEmbeddedSolrServerAdminHandler, AddBlockUpdateTest, TestConfigOverlay, 
TestHalfAndHalfDocValues, TestReRankQParserPlugin, TestConfigSetsAPIZkFailure, 
TestSimpleTrackingShardHandler, RegexBoostProcessorTest, NoCacheHeaderTest, 
TestRecoveryHdfs, SuggestComponentTest, TestFreeTextSuggestions, 
TestHdfsCloudBackupRestore, ZkStateReaderTest, TestDocumentBuilder, 
AnalyticsMergeStrategyTest, ReplaceNodeTest, SpatialFilterTest, 
TestNumericTerms32, TestCloudJSONFacetJoinDomain, TestStressLucene, 
TestPostingsSolrHighlighter, ManagedSchemaRoundRobinCloudTest, 
DeleteReplicaTest, TestJsonFacetsStatsParsing, TestSchemaManager, 
ChaosMonkeySafeLeaderTest, OverriddenZkACLAndCredentialsProvidersTest, 
TestStressUserVersions, TestCorePropertiesReload, TestSchemaNameResource, 
BitVectorTest, UpdateLogTest, PKIAuthenticationIntegrationTest, 
TestInitQParser, CacheHeaderTest, TestRTimerTree, SuggesterTest, 
TestCloudSchemaless, TimeZoneUtilsTest, DistributedSuggestComponentTest, 
BlockJoinFacetDistribTest, TestSolrCoreSnapshots, 
PeerSyncWithIndexFingerprintCachingTest, TestExclusionRuleCollectionAccess, 
TestSchemaVersionResource, TestCloudConsistency, 
IgnoreLargeDocumentProcessorFactoryTest, DocumentAnalysisRequestHandlerTest, 
TestSystemCollAutoCreate, CleanupOldIndexTest, PropertiesRequestHandlerTest, 
BlobRepositoryCloudTest, DistributedQueryComponentOptimizationTest, 
MoreLikeThisHandlerTest, UninvertDocValuesMergePolicyTest, 
CollectionsAPIAsyncDistributedZkTest, TestSystemIdResolver, 
ConfigureRecoveryStrategyTest, DocValuesMultiTest, TestGraphTermsQParserPlugin, 
TestFieldCacheVsDocValues, CoreAdminOperationTest, TestUseDocValuesAsStored, 
TestHdfsBackupRestoreCore, TaggingAttributeTest, InfixSuggestersTest, 
TestDocTermOrds, TestQuerySenderListener, RandomizedTaggerTest, ZkCLITest, 
PluginInfoTest, TestDistributedGrouping, ExternalFileFieldSortTest, 
TestCSVLoader, DistributedExpandComponentTest, ClusterStateUpdateTest, 
RequestHandlersTest, TestSearchPerf, TestLegacyNumericRangeQueryBuilder, 
TestSimNodeLostTrigger, TestSizeLimitedDistributedMap, TestCoreAdminApis, 
SoftAutoCommitTest, CdcrVersionReplicationTest, TestSolrXml, 
ConvertedLegacyTest, TestPushWriter, TestWithCollection, TestCharFilters, 
MetricTriggerIntegrationTest, TolerantUpdateProcessorTest, 
TestMultiWordSynonyms, MoveReplicaHDFSTest, DistribCursorPagingTest, 
SolrXmlInZkTest, FileUtilsTest, TestFilteredDocIdSet, 
TestSimGenericDistributedQueue, TestChildDocTransformerHierarchy, 
SolrIndexMetricsTest, ConnectionManagerTest, TestRemoteStreaming, 
SolrTestCaseJ4Test, ReturnFieldsTest, TestReqParamsAPI, ResponseBuilderTest, 
TestGraphMLResponseWriter, BasicZkTest, TestPullReplica, 
TestNonDefinedSimilarityFactory, CloudMLTQParserTest, TestSortByMinMaxFunction, 
AssignTest, OverseerRolesTest, TestSolrCoreParser, TestRetrieveFieldsOptimizer, 
TestCSVResponseWriter, InfoHandlerTest, TestScoreJoinQPNoScore, 
TestRuleBasedAuthorizationPlugin, OverseerTest, 
LeaderFailoverAfterPartitionTest, AssignBackwardCompatibilityTest, 
AsyncCallRequestStatusResponseTest, CreateCollectionCleanupTest, 
CreateRoutedAliasTest, DistribDocExpirationUpdateProcessorTest, 
DocValuesNotIndexedTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=DocValuesNotIndexedTest -Dtests.seed=28760B8E0B96DCA1 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=el 
-Dtests.timezone=Pacific/Chatham -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J2 | DocValuesNotIndexedTest (suite) <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Collection 
not found: dv_coll
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:853)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
   [j

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

89 INFO  (jetty-closer-91-thread-1) [    ] o.a.s.m.SolrMetricManager Closing 
metric reporters for registry=solr.jetty, tag=null
   [junit4]   2> 94489 INFO  (jetty-closer-91-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@2aa73d17: rootName = 
solr_39619, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@27bb1fbd
   [junit4]   2> 94490 INFO  (jetty-closer-91-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 94490 INFO  (jetty-closer-91-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@1c269d28: rootName = 
solr_46345, domain = solr.jvm, service url = null, agent id = null] for 
registry solr.jvm / com.codahale.metrics.MetricRegistry@31daebe0
   [junit4]   2> 94491 INFO  (jetty-closer-91-thread-1) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39619_solr
   [junit4]   2> 94491 INFO  (jetty-closer-91-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 94492 INFO  (zkCallback-110-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 94492 INFO  (zkCallback-123-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 94492 INFO  (zkCallback-117-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 94492 INFO  (zkCallback-102-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 94494 INFO  (jetty-closer-91-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 94494 INFO  (jetty-closer-91-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@4ed01069: rootName = 
solr_46345, domain = solr.jetty, service url = null, agent id = null] for 
registry solr.jetty / com.codahale.metrics.MetricRegistry@27bb1fbd
   [junit4]   2> 94495 INFO  (jetty-closer-91-thread-2) [    ] 
o.a.s.c.ZkController Remove node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46345_solr
   [junit4]   2> 94496 INFO  (jetty-closer-91-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 94496 INFO  (zkCallback-123-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 94496 INFO  (zkCallback-102-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 94496 INFO  (zkCallback-117-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 94496 INFO  (zkCallback-110-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 94502 INFO  (jetty-closer-91-thread-1) [    ] o.a.s.c.Overseer 
Overseer (id=72145921241317382-127.0.0.1:39619_solr-n_0000000000) closing
   [junit4]   2> 94502 INFO  (jetty-closer-91-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@b446f2a{/solr,null,UNAVAILABLE}
   [junit4]   2> 94502 INFO  (jetty-closer-91-thread-2) [    ] o.e.j.s.session 
node0 Stopped scavenging
   [junit4]   2> 94502 INFO  
(OverseerStateUpdate-72145921241317382-127.0.0.1:39619_solr-n_0000000000) 
[n:127.0.0.1:39619_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:39619_solr
   [junit4]   2> 94502 WARN  
(OverseerAutoScalingTriggerThread-72145921241317382-127.0.0.1:39619_solr-n_0000000000)
 [    ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we 
are closed, exiting.
   [junit4]   2> 94505 INFO  (jetty-closer-91-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7253094d{/solr,null,UNAVAILABLE}
   [junit4]   2> 94506 INFO  (jetty-closer-91-thread-1) [    ] o.e.j.s.session 
node0 Stopped scavenging
   [junit4]   2> 94508 ERROR 
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-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> 94509 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:33787 33787
   [junit4]   2> 94535 INFO  (Thread-52) [    ] o.a.s.c.ZkTestServer connecting 
to 127.0.0.1:33787 33787
   [junit4]   2> 94536 WARN  (Thread-52) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/aliases.json
   [junit4]   2>        3       /solr/configs/conf1/managed-schema
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard3
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard2
   [junit4]   2>        3       /solr/collections/dv_coll/terms/shard4
   [junit4]   2>        2       /solr/security.json
   [junit4]   2>        2       /solr/configs/conf1
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/clusterstate.json
   [junit4]   2>        5       /solr/clusterprops.json
   [junit4]   2>        3       /solr/collections/dv_coll/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/live_nodes
   [junit4]   2>        5       /solr/collections
   [junit4]   2> 
   [junit4]   2> 94536 INFO  
(SUITE-DocValuesNotIndexedTest-seed#[28760B8E0B96DCA1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Aug 31, 2018 9:48:41 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 6 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), 
sim=RandomSimilarity(queryNorm=false): {}, locale=el, timezone=Pacific/Chatham
   [junit4]   2> NOTE: Linux 4.15.0-32-generic amd64/Oracle Corporation 11 
(64-bit)/cpus=8,threads=1,free=437791920,total=513277952
   [junit4]   2> NOTE: All tests run in this JVM: [DocValuesNotIndexedTest, 
TestCloudRecovery, DocValuesNotIndexedTest]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=DocValuesNotIndexedTest -Dtests.seed=28760B8E0B96DCA1 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=el 
-Dtests.timezone=Pacific/Chatham -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J2 | DocValuesNotIndexedTest (suite) <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Collection 
not found: dv_coll
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([28760B8E0B96DCA1]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:853)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
   [junit4]    >        at 
org.apache.solr.cloud.DocValuesNotIndexedTest.createCluster(DocValuesNotIndexedTest.java:155)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    >        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    >        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    >        at 
java.base/java.lang.reflect.Method.invoke(Method.java:566)
   [junit4]    >        at java.base/java.lang.Thread.run(Thread.java:834)
   [junit4] Completed [10/10 (5!)] on J2 in 33.04s, 0 tests, 1 error <<< 
FAILURES!

[...truncated 15 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1568: The 
following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/lucene/common-build.xml:1092: 
There were test failures: 10 suites, 20 tests, 4 suite-level errors, 1 error 
[seed: 28760B8E0B96DCA1]

Total time: 1 minute 37 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   2/5 failed: org.apache.solr.cloud.DocValuesNotIndexedTest
[repro]   3/5 failed: org.apache.solr.cloud.TestCloudRecovery
[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=91c9068ba3e379ea47b17917e498fa0d448bbfed, 
workspace=/var/lib/jenkins/workspace/Lucene-Solr-7.x-Linux
[WARNINGS] Computing warning deltas based on reference build #2663
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: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to