Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/765/

4 tests failed.
REGRESSION:  org.apache.solr.cloud.CollectionStateFormat2Test.test

Error Message:
Error from server at http://127.0.0.1:57830: Could not find collection : 
myExternColl

Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:57830: Could not find collection : myExternColl
        at 
__randomizedtesting.SeedInfo.seed([8D9027F10AEAE137:5C4182BA4168CCF]: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:372)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.CollectionStateFormat2Test.testZkNodeLocation(CollectionStateFormat2Test.java:84)
        at 
org.apache.solr.cloud.CollectionStateFormat2Test.test(CollectionStateFormat2Test.java:40)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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=1992, name=WRITER6, 
state=RUNNABLE, group=TGRP-TestReloadDeadlock]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=1992, name=WRITER6, state=RUNNABLE, 
group=TGRP-TestReloadDeadlock]
        at 
__randomizedtesting.SeedInfo.seed([8D9027F10AEAE137:B01183505EA10275]:0)
Caused by: java.lang.RuntimeException: org.apache.solr.common.SolrException: 
Error opening new searcher
        at __randomizedtesting.SeedInfo.seed([8D9027F10AEAE137]: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:1673)
        at org.apache.solr.core.SolrCore.getRealtimeSearcher(SolrCore.java:1530)
        at 
org.apache.solr.update.VersionInfo.getVersionFromIndex(VersionInfo.java:202)
        at org.apache.solr.update.UpdateLog.lookupVersion(UpdateLog.java:783)
        at 
org.apache.solr.update.VersionInfo.lookupVersion(VersionInfo.java:195)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.versionAdd(DistributedUpdateProcessor.java:1088)
        at 
org.apache.solr.update.processor.DistributedUpdateProcessor.processAdd(DistributedUpdateProcessor.java:705)
        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:151)
        at org.apache.solr.core.SolrCore.execute(SolrCore.java:2079)
        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:1642)
        ... 21 more


FAILED:  org.apache.solr.cloud.CdcrReplicationDistributedZkTest.doTests

Error Message:
There are still nodes recoverying - waited for 330 seconds

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330 
seconds
        at 
__randomizedtesting.SeedInfo.seed([8D9027F10AEAE137:85F052DD05E4C93C]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:172)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:133)
        at 
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:128)
        at 
org.apache.solr.cloud.BaseCdcrDistributedZkTest.waitForRecoveriesToFinish(BaseCdcrDistributedZkTest.java:465)
        at 
org.apache.solr.cloud.BaseCdcrDistributedZkTest.clearSourceCollection(BaseCdcrDistributedZkTest.java:319)
        at 
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.doTestReplicationAfterRestart(CdcrReplicationDistributedZkTest.java:202)
        at 
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.doTests(CdcrReplicationDistributedZkTest.java:50)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        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.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=29826, name=collection0, state=RUNNABLE, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:55790/pdt/r: Could not find collection : 
awholynewstresscollection_collection0_0
        at __randomizedtesting.SeedInfo.seed([8D9027F10AEAE137]: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:372)
        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)




Build Log:
[...truncated 10176 lines...]
   [junit4] Suite: org.apache.solr.search.TestReloadDeadlock
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001
   [junit4]   2> 220429 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 220429 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 220430 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 220430 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 220430 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 220431 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 220454 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 220458 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 220467 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] o.a.s.c.Config 
Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 220468 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 220472 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 220555 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 220556 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 220557 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 220559 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 220566 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 220566 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader using system property solr.solr.home: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr
   [junit4]   2> 220566 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/'
   [junit4]   2> 220585 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1010663881
   [junit4]   2> 220585 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/]
   [junit4]   2> 220585 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.CoreContainer loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/lib
   [junit4]   2> 220586 WARN  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-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-trunk/solr/core/src/test-files/solr/lib).
   [junit4]   2> 220593 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-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> 220596 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=30000&connTimeout=30000&retry=true
   [junit4]   2> 220597 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 220597 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 220597 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 220597 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 220598 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, 
config=solrconfig-tlog.xml, transient=false, schema=schema15.xml, 
loadOnStartup=true, configSetProperties=configsetprops.json, 
instanceDir=collection1, collection=collection1, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/,
 
dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001,
 shard=shard1}
   [junit4]   2> 220598 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 220599 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 220599 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 220600 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 220618 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 220622 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 220630 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 220631 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 220635 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 220716 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 220717 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 220718 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 220720 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 220728 INFO  (coreLoadExecutor-583-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-trunk/solr/core/src/test-files/solr/collection1/conf'
   [junit4]   2> 220728 INFO  (coreLoadExecutor-583-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 220728 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 220728 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/],
 dataDir=[null]
   [junit4]   2> 220728 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6d71d4f9
   [junit4]   2> 220729 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001
   [junit4]   2> 220729 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/index/
   [junit4]   2> 220729 WARN  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/index'
 doesn't exist. Creating new index...
   [junit4]   2> 220729 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/index
   [junit4]   2> 220730 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=17, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 220730 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_1,generation=1}
   [junit4]   2> 220730 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 220731 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-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/
   [junit4]   2> 220734 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 220735 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 220735 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 220735 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 220735 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 220736 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 220736 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 220736 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 220736 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 220738 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 220739 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 220740 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 220741 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 220743 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 220744 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 220745 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 220745 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 220745 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 220745 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 220746 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=36, maxMergeAtOnceExplicit=35, maxMergedSegmentMB=14.9404296875, 
floorSegmentMB=1.85546875, forceMergeDeletesPctAllowed=25.18827565637258, 
segmentsPerTier=7.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3227667177051782
   [junit4]   2> 220746 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_1,generation=1}
   [junit4]   2> 220746 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 220746 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@73d6cb58[collection1] 
main
   [junit4]   2> 220747 WARN  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 220747 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 220747 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
InMemoryStorage
   [junit4]   2> 220747 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 220747 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 220748 INFO  
(searcherExecutor-584-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@73d6cb58[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 220748 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed 
version buckets
   [junit4]   2> 220748 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 
65536 version buckets from index
   [junit4]   2> 220748 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed 
version bucket highest value from index
   [junit4]   2> 220748 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1509538087982596096
   [junit4]   2> 220750 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with 
highest version 1509538087982596096
   [junit4]   2> 220751 INFO  (coreLoadExecutor-583-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 220752 INFO  
(SUITE-TestReloadDeadlock-seed#[8D9027F10AEAE137]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 220754 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testReloadDeadlock
   [junit4]   2> 220762 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 220764 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.SolrIndexSearcher Opening Searcher@297cbcc6[collection1] realtime
   [junit4]   2> 220764 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
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 9
   [junit4]   2> 220765 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 220765 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_2,generation=2}
   [junit4]   2> 220766 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrCore newest commit generation = 2
   [junit4]   2> 220766 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.SolrIndexSearcher Opening Searcher@6d4223c0[collection1] main
   [junit4]   2> 220767 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.u.UpdateHandler end_commit_flush
   [junit4]   2> 220767 INFO  (searcherExecutor-584-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6d4223c0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 220768 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} 
{commit=} 0 3
   [junit4]   2> 220780 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 
(1)]} 0 6
   [junit4]   2> 220781 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[0 
(2)]} 0 7
   [junit4]   2> 220809 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@76fc9b97[collection1] realtime
   [junit4]   2> 220809 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-3&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:0 (-3)} 0 35
   [junit4]   2> 220810 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-7&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:2 (-7)} 0 31
   [junit4]   2> 220810 INFO  (WRITER5) [    ] o.a.s.u.UpdateHandler Reordered 
DBQs detected.  Update=add{_version_=5,id=35} DBQs=[DBQ{version=7,q=id:2}]
   [junit4]   2> 220810 INFO  (WRITER4) [    ] o.a.s.u.UpdateHandler Reordered 
DBQs detected.  Update=add{_version_=4,id=2} DBQs=[DBQ{version=7,q=id:2}]
   [junit4]   2> 220820 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@19230dba[collection1] realtime
   [junit4]   2> 220820 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(8)]} 0 39
   [junit4]   2> 220820 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(9)]} 0 40
   [junit4]   2> 220825 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@1076b568[collection1] realtime
   [junit4]   2> 220825 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2 
(4)]} 0 45
   [junit4]   2> 220826 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[35 
(5)]} 0 46
   [junit4]   2> 220826 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[25 
(10)]} 0 40
   [junit4]   2> 220826 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2 
(11)]} 0 16
   [junit4]   2> 220827 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 
(6)]} 0 46
   [junit4]   2> 220831 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@5f626a5e[collection1] realtime
   [junit4]   2> 220831 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-12&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:2 (-12)} 0 20
   [junit4]   2> 220833 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(13)]} 0 12
   [junit4]   2> 220833 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[5 
(17)]} 0 6
   [junit4]   2> 220833 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(15)]} 0 7
   [junit4]   2> 220833 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(14)]} 0 12
   [junit4]   2> 220833 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[21 
(19)]} 0 6
   [junit4]   2> 220834 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2 
(18)]} 0 6
   [junit4]   2> 220836 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[2 
(20)]} 0 4
   [junit4]   2> 220836 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[21 
(25)]} 0 1
   [junit4]   2> 220837 INFO  (WRITER2) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 220837 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[35 
(16)]} 0 10
   [junit4]   2> 220836 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(22)]} 0 1
   [junit4]   2> 220836 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[26 
(24)]} 0 2
   [junit4]   2> 220845 INFO  (WRITER2) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_2,generation=2}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_3,generation=3}
   [junit4]   2> 220845 INFO  (WRITER2) [    ] o.a.s.c.SolrCore newest commit 
generation = 3
   [junit4]   2> 220846 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@310dd5e3[collection1] main
   [junit4]   2> 220846 INFO  (WRITER2) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 220847 INFO  (searcherExecutor-584-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@310dd5e3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C2/1:delGen=1)
 Uninverting(_3(6.0.0):C1) Uninverting(_8(6.0.0):C6/3:delGen=1) 
Uninverting(_7(6.0.0):C4)))}
   [junit4]   2> 220847 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 12
   [junit4]   2> 220849 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-23&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:10 (-23)} 0 15
   [junit4]   2> 220852 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-21&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:13 (-21)} 0 16
   [junit4]   2> 220853 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[16 
(30)]} 0 10
   [junit4]   2> 220853 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[21 
(27)]} 0 10
   [junit4]   2> 220857 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@1be9b3a1[collection1] realtime
   [junit4]   2> 220857 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-29&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:16 (-29)} 0 14
   [junit4]   2> 220857 INFO  (WRITER5) [    ] o.a.s.u.UpdateHandler Reordered 
DBQs detected.  Update=add{_version_=28,id=32} DBQs=[DBQ{version=29,q=id:16}]
   [junit4]   2> 220911 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6ad136ce[collection1] realtime
   [junit4]   2> 220912 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[32 
(28)]} 0 69
   [junit4]   2> 220914 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@e5c6ff[collection1] realtime
   [junit4]   2> 220914 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-26&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:11 (-26)} 0 71
   [junit4]   2> 220915 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-31&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:10 (-31)} 0 65
   [junit4]   2> 220916 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[10 
(32)]} 0 65
   [junit4]   2> 220920 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@3a19adb3[collection1] realtime
   [junit4]   2> 220920 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-33&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:11 (-33)} 0 67
   [junit4]   2> 220921 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(34)]} 0 67
   [junit4]   2> 220921 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[17 
(36)]} 0 63
   [junit4]   2> 220921 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[17 
(35)]} 0 67
   [junit4]   2> 220927 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/'
   [junit4]   2> 220928 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/.svn/'
 to classloader
   [junit4]   2> 220928 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/classes/'
 to classloader
   [junit4]   2> 220928 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrResourceLoader Adding 
'file:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/lib/README'
 to classloader
   [junit4]   2> 220930 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@73029d32[collection1] realtime
   [junit4]   2> 220930 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-37&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:6 (-37)} 0 18
   [junit4]   2> 220932 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 
(39)]} 0 16
   [junit4]   2> 220939 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@541f4f0d[collection1] realtime
   [junit4]   2> 220939 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-38&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:5 (-38)} 0 23
   [junit4]   2> 220940 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[5 
(40)]} 0 23
   [junit4]   2> 220945 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@488fd84f[collection1] realtime
   [junit4]   2> 220947 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-42&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:8 (-42)} 0 25
   [junit4]   2> 220948 INFO  (WRITER1) [    ] 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:11 (-43)} 0 27
   [junit4]   2> 220949 INFO  (WRITER4) [    ] 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:11 (-41)} 0 28
   [junit4]   2> 220949 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(44)]} 0 27
   [junit4]   2> 220954 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@1752dd96[collection1] realtime
   [junit4]   2> 220954 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-46&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:34 (-46)} 0 22
   [junit4]   2> 220954 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(45)]} 0 23
   [junit4]   2> 220955 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 220956 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-47&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:27 (-47)} 0 16
   [junit4]   2> 220958 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-48&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:31 (-48)} 0 18
   [junit4]   2> 220960 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[35 
(49)]} 0 12
   [junit4]   2> 220965 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 220966 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@3b473b8[collection1] realtime
   [junit4]   2> 220967 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-50&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:23 (-50)} 0 17
   [junit4]   2> 220967 INFO  (WRITER4) [    ] 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 18
   [junit4]   2> 220973 INFO  (WRITER6) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@18ce0987[collection1] realtime
   [junit4]   2> 220973 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-52&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:11 (-52)} 0 23
   [junit4]   2> 220975 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[10 
(53)]} 0 20
   [junit4]   2> 220976 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[27 
(55)]} 0 19
   [junit4]   2> 220976 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[27 
(56)]} 0 17
   [junit4]   2> 220976 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(54)]} 0 21
   [junit4]   2> 220977 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.Config Loaded SolrConfig: solrconfig-tlog.xml
   [junit4]   2> 220977 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.IndexSchema Reading Solr Schema from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema15.xml
   [junit4]   2> 220982 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 221044 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@5ffa0652[collection1] realtime
   [junit4]   2> 221047 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(59)]} 0 79
   [junit4]   2> 221047 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[23 
(58)]} 0 80
   [junit4]   2> 221047 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[27 
(62)]} 0 71
   [junit4]   2> 221047 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[10 
(61)]} 0 71
   [junit4]   2> 221067 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@3cfc6c68[collection1] realtime
   [junit4]   2> 221068 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 221068 INFO  (WRITER0) [    ] 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:36 (-57)} 0 107
   [junit4]   2> 221069 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-63&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:27 (-63)} 0 92
   [junit4]   2> 221069 INFO  (WRITER6) [    ] o.a.s.u.UpdateHandler Reordered 
DBQs detected.  Update=add{_version_=60,id=11} DBQs=[DBQ{version=63,q=id:27}]
   [junit4]   2> 221069 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 221070 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 221072 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 221080 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
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-trunk/solr/core/src/test-files/solr/collection1/conf'
   [junit4]   2> 221081 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    ] 
o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/
   [junit4]   2> 221081 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/]
   [junit4]   2> 221081 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@6d71d4f9
   [junit4]   2> 221082 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/index/
   [junit4]   2> 221082 INFO  (WRITER6) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2ec4cb3e[collection1] realtime
   [junit4]   2> 221083 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[33 
(64)]} 0 106
   [junit4]   2> 221083 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(60)]} 0 105
   [junit4]   2> 221087 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@aeda151[collection1] realtime
   [junit4]   2> 221090 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-65&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:5 (-65)} 0 43
   [junit4]   2> 221091 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[4 
(66)]} 0 44
   [junit4]   2> 221094 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 221094 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-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestReloadDeadlock_8D9027F10AEAE137-001/init-core-data-001/
   [junit4]   2> 221094 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 221095 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 221095 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 221095 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 221095 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 221095 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 221095 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 221096 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 221098 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 221104 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 221106 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 221106 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@478de116[collection1] realtime
   [junit4]   2> 221107 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 221107 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(68)]} 0 58
   [junit4]   2> 221118 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@9bc9d6c[collection1] realtime
   [junit4]   2> 221120 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-69&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:29 (-69)} 0 51
   [junit4]   2> 221120 INFO  (WRITER5) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 221120 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-67&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:30 (-67)} 0 72
   [junit4]   2> 221124 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[27 
(70)]} 0 54
   [junit4]   2> 221124 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(71)]} 0 32
   [junit4]   2> 221127 INFO  (WRITER5) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_3,generation=3}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_4,generation=4}
   [junit4]   2> 221127 INFO  (WRITER5) [    ] o.a.s.c.SolrCore newest commit 
generation = 4
   [junit4]   2> 221133 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6c0adcee[collection1] main
   [junit4]   2> 221134 INFO  (searcherExecutor-584-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6c0adcee[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C2/1:delGen=1)
 Uninverting(_3(6.0.0):C1) Uninverting(_8(6.0.0):C6/5:delGen=2) 
Uninverting(_7(6.0.0):C4/3:delGen=1) Uninverting(_9(6.0.0):C2) 
Uninverting(_a(6.0.0):C1) Uninverting(_d(6.0.0):C2/1:delGen=1) 
Uninverting(_h(6.0.0):C1) Uninverting(_n(6.0.0):C1) Uninverting(_p(6.0.0):C1) 
Uninverting(_q(6.0.0):C1) Uninverting(_s(6.0.0):C1) Uninverting(_t(6.0.0):C1) 
Uninverting(_v(6.0.0):C1) Uninverting(_u(6.0.0):C1)))}
   [junit4]   2> 221135 INFO  (WRITER5) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 221135 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 221136 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 221137 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 53
   [junit4]   2> 221144 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-72&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:5 (-72)} 0 51
   [junit4]   2> 221144 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 221144 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 221147 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-73&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:22 (-73)} 0 54
   [junit4]   2> 221147 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@18f8e23d[collection1] realtime
   [junit4]   2> 221148 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@3d7417e5[collection1] 
main
   [junit4]   2> 221148 WARN  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf;
 switching to use InMemory storage instead.
   [junit4]   2> 221151 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 221151 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(74)]} 0 43
   [junit4]   2> 221151 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
InMemoryStorage
   [junit4]   2> 221152 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 221152 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 221153 INFO  
(searcherExecutor-589-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3d7417e5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C2/1:delGen=1)
 Uninverting(_3(6.0.0):C1) Uninverting(_8(6.0.0):C6/5:delGen=2) 
Uninverting(_7(6.0.0):C4/3:delGen=1) Uninverting(_9(6.0.0):C2) 
Uninverting(_a(6.0.0):C1) Uninverting(_d(6.0.0):C2/1:delGen=1) 
Uninverting(_h(6.0.0):C1) Uninverting(_n(6.0.0):C1) Uninverting(_p(6.0.0):C1) 
Uninverting(_q(6.0.0):C1) Uninverting(_s(6.0.0):C1) Uninverting(_t(6.0.0):C1) 
Uninverting(_v(6.0.0):C1) Uninverting(_u(6.0.0):C1)))}
   [junit4]   2> 221153 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed 
version buckets
   [junit4]   2> 221157 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@5619cbd1[collection1] realtime
   [junit4]   2> 221157 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-76&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:35 (-76)} 0 36
   [junit4]   2> 221160 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-75&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:28 (-75)} 0 37
   [junit4]   2> 221162 INFO  (WRITER2) [    ] 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:30 (-77)} 0 37
   [junit4]   2> 221163 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[30 
(78)]} 0 38
   [junit4]   2> 221172 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@4abec0a4[collection1] realtime
   [junit4]   2> 221172 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[7 
(79)]} 0 32
   [junit4]   2> 221173 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[22 
(81)]} 0 25
   [junit4]   2> 221174 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(82)]} 0 22
   [junit4]   2> 221175 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 
65536 version buckets from index
   [junit4]   2> 221179 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.VersionInfo Found MAX value 71 from Terms for _version_ 
in index
   [junit4]   2> 221181 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.UpdateLog Took 6.0ms to seed version buckets with 
highest version 82
   [junit4]   2> 221181 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState Creating new IndexWriter...
   [junit4]   2> 221182 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is 
unused... core=collection1
   [junit4]   2> 221182 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... 
core=collection1
   [junit4]   2> 221182 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-80&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:5 (-80)} 0 32
   [junit4]   2> 221240 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_4,generation=4}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_5,generation=5}
   [junit4]   2> 221240 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 5
   [junit4]   2> 221242 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.1455078125, 
noCFSRatio=0.6085662599649047]
   [junit4]   2> 221252 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_5,generation=5}
   [junit4]   2> 221252 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore newest commit generation = 5
   [junit4]   2> 221258 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 221259 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[31 
(84)]} 0 98
   [junit4]   2> 221276 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@57197e66[collection1] realtime
   [junit4]   2> 221277 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@61386340[collection1] 
main
   [junit4]   2> 221277 INFO  (WRITER3) [    ] o.a.s.u.UpdateHandler Reordered 
DBQs detected.  Update=add{_version_=83,id=31} DBQs=[DBQ{version=85,q=id:31}]
   [junit4]   2> 221278 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.CoreContainer replacing core: collection1
   [junit4]   2> 221280 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@12accaeb
   [junit4]   2> 221281 INFO  
(searcherExecutor-589-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@61386340[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(6.0.0):C2/1:delGen=1)
 Uninverting(_3(6.0.0):C1) Uninverting(_8(6.0.0):C6/5:delGen=2) 
Uninverting(_7(6.0.0):C4/3:delGen=1) Uninverting(_9(6.0.0):C2) 
Uninverting(_a(6.0.0):C1) Uninverting(_d(6.0.0):C2/1:delGen=1) 
Uninverting(_n(6.0.0):C1) Uninverting(_p(6.0.0):C1) Uninverting(_q(6.0.0):C1) 
Uninverting(_s(6.0.0):C1) Uninverting(_v(6.0.0):C1) Uninverting(_u(6.0.0):C1) 
Uninverting(_x(6.0.0):C1) Uninverting(_y(6.0.0):C1) Uninverting(_z(6.0.0):C2)))}
   [junit4]   2> 221282 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-85&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:31 (-85)} 0 119
   [junit4]   2> 221293 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@660da09b[collection1] realtime
   [junit4]   2> 221293 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6 
(86)]} 0 129
   [junit4]   2> 221294 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.u.UpdateHandler closing 
DirectUpdateHandler2{commits=3,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=6,adds=8,deletesById=0,deletesByQuery=7,errors=1,cumulative_adds=54,cumulative_deletesById=0,cumulative_deletesByQuery=32,cumulative_errors=1,transaction_logs_total_size=2131,transaction_logs_total_number=2}
   [junit4]   2> 221294 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[31 
(83)]} 0 130
   [junit4]   2> 221294 INFO  
(TEST-TestReloadDeadlock.testReloadDeadlock-seed#[8D9027F10AEAE137]) [    
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 221295 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[14 
(90)]} 0 112
   [junit4]   2> 221296 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(87)]} 0 123
   [junit4]   2> 221296 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(89)]} 0 120
   [junit4]   2> 221296 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[21 
(88)]} 0 122
   [junit4]   2> 221366 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2c8d0dbc[collection1] realtime
   [junit4]   2> 221367 INFO  (WRITER0) [    ] 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:10 (-91)} 0 107
   [junit4]   2> 221369 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[31 
(92)]} 0 86
   [junit4]   2> 221369 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[6 
(93)]} 0 75
   [junit4]   2> 221369 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[18 
(94)]} 0 74
   [junit4]   2> 221379 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@a1244a7[collection1] realtime
   [junit4]   2> 221381 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(96)]} 0 85
   [junit4]   2> 221387 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@2a99f4c3[collection1] realtime
   [junit4]   2> 221442 INFO  (WRITER1) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@5cfea1c2[collection1] realtime
   [junit4]   2> 221443 INFO  (WRITER1) [    ] 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:4 (-98)} 0 146
   [junit4]   2> 221443 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-95&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:14 (-95)} 0 147
   [junit4]   2> 221443 INFO  (WRITER7) [    ] 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:36 (-97)} 0 146
   [junit4]   2> 221446 INFO  (WRITER0) [    ] 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:10 (-99)} 0 78
   [junit4]   2> 221446 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[4 
(100)]} 0 77
   [junit4]   2> 221447 INFO  (WRITER6) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[20 
(101)]} 0 77
   [junit4]   2> 221447 INFO  (WRITER3) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 221448 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(102)]} 0 66
   [junit4]   2> 221448 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[36 
(105)]} 0 3
   [junit4]   2> 221449 INFO  (WRITER2) [    ] 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 2
   [junit4]   2> 221451 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(103)]} 0 6
   [junit4]   2> 221451 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[25 
(106)]} 0 5
   [junit4]   2> 221509 INFO  (WRITER3) [    ] o.a.s.c.SolrCore 
SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_5,generation=5}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@7392ff6b 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6b8f7a9d),segFN=segments_6,generation=6}
   [junit4]   2> 221509 INFO  (WRITER3) [    ] o.a.s.c.SolrCore newest commit 
generation = 6
   [junit4]   2> 221518 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6d55c73d[collection1] main
   [junit4]   2> 221520 INFO  (searcherExecutor-589-thread-1) [    ] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6d55c73d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_8(6.0.0):C6/5:delGen=2)
 Uninverting(_7(6.0.0):C4/3:delGen=1) Uninverting(_9(6.0.0):C2/1:delGen=1) 
Uninverting(_a(6.0.0):C1) Uninverting(_d(6.0.0):C2/1:delGen=1) 
Uninverting(_n(6.0.0):C1) Uninverting(_q(6.0.0):C1) Uninverting(_u(6.0.0):C1) 
Uninverting(_x(6.0.0):C1) Uninverting(_y(6.0.0):C1) 
Uninverting(_z(6.0.0):C2/1:delGen=1) Uninverting(_14(6.0.0):C1) 
Uninverting(_15(6.0.0):C1) Uninverting(_19(6.0.0):C1) 
Uninverting(_17(6.0.0):C1) Uninverting(_18(6.0.0):C1) 
Uninverting(_1b(6.0.0):C2) Uninverting(_1d(6.0.0):C3/1:delGen=1) 
Uninverting(_1c(6.0.0):C2/1:delGen=1)))}
   [junit4]   2> 221521 INFO  (WRITER3) [    ] o.a.s.u.UpdateHandler 
end_commit_flush
   [junit4]   2> 221522 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null params={} {commit=} 0 152
   [junit4]   2> 221525 INFO  (WRITER4) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6e0fd7f3[collection1] realtime
   [junit4]   2> 221525 INFO  (WRITER4) [    ] 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:11 (-104)} 0 77
   [junit4]   2> 221526 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 
(108)]} 0 78
   [junit4]   2> 221526 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(109)]} 0 76
   [junit4]   2> 221526 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(110)]} 0 76
   [junit4]   2> 221540 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@7cf73fa6[collection1] realtime
   [junit4]   2> 221540 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-111&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:12 (-111)} 0 89
   [junit4]   2> 221541 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[32 
(113)]} 0 89
   [junit4]   2> 221541 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[11 
(112)]} 0 89
   [junit4]   2> 221550 INFO  (WRITER3) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@6ee2ffa7[collection1] realtime
   [junit4]   2> 221551 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 
(116)]} 0 24
   [junit4]   2> 221552 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-114&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:32 (-114)} 0 27
   [junit4]   2> 221551 INFO  (WRITER4) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[4 
(115)]} 0 25
   [junit4]   2> 221559 INFO  (WRITER5) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@1fffdc5a[collection1] realtime
   [junit4]   2> 221560 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-117&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:14 (-117)} 0 32
   [junit4]   2> 221562 INFO  (WRITER2) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@63a12064[collection1] realtime
   [junit4]   2> 221563 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-118&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:11 (-118)} 0 35
   [junit4]   2> 221565 INFO  (WRITER7) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@407d412f[collection1] realtime
   [junit4]   2> 221566 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-119&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:7 (-119)} 0 25
   [junit4]   2> 221569 INFO  (WRITER0) [    ] o.a.s.s.SolrIndexSearcher 
Opening Searcher@5cbff730[collection1] realtime
   [junit4]   2> 221569 INFO  (WRITER0) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={_version_=-120&update.distrib=FROMLEADER&versions=true&wt=json&indent=true}
 {deleteByQuery=id:17 (-120)} 0 28
   [junit4]   2> 221571 INFO  (WRITER4) [    ] o.a.s.u.UpdateHandler start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 221573 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 
(121)]} 0 31
   [junit4]   2> 221574 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 
(122)]} 0 22
   [junit4]   2> 221575 INFO  (WRITER3) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(123)]} 0 22
   [junit4]   2> 221576 INFO  (WRITER7) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[21 
(126)]} 0 3
   [junit4]   2> 221576 INFO  (WRITER1) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[10 
(128)]} 0 2
   [junit4]   2> 221577 INFO  (WRITER2) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 
(125)]} 0 13
   [junit4]   2> 221578 INFO  (WRITER5) [    ] o.a.s.u.p.LogUpdateProcessor 
[collection1] webapp=null path=null 
params={update.distrib=FROMLEADER&versions=true&wt=json&indent=true} {add=[13 (1

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

r.java:1720)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:197)
   [junit4]   2>        at 
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:50)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:497)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> Caused by: java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
   [junit4]   2>        at 
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
   [junit4]   2>        ... 53 more
   [junit4]   2> 3621445 INFO  
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[8D9027F10AEAE137]-worker) 
[n:127.0.0.1:55790_pdt%2Fr c:addReplicaColl s:shard1 r:core_node7 
x:propertyDotName] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> Aug 14, 2015 11:58:25 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene53): 
{other_tl1=PostingsFormat(name=Asserting), 
range_facet_l_dv=PostingsFormat(name=LuceneFixedGap), 
_version_=PostingsFormat(name=Asserting), multiDefault=Lucene50(blocksize=128), 
a_t=Lucene50(blocksize=128), intDefault=PostingsFormat(name=Asserting), 
a_i1=Lucene50(blocksize=128), id=PostingsFormat(name=LuceneFixedGap), 
range_facet_i_dv=Lucene50(blocksize=128), text=FSTOrd50, 
range_facet_l=Lucene50(blocksize=128), timestamp=Lucene50(blocksize=128)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Asserting), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, 
sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=da, 
timezone=Europe/Belfast
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_45 (64-bit)/cpus=4,threads=2,free=90568080,total=524812288
   [junit4]   2> NOTE: All tests run in this JVM: [TestBM25SimilarityFactory, 
ResponseLogComponentTest, HdfsWriteToMultipleCollectionsTest, 
TestSurroundQueryParser, NumericFieldsTest, DistributedIntervalFacetingTest, 
CloudMLTQParserTest, SearchHandlerTest, QueryParsingTest, 
MoreLikeThisHandlerTest, SolrCoreCheckLockOnStartupTest, TestCrossCoreJoin, 
BadIndexSchemaTest, TestRemoveLastDynamicCopyField, SolrInfoMBeanTest, 
PKIAuthenticationIntegrationTest, CoreAdminCreateDiscoverTest, AutoCommitTest, 
SimpleCollectionCreateDeleteTest, RequestLoggingTest, TestBulkSchemaConcurrent, 
CursorPagingTest, TestSchemaVersionResource, SynonymTokenizerTest, 
TestFieldSortValues, HdfsRecoveryZkTest, TestFieldResource, SOLR749Test, 
LeaderElectionTest, SortByFunctionTest, TestSolrCLIRunExample, 
TestRuleBasedAuthorizationPlugin, HLLSerializationTest, 
HdfsDirectoryFactoryTest, TestNonDefinedSimilarityFactory, VersionInfoTest, 
TestRandomMergePolicy, RollingRestartTest, StatsComponentTest, 
HardAutoCommitTest, SpatialHeatmapFacetsTest, TestPartialUpdateDeduplication, 
PathHierarchyTokenizerFactoryTest, TestSQLHandler, ExitableDirectoryReaderTest, 
OverseerTest, OverseerCollectionProcessorTest, SampleTest, 
SuggestComponentTest, TestCloudSchemaless, InfoHandlerTest, 
DistributedQueryElevationComponentTest, TestStressReorder, 
TestRequestStatusCollectionAPI, TestPseudoReturnFields, OutputWriterTest, 
TestSortingResponseWriter, TestMiniSolrCloudClusterSSL, TestCSVResponseWriter, 
TestSort, VMParamsZkACLAndCredentialsProvidersTest, ActionThrottleTest, 
CleanupOldIndexTest, ResponseHeaderTest, TestExactSharedStatsCache, 
DOMUtilTest, TestDynamicLoading, TestEmbeddedSolrServerConstructors, 
CoreAdminRequestStatusTest, UnloadDistributedZkTest, TestDocSet, 
TestCloudManagedSchema, TestCursorMarkWithoutUniqueKey, 
TestRandomRequestDistribution, OverriddenZkACLAndCredentialsProvidersTest, 
TestSystemIdResolver, FullSolrCloudDistribCmdsTest, HdfsLockFactoryTest, 
TestBulkSchemaAPI, XmlUpdateRequestHandlerTest, TestDistribDocBasedVersion, 
PrimUtilsTest, TestSchemaSimilarityResource, TestRecovery, TestSearcherReuse, 
TestCollationField, ClusterStateUpdateTest, TestRandomFaceting, TestZkChroot, 
TestRandomDVFaceting, TestDistributedGrouping, TestHashPartitioner, 
TermVectorComponentDistributedTest, ZkControllerTest, TestReload, 
TestStressVersions, SimpleFacetsTest, SpellCheckComponentTest, 
TestGroupingSearch, SolrCmdDistributorTest, TestLazyCores, 
DirectUpdateHandlerTest, TestIndexSearcher, SoftAutoCommitTest, 
CurrencyFieldOpenExchangeTest, SolrIndexSplitterTest, SimplePostToolTest, 
SignatureUpdateProcessorFactoryTest, TestExtendedDismaxParser, 
SpellCheckCollatorTest, SolrRequestParserTest, DocValuesTest, SuggesterTest, 
TestTrie, SuggesterWFSTTest, WordBreakSolrSpellCheckerTest, QueryEqualityTest, 
TestRemoteStreaming, DistanceFunctionTest, XsltUpdateRequestHandlerTest, 
DebugComponentTest, TestQueryUtils, TestWriterPerf, FileBasedSpellCheckerTest, 
TermVectorComponentTest, TestSolrQueryParser, IndexSchemaRuntimeFieldTest, 
RegexBoostProcessorTest, TestJmxIntegration, TestAnalyzedSuggestions, 
BinaryUpdateRequestHandlerTest, PingRequestHandlerTest, 
TestBinaryResponseWriter, TestQuerySenderNoQuery, TestStressRecovery, 
TestSuggestSpellingConverter, SpellingQueryConverterTest, 
RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestUtils, 
TestDocumentBuilder, ZkNodePropsTest, SystemInfoHandlerTest, UUIDFieldTest, 
FileUtilsTest, CircularListTest, DistributedMLTComponentTest, 
TestSimpleTrackingShardHandler, TestTolerantSearch, TestJettySolrRunner, 
AliasIntegrationTest, AsyncCallRequestStatusResponseTest, 
BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest, 
SharedFSAutoReplicaFailoverUtilsTest, TestAuthenticationFramework, 
TestCloudInspectUtil, TestCloudPivotFacet, TestLeaderElectionZkExpiry, 
TestReplicaProperties, HdfsBasicDistributedZk2Test, 
HdfsCollectionsAPIDistributedZkTest]
   [junit4] Completed [468/540] on J2 in 499.65s, 1 test, 1 error <<< FAILURES!

[...truncated 242 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:514:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1429:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:984:
 There were test failures: 540 suites, 2131 tests, 3 errors, 1 failure, 26 
ignored (14 assumptions)

Total time: 186 minutes 14 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to