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

2 tests failed.
FAILED:  org.apache.solr.cloud.BasicDistributedZkTest.test

Error Message:
commitWithin did not work on node: http://127.0.0.1:33340/collection1 
expected:<68> but was:<67>

Stack Trace:
java.lang.AssertionError: commitWithin did not work on node: 
http://127.0.0.1:33340/collection1 expected:<68> but was:<67>
        at 
__randomizedtesting.SeedInfo.seed([5BDA0A180335E023:D38E35C2ADC98DDB]: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.BasicDistributedZkTest.test(BasicDistributedZkTest.java:333)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:497)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1660)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:866)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:902)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:916)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:963)
        at 
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:938)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java: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:875)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:777)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:811)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:822)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java: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:54)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


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

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

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=9457, name=collection2, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:51613/rt/g: collection already exists: 
awholynewstresscollection_collection2_0
        at __randomizedtesting.SeedInfo.seed([5BDA0A180335E023]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
        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:1099)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1573)
        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1594)
        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:876)




Build Log:
[...truncated 9989 lines...]
   [junit4] Suite: org.apache.solr.cloud.BasicDistributedZkTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/init-core-data-001
   [junit4]   2> 460518 INFO  
(SUITE-BasicDistributedZkTest-seed#[5BDA0A180335E023]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
   [junit4]   2> 460527 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 460533 INFO  (Thread-12841) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 460534 INFO  (Thread-12841) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 460633 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:54364
   [junit4]   2> 460634 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 460657 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 460665 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6c1f3770 
name:ZooKeeperConnection Watcher:127.0.0.1:54364 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 460666 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 460666 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 460666 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 460669 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 460677 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 460688 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@c530e8 name:ZooKeeperConnection 
Watcher:127.0.0.1:54364/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 460688 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 460689 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 460689 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
   [junit4]   2> 460692 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
   [junit4]   2> 460693 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
   [junit4]   2> 460694 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
   [junit4]   2> 460696 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 460696 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 460698 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 460698 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 460699 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 460699 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: 
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 460700 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 460700 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
   [junit4]   2> 460701 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 460702 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
   [junit4]   2> 460703 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 460703 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
   [junit4]   2> 460704 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 460705 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
   [junit4]   2> 460706 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 460706 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
   [junit4]   2> 460708 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 460708 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 460709 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 460709 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
   [junit4]   2> 460711 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 460711 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
   [junit4]   2> 461214 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1
   [junit4]   2> 461219 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 461238 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@35ff7283{/,null,AVAILABLE}
   [junit4]   2> 461238 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@41837789{HTTP/1.1}{127.0.0.1:46417}
   [junit4]   2> 461238 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.Server Started @464124ms
   [junit4]   2> 461238 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/tempDir-001/control/data,
 hostContext=/, hostPort=46417, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores}
   [junit4]   2> 461239 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 461239 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/'
   [junit4]   2> 461239 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 461239 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 461258 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 461262 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 461277 INFO  (zkCallback-258-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3453b184 
name:ZooKeeperConnection Watcher:127.0.0.1:54364/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 461278 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 461278 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 461279 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 461285 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/solr.xml
   [junit4]   2> 461293 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoresLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores
   [junit4]   2> 461293 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 148941025
   [junit4]   2> 461293 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/]
   [junit4]   2> 461293 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoreContainer loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/lib
   [junit4]   2> 461293 WARN  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to 
classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/lib).
   [junit4]   2> 461301 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
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,
   [junit4]   2> 461315 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 461326 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 461326 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 461327 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54364/solr
   [junit4]   2> 461327 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 461327 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 461329 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 461341 INFO  (zkCallback-260-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@30e2b862 
name:ZooKeeperConnection Watcher:127.0.0.1:54364 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 461352 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 461355 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 461363 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 461366 INFO  
(zkCallback-261-thread-1-processing-n:127.0.0.1:46417_) [n:127.0.0.1:46417_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@56a8e209 
name:ZooKeeperConnection Watcher:127.0.0.1:54364/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 461366 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 461367 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 461370 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
   [junit4]   2> 461373 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
   [junit4]   2> 461376 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
   [junit4]   2> 461379 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
   [junit4]   2> 461383 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 461387 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 461388 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 461389 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 461390 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:46417_
   [junit4]   2> 461391 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:46417_
   [junit4]   2> 461392 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 461393 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
   [junit4]   2> 461394 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 461395 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94874741134655492-127.0.0.1:46417_-n_0000000000
   [junit4]   2> 461395 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46417_
   [junit4]   2> 461395 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
   [junit4]   2> 461398 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.Overseer Overseer 
(id=94874741134655492-127.0.0.1:46417_-n_0000000000) starting
   [junit4]   2> 461402 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
   [junit4]   2> 461422 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 461428 INFO  
(OverseerCollectionConfigSetProcessor-94874741134655492-127.0.0.1:46417_-n_0000000000)
 [n:127.0.0.1:46417_    ] o.a.s.c.OverseerTaskProcessor Process current queue 
of overseer operations
   [junit4]   2> 461428 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 461428 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 461448 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 461448 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 461449 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.CoresLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores
   [junit4]   2> 461450 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, 
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1,
 collection=control_collection, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/,
 coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 461450 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.CoresLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/
   [junit4]   2> 461450 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 461452 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 461452 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 461453 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
   [junit4]   2> 461453 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:46417_  
  ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 461454 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:46417";,
   [junit4]   2>   "node_name":"127.0.0.1:46417_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 461455 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:46417";,
   [junit4]   2>   "node_name":"127.0.0.1:46417_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 461455 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
control_collection
   [junit4]   2> 461456 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard1
   [junit4]   2> 461457 INFO  
(zkCallback-261-thread-1-processing-n:127.0.0.1:46417_) [n:127.0.0.1:46417_    
] 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> 461460 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.ZkController 
look for our core node name
   [junit4]   2> 461460 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.ZkController 
waiting to find shard id in clusterstate for collection1
   [junit4]   2> 461460 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Check for collection zkNode:control_collection
   [junit4]   2> 461460 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 461460 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader Load collection config 
from:/collections/control_collection
   [junit4]   2> 461461 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 
specified config exists in ZooKeeper
   [junit4]   2> 461461 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/'
   [junit4]   2> 461462 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 461462 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 461476 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.Config loaded 
config solrconfig.xml with version 0 
   [junit4]   2> 461481 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
current version of requestparams : -1
   [junit4]   2> 461485 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.0.0
   [junit4]   2> 461493 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.Config Loaded 
SolrConfig: solrconfig.xml
   [junit4]   2> 461494 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
Reading Solr Schema from /configs/conf1/schema.xml
   [junit4]   2> 461499 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 461626 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with 
rates=open-exchange-rates.json, refreshInterval=1440.
   [junit4]   2> 461632 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
default search field in schema is text
   [junit4]   2> 461633 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.s.IndexSchema 
unique key field: id
   [junit4]   2> 461642 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 461644 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
   [junit4]   2> 461646 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 461647 WARN  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
   [junit4]   2> 461647 WARN  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
   [junit4]   2> 461647 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from 
open-exchange-rates.json
   [junit4]   2> 461647 WARN  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
   [junit4]   2> 461647 WARN  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] 
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
   [junit4]   2> 461648 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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-trunk/solr/build/solr-core/test/J0
   [junit4]   2> 461648 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection   x:collection1] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1' using configuration from collection 
control_collection
   [junit4]   2> 461652 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 461652 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/],
 dataDir=[null]
   [junit4]   2> 461652 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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@23c1ba3d
   [junit4]   2> 461653 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/data
   [junit4]   2> 461653 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/data/index/
   [junit4]   2> 461653 WARN  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 461653 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/data/index
   [junit4]   2> 461654 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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=19, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 461668 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/index-MMapDirectory-001
 
lockFactory=org.apache.lucene.store.NativeFSLockFactory@82ba7d5),segFN=segments_1,generation=1}
   [junit4]   2> 461668 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"nodistrib"
   [junit4]   2> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"dedupe"
   [junit4]   2> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
   [junit4]   2> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain 
"stored_sig"
   [junit4]   2> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.p.UpdateRequestProcessorChain inserting 
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
   [junit4]   2> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461690 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461691 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461691 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461691 WARN  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461692 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 461694 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 461694 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 461709 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:46417_ 
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-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/data/
   [junit4]   2> 461710 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/control-001/cores/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 461710 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 461714 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 461715 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461730 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461730 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461731 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore Hard AutoCommit: disabled
   [junit4]   2> 461731 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore Soft AutoCommit: disabled
   [junit4]   2> 461731 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=9.5048828125, 
floorSegmentMB=1.0068359375, forceMergeDeletesPctAllowed=17.992572174167172, 
segmentsPerTier=15.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 461741 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        
commit{dir=MockDirectoryWrapper(MMapDirectory@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/index-MMapDirectory-001
 
lockFactory=org.apache.lucene.store.NativeFSLockFactory@82ba7d5),segFN=segments_1,generation=1}
   [junit4]   2> 461741 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.SolrCore newest commit generation = 1
   [junit4]   2> 461742 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.s.SolrIndexSearcher Opening Searcher@57b5d41d[collection1] main
   [junit4]   2> 461742 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461743 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461743 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461743 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 461743 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
   [junit4]   2> 461743 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461744 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461744 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461744 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 461744 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 461745 INFO  
(searcherExecutor-1145-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore 
[collection1] Registered new searcher Searcher@57b5d41d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 461745 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461745 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461745 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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> 461745 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ 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 1517995859415924736
   [junit4]   2> 461747 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 
1517995859415924736
   [junit4]   2> 461747 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 461748 INFO  
(coreLoadExecutor-1144-thread-1-processing-n:127.0.0.1:46417_) 
[n:127.0.0.1:46417_ c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 461757 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
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:46417 
collection:control_collection shard:shard1
   [junit4]   2> 461763 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: 
/collections/control_collection/leader_elect/shard1/election
   [junit4]   2> 461769 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector 
Joined leadership election with path: 
/collections/control_collection/leader_elect/shard1/election/94874741134655492-core_node1-n_0000000000
   [junit4]   2> 461770 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1
   [junit4]   2> 461771 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection"} current state version: 1
   [junit4]   2> 461773 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 461773 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 461773 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:46417/collection1/
   [junit4]   2> 461773 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 461773 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy 
http://127.0.0.1:46417/collection1/ has no replicas
   [junit4]   2> 461774 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
   [junit4]   2> 461775 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
   [junit4]   2> 461777 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "base_url":"http://127.0.0.1:46417";,
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "state":"active"} current state version: 1
   [junit4]   2> 461778 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:46417/collection1/ shard1
   [junit4]   2> 461879 INFO  
(zkCallback-261-thread-1-processing-n:127.0.0.1:46417_) [n:127.0.0.1:46417_    
] 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> 461929 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
We are http://127.0.0.1:46417/collection1/ and leader is 
http://127.0.0.1:46417/collection1/
   [junit4]   2> 461929 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:46417
   [junit4]   2> 461929 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 461929 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
publishing state=active
   [junit4]   2> 461929 INFO  
(coreZkRegister-1138-thread-1-processing-n:127.0.0.1:46417_ x:collection1 
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:46417_ 
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 461931 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:46417";,
   [junit4]   2>   "node_name":"127.0.0.1:46417_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"} current state version: 2
   [junit4]   2> 461931 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "core_node_name":"core_node1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:46417";,
   [junit4]   2>   "node_name":"127.0.0.1:46417_",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"active",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"control_collection",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 461955 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 461955 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 461962 INFO  (zkCallback-263-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@16700a0c 
name:ZooKeeperConnection Watcher:127.0.0.1:54364/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 461963 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 461963 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 461963 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 461967 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 461967 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
   [junit4]   2> 461967 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 461968 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 461977 INFO  (zkCallback-264-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@66c239af 
name:ZooKeeperConnection Watcher:127.0.0.1:54364/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 461977 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 461977 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 461980 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "operation":"create",
   [junit4]   2>   "name":"collection1",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "stateFormat":"2"} current state version: 2
   [junit4]   2> 461980 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ClusterStateMutator building a new cName: 
collection1
   [junit4]   2> 461980 INFO  
(zkCallback-261-thread-1-processing-n:127.0.0.1:46417_) [n:127.0.0.1:46417_    
] 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> 461983 INFO  (zkCallback-263-thread-1) [    ] 
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> 462103 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/collection1/state.json
   [junit4]   2> 462508 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores/collection1
   [junit4]   2> 462520 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001
   [junit4]   2> 462521 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.Server jetty-9.2.13.v20150730
   [junit4]   2> 462526 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6f8aa9e{/,null,AVAILABLE}
   [junit4]   2> 462526 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.ServerConnector Started 
ServerConnector@6f51d122{HTTP/1.1}{127.0.0.1:38919}
   [junit4]   2> 462526 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.e.j.s.Server Started @465412ms
   [junit4]   2> 462526 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/tempDir-001/jetty1,
 solrconfig=solrconfig.xml, hostContext=/, hostPort=38919, 
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores}
   [junit4]   2> 462530 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@4e0e2f2a
   [junit4]   2> 462530 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/'
   [junit4]   2> 462530 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 462530 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 462547 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 462548 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 462555 INFO  (zkCallback-265-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@78fc4845 
name:ZooKeeperConnection Watcher:127.0.0.1:54364/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 462555 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 462555 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 462561 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 462561 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/solr.xml
   [junit4]   2> 462569 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoresLocator Config-defined core root directory: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores
   [junit4]   2> 462569 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 415898173
   [junit4]   2> 462569 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/]
   [junit4]   2> 462569 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.CoreContainer loading shared library: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/lib
   [junit4]   2> 462570 WARN  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to 
classloader: lib (resolved as: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/lib).
   [junit4]   2> 462587 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
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,
   [junit4]   2> 462604 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 462604 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 462604 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 462605 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:54364/solr
   [junit4]   2> 462605 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 462605 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 462617 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 462631 INFO  (zkCallback-267-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@53318ddf 
name:ZooKeeperConnection Watcher:127.0.0.1:54364 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 462633 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 462634 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 462637 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 462659 INFO  
(zkCallback-268-thread-1-processing-n:127.0.0.1:38919_) [n:127.0.0.1:38919_    
] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@360ee680 
name:ZooKeeperConnection Watcher:127.0.0.1:54364/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 462659 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 462665 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 463671 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:38919_
   [junit4]   2> 463672 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:38919_
   [junit4]   2> 463672 INFO  (zkCallback-263-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live 
nodes size: 1)
   [junit4]   2> 463672 INFO  
(zkCallback-261-thread-1-processing-n:127.0.0.1:46417_) [n:127.0.0.1:46417_    
] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live 
nodes size: 1)
   [junit4]   2> 463673 INFO  
(zkCallback-268-thread-1-processing-n:127.0.0.1:38919_) [n:127.0.0.1:38919_    
] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live 
nodes size: 1)
   [junit4]   2> 463676 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 463676 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.LeaderElector Joined leadership election with path: 
/overseer_elect/election/94874741134655497-127.0.0.1:38919_-n_0000000001
   [junit4]   2> 463677 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/94874741134655492-127.0.0.1:46417_-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 463687 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 463687 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 463688 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.CoresLocator Looking for core definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores
   [junit4]   2> 463689 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, 
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores/collection1,
 collection=collection1, 
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores/collection1/,
 coreNodeName=, dataDir=data/, shard=}
   [junit4]   2> 463689 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.CoresLocator Found core collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores/collection1/
   [junit4]   2> 463689 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.c.CoresLocator Found 1 core definitions
   [junit4]   2> 463691 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController 
publishing state=down
   [junit4]   2> 463691 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController 
numShards not found on descriptor - reading it from system property
   [junit4]   2> 463693 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController 
Registering watch for collection collection1
   [junit4]   2> 463693 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
addZkWatch collection1
   [junit4]   2> 463693 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader Add 
data for collection1 ver 0 
   [junit4]   2> 463693 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController look 
for our core node name
   [junit4]   2> 463694 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.Overseer processMessage: queueSize: 1, message 
= {
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:38919";,
   [junit4]   2>   "node_name":"127.0.0.1:38919_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"} current state version: 3
   [junit4]   2> 463696 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ReplicaMutator Update state numShards=2 
message={
   [junit4]   2>   "core":"collection1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"http://127.0.0.1:38919";,
   [junit4]   2>   "node_name":"127.0.0.1:38919_",
   [junit4]   2>   "numShards":"2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":null,
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 463696 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ReplicaMutator Collection already exists 
with numShards=2
   [junit4]   2> 463696 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ReplicaMutator Assigning new node to shard 
shard=shard2
   [junit4]   2> 463698 INFO  
(OverseerStateUpdate-94874741134655492-127.0.0.1:46417_-n_0000000000) 
[n:127.0.0.1:46417_    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/collection1/state.json version: 0
   [junit4]   2> 463698 INFO  
(zkCallback-268-thread-1-processing-n:127.0.0.1:38919_) [n:127.0.0.1:38919_    
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json for collection collection1 has 
occurred - updating... (live nodes size: 2)
   [junit4]   2> 463699 INFO  
(zkCallback-268-thread-1-processing-n:127.0.0.1:38919_) [n:127.0.0.1:38919_    
] o.a.s.c.c.ZkStateReader Updating data for collection1 from 0 to 1 
   [junit4]   2> 463711 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.s.SolrDispatchFilter 
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
   [junit4]   2> 463711 INFO  
(TEST-BasicDistributedZkTest.test-seed#[5BDA0A180335E023]) [n:127.0.0.1:38919_  
  ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
   [junit4]   2> 464693 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController waiting 
to find shard id in clusterstate for collection1
   [junit4]   2> 464693 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController Check 
for collection zkNode:collection1
   [junit4]   2> 464694 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.ZkController 
Collection zkNode exists
   [junit4]   2> 464694 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader Load 
collection config from:/collections/collection1
   [junit4]   2> 464694 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.c.ZkStateReader 
path=/collections/collection1 configName=conf1 specified config exists in 
ZooKeeper
   [junit4]   2> 464695 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.BasicDistributedZkTest_5BDA0A180335E023-001/shard-1-001/cores/collection1/'
   [junit4]   2> 464695 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 464695 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.SolrResourceLoader 
solr home defaulted to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 464723 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.Config loaded config 
solrconfig.xml with version 0 
   [junit4]   2> 464728 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.SolrConfig current 
version of requestparams : -1
   [junit4]   2> 464731 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c:collection1   x:collection1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.0.0
   [junit4]   2> 464742 INFO  
(coreLoadExecutor-1155-thread-1-processing-n:127.0.0.1:38919_) 
[n:127.0.0.1:38919_ c

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

ollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:51613/rt/g: collection already exists: 
awholynewstresscollection_collection5_0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5BDA0A180335E023]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1573)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1594)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:876)Throwable
 #5: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an 
uncaught exception in thread: Thread[id=9455, name=collection0, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:51613/rt/g: collection already exists: 
awholynewstresscollection_collection0_0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5BDA0A180335E023]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1573)
   [junit4]    >        at 
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1594)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:876)Throwable
 #6: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an 
uncaught exception in thread: Thread[id=9456, name=collection1, state=RUNNABLE, 
group=TGRP-CollectionsAPIDistributedZkTest]
   [junit4]    > Caused by: 
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error 
from server at http://127.0.0.1:51613/rt/g: Could not find collection : 
awholynewstresscollection_collection1_0
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5BDA0A180335E023]:0)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1099)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
   [junit4]    >        at 
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
   [junit4]    >        at 
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
   [junit4]    >        at 
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:883)
   [junit4]   2> 1473001 INFO  
(SUITE-CollectionsAPIDistributedZkTest-seed#[5BDA0A180335E023]-worker) 
[n:127.0.0.1:51814_rt%2Fg c:addReplicaColl s:shard2 r:core_node6 
x:addReplicaColl_shard2_replica3] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene60): 
{other_tl1=PostingsFormat(name=MockRandom), 
range_facet_l_dv=PostingsFormat(name=LuceneFixedGap), 
_version_=PostingsFormat(name=MockRandom), 
multiDefault=PostingsFormat(name=Direct), a_t=PostingsFormat(name=MockRandom), 
intDefault=PostingsFormat(name=MockRandom), 
a_i1=PostingsFormat(name=MockRandom), id=PostingsFormat(name=LuceneFixedGap), 
range_facet_i_dv=PostingsFormat(name=MockRandom), 
text=PostingsFormat(name=Asserting), 
range_facet_l=PostingsFormat(name=MockRandom), 
timestamp=PostingsFormat(name=MockRandom)}, 
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), 
range_facet_i_dv=DocValuesFormat(name=Direct), 
timestamp=DocValuesFormat(name=Direct)}, 
sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=ro, 
timezone=Africa/Libreville
   [junit4]   2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 
1.8.0_66 (64-bit)/cpus=4,threads=1,free=90138976,total=512229376
   [junit4]   2> NOTE: All tests run in this JVM: [TestJmxMonitoredMap, 
CollectionTooManyReplicasTest, TestRemoveLastDynamicCopyField, 
TestSolrQueryParserResource, TestMacros, TestWriterPerf, 
TestSortByMinMaxFunction, SSLMigrationTest, HardAutoCommitTest, 
TestFileDictionaryLookup, TestStressUserVersions, TestCoreDiscovery, 
TestManagedSchema, LeaderElectionTest, TestObjectReleaseTracker, 
TestStressReorder, TestHighFrequencyDictionaryFactory, UnloadDistributedZkTest, 
SuggesterTSTTest, TestPostingsSolrHighlighter, TestSolrDeletionPolicy1, 
PreAnalyzedUpdateProcessorTest, TestUtils, TestRebalanceLeaders, 
TestRTimerTree, XmlUpdateRequestHandlerTest, TestFilteredDocIdSet, 
FieldAnalysisRequestHandlerTest, CustomCollectionTest, SuggesterWFSTTest, 
TestRequestStatusCollectionAPI, TermVectorComponentDistributedTest, 
TestReplicationHandlerBackup, TestCollapseQParserPlugin, TestCryptoKeys, 
HighlighterConfigTest, TestSchemaNameResource, TestJsonFacets, 
ScriptEngineTest, TestRecovery, CoreAdminRequestStatusTest, 
DirectUpdateHandlerTest, ExplicitHLLTest, TestSchemaSimilarityResource, 
UpdateParamsTest, TestSuggestSpellingConverter, PrimitiveFieldTypeTest, 
RuleEngineTest, OverseerTest, TestZkChroot, SpatialRPTFieldTypeTest, 
SuggesterTest, TestSolrQueryParser, BasicDistributedZk2Test, QueryParsingTest, 
DateMathParserTest, DirectUpdateHandlerOptimizeTest, CoreAdminHandlerTest, 
TestDistribDocBasedVersion, CircularListTest, HdfsNNFailoverTest, 
TestConfigSetsAPI, DistributedExpandComponentTest, 
FullSolrCloudDistribCmdsTest, TestSolrIndexConfig, 
TestRuleBasedAuthorizationPlugin, LukeRequestHandlerTest, FacetPivotSmallTest, 
NoCacheHeaderTest, BadIndexSchemaTest, TestCrossCoreJoin, 
CurrencyFieldXmlFileTest, SimpleFacetsTest, TestQueryWrapperFilter, 
TestCloudPivotFacet, ClusterStateTest, RequestHandlersTest, 
VMParamsZkACLAndCredentialsProvidersTest, StatsComponentTest, 
DocExpirationUpdateProcessorFactoryTest, TestSolr4Spatial2, TestSchemaManager, 
TestReloadAndDeleteDocs, TestCharFilters, 
DistribDocExpirationUpdateProcessorTest, HdfsRecoveryZkTest, 
DistributedQueueTest, TestReload, TestNoOpRegenerator, 
CollectionsAPIDistributedZkTest]
   [junit4] Completed [263/558] on J2 in 246.61s, 1 test, 1 error <<< FAILURES!

[...truncated 986 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:516:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1432:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:987:
 There were test failures: 558 suites (8 ignored), 2214 tests, 1 error, 1 
failure, 32 ignored (18 assumptions) [seed: 5BDA0A180335E023]

Total time: 211 minutes 26 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