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

6 tests failed.
FAILED:  org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test

Error Message:
Exactly one shard should have changed, instead: [shard2, shard1] 
nodes=([core_node2(shard1), core_node4(shard1), core_node3(shard2)]) 
expected:<1> but was:<2>

Stack Trace:
java.lang.AssertionError: Exactly one shard should have changed, instead: 
[shard2, shard1] nodes=([core_node2(shard1), core_node4(shard1), 
core_node3(shard2)]) expected:<1> but was:<2>
        at 
__randomizedtesting.SeedInfo.seed([D6A8934F3CFE4FB5:5EFCAC959202224D]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test(DistribDocExpirationUpdateProcessorTest.java:119)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest

Error Message:
3 threads leaked from SUITE scope at 
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest:     1) 
Thread[id=43709, name=searcherExecutor-9453-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) 
        at java.lang.Thread.run(Thread.java:745)    2) Thread[id=43724, 
name=searcherExecutor-9421-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) 
        at java.lang.Thread.run(Thread.java:745)    3) Thread[id=44215, 
name=searcherExecutor-9719-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 3 threads leaked from SUITE 
scope at org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest: 
   1) Thread[id=43709, name=searcherExecutor-9453-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
   2) Thread[id=43724, name=searcherExecutor-9421-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
   3) Thread[id=44215, name=searcherExecutor-9719-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([D6A8934F3CFE4FB5]:0)


FAILED:  
junit.framework.TestSuite.org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=43709, name=searcherExecutor-9453-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) 
        at java.lang.Thread.run(Thread.java:745)    2) Thread[id=43724, 
name=searcherExecutor-9421-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) 
        at java.lang.Thread.run(Thread.java:745)    3) Thread[id=44215, 
name=searcherExecutor-9719-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]         at 
sun.misc.Unsafe.park(Native Method)         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=43709, name=searcherExecutor-9453-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
   2) Thread[id=43724, name=searcherExecutor-9421-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
   3) Thread[id=44215, name=searcherExecutor-9719-thread-1, state=WAITING, 
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:186)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2043)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1068)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1130)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([D6A8934F3CFE4FB5]:0)


FAILED:  
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([D6A8934F3CFE4FB5:C912E2B8EC9E8970]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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

Error Message:
Timeout occured while waiting response from server at: http://127.0.0.1:37946

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting 
response from server at: http://127.0.0.1:37946
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:586)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:400)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:516)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:179)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:606)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.read(SocketInputStream.java:152)
        at java.net.SocketInputStream.read(SocketInputStream.java:122)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
        at 
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
        at 
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
        at 
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
        at 
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
        at 
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
        at 
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
        at 
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
        at 
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
        ... 47 more


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

Error Message:
Captured an uncaught exception in thread: Thread[id=15488, name=collection3, 
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=15488, name=collection3, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:38471/l/jn: collection already exists: 
awholynewstresscollection_collection3_0
        at __randomizedtesting.SeedInfo.seed([D6A8934F3CFE4FB5]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
        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:1121)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:891)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:827)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1575)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1596)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:984)




Build Log:
[...truncated 12031 lines...]
   [junit4] Suite: org.apache.solr.cloud.CollectionsAPIDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/init-core-data-001
   [junit4]   2> 2878475 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[D6A8934F3CFE4FB5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
   [junit4]   2> 2878475 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[D6A8934F3CFE4FB5]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /l/jn
   [junit4]   2> 2878480 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2878482 INFO  (Thread-8567) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2878482 INFO  (Thread-8567) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2878598 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:48649
   [junit4]   2> 2878598 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2878599 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2878618 INFO  (zkCallback-1300-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@11dfa0 name:ZooKeeperConnection 
Watcher:127.0.0.1:48649 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 2878618 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2878618 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2878618 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2878621 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2878630 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2878630 INFO  (zkCallback-1301-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@4571b64d 
name:ZooKeeperConnection Watcher:127.0.0.1:48649/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2878630 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2878631 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2878631 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 2878632 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 2878633 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 2878634 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 2878635 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 2878635 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 2878637 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 2878637 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 2878639 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2878639 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2878640 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 2878640 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 2878642 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 2878642 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 2878650 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 2878651 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 2878652 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 2878652 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 2878653 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2878653 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 2878654 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2878654 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2878655 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 2878655 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 2878657 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 2878657 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 2878668 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2878679 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2878682 INFO  (zkCallback-1302-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@34396be9 
name:ZooKeeperConnection Watcher:127.0.0.1:48649 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2878682 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2878683 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2878683 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 2878690 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2878710 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2878711 INFO  (zkCallback-1303-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@525ac59f 
name:ZooKeeperConnection Watcher:127.0.0.1:48649/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2878711 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2878711 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2878712 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf2/solrconfig.xml
   [junit4]   2> 2878712 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
   [junit4]   2> 2878714 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf2/schema.xml
   [junit4]   2> 2878718 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
   [junit4]   2> 2878719 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf2/enumsConfig.xml
   [junit4]   2> 2878720 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
   [junit4]   2> 2878721 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2878721 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 2878722 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf2/stopwords.txt
   [junit4]   2> 2878722 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
   [junit4]   2> 2878724 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf2/protwords.txt
   [junit4]   2> 2878724 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
   [junit4]   2> 2878725 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf2/currency.xml
   [junit4]   2> 2878725 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
   [junit4]   2> 2878726 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf2/open-exchange-rates.json
   [junit4]   2> 2878726 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
   [junit4]   2> 2878727 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2878727 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
   [junit4]   2> 2878728 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf2/old_synonyms.txt
   [junit4]   2> 2878729 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
   [junit4]   2> 2878734 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf2/synonyms.txt
   [junit4]   2> 2878734 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
   [junit4]   2> 2878735 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/core/src/test-files/solr/collection1/conf/elevate.xml
 to /configs/conf2/elevate.xml
   [junit4]   2> 2878735 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
   [junit4]   2> 2878845 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1
   [junit4]   2> 2878862 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 2878872 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6621224a{/l/jn,null,AVAILABLE}
   [junit4]   2> 2878872 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@9525ca8{HTTP/1.1}{127.0.0.1:38471}
   [junit4]   2> 2878872 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.e.j.s.Server Started @2883197ms
   [junit4]   2> 2878872 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostPort=38471, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores,
 hostContext=/l/jn, 
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/tempDir-001/control/data}
   [junit4]   2> 2878872 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@3836b1bb
   [junit4]   2> 2878873 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001'
   [junit4]   2> 2878873 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2878873 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2878873 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2878874 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2878895 INFO  (zkCallback-1304-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7ae97da4 
name:ZooKeeperConnection Watcher:127.0.0.1:48649/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2878896 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2878896 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2878897 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 2878897 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/solr.xml
   [junit4]   2> 2878909 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores
   [junit4]   2> 2878909 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 356317489
   [junit4]   2> 2878909 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001]
   [junit4]   2> 2878909 WARN  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/lib
   [junit4]   2> 2878909 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 2878912 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 2878913 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 2878913 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 2878913 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48649/solr
   [junit4]   2> 2878913 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 2878913 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 2878918 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 2878918 INFO  (zkCallback-1307-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@30b7d817 
name:ZooKeeperConnection Watcher:127.0.0.1:48649 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2878918 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 2878919 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 2878946 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.ZkController Added new OnReconnect 
listener org.apache.solr.cloud.ZkController$6@30e5be49
   [junit4]   2> 2878947 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.ConnectionManager Waiting for client 
to connect to ZooKeeper
   [junit4]   2> 2878958 INFO  
(zkCallback-1308-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@576ae7f7 
name:ZooKeeperConnection Watcher:127.0.0.1:48649/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 2878958 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.ConnectionManager Client is connected 
to ZooKeeper
   [junit4]   2> 2878966 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 2878990 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 2879000 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 2879002 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 2879003 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 2879008 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 2879009 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 2879010 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/clusterstate.json
   [junit4]   2> 2879011 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 2879011 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38471_l%2Fjn
   [junit4]   2> 2879012 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:38471_l%2Fjn
   [junit4]   2> 2879134 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 2879166 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 2879182 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2879183 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.LeaderElector Joined leadership election 
with path: 
/overseer_elect/election/96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000
   [junit4]   2> 2879183 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:38471_l%2Fjn
   [junit4]   2> 2879183 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/leader
   [junit4]   2> 2879184 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.Overseer Overseer 
(id=96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000) starting
   [junit4]   2> 2879185 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue-work
   [junit4]   2> 2879191 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.OverseerAutoReplicaFailoverThread 
Starting OverseerAutoReplicaFailoverThread 
autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=10000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 2879194 INFO  
(OverseerCollectionConfigSetProcessor-96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000)
 [n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.OverseerTaskProcessor Process current 
queue of overseer operations
   [junit4]   2> 2879195 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.ZkStateReader Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 2879199 INFO  
(OverseerStateUpdate-96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.Overseer Starting to work on the main 
queue
   [junit4]   2> 2879247 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.CoreContainer Security conf doesn't 
exist. Skipping setup for authorization module.
   [junit4]   2> 2879247 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.CoreContainer No authentication plugin 
used.
   [junit4]   2> 2879248 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores
   [junit4]   2> 2879248 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{coreNodeName=, loadOnStartup=true, collection=control_collection, 
configSetProperties=configsetprops.json, schema=schema.xml, 
config=solrconfig.xml, shard=, dataDir=data/, transient=false, name=collection1}
   [junit4]   2> 2879248 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.CorePropertiesLocator Found core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1
   [junit4]   2> 2879248 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.CorePropertiesLocator Found 1 core 
definitions
   [junit4]   2> 2879262 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1
   [junit4]   2> 2879262 INFO  
(TEST-CollectionsAPIDistributedZkTest.test-seed#[D6A8934F3CFE4FB5]) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.s.SolrDispatchFilter 
SolrDispatchFilter.init() done
   [junit4]   2> 2879266 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController publishing state=down
   [junit4]   2> 2879266 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController numShards not found on descriptor - reading it from system 
property
   [junit4]   2> 2879290 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection control_collection not visible yet, but 
flagging it so a watch is registered when it becomes visible
   [junit4]   2> 2879290 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader addZkWatch [control_collection]
   [junit4]   2> 2879291 INFO  
(OverseerStateUpdate-96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "node_name":"127.0.0.1:38471_l%2Fjn",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "base_url":"http://127.0.0.1:38471/l/jn";,
   [junit4]   2>   "shard":null,
   [junit4]   2>   "state":"down"} current state version: 0
   [junit4]   2> 2879302 INFO  
(OverseerStateUpdate-96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.o.ReplicaMutator Update state 
numShards=1 message={
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "node_name":"127.0.0.1:38471_l%2Fjn",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "operation":"state",
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "base_url":"http://127.0.0.1:38471/l/jn";,
   [junit4]   2>   "shard":null,
   [junit4]   2>   "state":"down"}
   [junit4]   2> 2879302 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Deleting data for [control_collection]
   [junit4]   2> 2879302 INFO  
(OverseerStateUpdate-96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: control_collection
   [junit4]   2> 2879310 INFO  
(OverseerStateUpdate-96564783194701830-127.0.0.1:38471_l%2Fjn-n_0000000000) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.o.ReplicaMutator Assigning new node to 
shard shard=shard1
   [junit4]   2> 2879318 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController look for our core node name
   [junit4]   2> 2879334 INFO  
(zkCallback-1308-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/clusterstate.json], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 2880326 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
   [junit4]   2> 2880326 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController Check for collection zkNode:control_collection
   [junit4]   2> 2880333 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 2880333 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 2880338 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 2880338 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1'
   [junit4]   2> 2880338 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 2880338 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 2880340 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] o.a.s.c.Config 
loaded config solrconfig.xml with version 0 
   [junit4]   2> 2880344 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 2880409 WARN  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] o.a.s.c.Config 
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> 
instead.
   [junit4]   2> 2880424 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.3
   [junit4]   2> 2880483 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 2880497 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 2881050 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 2881058 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.IndexSchema default search field in schema is text
   [junit4]   2> 2881059 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 2881069 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 2881071 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 2881073 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2881074 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 2881075 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/configs/conf1', 
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1
   [junit4]   2> 2881075 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection   x:collection1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
collection control_collection
   [junit4]   2> 2881075 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 2881076 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data/]
   [junit4]   2> 2881076 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@70f44ad5
   [junit4]   2> 2881076 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data
   [junit4]   2> 2881076 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data/index/
   [junit4]   2> 2881076 WARN  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 2881077 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data/index
   [junit4]   2> 2881077 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=1.88671875, 
noCFSRatio=0.251538182541141]
   [junit4]   2> 2881077 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@5ea89902 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ed582db),segFN=segments_1,generation=1}
   [junit4]   2> 2881077 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 2881080 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "nodistrib"
   [junit4]   2> 2881080 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "dedupe"
   [junit4]   2> 2881080 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 2881080 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2881080 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 2881080 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
   [junit4]   2> 2881081 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating 
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
   [junit4]   2> 2881081 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain 
"distrib-dup-test-chain-implicit"
   [junit4]   2> 2881081 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 2881081 WARN  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler 
{type = requestHandler,name = /dump,class = DumpRequestHandler,args = 
{defaults={a=A,b=B}}}
   [junit4]   2> 2881082 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:38471_l%2Fjn 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
Looking for old index directories to cleanup for core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data/
   [junit4]   2> 2881082 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:38471_l%2Fjn 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIDistributedZkTest_D6A8934F3CFE4FB5-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 2881082 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2881083 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2881084 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2881085 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 2881087 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/plugins,/admin/ping,/dump,/admin/properties,/config,/replication,/admin/luke,/update,/admin/logging,standard,/update/json,/admin/mbeans,/admin/system,/admin/segments,/admin/file,/update/csv,/update/json/docs,/admin/threads,/get,/schema
   [junit4]   2> 2881089 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 2881089 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 2881089 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2881090 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 2881090 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 2881090 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 2881090 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@5ea89902 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ed582db),segFN=segments_1,generation=1}
   [junit4]   2> 2881090 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 2881091 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2ed73866[collection1] 
main
   [junit4]   2> 2881091 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: 
[/collections/control_collection]
   [junit4]   2> 2881091 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection] 
[configName]=[conf1] specified config exists in ZooKeeper
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based 
storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO 
with znodeBase: /configs/conf1
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode 
/configs/conf1/_rest_managed.json
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 2881092 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 2881093 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 2881093 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed 
version buckets
   [junit4]   2> 2881093 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 
65536 version buckets from index
   [junit4]   2> 2881093 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed 
version bucket highest value from index
   [junit4]   2> 2881093 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1545036533852012544
   [junit4]   2> 2881095 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with 
highest version 1545036533852012544
   [junit4]   2> 2881095 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 2881095 INFO  
(coreLoadExecutor-4386-thread-1-processing-n:127.0.0.1:38471_l%2Fjn) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 2881096 INFO  
(searcherExecutor-4387-thread-1-processing-n:127.0.0.1:38471_l%2Fjn 
c:control_collection x:collection1 r:core_node1 s:shard1) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2ed73866[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2881096 INFO  
(coreZkRegister-4380-thread-1-processing-n:127.0.0.1:38471_l%2Fjn 
c:control_collection x:collection1 r:core_node1 s:shard1) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:shard1 r:core_node1 
x:collection1] o.a.s.c.ZkController Register replica - core:collection1 
address:http://127.0.0.1:38471/l/jn collection:control_collection shard:shard1
   [junit4]   2> 2881097 INFO  
(coreZkRegister-4380-thread-1-processing-n:127.0.0.1:38471_l%2Fjn 
c:control_collection x:collection1 r:core_node1 s:shard1) 
[n:127.0.0.1:38471_l%2Fjn c:control_collection s:s

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

o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 6145572 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 6145576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 6145576 INFO  (zkCallback-26987-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@30b345cc 
name:ZooKeeperConnection Watcher:127.0.0.1:46543 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 6145576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 6145576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 6145576 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 6145580 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 6145581 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 6145581 INFO  (zkCallback-26988-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@67df1a42 
name:ZooKeeperConnection Watcher:127.0.0.1:46543/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 6145581 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 6145582 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 6145582 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 6145583 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 6145583 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 6145591 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 6145592 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 6145593 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 6145594 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 6145594 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 6145594 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 6145596 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 6145612 INFO  (zkCallback-26988-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 6145612 INFO  (zkCallback-26988-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 6145623 INFO  (zkCallback-26988-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 6145677 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:46543 46543
   [junit4]   2> 6145678 INFO  (Thread-61721) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:46543 46543
   [junit4]   2> 6145687 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[D6A8934F3CFE4FB5]) 
[    ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 6145687 INFO  
(SUITE-ZkStateReaderTest-seed#[D6A8934F3CFE4FB5]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.overseer.ZkStateReaderTest_D6A8934F3CFE4FB5-001
   [junit4]   2> Sep 09, 2016 11:48:45 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(Lucene54): {}, 
docValues:{}, sim=DefaultSimilarity, locale=es-CL, timezone=Pacific/Efate
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.7.0_80 (64-bit)/cpus=4,threads=1,free=166186600,total=520617984
   [junit4]   2> NOTE: All tests run in this JVM: 
[DistributedQueryComponentCustomSortTest, TestExactSharedStatsCache, 
DirectoryFactoryTest, LeaderElectionIntegrationTest, CleanupOldIndexTest, 
TestRecoveryHdfs, PeerSyncTest, RequestLoggingTest, 
RecoveryAfterSoftCommitTest, TestBinaryField, BasicAuthIntegrationTest, 
DefaultValueUpdateProcessorTest, OverseerStatusTest, TestFieldResource, 
TestPseudoReturnFields, TestClassNameShortening, TestAnalyzedSuggestions, 
TestConfigSetProperties, SynonymTokenizerTest, TestRebalanceLeaders, 
TestRandomCollapseQParserPlugin, TestNRTOpen, CurrencyFieldOpenExchangeTest, 
TestXmlQParser, TestCryptoKeys, MergeStrategyTest, SolrCoreTest, DateFieldTest, 
ZkNodePropsTest, TestSolrQueryResponse, AsyncCallRequestStatusResponseTest, 
TestOrdValues, TestMiniSolrCloudClusterSSL, TestIntervalFaceting, 
TestOmitPositions, TestBlendedInfixSuggestions, IndexSchemaTest, 
AnalyticsMergeStrategyTest, HdfsRecoverLeaseTest, RAMDirectoryFactoryTest, 
TestRandomFaceting, TestMergePolicyConfig, TestMissingGroups, 
ChangedSchemaMergeTest, TestHashQParserPlugin, QueryElevationComponentTest, 
SharedFSAutoReplicaFailoverUtilsTest, TestPKIAuthenticationPlugin, 
TestFoldingMultitermQuery, TestDistributedSearch, RulesTest, 
TestSolrConfigHandlerCloud, HdfsSyncSliceTest, TestArbitraryIndexDir, 
TestCSVLoader, TestIBSimilarityFactory, DeleteInactiveReplicaTest, 
TestPhraseSuggestions, TestRangeQuery, TestImplicitCoreProperties, 
CoreAdminRequestStatusTest, TestLuceneMatchVersion, 
DistributedFacetPivotSmallAdvancedTest, ResourceLoaderTest, 
TestSolrConfigHandler, AlternateDirectoryTest, ConnectionReuseTest, 
TestRealTimeGet, TestReplicationHandler, TestCustomDocTransformer, 
EnumFieldTest, OutputWriterTest, CacheHeaderTest, SolrXmlInZkTest, 
TestRemoveLastDynamicCopyField, TestPivotHelperCode, DeleteShardTest, 
TestLazyCores, RequiredFieldsTest, TestCollationFieldDocValues, 
PreAnalyzedFieldTest, SignatureUpdateProcessorFactoryTest, CopyFieldTest, 
TestDFISimilarityFactory, JSONWriterTest, EchoParamsTest, 
XsltUpdateRequestHandlerTest, ExplicitHLLTest, TestConfig, PrimUtilsTest, 
TestDynamicFieldCollectionResource, ActionThrottleTest, 
ExternalFileFieldSortTest, DistribJoinFromCollectionTest, 
LeaderFailoverAfterPartitionTest, MigrateRouteKeyTest, 
OverriddenZkACLAndCredentialsProvidersTest, 
OverseerCollectionConfigSetProcessorTest, PeerSyncReplicationTest, 
RollingRestartTest, TestConfigSetsAPI, TestDownShardTolerantSearch, 
TestExclusionRuleCollectionAccess, TestOnReconnectListenerSupport, 
TestReplicaProperties, TestStressLiveNodes, HdfsNNFailoverTest, 
HdfsWriteToMultipleCollectionsTest, ZkStateReaderTest]
   [junit4] Completed [484/575 (4!)] on J0 in 2.66s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 308 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/build.xml:757:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/build.xml:694:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/solr/common-build.xml:534:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/lucene/common-build.xml:1477:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.5/checkout/lucene/common-build.xml:1033:
 There were test failures: 575 suites (7 ignored), 2322 tests, 2 suite-level 
errors, 3 errors, 1 failure, 383 ignored (16 assumptions) [seed: 
D6A8934F3CFE4FB5]

Total time: 333 minutes 44 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 - Any
Sending email for trigger: Failure - Any



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

Reply via email to