Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/926/

5 tests failed.
REGRESSION:  
org.apache.solr.cloud.ConcurrentDeleteAndCreateCollectionTest.testConcurrentCreateAndDeleteDoesNotFail

Error Message:
concurrent create and delete collection failed: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:55888/solr: Could not fully remove collection: 
collection4

Stack Trace:
java.lang.AssertionError: concurrent create and delete collection failed: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:55888/solr: Could not fully remove collection: 
collection4
        at 
__randomizedtesting.SeedInfo.seed([FB030AAA9367F8FF:3A2A5F10E4BC22EE]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at 
org.apache.solr.cloud.ConcurrentDeleteAndCreateCollectionTest.testConcurrentCreateAndDeleteDoesNotFail(ConcurrentDeleteAndCreateCollectionTest.java:72)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)


REGRESSION:  org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test

Error Message:
Captured an uncaught exception in thread: Thread[id=5015, name=collection1, 
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=5015, name=collection1, state=RUNNABLE, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:44666/sm_x: Could not find collection : 
awholynewstresscollection_collection1_0
        at __randomizedtesting.SeedInfo.seed([FB030AAA9367F8FF]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1085)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894)


REGRESSION:  
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload

Error Message:
expected:<[{indexVersion=1439365030209,generation=2,filelist=[_as.doc, _as.fdt, 
_as.fdx, _as.fnm, _as.nvd, _as.nvm, _as.si, _as.tim, _as.tip, _at.doc, _at.fdt, 
_at.fdx, _at.fnm, _at.nvd, _at.nvm, _at.si, _at.tim, _at.tip, _au.doc, _au.fdt, 
_au.fdx, _au.fnm, _au.nvd, _au.nvm, _au.si, _au.tim, _au.tip, _av.doc, _av.fdt, 
_av.fdx, _av.fnm, _av.nvd, _av.nvm, _av.si, _av.tim, _av.tip, segments_2]}]> 
but was:<[{indexVersion=1439365030209,generation=2,filelist=[_as.doc, _as.fdt, 
_as.fdx, _as.fnm, _as.nvd, _as.nvm, _as.si, _as.tim, _as.tip, _at.doc, _at.fdt, 
_at.fdx, _at.fnm, _at.nvd, _at.nvm, _at.si, _at.tim, _at.tip, _au.doc, _au.fdt, 
_au.fdx, _au.fnm, _au.nvd, _au.nvm, _au.si, _au.tim, _au.tip, _av.doc, _av.fdt, 
_av.fdx, _av.fnm, _av.nvd, _av.nvm, _av.si, _av.tim, _av.tip, segments_2]}, 
{indexVersion=1439365030209,generation=3,filelist=[_aw.doc, _aw.fdt, _aw.fdx, 
_aw.fnm, _aw.nvd, _aw.nvm, _aw.si, _aw.tim, _aw.tip, segments_3]}]>

Stack Trace:
java.lang.AssertionError: 
expected:<[{indexVersion=1439365030209,generation=2,filelist=[_as.doc, _as.fdt, 
_as.fdx, _as.fnm, _as.nvd, _as.nvm, _as.si, _as.tim, _as.tip, _at.doc, _at.fdt, 
_at.fdx, _at.fnm, _at.nvd, _at.nvm, _at.si, _at.tim, _at.tip, _au.doc, _au.fdt, 
_au.fdx, _au.fnm, _au.nvd, _au.nvm, _au.si, _au.tim, _au.tip, _av.doc, _av.fdt, 
_av.fdx, _av.fnm, _av.nvd, _av.nvm, _av.si, _av.tim, _av.tip, segments_2]}]> 
but was:<[{indexVersion=1439365030209,generation=2,filelist=[_as.doc, _as.fdt, 
_as.fdx, _as.fnm, _as.nvd, _as.nvm, _as.si, _as.tim, _as.tip, _at.doc, _at.fdt, 
_at.fdx, _at.fnm, _at.nvd, _at.nvm, _at.si, _at.tim, _at.tip, _au.doc, _au.fdt, 
_au.fdx, _au.fnm, _au.nvd, _au.nvm, _au.si, _au.tim, _au.tip, _av.doc, _av.fdt, 
_av.fdx, _av.fnm, _av.nvd, _av.nvm, _av.si, _av.tim, _av.tip, segments_2]}, 
{indexVersion=1439365030209,generation=3,filelist=[_aw.doc, _aw.fdt, _aw.fdx, 
_aw.fnm, _aw.nvd, _aw.nvm, _aw.si, _aw.tim, _aw.tip, segments_3]}]>
        at 
__randomizedtesting.SeedInfo.seed([FB030AAA9367F8FF:DED4119AE32FF6FC]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:147)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload(TestReplicationHandler.java:1138)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)


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

Error Message:
Error from server at http://127.0.0.1:45934: Error CREATEing SolrCore 
'halfcollection_shard1_replica1': Error reading cluster properties Caused by: 
KeeperErrorCode = Session expired for /clusterprops.json

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:45934: Error CREATEing SolrCore 
'halfcollection_shard1_replica1': Error reading cluster properties Caused by: 
KeeperErrorCode = Session expired for /clusterprops.json
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:301)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:418)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:168)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
        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:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.search.TestReloadDeadlock.testReloadDeadlock

Error Message:
Captured an uncaught exception in thread: Thread[id=3093, name=WRITER7, 
state=RUNNABLE, group=TGRP-TestReloadDeadlock]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=3093, name=WRITER7, state=RUNNABLE, 
group=TGRP-TestReloadDeadlock]
        at 
__randomizedtesting.SeedInfo.seed([FB030AAA9367F8FF:C682AE0BC72C1BBD]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.common.SolrException: 
Error opening new searcher
        at __randomizedtesting.SeedInfo.seed([FB030AAA9367F8FF]:0)
        at 
org.apache.solr.search.TestReloadDeadlock$1.run(TestReloadDeadlock.java:166)
Caused by: org.apache.solr.common.SolrException: Error opening new searcher
        at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:1662)
        at org.apache.solr.core.SolrCore.getRealtimeSearcher(SolrCore.java:1519)
        at 
org.apache.solr.update.VersionInfo.getVersionFromIndex(VersionInfo.java:201)
        at org.apache.solr.update.UpdateLog.lookupVersion(UpdateLog.java:778)
        at 
org.apache.solr.update.VersionInfo.lookupVersion(VersionInfo.java:194)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1089)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:706)
        at 
org.apache.solr.update.processor.LogUpdateProcessor.processAdd(LogUpdateProcessorFactory.java:104)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.handleAdds(JsonLoader.java:470)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.processUpdate(JsonLoader.java:134)
        at 
org.apache.solr.handler.loader.JsonLoader$SingleThreadedJsonLoader.load(JsonLoader.java:113)
        at org.apache.solr.handler.loader.JsonLoader.load(JsonLoader.java:76)
        at 
org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
        at 
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:143)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2068)
        at 
org.apache.solr.servlet.DirectSolrConnection.request(DirectSolrConnection.java:131)
        at org.apache.solr.SolrTestCaseJ4.updateJ(SolrTestCaseJ4.java:1104)
        at 
org.apache.solr.SolrTestCaseJ4.addAndGetVersion(SolrTestCaseJ4.java:1250)
        at 
org.apache.solr.search.TestReloadDeadlock.addDoc(TestReloadDeadlock.java:200)
        at 
org.apache.solr.search.TestReloadDeadlock.access$100(TestReloadDeadlock.java:46)
        at 
org.apache.solr.search.TestReloadDeadlock$1.run(TestReloadDeadlock.java:156)
Caused by: java.lang.NullPointerException
        at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:1631)
        ... 21 more




Build Log:
[...truncated 11041 lines...]
   [junit4] Suite: org.apache.solr.search.TestReloadDeadlock
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001
   [junit4]   2> 972393 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 972394 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 972394 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 972394 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 972395 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 972395 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 972442 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 972469 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
   [junit4]   2> 972505 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] o.a.s.c.Config 
Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 972506 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 972512 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 972717 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 972719 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 972729 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 972732 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 972740 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 972740 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr
   [junit4]   2> 972740 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/'
   [junit4]   2> 972784 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.CoreContainer New CoreContainer 681787977
   [junit4]   2> 972784 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/]
   [junit4]   2> 972784 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.CoreContainer loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/lib
   [junit4]   2> 972784 WARN  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to 
classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/lib).
   [junit4]   2> 972792 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 
600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 972794 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 972795 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 972795 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 972795 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 972795 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 972796 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.c.SolrCore Created CoreDescriptor: {instanceDir=collection1, 
config=solrconfig-tlog.xml, schema=schema15.xml, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/,
 transient=false, name=collection1, configSetProperties=configsetprops.json, 
shard=shard1, 
dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001,
 collection=collection1, loadOnStartup=true}
   [junit4]   2> 972797 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 972804 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 972804 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 972804 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 972823 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 972836 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
   [junit4]   2> 972865 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 972866 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 972872 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 973154 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 973157 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 973159 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 973163 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 973175 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf'
   [junit4]   2> 973175 INFO  (coreLoadExecutor-1028-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 973176 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 973176 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/],
 dataDir=[null]
   [junit4]   2> 973176 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cda2a84
   [junit4]   2> 973177 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001
   [junit4]   2> 973178 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/index/
   [junit4]   2> 973178 WARN  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 973178 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/index
   [junit4]   2> 973178 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@7a767a62
   [junit4]   2> 973179 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_1,generation=1}
   [junit4]   2> 973179 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 973186 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 973186 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 973187 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 973187 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 973187 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 973187 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 973188 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 973188 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 973188 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 973193 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973195 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973197 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/
   [junit4]   2> 973198 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973202 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973216 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
standard,/update/csv,/admin/file,/update,/admin/plugins,/update/json,/admin/mbeans,/admin/luke,/replication,/admin/segments,/admin/system,/config,/schema,/admin/properties,/get,/admin/logging,/update/json/docs,/admin/ping,/admin/threads
   [junit4]   2> 973222 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 973223 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 973223 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 973224 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 973224 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 973225 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=2089740733, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 973226 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_1,generation=1}
   [junit4]   2> 973226 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 973226 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@13573da3[collection1] 
main
   [junit4]   2> 973227 WARN  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 973227 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 973227 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
InMemoryStorage
   [junit4]   2> 973228 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 973228 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 973229 INFO  
(searcherExecutor-1029-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@13573da3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 973229 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed 
version buckets
   [junit4]   2> 973229 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 
65536 version buckets from index
   [junit4]   2> 973230 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed 
version bucket highest value from index
   [junit4]   2> 973230 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1509281733245140992
   [junit4]   2> 973232 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Took 3 ms to seed version buckets with highest 
version 1509281733245140992
   [junit4]   2> 973233 INFO  (coreLoadExecutor-1028-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 973234 INFO  
(SUITE-TestReloadDeadlock-seed#[FB030AAA9367F8FF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 973239 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testReloadDeadlock
   [junit4]   2> 973240 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 973240 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.SolrIndexSearcher Opening Searcher@49696c88[collection1] realtime
   [junit4]   2> 973240 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null 
params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=*:* (-9223372036854775807)} 0 1
   [junit4]   2> 973241 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973242 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_1,generation=1}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_2,generation=2}
   [junit4]   2> 973243 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 973243 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.SolrIndexSearcher Opening Searcher@3d4323e1[collection1] main
   [junit4]   2> 973243 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 973244 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3d4323e1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 973245 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} 
{commit=} 0 4
   [junit4]   2> 973263 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[30 
(1)]} 0 13
   [junit4]   2> 973292 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2f2e02c8[collection1] realtime
   [junit4]   2> 973293 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-2&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:42 (-2)} 0 35
   [junit4]   2> 973293 INFO  (WRITER0) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973295 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[24 
(3)]} 0 37
   [junit4]   2> 973298 INFO  (WRITER0) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_2,generation=2}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_3,generation=3}
   [junit4]   2> 973299 INFO  (WRITER0) [    ] o.a.s.c.SolrCore newest commit 
generation = 3
   [junit4]   2> 973299 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[29 
(4)]} 0 34
   [junit4]   2> 973305 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@31c8c618[collection1] main
   [junit4]   2> 973305 INFO  (WRITER0) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 973306 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@31c8c618[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.4.0):C1)
 Uninverting(_1(5.4.0):C1) Uninverting(_2(5.4.0):C1)))}
   [junit4]   2> 973307 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 42
   [junit4]   2> 973313 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6ebd7211[collection1] realtime
   [junit4]   2> 973314 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-5&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:29 (-5)} 0 48
   [junit4]   2> 973315 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-6&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:29 (-6)} 0 26
   [junit4]   2> 973316 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[38 
(7)]} 0 26
   [junit4]   2> 973321 INFO  (WRITER8) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@525294d9[collection1] realtime
   [junit4]   2> 973322 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-9&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:31 (-9)} 0 30
   [junit4]   2> 973323 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-8&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:3 (-8)} 0 33
   [junit4]   2> 973324 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[42 
(10)]} 0 31
   [junit4]   2> 973325 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[42 
(11)]} 0 29
   [junit4]   2> 973325 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[42 
(13)]} 0 14
   [junit4]   2> 973325 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[21 
(12)]} 0 23
   [junit4]   2> 973325 INFO  (WRITER4) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973331 INFO  (WRITER4) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_3,generation=3}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_4,generation=4}
   [junit4]   2> 973331 INFO  (WRITER4) [    ] o.a.s.c.SolrCore newest commit 
generation = 4
   [junit4]   2> 973332 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@31882856[collection1] main
   [junit4]   2> 973332 INFO  (WRITER4) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 973333 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@31882856[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.4.0):C1)
 Uninverting(_1(5.4.0):C1) Uninverting(_3(5.4.0):C1) 
Uninverting(_4(5.4.0):C4/2:delGen=1)))}
   [junit4]   2> 973334 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 19
   [junit4]   2> 973336 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-14&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:29 (-14)} 0 20
   [junit4]   2> 973340 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-15&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:1 (-15)} 0 24
   [junit4]   2> 973342 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-16&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:44 (-16)} 0 20
   [junit4]   2> 973343 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[3 
(17)]} 0 18
   [junit4]   2> 973347 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@78610b23[collection1] realtime
   [junit4]   2> 973347 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-18&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:3 (-18)} 0 23
   [junit4]   2> 973348 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[3 
(19)]} 0 23
   [junit4]   2> 973353 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@79ad29c3[collection1] realtime
   [junit4]   2> 973353 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-20&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:42 (-20)} 0 28
   [junit4]   2> 973361 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[20 
(21)]} 0 35
   [junit4]   2> 973361 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 973362 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[29 
(22)]} 0 23
   [junit4]   2> 973362 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[1 
(24)]} 0 20
   [junit4]   2> 973362 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[29 
(23)]} 0 24
   [junit4]   2> 973362 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 973362 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 973362 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[3 
(28)]} 0 14
   [junit4]   2> 973362 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 973363 INFO  (WRITER5) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973363 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[10 
(29)]} 0 9
   [junit4]   2> 973366 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[20 
(30)]} 0 4
   [junit4]   2> 973369 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[29 
(31)]} 0 6
   [junit4]   2> 973376 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[1 
(26)]} 0 33
   [junit4]   2> 973376 INFO  (WRITER5) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_4,generation=4}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_5,generation=5}
   [junit4]   2> 973377 INFO  (WRITER5) [    ] o.a.s.c.SolrCore newest commit 
generation = 5
   [junit4]   2> 973377 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[1 
(27)]} 0 28
   [junit4]   2> 973377 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[1 
(25)]} 0 34
   [junit4]   2> 973383 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@e78edbf[collection1] main
   [junit4]   2> 973383 INFO  (WRITER5) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 973385 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@e78edbf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.4.0):C1)
 Uninverting(_1(5.4.0):C1) Uninverting(_3(5.4.0):C1) 
Uninverting(_4(5.4.0):C4/3:delGen=2) Uninverting(_9(5.4.0):C2) 
Uninverting(_a(5.4.0):C3)))}
   [junit4]   2> 973392 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 30
   [junit4]   2> 973395 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@68296868[collection1] realtime
   [junit4]   2> 973396 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[3 
(33)]} 0 33
   [junit4]   2> 973397 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[0 
(34)]} 0 32
   [junit4]   2> 973403 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@64217ca[collection1] realtime
   [junit4]   2> 973405 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-32&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:3 (-32)} 0 42
   [junit4]   2> 973405 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(36)]} 0 36
   [junit4]   2> 973406 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-35&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:20 (-35)} 0 39
   [junit4]   2> 973406 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2 
(37)]} 0 29
   [junit4]   2> 973406 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[38 
(39)]} 0 28
   [junit4]   2> 973407 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[15 
(38)]} 0 29
   [junit4]   2> 973411 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 973421 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@918bb06[collection1] realtime
   [junit4]   2> 973423 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(42)]} 0 25
   [junit4]   2> 973429 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@388e42a3[collection1] realtime
   [junit4]   2> 973429 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-40&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:24 (-40)} 0 32
   [junit4]   2> 973433 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2ac01d9b[collection1] realtime
   [junit4]   2> 973433 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-44&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:3 (-44)} 0 27
   [junit4]   2> 973436 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-45&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:20 (-45)} 0 29
   [junit4]   2> 973438 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(47)]} 0 31
   [junit4]   2> 973438 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2 
(46)]} 0 32
   [junit4]   2> 973439 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-41&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:24 (-41)} 0 41
   [junit4]   2> 973439 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[24 
(48)]} 0 32
   [junit4]   2> 973441 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
   [junit4]   2> 973451 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@7d1ffa33[collection1] realtime
   [junit4]   2> 973451 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-43&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:0 (-43)} 0 44
   [junit4]   2> 973455 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(49)]} 0 31
   [junit4]   2> 973455 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(53)]} 0 17
   [junit4]   2> 973456 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[36 
(50)]} 0 26
   [junit4]   2> 973457 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[0 
(52)]} 0 21
   [junit4]   2> 973458 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[23 
(51)]} 0 24
   [junit4]   2> 973471 INFO  (WRITER6) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2147df18[collection1] realtime
   [junit4]   2> 973472 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-54&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:35 (-54)} 0 33
   [junit4]   2> 973473 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[24 
(55)]} 0 33
   [junit4]   2> 973473 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[24 
(56)]} 0 33
   [junit4]   2> 973478 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@b9e4ba4[collection1] realtime
   [junit4]   2> 973481 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-59&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:44 (-59)} 0 24
   [junit4]   2> 973482 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-58&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:44 (-58)} 0 26
   [junit4]   2> 973482 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-57&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:40 (-57)} 0 30
   [junit4]   2> 973483 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(60)]} 0 27
   [junit4]   2> 973484 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[23 
(62)]} 0 25
   [junit4]   2> 973484 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(61)]} 0 26
   [junit4]   2> 973484 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[4 
(63)]} 0 12
   [junit4]   2> 973484 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[24 
(64)]} 0 11
   [junit4]   2> 973485 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[24 
(65)]} 0 11
   [junit4]   2> 973486 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[44 
(66)]} 0 4
   [junit4]   2> 973486 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[44 
(67)]} 0 3
   [junit4]   2> 973486 INFO  (WRITER3) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973496 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[22 
(72)]} 0 10
   [junit4]   2> 973497 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[12 
(73)]} 0 11
   [junit4]   2> 973498 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(69)]} 0 12
   [junit4]   2> 973498 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(70)]} 0 14
   [junit4]   2> 973499 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[12 
(71)]} 0 14
   [junit4]   2> 973503 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(68)]} 0 20
   [junit4]   2> 973504 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 973504 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 973505 INFO  (WRITER3) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_5,generation=5}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_6,generation=6}
   [junit4]   2> 973505 INFO  (WRITER3) [    ] o.a.s.c.SolrCore newest commit 
generation = 6
   [junit4]   2> 973515 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2f862e97[collection1] main
   [junit4]   2> 973515 INFO  (WRITER3) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 973516 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 973516 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2f862e97[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_h(5.4.0):c12/4:delGen=1)
 Uninverting(_i(5.4.0):C1) Uninverting(_m(5.4.0):C1) Uninverting(_o(5.4.0):C1) 
Uninverting(_r(5.4.0):C7/2:delGen=1) Uninverting(_s(5.4.0):C2/1:delGen=1) 
Uninverting(_t(5.4.0):C2)))}
   [junit4]   2> 973518 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 33
   [junit4]   2> 973521 INFO  (WRITER8) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@28d0b119[collection1] realtime
   [junit4]   2> 973521 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-74&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:12 (-74)} 0 35
   [junit4]   2> 973522 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[12 
(75)]} 0 35
   [junit4]   2> 973522 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[22 
(76)]} 0 26
   [junit4]   2> 973530 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2edc7f63[collection1] realtime
   [junit4]   2> 973532 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(78)]} 0 33
   [junit4]   2> 973537 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@cdbedf[collection1] realtime
   [junit4]   2> 973538 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-79&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:40 (-79)} 0 39
   [junit4]   2> 973538 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-77&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:2 (-77)} 0 40
   [junit4]   2> 973539 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[30 
(81)]} 0 35
   [junit4]   2> 973540 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[38 
(84)]} 0 17
   [junit4]   2> 973540 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[38 
(85)]} 0 17
   [junit4]   2> 973540 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(80)]} 0 41
   [junit4]   2> 973540 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(83)]} 0 19
   [junit4]   2> 973541 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(82)]} 0 20
   [junit4]   2> 973560 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@4563011c[collection1] realtime
   [junit4]   2> 973561 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-86&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:14 (-86)} 0 29
   [junit4]   2> 973563 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-87&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:39 (-87)} 0 24
   [junit4]   2> 973565 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[39 
(88)]} 0 27
   [junit4]   2> 973566 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[37 
(90)]} 0 25
   [junit4]   2> 973565 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[30 
(89)]} 0 25
   [junit4]   2> 973576 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@704651e7[collection1] realtime
   [junit4]   2> 973576 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-91&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:4 (-91)} 0 36
   [junit4]   2> 973576 INFO  (WRITER8) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973578 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[32 
(92)]} 0 37
   [junit4]   2> 973578 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(94)]} 0 16
   [junit4]   2> 973578 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(95)]} 0 14
   [junit4]   2> 973583 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[26 
(93)]} 0 26
   [junit4]   2> 973633 INFO  (WRITER8) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_6,generation=6}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_7,generation=7}
   [junit4]   2> 973633 INFO  (WRITER8) [    ] o.a.s.c.SolrCore newest commit 
generation = 7
   [junit4]   2> 973649 INFO  (WRITER8) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@48c49ca2[collection1] main
   [junit4]   2> 973650 INFO  (WRITER8) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 973651 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@48c49ca2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_h(5.4.0):c12/6:delGen=2)
 Uninverting(_m(5.4.0):C1) Uninverting(_o(5.4.0):C1) 
Uninverting(_r(5.4.0):C7/4:delGen=2) Uninverting(_u(5.4.0):C1) 
Uninverting(_v(5.4.0):C1) Uninverting(_x(5.4.0):C3/2:delGen=2) 
Uninverting(_z(5.4.0):C2) Uninverting(_10(5.4.0):C1) Uninverting(_12(5.4.0):C2) 
Uninverting(_11(5.4.0):C1)))}
   [junit4]   2> 973655 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@7725f2e2[collection1] realtime
   [junit4]   2> 973655 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-97&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:18 (-97)} 0 89
   [junit4]   2> 973655 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 114
   [junit4]   2> 973660 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@a46c229[collection1] realtime
   [junit4]   2> 973661 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-98&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:32 (-98)} 0 94
   [junit4]   2> 973662 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@28376e9e[collection1] realtime
   [junit4]   2> 973662 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-96&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:28 (-96)} 0 96
   [junit4]   2> 973663 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(100)]} 0 84
   [junit4]   2> 973666 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@660264de[collection1] realtime
   [junit4]   2> 973666 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-101&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:40 (-101)} 0 88
   [junit4]   2> 973667 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-99&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:32 (-99)} 0 89
   [junit4]   2> 973668 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[40 
(102)]} 0 89
   [junit4]   2> 973669 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[26 
(103)]} 0 83
   [junit4]   2> 973675 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@35a67ba0[collection1] realtime
   [junit4]   2> 973675 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-104&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:26 (-104)} 0 19
   [junit4]   2> 973677 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[8 
(109)]} 0 10
   [junit4]   2> 973677 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[32 
(110)]} 0 9
   [junit4]   2> 973678 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[20 
(111)]} 0 8
   [junit4]   2> 973678 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[26 
(105)]} 0 19
   [junit4]   2> 973678 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[36 
(108)]} 0 14
   [junit4]   2> 973678 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[36 
(107)]} 0 15
   [junit4]   2> 973679 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[36 
(106)]} 0 17
   [junit4]   2> 973743 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@665be334[collection1] realtime
   [junit4]   2> 973745 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[26 
(113)]} 0 69
   [junit4]   2> 973745 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[34 
(114)]} 0 67
   [junit4]   2> 973745 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[34 
(115)]} 0 67
   [junit4]   2> 973750 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6fbf1740[collection1] realtime
   [junit4]   2> 973752 INFO  (WRITER0) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 973753 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[30 
(117)]} 0 74
   [junit4]   2> 973761 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[0 
(120)]} 0 81
   [junit4]   2> 973761 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-112&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:26 (-112)} 0 92
   [junit4]   2> 973761 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-116&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:7 (-116)} 0 83
   [junit4]   2> 973762 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[7 
(118)]} 0 82
   [junit4]   2> 973762 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[7 
(119)]} 0 83
   [junit4]   2> 973776 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 973777 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 973778 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 973781 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 973845 INFO  (WRITER0) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_7,generation=7}
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(NRTCachingDirectory(RAMDirectory@785cf6bd 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1f4b3007; 
maxCacheMB=0.1611328125 
maxMergeSizeMB=0.0078125)),segFN=segments_8,generation=8}
   [junit4]   2> 973845 INFO  (WRITER0) [    ] o.a.s.c.SolrCore newest commit 
generation = 8
   [junit4]   2> 973853 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/conf'
   [junit4]   2> 973853 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 973853 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/core/src/test-files/solr/collection1/],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/]
   [junit4]   2> 973854 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cda2a84
   [junit4]   2> 973855 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/index/
   [junit4]   2> 973855 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_FB030AAA9367F8FF-001/init-core-data-001/
   [junit4]   2> 973856 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@fc3d7fd[collection1] main
   [junit4]   2> 973858 INFO  (searcherExecutor-1029-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@fc3d7fd[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_13(5.4.0):c19/5:delGen=1)
 Uninverting(_14(5.4.0):C1) Uninverting(_15(5.4.0):C1) 
Uninverting(_1a(5.4.0):C3/1:delGen=1) Uninverting(_19(5.4.0):C1) 
Uninverting(_18(5.4.0):C1) Uninverting(_1b(5.4.0):C3/1:delGen=1) 
Uninverting(_1c(5.4.0):C1) Uninverting(_1e(5.4.0):C1) 
Uninverting(_1f(5.4.0):C1)))}
   [junit4]   2> 973859 INFO  (WRITER0) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 973864 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 119
   [junit4]   2> 973865 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 973865 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 973865 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 973865 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 973865 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 973866 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 973866 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@4e8c6428[collection1] realtime
   [junit4]   2> 973866 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-121&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:26 (-121)} 0 120
   [junit4]   2> 973866 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 973866 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 973866 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 973867 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@79ef634[collection1] realtime
   [junit4]   2> 973867 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-122&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:34 (-122)} 0 121
   [junit4]   2> 973868 INFO  (WRITER8) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@ba8e12c[collection1] realtime
   [junit4]   2> 973868 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-123&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:30 (-123)} 0 115
   [junit4]   2> 973869 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-124&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:31 (-124)} 0 108
   [junit4]   2> 973869 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973871 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973871 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[3 
(125)]} 0 109
   [junit4]   2> 973872 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[41 
(133)]} 0 1
   [junit4]   2> 973872 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[FB030AAA9367F8FF]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 973873 INFO  (WRITER8) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] we

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

Thread[id=11658, name=collection5, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: java.lang.RuntimeException: 
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available 
to handle this request:[http://127.0.0.1:55876, http://127.0.0.1:45934, 
http://127.0.0.1:57578, http://127.0.0.1:48813, http://127.0.0.1:57704]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([FB030AAA9367F8FF]:0)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:897)
   [junit4]    > Caused by: org.apache.solr.client.solrj.SolrServerException: 
No live SolrServers available to handle this request:[http://127.0.0.1:55876, 
http://127.0.0.1:45934, http://127.0.0.1:57578, http://127.0.0.1:48813, 
http://127.0.0.1:57704]
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:355)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1085)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:894)
   [junit4]    > Caused by: org.apache.solr.client.solrj.SolrServerException: 
Timeout occured while waiting response from server at: http://127.0.0.1:57578
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:570)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:234)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:226)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
   [junit4]    >        ... 5 more
   [junit4]    > Caused by: java.net.SocketTimeoutException: Read timed out
   [junit4]    >        at java.net.SocketInputStream.socketRead0(Native Method)
   [junit4]    >        at 
java.net.SocketInputStream.read(SocketInputStream.java:152)
   [junit4]    >        at 
java.net.SocketInputStream.read(SocketInputStream.java:122)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
   [junit4]    >        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
   [junit4]    >        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
   [junit4]    >        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
   [junit4]    >        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
   [junit4]    >        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
   [junit4]    >        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
   [junit4]    >        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
   [junit4]    >        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
   [junit4]    >        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
   [junit4]    >        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
   [junit4]    >        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:465)
   [junit4]    >        ... 9 more
   [junit4]   2> 3152916 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[FB030AAA9367F8FF]-worker) 
[n:127.0.0.1:48813_ c:awholynewstresscollection_collection3_0 s:shard7 
r:core_node14 x:awholynewstresscollection_collection3_0_shard7_replica1] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPIDistributedZkTest_FB030AAA9367F8FF-001
   [junit4]   2> Aug 12, 2015 3:43:25 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53): 
{range_facet_i_dv=PostingsFormat(name=Direct), 
intDefault=BlockTreeOrds(blocksize=128), 
id=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
timestamp=PostingsFormat(name=Direct), 
range_facet_l_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
other_tl1=BlockTreeOrds(blocksize=128), _version_=BlockTreeOrds(blocksize=128), 
a_t=PostingsFormat(name=Direct), range_facet_l=PostingsFormat(name=Direct), 
multiDefault=PostingsFormat(name=Direct), text=PostingsFormat(name=Memory 
doPackFST= false), a_i1=PostingsFormat(name=Direct)}, 
docValues:{range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct), 
range_facet_l_dv=DocValuesFormat(name=Memory)}, sim=DefaultSimilarity, 
locale=en_IE, timezone=SystemV/EST5EDT
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.7.0_72 (64-bit)/cpus=4,threads=1,free=93700216,total=500170752
   [junit4]   2> NOTE: All tests run in this JVM: [TestFastOutputStream, 
CoreAdminCreateDiscoverTest, TestQueryUtils, TestSmileRequest, 
DistributedQueryElevationComponentTest, SecurityConfHandlerTest, SampleTest, 
TestSchemaManager, TestSimpleTrackingShardHandler, 
TermVectorComponentDistributedTest, LoggingHandlerTest, TestLuceneMatchVersion, 
HttpPartitionTest, XmlUpdateRequestHandlerTest, MultiThreadedOCPTest, 
BJQParserTest, AddSchemaFieldsUpdateProcessorFactoryTest, TestJettySolrRunner, 
XsltUpdateRequestHandlerTest, TestIntervalFaceting, TestBulkSchemaConcurrent, 
BasicDistributedZk2Test, TestDynamicFieldResource, 
AsyncCallRequestStatusResponseTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, AutoCommitTest, TestRecovery, 
TestDocSet, OpenExchangeRatesOrgProviderTest, CachingDirectoryFactoryTest, 
TestInfoStreamLogging, ChangedSchemaMergeTest, SortByFunctionTest, 
CursorMarkTest, TestXIncludeConfig, BufferStoreTest, 
DocExpirationUpdateProcessorFactoryTest, FileBasedSpellCheckerTest, 
TestGroupingSearch, BlockCacheTest, HdfsDirectoryTest, 
TestSolrQueryParserDefaultOperatorResource, PrimUtilsTest, 
SpatialRPTFieldTypeTest, TestSystemIdResolver, 
BigEndianAscendingWordSerializerTest, ResponseHeaderTest, 
DirectSolrSpellCheckerTest, TestRebalanceLeaders, TestSort, NumericFieldsTest, 
TestSolrQueryParserResource, TestReload, SpellCheckCollatorTest, 
TestDistribIDF, HdfsCollectionsAPIDistributedZkTest, HdfsSyncSliceTest, 
TestDocBasedVersionConstraints, QueryResultKeyTest, TestCryptoKeys, 
TestRemoveLastDynamicCopyField, SoftAutoCommitTest, TestSolrJ, 
SolrCoreCheckLockOnStartupTest, HardAutoCommitTest, QueryParsingTest, 
TestRequestStatusCollectionAPI, DistributedExpandComponentTest, 
SynonymTokenizerTest, TestRandomRequestDistribution, 
PathHierarchyTokenizerFactoryTest, TestStressRecovery, SolrIndexSplitterTest, 
OutputWriterTest, TestPartialUpdateDeduplication, FullSolrCloudDistribCmdsTest, 
MoreLikeThisHandlerTest, DeleteShardTest, DeleteReplicaTest, TestConfigSets, 
CollectionReloadTest, SolrInfoMBeanTest, RankQueryTest, TestStandardQParsers, 
BadIndexSchemaTest, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, 
CollectionsAPIDistributedZkTest]
   [junit4] Completed [406/533] on J2 in 1318.60s, 1 test, 1 error <<< FAILURES!

[...truncated 418 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:776: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:713: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:230:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:524:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1449:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1003:
 There were test failures: 533 suites, 2111 tests, 3 errors, 2 failures, 26 
ignored (14 assumptions)

Total time: 185 minutes 13 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #911
Archived 4 artifacts
Archive block size is 32768
Received 0 blocks and 1228028293 bytes
Compression is 0.0%
Took 3 min 11 sec
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to